builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-052 starttime: 1463098850.92 results: success (0) buildid: 20160512162545 builduid: eae3da6f4091412e9452478e549d0e00 revision: bec48bfd05a8c6703aab63181441869a3dcaa4cc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-12 17:20:50.919864) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-12 17:20:50.920324) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-12 17:20:50.920607) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-12 17:20:50.929545) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 17:20:50.929930) ========= 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=826874ccc97bd7bf541b4875000001d5-1463098851.134378-859456878 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-12 17:20:51-- 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% 23.1M=0.001s 2016-05-12 17:20:51 (23.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086046 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 17:20:51.023967) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 17:20:51.024282) ========= 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=826874ccc97bd7bf541b4875000001d5-1463098851.134378-859456878 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.009485 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 17:20:51.070373) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-12 17:20:51.070729) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev bec48bfd05a8c6703aab63181441869a3dcaa4cc --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 bec48bfd05a8c6703aab63181441869a3dcaa4cc --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=826874ccc97bd7bf541b4875000001d5-1463098851.134378-859456878 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-12 17:20:51,867 truncating revision to first 12 chars 2016-05-12 17:20:51,867 Setting DEBUG logging. 2016-05-12 17:20:51,868 attempt 1/10 2016-05-12 17:20:51,868 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/bec48bfd05a8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-12 17:20:53,080 unpacking tar archive at: fx-team-bec48bfd05a8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.459848 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-12 17:20:52.538703) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-12 17:20:52.539031) ========= script_repo_revision: bec48bfd05a8c6703aab63181441869a3dcaa4cc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-12 17:20:52.539458) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-12 17:20:52.539746) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-12 17:20:52.545420) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-05-12 17:20:52.545705) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=826874ccc97bd7bf541b4875000001d5-1463098851.134378-859456878 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:20:53 INFO - MultiFileLogger online at 20160512 17:20:53 in /builds/slave/test 17:20:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 17:20:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:20:53 INFO - {'append_to_log': False, 17:20:53 INFO - 'base_work_dir': '/builds/slave/test', 17:20:53 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 17:20:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:20:53 INFO - 'branch': 'Fx-Team-Non-PGO', 17:20:53 INFO - 'buildbot_json_path': 'buildprops.json', 17:20:53 INFO - 'config_files': ('talos/linux_config.py',), 17:20:53 INFO - 'default_actions': ('clobber', 17:20:53 INFO - 'read-buildbot-config', 17:20:53 INFO - 'download-and-extract', 17:20:53 INFO - 'populate-webroot', 17:20:53 INFO - 'create-virtualenv', 17:20:53 INFO - 'install', 17:20:53 INFO - 'run-tests'), 17:20:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:20:53 INFO - 'download_minidump_stackwalk': True, 17:20:53 INFO - 'download_symbols': 'ondemand', 17:20:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:20:53 INFO - 'tooltool.py': '/tools/tooltool.py', 17:20:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:20:53 INFO - '/tools/misc-python/virtualenv.py')}, 17:20:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:20:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:20:53 INFO - 'installer_path': 'installer.exe', 17:20:53 INFO - 'log_level': 'info', 17:20:53 INFO - 'log_name': 'talos', 17:20:53 INFO - 'log_to_console': True, 17:20:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:20:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:20:53 INFO - 'opt_config_files': (), 17:20:53 INFO - 'pip_index': False, 17:20:53 INFO - 'sps_profile': False, 17:20:53 INFO - 'sps_profile_interval': 0, 17:20:53 INFO - 'suite': 'dromaeojs', 17:20:53 INFO - 'system_bits': '32', 17:20:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:20:53 INFO - 'title': 'talos-linux64-ix-052', 17:20:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:20:53 INFO - 'use_talos_json': True, 17:20:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:20:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:20:53 INFO - 'work_dir': 'build'} 17:20:53 INFO - ##### 17:20:53 INFO - ##### Running clobber step. 17:20:53 INFO - ##### 17:20:53 INFO - Running pre-action listener: _resource_record_pre_action 17:20:53 INFO - Running main action method: clobber 17:20:53 INFO - rmtree: /builds/slave/test/build 17:20:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:20:53 INFO - Running post-action listener: _resource_record_post_action 17:20:53 INFO - ##### 17:20:53 INFO - ##### Finished clobber step (success) 17:20:53 INFO - ##### 17:20:53 INFO - ##### 17:20:53 INFO - ##### Running read-buildbot-config step. 17:20:53 INFO - ##### 17:20:53 INFO - Running pre-action listener: _resource_record_pre_action 17:20:53 INFO - Running main action method: read_buildbot_config 17:20:53 INFO - Using buildbot properties: 17:20:53 INFO - { 17:20:53 INFO - "project": "", 17:20:53 INFO - "product": "firefox", 17:20:53 INFO - "script_repo_revision": "production", 17:20:53 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:20:53 INFO - "repository": "", 17:20:53 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 17:20:53 INFO - "buildid": "20160512162545", 17:20:53 INFO - "pgo_build": "False", 17:20:53 INFO - "basedir": "/builds/slave/test", 17:20:53 INFO - "buildnumber": 2970, 17:20:53 INFO - "slavename": "talos-linux64-ix-052", 17:20:53 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:20:53 INFO - "platform": "ubuntu64_hw", 17:20:53 INFO - "scheduler": "tests-fx-team-linux64-talos", 17:20:53 INFO - "branch": "fx-team", 17:20:53 INFO - "repo_path": "integration/fx-team", 17:20:53 INFO - "revision": "bec48bfd05a8c6703aab63181441869a3dcaa4cc", 17:20:53 INFO - "stage_platform": "linux64", 17:20:53 INFO - "builduid": "eae3da6f4091412e9452478e549d0e00", 17:20:53 INFO - "slavebuilddir": "test" 17:20:53 INFO - } 17:20:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/O6ir-GOHSXGcqtGBa_xKIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 17:20:53 INFO - Running post-action listener: _resource_record_post_action 17:20:53 INFO - ##### 17:20:53 INFO - ##### Finished read-buildbot-config step (success) 17:20:53 INFO - ##### 17:20:53 INFO - ##### 17:20:53 INFO - ##### Running download-and-extract step. 17:20:53 INFO - ##### 17:20:53 INFO - Running pre-action listener: _resource_record_pre_action 17:20:53 INFO - Running main action method: download_and_extract 17:20:53 INFO - mkdir: /builds/slave/test/build/tests 17:20: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')]} 17:20:53 INFO - https://queue.taskcluster.net/v1/task/O6ir-GOHSXGcqtGBa_xKIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:20:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6ir-GOHSXGcqtGBa_xKIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:20:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6ir-GOHSXGcqtGBa_xKIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:20:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6ir-GOHSXGcqtGBa_xKIg/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 17:20:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6ir-GOHSXGcqtGBa_xKIg/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 17:20:54 INFO - Downloaded 1361 bytes. 17:20:54 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:20:54 INFO - Using the following test package requirements: 17:20:54 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:20:54 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:20:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:20:54 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:20:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:20:54 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:20:54 INFO - u'jsshell-linux-x86_64.zip'], 17:20:54 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:20:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:20:54 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:20:54 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:20:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:20:54 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:20:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:20:54 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:20:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:20:54 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:20:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:20:54 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:20:54 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')]} 17:20:54 INFO - https://queue.taskcluster.net/v1/task/O6ir-GOHSXGcqtGBa_xKIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:20:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6ir-GOHSXGcqtGBa_xKIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:20:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6ir-GOHSXGcqtGBa_xKIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:20:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6ir-GOHSXGcqtGBa_xKIg/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 17:20:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6ir-GOHSXGcqtGBa_xKIg/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 17:20:55 INFO - Downloaded 22329650 bytes. 17:20:55 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'] 17:20:55 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 17:20:56 INFO - Return code: 0 17:20:56 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 17:20: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')]} 17:20:56 INFO - https://queue.taskcluster.net/v1/task/O6ir-GOHSXGcqtGBa_xKIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:20:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6ir-GOHSXGcqtGBa_xKIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:20:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6ir-GOHSXGcqtGBa_xKIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:20:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6ir-GOHSXGcqtGBa_xKIg/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 17:20:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6ir-GOHSXGcqtGBa_xKIg/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 17:20:57 INFO - Downloaded 22329650 bytes. 17:20: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'] 17:20: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 17:20:59 INFO - Return code: 0 17:20:59 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')]} 17:20:59 INFO - https://queue.taskcluster.net/v1/task/O6ir-GOHSXGcqtGBa_xKIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:20:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6ir-GOHSXGcqtGBa_xKIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:20:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6ir-GOHSXGcqtGBa_xKIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:20:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6ir-GOHSXGcqtGBa_xKIg/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 17:20:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6ir-GOHSXGcqtGBa_xKIg/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 17:21:00 INFO - Downloaded 10840239 bytes. 17:21:00 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'] 17:21:00 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 17:21:00 INFO - Return code: 0 17:21: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')]} 17:21:00 INFO - https://queue.taskcluster.net/v1/task/O6ir-GOHSXGcqtGBa_xKIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:21:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6ir-GOHSXGcqtGBa_xKIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:21:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6ir-GOHSXGcqtGBa_xKIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:21:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6ir-GOHSXGcqtGBa_xKIg/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 17:21:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6ir-GOHSXGcqtGBa_xKIg/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 17:21:01 INFO - Downloaded 54683919 bytes. 17:21:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O6ir-GOHSXGcqtGBa_xKIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:21:01 INFO - mkdir: /builds/slave/test/properties 17:21:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:21:01 INFO - Writing to file /builds/slave/test/properties/build_url 17:21:01 INFO - Contents: 17:21:01 INFO - build_url:https://queue.taskcluster.net/v1/task/O6ir-GOHSXGcqtGBa_xKIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:21:02 INFO - Running post-action listener: _resource_record_post_action 17:21:02 INFO - Running post-action listener: set_extra_try_arguments 17:21:02 INFO - ##### 17:21:02 INFO - ##### Finished download-and-extract step (success) 17:21:02 INFO - ##### 17:21:02 INFO - ##### 17:21:02 INFO - ##### Running populate-webroot step. 17:21:02 INFO - ##### 17:21:02 INFO - Running pre-action listener: _resource_record_pre_action 17:21:02 INFO - Running main action method: populate_webroot 17:21:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:21:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:21:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:21:02 INFO - '--tppagecycles', 17:21:02 INFO - '7'], 17:21:02 INFO - 'tests': ['tsvgm']}}, 17:21:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:21:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:21:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:21:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:21:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:21:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:21:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:02 INFO - 'talos_options': ['--disable-e10s'], 17:21:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:21:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:21:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:02 INFO - 'talos_options': ['--disable-e10s'], 17:21:02 INFO - 'tests': ['damp', 'tps']}, 17:21:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:02 INFO - 'tests': ['damp', 'tps']}, 17:21:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:21:02 INFO - 'tests': ['dromaeo_dom']}, 17:21:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:21:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:21:02 INFO - 'tests': ['a11yr', 17:21:02 INFO - 'ts_paint', 17:21:02 INFO - 'tpaint', 17:21:02 INFO - 'sessionrestore', 17:21:02 INFO - 'sessionrestore_no_auto_restore', 17:21:02 INFO - 'tabpaint']}, 17:21:02 INFO - 'other-e10s': {'tests': ['a11yr', 17:21:02 INFO - 'ts_paint', 17:21:02 INFO - 'tpaint', 17:21:02 INFO - 'sessionrestore', 17:21:02 INFO - 'sessionrestore_no_auto_restore', 17:21:02 INFO - 'tabpaint']}, 17:21:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:21:02 INFO - 'ts_paint', 17:21:02 INFO - 'tpaint', 17:21:02 INFO - 'sessionrestore', 17:21:02 INFO - 'sessionrestore_no_auto_restore', 17:21:02 INFO - 'tabpaint']}, 17:21:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:21:02 INFO - 'ts_paint', 17:21:02 INFO - 'tpaint', 17:21:02 INFO - 'sessionrestore', 17:21:02 INFO - 'sessionrestore_no_auto_restore', 17:21:02 INFO - 'tabpaint']}, 17:21:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:21:02 INFO - 'tests': ['a11yr', 17:21:02 INFO - 'ts_paint', 17:21:02 INFO - 'tpaint', 17:21:02 INFO - 'sessionrestore', 17:21:02 INFO - 'sessionrestore_no_auto_restore', 17:21:02 INFO - 'tabpaint']}, 17:21:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:21:02 INFO - 'tests': ['a11yr', 17:21:02 INFO - 'ts_paint', 17:21:02 INFO - 'tpaint', 17:21:02 INFO - 'sessionrestore', 17:21:02 INFO - 'sessionrestore_no_auto_restore', 17:21:02 INFO - 'tabpaint']}, 17:21:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:21:02 INFO - 'tests': ['tsvgx', 17:21:02 INFO - 'tsvgr_opacity', 17:21:02 INFO - 'tart', 17:21:02 INFO - 'tscrollx', 17:21:02 INFO - 'cart']}, 17:21:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:21:02 INFO - 'tsvgr_opacity', 17:21:02 INFO - 'tart', 17:21:02 INFO - 'tscrollx', 17:21:02 INFO - 'cart']}, 17:21:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:02 INFO - 'talos_options': ['--disable-e10s'], 17:21:02 INFO - 'tests': ['tp5o']}, 17:21:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:02 INFO - 'tests': ['tp5o']}, 17:21:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:02 INFO - 'talos_options': ['--disable-e10s', 17:21:02 INFO - '--xperf_path', 17:21:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:21:02 INFO - 'tests': ['tp5n']}, 17:21:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:02 INFO - 'talos_options': ['--xperf_path', 17:21:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:21:02 INFO - 'tests': ['tp5n']}}, 17:21:02 INFO - 'talos.zip': {'path': '', 17:21:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:21:02 INFO - Running post-action listener: _resource_record_post_action 17:21:02 INFO - ##### 17:21:02 INFO - ##### Finished populate-webroot step (success) 17:21:02 INFO - ##### 17:21:02 INFO - ##### 17:21:02 INFO - ##### Running create-virtualenv step. 17:21:02 INFO - ##### 17:21:02 INFO - Running pre-action listener: _resource_record_pre_action 17:21:02 INFO - Running main action method: create_virtualenv 17:21:02 INFO - Creating virtualenv /builds/slave/test/build/venv 17:21:02 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 17:21:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:21:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:21:02 INFO - Using real prefix '/usr' 17:21:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:21:03 INFO - Installing distribute.............................................................................................................................................................................................done. 17:21:05 INFO - Installing pip.................done. 17:21:05 INFO - Return code: 0 17:21:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:21:05 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')]} 17:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:05 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')]} 17:21:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:05 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 0x7f3be9522f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdad9c0>, '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 0xdae8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdaed50>, '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': '826874ccc97bd7bf541b4875000001d5-1463098851.134378-859456878', '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 17:21:05 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 17:21:05 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 17:21:05 INFO - Using env: {'DISPLAY': ':0', 17:21:05 INFO - 'HOME': '/home/cltbld', 17:21:05 INFO - 'LANG': 'en_US.UTF-8', 17:21:05 INFO - 'LANGUAGE': 'en_US:en', 17:21:05 INFO - 'LOGNAME': 'cltbld', 17:21:05 INFO - 'MAIL': '/var/mail/cltbld', 17:21:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:05 INFO - 'MOZ_NO_REMOTE': '1', 17:21:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:21:05 INFO - 'NO_EM_RESTART': '1', 17:21:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:21:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:21:05 INFO - 'PWD': '/builds/slave/test', 17:21:05 INFO - 'SHELL': '/bin/bash', 17:21:05 INFO - 'SHLVL': '1', 17:21:05 INFO - 'TERM': 'linux', 17:21:05 INFO - 'TMOUT': '86400', 17:21:05 INFO - 'USER': 'cltbld', 17:21:05 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1463098851.134378-859456878', 17:21:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:05 INFO - '_': '/tools/buildbot/bin/python'} 17:21:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:05 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 17:21:05 INFO - Cleaning up... 17:21:05 INFO - Return code: 0 17:21:05 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:21:05 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')]} 17:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:05 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')]} 17:21:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:05 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3be9522f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdad9c0>, '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 0xdae8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdaed50>, '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': '826874ccc97bd7bf541b4875000001d5-1463098851.134378-859456878', '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 17:21:05 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>=0.7.1'] in /builds/slave/test/build 17:21:05 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>=0.7.1 17:21:05 INFO - Using env: {'DISPLAY': ':0', 17:21:05 INFO - 'HOME': '/home/cltbld', 17:21:05 INFO - 'LANG': 'en_US.UTF-8', 17:21:05 INFO - 'LANGUAGE': 'en_US:en', 17:21:05 INFO - 'LOGNAME': 'cltbld', 17:21:05 INFO - 'MAIL': '/var/mail/cltbld', 17:21:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:05 INFO - 'MOZ_NO_REMOTE': '1', 17:21:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:21:05 INFO - 'NO_EM_RESTART': '1', 17:21:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:21:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:21:05 INFO - 'PWD': '/builds/slave/test', 17:21:05 INFO - 'SHELL': '/bin/bash', 17:21:05 INFO - 'SHLVL': '1', 17:21:05 INFO - 'TERM': 'linux', 17:21:05 INFO - 'TMOUT': '86400', 17:21:05 INFO - 'USER': 'cltbld', 17:21:05 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1463098851.134378-859456878', 17:21:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:05 INFO - '_': '/tools/buildbot/bin/python'} 17:21:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:05 INFO - Downloading/unpacking psutil>=0.7.1 17:21:05 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 17:21:05 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 17:21:05 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 17:21:05 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 17:21:05 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 17:21:05 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 17:21:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:21:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:21:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:21:07 INFO - Installing collected packages: psutil 17:21:07 INFO - Running setup.py install for psutil 17:21:07 INFO - building 'psutil._psutil_linux' extension 17:21:07 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 17:21:07 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 17:21:07 INFO - building 'psutil._psutil_posix' extension 17:21:07 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 17:21:07 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 17:21:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:21:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:21:08 INFO - Successfully installed psutil 17:21:08 INFO - Cleaning up... 17:21:08 INFO - Return code: 0 17:21:08 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:21:08 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')]} 17:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:08 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')]} 17:21:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:08 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3be9522f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdad9c0>, '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 0xdae8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdaed50>, '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': '826874ccc97bd7bf541b4875000001d5-1463098851.134378-859456878', '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 17:21:08 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.0.0'] in /builds/slave/test/build 17:21:08 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.0.0 17:21:08 INFO - Using env: {'DISPLAY': ':0', 17:21:08 INFO - 'HOME': '/home/cltbld', 17:21:08 INFO - 'LANG': 'en_US.UTF-8', 17:21:08 INFO - 'LANGUAGE': 'en_US:en', 17:21:08 INFO - 'LOGNAME': 'cltbld', 17:21:08 INFO - 'MAIL': '/var/mail/cltbld', 17:21:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:08 INFO - 'MOZ_NO_REMOTE': '1', 17:21:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:21:08 INFO - 'NO_EM_RESTART': '1', 17:21:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:21:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:21:08 INFO - 'PWD': '/builds/slave/test', 17:21:08 INFO - 'SHELL': '/bin/bash', 17:21:08 INFO - 'SHLVL': '1', 17:21:08 INFO - 'TERM': 'linux', 17:21:08 INFO - 'TMOUT': '86400', 17:21:08 INFO - 'USER': 'cltbld', 17:21:08 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1463098851.134378-859456878', 17:21:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:08 INFO - '_': '/tools/buildbot/bin/python'} 17:21:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:08 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:21:08 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 17:21:08 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 17:21:08 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 17:21:08 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 17:21:08 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 17:21:08 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 17:21:10 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:21:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:21:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:21:10 INFO - Installing collected packages: mozsystemmonitor 17:21:10 INFO - Running setup.py install for mozsystemmonitor 17:21:10 INFO - Successfully installed mozsystemmonitor 17:21:10 INFO - Cleaning up... 17:21:10 INFO - Return code: 0 17:21:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:21:10 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')]} 17:21:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:10 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')]} 17:21:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:10 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 0x7f3be9522f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdad9c0>, '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 0xdae8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdaed50>, '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': '826874ccc97bd7bf541b4875000001d5-1463098851.134378-859456878', '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 17:21:10 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 17:21:10 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 17:21:10 INFO - Using env: {'DISPLAY': ':0', 17:21:10 INFO - 'HOME': '/home/cltbld', 17:21:10 INFO - 'LANG': 'en_US.UTF-8', 17:21:10 INFO - 'LANGUAGE': 'en_US:en', 17:21:10 INFO - 'LOGNAME': 'cltbld', 17:21:10 INFO - 'MAIL': '/var/mail/cltbld', 17:21:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:10 INFO - 'MOZ_NO_REMOTE': '1', 17:21:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:21:10 INFO - 'NO_EM_RESTART': '1', 17:21:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:21:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:21:10 INFO - 'PWD': '/builds/slave/test', 17:21:10 INFO - 'SHELL': '/bin/bash', 17:21:10 INFO - 'SHLVL': '1', 17:21:10 INFO - 'TERM': 'linux', 17:21:10 INFO - 'TMOUT': '86400', 17:21:10 INFO - 'USER': 'cltbld', 17:21:10 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1463098851.134378-859456878', 17:21:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:10 INFO - '_': '/tools/buildbot/bin/python'} 17:21:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:10 INFO - Downloading/unpacking blobuploader==1.2.4 17:21:10 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 17:21:10 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 17:21:10 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 17:21:10 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 17:21:10 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 17:21:10 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 17:21:12 INFO - Downloading blobuploader-1.2.4.tar.gz 17:21:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:21:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:21:12 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 17:21:12 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 17:21:12 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 17:21:12 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 17:21:12 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 17:21:12 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 17:21:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:21:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:21:12 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 17:21:12 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 17:21:12 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 17:21:12 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 17:21:12 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 17:21:12 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 17:21:12 INFO - Downloading docopt-0.6.1.tar.gz 17:21:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:21:13 INFO - Installing collected packages: blobuploader, requests, docopt 17:21:13 INFO - Running setup.py install for blobuploader 17:21:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:21:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:21:13 INFO - Running setup.py install for requests 17:21:13 INFO - Running setup.py install for docopt 17:21:13 INFO - Successfully installed blobuploader requests docopt 17:21:13 INFO - Cleaning up... 17:21:13 INFO - Return code: 0 17:21:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:21:13 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')]} 17:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:13 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')]} 17:21:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:13 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 0x7f3be9522f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdad9c0>, '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 0xdae8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdaed50>, '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': '826874ccc97bd7bf541b4875000001d5-1463098851.134378-859456878', '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 17:21:13 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 17:21:13 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 17:21:13 INFO - Using env: {'DISPLAY': ':0', 17:21:13 INFO - 'HOME': '/home/cltbld', 17:21:13 INFO - 'LANG': 'en_US.UTF-8', 17:21:13 INFO - 'LANGUAGE': 'en_US:en', 17:21:13 INFO - 'LOGNAME': 'cltbld', 17:21:13 INFO - 'MAIL': '/var/mail/cltbld', 17:21:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:13 INFO - 'MOZ_NO_REMOTE': '1', 17:21:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:21:13 INFO - 'NO_EM_RESTART': '1', 17:21:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:21:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:21:13 INFO - 'PWD': '/builds/slave/test', 17:21:13 INFO - 'SHELL': '/bin/bash', 17:21:13 INFO - 'SHLVL': '1', 17:21:13 INFO - 'TERM': 'linux', 17:21:13 INFO - 'TMOUT': '86400', 17:21:13 INFO - 'USER': 'cltbld', 17:21:13 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1463098851.134378-859456878', 17:21:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:13 INFO - '_': '/tools/buildbot/bin/python'} 17:21:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:21:13 INFO - Running setup.py (path:/tmp/pip-tJwqcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:21:13 INFO - Running setup.py (path:/tmp/pip-rVg4lQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:21:13 INFO - Running setup.py (path:/tmp/pip-oSfXi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:21:13 INFO - Running setup.py (path:/tmp/pip-Tlben3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:21:14 INFO - Running setup.py (path:/tmp/pip-0A6bwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:21:14 INFO - Running setup.py (path:/tmp/pip-i3hdJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:21:14 INFO - Running setup.py (path:/tmp/pip-OV7Cmx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:21:14 INFO - Running setup.py (path:/tmp/pip-MUqFj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:21:14 INFO - Running setup.py (path:/tmp/pip-evYDWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:21:14 INFO - Running setup.py (path:/tmp/pip-tLHKIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:21:14 INFO - Running setup.py (path:/tmp/pip-VMmKZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:21:14 INFO - Running setup.py (path:/tmp/pip-7rahUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:21:14 INFO - Running setup.py (path:/tmp/pip-pzplt2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:21:14 INFO - Running setup.py (path:/tmp/pip-jQuUjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:21:14 INFO - Running setup.py (path:/tmp/pip-zvY40l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:21:14 INFO - Running setup.py (path:/tmp/pip-DkPqut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:21:14 INFO - Running setup.py (path:/tmp/pip-AfhaAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:21:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:21:14 INFO - Running setup.py install for manifestparser 17:21:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:21:14 INFO - Running setup.py install for mozcrash 17:21:14 INFO - Running setup.py install for mozdebug 17:21:15 INFO - Running setup.py install for mozdevice 17:21:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:21:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:21:15 INFO - Running setup.py install for mozfile 17:21:15 INFO - Running setup.py install for mozhttpd 17:21:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:21:15 INFO - Running setup.py install for mozinfo 17:21:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:21:15 INFO - Running setup.py install for mozInstall 17:21:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:21:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:21:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:21:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:21:15 INFO - Running setup.py install for mozleak 17:21:15 INFO - Running setup.py install for mozlog 17:21:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:21:15 INFO - Running setup.py install for moznetwork 17:21:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:21:15 INFO - Running setup.py install for mozprocess 17:21:15 INFO - Running setup.py install for mozprofile 17:21:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:21:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:21:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:21:15 INFO - Running setup.py install for mozrunner 17:21:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:21:16 INFO - Running setup.py install for mozscreenshot 17:21:16 INFO - Running setup.py install for moztest 17:21:16 INFO - Running setup.py install for mozversion 17:21:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:21:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:21:16 INFO - Cleaning up... 17:21:16 INFO - Return code: 0 17:21:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:21:16 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')]} 17:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:16 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')]} 17:21:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:16 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 0x7f3be9522f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdad9c0>, '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 0xdae8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdaed50>, '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': '826874ccc97bd7bf541b4875000001d5-1463098851.134378-859456878', '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 17:21:16 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 17:21:16 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 17:21:16 INFO - Using env: {'DISPLAY': ':0', 17:21:16 INFO - 'HOME': '/home/cltbld', 17:21:16 INFO - 'LANG': 'en_US.UTF-8', 17:21:16 INFO - 'LANGUAGE': 'en_US:en', 17:21:16 INFO - 'LOGNAME': 'cltbld', 17:21:16 INFO - 'MAIL': '/var/mail/cltbld', 17:21:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:16 INFO - 'MOZ_NO_REMOTE': '1', 17:21:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:21:16 INFO - 'NO_EM_RESTART': '1', 17:21:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:21:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:21:16 INFO - 'PWD': '/builds/slave/test', 17:21:16 INFO - 'SHELL': '/bin/bash', 17:21:16 INFO - 'SHLVL': '1', 17:21:16 INFO - 'TERM': 'linux', 17:21:16 INFO - 'TMOUT': '86400', 17:21:16 INFO - 'USER': 'cltbld', 17:21:16 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1463098851.134378-859456878', 17:21:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:16 INFO - '_': '/tools/buildbot/bin/python'} 17:21:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:21:16 INFO - Running setup.py (path:/tmp/pip-NoElvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:21:16 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)) 17:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:21:16 INFO - Running setup.py (path:/tmp/pip-fO2Tkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:21:16 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)) 17:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:21:16 INFO - Running setup.py (path:/tmp/pip-LlaMqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:21:16 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)) 17:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:21:16 INFO - Running setup.py (path:/tmp/pip-324_cA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:21:16 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)) 17:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:21:16 INFO - Running setup.py (path:/tmp/pip-PtOB1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:21:16 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)) 17:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:21:16 INFO - Running setup.py (path:/tmp/pip-Tgw7Ka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:21:16 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)) 17:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:21:16 INFO - Running setup.py (path:/tmp/pip-KuFNuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:21:16 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)) 17:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:21:16 INFO - Running setup.py (path:/tmp/pip-UEo9lF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:21:17 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)) 17:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:21:17 INFO - Running setup.py (path:/tmp/pip-vbgizY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:21:17 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)) 17:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:21:17 INFO - Running setup.py (path:/tmp/pip-5yMBvk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:21:17 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)) 17:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:21:17 INFO - Running setup.py (path:/tmp/pip-qxh2M2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:21:17 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)) 17:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:21:17 INFO - Running setup.py (path:/tmp/pip-TzuJap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:21:17 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)) 17:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:21:17 INFO - Running setup.py (path:/tmp/pip-fsxlMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:21:17 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)) 17:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:21:17 INFO - Running setup.py (path:/tmp/pip-qFg7Gf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:21:17 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)) 17:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:21:17 INFO - Running setup.py (path:/tmp/pip-B5ARIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:21:17 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)) 17:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:21:17 INFO - Running setup.py (path:/tmp/pip-MS4QhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:21:17 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)) 17:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:21:17 INFO - Running setup.py (path:/tmp/pip-fRoxlf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:21:17 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)) 17:21:17 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)) 17:21:17 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)) 17:21:17 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)) 17:21:17 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)) 17:21:17 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)) 17:21:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:21:17 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 17:21:17 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 17:21:17 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 17:21:17 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 17:21:17 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 17:21:17 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 17:21:19 INFO - Downloading blessings-1.6.tar.gz 17:21:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:21:19 INFO - Installing collected packages: blessings 17:21:19 INFO - Running setup.py install for blessings 17:21:19 INFO - Successfully installed blessings 17:21:19 INFO - Cleaning up... 17:21:19 INFO - Return code: 0 17:21:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:21:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:21:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:21:19 INFO - Reading from file tmpfile_stdout 17:21:19 INFO - Current package versions: 17:21:19 INFO - argparse == 1.2.1 17:21:19 INFO - blessings == 1.6 17:21:19 INFO - blobuploader == 1.2.4 17:21:19 INFO - docopt == 0.6.1 17:21:19 INFO - manifestparser == 1.1 17:21:19 INFO - mozInstall == 1.12 17:21:19 INFO - mozcrash == 0.17 17:21:19 INFO - mozdebug == 0.1 17:21:19 INFO - mozdevice == 0.48 17:21:19 INFO - mozfile == 1.2 17:21:19 INFO - mozhttpd == 0.7 17:21:19 INFO - mozinfo == 0.9 17:21:19 INFO - mozleak == 0.1 17:21:19 INFO - mozlog == 3.2 17:21:19 INFO - moznetwork == 0.27 17:21:19 INFO - mozprocess == 0.22 17:21:19 INFO - mozprofile == 0.28 17:21:19 INFO - mozrunner == 6.11 17:21:19 INFO - mozscreenshot == 0.1 17:21:19 INFO - mozsystemmonitor == 0.0 17:21:19 INFO - moztest == 0.7 17:21:19 INFO - mozversion == 1.4 17:21:19 INFO - psutil == 3.1.1 17:21:19 INFO - requests == 1.2.3 17:21:19 INFO - wsgiref == 0.1.2 17:21:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:21:19 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')]} 17:21:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:19 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')]} 17:21:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:19 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 0x7f3be9522f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdad9c0>, '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 0xdae8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdaed50>, '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': '826874ccc97bd7bf541b4875000001d5-1463098851.134378-859456878', '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 17:21:19 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 17:21:19 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 17:21:19 INFO - Using env: {'DISPLAY': ':0', 17:21:19 INFO - 'HOME': '/home/cltbld', 17:21:19 INFO - 'LANG': 'en_US.UTF-8', 17:21:19 INFO - 'LANGUAGE': 'en_US:en', 17:21:19 INFO - 'LOGNAME': 'cltbld', 17:21:19 INFO - 'MAIL': '/var/mail/cltbld', 17:21:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:19 INFO - 'MOZ_NO_REMOTE': '1', 17:21:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:21:19 INFO - 'NO_EM_RESTART': '1', 17:21:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:21:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:21:19 INFO - 'PWD': '/builds/slave/test', 17:21:19 INFO - 'SHELL': '/bin/bash', 17:21:19 INFO - 'SHLVL': '1', 17:21:19 INFO - 'TERM': 'linux', 17:21:19 INFO - 'TMOUT': '86400', 17:21:19 INFO - 'USER': 'cltbld', 17:21:19 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1463098851.134378-859456878', 17:21:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:19 INFO - '_': '/tools/buildbot/bin/python'} 17:21:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:20 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)) 17:21:20 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)) 17:21:20 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)) 17:21:20 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)) 17:21:20 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)) 17:21:20 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)) 17:21:20 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)) 17:21:20 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)) 17:21:20 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)) 17:21:20 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)) 17:21:20 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)) 17:21:20 INFO - Cleaning up... 17:21:20 INFO - Return code: 0 17:21:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:21:20 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')]} 17:21:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:20 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')]} 17:21:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:20 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 0x7f3be9522f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdad9c0>, '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 0xdae8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdaed50>, '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': '826874ccc97bd7bf541b4875000001d5-1463098851.134378-859456878', '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 17:21:20 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 17:21:20 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 17:21:20 INFO - Using env: {'DISPLAY': ':0', 17:21:20 INFO - 'HOME': '/home/cltbld', 17:21:20 INFO - 'LANG': 'en_US.UTF-8', 17:21:20 INFO - 'LANGUAGE': 'en_US:en', 17:21:20 INFO - 'LOGNAME': 'cltbld', 17:21:20 INFO - 'MAIL': '/var/mail/cltbld', 17:21:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:20 INFO - 'MOZ_NO_REMOTE': '1', 17:21:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:21:20 INFO - 'NO_EM_RESTART': '1', 17:21:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:21:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:21:20 INFO - 'PWD': '/builds/slave/test', 17:21:20 INFO - 'SHELL': '/bin/bash', 17:21:20 INFO - 'SHLVL': '1', 17:21:20 INFO - 'TERM': 'linux', 17:21:20 INFO - 'TMOUT': '86400', 17:21:20 INFO - 'USER': 'cltbld', 17:21:20 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1463098851.134378-859456878', 17:21:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:20 INFO - '_': '/tools/buildbot/bin/python'} 17:21:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:20 INFO - Downloading/unpacking jsonschema 17:21:20 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 17:21:20 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 17:21:20 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 17:21:20 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 17:21:20 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 17:21:20 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 17:21:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:21:22 INFO - Downloading/unpacking functools32 (from jsonschema) 17:21:22 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 17:21:22 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 17:21:22 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 17:21:22 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 17:21:22 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 17:21:22 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 17:21:22 INFO - Downloading functools32-3.2.3-2.tar.gz 17:21:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:21:22 INFO - warning: no files found matching '*.txt' 17:21:22 INFO - no previously-included directories found matching 'build' 17:21:22 INFO - no previously-included directories found matching 'dist' 17:21:22 INFO - no previously-included directories found matching '.git*' 17:21:22 INFO - Installing collected packages: jsonschema, functools32 17:21:22 INFO - Running setup.py install for functools32 17:21:22 INFO - warning: no files found matching '*.txt' 17:21:22 INFO - no previously-included directories found matching 'build' 17:21:22 INFO - no previously-included directories found matching 'dist' 17:21:22 INFO - no previously-included directories found matching '.git*' 17:21:22 INFO - Successfully installed jsonschema functools32 17:21:22 INFO - Cleaning up... 17:21:22 INFO - Return code: 0 17:21:22 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:21:22 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')]} 17:21:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:22 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')]} 17:21:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:22 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 0x7f3be9522f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdad9c0>, '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 0xdae8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdaed50>, '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': '826874ccc97bd7bf541b4875000001d5-1463098851.134378-859456878', '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 17:21:22 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 17:21:22 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 17:21:22 INFO - Using env: {'DISPLAY': ':0', 17:21:22 INFO - 'HOME': '/home/cltbld', 17:21:22 INFO - 'LANG': 'en_US.UTF-8', 17:21:22 INFO - 'LANGUAGE': 'en_US:en', 17:21:22 INFO - 'LOGNAME': 'cltbld', 17:21:22 INFO - 'MAIL': '/var/mail/cltbld', 17:21:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:22 INFO - 'MOZ_NO_REMOTE': '1', 17:21:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:21:22 INFO - 'NO_EM_RESTART': '1', 17:21:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:21:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:21:22 INFO - 'PWD': '/builds/slave/test', 17:21:22 INFO - 'SHELL': '/bin/bash', 17:21:22 INFO - 'SHLVL': '1', 17:21:22 INFO - 'TERM': 'linux', 17:21:22 INFO - 'TMOUT': '86400', 17:21:22 INFO - 'USER': 'cltbld', 17:21:22 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1463098851.134378-859456878', 17:21:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:22 INFO - '_': '/tools/buildbot/bin/python'} 17:21:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:22 INFO - Downloading/unpacking flake8 17:21:22 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 17:21:22 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 17:21:22 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 17:21:22 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 17:21:22 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 17:21:22 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 17:21:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:21:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:21:24 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 17:21:24 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 17:21:24 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 17:21:24 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 17:21:24 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 17:21:24 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 17:21:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:21:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:21:24 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 17:21:24 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 17:21:24 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 17:21:24 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 17:21:24 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 17:21:24 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 17:21:25 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:21:25 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 17:21:25 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 17:21:25 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 17:21:25 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 17:21:25 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 17:21:25 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 17:21:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:21:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:21:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:21:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:21:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:21:25 INFO - no previously-included directories found matching 'docs/_build' 17:21:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:21:25 INFO - Running setup.py install for pep8 17:21:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:21:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:21:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:21:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:21:25 INFO - no previously-included directories found matching 'docs/_build' 17:21:25 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:21:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:21:25 INFO - Cleaning up... 17:21:25 INFO - Return code: 0 17:21:25 INFO - Running post-action listener: _resource_record_post_action 17:21:25 INFO - Running post-action listener: _start_resource_monitoring 17:21:25 INFO - Starting resource monitoring. 17:21:25 INFO - ##### 17:21:25 INFO - ##### Finished create-virtualenv step (success) 17:21:25 INFO - ##### 17:21:25 INFO - ##### 17:21:25 INFO - ##### Running install step. 17:21:25 INFO - ##### 17:21:25 INFO - Running pre-action listener: _resource_record_pre_action 17:21:25 INFO - Running main action method: install 17:21:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:21:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:21:25 INFO - Reading from file tmpfile_stdout 17:21:25 INFO - Detecting whether we're running mozinstall >=1.0... 17:21:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:21:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:21:25 INFO - Reading from file tmpfile_stdout 17:21:25 INFO - Output received: 17:21:25 INFO - Usage: mozinstall [options] installer 17:21:25 INFO - Options: 17:21:25 INFO - -h, --help show this help message and exit 17:21:25 INFO - -d DEST, --destination=DEST 17:21:25 INFO - Directory to install application into. [default: 17:21:25 INFO - "/builds/slave/test"] 17:21:25 INFO - --app=APP Application being installed. [default: firefox] 17:21:25 INFO - mkdir: /builds/slave/test/build/application 17:21:25 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'] 17:21:25 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 17:21:41 INFO - Reading from file tmpfile_stdout 17:21:41 INFO - Output received: 17:21:41 INFO - /builds/slave/test/build/application/firefox/firefox 17:21:41 INFO - Running post-action listener: _resource_record_post_action 17:21:41 INFO - ##### 17:21:41 INFO - ##### Finished install step (success) 17:21:41 INFO - ##### 17:21:41 INFO - ##### 17:21:41 INFO - ##### Running run-tests step. 17:21:41 INFO - ##### 17:21:41 INFO - Running pre-action listener: _resource_record_pre_action 17:21:41 INFO - Running main action method: run_tests 17:21:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:21:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:21:41 INFO - Python 2.7.3 17:21:41 INFO - Return code: 0 17:21:41 INFO - grabbing minidump binary from tooltool 17:21:41 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')]} 17:21:41 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 0xdad9c0>, '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 0xdae8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdaed50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:21:41 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 17:21:41 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 17:21:41 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 17:21:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:21:41 INFO - Return code: 0 17:21:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:21:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:21:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:21:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:21:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:21:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:21:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:21:42 INFO - Return code: 0 17:21:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O6ir-GOHSXGcqtGBa_xKIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 17:21:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/O6ir-GOHSXGcqtGBa_xKIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-052 --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 17:21:42 INFO - Using env: {'DISPLAY': ':0', 17:21:42 INFO - 'HOME': '/home/cltbld', 17:21:42 INFO - 'LANG': 'en_US.UTF-8', 17:21:42 INFO - 'LANGUAGE': 'en_US:en', 17:21:42 INFO - 'LOGNAME': 'cltbld', 17:21:42 INFO - 'MAIL': '/var/mail/cltbld', 17:21:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:21:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:21:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:42 INFO - 'MOZ_NO_REMOTE': '1', 17:21:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:21:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:21:42 INFO - 'NO_EM_RESTART': '1', 17:21:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:21:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:21:42 INFO - 'PWD': '/builds/slave/test', 17:21:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:21:42 INFO - 'SHELL': '/bin/bash', 17:21:42 INFO - 'SHLVL': '1', 17:21:42 INFO - 'TERM': 'linux', 17:21:42 INFO - 'TMOUT': '86400', 17:21:42 INFO - 'USER': 'cltbld', 17:21:42 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1463098851.134378-859456878', 17:21:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:42 INFO - '_': '/tools/buildbot/bin/python'} 17:21:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O6ir-GOHSXGcqtGBa_xKIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 17:21:42 INFO - mozversion application_buildid: 20160512162545 17:21:42 INFO - mozversion application_changeset: bec48bfd05a8c6703aab63181441869a3dcaa4cc 17:21:42 INFO - mozversion application_display_name: Nightly 17:21:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:21:42 INFO - mozversion application_name: Firefox 17:21:42 INFO - mozversion application_remotingname: firefox 17:21:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:21:42 INFO - mozversion application_vendor: Mozilla 17:21:42 INFO - mozversion application_version: 49.0a1 17:21:42 INFO - mozversion platform_buildid: 20160512162545 17:21:42 INFO - mozversion platform_changeset: bec48bfd05a8c6703aab63181441869a3dcaa4cc 17:21:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:21:42 INFO - mozversion platform_version: 49.0a1 17:21:42 INFO - using testdate: 1463098902 17:21:42 INFO - actual date: 1463098902 17:21:42 INFO - starting webserver on 'localhost:53318' 17:21:42 INFO - SUITE-START | Running 2 tests 17:21:42 INFO - TEST-START | dromaeo_css 17:21:42 INFO - operating with platform_type : linux_ 17:21:42 INFO - Initialising browser for dromaeo_css test... 17:21:42 INFO - TEST-INFO | started process 18878 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqOb64k/profile http://localhost:53318/getInfo.html) 17:21:46 INFO - PROCESS | 18878 | __metrics Screen width/height:1600/1200 17:21:46 INFO - PROCESS | 18878 | colorDepth:24 17:21:46 INFO - PROCESS | 18878 | Browser inner width/height: 1024/697 17:21:46 INFO - PROCESS | 18878 | __metrics 17:21:47 ERROR - PROCESS | 18878 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:21:47 INFO - TEST-INFO | 18878: exit 0 17:21:47 INFO - Browser initialized. 17:21:47 INFO - Running cycle 1/1 for dromaeo_css test... 17:21:47 INFO - TEST-INFO | started process 18957 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqOb64k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:21:59 INFO - PROCESS | 18957 | RSS: Main: 153882624 17:21:59 INFO - PROCESS | 18957 | 17:22:50 INFO - PROCESS | 18957 | 1463098970982 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] 17:25:02 INFO - PROCESS | 18957 | Cycle 1(1): loaded http://localhost:53318/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53318/tests/dromaeo/cssquery-ext.html) 17:25:03 INFO - PROCESS | 18957 | RSS: Main: 266317824 17:25:03 INFO - PROCESS | 18957 | 17:28:06 INFO - PROCESS | 18957 | Cycle 1(1): loaded http://localhost:53318/tests/dromaeo/cssquery-ext.html (next: http://localhost:53318/tests/dromaeo/cssquery-jquery.html) 17:28:06 INFO - PROCESS | 18957 | RSS: Main: 234422272 17:28:06 INFO - PROCESS | 18957 | 17:31:09 INFO - PROCESS | 18957 | Cycle 1(1): loaded http://localhost:53318/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53318/tests/dromaeo/cssquery-mootools.html) 17:31:09 INFO - PROCESS | 18957 | RSS: Main: 241958912 17:31:09 INFO - PROCESS | 18957 | 17:34:11 INFO - PROCESS | 18957 | Cycle 1(1): loaded http://localhost:53318/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53318/tests/dromaeo/cssquery-prototype.html) 17:34:12 INFO - PROCESS | 18957 | RSS: Main: 240779264 17:34:12 INFO - PROCESS | 18957 | 17:37:14 INFO - PROCESS | 18957 | Cycle 1(1): loaded http://localhost:53318/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53318/tests/dromaeo/cssquery-yui.html) 17:37:15 INFO - PROCESS | 18957 | RSS: Main: 213315584 17:37:15 INFO - PROCESS | 18957 | 17:40:18 INFO - PROCESS | 18957 | Cycle 1(1): loaded http://localhost:53318/tests/dromaeo/cssquery-yui.html (next: http://localhost:53318/tests/dromaeo/cssquery-dojo.html) 17:40:18 INFO - PROCESS | 18957 | RSS: Main: 275599360 17:40:18 INFO - PROCESS | 18957 | 17:40:18 INFO - PROCESS | 18957 | __start_tp_report 17:40:18 INFO - PROCESS | 18957 | _x_x_mozilla_page_load 17:40:18 INFO - PROCESS | 18957 | _x_x_mozilla_page_load_details 17:40:18 INFO - PROCESS | 18957 | |i|pagename|runs| 17:40:18 INFO - PROCESS | 18957 | |0;dojo.html;2568.4606232691135;2587.676540432446;2605.7003444603865;2605.947881042378;2611.647427597275;4541.409616749818;4572.519885412034;4693.202155633542;4744.169770290203;4755.90488190236;4623.8150473981;4659.044895796362;4678.5087565805525;4785.97101623151;4801.96757697095;4247.06564555798;4284.6786491013145;4314;4337.631301339374;4529.184746745585;4417.514073451917;4440.045390241097;4458.71018383804;4471.485779135409;4484.573965473275;4170.249355116078;4220.767857767822;4287.206866729665;4308.310670292738;4341.3053911374345;4362.171187474401;4392.736435813861;4392.868213953587;4421.60205581496;4463.754493502856;4372.89067773305;4382.824687012516;4389.670774691879;4420.513743488214;4445.088756804847;4426;4426.955730442719;4533.546645335473;4682.81268749253;4748.715077095385;4991.700497970133;5016.04695107932;5036.974815125901;5040.495950404967;5068.4424713281505;5000.499950005007;5050.646454748169;5091.847244582668;5099.031184075014;5134.127198376285;4541.954580454186;4615;4666.510016448292;4667.743274119956;4668;5108.2082277246345;5109.463506331856;5126.769295381717;5139.023585518739;5177.508136727005;4971.751412429364;4993.775280112403;4995.275685025651;4998;5006.424261209934;4847.151748444008;4998.525140111684;5010.123228435009;5025.447200807908;5065.417476990119;4951.356323677899;4956.90086198274;4965.726885021359;4993.375828021497;5021.974890125526;4806.759662016885;4939.728314942713;4948.233023881232;5003.54968052877;5005.874853128628;4220.53574106848;4232.153569286155;4241.597048280409;4244.257254980366;4258.999135203225;3710.8330125143893;3729.4219395993664;3733.290674771785;3735.738498305147;3773.471713959993;4295.570442955679;4301.2257793597455;4321.611055005064;4331.350297455407;4351.12977404514;4787.042591481718;5014.423341315723;5029.84910452687;5076.44159142494;5082.517160869711;4314.7626880521875;4322.459692538433;4335.913281734348;4365.716228445141;4384.6273066789045;4444.688871779009;4537.773111344485;4543.295789152687;4556.521565235669;4607.378003969421;4504.324351347259;4653.627709783209;4694.859154225379;4702.694324868872;4715.622750180046;5014.749262536931;5055.241713742968;5060.84817455477;5062.519060689376;5075.390953085654;4538.500764915791;4682.344471773887;4698.224792909268;4715.056988602362;4750.07373562152;4946.282788995503;4982.551570358685;4999.300097986212;5021.623378246719;5042.621803364836;5065.544101030778;5102.642815002914;5119.769610367468;5141;5190.429052804113;4754.738489383117;4808.08646357191;4968.329275547755;4997.800087996439;5000.524950129732;4815.686980346266;4875.439324477588;4910.705357678551;4918.877028074184;4955.975220123876;4800.5199480051715;4838.395200599925;4845.394325709286;4852.078105160008;4881.658283920092;4791.904161916812;4864.343313652612;4901.656884018084;4951.232558953224;4955.900881982412;4757.3577567028005;4758.452777930583;4809.158397280392;4830.565249127595;4859.829905953275 17:40:18 INFO - PROCESS | 18957 | |1;ext.html;554.2600628161405;576.2595065341035;584.8917950179219;589.1545632018054;590.9674967876766;27987;41490;42540.78729606355;42981.785091074504;46056.53943460564;41530.58469415305;42072.57927420725;42087.36868946968;42166;42245;7724.150343462215;7804.29761321481;7830.56931868747;7832.412569057315;7839.608019599026;7755.108162561293;7858.253465920757;7867.1739467355965;7868.763937081897;7872.252136047066;7844.333231675315;7869.331106855924;7870.331021863149;7882.369410447151;7882.80292992674;7877.566733829637;7889.132195458495;7894.3289820365335;7927.246911543394;7942.682292708285;7693.884591731073;7813.140554538996;7844.568548729818;7845.215478452166;7848.411369147337;38641.806790965864;38979.02552436212;39119.21761564781;39134.21731565381;39136.80431597824;3198.984005079983;3218.5815843940372;3369.0903456066726;3748.5689145748042;3980.283548961215;28376.432471350457;28774.424511509653;30725.697575362086;31130.688693113232;31716.682833171602;3355.2450698592866;3535.864264258267;3537.4163263061564;3646.252518233756;3729.8321575528894;231384;236821;237074;237173;239406;35033.82483087568;51881.2217816733;53117.7344113277;53234.46765532372;53275.467245327825;34083.762042605915;36186.63813361886;36255.4561681575;36388.636113638524;36399.27201456009;14210.928945355206;14302.928485357506;14356.784648230285;14416.207108608918;14456.783148252785;11587.59443419493;11823.290602563873;11845.88154118465;11889.405529723479;11951.940240298916;8496.192861678132;8526.062133165347;8554.14458554152;8558.572071396406;8609.61256743448;3357.0600231935096;3369.2082360645227;3371.8482668279985;3380.9323813523592;3411.454167333264;882.6645874567623;899.8425275576748;930.7859192385789;944.2729098594044;1035.7307100153864;27521;27640.723592764218;28267.293317666812;28286.434271314458;28635.57046644302;831.6465502161557;986.8273052215834;1073.291627525845;1088.4612117001977;1157.9015783658483;14133;14579.41682332716;14624.341904614104;14730.189839558927;14827.851721482863;343420;344285;346579;347100;347253;47022.529774702496;47524.04951900943;47688.761556191996;47725.284120737524;47811.76094119577;1143.7769634921276;1221.8167274908835;1260.4706023470164;1287.150480682745;1296.546208826903;28046.85976570104;29035.7096429033;29252.268693282836;29357.385343806294;29925.85037074801;42259.36610950777;42480;42736.35895461633;42856;42934.35598466088;285292;288322;289754;289769;588808;25885.22344329673;27248.455030898873;27300.180994570193;28117.578236326062;28285.151445456668;42112;42176.57823421727;42376.5762342385;42908;43800;35660.28679426345;36550.817245914666;36735.448968266035;36749;37203.62796372001;36739.63260367362;36916;36969.6303036977;37535.249295014495;37609;35974.820125899205;36065;36420.27159456743;36635.08412289714;36807.07982300464;31931.840340798146;32349.029529114163;32637.836810815796;32786.83606582047;32795;24314.513709725354;25208.621870671588;25328.240152795446;25548.744512554636;25554.488910222062 17:40:18 INFO - PROCESS | 18957 | |2;jquery.html;376.52745804015956;391.17071807767536;394.111279065707;401.8794361691495;409.16121950002486;15336.53990380289;16592.751108733377;17208.91395543024;17313.961162330237;17358.392456264035;16049.598760031005;16974;17108.914455427705;17143.571410714707;17193.71047171464;5087.56755675768;5325.733713314319;5329.493698098694;5332.3601167859715;5354.705491197982;3652.2878038782446;3942.073612701013;5480.506754392104;6077.301110372297;6180.752769889199;5932.792352267671;6018.187544681477;6053.122297266894;6096.664683442409;6113.23584551931;5938.346781854014;5948.434898684618;6099.420555047263;6116.052011938156;6123.693815309217;3371.258323168899;5024.773885175176;5391.81128660495;5393.7303134843105;5398.595105367113;19703.211871525124;19848.305309314248;20509.589808203753;20523.794762052337;20606.072726727332;2022.3023057045443;2038.0828627117708;2286.737025242102;2328.951971612781;2548.1845809341016;11884.40577971098;12286.692832679255;13447.394867230998;13547.051706380556;13653.522126725517;1777.7155655095123;1837.2099997001285;1867.6264747050643;1884;1905.9618807623908;72300.63849680718;74900;76283.61858190673;81618.59190704068;83147.5842620789;15814.181369142465;16460.588485287964;17242.827571724374;17290.221940012478;17339.133043348036;29897.412310522875;30268.09195724132;30552.236194095327;30590.235244119074;30618;8826.338024648177;8958.417702849294;9013.684521041732;9106.86339704905;9473.905260947302;7206.639668016578;7233.132024157135;7287.453440991947;7310.268973102648;7433.219511951167;8740.606672699743;8835;8835.469871807712;8905.465672059698;8915.910840891638;3285.5235990781202;3508.7894726316504;3526.2771131917893;3551.714663935849;3609.6209897960334;820;821.3716506872247;876.0932434929817;906.6781292641149;971.2763990826879;16177.838221617869;16496.587585310463;16948.915255423643;17053.57366065858;17070.146492675318;856.3620103023287;873.8995015573163;901.9909800901906;910.0762725833284;939.2673714502699;7762.456628036096;9241.399309045026;9507.334486585873;9617.422954622745;9681.128698417177;398876;405781;408482;427184;427474;75485.6225718868;79019.20980790119;79163;79416.60291698505;80538.59730701309;957.2103015012782;970.9368891022061;996.3125443444001;996.7557948302713;1019.6227395863579;15080.622984425478;15099.471518496799;15192.544223673307;15273.389064437299;15458.304376302869;33109;34020;34548.481772772924;34700.82649586736;34857.302853942274;45808.312875306234;48344.27483587819;48362.75818620884;48583.75708121437;48622.5137748618;7853.725119620786;7878.645460954156;8008.959955200186;8069.798255043671;8093.150219226896;11149.72125696864;11569.074474042225;11684;11772.705682357668;12227.572034978733;10221.693349199535;10321;10373.58505659765;10398.740031499274;10517.78964420692;9724.367916085432;10409;10513.369197848153;10560.207984401355;10826.13390928708;10351.378917264989;10640.255182137176;10708.785824283315;10919;10921.235513513977;7676.309132178131;7834.569098699626;7881.172476890073;7985.241402066795;8195.95902020486;9372.437653740797;10663.46682665879;10693.572257109628;10802.891971080502;10832.67501974942 17:40:18 INFO - PROCESS | 18957 | |3;mootools.html;1296.2481760578864;1440.7766796146598;1479.3416929466387;1634.8201697813238;1809.9276028958834;7308.305710957457;7658.6553605087765;7668.5398876067475;7837.451378403514;7861.921380786191;7617.6191190440395;7732.884006739903;7797.610119494031;7804.8048798780055;7805.180456052118;2168.533765240473;2191.375457994472;2191.923282685106;2192.967105493419;2198.9780102198933;2161.6109100361928;2176.183931025865;2180.6292930201826;2185.4536365908525;2196.516766311409;2139.1657253671;2178.4880553070016;2181;2194.5281764420647;2224.644056950888;2014.687723402875;2071;2087.812096911278;2104.053176070759;2107.062357251024;2054.753429588444;2102.2852230241792;2106.4628519727526;2108.3569511299047;2109.335559298816;7388.15036270825;7641.7707468776025;7708.691652333956;7782.143964163937;7793.415493837985;4386.780660966939;4488.236999710057;4502.5047244803045;4514.525974772634;4524.02733412318;2813.212300555848;2843.672977607581;2849.722888329464;2871.6410448693914;2924.035068427414;889.6574818694849;893.9865902011475;899.4288626722014;924.611663101499;930.8836395450569;10370.740731481697;10454.372737635766;10503.2122590806;10514.316569422963;10516.579336826519;3820.102275965146;3859.710521710827;3923.6272554107313;3942.8817135485406;4017.276890159799;8170.918290817134;8246.670133194724;8307;8313.376496762767;8318.292945099613;4442.6890117691455;4451.287793952952;4451.488078870907;4456;4460.955390446119;3588.820558972041;3906.2968665640456;4024.75851448914;4049.716519843583;4171.8957026074595;3306.057773534531;3313.122022663996;3333.833308334622;3357.3117510910206;3405.3870303345634;943.3113826906397;992.4194346307492;996.9700908972742;1000.2248257600272;1017.9592816287266;752.1951511882343;856.6737973235138;862.3489265604428;869.0831173112427;882.3955590420583;4810.4467986181335;4969.801207951714;4991;5100.1074811907765;5152.793888244503;398.3864848133899;398.607371738837;413.97102202845514;417.2031419987809;417.41770230528243;3496.8950931472095;3600.4959305697225;3678.779273243614;3685.7972811495088;3702.500162478085;9143.862842057242;9347.345685802065;9376;9406.294527910433;9445.905540944503;9167.908320916706;9335.90664093364;9344.34589578723;9362.438253704799;9381.0618938107;7157.069580954442;7170.892436613455;7282.271772822675;7290.890636640454;7305.45209109319;4973.950260497349;5131.512506311894;5153.613478989016;5162.354705661793;5285.973570132125;8527.360447966303;8573.699920502753;8688.652453901774;8691.391602587759;8854.026057133582;8283.130271321425;8855.424397414148;8913.019567847401;8927.107289271022;9030.232430243503;5666.744996475251;6366.808995730135;6412.839679008062;6470.805875823733;6520.706568204348;7207.783766487014;7305.707771689285;7414.740484083031;7455.440841936768;7482.588457634883;6475.320091390525;6903.344182302673;6947;6957.512974091765;7019.754308599175;6759;6780.050792889098;6790.151231096113;6797.796066118024;6908.378245957888;6261.780837670842;6323.9683801580695;6377.1390862233;6399.520035997226;6410.45511131559;4452;4519.050999290186;4526.275795872644;4541.568550987651;4581.793819278074;4420.77896105187;4496.775161241991;4543.977280113579;4588.678792484494;4629.652776041743 17:40:18 INFO - PROCESS | 18957 | |4;prototype.html;312.1229345539036;315.2449882531337;319.1271871431635;322.9289556297614;323.84710430866136;4712.505186955367;4717.57541821236;4741.8103275868925;4743.335932969387;4757.238841785315;4626.606738427237;4664.277037059262;4678.228092364756;4682.601978831794;4686.531346865312;3542.5040494330815;3621.4024685926793;3718.6758276077453;3732.2348918471785;3757.530308711411;3716.479692843004;3719.274741425423;3733.4959780429567;3755.6619904208615;3772.3775577029896;3471.4205036708236;3708.5735140458924;3720.6465385788306;3735.3463143949834;3735.383661695817;3554.431290993429;3688.79711615861;3698.1679122197424;3703.6481534254203;3718.3492888744363;3296.6703329666843;3300.950485742716;3303.900882973515;3304.1244070321386;3312.519684645713;4449.9110017799785;4468.932966005513;4479.3057076153245;4505.571970662814;4519.864404067883;3878.45701601776;4117.649999750025;4121.175764847043;4228.217779710732;4253.851115210984;4831.710097394132;4834.468208497063;4837.274408838667;4843.539863712942;4862.246351815475;3464.7574669773126;3486.6861982421706;3490.703290220334;3490.9003663845806;3501.8949431517094;4835.984443266918;5067.873303167414;5075.543201111881;5114.948850511484;5141.717205553693;3516.191276006533;3540.274243780019;3551.4672799080345;3567.250877315741;3579.6241394653184;3609.4118587821276;3624.5469316335457;3625.2024554597947;3627.981860090683;3630.8003059831963;4088.9591104089172;4093.3450647896193;4093.9181216375505;4104.056067104523;4117;4735.597474214662;4838.588719958772;4862.371105679637;4864.975675121602;4875.585575226075;1225.1179151011436;1236.2211806561809;1249.6813312605227;1250.9186902851286;1252.2861968677767;784.3098073695112;805.1787177079347;848.4145939301862;867.9783005424915;872.5506364222431;4240.194363071007;4267.615914567704;4276.935845962313;4287.206866729665;4295.656347492193;4850.466448690641;4914.213725803854;4958.181899986534;4978.103941290602;4983.732401757192;4058.2492238935893;4202.642775364067;4236.9364459533135;4242.8727138185905;4256.34026725858;2632.4735052989477;2635.5387807133675;2637.973620263811;2645.550256456407;2664.8934042638466;4644.489106198315;4655.580997710223;4657.67396282257;4662.020975595163;4670.509596492319;4832.806687732522;5052.9242061369105;5058.924116138261;5102.36220472441;5119.74401279942;4556.840510582114;4587.610053145453;4590.655700822452;4631.814727410933;4636.698614590108;4883.218685010382;4906.288588154626;4917.557419832232;4927.556519913225;4951.603871690329;4744.169770290255;4786.712797232177;4786.726305005095;4822.831200907952;4858.659893807541;4547.454305483231;4550.2492088804975;4591.517890621437;4596.471405788244;4619.4687610925175;3523.1896663766966;3544.6278140795876;3547.3614749344333;3553.4492153716214;3559.537260156163;4833.854984350475;4928.408590969107;4960.47914968923;4972.602191824573;4977;4620.768961551977;4871.683340582851;4887.853364399074;4923.926141107958;4952.678075925053;4895.853124406273;4910.43529994041;4911;4920.5571498565305;4934.654574179773;4853.684510506806;4859.663592512087;4864.513548645107;4866.562009419169;4888.560029597354;4730.148573256709;4945.876353091202;4952.455229924633;4957.851264462072;4965.0566392385335;4803;4819.638527110411;4829.879253018703;4838.225883858566;4838.612910967185 17:40:18 INFO - PROCESS | 18957 | |5;yui.html;685.4721864164593;700.2927043685876;715.9785206443809;749.3293502315428;755.6788364944897;12493.375331233447;12520.874791252096;12539.498420063186;12797.296148711817;13120.671983200426;12402.813957790619;12777.233365998023;12794.744105117916;12804.423800928957;12877;685.3934268172653;830.6345208108443;839.1817977471977;868.0321441592611;873.4715497124243;861.452977359375;865.7965378136133;865.8701194820765;868.4051424774018;871.4466313890694;910.9842525583992;911.7994041310934;913.1051569461931;913.7167478081816;921.2123634292684;713.0979311171346;875.3041332140931;901.5537309032005;907.120093509295;910.5840418149775;664.7939138866967;665.5441022899281;667.0094909060042;669.407574296746;670.1522573943964;12677.683057923625;12694.30181340026;12704.618861434172;12711.237325760392;12812.679683007906;12022.879771202264;12447.75104497905;12467.314297713621;12493.81308775665;12620.810687839597;10927.289726167854;11065.225434219608;11205.495752691148;11259.493322800494;11393.316401015883;4102.466679331667;4145.813438395249;4183.602557757008;4297.871063868089;4312.827486900552;41899;42315.78842105801;42652.78673606643;43808.34287485722;43907.78046109749;9900.60397584103;9980.451075190935;10007.09936105754;10092.44491552957;10123.1901447884;17441.12794360277;17446.127693615268;17510.82489175092;17562.385316514115;17676.381326653507;6356.713947872357;6438;6707.966460167766;6750;6798.388145066869;3668.834902429397;3716.554013518341;3744.9438258426144;3772.1889793694486;3823.6941044716355;2690.421559364746;2788.4004938938224;2799.1182777425047;2817.1970988268245;2832.7167283271506;493.8370337788521;508.7074931914164;512.3697851642501;519.2678323563757;520.8463503266546;515.9458256883048;568.1704711121808;568.3407247592772;583.5098517245534;599.6072572465042;6583.934160658332;6977.79066628002;7027.508074434741;7031.964840175767;7090.574565526085;519.3093186062604;547.8657728856456;592.7540070870626;598.853280946171;600.2826622186533;3338.21551935295;3340.1816554944194;3352.7150192233444;3364.6635336466647;3408;48617.756911215925;50844.49155508397;51268.743656282226;51925;52251.73874130605;45061;45326;45513.5383753945;47060.52939470561;47174.5282547177;43031.7848410756;43047.569524304985;43137.56862431335;43550.34674479822;43588.910277243325;6791.185057793096;6885.862282754417;6891.552049116792;6994.650267486503;7079.610621415872;27579;28189.577156343083;28443.715562844107;29290.267743306587;29412.852935735184;35479.29041419209;37190;37569.81215093907;37616.05031471766;37874.62125378711;9461.33770636049;9588.56851441673;9804.705858824247;9909.256805739455;9991.650292239738;10181.440020798631;10214.387136771817;10351.327163734333;10366;10670.039696427359;9225.769355766159;9378.624855005723;9564.13922746956;9741.659041933499;9773.169280611228;9407.247420206504;9585.089416505421;9621.422714637145;9661.3237073407;9891.258155638212;9323.673671421468;9372.718818435458;9553.808923821623;9572.425654460754;9728.124468797841;7947.960260198662;8006.639701213576;8258.917410825814;8303.709370172015;8606.956965215133;7814.843703125792;7920.84158316842;7984.720534781255;8067.757967260992;8239.464434811718 17:40:18 INFO - PROCESS | 18957 | __end_tp_report 17:40:18 INFO - PROCESS | 18957 | __start_cc_report 17:40:18 INFO - PROCESS | 18957 | _x_x_mozilla_cycle_collect,1033 17:40:18 INFO - PROCESS | 18957 | __end_cc_report 17:40:18 INFO - PROCESS | 18957 | __startTimestamp1463100018303__endTimestamp 17:40:18 INFO - PROCESS | 18957 | 17:40:18 INFO - PROCESS | 18957 | ------- Summary: start ------- 17:40:18 INFO - PROCESS | 18957 | Number of tests: 6 17:40:18 INFO - PROCESS | 18957 | 17:40:18 INFO - PROCESS | 18957 | [#0] dojo.html Cycles:165 Average:4642.37 Median:4754.74 stddev:488.31 (10.3%) stddev-sans-first:461.91 17:40:18 INFO - PROCESS | 18957 | Values: 2568.5 2587.7 2605.7 2605.9 2611.6 4541.4 4572.5 4693.2 4744.2 4755.9 4623.8 4659.0 4678.5 4786.0 4802.0 4247.1 4284.7 4314.0 4337.6 4529.2 4417.5 4440.0 4458.7 4471.5 4484.6 4170.2 4220.8 4287.2 4308.3 4341.3 4362.2 4392.7 4392.9 4421.6 4463.8 4372.9 4382.8 4389.7 4420.5 4445.1 4426.0 4427.0 4533.5 4682.8 4748.7 4991.7 5016.0 5037.0 5040.5 5068.4 5000.5 5050.6 5091.8 5099.0 5134.1 4542.0 4615.0 4666.5 4667.7 4668.0 5108.2 5109.5 5126.8 5139.0 5177.5 4971.8 4993.8 4995.3 4998.0 5006.4 4847.2 4998.5 5010.1 5025.4 5065.4 4951.4 4956.9 4965.7 4993.4 5022.0 4806.8 4939.7 4948.2 5003.5 5005.9 4220.5 4232.2 4241.6 4244.3 4259.0 3710.8 3729.4 3733.3 3735.7 3773.5 4295.6 4301.2 4321.6 4331.4 4351.1 4787.0 5014.4 5029.8 5076.4 5082.5 4314.8 4322.5 4335.9 4365.7 4384.6 4444.7 4537.8 4543.3 4556.5 4607.4 4504.3 4653.6 4694.9 4702.7 4715.6 5014.7 5055.2 5060.8 5062.5 5075.4 4538.5 4682.3 4698.2 4715.1 4750.1 4946.3 4982.6 4999.3 5021.6 5042.6 5065.5 5102.6 5119.8 5141.0 5190.4 4754.7 4808.1 4968.3 4997.8 5000.5 4815.7 4875.4 4910.7 4918.9 4956.0 4800.5 4838.4 4845.4 4852.1 4881.7 4791.9 4864.3 4901.7 4951.2 4955.9 4757.4 4758.5 4809.2 4830.6 4859.8 17:40:18 INFO - PROCESS | 18957 | 17:40:18 INFO - PROCESS | 18957 | [#1] ext.html Cycles:180 Average:45973.55 Median:20098.53 stddev:85183.58 (423.8%) stddev-sans-first:85354.28 17:40:18 INFO - PROCESS | 18957 | Values: 554.3 576.3 584.9 589.2 591.0 27987.0 41490.0 42540.8 42981.8 46056.5 41530.6 42072.6 42087.4 42166.0 42245.0 7724.2 7804.3 7830.6 7832.4 7839.6 7755.1 7858.3 7867.2 7868.8 7872.3 7844.3 7869.3 7870.3 7882.4 7882.8 7877.6 7889.1 7894.3 7927.2 7942.7 7693.9 7813.1 7844.6 7845.2 7848.4 38641.8 38979.0 39119.2 39134.2 39136.8 3199.0 3218.6 3369.1 3748.6 3980.3 28376.4 28774.4 30725.7 31130.7 31716.7 3355.2 3535.9 3537.4 3646.3 3729.8 231384.0 236821.0 237074.0 237173.0 239406.0 35033.8 51881.2 53117.7 53234.5 53275.5 34083.8 36186.6 36255.5 36388.6 36399.3 14210.9 14302.9 14356.8 14416.2 14456.8 11587.6 11823.3 11845.9 11889.4 11951.9 8496.2 8526.1 8554.1 8558.6 8609.6 3357.1 3369.2 3371.8 3380.9 3411.5 882.7 899.8 930.8 944.3 1035.7 27521.0 27640.7 28267.3 28286.4 28635.6 831.6 986.8 1073.3 1088.5 1157.9 14133.0 14579.4 14624.3 14730.2 14827.9 343420.0 344285.0 346579.0 347100.0 347253.0 47022.5 47524.0 47688.8 47725.3 47811.8 1143.8 1221.8 1260.5 1287.2 1296.5 28046.9 29035.7 29252.3 29357.4 29925.9 42259.4 42480.0 42736.4 42856.0 42934.4 285292.0 288322.0 289754.0 289769.0 588808.0 25885.2 27248.5 27300.2 28117.6 28285.2 42112.0 42176.6 42376.6 42908.0 43800.0 35660.3 36550.8 36735.4 36749.0 37203.6 36739.6 36916.0 36969.6 37535.2 37609.0 35974.8 36065.0 36420.3 36635.1 36807.1 31931.8 32349.0 32637.8 32786.8 32795.0 24314.5 25208.6 25328.2 25548.7 25554.5 17:40:18 INFO - PROCESS | 18957 | 17:40:18 INFO - PROCESS | 18957 | [#2] jquery.html Cycles:180 Average:26116.33 Median:199638.94 stddev:68171.65 (34.1%) stddev-sans-first:68335.49 17:40:18 INFO - PROCESS | 18957 | Values: 376.5 391.2 394.1 401.9 409.2 15336.5 16592.8 17208.9 17314.0 17358.4 16049.6 16974.0 17108.9 17143.6 17193.7 5087.6 5325.7 5329.5 5332.4 5354.7 3652.3 3942.1 5480.5 6077.3 6180.8 5932.8 6018.2 6053.1 6096.7 6113.2 5938.3 5948.4 6099.4 6116.1 6123.7 3371.3 5024.8 5391.8 5393.7 5398.6 19703.2 19848.3 20509.6 20523.8 20606.1 2022.3 2038.1 2286.7 2329.0 2548.2 11884.4 12286.7 13447.4 13547.1 13653.5 1777.7 1837.2 1867.6 1884.0 1906.0 72300.6 74900.0 76283.6 81618.6 83147.6 15814.2 16460.6 17242.8 17290.2 17339.1 29897.4 30268.1 30552.2 30590.2 30618.0 8826.3 8958.4 9013.7 9106.9 9473.9 7206.6 7233.1 7287.5 7310.3 7433.2 8740.6 8835.0 8835.5 8905.5 8915.9 3285.5 3508.8 3526.3 3551.7 3609.6 820.0 821.4 876.1 906.7 971.3 16177.8 16496.6 16948.9 17053.6 17070.1 856.4 873.9 902.0 910.1 939.3 7762.5 9241.4 9507.3 9617.4 9681.1 398876.0 405781.0 408482.0 427184.0 427474.0 75485.6 79019.2 79163.0 79416.6 80538.6 957.2 970.9 996.3 996.8 1019.6 15080.6 15099.5 15192.5 15273.4 15458.3 33109.0 34020.0 34548.5 34700.8 34857.3 45808.3 48344.3 48362.8 48583.8 48622.5 7853.7 7878.6 8009.0 8069.8 8093.2 11149.7 11569.1 11684.0 11772.7 12227.6 10221.7 10321.0 10373.6 10398.7 10517.8 9724.4 10409.0 10513.4 10560.2 10826.1 10351.4 10640.3 10708.8 10919.0 10921.2 7676.3 7834.6 7881.2 7985.2 8196.0 9372.4 10663.5 10693.6 10802.9 10832.7 17:40:18 INFO - PROCESS | 18957 | 17:40:18 INFO - PROCESS | 18957 | [#3] mootools.html Cycles:180 Average:5003.58 Median:5045.55 stddev:2824.63 (56.0%) stddev-sans-first:2818.81 17:40:18 INFO - PROCESS | 18957 | Values: 1296.2 1440.8 1479.3 1634.8 1809.9 7308.3 7658.7 7668.5 7837.5 7861.9 7617.6 7732.9 7797.6 7804.8 7805.2 2168.5 2191.4 2191.9 2193.0 2199.0 2161.6 2176.2 2180.6 2185.5 2196.5 2139.2 2178.5 2181.0 2194.5 2224.6 2014.7 2071.0 2087.8 2104.1 2107.1 2054.8 2102.3 2106.5 2108.4 2109.3 7388.2 7641.8 7708.7 7782.1 7793.4 4386.8 4488.2 4502.5 4514.5 4524.0 2813.2 2843.7 2849.7 2871.6 2924.0 889.7 894.0 899.4 924.6 930.9 10370.7 10454.4 10503.2 10514.3 10516.6 3820.1 3859.7 3923.6 3942.9 4017.3 8170.9 8246.7 8307.0 8313.4 8318.3 4442.7 4451.3 4451.5 4456.0 4461.0 3588.8 3906.3 4024.8 4049.7 4171.9 3306.1 3313.1 3333.8 3357.3 3405.4 943.3 992.4 997.0 1000.2 1018.0 752.2 856.7 862.3 869.1 882.4 4810.4 4969.8 4991.0 5100.1 5152.8 398.4 398.6 414.0 417.2 417.4 3496.9 3600.5 3678.8 3685.8 3702.5 9143.9 9347.3 9376.0 9406.3 9445.9 9167.9 9335.9 9344.3 9362.4 9381.1 7157.1 7170.9 7282.3 7290.9 7305.5 4974.0 5131.5 5153.6 5162.4 5286.0 8527.4 8573.7 8688.7 8691.4 8854.0 8283.1 8855.4 8913.0 8927.1 9030.2 5666.7 6366.8 6412.8 6470.8 6520.7 7207.8 7305.7 7414.7 7455.4 7482.6 6475.3 6903.3 6947.0 6957.5 7019.8 6759.0 6780.1 6790.2 6797.8 6908.4 6261.8 6324.0 6377.1 6399.5 6410.5 4452.0 4519.1 4526.3 4541.6 4581.8 4420.8 4496.8 4544.0 4588.7 4629.7 17:40:18 INFO - PROCESS | 18957 | 17:40:18 INFO - PROCESS | 18957 | [#4] prototype.html Cycles:180 Average:4040.17 Median:4593.99 stddev:1156.19 (25.2%) stddev-sans-first:1125.06 17:40:18 INFO - PROCESS | 18957 | Values: 312.1 315.2 319.1 322.9 323.8 4712.5 4717.6 4741.8 4743.3 4757.2 4626.6 4664.3 4678.2 4682.6 4686.5 3542.5 3621.4 3718.7 3732.2 3757.5 3716.5 3719.3 3733.5 3755.7 3772.4 3471.4 3708.6 3720.6 3735.3 3735.4 3554.4 3688.8 3698.2 3703.6 3718.3 3296.7 3301.0 3303.9 3304.1 3312.5 4449.9 4468.9 4479.3 4505.6 4519.9 3878.5 4117.6 4121.2 4228.2 4253.9 4831.7 4834.5 4837.3 4843.5 4862.2 3464.8 3486.7 3490.7 3490.9 3501.9 4836.0 5067.9 5075.5 5114.9 5141.7 3516.2 3540.3 3551.5 3567.3 3579.6 3609.4 3624.5 3625.2 3628.0 3630.8 4089.0 4093.3 4093.9 4104.1 4117.0 4735.6 4838.6 4862.4 4865.0 4875.6 1225.1 1236.2 1249.7 1250.9 1252.3 784.3 805.2 848.4 868.0 872.6 4240.2 4267.6 4276.9 4287.2 4295.7 4850.5 4914.2 4958.2 4978.1 4983.7 4058.2 4202.6 4236.9 4242.9 4256.3 2632.5 2635.5 2638.0 2645.6 2664.9 4644.5 4655.6 4657.7 4662.0 4670.5 4832.8 5052.9 5058.9 5102.4 5119.7 4556.8 4587.6 4590.7 4631.8 4636.7 4883.2 4906.3 4917.6 4927.6 4951.6 4744.2 4786.7 4786.7 4822.8 4858.7 4547.5 4550.2 4591.5 4596.5 4619.5 3523.2 3544.6 3547.4 3553.4 3559.5 4833.9 4928.4 4960.5 4972.6 4977.0 4620.8 4871.7 4887.9 4923.9 4952.7 4895.9 4910.4 4911.0 4920.6 4934.7 4853.7 4859.7 4864.5 4866.6 4888.6 4730.1 4945.9 4952.5 4957.9 4965.1 4803.0 4819.6 4829.9 4838.2 4838.6 17:40:18 INFO - PROCESS | 18957 | 17:40:18 INFO - PROCESS | 18957 | [#5] yui.html Cycles:180 Average:12341.66 Median:519.29 stddev:14107.97 (2716.8%) stddev-sans-first:14120.39 17:40:18 INFO - PROCESS | 18957 | Values: 685.5 700.3 716.0 749.3 755.7 12493.4 12520.9 12539.5 12797.3 13120.7 12402.8 12777.2 12794.7 12804.4 12877.0 685.4 830.6 839.2 868.0 873.5 861.5 865.8 865.9 868.4 871.4 911.0 911.8 913.1 913.7 921.2 713.1 875.3 901.6 907.1 910.6 664.8 665.5 667.0 669.4 670.2 12677.7 12694.3 12704.6 12711.2 12812.7 12022.9 12447.8 12467.3 12493.8 12620.8 10927.3 11065.2 11205.5 11259.5 11393.3 4102.5 4145.8 4183.6 4297.9 4312.8 41899.0 42315.8 42652.8 43808.3 43907.8 9900.6 9980.5 10007.1 10092.4 10123.2 17441.1 17446.1 17510.8 17562.4 17676.4 6356.7 6438.0 6708.0 6750.0 6798.4 3668.8 3716.6 3744.9 3772.2 3823.7 2690.4 2788.4 2799.1 2817.2 2832.7 493.8 508.7 512.4 519.3 520.8 515.9 568.2 568.3 583.5 599.6 6583.9 6977.8 7027.5 7032.0 7090.6 519.3 547.9 592.8 598.9 600.3 3338.2 3340.2 3352.7 3364.7 3408.0 48617.8 50844.5 51268.7 51925.0 52251.7 45061.0 45326.0 45513.5 47060.5 47174.5 43031.8 43047.6 43137.6 43550.3 43588.9 6791.2 6885.9 6891.6 6994.7 7079.6 27579.0 28189.6 28443.7 29290.3 29412.9 35479.3 37190.0 37569.8 37616.1 37874.6 9461.3 9588.6 9804.7 9909.3 9991.7 10181.4 10214.4 10351.3 10366.0 10670.0 9225.8 9378.6 9564.1 9741.7 9773.2 9407.2 9585.1 9621.4 9661.3 9891.3 9323.7 9372.7 9553.8 9572.4 9728.1 7948.0 8006.6 8258.9 8303.7 8607.0 7814.8 7920.8 7984.7 8067.8 8239.5 17:40:18 INFO - PROCESS | 18957 | -------- Summary: end -------- 17:40:18 INFO - PROCESS | 18957 | 17:40:18 INFO - TEST-INFO | 18957: exit 0 17:40:18 INFO - TEST-OK | dromaeo_css | took 1116044ms 17:40:18 INFO - TEST-START | kraken 17:40:18 INFO - operating with platform_type : linux_ 17:40:18 INFO - Initialising browser for kraken test... 17:40:18 INFO - TEST-INFO | started process 19132 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp95hnS7/profile http://localhost:53318/getInfo.html) 17:40:22 INFO - PROCESS | 19132 | __metrics Screen width/height:1600/1200 17:40:22 INFO - PROCESS | 19132 | colorDepth:24 17:40:22 INFO - PROCESS | 19132 | Browser inner width/height: 1024/697 17:40:22 INFO - PROCESS | 19132 | __metrics 17:40:23 ERROR - PROCESS | 19132 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:40:24 INFO - TEST-INFO | 19132: exit 0 17:40:24 INFO - Browser initialized. 17:40:24 INFO - Running cycle 1/1 for kraken test... 17:40:24 INFO - TEST-INFO | started process 19210 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp95hnS7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:40:35 INFO - PROCESS | 19210 | RSS: Main: 153669632 17:40:35 INFO - PROCESS | 19210 | 17:40:38 INFO - PROCESS | 19210 | Cycle 1(1): loaded http://localhost:53318/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53318/tests/kraken/driver.html?testName=audio-beat-detection) 17:40:39 INFO - PROCESS | 19210 | RSS: Main: 209371136 17:40:39 INFO - PROCESS | 19210 | 17:40:42 INFO - PROCESS | 19210 | Cycle 1(1): loaded http://localhost:53318/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53318/tests/kraken/driver.html?testName=audio-dft) 17:40:42 INFO - PROCESS | 19210 | RSS: Main: 196431872 17:40:42 INFO - PROCESS | 19210 | 17:40:46 INFO - PROCESS | 19210 | Cycle 1(1): loaded http://localhost:53318/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53318/tests/kraken/driver.html?testName=audio-fft) 17:40:46 INFO - PROCESS | 19210 | RSS: Main: 266358784 17:40:46 INFO - PROCESS | 19210 | 17:40:48 INFO - PROCESS | 19210 | Cycle 1(1): loaded http://localhost:53318/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53318/tests/kraken/driver.html?testName=audio-oscillator) 17:40:49 INFO - PROCESS | 19210 | RSS: Main: 175206400 17:40:49 INFO - PROCESS | 19210 | 17:40:51 INFO - PROCESS | 19210 | Cycle 1(1): loaded http://localhost:53318/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53318/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:40:52 INFO - PROCESS | 19210 | RSS: Main: 179372032 17:40:52 INFO - PROCESS | 19210 | 17:40:55 INFO - PROCESS | 19210 | Cycle 1(1): loaded http://localhost:53318/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53318/tests/kraken/driver.html?testName=imaging-darkroom) 17:40:56 INFO - PROCESS | 19210 | RSS: Main: 215449600 17:40:56 INFO - PROCESS | 19210 | 17:41:00 INFO - PROCESS | 19210 | Cycle 1(1): loaded http://localhost:53318/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53318/tests/kraken/driver.html?testName=imaging-desaturate) 17:41:00 INFO - PROCESS | 19210 | RSS: Main: 214216704 17:41:00 INFO - PROCESS | 19210 | 17:41:03 INFO - PROCESS | 19210 | Cycle 1(1): loaded http://localhost:53318/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53318/tests/kraken/driver.html?testName=json-parse-financial) 17:41:04 INFO - PROCESS | 19210 | RSS: Main: 214401024 17:41:04 INFO - PROCESS | 19210 | 17:41:06 INFO - PROCESS | 19210 | Cycle 1(1): loaded http://localhost:53318/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53318/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:41:06 INFO - PROCESS | 19210 | RSS: Main: 208265216 17:41:06 INFO - PROCESS | 19210 | 17:41:08 INFO - PROCESS | 19210 | Cycle 1(1): loaded http://localhost:53318/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53318/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:41:09 INFO - PROCESS | 19210 | RSS: Main: 210518016 17:41:09 INFO - PROCESS | 19210 | 17:41:11 INFO - PROCESS | 19210 | Cycle 1(1): loaded http://localhost:53318/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53318/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:41:12 INFO - PROCESS | 19210 | RSS: Main: 214970368 17:41:12 INFO - PROCESS | 19210 | 17:41:15 INFO - PROCESS | 19210 | Cycle 1(1): loaded http://localhost:53318/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53318/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:41:15 INFO - PROCESS | 19210 | RSS: Main: 219643904 17:41:15 INFO - PROCESS | 19210 | 17:41:18 INFO - PROCESS | 19210 | Cycle 1(1): loaded http://localhost:53318/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53318/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:41:19 INFO - PROCESS | 19210 | RSS: Main: 218877952 17:41:19 INFO - PROCESS | 19210 | 17:41:21 INFO - PROCESS | 19210 | Cycle 1(1): loaded http://localhost:53318/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53318/tests/kraken/driver.html?testName=ai-astar) 17:41:21 INFO - PROCESS | 19210 | RSS: Main: 265113600 17:41:21 INFO - PROCESS | 19210 | 17:41:21 INFO - PROCESS | 19210 | __start_tp_report 17:41:21 INFO - PROCESS | 19210 | _x_x_mozilla_page_load 17:41:21 INFO - PROCESS | 19210 | _x_x_mozilla_page_load_details 17:41:21 INFO - PROCESS | 19210 | |i|pagename|runs| 17:41:21 INFO - PROCESS | 19210 | |0;ai-astar;117;113;118;118;118;116;117;115;116;116 17:41:21 INFO - PROCESS | 19210 | |1;audio-beat-detection;161;141;157;223;138;168;159;139;188;136 17:41:21 INFO - PROCESS | 19210 | |2;audio-dft;164;163;163;163;164;164;162;164;163;163 17:41:21 INFO - PROCESS | 19210 | |3;audio-fft;77;78;77;155;78;79;79;77;127;76 17:41:21 INFO - PROCESS | 19210 | |4;audio-oscillator;94;95;146;94;95;95;122;97;95;121 17:41:21 INFO - PROCESS | 19210 | |5;imaging-gaussian-blur;118;118;118;118;119;118;119;119;119;118 17:41:21 INFO - PROCESS | 19210 | |6;imaging-darkroom;150;150;156;149;150;150;149;147;149;149 17:41:21 INFO - PROCESS | 19210 | |7;imaging-desaturate;96;96;96;97;96;95;96;95;95;97 17:41:21 INFO - PROCESS | 19210 | |8;json-parse-financial;67;68;70;68;67;69;67;68;67;68 17:41:21 INFO - PROCESS | 19210 | |9;json-stringify-tinderbox;65;65;64;65;65;66;64;64;65;65 17:41:21 INFO - PROCESS | 19210 | |10;stanford-crypto-aes;91;87;87;87;87;89;87;87;167;86 17:41:21 INFO - PROCESS | 19210 | |11;stanford-crypto-ccm;141;142;152;141;137;144;137;141;173;155 17:41:21 INFO - PROCESS | 19210 | |12;stanford-crypto-pbkdf2;181;187;183;183;191;179;182;178;179;177 17:41:21 INFO - PROCESS | 19210 | |13;stanford-crypto-sha256-iterative;70;71;71;69;70;70;70;70;69;70 17:41:21 INFO - PROCESS | 19210 | __end_tp_report 17:41:21 INFO - PROCESS | 19210 | __start_cc_report 17:41:21 INFO - PROCESS | 19210 | _x_x_mozilla_cycle_collect,1939 17:41:21 INFO - PROCESS | 19210 | __end_cc_report 17:41:21 INFO - PROCESS | 19210 | __startTimestamp1463100081422__endTimestamp 17:41:21 INFO - PROCESS | 19210 | 17:41:21 INFO - PROCESS | 19210 | ------- Summary: start ------- 17:41:21 INFO - PROCESS | 19210 | Number of tests: 14 17:41:21 INFO - PROCESS | 19210 | 17:41:21 INFO - PROCESS | 19210 | [#0] ai-astar Cycles:10 Average:116.40 Median:117.00 stddev:1.58 (1.3%) stddev-sans-first:1.66 17:41:21 INFO - PROCESS | 19210 | Values: 117.0 113.0 118.0 118.0 118.0 116.0 117.0 115.0 116.0 116.0 17:41:21 INFO - PROCESS | 19210 | 17:41:21 INFO - PROCESS | 19210 | [#1] audio-beat-detection Cycles:10 Average:161.00 Median:160.00 stddev:27.24 (17.0%) stddev-sans-first:28.90 17:41:21 INFO - PROCESS | 19210 | Values: 161.0 141.0 157.0 223.0 138.0 168.0 159.0 139.0 188.0 136.0 17:41:21 INFO - PROCESS | 19210 | 17:41:21 INFO - PROCESS | 19210 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.50 stddev:0.67 (0.4%) stddev-sans-first:0.67 17:41:21 INFO - PROCESS | 19210 | Values: 164.0 163.0 163.0 163.0 164.0 164.0 162.0 164.0 163.0 163.0 17:41:21 INFO - PROCESS | 19210 | 17:41:21 INFO - PROCESS | 19210 | [#3] audio-fft Cycles:10 Average:90.30 Median:77.50 stddev:27.54 (35.5%) stddev-sans-first:28.79 17:41:21 INFO - PROCESS | 19210 | Values: 77.0 78.0 77.0 155.0 78.0 79.0 79.0 77.0 127.0 76.0 17:41:21 INFO - PROCESS | 19210 | 17:41:21 INFO - PROCESS | 19210 | [#4] audio-oscillator Cycles:10 Average:105.40 Median:95.00 stddev:18.04 (19.0%) stddev-sans-first:18.66 17:41:21 INFO - PROCESS | 19210 | Values: 94.0 95.0 146.0 94.0 95.0 95.0 122.0 97.0 95.0 121.0 17:41:21 INFO - PROCESS | 19210 | 17:41:21 INFO - PROCESS | 19210 | [#5] imaging-gaussian-blur Cycles:10 Average:118.40 Median:118.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 17:41:21 INFO - PROCESS | 19210 | Values: 118.0 118.0 118.0 118.0 119.0 118.0 119.0 119.0 119.0 118.0 17:41:21 INFO - PROCESS | 19210 | 17:41:21 INFO - PROCESS | 19210 | [#6] imaging-darkroom Cycles:10 Average:149.90 Median:150.00 stddev:2.33 (1.6%) stddev-sans-first:2.47 17:41:21 INFO - PROCESS | 19210 | Values: 150.0 150.0 156.0 149.0 150.0 150.0 149.0 147.0 149.0 149.0 17:41:21 INFO - PROCESS | 19210 | 17:41:21 INFO - PROCESS | 19210 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 17:41:21 INFO - PROCESS | 19210 | Values: 96.0 96.0 96.0 97.0 96.0 95.0 96.0 95.0 95.0 97.0 17:41:21 INFO - PROCESS | 19210 | 17:41:21 INFO - PROCESS | 19210 | [#8] json-parse-financial Cycles:10 Average:67.90 Median:68.00 stddev:0.99 (1.5%) stddev-sans-first:1.00 17:41:21 INFO - PROCESS | 19210 | Values: 67.0 68.0 70.0 68.0 67.0 69.0 67.0 68.0 67.0 68.0 17:41:21 INFO - PROCESS | 19210 | 17:41:21 INFO - PROCESS | 19210 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 17:41:21 INFO - PROCESS | 19210 | Values: 65.0 65.0 64.0 65.0 65.0 66.0 64.0 64.0 65.0 65.0 17:41:21 INFO - PROCESS | 19210 | 17:41:21 INFO - PROCESS | 19210 | [#10] stanford-crypto-aes Cycles:10 Average:95.50 Median:87.00 stddev:25.16 (28.9%) stddev-sans-first:26.64 17:41:21 INFO - PROCESS | 19210 | Values: 91.0 87.0 87.0 87.0 87.0 89.0 87.0 87.0 167.0 86.0 17:41:21 INFO - PROCESS | 19210 | 17:41:21 INFO - PROCESS | 19210 | [#11] stanford-crypto-ccm Cycles:10 Average:146.30 Median:143.00 stddev:11.07 (7.7%) stddev-sans-first:11.57 17:41:21 INFO - PROCESS | 19210 | Values: 141.0 142.0 152.0 141.0 137.0 144.0 137.0 141.0 173.0 155.0 17:41:21 INFO - PROCESS | 19210 | 17:41:21 INFO - PROCESS | 19210 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.00 Median:182.50 stddev:4.32 (2.4%) stddev-sans-first:4.57 17:41:21 INFO - PROCESS | 19210 | Values: 181.0 187.0 183.0 183.0 191.0 179.0 182.0 178.0 179.0 177.0 17:41:21 INFO - PROCESS | 19210 | 17:41:21 INFO - PROCESS | 19210 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:70.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 17:41:21 INFO - PROCESS | 19210 | Values: 70.0 71.0 71.0 69.0 70.0 70.0 70.0 70.0 69.0 70.0 17:41:21 INFO - PROCESS | 19210 | -------- Summary: end -------- 17:41:21 INFO - PROCESS | 19210 | 17:41:22 INFO - TEST-INFO | 19210: exit 0 17:41:22 INFO - TEST-OK | kraken | took 63465ms 17:41:22 INFO - SUITE-END | took 1179s 17:41:22 INFO - Completed test suite (00:19:39) 17:41:22 INFO - javascript benchmark 17:41:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2568.4606232691135, 2587.676540432446, 2605.7003444603865, 2605.947881042378, 2611.647427597275, 4541.409616749818, 4572.519885412034, 4693.202155633542, 4744.169770290203, 4755.90488190236, 4623.8150473981, 4659.044895796362, 4678.5087565805525, 4785.97101623151, 4801.96757697095, 4247.06564555798, 4284.6786491013145, 4314.0, 4337.631301339374, 4529.184746745585, 4417.514073451917, 4440.045390241097, 4458.71018383804, 4471.485779135409, 4484.573965473275, 4170.249355116078, 4220.767857767822, 4287.206866729665, 4308.310670292738, 4341.3053911374345, 4362.171187474401, 4392.736435813861, 4392.868213953587, 4421.60205581496, 4463.754493502856, 4372.89067773305, 4382.824687012516, 4389.670774691879, 4420.513743488214, 4445.088756804847, 4426.0, 4426.955730442719, 4533.546645335473, 4682.81268749253, 4748.715077095385, 4991.700497970133, 5016.04695107932, 5036.974815125901, 5040.495950404967, 5068.4424713281505, 5000.499950005007, 5050.646454748169, 5091.847244582668, 5099.031184075014, 5134.127198376285, 4541.954580454186, 4615.0, 4666.510016448292, 4667.743274119956, 4668.0, 5108.2082277246345, 5109.463506331856, 5126.769295381717, 5139.023585518739, 5177.508136727005, 4971.751412429364, 4993.775280112403, 4995.275685025651, 4998.0, 5006.424261209934, 4847.151748444008, 4998.525140111684, 5010.123228435009, 5025.447200807908, 5065.417476990119, 4951.356323677899, 4956.90086198274, 4965.726885021359, 4993.375828021497, 5021.974890125526, 4806.759662016885, 4939.728314942713, 4948.233023881232, 5003.54968052877, 5005.874853128628, 4220.53574106848, 4232.153569286155, 4241.597048280409, 4244.257254980366, 4258.999135203225, 3710.8330125143893, 3729.4219395993664, 3733.290674771785, 3735.738498305147, 3773.471713959993, 4295.570442955679, 4301.2257793597455, 4321.611055005064, 4331.350297455407, 4351.12977404514, 4787.042591481718, 5014.423341315723, 5029.84910452687, 5076.44159142494, 5082.517160869711, 4314.7626880521875, 4322.459692538433, 4335.913281734348, 4365.716228445141, 4384.6273066789045, 4444.688871779009, 4537.773111344485, 4543.295789152687, 4556.521565235669, 4607.378003969421, 4504.324351347259, 4653.627709783209, 4694.859154225379, 4702.694324868872, 4715.622750180046, 5014.749262536931, 5055.241713742968, 5060.84817455477, 5062.519060689376, 5075.390953085654, 4538.500764915791, 4682.344471773887, 4698.224792909268, 4715.056988602362, 4750.07373562152, 4946.282788995503, 4982.551570358685, 4999.300097986212, 5021.623378246719, 5042.621803364836, 5065.544101030778, 5102.642815002914, 5119.769610367468, 5141.0, 5190.429052804113, 4754.738489383117, 4808.08646357191, 4968.329275547755, 4997.800087996439, 5000.524950129732, 4815.686980346266, 4875.439324477588, 4910.705357678551, 4918.877028074184, 4955.975220123876, 4800.5199480051715, 4838.395200599925, 4845.394325709286, 4852.078105160008, 4881.658283920092, 4791.904161916812, 4864.343313652612, 4901.656884018084, 4951.232558953224, 4955.900881982412, 4757.3577567028005, 4758.452777930583, 4809.158397280392, 4830.565249127595, 4859.829905953275], "value": 4611.037341266578, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.2600628161405, 576.2595065341035, 584.8917950179219, 589.1545632018054, 590.9674967876766, 27987.0, 41490.0, 42540.78729606355, 42981.785091074504, 46056.53943460564, 41530.58469415305, 42072.57927420725, 42087.36868946968, 42166.0, 42245.0, 7724.150343462215, 7804.29761321481, 7830.56931868747, 7832.412569057315, 7839.608019599026, 7755.108162561293, 7858.253465920757, 7867.1739467355965, 7868.763937081897, 7872.252136047066, 7844.333231675315, 7869.331106855924, 7870.331021863149, 7882.369410447151, 7882.80292992674, 7877.566733829637, 7889.132195458495, 7894.3289820365335, 7927.246911543394, 7942.682292708285, 7693.884591731073, 7813.140554538996, 7844.568548729818, 7845.215478452166, 7848.411369147337, 38641.806790965864, 38979.02552436212, 39119.21761564781, 39134.21731565381, 39136.80431597824, 3198.984005079983, 3218.5815843940372, 3369.0903456066726, 3748.5689145748042, 3980.283548961215, 28376.432471350457, 28774.424511509653, 30725.697575362086, 31130.688693113232, 31716.682833171602, 3355.2450698592866, 3535.864264258267, 3537.4163263061564, 3646.252518233756, 3729.8321575528894, 231384.0, 236821.0, 237074.0, 237173.0, 239406.0, 35033.82483087568, 51881.2217816733, 53117.7344113277, 53234.46765532372, 53275.467245327825, 34083.762042605915, 36186.63813361886, 36255.4561681575, 36388.636113638524, 36399.27201456009, 14210.928945355206, 14302.928485357506, 14356.784648230285, 14416.207108608918, 14456.783148252785, 11587.59443419493, 11823.290602563873, 11845.88154118465, 11889.405529723479, 11951.940240298916, 8496.192861678132, 8526.062133165347, 8554.14458554152, 8558.572071396406, 8609.61256743448, 3357.0600231935096, 3369.2082360645227, 3371.8482668279985, 3380.9323813523592, 3411.454167333264, 882.6645874567623, 899.8425275576748, 930.7859192385789, 944.2729098594044, 1035.7307100153864, 27521.0, 27640.723592764218, 28267.293317666812, 28286.434271314458, 28635.57046644302, 831.6465502161557, 986.8273052215834, 1073.291627525845, 1088.4612117001977, 1157.9015783658483, 14133.0, 14579.41682332716, 14624.341904614104, 14730.189839558927, 14827.851721482863, 343420.0, 344285.0, 346579.0, 347100.0, 347253.0, 47022.529774702496, 47524.04951900943, 47688.761556191996, 47725.284120737524, 47811.76094119577, 1143.7769634921276, 1221.8167274908835, 1260.4706023470164, 1287.150480682745, 1296.546208826903, 28046.85976570104, 29035.7096429033, 29252.268693282836, 29357.385343806294, 29925.85037074801, 42259.36610950777, 42480.0, 42736.35895461633, 42856.0, 42934.35598466088, 285292.0, 288322.0, 289754.0, 289769.0, 588808.0, 25885.22344329673, 27248.455030898873, 27300.180994570193, 28117.578236326062, 28285.151445456668, 42112.0, 42176.57823421727, 42376.5762342385, 42908.0, 43800.0, 35660.28679426345, 36550.817245914666, 36735.448968266035, 36749.0, 37203.62796372001, 36739.63260367362, 36916.0, 36969.6303036977, 37535.249295014495, 37609.0, 35974.820125899205, 36065.0, 36420.27159456743, 36635.08412289714, 36807.07982300464, 31931.840340798146, 32349.029529114163, 32637.836810815796, 32786.83606582047, 32795.0, 24314.513709725354, 25208.621870671588, 25328.240152795446, 25548.744512554636, 25554.488910222062], "value": 16853.549202756993, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.52745804015956, 391.17071807767536, 394.111279065707, 401.8794361691495, 409.16121950002486, 15336.53990380289, 16592.751108733377, 17208.91395543024, 17313.961162330237, 17358.392456264035, 16049.598760031005, 16974.0, 17108.914455427705, 17143.571410714707, 17193.71047171464, 5087.56755675768, 5325.733713314319, 5329.493698098694, 5332.3601167859715, 5354.705491197982, 3652.2878038782446, 3942.073612701013, 5480.506754392104, 6077.301110372297, 6180.752769889199, 5932.792352267671, 6018.187544681477, 6053.122297266894, 6096.664683442409, 6113.23584551931, 5938.346781854014, 5948.434898684618, 6099.420555047263, 6116.052011938156, 6123.693815309217, 3371.258323168899, 5024.773885175176, 5391.81128660495, 5393.7303134843105, 5398.595105367113, 19703.211871525124, 19848.305309314248, 20509.589808203753, 20523.794762052337, 20606.072726727332, 2022.3023057045443, 2038.0828627117708, 2286.737025242102, 2328.951971612781, 2548.1845809341016, 11884.40577971098, 12286.692832679255, 13447.394867230998, 13547.051706380556, 13653.522126725517, 1777.7155655095123, 1837.2099997001285, 1867.6264747050643, 1884.0, 1905.9618807623908, 72300.63849680718, 74900.0, 76283.61858190673, 81618.59190704068, 83147.5842620789, 15814.181369142465, 16460.588485287964, 17242.827571724374, 17290.221940012478, 17339.133043348036, 29897.412310522875, 30268.09195724132, 30552.236194095327, 30590.235244119074, 30618.0, 8826.338024648177, 8958.417702849294, 9013.684521041732, 9106.86339704905, 9473.905260947302, 7206.639668016578, 7233.132024157135, 7287.453440991947, 7310.268973102648, 7433.219511951167, 8740.606672699743, 8835.0, 8835.469871807712, 8905.465672059698, 8915.910840891638, 3285.5235990781202, 3508.7894726316504, 3526.2771131917893, 3551.714663935849, 3609.6209897960334, 820.0, 821.3716506872247, 876.0932434929817, 906.6781292641149, 971.2763990826879, 16177.838221617869, 16496.587585310463, 16948.915255423643, 17053.57366065858, 17070.146492675318, 856.3620103023287, 873.8995015573163, 901.9909800901906, 910.0762725833284, 939.2673714502699, 7762.456628036096, 9241.399309045026, 9507.334486585873, 9617.422954622745, 9681.128698417177, 398876.0, 405781.0, 408482.0, 427184.0, 427474.0, 75485.6225718868, 79019.20980790119, 79163.0, 79416.60291698505, 80538.59730701309, 957.2103015012782, 970.9368891022061, 996.3125443444001, 996.7557948302713, 1019.6227395863579, 15080.622984425478, 15099.471518496799, 15192.544223673307, 15273.389064437299, 15458.304376302869, 33109.0, 34020.0, 34548.481772772924, 34700.82649586736, 34857.302853942274, 45808.312875306234, 48344.27483587819, 48362.75818620884, 48583.75708121437, 48622.5137748618, 7853.725119620786, 7878.645460954156, 8008.959955200186, 8069.798255043671, 8093.150219226896, 11149.72125696864, 11569.074474042225, 11684.0, 11772.705682357668, 12227.572034978733, 10221.693349199535, 10321.0, 10373.58505659765, 10398.740031499274, 10517.78964420692, 9724.367916085432, 10409.0, 10513.369197848153, 10560.207984401355, 10826.13390928708, 10351.378917264989, 10640.255182137176, 10708.785824283315, 10919.0, 10921.235513513977, 7676.309132178131, 7834.569098699626, 7881.172476890073, 7985.241402066795, 8195.95902020486, 9372.437653740797, 10663.46682665879, 10693.572257109628, 10802.891971080502, 10832.67501974942], "value": 9154.987335324724, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1296.2481760578864, 1440.7766796146598, 1479.3416929466387, 1634.8201697813238, 1809.9276028958834, 7308.305710957457, 7658.6553605087765, 7668.5398876067475, 7837.451378403514, 7861.921380786191, 7617.6191190440395, 7732.884006739903, 7797.610119494031, 7804.8048798780055, 7805.180456052118, 2168.533765240473, 2191.375457994472, 2191.923282685106, 2192.967105493419, 2198.9780102198933, 2161.6109100361928, 2176.183931025865, 2180.6292930201826, 2185.4536365908525, 2196.516766311409, 2139.1657253671, 2178.4880553070016, 2181.0, 2194.5281764420647, 2224.644056950888, 2014.687723402875, 2071.0, 2087.812096911278, 2104.053176070759, 2107.062357251024, 2054.753429588444, 2102.2852230241792, 2106.4628519727526, 2108.3569511299047, 2109.335559298816, 7388.15036270825, 7641.7707468776025, 7708.691652333956, 7782.143964163937, 7793.415493837985, 4386.780660966939, 4488.236999710057, 4502.5047244803045, 4514.525974772634, 4524.02733412318, 2813.212300555848, 2843.672977607581, 2849.722888329464, 2871.6410448693914, 2924.035068427414, 889.6574818694849, 893.9865902011475, 899.4288626722014, 924.611663101499, 930.8836395450569, 10370.740731481697, 10454.372737635766, 10503.2122590806, 10514.316569422963, 10516.579336826519, 3820.102275965146, 3859.710521710827, 3923.6272554107313, 3942.8817135485406, 4017.276890159799, 8170.918290817134, 8246.670133194724, 8307.0, 8313.376496762767, 8318.292945099613, 4442.6890117691455, 4451.287793952952, 4451.488078870907, 4456.0, 4460.955390446119, 3588.820558972041, 3906.2968665640456, 4024.75851448914, 4049.716519843583, 4171.8957026074595, 3306.057773534531, 3313.122022663996, 3333.833308334622, 3357.3117510910206, 3405.3870303345634, 943.3113826906397, 992.4194346307492, 996.9700908972742, 1000.2248257600272, 1017.9592816287266, 752.1951511882343, 856.6737973235138, 862.3489265604428, 869.0831173112427, 882.3955590420583, 4810.4467986181335, 4969.801207951714, 4991.0, 5100.1074811907765, 5152.793888244503, 398.3864848133899, 398.607371738837, 413.97102202845514, 417.2031419987809, 417.41770230528243, 3496.8950931472095, 3600.4959305697225, 3678.779273243614, 3685.7972811495088, 3702.500162478085, 9143.862842057242, 9347.345685802065, 9376.0, 9406.294527910433, 9445.905540944503, 9167.908320916706, 9335.90664093364, 9344.34589578723, 9362.438253704799, 9381.0618938107, 7157.069580954442, 7170.892436613455, 7282.271772822675, 7290.890636640454, 7305.45209109319, 4973.950260497349, 5131.512506311894, 5153.613478989016, 5162.354705661793, 5285.973570132125, 8527.360447966303, 8573.699920502753, 8688.652453901774, 8691.391602587759, 8854.026057133582, 8283.130271321425, 8855.424397414148, 8913.019567847401, 8927.107289271022, 9030.232430243503, 5666.744996475251, 6366.808995730135, 6412.839679008062, 6470.805875823733, 6520.706568204348, 7207.783766487014, 7305.707771689285, 7414.740484083031, 7455.440841936768, 7482.588457634883, 6475.320091390525, 6903.344182302673, 6947.0, 6957.512974091765, 7019.754308599175, 6759.0, 6780.050792889098, 6790.151231096113, 6797.796066118024, 6908.378245957888, 6261.780837670842, 6323.9683801580695, 6377.1390862233, 6399.520035997226, 6410.45511131559, 4452.0, 4519.050999290186, 4526.275795872644, 4541.568550987651, 4581.793819278074, 4420.77896105187, 4496.775161241991, 4543.977280113579, 4588.678792484494, 4629.652776041743], "value": 3957.027128763646, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.1229345539036, 315.2449882531337, 319.1271871431635, 322.9289556297614, 323.84710430866136, 4712.505186955367, 4717.57541821236, 4741.8103275868925, 4743.335932969387, 4757.238841785315, 4626.606738427237, 4664.277037059262, 4678.228092364756, 4682.601978831794, 4686.531346865312, 3542.5040494330815, 3621.4024685926793, 3718.6758276077453, 3732.2348918471785, 3757.530308711411, 3716.479692843004, 3719.274741425423, 3733.4959780429567, 3755.6619904208615, 3772.3775577029896, 3471.4205036708236, 3708.5735140458924, 3720.6465385788306, 3735.3463143949834, 3735.383661695817, 3554.431290993429, 3688.79711615861, 3698.1679122197424, 3703.6481534254203, 3718.3492888744363, 3296.6703329666843, 3300.950485742716, 3303.900882973515, 3304.1244070321386, 3312.519684645713, 4449.9110017799785, 4468.932966005513, 4479.3057076153245, 4505.571970662814, 4519.864404067883, 3878.45701601776, 4117.649999750025, 4121.175764847043, 4228.217779710732, 4253.851115210984, 4831.710097394132, 4834.468208497063, 4837.274408838667, 4843.539863712942, 4862.246351815475, 3464.7574669773126, 3486.6861982421706, 3490.703290220334, 3490.9003663845806, 3501.8949431517094, 4835.984443266918, 5067.873303167414, 5075.543201111881, 5114.948850511484, 5141.717205553693, 3516.191276006533, 3540.274243780019, 3551.4672799080345, 3567.250877315741, 3579.6241394653184, 3609.4118587821276, 3624.5469316335457, 3625.2024554597947, 3627.981860090683, 3630.8003059831963, 4088.9591104089172, 4093.3450647896193, 4093.9181216375505, 4104.056067104523, 4117.0, 4735.597474214662, 4838.588719958772, 4862.371105679637, 4864.975675121602, 4875.585575226075, 1225.1179151011436, 1236.2211806561809, 1249.6813312605227, 1250.9186902851286, 1252.2861968677767, 784.3098073695112, 805.1787177079347, 848.4145939301862, 867.9783005424915, 872.5506364222431, 4240.194363071007, 4267.615914567704, 4276.935845962313, 4287.206866729665, 4295.656347492193, 4850.466448690641, 4914.213725803854, 4958.181899986534, 4978.103941290602, 4983.732401757192, 4058.2492238935893, 4202.642775364067, 4236.9364459533135, 4242.8727138185905, 4256.34026725858, 2632.4735052989477, 2635.5387807133675, 2637.973620263811, 2645.550256456407, 2664.8934042638466, 4644.489106198315, 4655.580997710223, 4657.67396282257, 4662.020975595163, 4670.509596492319, 4832.806687732522, 5052.9242061369105, 5058.924116138261, 5102.36220472441, 5119.74401279942, 4556.840510582114, 4587.610053145453, 4590.655700822452, 4631.814727410933, 4636.698614590108, 4883.218685010382, 4906.288588154626, 4917.557419832232, 4927.556519913225, 4951.603871690329, 4744.169770290255, 4786.712797232177, 4786.726305005095, 4822.831200907952, 4858.659893807541, 4547.454305483231, 4550.2492088804975, 4591.517890621437, 4596.471405788244, 4619.4687610925175, 3523.1896663766966, 3544.6278140795876, 3547.3614749344333, 3553.4492153716214, 3559.537260156163, 4833.854984350475, 4928.408590969107, 4960.47914968923, 4972.602191824573, 4977.0, 4620.768961551977, 4871.683340582851, 4887.853364399074, 4923.926141107958, 4952.678075925053, 4895.853124406273, 4910.43529994041, 4911.0, 4920.5571498565305, 4934.654574179773, 4853.684510506806, 4859.663592512087, 4864.513548645107, 4866.562009419169, 4888.560029597354, 4730.148573256709, 4945.876353091202, 4952.455229924633, 4957.851264462072, 4965.0566392385335, 4803.0, 4819.638527110411, 4829.879253018703, 4838.225883858566, 4838.612910967185], "value": 3681.0566225777206, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [685.4721864164593, 700.2927043685876, 715.9785206443809, 749.3293502315428, 755.6788364944897, 12493.375331233447, 12520.874791252096, 12539.498420063186, 12797.296148711817, 13120.671983200426, 12402.813957790619, 12777.233365998023, 12794.744105117916, 12804.423800928957, 12877.0, 685.3934268172653, 830.6345208108443, 839.1817977471977, 868.0321441592611, 873.4715497124243, 861.452977359375, 865.7965378136133, 865.8701194820765, 868.4051424774018, 871.4466313890694, 910.9842525583992, 911.7994041310934, 913.1051569461931, 913.7167478081816, 921.2123634292684, 713.0979311171346, 875.3041332140931, 901.5537309032005, 907.120093509295, 910.5840418149775, 664.7939138866967, 665.5441022899281, 667.0094909060042, 669.407574296746, 670.1522573943964, 12677.683057923625, 12694.30181340026, 12704.618861434172, 12711.237325760392, 12812.679683007906, 12022.879771202264, 12447.75104497905, 12467.314297713621, 12493.81308775665, 12620.810687839597, 10927.289726167854, 11065.225434219608, 11205.495752691148, 11259.493322800494, 11393.316401015883, 4102.466679331667, 4145.813438395249, 4183.602557757008, 4297.871063868089, 4312.827486900552, 41899.0, 42315.78842105801, 42652.78673606643, 43808.34287485722, 43907.78046109749, 9900.60397584103, 9980.451075190935, 10007.09936105754, 10092.44491552957, 10123.1901447884, 17441.12794360277, 17446.127693615268, 17510.82489175092, 17562.385316514115, 17676.381326653507, 6356.713947872357, 6438.0, 6707.966460167766, 6750.0, 6798.388145066869, 3668.834902429397, 3716.554013518341, 3744.9438258426144, 3772.1889793694486, 3823.6941044716355, 2690.421559364746, 2788.4004938938224, 2799.1182777425047, 2817.1970988268245, 2832.7167283271506, 493.8370337788521, 508.7074931914164, 512.3697851642501, 519.2678323563757, 520.8463503266546, 515.9458256883048, 568.1704711121808, 568.3407247592772, 583.5098517245534, 599.6072572465042, 6583.934160658332, 6977.79066628002, 7027.508074434741, 7031.964840175767, 7090.574565526085, 519.3093186062604, 547.8657728856456, 592.7540070870626, 598.853280946171, 600.2826622186533, 3338.21551935295, 3340.1816554944194, 3352.7150192233444, 3364.6635336466647, 3408.0, 48617.756911215925, 50844.49155508397, 51268.743656282226, 51925.0, 52251.73874130605, 45061.0, 45326.0, 45513.5383753945, 47060.52939470561, 47174.5282547177, 43031.7848410756, 43047.569524304985, 43137.56862431335, 43550.34674479822, 43588.910277243325, 6791.185057793096, 6885.862282754417, 6891.552049116792, 6994.650267486503, 7079.610621415872, 27579.0, 28189.577156343083, 28443.715562844107, 29290.267743306587, 29412.852935735184, 35479.29041419209, 37190.0, 37569.81215093907, 37616.05031471766, 37874.62125378711, 9461.33770636049, 9588.56851441673, 9804.705858824247, 9909.256805739455, 9991.650292239738, 10181.440020798631, 10214.387136771817, 10351.327163734333, 10366.0, 10670.039696427359, 9225.769355766159, 9378.624855005723, 9564.13922746956, 9741.659041933499, 9773.169280611228, 9407.247420206504, 9585.089416505421, 9621.422714637145, 9661.3237073407, 9891.258155638212, 9323.673671421468, 9372.718818435458, 9553.808923821623, 9572.425654460754, 9728.124468797841, 7947.960260198662, 8006.639701213576, 8258.917410825814, 8303.709370172015, 8606.956965215133, 7814.843703125792, 7920.84158316842, 7984.720534781255, 8067.757967260992, 8239.464434811718], "value": 5789.064291434376, "unit": "score"}], "name": "dromaeo_css", "value": 6256.89049290086, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 113.0, 118.0, 118.0, 118.0, 116.0, 117.0, 115.0, 116.0, 116.0], "value": 116.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 141.0, 157.0, 223.0, 138.0, 168.0, 159.0, 139.0, 188.0, 136.0], "value": 161.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 163.0, 163.0, 164.0, 164.0, 162.0, 164.0, 163.0, 163.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 77.0, 155.0, 78.0, 79.0, 79.0, 77.0, 127.0, 76.0], "value": 90.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 146.0, 94.0, 95.0, 95.0, 122.0, 97.0, 95.0, 121.0], "value": 105.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 119.0, 118.0, 119.0, 119.0, 119.0, 118.0], "value": 118.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 156.0, 149.0, 150.0, 150.0, 149.0, 147.0, 149.0, 149.0], "value": 149.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 97.0, 96.0, 95.0, 96.0, 95.0, 95.0, 97.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 70.0, 68.0, 67.0, 69.0, 67.0, 68.0, 67.0, 68.0], "value": 67.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 65.0, 65.0, 66.0, 64.0, 64.0, 65.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 87.0, 87.0, 87.0, 87.0, 89.0, 87.0, 87.0, 167.0, 86.0], "value": 95.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 142.0, 152.0, 141.0, 137.0, 144.0, 137.0, 141.0, 173.0, 155.0], "value": 146.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 187.0, 183.0, 183.0, 191.0, 179.0, 182.0, 178.0, 179.0, 177.0], "value": 182.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 71.0, 69.0, 70.0, 70.0, 70.0, 70.0, 69.0, 70.0], "value": 70.0, "unit": "score"}], "name": "kraken", "value": 1627.1, "alertThreshold": 2.0}]} 17:41:22 INFO - Return code: 0 17:41:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:41:22 ERROR - # TBPL SUCCESS # 17:41:22 INFO - Running post-action listener: _resource_record_post_action 17:41:22 INFO - ##### 17:41:22 INFO - ##### Finished run-tests step (success) 17:41:22 INFO - ##### 17:41:22 INFO - Running post-run listener: _resource_record_post_run 17:41:23 INFO - Total resource usage - Wall time: 1197s; CPU: 26.0%; Read bytes: 0; Write bytes: 528482304; Read time: 0; Write time: 600916 17:41:23 INFO - TinderboxPrint: CPU usage
25.5% 17:41:23 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 17:41:23 INFO - TinderboxPrint: I/O write bytes / time
528,482,304 / 600,916 17:41:23 INFO - TinderboxPrint: CPU idle
7,113.6 (74.4%) 17:41:23 INFO - TinderboxPrint: CPU user
2,406.3 (25.2%) 17:41:23 INFO - TinderboxPrint: Swap in / out
0 / 0 17:41:23 INFO - install - Wall time: 16s; CPU: 27.0%; Read bytes: 0; Write bytes: 243425280; Read time: 0; Write time: 367132 17:41:23 INFO - run-tests - Wall time: 1181s; CPU: 26.0%; Read bytes: 0; Write bytes: 285057024; Read time: 0; Write time: 233784 17:41:23 INFO - Running post-run listener: _upload_blobber_files 17:41:23 INFO - Blob upload gear active. 17:41:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:41:23 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 17:41:23 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:41:23 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:41:24 INFO - (blobuploader) - INFO - Open directory for files ... 17:41:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:41:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:41:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:41:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:41:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:41:24 INFO - (blobuploader) - INFO - Done attempting. 17:41:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:41:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:41:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:41:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:41:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:41:25 INFO - (blobuploader) - INFO - Done attempting. 17:41:25 INFO - (blobuploader) - INFO - Iteration through files over. 17:41:25 INFO - Return code: 0 17:41:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:41:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:41:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c1c0425cca7a70710e1e835e5c2c3479723f758e382cccce4472b2fba80324c8b5dfc533fcd51c1d942add78f2bff448419f10fb1cad8949392578de97e13c10", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3c308af3879a40f2297b6252b986b124f781e256e9ae0669dff607702d619d44c215b26adbdbc76304a98de3905471981b0d73721282e083d056fc6ccce6fa4b"} 17:41:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:41:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:41:25 INFO - Contents: 17:41:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c1c0425cca7a70710e1e835e5c2c3479723f758e382cccce4472b2fba80324c8b5dfc533fcd51c1d942add78f2bff448419f10fb1cad8949392578de97e13c10", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3c308af3879a40f2297b6252b986b124f781e256e9ae0669dff607702d619d44c215b26adbdbc76304a98de3905471981b0d73721282e083d056fc6ccce6fa4b"} 17:41:25 INFO - Running post-run listener: copy_logs_to_upload_dir 17:41:25 INFO - Copying logs to upload dir... 17:41:25 INFO - mkdir: /builds/slave/test/build/upload/logs 17:41:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.552038 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-05-12 17:41:25.109434) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-12 17:41:25.113309) ========= 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=826874ccc97bd7bf541b4875000001d5-1463098851.134378-859456878 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-Non-PGO/sha512/c1c0425cca7a70710e1e835e5c2c3479723f758e382cccce4472b2fba80324c8b5dfc533fcd51c1d942add78f2bff448419f10fb1cad8949392578de97e13c10", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3c308af3879a40f2297b6252b986b124f781e256e9ae0669dff607702d619d44c215b26adbdbc76304a98de3905471981b0d73721282e083d056fc6ccce6fa4b"} build_url:https://queue.taskcluster.net/v1/task/O6ir-GOHSXGcqtGBa_xKIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.005267 build_url: 'https://queue.taskcluster.net/v1/task/O6ir-GOHSXGcqtGBa_xKIg/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-Non-PGO/sha512/c1c0425cca7a70710e1e835e5c2c3479723f758e382cccce4472b2fba80324c8b5dfc533fcd51c1d942add78f2bff448419f10fb1cad8949392578de97e13c10", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3c308af3879a40f2297b6252b986b124f781e256e9ae0669dff607702d619d44c215b26adbdbc76304a98de3905471981b0d73721282e083d056fc6ccce6fa4b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-12 17:41:25.133431) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 17:41:25.133997) ========= 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=826874ccc97bd7bf541b4875000001d5-1463098851.134378-859456878 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.002097 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 17:41:25.216136) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-12 17:41:25.216659) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-12 17:41:25.217158) ========= ========= Total master_lag: 0.16 =========