builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-067 starttime: 1464988550.1 results: success (0) buildid: 20160603113009 builduid: 6e945fe0a6574cf698c53d737e6c9e37 revision: 1a72dc1810bc0170754b9fbf14a79e7f855346df ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 14:15:50.098740) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 14:15:50.099264) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 14:15:50.099599) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 14:15:50.114972) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 14:15:50.115299) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1464988550.235200-405161547 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-03 14:15:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 218M=0s 2016-06-03 14:15:51 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109656 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 14:15:50.239178) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 14:15:50.239548) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1464988550.235200-405161547 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018743 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 14:15:50.289726) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 14:15:50.290137) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1a72dc1810bc0170754b9fbf14a79e7f855346df --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 1a72dc1810bc0170754b9fbf14a79e7f855346df --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1464988550.235200-405161547 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-03 14:15:51,192 truncating revision to first 12 chars 2016-06-03 14:15:51,192 Setting DEBUG logging. 2016-06-03 14:15:51,192 attempt 1/10 2016-06-03 14:15:51,192 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1a72dc1810bc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-03 14:15:51,539 unpacking tar archive at: fx-team-1a72dc1810bc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.683757 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 14:15:50.987620) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 14:15:50.988044) ========= script_repo_revision: 1a72dc1810bc0170754b9fbf14a79e7f855346df ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 14:15:50.988495) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 14:15:50.988854) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 14:15:50.999560) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 10 secs) (at 2016-06-03 14:15:50.999891) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1464988550.235200-405161547 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:15:51 INFO - MultiFileLogger online at 20160603 14:15:51 in /builds/slave/test 14:15:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:15:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:15:51 INFO - {'append_to_log': False, 14:15:51 INFO - 'base_work_dir': '/builds/slave/test', 14:15:51 INFO - 'blob_upload_branch': 'Fx-Team', 14:15:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:15:51 INFO - 'branch': 'Fx-Team', 14:15:51 INFO - 'buildbot_json_path': 'buildprops.json', 14:15:51 INFO - 'config_files': ('talos/linux_config.py',), 14:15:51 INFO - 'default_actions': ('clobber', 14:15:51 INFO - 'read-buildbot-config', 14:15:51 INFO - 'download-and-extract', 14:15:51 INFO - 'populate-webroot', 14:15:51 INFO - 'create-virtualenv', 14:15:51 INFO - 'install', 14:15:51 INFO - 'run-tests'), 14:15:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:15:51 INFO - 'download_minidump_stackwalk': True, 14:15:51 INFO - 'download_symbols': 'ondemand', 14:15:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:15:51 INFO - 'tooltool.py': '/tools/tooltool.py', 14:15:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:15:51 INFO - '/tools/misc-python/virtualenv.py')}, 14:15:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:15:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:15:51 INFO - 'installer_path': 'installer.exe', 14:15:51 INFO - 'log_level': 'info', 14:15:51 INFO - 'log_name': 'talos', 14:15:51 INFO - 'log_to_console': True, 14:15:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:15:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:15:51 INFO - 'opt_config_files': (), 14:15:51 INFO - 'pip_index': False, 14:15:51 INFO - 'sps_profile': False, 14:15:51 INFO - 'sps_profile_interval': 0, 14:15:51 INFO - 'suite': 'dromaeojs', 14:15:51 INFO - 'system_bits': '32', 14:15:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:15:51 INFO - 'title': 'talos-linux64-ix-067', 14:15:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:15:51 INFO - 'use_talos_json': True, 14:15:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:15:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:15:51 INFO - 'work_dir': 'build'} 14:15:51 INFO - ##### 14:15:51 INFO - ##### Running clobber step. 14:15:51 INFO - ##### 14:15:51 INFO - Running pre-action listener: _resource_record_pre_action 14:15:51 INFO - Running main action method: clobber 14:15:51 INFO - rmtree: /builds/slave/test/build 14:15:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:15:52 INFO - Running post-action listener: _resource_record_post_action 14:15:52 INFO - ##### 14:15:52 INFO - ##### Finished clobber step (success) 14:15:52 INFO - ##### 14:15:52 INFO - ##### 14:15:52 INFO - ##### Running read-buildbot-config step. 14:15:52 INFO - ##### 14:15:52 INFO - Running pre-action listener: _resource_record_pre_action 14:15:52 INFO - Running main action method: read_buildbot_config 14:15:52 INFO - Using buildbot properties: 14:15:52 INFO - { 14:15:52 INFO - "project": "", 14:15:52 INFO - "product": "firefox", 14:15:52 INFO - "script_repo_revision": "production", 14:15:52 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:15:52 INFO - "repository": "", 14:15:52 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 14:15:52 INFO - "buildid": "20160603113009", 14:15:52 INFO - "pgo_build": "True", 14:15:52 INFO - "basedir": "/builds/slave/test", 14:15:52 INFO - "buildnumber": 1220, 14:15:52 INFO - "slavename": "talos-linux64-ix-067", 14:15:52 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:15:52 INFO - "platform": "ubuntu64_hw", 14:15:52 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:15:52 INFO - "branch": "fx-team", 14:15:52 INFO - "repo_path": "integration/fx-team", 14:15:52 INFO - "revision": "1a72dc1810bc0170754b9fbf14a79e7f855346df", 14:15:52 INFO - "stage_platform": "linux64-pgo", 14:15:52 INFO - "builduid": "6e945fe0a6574cf698c53d737e6c9e37", 14:15:52 INFO - "slavebuilddir": "test" 14:15:52 INFO - } 14:15:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/cG1xelpHSzW0ZtYZs0PGMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 14:15:52 INFO - Running post-action listener: _resource_record_post_action 14:15:52 INFO - ##### 14:15:52 INFO - ##### Finished read-buildbot-config step (success) 14:15:52 INFO - ##### 14:15:52 INFO - ##### 14:15:52 INFO - ##### Running download-and-extract step. 14:15:52 INFO - ##### 14:15:52 INFO - Running pre-action listener: _resource_record_pre_action 14:15:52 INFO - Running main action method: download_and_extract 14:15:52 INFO - mkdir: /builds/slave/test/build/tests 14:15:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:52 INFO - https://queue.taskcluster.net/v1/task/cG1xelpHSzW0ZtYZs0PGMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:15:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cG1xelpHSzW0ZtYZs0PGMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:15:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cG1xelpHSzW0ZtYZs0PGMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:15:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cG1xelpHSzW0ZtYZs0PGMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:15:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cG1xelpHSzW0ZtYZs0PGMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:15:53 INFO - Downloaded 1361 bytes. 14:15:53 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:15:53 INFO - Using the following test package requirements: 14:15:53 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:15:53 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:15:53 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:15:53 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:15:53 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:15:53 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:15:53 INFO - u'jsshell-linux-x86_64.zip'], 14:15:53 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:15:53 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:15:53 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:15:53 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:15:53 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:15:53 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:15:53 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:15:53 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:15:53 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:15:53 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:15:53 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:15:53 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:15:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:53 INFO - https://queue.taskcluster.net/v1/task/cG1xelpHSzW0ZtYZs0PGMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:15:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cG1xelpHSzW0ZtYZs0PGMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:15:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cG1xelpHSzW0ZtYZs0PGMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:15:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cG1xelpHSzW0ZtYZs0PGMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:15:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cG1xelpHSzW0ZtYZs0PGMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:17:57 INFO - Downloaded 24440968 bytes. 14:17:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:17:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:17:58 INFO - Return code: 0 14:17:58 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:58 INFO - https://queue.taskcluster.net/v1/task/cG1xelpHSzW0ZtYZs0PGMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:17:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cG1xelpHSzW0ZtYZs0PGMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:17:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cG1xelpHSzW0ZtYZs0PGMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:17:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cG1xelpHSzW0ZtYZs0PGMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:17:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cG1xelpHSzW0ZtYZs0PGMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:18:00 INFO - Downloaded 24440968 bytes. 14:18:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:18:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:18:02 INFO - Return code: 0 14:18:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:02 INFO - https://queue.taskcluster.net/v1/task/cG1xelpHSzW0ZtYZs0PGMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:18:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cG1xelpHSzW0ZtYZs0PGMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:18:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cG1xelpHSzW0ZtYZs0PGMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:18:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cG1xelpHSzW0ZtYZs0PGMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:18:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cG1xelpHSzW0ZtYZs0PGMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:18:29 INFO - Downloaded 10833369 bytes. 14:18:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:18:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:18:30 INFO - Return code: 0 14:18:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:30 INFO - https://queue.taskcluster.net/v1/task/cG1xelpHSzW0ZtYZs0PGMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:18:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cG1xelpHSzW0ZtYZs0PGMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:18:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cG1xelpHSzW0ZtYZs0PGMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:18:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cG1xelpHSzW0ZtYZs0PGMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:18:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cG1xelpHSzW0ZtYZs0PGMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:18:37 INFO - Downloaded 59158427 bytes. 14:18:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cG1xelpHSzW0ZtYZs0PGMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:18:37 INFO - mkdir: /builds/slave/test/properties 14:18:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:18:37 INFO - Writing to file /builds/slave/test/properties/build_url 14:18:37 INFO - Contents: 14:18:37 INFO - build_url:https://queue.taskcluster.net/v1/task/cG1xelpHSzW0ZtYZs0PGMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:18:39 INFO - Running post-action listener: _resource_record_post_action 14:18:39 INFO - Running post-action listener: set_extra_try_arguments 14:18:39 INFO - ##### 14:18:39 INFO - ##### Finished download-and-extract step (success) 14:18:39 INFO - ##### 14:18:39 INFO - ##### 14:18:39 INFO - ##### Running populate-webroot step. 14:18:39 INFO - ##### 14:18:39 INFO - Running pre-action listener: _resource_record_pre_action 14:18:39 INFO - Running main action method: populate_webroot 14:18:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:18:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:18:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:18:39 INFO - '--tppagecycles', 14:18:39 INFO - '7'], 14:18:39 INFO - 'tests': ['tsvgm']}}, 14:18:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:18:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:18:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:18:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:18:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:18:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:18:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:39 INFO - 'talos_options': ['--disable-e10s'], 14:18:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:18:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:18:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:39 INFO - 'talos_options': ['--disable-e10s'], 14:18:39 INFO - 'tests': ['damp', 'tps']}, 14:18:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:39 INFO - 'tests': ['damp', 'tps']}, 14:18:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:18:39 INFO - 'tests': ['dromaeo_dom']}, 14:18:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:18:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:18:39 INFO - 'tests': ['a11yr', 14:18:39 INFO - 'ts_paint', 14:18:39 INFO - 'tpaint', 14:18:39 INFO - 'sessionrestore', 14:18:39 INFO - 'sessionrestore_no_auto_restore', 14:18:39 INFO - 'tabpaint']}, 14:18:39 INFO - 'other-e10s': {'tests': ['a11yr', 14:18:39 INFO - 'ts_paint', 14:18:39 INFO - 'tpaint', 14:18:39 INFO - 'sessionrestore', 14:18:39 INFO - 'sessionrestore_no_auto_restore', 14:18:39 INFO - 'tabpaint']}, 14:18:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:18:39 INFO - 'ts_paint', 14:18:39 INFO - 'tpaint', 14:18:39 INFO - 'sessionrestore', 14:18:39 INFO - 'sessionrestore_no_auto_restore', 14:18:39 INFO - 'tabpaint']}, 14:18:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:18:39 INFO - 'ts_paint', 14:18:39 INFO - 'tpaint', 14:18:39 INFO - 'sessionrestore', 14:18:39 INFO - 'sessionrestore_no_auto_restore', 14:18:39 INFO - 'tabpaint']}, 14:18:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:18:39 INFO - 'tests': ['a11yr', 14:18:39 INFO - 'ts_paint', 14:18:39 INFO - 'tpaint', 14:18:39 INFO - 'sessionrestore', 14:18:39 INFO - 'sessionrestore_no_auto_restore', 14:18:39 INFO - 'tabpaint']}, 14:18:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:18:39 INFO - 'tests': ['a11yr', 14:18:39 INFO - 'ts_paint', 14:18:39 INFO - 'tpaint', 14:18:39 INFO - 'sessionrestore', 14:18:39 INFO - 'sessionrestore_no_auto_restore', 14:18:39 INFO - 'tabpaint']}, 14:18:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:18:39 INFO - 'tests': ['tsvgx', 14:18:39 INFO - 'tsvgr_opacity', 14:18:39 INFO - 'tart', 14:18:39 INFO - 'tscrollx', 14:18:39 INFO - 'cart']}, 14:18:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:18:39 INFO - 'tsvgr_opacity', 14:18:39 INFO - 'tart', 14:18:39 INFO - 'tscrollx', 14:18:39 INFO - 'cart']}, 14:18:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:39 INFO - 'talos_options': ['--disable-e10s'], 14:18:39 INFO - 'tests': ['tp5o']}, 14:18:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:39 INFO - 'tests': ['tp5o']}, 14:18:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:39 INFO - 'talos_options': ['--disable-e10s', 14:18:39 INFO - '--xperf_path', 14:18:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:18:39 INFO - 'tests': ['tp5n']}, 14:18:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:39 INFO - 'talos_options': ['--xperf_path', 14:18:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:18:39 INFO - 'tests': ['tp5n']}}, 14:18:39 INFO - 'talos.zip': {'path': '', 14:18:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:18:39 INFO - Running post-action listener: _resource_record_post_action 14:18:39 INFO - ##### 14:18:39 INFO - ##### Finished populate-webroot step (success) 14:18:39 INFO - ##### 14:18:39 INFO - ##### 14:18:39 INFO - ##### Running create-virtualenv step. 14:18:39 INFO - ##### 14:18:39 INFO - Running pre-action listener: _resource_record_pre_action 14:18:39 INFO - Running main action method: create_virtualenv 14:18:39 INFO - Creating virtualenv /builds/slave/test/build/venv 14:18:39 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:18:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:18:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:18:39 INFO - Using real prefix '/usr' 14:18:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:18:40 INFO - Installing distribute.............................................................................................................................................................................................done. 14:18:42 INFO - Installing pip.................done. 14:18:42 INFO - Return code: 0 14:18:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:18:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f15eb848f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2454350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e31c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e4550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464988550.235200-405161547', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:18:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:18:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:18:42 INFO - Using env: {'DISPLAY': ':0', 14:18:42 INFO - 'HOME': '/home/cltbld', 14:18:42 INFO - 'LANG': 'en_US.UTF-8', 14:18:42 INFO - 'LANGUAGE': 'en_US:en', 14:18:42 INFO - 'LOGNAME': 'cltbld', 14:18:42 INFO - 'MAIL': '/var/mail/cltbld', 14:18:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:42 INFO - 'MOZ_NO_REMOTE': '1', 14:18:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:42 INFO - 'NO_EM_RESTART': '1', 14:18:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:42 INFO - 'PWD': '/builds/slave/test', 14:18:42 INFO - 'SHELL': '/bin/bash', 14:18:42 INFO - 'SHLVL': '1', 14:18:42 INFO - 'TERM': 'linux', 14:18:42 INFO - 'TMOUT': '86400', 14:18:42 INFO - 'USER': 'cltbld', 14:18:42 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464988550.235200-405161547', 14:18:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:42 INFO - '_': '/tools/buildbot/bin/python'} 14:18:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:42 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:18:42 INFO - Cleaning up... 14:18:42 INFO - Return code: 0 14:18:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:18:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f15eb848f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2454350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e31c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e4550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464988550.235200-405161547', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:18:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:18:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:18:42 INFO - Using env: {'DISPLAY': ':0', 14:18:42 INFO - 'HOME': '/home/cltbld', 14:18:42 INFO - 'LANG': 'en_US.UTF-8', 14:18:42 INFO - 'LANGUAGE': 'en_US:en', 14:18:42 INFO - 'LOGNAME': 'cltbld', 14:18:42 INFO - 'MAIL': '/var/mail/cltbld', 14:18:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:42 INFO - 'MOZ_NO_REMOTE': '1', 14:18:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:42 INFO - 'NO_EM_RESTART': '1', 14:18:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:42 INFO - 'PWD': '/builds/slave/test', 14:18:42 INFO - 'SHELL': '/bin/bash', 14:18:42 INFO - 'SHLVL': '1', 14:18:42 INFO - 'TERM': 'linux', 14:18:42 INFO - 'TMOUT': '86400', 14:18:42 INFO - 'USER': 'cltbld', 14:18:42 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464988550.235200-405161547', 14:18:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:42 INFO - '_': '/tools/buildbot/bin/python'} 14:18:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:42 INFO - Downloading/unpacking psutil>=3.1.1 14:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:18:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:18:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:18:44 INFO - Installing collected packages: psutil 14:18:44 INFO - Running setup.py install for psutil 14:18:44 INFO - building 'psutil._psutil_linux' extension 14:18:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:18:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:18:45 INFO - building 'psutil._psutil_posix' extension 14:18:45 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:18:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:18:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:18:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:18:45 INFO - Successfully installed psutil 14:18:45 INFO - Cleaning up... 14:18:45 INFO - Return code: 0 14:18:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:18:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f15eb848f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2454350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e31c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e4550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464988550.235200-405161547', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:18:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:18:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:18:45 INFO - Using env: {'DISPLAY': ':0', 14:18:45 INFO - 'HOME': '/home/cltbld', 14:18:45 INFO - 'LANG': 'en_US.UTF-8', 14:18:45 INFO - 'LANGUAGE': 'en_US:en', 14:18:45 INFO - 'LOGNAME': 'cltbld', 14:18:45 INFO - 'MAIL': '/var/mail/cltbld', 14:18:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:45 INFO - 'MOZ_NO_REMOTE': '1', 14:18:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:45 INFO - 'NO_EM_RESTART': '1', 14:18:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:45 INFO - 'PWD': '/builds/slave/test', 14:18:45 INFO - 'SHELL': '/bin/bash', 14:18:45 INFO - 'SHLVL': '1', 14:18:45 INFO - 'TERM': 'linux', 14:18:45 INFO - 'TMOUT': '86400', 14:18:45 INFO - 'USER': 'cltbld', 14:18:45 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464988550.235200-405161547', 14:18:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:45 INFO - '_': '/tools/buildbot/bin/python'} 14:18:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:18:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:18:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:18:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:18:47 INFO - Installing collected packages: mozsystemmonitor 14:18:47 INFO - Running setup.py install for mozsystemmonitor 14:18:47 INFO - Successfully installed mozsystemmonitor 14:18:47 INFO - Cleaning up... 14:18:47 INFO - Return code: 0 14:18:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:18:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f15eb848f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2454350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e31c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e4550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464988550.235200-405161547', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:18:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:18:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:18:47 INFO - Using env: {'DISPLAY': ':0', 14:18:47 INFO - 'HOME': '/home/cltbld', 14:18:47 INFO - 'LANG': 'en_US.UTF-8', 14:18:47 INFO - 'LANGUAGE': 'en_US:en', 14:18:47 INFO - 'LOGNAME': 'cltbld', 14:18:47 INFO - 'MAIL': '/var/mail/cltbld', 14:18:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:47 INFO - 'MOZ_NO_REMOTE': '1', 14:18:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:47 INFO - 'NO_EM_RESTART': '1', 14:18:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:47 INFO - 'PWD': '/builds/slave/test', 14:18:47 INFO - 'SHELL': '/bin/bash', 14:18:47 INFO - 'SHLVL': '1', 14:18:47 INFO - 'TERM': 'linux', 14:18:47 INFO - 'TMOUT': '86400', 14:18:47 INFO - 'USER': 'cltbld', 14:18:47 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464988550.235200-405161547', 14:18:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:47 INFO - '_': '/tools/buildbot/bin/python'} 14:18:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:47 INFO - Downloading/unpacking jsonschema==2.5.1 14:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:18:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:50 INFO - Downloading functools32-3.2.3-2.tar.gz 14:18:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:18:50 INFO - warning: no files found matching '*.txt' 14:18:50 INFO - no previously-included directories found matching 'build' 14:18:50 INFO - no previously-included directories found matching 'dist' 14:18:50 INFO - no previously-included directories found matching '.git*' 14:18:50 INFO - Installing collected packages: jsonschema, functools32 14:18:50 INFO - Running setup.py install for functools32 14:18:50 INFO - warning: no files found matching '*.txt' 14:18:50 INFO - no previously-included directories found matching 'build' 14:18:50 INFO - no previously-included directories found matching 'dist' 14:18:50 INFO - no previously-included directories found matching '.git*' 14:18:50 INFO - Successfully installed jsonschema functools32 14:18:50 INFO - Cleaning up... 14:18:50 INFO - Return code: 0 14:18:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f15eb848f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2454350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e31c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e4550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464988550.235200-405161547', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:18:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:18:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:18:50 INFO - Using env: {'DISPLAY': ':0', 14:18:50 INFO - 'HOME': '/home/cltbld', 14:18:50 INFO - 'LANG': 'en_US.UTF-8', 14:18:50 INFO - 'LANGUAGE': 'en_US:en', 14:18:50 INFO - 'LOGNAME': 'cltbld', 14:18:50 INFO - 'MAIL': '/var/mail/cltbld', 14:18:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:50 INFO - 'MOZ_NO_REMOTE': '1', 14:18:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:50 INFO - 'NO_EM_RESTART': '1', 14:18:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:50 INFO - 'PWD': '/builds/slave/test', 14:18:50 INFO - 'SHELL': '/bin/bash', 14:18:50 INFO - 'SHLVL': '1', 14:18:50 INFO - 'TERM': 'linux', 14:18:50 INFO - 'TMOUT': '86400', 14:18:50 INFO - 'USER': 'cltbld', 14:18:50 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464988550.235200-405161547', 14:18:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:50 INFO - '_': '/tools/buildbot/bin/python'} 14:18:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:50 INFO - Downloading/unpacking blobuploader==1.2.4 14:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:52 INFO - Downloading blobuploader-1.2.4.tar.gz 14:18:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:18:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:18:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:53 INFO - Downloading docopt-0.6.1.tar.gz 14:18:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:18:53 INFO - Installing collected packages: blobuploader, requests, docopt 14:18:53 INFO - Running setup.py install for blobuploader 14:18:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:18:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:18:53 INFO - Running setup.py install for requests 14:18:53 INFO - Running setup.py install for docopt 14:18:53 INFO - Successfully installed blobuploader requests docopt 14:18:53 INFO - Cleaning up... 14:18:53 INFO - Return code: 0 14:18:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:18:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f15eb848f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2454350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e31c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e4550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464988550.235200-405161547', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:18:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:18:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:18:53 INFO - Using env: {'DISPLAY': ':0', 14:18:53 INFO - 'HOME': '/home/cltbld', 14:18:53 INFO - 'LANG': 'en_US.UTF-8', 14:18:53 INFO - 'LANGUAGE': 'en_US:en', 14:18:53 INFO - 'LOGNAME': 'cltbld', 14:18:53 INFO - 'MAIL': '/var/mail/cltbld', 14:18:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:53 INFO - 'MOZ_NO_REMOTE': '1', 14:18:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:53 INFO - 'NO_EM_RESTART': '1', 14:18:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:53 INFO - 'PWD': '/builds/slave/test', 14:18:53 INFO - 'SHELL': '/bin/bash', 14:18:53 INFO - 'SHLVL': '1', 14:18:53 INFO - 'TERM': 'linux', 14:18:53 INFO - 'TMOUT': '86400', 14:18:53 INFO - 'USER': 'cltbld', 14:18:53 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464988550.235200-405161547', 14:18:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:53 INFO - '_': '/tools/buildbot/bin/python'} 14:18:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:18:53 INFO - Running setup.py (path:/tmp/pip-bXGcIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:18:54 INFO - Running setup.py (path:/tmp/pip-rDy2sV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:18:54 INFO - Running setup.py (path:/tmp/pip-pZpEWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:18:54 INFO - Running setup.py (path:/tmp/pip-rzFcmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:18:54 INFO - Running setup.py (path:/tmp/pip-nbWYqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:18:54 INFO - Running setup.py (path:/tmp/pip-zR_NaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:18:54 INFO - Running setup.py (path:/tmp/pip-x5OpCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:18:54 INFO - Running setup.py (path:/tmp/pip-cAarD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:18:54 INFO - Running setup.py (path:/tmp/pip-DZyWjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:18:54 INFO - Running setup.py (path:/tmp/pip-urFziZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:18:54 INFO - Running setup.py (path:/tmp/pip-ehD6LE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:18:54 INFO - Running setup.py (path:/tmp/pip-zn054p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:18:54 INFO - Running setup.py (path:/tmp/pip-J3ANvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:18:54 INFO - Running setup.py (path:/tmp/pip-JMUE24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:54 INFO - Running setup.py (path:/tmp/pip-sVBc0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:18:55 INFO - Running setup.py (path:/tmp/pip-MwKuBn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:18:55 INFO - Running setup.py (path:/tmp/pip-D5VyJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:18:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:18:55 INFO - Running setup.py install for manifestparser 14:18:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:18:55 INFO - Running setup.py install for mozcrash 14:18:55 INFO - Running setup.py install for mozdebug 14:18:55 INFO - Running setup.py install for mozdevice 14:18:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:18:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:18:55 INFO - Running setup.py install for mozfile 14:18:55 INFO - Running setup.py install for mozhttpd 14:18:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:18:55 INFO - Running setup.py install for mozinfo 14:18:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:18:55 INFO - Running setup.py install for mozInstall 14:18:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:18:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:18:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:18:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:18:55 INFO - Running setup.py install for mozleak 14:18:56 INFO - Running setup.py install for mozlog 14:18:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:18:56 INFO - Running setup.py install for moznetwork 14:18:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:18:56 INFO - Running setup.py install for mozprocess 14:18:56 INFO - Running setup.py install for mozprofile 14:18:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:18:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:18:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:18:56 INFO - Running setup.py install for mozrunner 14:18:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:18:56 INFO - Running setup.py install for mozscreenshot 14:18:56 INFO - Running setup.py install for moztest 14:18:56 INFO - Running setup.py install for mozversion 14:18:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:18:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:18:56 INFO - Cleaning up... 14:18:56 INFO - Return code: 0 14:18:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:18:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f15eb848f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2454350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e31c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e4550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464988550.235200-405161547', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:18:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:18:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:18:56 INFO - Using env: {'DISPLAY': ':0', 14:18:56 INFO - 'HOME': '/home/cltbld', 14:18:56 INFO - 'LANG': 'en_US.UTF-8', 14:18:56 INFO - 'LANGUAGE': 'en_US:en', 14:18:56 INFO - 'LOGNAME': 'cltbld', 14:18:56 INFO - 'MAIL': '/var/mail/cltbld', 14:18:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:56 INFO - 'MOZ_NO_REMOTE': '1', 14:18:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:56 INFO - 'NO_EM_RESTART': '1', 14:18:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:56 INFO - 'PWD': '/builds/slave/test', 14:18:56 INFO - 'SHELL': '/bin/bash', 14:18:56 INFO - 'SHLVL': '1', 14:18:56 INFO - 'TERM': 'linux', 14:18:56 INFO - 'TMOUT': '86400', 14:18:56 INFO - 'USER': 'cltbld', 14:18:56 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464988550.235200-405161547', 14:18:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:56 INFO - '_': '/tools/buildbot/bin/python'} 14:18:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:18:57 INFO - Running setup.py (path:/tmp/pip-4Yww8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:18:57 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:18:57 INFO - Running setup.py (path:/tmp/pip-gH2ciL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:18:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:18:57 INFO - Running setup.py (path:/tmp/pip-tDLBFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:18:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:18:57 INFO - Running setup.py (path:/tmp/pip-h4g0Np-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:18:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:18:57 INFO - Running setup.py (path:/tmp/pip-tIMW47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:18:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:18:57 INFO - Running setup.py (path:/tmp/pip-eG4Spc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:18:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:18:57 INFO - Running setup.py (path:/tmp/pip-LntBcs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:18:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:18:57 INFO - Running setup.py (path:/tmp/pip-3L1PzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:18:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:18:57 INFO - Running setup.py (path:/tmp/pip-00wAar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:18:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:18:57 INFO - Running setup.py (path:/tmp/pip-vUPW1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:18:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:18:57 INFO - Running setup.py (path:/tmp/pip-hAD1ke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:18:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:18:58 INFO - Running setup.py (path:/tmp/pip-Bc3fXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:18:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:18:58 INFO - Running setup.py (path:/tmp/pip-WBTNVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:18:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:18:58 INFO - Running setup.py (path:/tmp/pip-EVfA_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:18:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:58 INFO - Running setup.py (path:/tmp/pip-yEwuX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:18:58 INFO - Running setup.py (path:/tmp/pip-1rdRvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:18:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:18:58 INFO - Running setup.py (path:/tmp/pip-VFxn9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:18:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:18:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:18:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:18:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:18:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:18:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:18:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:00 INFO - Downloading blessings-1.6.tar.gz 14:19:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:19:00 INFO - Installing collected packages: blessings 14:19:00 INFO - Running setup.py install for blessings 14:19:00 INFO - Successfully installed blessings 14:19:00 INFO - Cleaning up... 14:19:00 INFO - Return code: 0 14:19:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:19:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:19:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:19:00 INFO - Reading from file tmpfile_stdout 14:19:00 INFO - Current package versions: 14:19:00 INFO - argparse == 1.2.1 14:19:00 INFO - blessings == 1.6 14:19:00 INFO - blobuploader == 1.2.4 14:19:00 INFO - docopt == 0.6.1 14:19:00 INFO - functools32 == 3.2.3-2 14:19:00 INFO - jsonschema == 2.5.1 14:19:00 INFO - manifestparser == 1.1 14:19:00 INFO - mozInstall == 1.12 14:19:00 INFO - mozcrash == 0.17 14:19:00 INFO - mozdebug == 0.1 14:19:00 INFO - mozdevice == 0.48 14:19:00 INFO - mozfile == 1.2 14:19:00 INFO - mozhttpd == 0.7 14:19:00 INFO - mozinfo == 0.9 14:19:00 INFO - mozleak == 0.1 14:19:00 INFO - mozlog == 3.2 14:19:00 INFO - moznetwork == 0.27 14:19:00 INFO - mozprocess == 0.22 14:19:00 INFO - mozprofile == 0.28 14:19:00 INFO - mozrunner == 6.11 14:19:00 INFO - mozscreenshot == 0.1 14:19:00 INFO - mozsystemmonitor == 0.3 14:19:00 INFO - moztest == 0.7 14:19:00 INFO - mozversion == 1.4 14:19:00 INFO - psutil == 3.1.1 14:19:00 INFO - requests == 1.2.3 14:19:00 INFO - wsgiref == 0.1.2 14:19:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:19:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f15eb848f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2454350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e31c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e4550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464988550.235200-405161547', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:19:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:19:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:19:00 INFO - Using env: {'DISPLAY': ':0', 14:19:00 INFO - 'HOME': '/home/cltbld', 14:19:00 INFO - 'LANG': 'en_US.UTF-8', 14:19:00 INFO - 'LANGUAGE': 'en_US:en', 14:19:00 INFO - 'LOGNAME': 'cltbld', 14:19:00 INFO - 'MAIL': '/var/mail/cltbld', 14:19:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:00 INFO - 'MOZ_NO_REMOTE': '1', 14:19:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:19:00 INFO - 'NO_EM_RESTART': '1', 14:19:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:19:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:00 INFO - 'PWD': '/builds/slave/test', 14:19:00 INFO - 'SHELL': '/bin/bash', 14:19:00 INFO - 'SHLVL': '1', 14:19:00 INFO - 'TERM': 'linux', 14:19:00 INFO - 'TMOUT': '86400', 14:19:00 INFO - 'USER': 'cltbld', 14:19:00 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464988550.235200-405161547', 14:19:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:00 INFO - '_': '/tools/buildbot/bin/python'} 14:19:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:19:00 INFO - Cleaning up... 14:19:01 INFO - Return code: 0 14:19:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:19:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f15eb848f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2454350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e31c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e4550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464988550.235200-405161547', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:19:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:19:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:19:01 INFO - Using env: {'DISPLAY': ':0', 14:19:01 INFO - 'HOME': '/home/cltbld', 14:19:01 INFO - 'LANG': 'en_US.UTF-8', 14:19:01 INFO - 'LANGUAGE': 'en_US:en', 14:19:01 INFO - 'LOGNAME': 'cltbld', 14:19:01 INFO - 'MAIL': '/var/mail/cltbld', 14:19:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:01 INFO - 'MOZ_NO_REMOTE': '1', 14:19:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:19:01 INFO - 'NO_EM_RESTART': '1', 14:19:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:19:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:01 INFO - 'PWD': '/builds/slave/test', 14:19:01 INFO - 'SHELL': '/bin/bash', 14:19:01 INFO - 'SHLVL': '1', 14:19:01 INFO - 'TERM': 'linux', 14:19:01 INFO - 'TMOUT': '86400', 14:19:01 INFO - 'USER': 'cltbld', 14:19:01 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464988550.235200-405161547', 14:19:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:01 INFO - '_': '/tools/buildbot/bin/python'} 14:19:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:19:01 INFO - Cleaning up... 14:19:01 INFO - Return code: 0 14:19:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:19:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f15eb848f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2454350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e31c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e4550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464988550.235200-405161547', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:19:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:19:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:19:01 INFO - Using env: {'DISPLAY': ':0', 14:19:01 INFO - 'HOME': '/home/cltbld', 14:19:01 INFO - 'LANG': 'en_US.UTF-8', 14:19:01 INFO - 'LANGUAGE': 'en_US:en', 14:19:01 INFO - 'LOGNAME': 'cltbld', 14:19:01 INFO - 'MAIL': '/var/mail/cltbld', 14:19:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:01 INFO - 'MOZ_NO_REMOTE': '1', 14:19:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:19:01 INFO - 'NO_EM_RESTART': '1', 14:19:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:19:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:01 INFO - 'PWD': '/builds/slave/test', 14:19:01 INFO - 'SHELL': '/bin/bash', 14:19:01 INFO - 'SHLVL': '1', 14:19:01 INFO - 'TERM': 'linux', 14:19:01 INFO - 'TMOUT': '86400', 14:19:01 INFO - 'USER': 'cltbld', 14:19:01 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464988550.235200-405161547', 14:19:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:01 INFO - '_': '/tools/buildbot/bin/python'} 14:19:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:01 INFO - Downloading/unpacking flake8 14:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:19:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:19:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:19:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:19:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:19:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:19:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:19:04 INFO - no previously-included directories found matching 'docs/_build' 14:19:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:19:04 INFO - Running setup.py install for pep8 14:19:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:19:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:19:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:19:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:19:04 INFO - no previously-included directories found matching 'docs/_build' 14:19:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:19:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:19:04 INFO - Cleaning up... 14:19:04 INFO - Return code: 0 14:19:04 INFO - Running post-action listener: _resource_record_post_action 14:19:04 INFO - Running post-action listener: _start_resource_monitoring 14:19:04 INFO - Starting resource monitoring. 14:19:04 INFO - ##### 14:19:04 INFO - ##### Finished create-virtualenv step (success) 14:19:04 INFO - ##### 14:19:04 INFO - ##### 14:19:04 INFO - ##### Running install step. 14:19:04 INFO - ##### 14:19:04 INFO - Running pre-action listener: _resource_record_pre_action 14:19:04 INFO - Running main action method: install 14:19:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:19:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:19:04 INFO - Reading from file tmpfile_stdout 14:19:04 INFO - Detecting whether we're running mozinstall >=1.0... 14:19:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:19:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:19:04 INFO - Reading from file tmpfile_stdout 14:19:04 INFO - Output received: 14:19:04 INFO - Usage: mozinstall [options] installer 14:19:04 INFO - Options: 14:19:04 INFO - -h, --help show this help message and exit 14:19:04 INFO - -d DEST, --destination=DEST 14:19:04 INFO - Directory to install application into. [default: 14:19:04 INFO - "/builds/slave/test"] 14:19:04 INFO - --app=APP Application being installed. [default: firefox] 14:19:04 INFO - mkdir: /builds/slave/test/build/application 14:19:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:19:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:19:21 INFO - Reading from file tmpfile_stdout 14:19:21 INFO - Output received: 14:19:21 INFO - /builds/slave/test/build/application/firefox/firefox 14:19:21 INFO - Running post-action listener: _resource_record_post_action 14:19:21 INFO - ##### 14:19:21 INFO - ##### Finished install step (success) 14:19:21 INFO - ##### 14:19:21 INFO - ##### 14:19:21 INFO - ##### Running run-tests step. 14:19:21 INFO - ##### 14:19:21 INFO - Running pre-action listener: _resource_record_pre_action 14:19:21 INFO - Running main action method: run_tests 14:19:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:19:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:19:21 INFO - Python 2.7.3 14:19:21 INFO - Return code: 0 14:19:21 INFO - grabbing minidump binary from tooltool 14:19:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:19:21 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e31c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e4550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:19:21 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:19:21 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:19:21 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:19:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:19:21 INFO - Return code: 0 14:19:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:19:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:19:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:19:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:19:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:19:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:19:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:19:22 INFO - Return code: 0 14:19:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cG1xelpHSzW0ZtYZs0PGMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:19:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cG1xelpHSzW0ZtYZs0PGMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:19:22 INFO - Using env: {'DISPLAY': ':0', 14:19:22 INFO - 'HOME': '/home/cltbld', 14:19:22 INFO - 'LANG': 'en_US.UTF-8', 14:19:22 INFO - 'LANGUAGE': 'en_US:en', 14:19:22 INFO - 'LOGNAME': 'cltbld', 14:19:22 INFO - 'MAIL': '/var/mail/cltbld', 14:19:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:19:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:19:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:22 INFO - 'MOZ_NO_REMOTE': '1', 14:19:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:19:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:19:22 INFO - 'NO_EM_RESTART': '1', 14:19:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:19:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:22 INFO - 'PWD': '/builds/slave/test', 14:19:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:19:22 INFO - 'SHELL': '/bin/bash', 14:19:22 INFO - 'SHLVL': '1', 14:19:22 INFO - 'TERM': 'linux', 14:19:22 INFO - 'TMOUT': '86400', 14:19:22 INFO - 'USER': 'cltbld', 14:19:22 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464988550.235200-405161547', 14:19:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:22 INFO - '_': '/tools/buildbot/bin/python'} 14:19:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cG1xelpHSzW0ZtYZs0PGMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:19:22 INFO - mozversion application_buildid: 20160603113009 14:19:22 INFO - mozversion application_changeset: 1a72dc1810bc0170754b9fbf14a79e7f855346df 14:19:22 INFO - mozversion application_display_name: Nightly 14:19:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:19:22 INFO - mozversion application_name: Firefox 14:19:22 INFO - mozversion application_remotingname: firefox 14:19:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:19:22 INFO - mozversion application_vendor: Mozilla 14:19:22 INFO - mozversion application_version: 49.0a1 14:19:22 INFO - mozversion platform_buildid: 20160603113009 14:19:22 INFO - mozversion platform_changeset: 1a72dc1810bc0170754b9fbf14a79e7f855346df 14:19:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:19:22 INFO - mozversion platform_version: 49.0a1 14:19:22 INFO - using testdate: 1464988762 14:19:22 INFO - actual date: 1464988762 14:19:22 INFO - starting webserver on 'localhost:58635' 14:19:22 INFO - SUITE-START | Running 2 tests 14:19:22 INFO - TEST-START | dromaeo_css 14:19:22 INFO - operating with platform_type : linux_ 14:19:22 INFO - Initialising browser for dromaeo_css test... 14:19:22 INFO - TEST-INFO | started process 21015 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxOX_HE/profile http://localhost:58635/getInfo.html) 14:19:26 INFO - PROCESS | 21015 | __metrics Screen width/height:1600/1200 14:19:26 INFO - PROCESS | 21015 | colorDepth:24 14:19:26 INFO - PROCESS | 21015 | Browser inner width/height: 1024/697 14:19:26 INFO - PROCESS | 21015 | __metrics 14:19:26 ERROR - PROCESS | 21015 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:19:27 INFO - TEST-INFO | 21015: exit 0 14:19:27 INFO - Browser initialized. 14:19:27 INFO - Running cycle 1/1 for dromaeo_css test... 14:19:27 INFO - TEST-INFO | started process 21097 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxOX_HE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:19:39 INFO - PROCESS | 21097 | RSS: Main: 155865088 14:19:39 INFO - PROCESS | 21097 | 14:20:30 INFO - PROCESS | 21097 | 1464988830695 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:22:38 INFO - PROCESS | 21097 | Cycle 1(1): loaded http://localhost:58635/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58635/tests/dromaeo/cssquery-ext.html) 14:22:39 INFO - PROCESS | 21097 | RSS: Main: 247783424 14:22:39 INFO - PROCESS | 21097 | 14:25:42 INFO - PROCESS | 21097 | Cycle 1(1): loaded http://localhost:58635/tests/dromaeo/cssquery-ext.html (next: http://localhost:58635/tests/dromaeo/cssquery-jquery.html) 14:25:42 INFO - PROCESS | 21097 | RSS: Main: 249626624 14:25:42 INFO - PROCESS | 21097 | 14:28:44 INFO - PROCESS | 21097 | Cycle 1(1): loaded http://localhost:58635/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58635/tests/dromaeo/cssquery-mootools.html) 14:28:45 INFO - PROCESS | 21097 | RSS: Main: 247959552 14:28:45 INFO - PROCESS | 21097 | 14:31:47 INFO - PROCESS | 21097 | Cycle 1(1): loaded http://localhost:58635/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58635/tests/dromaeo/cssquery-prototype.html) 14:31:47 INFO - PROCESS | 21097 | RSS: Main: 244531200 14:31:47 INFO - PROCESS | 21097 | 14:34:50 INFO - PROCESS | 21097 | Cycle 1(1): loaded http://localhost:58635/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58635/tests/dromaeo/cssquery-yui.html) 14:34:51 INFO - PROCESS | 21097 | RSS: Main: 232296448 14:34:51 INFO - PROCESS | 21097 | 14:37:53 INFO - PROCESS | 21097 | Cycle 1(1): loaded http://localhost:58635/tests/dromaeo/cssquery-yui.html (next: http://localhost:58635/tests/dromaeo/cssquery-dojo.html) 14:37:54 INFO - PROCESS | 21097 | RSS: Main: 278917120 14:37:54 INFO - PROCESS | 21097 | 14:37:54 INFO - PROCESS | 21097 | __start_tp_report 14:37:54 INFO - PROCESS | 21097 | _x_x_mozilla_page_load 14:37:54 INFO - PROCESS | 21097 | _x_x_mozilla_page_load_details 14:37:54 INFO - PROCESS | 21097 | |i|pagename|runs| 14:37:54 INFO - PROCESS | 21097 | |0;dojo.html;3125.046860707484;3133.1853718033303;3141.952870706939;3167.0815463515582;3194.217416732901;5300.893982120355;5319.441458646845;5395.109806881865;5516.310461192351;5523.7238138093135;5428.077226871432;5441.156620723784;5461.77110150216;5494.395616482184;5551.333839939203;4875.829345972892;4935.457099719028;4961.057399094178;4978.950210497903;5106.5659418949435;4995.800167993276;5026.969471258383;5052.8484145475695;5055.898882022358;5073.391193056838;4828.613710903137;4883;4883.755812209411;4884.780184891652;4887.0225954809;4898.191798353268;4939.160342741707;4939.165988527895;4953.083679519301;4977.502249774993;4901.950980490221;4911.386076740408;4925.3350797642215;4925.926111108336;4944.480829512885;5226.372835259755;5271.710055946922;5314.176302673091;5370.140777475624;5401.70290634015;5937.614055086448;5941.079132734433;5946.97026514869;5956.672383018932;5958.642481451084;5949.553783466257;5960.701964901781;5982.371850955674;5983.730732117066;5989.460948514655;5230.137027390476;5339.279197308352;5392.16421454679;5397.595180361489;5513.117901135879;6026.306974697878;6046.788362407295;6047.365026672136;6054.51563874889;6068.6358818471035;5798.985177593904;5802.071668533099;5805.071188609887;5814.854628634233;5819.505342045889;5632.352279487829;5730.140478928194;5794.942050579441;5797.275340582427;5892.941070589325;5769.163471296639;5810.1865738796605;5812.7674893003805;5814.476697097281;5819.039858423313;5766.0197766379815;5830.795922142789;5834.066549352084;5834.912476312774;5838.065909454552;4298.2263192625005;4330.805113769888;4333.58830911063;4385.934210986838;4395.099004704028;3950.48643676326;3975.960240397617;3976.2842688315804;3980.960190398059;3982.183652351261;5414.91877621836;5422.8373148805595;5429.6742195467605;5434.782608695607;5491.203775452537;5840.620359676607;5876.265466816648;5894.263217097863;5902;5954.047352423591;5490.56075513958;5492.1212605982855;5504.0643090674685;5505.779768809283;5511.145772405283;4906.779194936236;4965.3048573199785;5016.498350165028;5019.42276638184;5033.597312215014;6060.606060606135;6065.969670151621;6074.787382441594;6084.787032453843;6089.269287685506;5870.559708021916;5893.410658934073;5900.498457631149;5900.763969441175;5903.557233207441;5851.590388672752;6003.969980150246;6040;6059.3334733178435;6125.296497837459;5774.740136693775;5779.2198053263955;5800.24596802413;5817.098349755625;5865.384134665798;5908.113782932594;5937.851553711019;5938.317093534299;5938.73275702603;5939.227900372924;5577.27495425592;5682.318121825408;5718.25662663851;5738.454846789548;5763.4812866842185;5736.512396446349;5742.310922689304;5742.483176514133;5746.109353050284;5749.741261643152;5434.510894019557;5633.915491267716;5647.717614119196;5648;5648.774049037993;5664.8300550981885;5740.368559458373;5745.454181852718;5825.213596164633;5829.7085145743395;5597.356304024926;5635.15472679085;5635.971820140873;5640.971795140998;5642.069058605284 14:37:54 INFO - PROCESS | 21097 | |1;ext.html;613.9324674285828;635.9427651511363;637.1334984421188;645.670707938951;649.4285029174329;31478;34213.486797698024;34289.14277143073;43093.56906430935;44277.33583996243;46399.536004639944;46690.299645505256;46758.766206169006;46875.29687054688;46952.295715564294;8482.363822713305;8635.95682021589;8649.351298652626;8649.827003459926;8659.69691060813;8548.316134709208;8685.435446695945;8694.739157825275;8709.60806763694;8714.215720585145;8725.825483490325;8780.078091800366;8784.736457906272;8787.912120878806;8789.824203515926;8701.56492175392;8770.122987701243;8770.473771573663;8775.517346545937;8777.956110219471;8623.82752344956;8678.86981695275;8686.695965641173;8687.391882568223;8687.913120868774;42689.57310426887;43097;43114.78442607767;43141.784291078344;43151;3261.673832616743;3519.4017017107153;3602.081469225357;3699.7040236780995;3976.443297938291;32530.512042319384;32560.837195814107;33252.50121248183;33296.1675958103;33350.16624584381;4173.728707633994;4375.409319741826;4430.091831174602;4475.261581838992;4480.059187570614;359665;360024;361559;361974;362331;62091;62381.37618623846;62495.375046249865;62505;62697;66091.33908660852;66487;66696.6665166671;66698;66739;17383.304667813147;17523;17531.64936701259;17573.297068117132;17623.295068197385;13191.604251872459;13235.139715918434;13242;13284.933575332254;13308.068435209636;18667.533311667044;19753.40739777809;19838.40484785459;19850.20599176017;19925.402237932885;7053.858922821515;7384.176621926224;7398.408127349907;7484.5883476408235;7558.281963213486;841.6086519768337;980.7401038724744;1092.847001419802;1097.8847221041835;1219.2257916223261;32552.837235814142;34048.659513405044;34190;34262.96004635708;34338.48492272618;1108.828131639581;1162.2503485251966;1203.2299328429813;1211.4669545399995;1301.5119330251157;17307.653846922993;17823.287068517373;17865;17921.37275195362;17969.7304540432;530171;535599;535963;536882.2623547586;536986;59642.403575964556;60351.09473357903;61020.084698728664;61059.694701526205;61137.69431152816;1300.3108352573151;1387.5074348606302;1503.9624009399633;1619.5141457562684;1620.0441739373825;27835.582466263426;29885.402291953604;30319.545206822357;30508.237294067825;30940;52384.738076309375;53422.46577534175;53528.1970770431;53600.46399535955;53605.73197133989;475426;483136;483284;483760;516870;44979.32531011972;45674.54325456703;46489.30266045944;48861.51138488569;50318.748406257735;50423.24365134453;50496.747516263655;51080.47374426403;51545;52173.7391313041;42144.78927605342;42747.145057099304;43497;43535.34696979611;44311.55688443074;41737.58262417337;42029;42395.364069538366;42538.78730606327;43522.12955740804;41545;41759.58240417557;42938.1412371757;43047;43095.56904430916;35590.28819423545;37394.43908341431;37437.43843842399;38123.618763813116;38219.808900955315;28179.295517612223;28937.13188604345;28974.855125724236;29084.12747617575;29111.708882910898 14:37:54 INFO - PROCESS | 21097 | |2;jquery.html;391.6259971726999;391.6416478921787;394.3260857659237;394.960503949605;415.3375366290767;18178.27286908522;19628.31300904465;19682.212711491542;19703.31038413656;20404.795952040477;18783.3425830096;19236;19315.710264346046;19653;19750.506237344074;5420.1327787554;5613.186088017245;5718.971405142968;5741.569382296345;5819.039858423376;5754;5759.856003599923;5775.451332123463;5784.710764461781;5805.5065319447895;5706.857328566777;5713.714314284269;5860.73626686798;5870.295564532262;5873.676947767871;5771.624844385102;5777.422257774231;5788.710564471801;5825.417458254162;5852.531797456193;5520.337559492847;5606.747696353674;5637.126245431924;5646.943530564683;5651;13146.671333216651;13398.464061437531;20022.69965950512;22250.88874555633;22528.634493378122;2244.955100897973;2258.2209137847417;2261.9208327708616;2275.82931280153;2299.091858715798;9479.28905332096;9890.20878329732;9928.354656947347;10302.948485257526;10349.172066234683;1901.3630433804692;1910.646530391882;1945.6108778244266;2017.9192832286838;2042.3668662714606;79487.6025619874;83710;84041;85294.57352713258;85362;10521.947390263;10740.516676749565;10815.56737730482;10964.725881853017;11070.169737269576;15209.239538023054;15276.847231527765;15295.92352038255;15308.617284567976;15331.156786376856;7662.540247585162;7863.567503787347;7902.209779022167;7976.641051152712;8023.959880200561;7598.126215485179;7646.158922518519;7668.808279792938;7807.093211180244;7876.251756083163;4649.860504184812;4661.976690116596;4670.206064968964;4699.224627936421;4700.788464519105;1874.7375367448567;1884.6230753849286;1920;1926.7880533141342;1949.2008276606523;905.2260317428635;1035.968920932358;1056.8414737789394;1087.0434018064211;1100.315582834285;18974.81025189758;19613.254144419792;19613.313534026525;19671.803281966997;19768.520585594197;1002.4185972136144;1004.1916257412706;1023.4831410137981;1066.5094056733835;1074.7581794096266;10528.467444411268;10895.128389728803;10923.563057477772;11000.394978276272;11028.669139925654;471430;471946;525132;529308;532888;93376;94962;96777.51611241899;98504.50747746216;100055;1002.8445590933417;1022.2895087913977;1044.587387981743;1055.1137044882337;1068.3803394031443;17190;17271.962193306263;17494.300227990738;17519.82480175182;17719.73420398721;40401.595984039785;41281.793591031856;41466;41789.16421671489;42747.35878961756;58574.41425585689;59823;59983;60359;60612.39387606244;7382.298681625237;7641.42689298316;8287.50274983503;8620.52587107715;8826.470411775314;12724.6182614518;13152.276624785729;13160.934195328962;13189.604311870658;13356.666083347995;11607.941960290482;11659.825102623297;11795.705107372385;11847;12014.459349329476;11234.4382780859;11291.604793832505;11351.318920864775;11379.829302560303;11499.252548584314;6499.935000649933;8709.912900871164;11913.880861191625;11917.880821192024;12016.819747703967;7023.68393422287;7254.528455650366;7330.340269375782;7885.250901164381;8143.51138931666;10905.400202988912;11366.715832104264;11537.653870383901;11671.59149429766;11954.641360759191 14:37:54 INFO - PROCESS | 21097 | |3;mootools.html;1293.838270216223;1489.3670190169178;1490.359145567406;1638.713225185593;1775.8224177582244;8067.112617612058;8794.944606647203;9041.186293233608;9060.139286767762;9289.071092890708;8949.731508054752;9080.27357811375;9146.542672866346;9151.496667683276;9155.267578593714;2058.135583055113;2311.838171328008;2367.3608125806063;2383.678203442539;2402.327348342467;2410.6384042393606;2434.1358817619666;2436.9634455483183;2438.8048956083558;2439.4633180700216;2342.320726989171;2377.1917548033666;2377.655239990209;2378.7740164684415;2379.1910750344878;1986.0864002558767;2293.564222797663;2362.2913126062285;2362.70466191726;2377.09670325277;2277.089164334263;2295.7933785959344;2298.7011688480557;2299.494111295529;2307.8730669813153;8866.157715017063;8869.068747781455;8907.599158037903;8935.553222338856;8947.821043579157;5233.450487698813;5407.756650950717;5407.83776486706;5413.242146099549;5414.566834653218;3196.5205219217305;3353.5975682918206;3379.5268662387284;3439.9656003439895;3469.09803451102;1111.2388014210292;1128.317367992361;1153.9192256542046;1188.7265928836416;1192.0926517571816;13104.148230364995;13130.606081817561;13147.079704420694;13155.210687358789;13166.341682915816;4584.4498660161;4754.857354279377;4777.689450185727;4820.783064762094;4843.854684359475;10879.673609791718;10880.945595271973;10885.564577416973;10895.291806032583;10905.400202988752;4846.539578740014;5432.864178395572;5476.890462190734;5492.615516913777;5499.477549632778;4834.8791280218275;4959.08256972454;4960.454350021495;4974.0797952378925;4985.401751789808;4069.3315740546236;4108.746832216203;4119.176164767058;4261.893452663709;4287.7212981156745;1232.5131573028782;1265.6519457149357;1267.5626908716479;1285.13895689888;1289.4970961325091;882.2565101191291;898.384606544506;996.9501524923725;1040.8334666453331;1048.9580416783242;6099.207103076572;6199.721012554446;6283.59156654816;6392.7123279452535;6528.51036172289;936.134075979716;982.0572250639324;1007.7329507680471;1008.3496144986443;1012.2509343086064;4215.409842622035;4247.532771395144;4281.507626622916;4342.305231162999;4408.404865343202;10952.39761813092;11311.321320720783;11433.59982400612;11444.771104577861;11456.4844581994;11234.831477527843;11237.71905702364;11258.943705281421;11277.097832173406;11283.040941520063;8505.106963768716;8534.146585341416;8573.271271941954;8664.436811607351;8686.305095592337;6059.242594675666;6159.414855588712;6342.7145778441;6409.775657851953;6521.217453905561;9963;10277.84583231267;10529.526171322463;10539.367637941748;10550.683479495627;10543.789124217627;10776.407297598707;10882.455877206266;10937.179711521827;11070.5571777128;7875.212478752079;8074.59627018635;8144.226298501633;8155.79610509742;8192.918070819216;8927.598258078531;8950.373473856767;8979.326550508607;8987.685431009882;9022.413543119676;7830.921690783247;8065.516069035877;8095.081280124568;8108.83782324362;8233.34133269325;7889.526628402315;7918.2477664621765;7958.204179581995;8071.071826739765;8102.5948702563455;6824.624645644339;6864.313568643096;6890.173179218526;6901.482388820959;7102.609356485236;5222.3733152022005;5312.5484333832055;5322.228276899906;5349.170878513836;5436.456354364532;5228.215767634885;5261.342332208474;5355.062863998863;5382.407935127055;5432.348118225838 14:37:54 INFO - PROCESS | 21097 | |4;prototype.html;326.47274651437937;332.22756593573285;339.5958809017269;340.49096600582124;343.89683095071473;5271.471273330734;5317;5323.547498462635;5339.412664606895;5343.839684809453;5065.316182315386;5077.1622682257475;5184.818531351403;5201.687898726079;5266.841994740154;4022.5776293489203;4079.571644977279;4114;4151.916961660765;4163.854265100722;4091.6317531422164;4126.938095928564;4142.399352093945;4146.6268035876765;4155.896102597429;4035.3946907963896;4061.1268577255883;4136.110736191718;4151.854685086023;4154.709170358076;4099.364598487239;4109.3425051991835;4124.979375103136;4141.088960428716;4144;3646.5441819772527;3658.396364599838;3659.79871107089;3663.9450408243897;3678.5769636491877;4805.068907966138;5067.113255180366;5072.822451214227;5080.263361812516;5097.464766199532;4638.350630911675;4653.976730116327;4703.129920964632;4711.24620060792;4720.575148236675;5490.203920431515;5512.39363669996;5521.1442226454965;5531.723413829292;5551.500364967173;3892.2215556888737;3897.6881849451975;3954.604539546051;3971.6028397160344;3976.8011599419915;5697.344805347355;5714.285714285715;5753;5766.596338256324;5770.19217309577;3986.5016872890887;3989.4813674222746;4006.2788698034633;4032.1935612876955;4047.777372244555;4035.6569691576547;4053.493313335833;4083.5508094109623;4100.446439730657;4121.443605113272;4554.95445045552;4679.555442232982;4688.226442636927;4689;4698.929516057262;5467.015937131275;5487.6158668892795;5501.477359650827;5515.696636685021;5522.530584900329;1331.8734720201564;1357.4027427931678;1381.8687224713838;1412.653899794557;1418.21997901156;891.38494438837;895.3463971300987;906.4787747045475;917.3440989692402;925.9721708903112;4663.642177632099;4707.8587642370785;4708.929366059512;4738.502457242009;4761.642876784255;5025.773840177128;5026.447090820006;5030;5038.899222015612;5070.3155074064525;4562.5665561771575;4716.88207794801;4744.525547445228;4760;4775.068861572029;2565.961510577343;2634.841909485437;2674.5586978148776;2675;2678.6517752692025;5075.923861142012;5089;5135.7432128394175;5177.456367081478;5189.42916279209;5018.293780114778;5026.768441731799;5028.522290382408;5084.3898732152375;5354.303940487712;5840.532757379399;5851.678157701367;5876;5893.882122357529;5922.170896074553;5589.490837473941;5683.2666036859155;5709.942900570941;5742.971285143548;5743.74153163117;5568;5577.721113944205;5586.011483856118;5628.1557766333735;5729.369769325454;5803.593748437569;5844.766209351578;5875.794347197828;5885.852853678521;5886.20536227621;4048.9392659110727;4053.635172834459;4064.878053658395;4087.7956102195367;4101.794910254535;5366.899785543876;5544.889102218014;5659.745311460912;5680.460356266148;5690;5443.618946673695;5551.751540626053;5572.3034620672415;5585.273914391103;5622.775088996558;5498.45015498463;5513.7794488221625;5552.361478430033;5559.138333558305;5593.552515798808;5243.711595862264;5423.864403389947;5447.373552041566;5448.7548060336585;5457.235986961749;5462.590305727007;5500.917486237629;5515.703809604659;5519.558435325244;5527.5577953764405;5430.945690543044;5480.890382192254;5506.752196151103;5516.834494965157;5521.171824226398 14:37:54 INFO - PROCESS | 21097 | |5;yui.html;701.5510073552924;720.0881659194837;753.2279413601058;789.9131095579487;802.4543310548828;15639.296231669574;16126.677466450694;16142.919285403586;16170.676586468278;16196.433124840647;14754.704905901875;14825.036372635772;14825.332860021297;14867.479638212664;14870.851291487083;677.3159109299618;781.8670825959572;803.3773825285407;807.0597753617029;813.1258896686086;800.047942947893;806.3992325717348;807.3662175192475;808.8786681997689;810.1452967119686;837.5016864965336;837.874318852174;838.2330167896367;838.2372041442288;839.7816567692413;706.7702996526124;717.519262094398;720.4884531982325;815.8531464336417;832.6544484039116;616.6639181646013;621.549376701892;621.7450845153511;621.8072397556726;621.8694074244414;15220;15227.467038653705;15235.238238088052;15241.542753717406;15245.161516116608;14495.492657757033;14678.266086695729;14740.631484212874;14754.631134221623;14919.104853708812;12608.74782504354;12742.426590803436;12763.617091487271;12885.87114128856;13046.282454465096;4463.303161589031;4471.128130014648;4481.73109613421;4542.182407166709;4654.371659825914;77920.22079779186;79067.6046619769;79134.60432697857;80227;80661;11423.314601123959;11471;11565.653030409101;11706.531738730526;11860.22908510944;21609.459763506038;21726.13095476195;21767.238146665106;21780.782192177874;21816;8406.28546573548;8464;8489.83020339602;8562.914370856337;8645.351598630128;4639.605633521189;4660.883477913011;4747.572718455355;4748.738819364969;4803.279508073817;3476.061463404917;3549.378858699717;3596.8021758802993;3597.442396428558;3606.5311509503595;634.1977398590786;639.9072134540465;644.9580777249464;688.4784625976548;721.8267615772177;617.8795134948642;762.0453536678402;762.5043721581017;769.2730369800485;808.7088648086684;10233.232507561963;10515.26393152472;10716.624918127829;10795.190360722978;10959.726006849893;658.5653468710628;707.5542408282749;765.1774342581635;790.3440144679902;797.2585495489251;5010.273510341053;5142.460041695568;5206.843794686166;5224.16413373866;5235;75907;76808.61595691986;118090;123562;126949;102636.48681756693;105072;105596.47201763942;105875.47062264639;107340;60198.39801602015;84055.15944840596;84462;86857.5657121723;94073;9676.56455459492;9778.853317200106;9788.951055244679;9789.755256118655;9858.457784821903;40656;42719.5728042728;44053.33919991139;48969.510304896496;51018;66984.66507667431;73284.24388756443;73336;74052.62973685097;74575.62712186405;12516.245126461843;12669.176503527242;12824.29466379358;12901.419436125585;13149;14113.364898579794;14183.858161418253;14441.711165776416;15109.244537772847;15110.39558417651;14167.64580885445;14268.21524816145;14548;14830.88932698358;14832.480863169738;12049.277043377426;13817.447302108205;13908.165510069428;14195.858041419453;15119.848801511844;12212.764895289776;12353.197042192229;12388.318642474751;12610.43253053633;12846.743065138831;10580.576776929145;10751.9844516171;11138.3873886937;11562.884371156517;11731.924477046954;11213.775724485628;11929.038430081879;12021.879781202077;12138.150329476852;12139.817902731289 14:37:54 INFO - PROCESS | 21097 | __end_tp_report 14:37:54 INFO - PROCESS | 21097 | __start_cc_report 14:37:54 INFO - PROCESS | 21097 | _x_x_mozilla_cycle_collect,923 14:37:54 INFO - PROCESS | 21097 | __end_cc_report 14:37:54 INFO - PROCESS | 21097 | __startTimestamp1464989874014__endTimestamp 14:37:54 INFO - PROCESS | 21097 | 14:37:54 INFO - PROCESS | 21097 | ------- Summary: start ------- 14:37:54 INFO - PROCESS | 21097 | Number of tests: 6 14:37:54 INFO - PROCESS | 21097 | 14:37:54 INFO - PROCESS | 21097 | [#0] dojo.html Cycles:165 Average:5422.85 Median:5640.97 stddev:638.38 (11.3%) stddev-sans-first:614.37 14:37:54 INFO - PROCESS | 21097 | Values: 3125.0 3133.2 3142.0 3167.1 3194.2 5300.9 5319.4 5395.1 5516.3 5523.7 5428.1 5441.2 5461.8 5494.4 5551.3 4875.8 4935.5 4961.1 4979.0 5106.6 4995.8 5027.0 5052.8 5055.9 5073.4 4828.6 4883.0 4883.8 4884.8 4887.0 4898.2 4939.2 4939.2 4953.1 4977.5 4902.0 4911.4 4925.3 4925.9 4944.5 5226.4 5271.7 5314.2 5370.1 5401.7 5937.6 5941.1 5947.0 5956.7 5958.6 5949.6 5960.7 5982.4 5983.7 5989.5 5230.1 5339.3 5392.2 5397.6 5513.1 6026.3 6046.8 6047.4 6054.5 6068.6 5799.0 5802.1 5805.1 5814.9 5819.5 5632.4 5730.1 5794.9 5797.3 5892.9 5769.2 5810.2 5812.8 5814.5 5819.0 5766.0 5830.8 5834.1 5834.9 5838.1 4298.2 4330.8 4333.6 4385.9 4395.1 3950.5 3976.0 3976.3 3981.0 3982.2 5414.9 5422.8 5429.7 5434.8 5491.2 5840.6 5876.3 5894.3 5902.0 5954.0 5490.6 5492.1 5504.1 5505.8 5511.1 4906.8 4965.3 5016.5 5019.4 5033.6 6060.6 6066.0 6074.8 6084.8 6089.3 5870.6 5893.4 5900.5 5900.8 5903.6 5851.6 6004.0 6040.0 6059.3 6125.3 5774.7 5779.2 5800.2 5817.1 5865.4 5908.1 5937.9 5938.3 5938.7 5939.2 5577.3 5682.3 5718.3 5738.5 5763.5 5736.5 5742.3 5742.5 5746.1 5749.7 5434.5 5633.9 5647.7 5648.0 5648.8 5664.8 5740.4 5745.5 5825.2 5829.7 5597.4 5635.2 5636.0 5641.0 5642.1 14:37:54 INFO - PROCESS | 21097 | 14:37:54 INFO - PROCESS | 21097 | [#1] ext.html Cycles:180 Average:63218.22 Median:43528.74 stddev:123878.78 (284.6%) stddev-sans-first:124137.11 14:37:54 INFO - PROCESS | 21097 | Values: 613.9 635.9 637.1 645.7 649.4 31478.0 34213.5 34289.1 43093.6 44277.3 46399.5 46690.3 46758.8 46875.3 46952.3 8482.4 8636.0 8649.4 8649.8 8659.7 8548.3 8685.4 8694.7 8709.6 8714.2 8725.8 8780.1 8784.7 8787.9 8789.8 8701.6 8770.1 8770.5 8775.5 8778.0 8623.8 8678.9 8686.7 8687.4 8687.9 42689.6 43097.0 43114.8 43141.8 43151.0 3261.7 3519.4 3602.1 3699.7 3976.4 32530.5 32560.8 33252.5 33296.2 33350.2 4173.7 4375.4 4430.1 4475.3 4480.1 359665.0 360024.0 361559.0 361974.0 362331.0 62091.0 62381.4 62495.4 62505.0 62697.0 66091.3 66487.0 66696.7 66698.0 66739.0 17383.3 17523.0 17531.6 17573.3 17623.3 13191.6 13235.1 13242.0 13284.9 13308.1 18667.5 19753.4 19838.4 19850.2 19925.4 7053.9 7384.2 7398.4 7484.6 7558.3 841.6 980.7 1092.8 1097.9 1219.2 32552.8 34048.7 34190.0 34263.0 34338.5 1108.8 1162.3 1203.2 1211.5 1301.5 17307.7 17823.3 17865.0 17921.4 17969.7 530171.0 535599.0 535963.0 536882.3 536986.0 59642.4 60351.1 61020.1 61059.7 61137.7 1300.3 1387.5 1504.0 1619.5 1620.0 27835.6 29885.4 30319.5 30508.2 30940.0 52384.7 53422.5 53528.2 53600.5 53605.7 475426.0 483136.0 483284.0 483760.0 516870.0 44979.3 45674.5 46489.3 48861.5 50318.7 50423.2 50496.7 51080.5 51545.0 52173.7 42144.8 42747.1 43497.0 43535.3 44311.6 41737.6 42029.0 42395.4 42538.8 43522.1 41545.0 41759.6 42938.1 43047.0 43095.6 35590.3 37394.4 37437.4 38123.6 38219.8 28179.3 28937.1 28974.9 29084.1 29111.7 14:37:54 INFO - PROCESS | 21097 | 14:37:54 INFO - PROCESS | 21097 | [#2] jquery.html Cycles:180 Average:29476.68 Median:12393.43 stddev:83707.95 (675.4%) stddev-sans-first:83914.28 14:37:54 INFO - PROCESS | 21097 | Values: 391.6 391.6 394.3 395.0 415.3 18178.3 19628.3 19682.2 19703.3 20404.8 18783.3 19236.0 19315.7 19653.0 19750.5 5420.1 5613.2 5719.0 5741.6 5819.0 5754.0 5759.9 5775.5 5784.7 5805.5 5706.9 5713.7 5860.7 5870.3 5873.7 5771.6 5777.4 5788.7 5825.4 5852.5 5520.3 5606.7 5637.1 5646.9 5651.0 13146.7 13398.5 20022.7 22250.9 22528.6 2245.0 2258.2 2261.9 2275.8 2299.1 9479.3 9890.2 9928.4 10302.9 10349.2 1901.4 1910.6 1945.6 2017.9 2042.4 79487.6 83710.0 84041.0 85294.6 85362.0 10521.9 10740.5 10815.6 10964.7 11070.2 15209.2 15276.8 15295.9 15308.6 15331.2 7662.5 7863.6 7902.2 7976.6 8024.0 7598.1 7646.2 7668.8 7807.1 7876.3 4649.9 4662.0 4670.2 4699.2 4700.8 1874.7 1884.6 1920.0 1926.8 1949.2 905.2 1036.0 1056.8 1087.0 1100.3 18974.8 19613.3 19613.3 19671.8 19768.5 1002.4 1004.2 1023.5 1066.5 1074.8 10528.5 10895.1 10923.6 11000.4 11028.7 471430.0 471946.0 525132.0 529308.0 532888.0 93376.0 94962.0 96777.5 98504.5 100055.0 1002.8 1022.3 1044.6 1055.1 1068.4 17190.0 17272.0 17494.3 17519.8 17719.7 40401.6 41281.8 41466.0 41789.2 42747.4 58574.4 59823.0 59983.0 60359.0 60612.4 7382.3 7641.4 8287.5 8620.5 8826.5 12724.6 13152.3 13160.9 13189.6 13356.7 11607.9 11659.8 11795.7 11847.0 12014.5 11234.4 11291.6 11351.3 11379.8 11499.3 6499.9 8709.9 11913.9 11917.9 12016.8 7023.7 7254.5 7330.3 7885.3 8143.5 10905.4 11366.7 11537.7 11671.6 11954.6 14:37:54 INFO - PROCESS | 21097 | 14:37:54 INFO - PROCESS | 21097 | [#3] mootools.html Cycles:180 Average:6011.77 Median:4766.27 stddev:3466.36 (72.7%) stddev-sans-first:3457.95 14:37:54 INFO - PROCESS | 21097 | Values: 1293.8 1489.4 1490.4 1638.7 1775.8 8067.1 8794.9 9041.2 9060.1 9289.1 8949.7 9080.3 9146.5 9151.5 9155.3 2058.1 2311.8 2367.4 2383.7 2402.3 2410.6 2434.1 2437.0 2438.8 2439.5 2342.3 2377.2 2377.7 2378.8 2379.2 1986.1 2293.6 2362.3 2362.7 2377.1 2277.1 2295.8 2298.7 2299.5 2307.9 8866.2 8869.1 8907.6 8935.6 8947.8 5233.5 5407.8 5407.8 5413.2 5414.6 3196.5 3353.6 3379.5 3440.0 3469.1 1111.2 1128.3 1153.9 1188.7 1192.1 13104.1 13130.6 13147.1 13155.2 13166.3 4584.4 4754.9 4777.7 4820.8 4843.9 10879.7 10880.9 10885.6 10895.3 10905.4 4846.5 5432.9 5476.9 5492.6 5499.5 4834.9 4959.1 4960.5 4974.1 4985.4 4069.3 4108.7 4119.2 4261.9 4287.7 1232.5 1265.7 1267.6 1285.1 1289.5 882.3 898.4 997.0 1040.8 1049.0 6099.2 6199.7 6283.6 6392.7 6528.5 936.1 982.1 1007.7 1008.3 1012.3 4215.4 4247.5 4281.5 4342.3 4408.4 10952.4 11311.3 11433.6 11444.8 11456.5 11234.8 11237.7 11258.9 11277.1 11283.0 8505.1 8534.1 8573.3 8664.4 8686.3 6059.2 6159.4 6342.7 6409.8 6521.2 9963.0 10277.8 10529.5 10539.4 10550.7 10543.8 10776.4 10882.5 10937.2 11070.6 7875.2 8074.6 8144.2 8155.8 8192.9 8927.6 8950.4 8979.3 8987.7 9022.4 7830.9 8065.5 8095.1 8108.8 8233.3 7889.5 7918.2 7958.2 8071.1 8102.6 6824.6 6864.3 6890.2 6901.5 7102.6 5222.4 5312.5 5322.2 5349.2 5436.5 5228.2 5261.3 5355.1 5382.4 5432.3 14:37:54 INFO - PROCESS | 21097 | 14:37:54 INFO - PROCESS | 21097 | [#4] prototype.html Cycles:180 Average:4554.23 Median:5071.57 stddev:1341.11 (26.4%) stddev-sans-first:1306.79 14:37:54 INFO - PROCESS | 21097 | Values: 326.5 332.2 339.6 340.5 343.9 5271.5 5317.0 5323.5 5339.4 5343.8 5065.3 5077.2 5184.8 5201.7 5266.8 4022.6 4079.6 4114.0 4151.9 4163.9 4091.6 4126.9 4142.4 4146.6 4155.9 4035.4 4061.1 4136.1 4151.9 4154.7 4099.4 4109.3 4125.0 4141.1 4144.0 3646.5 3658.4 3659.8 3663.9 3678.6 4805.1 5067.1 5072.8 5080.3 5097.5 4638.4 4654.0 4703.1 4711.2 4720.6 5490.2 5512.4 5521.1 5531.7 5551.5 3892.2 3897.7 3954.6 3971.6 3976.8 5697.3 5714.3 5753.0 5766.6 5770.2 3986.5 3989.5 4006.3 4032.2 4047.8 4035.7 4053.5 4083.6 4100.4 4121.4 4555.0 4679.6 4688.2 4689.0 4698.9 5467.0 5487.6 5501.5 5515.7 5522.5 1331.9 1357.4 1381.9 1412.7 1418.2 891.4 895.3 906.5 917.3 926.0 4663.6 4707.9 4708.9 4738.5 4761.6 5025.8 5026.4 5030.0 5038.9 5070.3 4562.6 4716.9 4744.5 4760.0 4775.1 2566.0 2634.8 2674.6 2675.0 2678.7 5075.9 5089.0 5135.7 5177.5 5189.4 5018.3 5026.8 5028.5 5084.4 5354.3 5840.5 5851.7 5876.0 5893.9 5922.2 5589.5 5683.3 5709.9 5743.0 5743.7 5568.0 5577.7 5586.0 5628.2 5729.4 5803.6 5844.8 5875.8 5885.9 5886.2 4048.9 4053.6 4064.9 4087.8 4101.8 5366.9 5544.9 5659.7 5680.5 5690.0 5443.6 5551.8 5572.3 5585.3 5622.8 5498.5 5513.8 5552.4 5559.1 5593.6 5243.7 5423.9 5447.4 5448.8 5457.2 5462.6 5500.9 5515.7 5519.6 5527.6 5430.9 5480.9 5506.8 5516.8 5521.2 14:37:54 INFO - PROCESS | 21097 | 14:37:54 INFO - PROCESS | 21097 | [#5] yui.html Cycles:180 Average:20575.27 Median:24258.32 stddev:29429.85 (121.3%) stddev-sans-first:29474.58 14:37:54 INFO - PROCESS | 21097 | Values: 701.6 720.1 753.2 789.9 802.5 15639.3 16126.7 16142.9 16170.7 16196.4 14754.7 14825.0 14825.3 14867.5 14870.9 677.3 781.9 803.4 807.1 813.1 800.0 806.4 807.4 808.9 810.1 837.5 837.9 838.2 838.2 839.8 706.8 717.5 720.5 815.9 832.7 616.7 621.5 621.7 621.8 621.9 15220.0 15227.5 15235.2 15241.5 15245.2 14495.5 14678.3 14740.6 14754.6 14919.1 12608.7 12742.4 12763.6 12885.9 13046.3 4463.3 4471.1 4481.7 4542.2 4654.4 77920.2 79067.6 79134.6 80227.0 80661.0 11423.3 11471.0 11565.7 11706.5 11860.2 21609.5 21726.1 21767.2 21780.8 21816.0 8406.3 8464.0 8489.8 8562.9 8645.4 4639.6 4660.9 4747.6 4748.7 4803.3 3476.1 3549.4 3596.8 3597.4 3606.5 634.2 639.9 645.0 688.5 721.8 617.9 762.0 762.5 769.3 808.7 10233.2 10515.3 10716.6 10795.2 10959.7 658.6 707.6 765.2 790.3 797.3 5010.3 5142.5 5206.8 5224.2 5235.0 75907.0 76808.6 118090.0 123562.0 126949.0 102636.5 105072.0 105596.5 105875.5 107340.0 60198.4 84055.2 84462.0 86857.6 94073.0 9676.6 9778.9 9789.0 9789.8 9858.5 40656.0 42719.6 44053.3 48969.5 51018.0 66984.7 73284.2 73336.0 74052.6 74575.6 12516.2 12669.2 12824.3 12901.4 13149.0 14113.4 14183.9 14441.7 15109.2 15110.4 14167.6 14268.2 14548.0 14830.9 14832.5 12049.3 13817.4 13908.2 14195.9 15119.8 12212.8 12353.2 12388.3 12610.4 12846.7 10580.6 10752.0 11138.4 11562.9 11731.9 11213.8 11929.0 12021.9 12138.2 12139.8 14:37:54 INFO - PROCESS | 21097 | -------- Summary: end -------- 14:37:54 INFO - PROCESS | 21097 | 14:37:54 INFO - TEST-INFO | 21097: exit 0 14:37:54 INFO - TEST-OK | dromaeo_css | took 1112131ms 14:37:54 INFO - TEST-START | kraken 14:37:54 INFO - operating with platform_type : linux_ 14:37:54 INFO - Initialising browser for kraken test... 14:37:54 INFO - TEST-INFO | started process 21275 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBlvmys/profile http://localhost:58635/getInfo.html) 14:37:58 INFO - PROCESS | 21275 | __metrics Screen width/height:1600/1200 14:37:58 INFO - PROCESS | 21275 | colorDepth:24 14:37:58 INFO - PROCESS | 21275 | Browser inner width/height: 1024/697 14:37:58 INFO - PROCESS | 21275 | __metrics 14:37:58 ERROR - PROCESS | 21275 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:37:59 INFO - TEST-INFO | 21275: exit 0 14:37:59 INFO - Browser initialized. 14:37:59 INFO - Running cycle 1/1 for kraken test... 14:37:59 INFO - TEST-INFO | started process 21357 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBlvmys/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:38:11 INFO - PROCESS | 21357 | RSS: Main: 156135424 14:38:11 INFO - PROCESS | 21357 | 14:38:14 INFO - PROCESS | 21357 | Cycle 1(1): loaded http://localhost:58635/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58635/tests/kraken/driver.html?testName=audio-beat-detection) 14:38:14 INFO - PROCESS | 21357 | RSS: Main: 214466560 14:38:14 INFO - PROCESS | 21357 | 14:38:17 INFO - PROCESS | 21357 | Cycle 1(1): loaded http://localhost:58635/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58635/tests/kraken/driver.html?testName=audio-dft) 14:38:18 INFO - PROCESS | 21357 | RSS: Main: 201555968 14:38:18 INFO - PROCESS | 21357 | 14:38:21 INFO - PROCESS | 21357 | Cycle 1(1): loaded http://localhost:58635/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58635/tests/kraken/driver.html?testName=audio-fft) 14:38:21 INFO - PROCESS | 21357 | RSS: Main: 268746752 14:38:21 INFO - PROCESS | 21357 | 14:38:24 INFO - PROCESS | 21357 | Cycle 1(1): loaded http://localhost:58635/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58635/tests/kraken/driver.html?testName=audio-oscillator) 14:38:24 INFO - PROCESS | 21357 | RSS: Main: 179945472 14:38:24 INFO - PROCESS | 21357 | 14:38:26 INFO - PROCESS | 21357 | Cycle 1(1): loaded http://localhost:58635/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58635/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:38:27 INFO - PROCESS | 21357 | RSS: Main: 184004608 14:38:27 INFO - PROCESS | 21357 | 14:38:30 INFO - PROCESS | 21357 | Cycle 1(1): loaded http://localhost:58635/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58635/tests/kraken/driver.html?testName=imaging-darkroom) 14:38:31 INFO - PROCESS | 21357 | RSS: Main: 218529792 14:38:31 INFO - PROCESS | 21357 | 14:38:34 INFO - PROCESS | 21357 | Cycle 1(1): loaded http://localhost:58635/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58635/tests/kraken/driver.html?testName=imaging-desaturate) 14:38:34 INFO - PROCESS | 21357 | RSS: Main: 220315648 14:38:34 INFO - PROCESS | 21357 | 14:38:37 INFO - PROCESS | 21357 | Cycle 1(1): loaded http://localhost:58635/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58635/tests/kraken/driver.html?testName=json-parse-financial) 14:38:38 INFO - PROCESS | 21357 | RSS: Main: 220983296 14:38:38 INFO - PROCESS | 21357 | 14:38:39 INFO - PROCESS | 21357 | Cycle 1(1): loaded http://localhost:58635/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58635/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:38:40 INFO - PROCESS | 21357 | RSS: Main: 206082048 14:38:40 INFO - PROCESS | 21357 | 14:38:42 INFO - PROCESS | 21357 | Cycle 1(1): loaded http://localhost:58635/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58635/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:38:42 INFO - PROCESS | 21357 | RSS: Main: 210776064 14:38:42 INFO - PROCESS | 21357 | 14:38:44 INFO - PROCESS | 21357 | Cycle 1(1): loaded http://localhost:58635/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58635/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:38:45 INFO - PROCESS | 21357 | RSS: Main: 217227264 14:38:45 INFO - PROCESS | 21357 | 14:38:48 INFO - PROCESS | 21357 | Cycle 1(1): loaded http://localhost:58635/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58635/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:38:48 INFO - PROCESS | 21357 | RSS: Main: 223031296 14:38:48 INFO - PROCESS | 21357 | 14:38:51 INFO - PROCESS | 21357 | Cycle 1(1): loaded http://localhost:58635/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58635/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:38:52 INFO - PROCESS | 21357 | RSS: Main: 223170560 14:38:52 INFO - PROCESS | 21357 | 14:38:53 INFO - PROCESS | 21357 | Cycle 1(1): loaded http://localhost:58635/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58635/tests/kraken/driver.html?testName=ai-astar) 14:38:54 INFO - PROCESS | 21357 | RSS: Main: 265342976 14:38:54 INFO - PROCESS | 21357 | 14:38:54 INFO - PROCESS | 21357 | __start_tp_report 14:38:54 INFO - PROCESS | 21357 | _x_x_mozilla_page_load 14:38:54 INFO - PROCESS | 21357 | _x_x_mozilla_page_load_details 14:38:54 INFO - PROCESS | 21357 | |i|pagename|runs| 14:38:54 INFO - PROCESS | 21357 | |0;ai-astar;112;104;110;109;112;111;110;110;110;109 14:38:54 INFO - PROCESS | 21357 | |1;audio-beat-detection;156;124;135;181;127;162;159;129;176;129 14:38:54 INFO - PROCESS | 21357 | |2;audio-dft;160;162;162;162;162;161;161;160;161;160 14:38:54 INFO - PROCESS | 21357 | |3;audio-fft;75;74;75;129;75;74;74;74;96;74 14:38:54 INFO - PROCESS | 21357 | |4;audio-oscillator;85;85;113;84;85;86;120;85;86;122 14:38:54 INFO - PROCESS | 21357 | |5;imaging-gaussian-blur;116;117;116;117;117;117;117;117;116;117 14:38:54 INFO - PROCESS | 21357 | |6;imaging-darkroom;146;146;147;146;146;146;147;146;145;145 14:38:54 INFO - PROCESS | 21357 | |7;imaging-desaturate;94;95;95;95;94;95;95;95;95;95 14:38:54 INFO - PROCESS | 21357 | |8;json-parse-financial;51;51;53;52;51;52;53;52;52;52 14:38:54 INFO - PROCESS | 21357 | |9;json-stringify-tinderbox;63;63;63;63;63;63;68;62;62;63 14:38:54 INFO - PROCESS | 21357 | |10;stanford-crypto-aes;80;81;85;80;85;84;86;80;109;79 14:38:54 INFO - PROCESS | 21357 | |11;stanford-crypto-ccm;127;131;128;120;119;120;126;128;135;130 14:38:54 INFO - PROCESS | 21357 | |12;stanford-crypto-pbkdf2;162;162;159;168;164;165;164;159;158;158 14:38:54 INFO - PROCESS | 21357 | |13;stanford-crypto-sha256-iterative;65;64;62;62;63;61;62;65;70;64 14:38:54 INFO - PROCESS | 21357 | __end_tp_report 14:38:54 INFO - PROCESS | 21357 | __start_cc_report 14:38:54 INFO - PROCESS | 21357 | _x_x_mozilla_cycle_collect,1646 14:38:54 INFO - PROCESS | 21357 | __end_cc_report 14:38:54 INFO - PROCESS | 21357 | __startTimestamp1464989934044__endTimestamp 14:38:54 INFO - PROCESS | 21357 | 14:38:54 INFO - PROCESS | 21357 | ------- Summary: start ------- 14:38:54 INFO - PROCESS | 21357 | Number of tests: 14 14:38:54 INFO - PROCESS | 21357 | 14:38:54 INFO - PROCESS | 21357 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.00 stddev:2.26 (2.1%) stddev-sans-first:2.24 14:38:54 INFO - PROCESS | 21357 | Values: 112.0 104.0 110.0 109.0 112.0 111.0 110.0 110.0 110.0 109.0 14:38:54 INFO - PROCESS | 21357 | 14:38:54 INFO - PROCESS | 21357 | [#1] audio-beat-detection Cycles:10 Average:147.80 Median:157.50 stddev:21.50 (13.7%) stddev-sans-first:22.60 14:38:54 INFO - PROCESS | 21357 | Values: 156.0 124.0 135.0 181.0 127.0 162.0 159.0 129.0 176.0 129.0 14:38:54 INFO - PROCESS | 21357 | 14:38:54 INFO - PROCESS | 21357 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:0.88 (0.5%) stddev-sans-first:0.83 14:38:54 INFO - PROCESS | 21357 | Values: 160.0 162.0 162.0 162.0 162.0 161.0 161.0 160.0 161.0 160.0 14:38:54 INFO - PROCESS | 21357 | 14:38:54 INFO - PROCESS | 21357 | [#3] audio-fft Cycles:10 Average:82.00 Median:74.50 stddev:17.86 (24.0%) stddev-sans-first:18.77 14:38:54 INFO - PROCESS | 21357 | Values: 75.0 74.0 75.0 129.0 75.0 74.0 74.0 74.0 96.0 74.0 14:38:54 INFO - PROCESS | 21357 | 14:38:54 INFO - PROCESS | 21357 | [#4] audio-oscillator Cycles:10 Average:95.10 Median:85.00 stddev:16.20 (19.1%) stddev-sans-first:16.76 14:38:54 INFO - PROCESS | 21357 | Values: 85.0 85.0 113.0 84.0 85.0 86.0 120.0 85.0 86.0 122.0 14:38:54 INFO - PROCESS | 21357 | 14:38:54 INFO - PROCESS | 21357 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 14:38:54 INFO - PROCESS | 21357 | Values: 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 14:38:54 INFO - PROCESS | 21357 | 14:38:54 INFO - PROCESS | 21357 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 14:38:54 INFO - PROCESS | 21357 | Values: 146.0 146.0 147.0 146.0 146.0 146.0 147.0 146.0 145.0 145.0 14:38:54 INFO - PROCESS | 21357 | 14:38:54 INFO - PROCESS | 21357 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 14:38:54 INFO - PROCESS | 21357 | Values: 94.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 14:38:54 INFO - PROCESS | 21357 | 14:38:54 INFO - PROCESS | 21357 | [#8] json-parse-financial Cycles:10 Average:51.90 Median:52.00 stddev:0.74 (1.4%) stddev-sans-first:0.71 14:38:54 INFO - PROCESS | 21357 | Values: 51.0 51.0 53.0 52.0 51.0 52.0 53.0 52.0 52.0 52.0 14:38:54 INFO - PROCESS | 21357 | 14:38:54 INFO - PROCESS | 21357 | [#9] json-stringify-tinderbox Cycles:10 Average:63.30 Median:63.00 stddev:1.70 (2.7%) stddev-sans-first:1.80 14:38:54 INFO - PROCESS | 21357 | Values: 63.0 63.0 63.0 63.0 63.0 63.0 68.0 62.0 62.0 63.0 14:38:54 INFO - PROCESS | 21357 | 14:38:54 INFO - PROCESS | 21357 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:82.50 stddev:8.85 (10.7%) stddev-sans-first:9.21 14:38:54 INFO - PROCESS | 21357 | Values: 80.0 81.0 85.0 80.0 85.0 84.0 86.0 80.0 109.0 79.0 14:38:54 INFO - PROCESS | 21357 | 14:38:54 INFO - PROCESS | 21357 | [#11] stanford-crypto-ccm Cycles:10 Average:126.40 Median:128.00 stddev:5.27 (4.1%) stddev-sans-first:5.59 14:38:54 INFO - PROCESS | 21357 | Values: 127.0 131.0 128.0 120.0 119.0 120.0 126.0 128.0 135.0 130.0 14:38:54 INFO - PROCESS | 21357 | 14:38:54 INFO - PROCESS | 21357 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.90 Median:163.00 stddev:3.38 (2.1%) stddev-sans-first:3.59 14:38:54 INFO - PROCESS | 21357 | Values: 162.0 162.0 159.0 168.0 164.0 165.0 164.0 159.0 158.0 158.0 14:38:54 INFO - PROCESS | 21357 | 14:38:54 INFO - PROCESS | 21357 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:64.00 stddev:2.57 (4.0%) stddev-sans-first:2.69 14:38:54 INFO - PROCESS | 21357 | Values: 65.0 64.0 62.0 62.0 63.0 61.0 62.0 65.0 70.0 64.0 14:38:54 INFO - PROCESS | 21357 | -------- Summary: end -------- 14:38:54 INFO - PROCESS | 21357 | 14:38:54 INFO - TEST-INFO | 21357: exit 0 14:38:54 INFO - TEST-OK | kraken | took 60222ms 14:38:54 INFO - SUITE-END | took 1172s 14:38:55 INFO - Completed test suite (00:19:32) 14:38:55 INFO - javascript benchmark 14:38:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3125.046860707484, 3133.1853718033303, 3141.952870706939, 3167.0815463515582, 3194.217416732901, 5300.893982120355, 5319.441458646845, 5395.109806881865, 5516.310461192351, 5523.7238138093135, 5428.077226871432, 5441.156620723784, 5461.77110150216, 5494.395616482184, 5551.333839939203, 4875.829345972892, 4935.457099719028, 4961.057399094178, 4978.950210497903, 5106.5659418949435, 4995.800167993276, 5026.969471258383, 5052.8484145475695, 5055.898882022358, 5073.391193056838, 4828.613710903137, 4883.0, 4883.755812209411, 4884.780184891652, 4887.0225954809, 4898.191798353268, 4939.160342741707, 4939.165988527895, 4953.083679519301, 4977.502249774993, 4901.950980490221, 4911.386076740408, 4925.3350797642215, 4925.926111108336, 4944.480829512885, 5226.372835259755, 5271.710055946922, 5314.176302673091, 5370.140777475624, 5401.70290634015, 5937.614055086448, 5941.079132734433, 5946.97026514869, 5956.672383018932, 5958.642481451084, 5949.553783466257, 5960.701964901781, 5982.371850955674, 5983.730732117066, 5989.460948514655, 5230.137027390476, 5339.279197308352, 5392.16421454679, 5397.595180361489, 5513.117901135879, 6026.306974697878, 6046.788362407295, 6047.365026672136, 6054.51563874889, 6068.6358818471035, 5798.985177593904, 5802.071668533099, 5805.071188609887, 5814.854628634233, 5819.505342045889, 5632.352279487829, 5730.140478928194, 5794.942050579441, 5797.275340582427, 5892.941070589325, 5769.163471296639, 5810.1865738796605, 5812.7674893003805, 5814.476697097281, 5819.039858423313, 5766.0197766379815, 5830.795922142789, 5834.066549352084, 5834.912476312774, 5838.065909454552, 4298.2263192625005, 4330.805113769888, 4333.58830911063, 4385.934210986838, 4395.099004704028, 3950.48643676326, 3975.960240397617, 3976.2842688315804, 3980.960190398059, 3982.183652351261, 5414.91877621836, 5422.8373148805595, 5429.6742195467605, 5434.782608695607, 5491.203775452537, 5840.620359676607, 5876.265466816648, 5894.263217097863, 5902.0, 5954.047352423591, 5490.56075513958, 5492.1212605982855, 5504.0643090674685, 5505.779768809283, 5511.145772405283, 4906.779194936236, 4965.3048573199785, 5016.498350165028, 5019.42276638184, 5033.597312215014, 6060.606060606135, 6065.969670151621, 6074.787382441594, 6084.787032453843, 6089.269287685506, 5870.559708021916, 5893.410658934073, 5900.498457631149, 5900.763969441175, 5903.557233207441, 5851.590388672752, 6003.969980150246, 6040.0, 6059.3334733178435, 6125.296497837459, 5774.740136693775, 5779.2198053263955, 5800.24596802413, 5817.098349755625, 5865.384134665798, 5908.113782932594, 5937.851553711019, 5938.317093534299, 5938.73275702603, 5939.227900372924, 5577.27495425592, 5682.318121825408, 5718.25662663851, 5738.454846789548, 5763.4812866842185, 5736.512396446349, 5742.310922689304, 5742.483176514133, 5746.109353050284, 5749.741261643152, 5434.510894019557, 5633.915491267716, 5647.717614119196, 5648.0, 5648.774049037993, 5664.8300550981885, 5740.368559458373, 5745.454181852718, 5825.213596164633, 5829.7085145743395, 5597.356304024926, 5635.15472679085, 5635.971820140873, 5640.971795140998, 5642.069058605284], "value": 5378.473372716307, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [613.9324674285828, 635.9427651511363, 637.1334984421188, 645.670707938951, 649.4285029174329, 31478.0, 34213.486797698024, 34289.14277143073, 43093.56906430935, 44277.33583996243, 46399.536004639944, 46690.299645505256, 46758.766206169006, 46875.29687054688, 46952.295715564294, 8482.363822713305, 8635.95682021589, 8649.351298652626, 8649.827003459926, 8659.69691060813, 8548.316134709208, 8685.435446695945, 8694.739157825275, 8709.60806763694, 8714.215720585145, 8725.825483490325, 8780.078091800366, 8784.736457906272, 8787.912120878806, 8789.824203515926, 8701.56492175392, 8770.122987701243, 8770.473771573663, 8775.517346545937, 8777.956110219471, 8623.82752344956, 8678.86981695275, 8686.695965641173, 8687.391882568223, 8687.913120868774, 42689.57310426887, 43097.0, 43114.78442607767, 43141.784291078344, 43151.0, 3261.673832616743, 3519.4017017107153, 3602.081469225357, 3699.7040236780995, 3976.443297938291, 32530.512042319384, 32560.837195814107, 33252.50121248183, 33296.1675958103, 33350.16624584381, 4173.728707633994, 4375.409319741826, 4430.091831174602, 4475.261581838992, 4480.059187570614, 359665.0, 360024.0, 361559.0, 361974.0, 362331.0, 62091.0, 62381.37618623846, 62495.375046249865, 62505.0, 62697.0, 66091.33908660852, 66487.0, 66696.6665166671, 66698.0, 66739.0, 17383.304667813147, 17523.0, 17531.64936701259, 17573.297068117132, 17623.295068197385, 13191.604251872459, 13235.139715918434, 13242.0, 13284.933575332254, 13308.068435209636, 18667.533311667044, 19753.40739777809, 19838.40484785459, 19850.20599176017, 19925.402237932885, 7053.858922821515, 7384.176621926224, 7398.408127349907, 7484.5883476408235, 7558.281963213486, 841.6086519768337, 980.7401038724744, 1092.847001419802, 1097.8847221041835, 1219.2257916223261, 32552.837235814142, 34048.659513405044, 34190.0, 34262.96004635708, 34338.48492272618, 1108.828131639581, 1162.2503485251966, 1203.2299328429813, 1211.4669545399995, 1301.5119330251157, 17307.653846922993, 17823.287068517373, 17865.0, 17921.37275195362, 17969.7304540432, 530171.0, 535599.0, 535963.0, 536882.2623547586, 536986.0, 59642.403575964556, 60351.09473357903, 61020.084698728664, 61059.694701526205, 61137.69431152816, 1300.3108352573151, 1387.5074348606302, 1503.9624009399633, 1619.5141457562684, 1620.0441739373825, 27835.582466263426, 29885.402291953604, 30319.545206822357, 30508.237294067825, 30940.0, 52384.738076309375, 53422.46577534175, 53528.1970770431, 53600.46399535955, 53605.73197133989, 475426.0, 483136.0, 483284.0, 483760.0, 516870.0, 44979.32531011972, 45674.54325456703, 46489.30266045944, 48861.51138488569, 50318.748406257735, 50423.24365134453, 50496.747516263655, 51080.47374426403, 51545.0, 52173.7391313041, 42144.78927605342, 42747.145057099304, 43497.0, 43535.34696979611, 44311.55688443074, 41737.58262417337, 42029.0, 42395.364069538366, 42538.78730606327, 43522.12955740804, 41545.0, 41759.58240417557, 42938.1412371757, 43047.0, 43095.56904430916, 35590.28819423545, 37394.43908341431, 37437.43843842399, 38123.618763813116, 38219.808900955315, 28179.295517612223, 28937.13188604345, 28974.855125724236, 29084.12747617575, 29111.708882910898], "value": 20947.665528994403, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.6259971726999, 391.6416478921787, 394.3260857659237, 394.960503949605, 415.3375366290767, 18178.27286908522, 19628.31300904465, 19682.212711491542, 19703.31038413656, 20404.795952040477, 18783.3425830096, 19236.0, 19315.710264346046, 19653.0, 19750.506237344074, 5420.1327787554, 5613.186088017245, 5718.971405142968, 5741.569382296345, 5819.039858423376, 5754.0, 5759.856003599923, 5775.451332123463, 5784.710764461781, 5805.5065319447895, 5706.857328566777, 5713.714314284269, 5860.73626686798, 5870.295564532262, 5873.676947767871, 5771.624844385102, 5777.422257774231, 5788.710564471801, 5825.417458254162, 5852.531797456193, 5520.337559492847, 5606.747696353674, 5637.126245431924, 5646.943530564683, 5651.0, 13146.671333216651, 13398.464061437531, 20022.69965950512, 22250.88874555633, 22528.634493378122, 2244.955100897973, 2258.2209137847417, 2261.9208327708616, 2275.82931280153, 2299.091858715798, 9479.28905332096, 9890.20878329732, 9928.354656947347, 10302.948485257526, 10349.172066234683, 1901.3630433804692, 1910.646530391882, 1945.6108778244266, 2017.9192832286838, 2042.3668662714606, 79487.6025619874, 83710.0, 84041.0, 85294.57352713258, 85362.0, 10521.947390263, 10740.516676749565, 10815.56737730482, 10964.725881853017, 11070.169737269576, 15209.239538023054, 15276.847231527765, 15295.92352038255, 15308.617284567976, 15331.156786376856, 7662.540247585162, 7863.567503787347, 7902.209779022167, 7976.641051152712, 8023.959880200561, 7598.126215485179, 7646.158922518519, 7668.808279792938, 7807.093211180244, 7876.251756083163, 4649.860504184812, 4661.976690116596, 4670.206064968964, 4699.224627936421, 4700.788464519105, 1874.7375367448567, 1884.6230753849286, 1920.0, 1926.7880533141342, 1949.2008276606523, 905.2260317428635, 1035.968920932358, 1056.8414737789394, 1087.0434018064211, 1100.315582834285, 18974.81025189758, 19613.254144419792, 19613.313534026525, 19671.803281966997, 19768.520585594197, 1002.4185972136144, 1004.1916257412706, 1023.4831410137981, 1066.5094056733835, 1074.7581794096266, 10528.467444411268, 10895.128389728803, 10923.563057477772, 11000.394978276272, 11028.669139925654, 471430.0, 471946.0, 525132.0, 529308.0, 532888.0, 93376.0, 94962.0, 96777.51611241899, 98504.50747746216, 100055.0, 1002.8445590933417, 1022.2895087913977, 1044.587387981743, 1055.1137044882337, 1068.3803394031443, 17190.0, 17271.962193306263, 17494.300227990738, 17519.82480175182, 17719.73420398721, 40401.595984039785, 41281.793591031856, 41466.0, 41789.16421671489, 42747.35878961756, 58574.41425585689, 59823.0, 59983.0, 60359.0, 60612.39387606244, 7382.298681625237, 7641.42689298316, 8287.50274983503, 8620.52587107715, 8826.470411775314, 12724.6182614518, 13152.276624785729, 13160.934195328962, 13189.604311870658, 13356.666083347995, 11607.941960290482, 11659.825102623297, 11795.705107372385, 11847.0, 12014.459349329476, 11234.4382780859, 11291.604793832505, 11351.318920864775, 11379.829302560303, 11499.252548584314, 6499.935000649933, 8709.912900871164, 11913.880861191625, 11917.880821192024, 12016.819747703967, 7023.68393422287, 7254.528455650366, 7330.340269375782, 7885.250901164381, 8143.51138931666, 10905.400202988912, 11366.715832104264, 11537.653870383901, 11671.59149429766, 11954.641360759191], "value": 9119.496204934252, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1293.838270216223, 1489.3670190169178, 1490.359145567406, 1638.713225185593, 1775.8224177582244, 8067.112617612058, 8794.944606647203, 9041.186293233608, 9060.139286767762, 9289.071092890708, 8949.731508054752, 9080.27357811375, 9146.542672866346, 9151.496667683276, 9155.267578593714, 2058.135583055113, 2311.838171328008, 2367.3608125806063, 2383.678203442539, 2402.327348342467, 2410.6384042393606, 2434.1358817619666, 2436.9634455483183, 2438.8048956083558, 2439.4633180700216, 2342.320726989171, 2377.1917548033666, 2377.655239990209, 2378.7740164684415, 2379.1910750344878, 1986.0864002558767, 2293.564222797663, 2362.2913126062285, 2362.70466191726, 2377.09670325277, 2277.089164334263, 2295.7933785959344, 2298.7011688480557, 2299.494111295529, 2307.8730669813153, 8866.157715017063, 8869.068747781455, 8907.599158037903, 8935.553222338856, 8947.821043579157, 5233.450487698813, 5407.756650950717, 5407.83776486706, 5413.242146099549, 5414.566834653218, 3196.5205219217305, 3353.5975682918206, 3379.5268662387284, 3439.9656003439895, 3469.09803451102, 1111.2388014210292, 1128.317367992361, 1153.9192256542046, 1188.7265928836416, 1192.0926517571816, 13104.148230364995, 13130.606081817561, 13147.079704420694, 13155.210687358789, 13166.341682915816, 4584.4498660161, 4754.857354279377, 4777.689450185727, 4820.783064762094, 4843.854684359475, 10879.673609791718, 10880.945595271973, 10885.564577416973, 10895.291806032583, 10905.400202988752, 4846.539578740014, 5432.864178395572, 5476.890462190734, 5492.615516913777, 5499.477549632778, 4834.8791280218275, 4959.08256972454, 4960.454350021495, 4974.0797952378925, 4985.401751789808, 4069.3315740546236, 4108.746832216203, 4119.176164767058, 4261.893452663709, 4287.7212981156745, 1232.5131573028782, 1265.6519457149357, 1267.5626908716479, 1285.13895689888, 1289.4970961325091, 882.2565101191291, 898.384606544506, 996.9501524923725, 1040.8334666453331, 1048.9580416783242, 6099.207103076572, 6199.721012554446, 6283.59156654816, 6392.7123279452535, 6528.51036172289, 936.134075979716, 982.0572250639324, 1007.7329507680471, 1008.3496144986443, 1012.2509343086064, 4215.409842622035, 4247.532771395144, 4281.507626622916, 4342.305231162999, 4408.404865343202, 10952.39761813092, 11311.321320720783, 11433.59982400612, 11444.771104577861, 11456.4844581994, 11234.831477527843, 11237.71905702364, 11258.943705281421, 11277.097832173406, 11283.040941520063, 8505.106963768716, 8534.146585341416, 8573.271271941954, 8664.436811607351, 8686.305095592337, 6059.242594675666, 6159.414855588712, 6342.7145778441, 6409.775657851953, 6521.217453905561, 9963.0, 10277.84583231267, 10529.526171322463, 10539.367637941748, 10550.683479495627, 10543.789124217627, 10776.407297598707, 10882.455877206266, 10937.179711521827, 11070.5571777128, 7875.212478752079, 8074.59627018635, 8144.226298501633, 8155.79610509742, 8192.918070819216, 8927.598258078531, 8950.373473856767, 8979.326550508607, 8987.685431009882, 9022.413543119676, 7830.921690783247, 8065.516069035877, 8095.081280124568, 8108.83782324362, 8233.34133269325, 7889.526628402315, 7918.2477664621765, 7958.204179581995, 8071.071826739765, 8102.5948702563455, 6824.624645644339, 6864.313568643096, 6890.173179218526, 6901.482388820959, 7102.609356485236, 5222.3733152022005, 5312.5484333832055, 5322.228276899906, 5349.170878513836, 5436.456354364532, 5228.215767634885, 5261.342332208474, 5355.062863998863, 5382.407935127055, 5432.348118225838], "value": 4778.1475124933195, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.47274651437937, 332.22756593573285, 339.5958809017269, 340.49096600582124, 343.89683095071473, 5271.471273330734, 5317.0, 5323.547498462635, 5339.412664606895, 5343.839684809453, 5065.316182315386, 5077.1622682257475, 5184.818531351403, 5201.687898726079, 5266.841994740154, 4022.5776293489203, 4079.571644977279, 4114.0, 4151.916961660765, 4163.854265100722, 4091.6317531422164, 4126.938095928564, 4142.399352093945, 4146.6268035876765, 4155.896102597429, 4035.3946907963896, 4061.1268577255883, 4136.110736191718, 4151.854685086023, 4154.709170358076, 4099.364598487239, 4109.3425051991835, 4124.979375103136, 4141.088960428716, 4144.0, 3646.5441819772527, 3658.396364599838, 3659.79871107089, 3663.9450408243897, 3678.5769636491877, 4805.068907966138, 5067.113255180366, 5072.822451214227, 5080.263361812516, 5097.464766199532, 4638.350630911675, 4653.976730116327, 4703.129920964632, 4711.24620060792, 4720.575148236675, 5490.203920431515, 5512.39363669996, 5521.1442226454965, 5531.723413829292, 5551.500364967173, 3892.2215556888737, 3897.6881849451975, 3954.604539546051, 3971.6028397160344, 3976.8011599419915, 5697.344805347355, 5714.285714285715, 5753.0, 5766.596338256324, 5770.19217309577, 3986.5016872890887, 3989.4813674222746, 4006.2788698034633, 4032.1935612876955, 4047.777372244555, 4035.6569691576547, 4053.493313335833, 4083.5508094109623, 4100.446439730657, 4121.443605113272, 4554.95445045552, 4679.555442232982, 4688.226442636927, 4689.0, 4698.929516057262, 5467.015937131275, 5487.6158668892795, 5501.477359650827, 5515.696636685021, 5522.530584900329, 1331.8734720201564, 1357.4027427931678, 1381.8687224713838, 1412.653899794557, 1418.21997901156, 891.38494438837, 895.3463971300987, 906.4787747045475, 917.3440989692402, 925.9721708903112, 4663.642177632099, 4707.8587642370785, 4708.929366059512, 4738.502457242009, 4761.642876784255, 5025.773840177128, 5026.447090820006, 5030.0, 5038.899222015612, 5070.3155074064525, 4562.5665561771575, 4716.88207794801, 4744.525547445228, 4760.0, 4775.068861572029, 2565.961510577343, 2634.841909485437, 2674.5586978148776, 2675.0, 2678.6517752692025, 5075.923861142012, 5089.0, 5135.7432128394175, 5177.456367081478, 5189.42916279209, 5018.293780114778, 5026.768441731799, 5028.522290382408, 5084.3898732152375, 5354.303940487712, 5840.532757379399, 5851.678157701367, 5876.0, 5893.882122357529, 5922.170896074553, 5589.490837473941, 5683.2666036859155, 5709.942900570941, 5742.971285143548, 5743.74153163117, 5568.0, 5577.721113944205, 5586.011483856118, 5628.1557766333735, 5729.369769325454, 5803.593748437569, 5844.766209351578, 5875.794347197828, 5885.852853678521, 5886.20536227621, 4048.9392659110727, 4053.635172834459, 4064.878053658395, 4087.7956102195367, 4101.794910254535, 5366.899785543876, 5544.889102218014, 5659.745311460912, 5680.460356266148, 5690.0, 5443.618946673695, 5551.751540626053, 5572.3034620672415, 5585.273914391103, 5622.775088996558, 5498.45015498463, 5513.7794488221625, 5552.361478430033, 5559.138333558305, 5593.552515798808, 5243.711595862264, 5423.864403389947, 5447.373552041566, 5448.7548060336585, 5457.235986961749, 5462.590305727007, 5500.917486237629, 5515.703809604659, 5519.558435325244, 5527.5577953764405, 5430.945690543044, 5480.890382192254, 5506.752196151103, 5516.834494965157, 5521.171824226398], "value": 4128.420988777509, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [701.5510073552924, 720.0881659194837, 753.2279413601058, 789.9131095579487, 802.4543310548828, 15639.296231669574, 16126.677466450694, 16142.919285403586, 16170.676586468278, 16196.433124840647, 14754.704905901875, 14825.036372635772, 14825.332860021297, 14867.479638212664, 14870.851291487083, 677.3159109299618, 781.8670825959572, 803.3773825285407, 807.0597753617029, 813.1258896686086, 800.047942947893, 806.3992325717348, 807.3662175192475, 808.8786681997689, 810.1452967119686, 837.5016864965336, 837.874318852174, 838.2330167896367, 838.2372041442288, 839.7816567692413, 706.7702996526124, 717.519262094398, 720.4884531982325, 815.8531464336417, 832.6544484039116, 616.6639181646013, 621.549376701892, 621.7450845153511, 621.8072397556726, 621.8694074244414, 15220.0, 15227.467038653705, 15235.238238088052, 15241.542753717406, 15245.161516116608, 14495.492657757033, 14678.266086695729, 14740.631484212874, 14754.631134221623, 14919.104853708812, 12608.74782504354, 12742.426590803436, 12763.617091487271, 12885.87114128856, 13046.282454465096, 4463.303161589031, 4471.128130014648, 4481.73109613421, 4542.182407166709, 4654.371659825914, 77920.22079779186, 79067.6046619769, 79134.60432697857, 80227.0, 80661.0, 11423.314601123959, 11471.0, 11565.653030409101, 11706.531738730526, 11860.22908510944, 21609.459763506038, 21726.13095476195, 21767.238146665106, 21780.782192177874, 21816.0, 8406.28546573548, 8464.0, 8489.83020339602, 8562.914370856337, 8645.351598630128, 4639.605633521189, 4660.883477913011, 4747.572718455355, 4748.738819364969, 4803.279508073817, 3476.061463404917, 3549.378858699717, 3596.8021758802993, 3597.442396428558, 3606.5311509503595, 634.1977398590786, 639.9072134540465, 644.9580777249464, 688.4784625976548, 721.8267615772177, 617.8795134948642, 762.0453536678402, 762.5043721581017, 769.2730369800485, 808.7088648086684, 10233.232507561963, 10515.26393152472, 10716.624918127829, 10795.190360722978, 10959.726006849893, 658.5653468710628, 707.5542408282749, 765.1774342581635, 790.3440144679902, 797.2585495489251, 5010.273510341053, 5142.460041695568, 5206.843794686166, 5224.16413373866, 5235.0, 75907.0, 76808.61595691986, 118090.0, 123562.0, 126949.0, 102636.48681756693, 105072.0, 105596.47201763942, 105875.47062264639, 107340.0, 60198.39801602015, 84055.15944840596, 84462.0, 86857.5657121723, 94073.0, 9676.56455459492, 9778.853317200106, 9788.951055244679, 9789.755256118655, 9858.457784821903, 40656.0, 42719.5728042728, 44053.33919991139, 48969.510304896496, 51018.0, 66984.66507667431, 73284.24388756443, 73336.0, 74052.62973685097, 74575.62712186405, 12516.245126461843, 12669.176503527242, 12824.29466379358, 12901.419436125585, 13149.0, 14113.364898579794, 14183.858161418253, 14441.711165776416, 15109.244537772847, 15110.39558417651, 14167.64580885445, 14268.21524816145, 14548.0, 14830.88932698358, 14832.480863169738, 12049.277043377426, 13817.447302108205, 13908.165510069428, 14195.858041419453, 15119.848801511844, 12212.764895289776, 12353.197042192229, 12388.318642474751, 12610.43253053633, 12846.743065138831, 10580.576776929145, 10751.9844516171, 11138.3873886937, 11562.884371156517, 11731.924477046954, 11213.775724485628, 11929.038430081879, 12021.879781202077, 12138.150329476852, 12139.817902731289], "value": 7636.679369239959, "unit": "score"}], "name": "dromaeo_css", "value": 7327.5704736992375, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 104.0, 110.0, 109.0, 112.0, 111.0, 110.0, 110.0, 110.0, 109.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 124.0, 135.0, 181.0, 127.0, 162.0, 159.0, 129.0, 176.0, 129.0], "value": 147.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 162.0, 162.0, 162.0, 161.0, 161.0, 160.0, 161.0, 160.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 129.0, 75.0, 74.0, 74.0, 74.0, 96.0, 74.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 113.0, 84.0, 85.0, 86.0, 120.0, 85.0, 86.0, 122.0], "value": 95.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 145.0, 145.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 53.0, 52.0, 51.0, 52.0, 53.0, 52.0, 52.0, 52.0], "value": 51.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 68.0, 62.0, 62.0, 63.0], "value": 63.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 85.0, 80.0, 85.0, 84.0, 86.0, 80.0, 109.0, 79.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 131.0, 128.0, 120.0, 119.0, 120.0, 126.0, 128.0, 135.0, 130.0], "value": 126.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 159.0, 168.0, 164.0, 165.0, 164.0, 159.0, 158.0, 158.0], "value": 161.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 62.0, 62.0, 63.0, 61.0, 62.0, 65.0, 70.0, 64.0], "value": 63.8, "unit": "score"}], "name": "kraken", "value": 1505.4000000000003, "alertThreshold": 2.0}]} 14:38:55 INFO - Return code: 0 14:38:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:38:55 ERROR - # TBPL SUCCESS # 14:38:55 INFO - Running post-action listener: _resource_record_post_action 14:38:55 INFO - ##### 14:38:55 INFO - ##### Finished run-tests step (success) 14:38:55 INFO - ##### 14:38:55 INFO - Running post-run listener: _resource_record_post_run 14:38:55 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 365101056; Read time: 12; Write time: 203980 14:38:55 INFO - TinderboxPrint: CPU usage
13.2% 14:38:55 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 14:38:55 INFO - TinderboxPrint: I/O write bytes / time
365,101,056 / 203,980 14:38:55 INFO - TinderboxPrint: CPU idle
8,252.4 (86.8%) 14:38:55 INFO - TinderboxPrint: CPU user
1,211.6 (12.7%) 14:38:55 INFO - TinderboxPrint: Swap in / out
0 / 0 14:38:55 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 60821504; Read time: 0; Write time: 32316 14:38:55 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291172352; Read time: 12; Write time: 170260 14:38:55 INFO - Running post-run listener: _upload_blobber_files 14:38:55 INFO - Blob upload gear active. 14:38:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:38:55 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:38:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:38:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:38:56 INFO - (blobuploader) - INFO - Open directory for files ... 14:38:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:38:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:38:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:39:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:39:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:39:00 INFO - (blobuploader) - INFO - Done attempting. 14:39:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:39:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:39:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:39:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:39:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:39:01 INFO - (blobuploader) - INFO - Done attempting. 14:39:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:39:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:39:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:39:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:39:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:39:02 INFO - (blobuploader) - INFO - Done attempting. 14:39:02 INFO - (blobuploader) - INFO - Iteration through files over. 14:39:02 INFO - Return code: 0 14:39:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:39:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:39:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa7cbd936469e40eba415057afecc612c343c116c3c6635d7f4b0e6e1d74c04d55540fe69269a18ca611682836e17106ea65a99b9141856d0e9d5bb47bb54ee0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e8ff5d5ab7f32bc93623e6ff5223fc9d9d17a55189f91ef915575a1cd0cee897b41ca26da8f3c8d5acfe44bf9887bef6ada48301ff92fcd94e28e3921671bfdc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5df26cbd9864290d07bcd68abd9de682ee5077c76fc7be3bfc87c25685c87e7e3d1f662f67b5bd45697d6fec464952644537c3681485e536c2281311a39265d0"} 14:39:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:39:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:39:02 INFO - Contents: 14:39:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa7cbd936469e40eba415057afecc612c343c116c3c6635d7f4b0e6e1d74c04d55540fe69269a18ca611682836e17106ea65a99b9141856d0e9d5bb47bb54ee0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e8ff5d5ab7f32bc93623e6ff5223fc9d9d17a55189f91ef915575a1cd0cee897b41ca26da8f3c8d5acfe44bf9887bef6ada48301ff92fcd94e28e3921671bfdc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5df26cbd9864290d07bcd68abd9de682ee5077c76fc7be3bfc87c25685c87e7e3d1f662f67b5bd45697d6fec464952644537c3681485e536c2281311a39265d0"} 14:39:02 INFO - Running post-run listener: copy_logs_to_upload_dir 14:39:02 INFO - Copying logs to upload dir... 14:39:02 INFO - mkdir: /builds/slave/test/build/upload/logs 14:39:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1390.429479 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 10 secs) (at 2016-06-03 14:39:01.427777) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 14:39:01.431214) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1464988550.235200-405161547 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa7cbd936469e40eba415057afecc612c343c116c3c6635d7f4b0e6e1d74c04d55540fe69269a18ca611682836e17106ea65a99b9141856d0e9d5bb47bb54ee0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e8ff5d5ab7f32bc93623e6ff5223fc9d9d17a55189f91ef915575a1cd0cee897b41ca26da8f3c8d5acfe44bf9887bef6ada48301ff92fcd94e28e3921671bfdc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5df26cbd9864290d07bcd68abd9de682ee5077c76fc7be3bfc87c25685c87e7e3d1f662f67b5bd45697d6fec464952644537c3681485e536c2281311a39265d0"} build_url:https://queue.taskcluster.net/v1/task/cG1xelpHSzW0ZtYZs0PGMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011283 build_url: 'https://queue.taskcluster.net/v1/task/cG1xelpHSzW0ZtYZs0PGMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa7cbd936469e40eba415057afecc612c343c116c3c6635d7f4b0e6e1d74c04d55540fe69269a18ca611682836e17106ea65a99b9141856d0e9d5bb47bb54ee0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e8ff5d5ab7f32bc93623e6ff5223fc9d9d17a55189f91ef915575a1cd0cee897b41ca26da8f3c8d5acfe44bf9887bef6ada48301ff92fcd94e28e3921671bfdc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5df26cbd9864290d07bcd68abd9de682ee5077c76fc7be3bfc87c25685c87e7e3d1f662f67b5bd45697d6fec464952644537c3681485e536c2281311a39265d0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 14:39:01.457309) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 14:39:01.457747) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1464988550.235200-405161547 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004482 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 14:39:01.543191) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 14:39:01.543583) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 14:39:01.544143) ========= ========= Total master_lag: 0.15 =========