builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-057 starttime: 1472737945.93 results: success (0) buildid: 20160830093921 builduid: 86ba142624df48b3b49a4204efa8ff7c revision: c819e284a13937fc955c2efb6da7fdf9c5bb8b88 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 06:52:25.933372) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 06:52:25.933724) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 06:52:25.933990) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 06:52:26.120357) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 06:52:26.120604) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1472737324.396277-1139027901 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-01 06:52:26-- 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% 213M=0s 2016-09-01 06:52:26 (213 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116430 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 06:52:26.299602) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 06:52:26.302919) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1472737324.396277-1139027901 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016560 ========= master_lag: 0.11 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 06:52:26.433537) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 06:52:26.436878) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c819e284a13937fc955c2efb6da7fdf9c5bb8b88 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c819e284a13937fc955c2efb6da7fdf9c5bb8b88 --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=934fc3100db09dcb9af4d4b6000001ab-1472737324.396277-1139027901 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-01 06:52:26,799 truncating revision to first 12 chars 2016-09-01 06:52:26,799 Setting DEBUG logging. 2016-09-01 06:52:26,799 attempt 1/10 2016-09-01 06:52:26,799 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c819e284a139?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-01 06:52:27,204 unpacking tar archive at: mozilla-aurora-c819e284a139/testing/mozharness/ program finished with exit code 0 elapsedTime=0.724333 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 06:52:27.190758) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 06:52:27.191022) ========= script_repo_revision: c819e284a13937fc955c2efb6da7fdf9c5bb8b88 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 06:52:27.191379) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 06:52:27.191652) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 06:52:27.205463) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 5 secs) (at 2016-09-01 06:52:27.205732) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=934fc3100db09dcb9af4d4b6000001ab-1472737324.396277-1139027901 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:52:27 INFO - MultiFileLogger online at 20160901 06:52:27 in /builds/slave/test 06:52:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 06:52:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:52:27 INFO - {'append_to_log': False, 06:52:27 INFO - 'base_work_dir': '/builds/slave/test', 06:52:27 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:52:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:52:27 INFO - 'branch': 'Mozilla-Aurora', 06:52:27 INFO - 'buildbot_json_path': 'buildprops.json', 06:52:27 INFO - 'config_files': ('talos/linux_config.py',), 06:52:27 INFO - 'default_actions': ('clobber', 06:52:27 INFO - 'read-buildbot-config', 06:52:27 INFO - 'download-and-extract', 06:52:27 INFO - 'populate-webroot', 06:52:27 INFO - 'create-virtualenv', 06:52:27 INFO - 'install', 06:52:27 INFO - 'run-tests'), 06:52:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:52:27 INFO - 'download_minidump_stackwalk': True, 06:52:27 INFO - 'download_symbols': 'ondemand', 06:52:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:52:27 INFO - 'tooltool.py': '/tools/tooltool.py', 06:52:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:52:27 INFO - '/tools/misc-python/virtualenv.py')}, 06:52:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:52:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:52:27 INFO - 'installer_path': 'installer.exe', 06:52:27 INFO - 'log_level': 'info', 06:52:27 INFO - 'log_name': 'talos', 06:52:27 INFO - 'log_to_console': True, 06:52:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:52:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:52:27 INFO - 'opt_config_files': (), 06:52:27 INFO - 'pip_index': False, 06:52:27 INFO - 'sps_profile': False, 06:52:27 INFO - 'sps_profile_interval': 0, 06:52:27 INFO - 'suite': 'dromaeojs-e10s', 06:52:27 INFO - 'system_bits': '32', 06:52:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:52:27 INFO - 'title': 'talos-linux64-ix-057', 06:52:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:52:27 INFO - 'use_talos_json': True, 06:52:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:52:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:52:27 INFO - 'work_dir': 'build'} 06:52:27 INFO - [mozharness: 2016-09-01 13:52:27.642083Z] Running clobber step. 06:52:27 INFO - Running pre-action listener: _resource_record_pre_action 06:52:27 INFO - Running main action method: clobber 06:52:27 INFO - rmtree: /builds/slave/test/build 06:52:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:52:28 INFO - Running post-action listener: _resource_record_post_action 06:52:28 INFO - [mozharness: 2016-09-01 13:52:28.109642Z] Finished clobber step (success) 06:52:28 INFO - [mozharness: 2016-09-01 13:52:28.109743Z] Running read-buildbot-config step. 06:52:28 INFO - Running pre-action listener: _resource_record_pre_action 06:52:28 INFO - Running main action method: read_buildbot_config 06:52:28 INFO - Using buildbot properties: 06:52:28 INFO - { 06:52:28 INFO - "project": "", 06:52:28 INFO - "product": "firefox", 06:52:28 INFO - "script_repo_revision": "production", 06:52:28 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 06:52:28 INFO - "repository": "", 06:52:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 06:52:28 INFO - "buildid": "20160830093921", 06:52:28 INFO - "pgo_build": "True", 06:52:28 INFO - "basedir": "/builds/slave/test", 06:52:28 INFO - "buildnumber": 521, 06:52:28 INFO - "slavename": "talos-linux64-ix-057", 06:52:28 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:52:28 INFO - "platform": "ubuntu64_hw", 06:52:28 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 06:52:28 INFO - "branch": "mozilla-aurora", 06:52:28 INFO - "repo_path": "releases/mozilla-aurora", 06:52:28 INFO - "revision": "c819e284a13937fc955c2efb6da7fdf9c5bb8b88", 06:52:28 INFO - "stage_platform": "linux64-pgo", 06:52:28 INFO - "builduid": "86ba142624df48b3b49a4204efa8ff7c", 06:52:28 INFO - "slavebuilddir": "test" 06:52:28 INFO - } 06:52:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 06:52:28 INFO - Running post-action listener: _resource_record_post_action 06:52:28 INFO - [mozharness: 2016-09-01 13:52:28.112192Z] Finished read-buildbot-config step (success) 06:52:28 INFO - [mozharness: 2016-09-01 13:52:28.112282Z] Running download-and-extract step. 06:52:28 INFO - Running pre-action listener: _resource_record_pre_action 06:52:28 INFO - Running main action method: download_and_extract 06:52:28 INFO - mkdir: /builds/slave/test/build/tests 06:52:28 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')]} 06:52:28 INFO - https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:52:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 06:52:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 06:52:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 06:52:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:52:28 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 06:52:28 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 06:52:28 INFO - retry: Failed, sleeping 30 seconds before retrying 06:52:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #2 06:52:58 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 06:52:58 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 06:52:58 INFO - retry: Failed, sleeping 60 seconds before retrying 06:53:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #3 06:53:58 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 06:53:58 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 06:53:58 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json! 06:53:58 INFO - Caught exception: HTTP Error 404: Not Found 06:53:58 INFO - Caught exception: HTTP Error 404: Not Found 06:53:58 INFO - Caught exception: HTTP Error 404: Not Found 06:53:58 INFO - trying https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 06:53:58 INFO - Downloading https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 06:53:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:53:58 INFO - Downloaded 1361 bytes. 06:53:58 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 06:53:58 INFO - Using the following test package requirements: 06:53:58 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 06:53:58 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 06:53:58 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 06:53:58 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 06:53:58 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 06:53:58 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 06:53:58 INFO - u'jsshell-linux-x86_64.zip'], 06:53:58 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 06:53:58 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 06:53:58 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 06:53:58 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 06:53:58 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 06:53:58 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 06:53:58 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 06:53:58 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 06:53:58 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 06:53:58 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 06:53:58 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 06:53:58 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:53:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:58 INFO - https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:53:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:53:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:53:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:53:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:53:58 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:53:58 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 06:53:58 INFO - retry: Failed, sleeping 30 seconds before retrying 06:54:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 06:54:28 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:54:28 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 06:54:28 INFO - retry: Failed, sleeping 60 seconds before retrying 06:55:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 06:55:28 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:55:28 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 06:55:28 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 06:55:28 INFO - Caught exception: HTTP Error 404: Not Found 06:55:28 INFO - Caught exception: HTTP Error 404: Not Found 06:55:28 INFO - Caught exception: HTTP Error 404: Not Found 06:55:28 INFO - trying https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:55:28 INFO - Downloading https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:55:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:55:29 INFO - Downloaded 21769265 bytes. 06:55:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:55:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:55:30 INFO - Return code: 0 06:55:30 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:55:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:30 INFO - https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:55:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:55:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:55:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:55:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:55:30 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:55:30 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 06:55:30 INFO - retry: Failed, sleeping 30 seconds before retrying 06:56:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 06:56:00 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:56:00 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 06:56:00 INFO - retry: Failed, sleeping 60 seconds before retrying 06:57:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 06:57:00 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:57:00 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 06:57:00 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 06:57:00 INFO - Caught exception: HTTP Error 404: Not Found 06:57:00 INFO - Caught exception: HTTP Error 404: Not Found 06:57:00 INFO - Caught exception: HTTP Error 404: Not Found 06:57:00 INFO - trying https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:57:00 INFO - Downloading https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:57:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:57:01 INFO - Downloaded 21769265 bytes. 06:57:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:57:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:57:03 INFO - Return code: 0 06:57:03 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')]} 06:57:03 INFO - https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:57:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 06:57:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 06:57:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 06:57:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:57:03 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 06:57:03 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 06:57:03 INFO - retry: Failed, sleeping 30 seconds before retrying 06:57:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 06:57:33 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 06:57:33 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 06:57:33 INFO - retry: Failed, sleeping 60 seconds before retrying 06:58:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 06:58:33 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 06:58:33 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 06:58:33 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip! 06:58:33 INFO - Caught exception: HTTP Error 404: Not Found 06:58:33 INFO - Caught exception: HTTP Error 404: Not Found 06:58:33 INFO - Caught exception: HTTP Error 404: Not Found 06:58:33 INFO - trying https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 06:58:33 INFO - Downloading https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 06:58:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:58:34 INFO - Downloaded 14413723 bytes. 06:58:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:58:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:58:34 INFO - Return code: 0 06:58:34 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')]} 06:58:34 INFO - https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:58:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 06:58:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 06:58:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 06:58:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:58:34 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 06:58:34 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 06:58:34 INFO - retry: Failed, sleeping 30 seconds before retrying 06:59:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #2 06:59:04 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 06:59:04 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 06:59:04 INFO - retry: Failed, sleeping 60 seconds before retrying 07:00:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #3 07:00:04 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 07:00:04 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 07:00:04 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2! 07:00:04 INFO - Caught exception: HTTP Error 404: Not Found 07:00:04 INFO - Caught exception: HTTP Error 404: Not Found 07:00:04 INFO - Caught exception: HTTP Error 404: Not Found 07:00:04 INFO - trying https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 07:00:04 INFO - Downloading https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 07:00:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:00:06 INFO - Downloaded 63875997 bytes. 07:00:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 07:00:06 INFO - mkdir: /builds/slave/test/properties 07:00:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:00:06 INFO - Writing to file /builds/slave/test/properties/build_url 07:00:06 INFO - Contents: 07:00:06 INFO - build_url:https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 07:00:07 INFO - Running post-action listener: _resource_record_post_action 07:00:07 INFO - Running post-action listener: set_extra_try_arguments 07:00:07 INFO - [mozharness: 2016-09-01 14:00:07.386287Z] Finished download-and-extract step (success) 07:00:07 INFO - [mozharness: 2016-09-01 14:00:07.386518Z] Running populate-webroot step. 07:00:07 INFO - Running pre-action listener: _resource_record_pre_action 07:00:07 INFO - Running main action method: populate_webroot 07:00:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:00:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:00:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:00:07 INFO - '--tppagecycles', 07:00:07 INFO - '7'], 07:00:07 INFO - 'tests': ['tsvgm']}}, 07:00:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:00:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:00:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:00:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:00:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:00:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:00:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:07 INFO - 'talos_options': ['--disable-e10s'], 07:00:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:00:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:00:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:07 INFO - 'talos_options': ['--disable-e10s'], 07:00:07 INFO - 'tests': ['damp', 'tps']}, 07:00:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:07 INFO - 'tests': ['damp', 'tps']}, 07:00:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:00:07 INFO - 'tests': ['dromaeo_dom']}, 07:00:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:00:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:00:07 INFO - 'tests': ['basic_compositor_video']}, 07:00:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:00:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:00:07 INFO - 'tests': ['a11yr', 07:00:07 INFO - 'ts_paint', 07:00:07 INFO - 'tpaint', 07:00:07 INFO - 'sessionrestore', 07:00:07 INFO - 'sessionrestore_no_auto_restore', 07:00:07 INFO - 'tabpaint']}, 07:00:07 INFO - 'other-e10s': {'tests': ['a11yr', 07:00:07 INFO - 'ts_paint', 07:00:07 INFO - 'tpaint', 07:00:07 INFO - 'sessionrestore', 07:00:07 INFO - 'sessionrestore_no_auto_restore', 07:00:07 INFO - 'tabpaint']}, 07:00:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:00:07 INFO - 'ts_paint', 07:00:07 INFO - 'tpaint', 07:00:07 INFO - 'sessionrestore', 07:00:07 INFO - 'sessionrestore_no_auto_restore', 07:00:07 INFO - 'tabpaint']}, 07:00:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:00:07 INFO - 'ts_paint', 07:00:07 INFO - 'tpaint', 07:00:07 INFO - 'sessionrestore', 07:00:07 INFO - 'sessionrestore_no_auto_restore', 07:00:07 INFO - 'tabpaint']}, 07:00:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:00:07 INFO - 'tests': ['a11yr', 07:00:07 INFO - 'ts_paint', 07:00:07 INFO - 'tpaint', 07:00:07 INFO - 'sessionrestore', 07:00:07 INFO - 'sessionrestore_no_auto_restore', 07:00:07 INFO - 'tabpaint']}, 07:00:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:00:07 INFO - 'tests': ['a11yr', 07:00:07 INFO - 'ts_paint', 07:00:07 INFO - 'tpaint', 07:00:07 INFO - 'sessionrestore', 07:00:07 INFO - 'sessionrestore_no_auto_restore', 07:00:07 INFO - 'tabpaint']}, 07:00:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:00:07 INFO - 'tests': ['tsvgx', 07:00:07 INFO - 'tsvgr_opacity', 07:00:07 INFO - 'tart', 07:00:07 INFO - 'tscrollx', 07:00:07 INFO - 'cart']}, 07:00:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:00:07 INFO - 'tsvgr_opacity', 07:00:07 INFO - 'tart', 07:00:07 INFO - 'tscrollx', 07:00:07 INFO - 'cart']}, 07:00:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:07 INFO - 'talos_options': ['--disable-e10s'], 07:00:07 INFO - 'tests': ['tp5o']}, 07:00:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:07 INFO - 'tests': ['tp5o']}, 07:00:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:07 INFO - 'talos_options': ['--disable-e10s', 07:00:07 INFO - '--xperf_path', 07:00:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:00:07 INFO - 'tests': ['tp5n']}, 07:00:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:07 INFO - 'talos_options': ['--xperf_path', 07:00:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:00:07 INFO - 'tests': ['tp5n']}}, 07:00:07 INFO - 'talos.zip': {'path': '', 07:00:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:00:07 INFO - Running post-action listener: _resource_record_post_action 07:00:07 INFO - [mozharness: 2016-09-01 14:00:07.406692Z] Finished populate-webroot step (success) 07:00:07 INFO - [mozharness: 2016-09-01 14:00:07.406782Z] Running create-virtualenv step. 07:00:07 INFO - Running pre-action listener: _resource_record_pre_action 07:00:07 INFO - Running main action method: create_virtualenv 07:00:07 INFO - Creating virtualenv /builds/slave/test/build/venv 07:00:07 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 07:00:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:00:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:00:07 INFO - Using real prefix '/usr' 07:00:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:00:08 INFO - Installing distribute.............................................................................................................................................................................................done. 07:00:09 INFO - Installing pip.................done. 07:00:09 INFO - Return code: 0 07:00:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:00:09 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')]} 07:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:09 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')]} 07:00:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:09 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 0x277d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ac400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3b570>, '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 0x2a3c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c900>, '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': '934fc3100db09dcb9af4d4b6000001ab-1472737324.396277-1139027901', '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 07:00:09 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 07:00:09 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 07:00:09 INFO - Using env: {'DISPLAY': ':0', 07:00:09 INFO - 'HOME': '/home/cltbld', 07:00:10 INFO - 'LANG': 'en_US.UTF-8', 07:00:10 INFO - 'LANGUAGE': 'en_US:en', 07:00:10 INFO - 'LOGNAME': 'cltbld', 07:00:10 INFO - 'MAIL': '/var/mail/cltbld', 07:00:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:10 INFO - 'MOZ_NO_REMOTE': '1', 07:00:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:10 INFO - 'NO_EM_RESTART': '1', 07:00:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:10 INFO - 'PWD': '/builds/slave/test', 07:00:10 INFO - 'SHELL': '/bin/bash', 07:00:10 INFO - 'SHLVL': '1', 07:00:10 INFO - 'TERM': 'linux', 07:00:10 INFO - 'TMOUT': '86400', 07:00:10 INFO - 'USER': 'cltbld', 07:00:10 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1472737324.396277-1139027901', 07:00:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:10 INFO - '_': '/tools/buildbot/bin/python'} 07:00:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:10 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 07:00:10 INFO - Cleaning up... 07:00:10 INFO - Return code: 0 07:00:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:00: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')]} 07:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00: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')]} 07:00:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00: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', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x277d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ac400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3b570>, '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 0x2a3c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c900>, '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': '934fc3100db09dcb9af4d4b6000001ab-1472737324.396277-1139027901', '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 07:00: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', 'psutil>=3.1.1'] in /builds/slave/test/build 07:00: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 psutil>=3.1.1 07:00:10 INFO - Using env: {'DISPLAY': ':0', 07:00:10 INFO - 'HOME': '/home/cltbld', 07:00:10 INFO - 'LANG': 'en_US.UTF-8', 07:00:10 INFO - 'LANGUAGE': 'en_US:en', 07:00:10 INFO - 'LOGNAME': 'cltbld', 07:00:10 INFO - 'MAIL': '/var/mail/cltbld', 07:00:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:10 INFO - 'MOZ_NO_REMOTE': '1', 07:00:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:10 INFO - 'NO_EM_RESTART': '1', 07:00:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:10 INFO - 'PWD': '/builds/slave/test', 07:00:10 INFO - 'SHELL': '/bin/bash', 07:00:10 INFO - 'SHLVL': '1', 07:00:10 INFO - 'TERM': 'linux', 07:00:10 INFO - 'TMOUT': '86400', 07:00:10 INFO - 'USER': 'cltbld', 07:00:10 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1472737324.396277-1139027901', 07:00:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:10 INFO - '_': '/tools/buildbot/bin/python'} 07:00:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:10 INFO - Downloading/unpacking psutil>=3.1.1 07:00: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 07:00: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 07:00: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 07:00: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 07:00: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 07:00: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 07:00:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:00:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:00:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:00:12 INFO - Installing collected packages: psutil 07:00:12 INFO - Running setup.py install for psutil 07:00:12 INFO - building 'psutil._psutil_linux' extension 07:00:12 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 07:00:12 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 07:00:12 INFO - building 'psutil._psutil_posix' extension 07:00:12 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 07:00:12 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 07:00:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:00:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:00:12 INFO - Successfully installed psutil 07:00:12 INFO - Cleaning up... 07:00:12 INFO - Return code: 0 07:00:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:00:12 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')]} 07:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:12 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')]} 07:00:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x277d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ac400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3b570>, '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 0x2a3c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c900>, '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': '934fc3100db09dcb9af4d4b6000001ab-1472737324.396277-1139027901', '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 07:00:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:00:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:00:12 INFO - Using env: {'DISPLAY': ':0', 07:00:12 INFO - 'HOME': '/home/cltbld', 07:00:12 INFO - 'LANG': 'en_US.UTF-8', 07:00:12 INFO - 'LANGUAGE': 'en_US:en', 07:00:12 INFO - 'LOGNAME': 'cltbld', 07:00:12 INFO - 'MAIL': '/var/mail/cltbld', 07:00:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:12 INFO - 'MOZ_NO_REMOTE': '1', 07:00:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:12 INFO - 'NO_EM_RESTART': '1', 07:00:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:12 INFO - 'PWD': '/builds/slave/test', 07:00:12 INFO - 'SHELL': '/bin/bash', 07:00:12 INFO - 'SHLVL': '1', 07:00:12 INFO - 'TERM': 'linux', 07:00:12 INFO - 'TMOUT': '86400', 07:00:12 INFO - 'USER': 'cltbld', 07:00:12 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1472737324.396277-1139027901', 07:00:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:12 INFO - '_': '/tools/buildbot/bin/python'} 07:00:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:00:13 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 07:00:13 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 07:00:13 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 07:00:13 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 07:00:13 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 07:00:13 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 07:00:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:00:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:00:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:00:15 INFO - Installing collected packages: mozsystemmonitor 07:00:15 INFO - Running setup.py install for mozsystemmonitor 07:00:15 INFO - Successfully installed mozsystemmonitor 07:00:15 INFO - Cleaning up... 07:00:15 INFO - Return code: 0 07:00:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:00:15 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')]} 07:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:15 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')]} 07:00:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x277d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ac400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3b570>, '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 0x2a3c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c900>, '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': '934fc3100db09dcb9af4d4b6000001ab-1472737324.396277-1139027901', '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 07:00:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:00:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:00:15 INFO - Using env: {'DISPLAY': ':0', 07:00:15 INFO - 'HOME': '/home/cltbld', 07:00:15 INFO - 'LANG': 'en_US.UTF-8', 07:00:15 INFO - 'LANGUAGE': 'en_US:en', 07:00:15 INFO - 'LOGNAME': 'cltbld', 07:00:15 INFO - 'MAIL': '/var/mail/cltbld', 07:00:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:15 INFO - 'MOZ_NO_REMOTE': '1', 07:00:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:15 INFO - 'NO_EM_RESTART': '1', 07:00:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:15 INFO - 'PWD': '/builds/slave/test', 07:00:15 INFO - 'SHELL': '/bin/bash', 07:00:15 INFO - 'SHLVL': '1', 07:00:15 INFO - 'TERM': 'linux', 07:00:15 INFO - 'TMOUT': '86400', 07:00:15 INFO - 'USER': 'cltbld', 07:00:15 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1472737324.396277-1139027901', 07:00:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:15 INFO - '_': '/tools/buildbot/bin/python'} 07:00:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:15 INFO - Downloading/unpacking jsonschema==2.5.1 07:00:15 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 07:00:15 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 07:00:15 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 07:00:15 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 07:00:15 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 07:00:15 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 07:00:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:00:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:00: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 07:00: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 07:00: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 07:00: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 07:00: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 07:00: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 07:00:17 INFO - Downloading functools32-3.2.3-2.tar.gz 07:00:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:00:17 INFO - warning: no files found matching '*.txt' 07:00:17 INFO - no previously-included directories found matching 'build' 07:00:17 INFO - no previously-included directories found matching 'dist' 07:00:17 INFO - no previously-included directories found matching '.git*' 07:00:17 INFO - Installing collected packages: jsonschema, functools32 07:00:17 INFO - Running setup.py install for functools32 07:00:17 INFO - warning: no files found matching '*.txt' 07:00:17 INFO - no previously-included directories found matching 'build' 07:00:17 INFO - no previously-included directories found matching 'dist' 07:00:17 INFO - no previously-included directories found matching '.git*' 07:00:17 INFO - Successfully installed jsonschema functools32 07:00:17 INFO - Cleaning up... 07:00:17 INFO - Return code: 0 07:00:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:00:17 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')]} 07:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:17 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')]} 07:00:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:17 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x277d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ac400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3b570>, '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 0x2a3c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c900>, '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': '934fc3100db09dcb9af4d4b6000001ab-1472737324.396277-1139027901', '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 07:00:17 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:00:17 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 functools32==3.2.3-2 07:00:17 INFO - Using env: {'DISPLAY': ':0', 07:00:17 INFO - 'HOME': '/home/cltbld', 07:00:17 INFO - 'LANG': 'en_US.UTF-8', 07:00:17 INFO - 'LANGUAGE': 'en_US:en', 07:00:17 INFO - 'LOGNAME': 'cltbld', 07:00:17 INFO - 'MAIL': '/var/mail/cltbld', 07:00:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:17 INFO - 'MOZ_NO_REMOTE': '1', 07:00:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:17 INFO - 'NO_EM_RESTART': '1', 07:00:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:17 INFO - 'PWD': '/builds/slave/test', 07:00:17 INFO - 'SHELL': '/bin/bash', 07:00:17 INFO - 'SHLVL': '1', 07:00:17 INFO - 'TERM': 'linux', 07:00:17 INFO - 'TMOUT': '86400', 07:00:17 INFO - 'USER': 'cltbld', 07:00:17 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1472737324.396277-1139027901', 07:00:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:17 INFO - '_': '/tools/buildbot/bin/python'} 07:00:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:00:18 INFO - Cleaning up... 07:00:18 INFO - Return code: 0 07:00:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:00:18 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')]} 07:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:18 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')]} 07:00:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:18 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 0x277d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ac400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3b570>, '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 0x2a3c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c900>, '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': '934fc3100db09dcb9af4d4b6000001ab-1472737324.396277-1139027901', '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 07:00:18 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 07:00:18 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 07:00:18 INFO - Using env: {'DISPLAY': ':0', 07:00:18 INFO - 'HOME': '/home/cltbld', 07:00:18 INFO - 'LANG': 'en_US.UTF-8', 07:00:18 INFO - 'LANGUAGE': 'en_US:en', 07:00:18 INFO - 'LOGNAME': 'cltbld', 07:00:18 INFO - 'MAIL': '/var/mail/cltbld', 07:00:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:18 INFO - 'MOZ_NO_REMOTE': '1', 07:00:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:18 INFO - 'NO_EM_RESTART': '1', 07:00:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:18 INFO - 'PWD': '/builds/slave/test', 07:00:18 INFO - 'SHELL': '/bin/bash', 07:00:18 INFO - 'SHLVL': '1', 07:00:18 INFO - 'TERM': 'linux', 07:00:18 INFO - 'TMOUT': '86400', 07:00:18 INFO - 'USER': 'cltbld', 07:00:18 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1472737324.396277-1139027901', 07:00:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:18 INFO - '_': '/tools/buildbot/bin/python'} 07:00:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:18 INFO - Downloading/unpacking blobuploader==1.2.4 07:00:18 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 07:00:18 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 07:00:18 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 07:00:18 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 07:00:18 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 07:00:18 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 07:00:20 INFO - Downloading blobuploader-1.2.4.tar.gz 07:00:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:00:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:00: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 07:00: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 07:00: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 07:00: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 07:00: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 07:00: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 07:00:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:00:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:00: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 07:00: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 07:00: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 07:00: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 07:00: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 07:00: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 07:00:20 INFO - Downloading docopt-0.6.1.tar.gz 07:00:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:00:20 INFO - Installing collected packages: blobuploader, requests, docopt 07:00:20 INFO - Running setup.py install for blobuploader 07:00:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:00:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:00:21 INFO - Running setup.py install for requests 07:00:21 INFO - Running setup.py install for docopt 07:00:21 INFO - Successfully installed blobuploader requests docopt 07:00:21 INFO - Cleaning up... 07:00:21 INFO - Return code: 0 07:00:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:00:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:21 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 0x277d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ac400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3b570>, '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 0x2a3c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c900>, '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': '934fc3100db09dcb9af4d4b6000001ab-1472737324.396277-1139027901', '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 07:00:21 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 07:00:21 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 07:00:21 INFO - Using env: {'DISPLAY': ':0', 07:00:21 INFO - 'HOME': '/home/cltbld', 07:00:21 INFO - 'LANG': 'en_US.UTF-8', 07:00:21 INFO - 'LANGUAGE': 'en_US:en', 07:00:21 INFO - 'LOGNAME': 'cltbld', 07:00:21 INFO - 'MAIL': '/var/mail/cltbld', 07:00:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:21 INFO - 'MOZ_NO_REMOTE': '1', 07:00:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:21 INFO - 'NO_EM_RESTART': '1', 07:00:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:21 INFO - 'PWD': '/builds/slave/test', 07:00:21 INFO - 'SHELL': '/bin/bash', 07:00:21 INFO - 'SHLVL': '1', 07:00:21 INFO - 'TERM': 'linux', 07:00:21 INFO - 'TMOUT': '86400', 07:00:21 INFO - 'USER': 'cltbld', 07:00:21 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1472737324.396277-1139027901', 07:00:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:21 INFO - '_': '/tools/buildbot/bin/python'} 07:00:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:00:21 INFO - Running setup.py (path:/tmp/pip-53pVxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:00:21 INFO - Running setup.py (path:/tmp/pip-A5Onfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:00:21 INFO - Running setup.py (path:/tmp/pip-LQRnUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:00:22 INFO - Running setup.py (path:/tmp/pip-cG3oH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:00:22 INFO - Running setup.py (path:/tmp/pip-Vsz1Ld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:00:22 INFO - Running setup.py (path:/tmp/pip-7Wjlsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:00:22 INFO - Running setup.py (path:/tmp/pip-XqRRCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:00:22 INFO - Running setup.py (path:/tmp/pip-UFqZGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:00:22 INFO - Running setup.py (path:/tmp/pip-LCSuSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:00:22 INFO - Running setup.py (path:/tmp/pip-uIX6UG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:00:22 INFO - Running setup.py (path:/tmp/pip-Dedyfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:00:22 INFO - Running setup.py (path:/tmp/pip-MB7U4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:00:22 INFO - Running setup.py (path:/tmp/pip-j2NYfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:00:22 INFO - Running setup.py (path:/tmp/pip-7gJgs_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:00:22 INFO - Running setup.py (path:/tmp/pip-RwxQb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:00:22 INFO - Running setup.py (path:/tmp/pip-SizFuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:00:22 INFO - Running setup.py (path:/tmp/pip-Rngc1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:00:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:00:23 INFO - Running setup.py install for manifestparser 07:00:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:00:23 INFO - Running setup.py install for mozcrash 07:00:23 INFO - Running setup.py install for mozdebug 07:00:23 INFO - Running setup.py install for mozdevice 07:00:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:00:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:00:23 INFO - Running setup.py install for mozfile 07:00:23 INFO - Running setup.py install for mozhttpd 07:00:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:00:23 INFO - Running setup.py install for mozinfo 07:00:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:00:23 INFO - Running setup.py install for mozInstall 07:00:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:00:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:00:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:00:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:00:23 INFO - Running setup.py install for mozleak 07:00:23 INFO - Running setup.py install for mozlog 07:00:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:00:24 INFO - Running setup.py install for moznetwork 07:00:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:00:24 INFO - Running setup.py install for mozprocess 07:00:24 INFO - Running setup.py install for mozprofile 07:00:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:00:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:00:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:00:24 INFO - Running setup.py install for mozrunner 07:00:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:00:24 INFO - Running setup.py install for mozscreenshot 07:00:24 INFO - Running setup.py install for moztest 07:00:24 INFO - Running setup.py install for mozversion 07:00:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:00:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:00:24 INFO - Cleaning up... 07:00:24 INFO - Return code: 0 07:00:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:00:24 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')]} 07:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:24 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')]} 07:00:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:24 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 0x277d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ac400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3b570>, '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 0x2a3c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c900>, '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': '934fc3100db09dcb9af4d4b6000001ab-1472737324.396277-1139027901', '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 07:00:24 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 07:00:24 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 07:00:24 INFO - Using env: {'DISPLAY': ':0', 07:00:24 INFO - 'HOME': '/home/cltbld', 07:00:24 INFO - 'LANG': 'en_US.UTF-8', 07:00:24 INFO - 'LANGUAGE': 'en_US:en', 07:00:24 INFO - 'LOGNAME': 'cltbld', 07:00:24 INFO - 'MAIL': '/var/mail/cltbld', 07:00:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:24 INFO - 'MOZ_NO_REMOTE': '1', 07:00:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:24 INFO - 'NO_EM_RESTART': '1', 07:00:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:24 INFO - 'PWD': '/builds/slave/test', 07:00:24 INFO - 'SHELL': '/bin/bash', 07:00:24 INFO - 'SHLVL': '1', 07:00:24 INFO - 'TERM': 'linux', 07:00:24 INFO - 'TMOUT': '86400', 07:00:24 INFO - 'USER': 'cltbld', 07:00:24 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1472737324.396277-1139027901', 07:00:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:24 INFO - '_': '/tools/buildbot/bin/python'} 07:00:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:00:25 INFO - Running setup.py (path:/tmp/pip-u7mhG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:00:25 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)) 07:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:00:25 INFO - Running setup.py (path:/tmp/pip-2WmkTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:00:25 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)) 07:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:00:25 INFO - Running setup.py (path:/tmp/pip-1mko17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:00:25 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)) 07:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:00:25 INFO - Running setup.py (path:/tmp/pip-KGstVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:00:25 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)) 07:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:00:25 INFO - Running setup.py (path:/tmp/pip-duzUU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:00:25 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)) 07:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:00:25 INFO - Running setup.py (path:/tmp/pip-AAlBE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:00:25 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)) 07:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:00:25 INFO - Running setup.py (path:/tmp/pip-kKOniS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:00:25 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)) 07:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:00:25 INFO - Running setup.py (path:/tmp/pip-c78pAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:00:25 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)) 07:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:00:25 INFO - Running setup.py (path:/tmp/pip-RpLwF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:00:25 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)) 07:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:00:25 INFO - Running setup.py (path:/tmp/pip-t_Bqk5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:00:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 07:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:00:25 INFO - Running setup.py (path:/tmp/pip-WaymzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:00:25 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)) 07:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:00:25 INFO - Running setup.py (path:/tmp/pip-9Uxnb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:00:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 07:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:00:25 INFO - Running setup.py (path:/tmp/pip-8MWW14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:00:25 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)) 07:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:00:25 INFO - Running setup.py (path:/tmp/pip-dj3wWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:00:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 07:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:00:26 INFO - Running setup.py (path:/tmp/pip-oRU1Qn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:00:26 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)) 07:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:00:26 INFO - Running setup.py (path:/tmp/pip-Bt0uGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:00:26 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)) 07:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:00:26 INFO - Running setup.py (path:/tmp/pip-6gpeVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:00:26 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)) 07:00:26 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)) 07:00:26 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)) 07:00:26 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)) 07:00:26 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)) 07:00:26 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)) 07:00:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:00:26 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 07:00:26 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 07:00:26 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 07:00:26 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 07:00:26 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 07:00:26 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 07:00:28 INFO - Downloading blessings-1.6.tar.gz 07:00:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:00:28 INFO - Installing collected packages: blessings 07:00:28 INFO - Running setup.py install for blessings 07:00:28 INFO - Successfully installed blessings 07:00:28 INFO - Cleaning up... 07:00:28 INFO - Return code: 0 07:00:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:00:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:00:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:00:28 INFO - Reading from file tmpfile_stdout 07:00:28 INFO - Current package versions: 07:00:28 INFO - argparse == 1.2.1 07:00:28 INFO - blessings == 1.6 07:00:28 INFO - blobuploader == 1.2.4 07:00:28 INFO - docopt == 0.6.1 07:00:28 INFO - functools32 == 3.2.3-2 07:00:28 INFO - jsonschema == 2.5.1 07:00:28 INFO - manifestparser == 1.1 07:00:28 INFO - mozInstall == 1.12 07:00:28 INFO - mozcrash == 0.17 07:00:28 INFO - mozdebug == 0.1 07:00:28 INFO - mozdevice == 0.48 07:00:28 INFO - mozfile == 1.2 07:00:28 INFO - mozhttpd == 0.7 07:00:28 INFO - mozinfo == 0.9 07:00:28 INFO - mozleak == 0.1 07:00:28 INFO - mozlog == 3.3 07:00:28 INFO - moznetwork == 0.27 07:00:28 INFO - mozprocess == 0.23 07:00:28 INFO - mozprofile == 0.28 07:00:28 INFO - mozrunner == 6.12 07:00:28 INFO - mozscreenshot == 0.1 07:00:28 INFO - mozsystemmonitor == 0.3 07:00:28 INFO - moztest == 0.7 07:00:28 INFO - mozversion == 1.4 07:00:28 INFO - psutil == 3.1.1 07:00:28 INFO - requests == 1.2.3 07:00:28 INFO - wsgiref == 0.1.2 07:00:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:00:28 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')]} 07:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:28 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')]} 07:00:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:28 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 0x277d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ac400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3b570>, '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 0x2a3c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c900>, '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': '934fc3100db09dcb9af4d4b6000001ab-1472737324.396277-1139027901', '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 07:00:28 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 07:00:28 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 07:00:28 INFO - Using env: {'DISPLAY': ':0', 07:00:28 INFO - 'HOME': '/home/cltbld', 07:00:28 INFO - 'LANG': 'en_US.UTF-8', 07:00:28 INFO - 'LANGUAGE': 'en_US:en', 07:00:28 INFO - 'LOGNAME': 'cltbld', 07:00:28 INFO - 'MAIL': '/var/mail/cltbld', 07:00:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:28 INFO - 'MOZ_NO_REMOTE': '1', 07:00:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:28 INFO - 'NO_EM_RESTART': '1', 07:00:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:28 INFO - 'PWD': '/builds/slave/test', 07:00:28 INFO - 'SHELL': '/bin/bash', 07:00:28 INFO - 'SHLVL': '1', 07:00:28 INFO - 'TERM': 'linux', 07:00:28 INFO - 'TMOUT': '86400', 07:00:28 INFO - 'USER': 'cltbld', 07:00:28 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1472737324.396277-1139027901', 07:00:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:28 INFO - '_': '/tools/buildbot/bin/python'} 07:00:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:28 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)) 07:00:28 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)) 07:00:28 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)) 07:00:28 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)) 07:00:28 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)) 07:00:28 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)) 07:00:28 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)) 07:00:28 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)) 07:00:28 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)) 07:00:28 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)) 07:00:28 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)) 07:00:28 INFO - Cleaning up... 07:00:28 INFO - Return code: 0 07:00:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:00:28 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')]} 07:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:28 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')]} 07:00:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:28 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 0x277d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ac400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3b570>, '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 0x2a3c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c900>, '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': '934fc3100db09dcb9af4d4b6000001ab-1472737324.396277-1139027901', '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 07:00:28 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 07:00:28 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 07:00:28 INFO - Using env: {'DISPLAY': ':0', 07:00:28 INFO - 'HOME': '/home/cltbld', 07:00:28 INFO - 'LANG': 'en_US.UTF-8', 07:00:28 INFO - 'LANGUAGE': 'en_US:en', 07:00:28 INFO - 'LOGNAME': 'cltbld', 07:00:28 INFO - 'MAIL': '/var/mail/cltbld', 07:00:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:28 INFO - 'MOZ_NO_REMOTE': '1', 07:00:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:28 INFO - 'NO_EM_RESTART': '1', 07:00:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:28 INFO - 'PWD': '/builds/slave/test', 07:00:28 INFO - 'SHELL': '/bin/bash', 07:00:28 INFO - 'SHLVL': '1', 07:00:28 INFO - 'TERM': 'linux', 07:00:28 INFO - 'TMOUT': '86400', 07:00:28 INFO - 'USER': 'cltbld', 07:00:28 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1472737324.396277-1139027901', 07:00:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:28 INFO - '_': '/tools/buildbot/bin/python'} 07:00:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:00:29 INFO - Cleaning up... 07:00:29 INFO - Return code: 0 07:00:29 INFO - Running post-action listener: _resource_record_post_action 07:00:29 INFO - Running post-action listener: _start_resource_monitoring 07:00:29 INFO - Starting resource monitoring. 07:00:29 INFO - [mozharness: 2016-09-01 14:00:29.098397Z] Finished create-virtualenv step (success) 07:00:29 INFO - [mozharness: 2016-09-01 14:00:29.098876Z] Running install step. 07:00:29 INFO - Running pre-action listener: _resource_record_pre_action 07:00:29 INFO - Running main action method: install 07:00:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:00:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:00:29 INFO - Reading from file tmpfile_stdout 07:00:29 INFO - Detecting whether we're running mozinstall >=1.0... 07:00:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:00:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:00:29 INFO - Reading from file tmpfile_stdout 07:00:29 INFO - Output received: 07:00:29 INFO - Usage: mozinstall [options] installer 07:00:29 INFO - Options: 07:00:29 INFO - -h, --help show this help message and exit 07:00:29 INFO - -d DEST, --destination=DEST 07:00:29 INFO - Directory to install application into. [default: 07:00:29 INFO - "/builds/slave/test"] 07:00:29 INFO - --app=APP Application being installed. [default: firefox] 07:00:29 INFO - mkdir: /builds/slave/test/build/application 07:00:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:00:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:00:46 INFO - Reading from file tmpfile_stdout 07:00:46 INFO - Output received: 07:00:46 INFO - /builds/slave/test/build/application/firefox/firefox 07:00:46 INFO - Running post-action listener: _resource_record_post_action 07:00:46 INFO - [mozharness: 2016-09-01 14:00:46.057771Z] Finished install step (success) 07:00:46 INFO - [mozharness: 2016-09-01 14:00:46.058045Z] Running run-tests step. 07:00:46 INFO - Running pre-action listener: _resource_record_pre_action 07:00:46 INFO - Running main action method: run_tests 07:00:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:00:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:00:46 INFO - Python 2.7.3 07:00:46 INFO - Return code: 0 07:00:46 INFO - grabbing minidump binary from tooltool 07:00:46 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')]} 07:00:46 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 0x2a3b570>, '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 0x2a3c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:00:46 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 07:00:46 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 07:00:46 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 07:00:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:00:46 INFO - Return code: 0 07:00:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:00:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:00:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:00:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:00:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:00:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:00:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:00:46 INFO - Using env: {'DISPLAY': ':0', 07:00:46 INFO - 'HOME': '/home/cltbld', 07:00:46 INFO - 'LANG': 'en_US.UTF-8', 07:00:46 INFO - 'LANGUAGE': 'en_US:en', 07:00:46 INFO - 'LOGNAME': 'cltbld', 07:00:46 INFO - 'MAIL': '/var/mail/cltbld', 07:00:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:00:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:46 INFO - 'MOZ_NO_REMOTE': '1', 07:00:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:00:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:46 INFO - 'NO_EM_RESTART': '1', 07:00:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:46 INFO - 'PWD': '/builds/slave/test', 07:00:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:00:46 INFO - 'SHELL': '/bin/bash', 07:00:46 INFO - 'SHLVL': '1', 07:00:46 INFO - 'TERM': 'linux', 07:00:46 INFO - 'TMOUT': '86400', 07:00:46 INFO - 'USER': 'cltbld', 07:00:46 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1472737324.396277-1139027901', 07:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:46 INFO - '_': '/tools/buildbot/bin/python'} 07:00:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:00:46 INFO - mozversion application_buildid: 20160830093921 07:00:46 INFO - mozversion application_changeset: c819e284a13937fc955c2efb6da7fdf9c5bb8b88 07:00:46 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:00:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:00:46 INFO - mozversion application_name: Firefox 07:00:46 INFO - mozversion application_remotingname: firefox-dev 07:00:46 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:00:46 INFO - mozversion application_vendor: Mozilla 07:00:46 INFO - mozversion application_version: 50.0a2 07:00:46 INFO - mozversion platform_buildid: 20160830093921 07:00:46 INFO - mozversion platform_changeset: c819e284a13937fc955c2efb6da7fdf9c5bb8b88 07:00:46 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:00:46 INFO - mozversion platform_version: 50.0a2 07:00:46 INFO - using testdate: 1472738446 07:00:46 INFO - actual date: 1472738446 07:00:46 INFO - starting webserver on 'localhost:52281' 07:00:46 INFO - SUITE-START | Running 2 tests 07:00:46 INFO - TEST-START | dromaeo_css 07:00:46 INFO - operating with platform_type : linux_ 07:00:46 INFO - Initialising browser for dromaeo_css test... 07:00:46 INFO - TEST-INFO | started process 24457 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7VOs3n/profile http://localhost:52281/getInfo.html) 07:00:51 INFO - PROCESS | 24457 | __metrics Screen width/height:1600/1200 07:00:51 INFO - PROCESS | 24457 | colorDepth:24 07:00:51 INFO - PROCESS | 24457 | Browser inner width/height: 1024/697 07:00:51 INFO - PROCESS | 24457 | __metrics 07:00:51 ERROR - PROCESS | 24457 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 07:00:52 INFO - TEST-INFO | 24457: exit 0 07:00:52 INFO - Browser initialized. 07:00:52 INFO - Running cycle 1/1 for dromaeo_css test... 07:00:52 INFO - TEST-INFO | started process 24585 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7VOs3n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:01:04 INFO - PROCESS | 24585 | RSS: Main: 152944640 07:01:04 INFO - PROCESS | 24585 | 07:01:53 INFO - PROCESS | 24585 | 1472738513930 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] 07:04:02 INFO - PROCESS | 24585 | Cycle 1(1): loaded http://localhost:52281/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52281/tests/dromaeo/cssquery-ext.html) 07:04:03 INFO - PROCESS | 24585 | RSS: Main: 158593024 07:04:03 INFO - PROCESS | 24585 | 07:07:05 INFO - PROCESS | 24585 | Cycle 1(1): loaded http://localhost:52281/tests/dromaeo/cssquery-ext.html (next: http://localhost:52281/tests/dromaeo/cssquery-jquery.html) 07:07:06 INFO - PROCESS | 24585 | RSS: Main: 154128384 07:07:06 INFO - PROCESS | 24585 | 07:10:08 INFO - PROCESS | 24585 | Cycle 1(1): loaded http://localhost:52281/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52281/tests/dromaeo/cssquery-mootools.html) 07:10:08 INFO - PROCESS | 24585 | RSS: Main: 154312704 07:10:08 INFO - PROCESS | 24585 | 07:13:10 INFO - PROCESS | 24585 | Cycle 1(1): loaded http://localhost:52281/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52281/tests/dromaeo/cssquery-prototype.html) 07:13:11 INFO - PROCESS | 24585 | RSS: Main: 153075712 07:13:11 INFO - PROCESS | 24585 | 07:16:13 INFO - PROCESS | 24585 | Cycle 1(1): loaded http://localhost:52281/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52281/tests/dromaeo/cssquery-yui.html) 07:16:14 INFO - PROCESS | 24585 | RSS: Main: 155271168 07:16:14 INFO - PROCESS | 24585 | 07:19:16 INFO - PROCESS | 24585 | Cycle 1(1): loaded http://localhost:52281/tests/dromaeo/cssquery-yui.html (next: http://localhost:52281/tests/dromaeo/cssquery-dojo.html) 07:19:16 INFO - PROCESS | 24585 | RSS: Main: 155467776 07:19:16 INFO - PROCESS | 24585 | 07:19:16 INFO - PROCESS | 24585 | __start_tp_report 07:19:16 INFO - PROCESS | 24585 | _x_x_mozilla_page_load 07:19:16 INFO - PROCESS | 24585 | _x_x_mozilla_page_load_details 07:19:16 INFO - PROCESS | 24585 | |i|pagename|runs| 07:19:16 INFO - PROCESS | 24585 | |0;dojo.html;3348.9497657535135;3364.461686130219;3377.3751855906676;3391.5930088389396;3401.1667141550324;5866.149408335788;5938.346781853993;5939.287285525732;5952.58331916766;5974.641521508707;5831.9416805831925;5859.589828711981;5880.441358070987;5888.11678248263;5919.112133180025;5293.417724050351;5332.413434522199;5358.089124848766;5423.349198096214;5434.510894019538;5177.715225662587;5194.168932970725;5214.348206474191;5308.867278318035;5322.20166974953;5346.705931173784;5367.919481207766;5368.543673787733;5370.355557333126;5409.350877894639;5435.456454354572;5442.564594832404;5444.210589464526;5458.372287186985;5491.862703432406;5146.125158723026;5204.583633309327;5219.451957544441;5354.544863686591;5359.517643412073;5804.303483581955;5822.272215973004;5861.589688721791;5864.442877926633;5943.821685349447;6245.3442388549;6297.842553936142;6307.716152773136;6319.842003949892;6345.302016778151;6124.472479235491;6225.626462412224;6268.529860260499;6301.369863013662;6361.077643741632;5930.406959304079;5932.377100404396;5949.9107513387335;5950.999999999956;5954.255718035246;6441.130447389636;6465.806025819233;6471.352864713491;6503.772367967098;6519.543631945813;6063.090536419572;6108.664023478663;6132.969335153385;6250.812475625738;6269.655168965751;6298.590591611531;6318.083877837687;6320.652364119926;6323.7786677466065;6353.904691429632;6317.273513545909;6326.4622507087415;6327.050942358683;6331.905021424683;6335.968320158369;6078.635281883101;6141.670122563582;6191.226096737908;6299.370062993664;6303.7793677222;4806.2310030394965;4811.927821082687;4812.205986012339;4812.663113582015;4842.927356089662;4281.293586558245;4284.657227421799;4291.828326866953;4303.63419109373;4315.762633055212;5862.091375836752;5982.132590774313;6006.429389208019;6023.728932198062;6103.450689437972;6402.743890244338;6428.325025872309;6429.742810287629;6446.871062578723;6448.226212854487;6112.144299798032;6118.357572454917;6134.754609815557;6141.785037523665;6145.907811382833;5293.364796224478;5432.619716619878;5460.235567020621;5518.834434966958;5546.389897111315;6568.474522038226;6571.80284591463;6572.76995305162;6585.6377899216;6598.90101648466;6413.967930160319;6440.066190402459;6446.580972236789;6450.645214513247;6464.127342808661;6273.341299163704;6408.839779005562;6415.486761059197;6517.152770139852;6601.405873471219;6267.6866156692895;6276.152719382825;6281.309056003927;6292.52806039558;6299.559030867796;6322.873542529215;6388.776392826228;6391.6804159792755;6400.487960963019;6413.35866413355;6017.608855424559;6116.938830611637;6141.631502109888;6251.78118765841;6262.780802671885;6126.663033533198;6154.815355539341;6159.692015399301;6176.845578860564;6180.47465965398;6097.96334623124;6133.44798968095;6140.140380346666;6148.661823599566;6178.073289006685;5996.520278377807;6104.9389506106145;6178.969105154445;6193.040078787795;6229.906551401823;6076.574639775174;6119.632822030692;6121.755129794758;6123.08153776937;6140.5701600887505 07:19:16 INFO - PROCESS | 24585 | |1;ext.html;577.6447484796848;648.9805305840825;661.3981277037894;670.1723371636028;718.3642476408384;43276;47064.29403558941;47414.76292618541;47476;47603.52396476039;47409.051818963686;47478.287825682644;47918.28122578164;47952.760236198774;48060.75969620147;9038.63845446183;9155.313351498631;9171.816563668723;9182.127697868726;9212.907870921306;9124.726258212264;9153.908460915405;9160.312976526788;9167.12912273333;9187.95406022969;9274.721758347227;9286.628534858597;9289.72130836076;9323.347365684405;9339.299552533554;9130.360874738737;9215.677451289239;9255.861162082574;9260.629574817;9265.16613504781;9123.224525915306;9128.361014728971;9177.403468774508;9204.585793639302;9213.032631573655;45088;45238.54761452376;45344.54655453436;45354.77322613366;45467.31799023017;3194;3784.375578029622;3801.4107813288983;3966.127451960564;4025.9798701006603;35589.93230203098;35861.28277434437;36009.81995090034;36212.63787362119;36235.275294493964;4596.471405788344;4782.928256076161;4815.253635686439;4835.540623640749;4871.0744958458135;384336;385824;387296;388407;390375;72606.27393725995;74001;74003.25996739963;74208.62895685594;74250.62874685592;41186.9703257421;41588.79205603953;41858.790706046275;44200.77899610481;44362.556374436484;19815.10832012563;20136.697949530768;20136.89247091424;20157.19371225164;20244.898775506324;14448.422063117569;14502.709945801025;14637.780433293508;14645;14659;22535.873206339616;22703.659445108337;22826.201082962016;22952;22978.770212297663;7815.179406162385;7890.8816367754525;8094.952523738131;8095.2714255717265;8250.422470427013;1004.352192835617;1052.7473406382567;1065.08934860693;1074.9301295415773;1100.4827730966433;34189.48715769265;34613.307733845184;34697.653023469444;34927.476087858704;35732;1158.3223814068865;1182.6392950150287;1188.6374655730085;1257.6981524434252;1278.520554791953;17869.7319540207;17958.714003710047;18091.185896634684;18261.817381826277;18278.63442731138;433161;558143;587702;588089;588884;71598.64200678964;72527;72596.63701681458;72603.27396725965;72803.27196728071;1490.2623201515103;1497.0194522587722;1520.1639098495782;1524.9542513724828;1536.6312085099496;35294.82352588221;35941.82029089942;36236.27527449383;36692;36859.262814743015;58463;63110;65239;65328;69417.30582694108;525360;530963;531351;532545;533908;49029.50970490249;49182.508174919225;49505;49954;50051.24923126083;52394;53385.46614533805;53502.73248633732;54307.45692543024;55539;44686.55313446824;45777.54222457733;45966;46001.079978400914;47098.29352559783;44824.55175448204;46506.767466162455;46513;46979.53020469751;47692;39228.803855980535;44063;44456.555434446534;44484.77757611191;44683;37865.81067094647;39454.60545394509;39867.40198896961;42300.36549451699;42459;30912.53631195489;31089.222769430944;31334.595833748994;31420.214494637818;31853.20366990751 07:19:16 INFO - PROCESS | 24585 | |2;jquery.html;415.2421830159957;415.5553557693269;419.1805021183586;427.9957200427996;446.48208078628795;19108.90445547772;20286.28997985071;20819.791802081974;21903;22096.447588810246;18734.344297949574;19023.429297121074;19064.523386915334;19142.330018449356;20509.897450512763;5895.498882594974;6132.540059495534;6133.233345831771;6141.2937512186;6141.385861413867;5557.6109672322955;5817.389174136718;5926.051831706928;5955.791547295846;5956.970215148918;5750.7412166452405;5796.536277097843;5801.187833703285;5805.36141024487;5818.563607729416;5879.382664820175;5891.5286777057945;5965.254343207099;5988.640681559121;6133;5959.165716799652;5977.282726072855;6008.939910600881;6082.330943596201;6170.907436388457;14437;14739.705205895929;14748.705025899422;21939.341819745434;24928.875355623288;2406.554787364343;2474.6288056791445;2692.3538350795866;2809.2555472799722;2815.9014434494898;10423.278324341481;10794.622188223375;10985.121190304837;11410.543578256942;15033.323500442506;2002.149086638173;2005.1979208316643;2034.4506983114625;2043.2746375036945;2059.423361458794;81990.59004704998;84290.15709842945;86250;86554.5672271641;86935.56532217361;10111.292209545261;10427.374357538572;10837.783244335069;11652.53389864413;11727.589534366256;16562.254698538596;16734.079625620707;16769.664606707796;16813.15934203285;16824.74762878558;8446.957765211135;8610.956945215234;8866.162827895141;8978.775530611656;9115.772105697411;8562.828743425222;8595.026545947623;8630.913690863137;8822.51476168804;8837.867431988525;4899.510048995072;5100.591952643779;5118.360204974379;5118.795248190031;5233.058049551041;1965.7935916728538;2070.285751415759;2109.493721506827;2116.386247988097;2122.204173434962;959.4147569982305;1022.9181665466893;1031.4842578710645;1042.7080417483116;1085.880553139154;20175.192992280437;20712.689309660367;20806.271780487612;21003;21066.89466552688;1002.4937406609615;1062.4634559547533;1067.0076828549522;1083.6532309660834;1156.797560426922;10632.681019569425;11542.826857596974;11593.420328983517;11615.825762613567;11632.883671163348;239083;497884;499267;502520;505099;92587.53706231425;99581;100380;102168.48915755373;105279;1061.2624226162743;1075.956961721538;1109.3676604335612;1110.7945030169283;1124.4939777100337;16176.67646647084;18272;18669.626607468046;18763;19090.904545477184;44208.778956105016;45517.31724024208;45639.31541026953;47114.997639928275;47285;64479;65003;65688.34311656823;66210.66894665688;67250.65498690096;8791.736247912573;8845.911540884767;8897.688580899638;8944.150305720947;9061.41100828444;12449.439775209956;13788.310584470937;14086.36611352512;14165.079269847427;14378.424863005781;12071.637850864488;12281.815772763237;12522.561710340095;12598.937005314914;12640.178388404724;12328.506859725869;12334.444949977093;12426.937865310616;12473.313967731861;12590.307533085768;12293.139480236297;12335.938320308342;12439.502419903465;12511.56209532662;12542.482521832015;7703.922960770321;8158.796030099295;8852.424592401474;8882.15619516145;9060.275177985877;11934.462949167135;12045.819312710491;12291.56979505713;12486.250824950532;12546.498140074294 07:19:16 INFO - PROCESS | 24585 | |3;mootools.html;1295.9028072894532;1422.5732280315906;1427.4147599484213;1841.2082804394106;1852.3331600623774;8609.483430994145;9104.817903641931;9254.537273136333;9806.11744942956;9834.31159818813;9374.578143983521;9740.805183896318;9766.462844543546;9789.853152202722;9805.901940980588;2545.618157276405;2563.3976015636313;2565.0252903896585;2575.4591535777417;2588.9093881714143;2512.5351809915223;2600.8569528675916;2603.648507451498;2605.817592768507;2607.569750991084;2526;2550.693916729995;2594.4940736556377;2595.4419799743146;2596.117320111162;2480.8635525046116;2488.9004439822475;2522.533331333709;2534.6831646044243;2552.0429838810446;2463.8521688698734;2479.6280557916275;2489.7012358517095;2498.0757119865584;2527.2797252783052;9702.660406885725;9866.950665246628;9868.259880508991;9874.60501579936;9887.90112098877;5636.351819540764;5792.218050563162;5801.535877129862;5808.244928159313;5819.359870414293;3743.5320584926885;3799.088218827489;3826.712996525244;3840.116773142193;3900.0834803821363;1279.891209247215;1308.2019967819622;1309.3126108792865;1323.5499930023839;1325.1121748428577;13541.661458463519;13587.116837405636;13624.93187534056;13686.452541898312;13748.106373085717;4854.757262136879;4924.8276310328965;5040.873978150576;5106.208537676666;5244.344456942882;11405.657830265105;11407.600733974272;11435.485403156712;11519.539218431337;11520.423978801027;5872.060470324727;5875.823725288163;5878.088896221093;5880.176775251468;5888.558358123158;4755.548222918817;5205.167173252262;5278.630495865329;5321.361436627552;5393.056215162331;4308.827646894089;4351.36905148758;4438.911221775546;4443.822247110079;4456.598906098402;1367.3710093357167;1373.1623709537175;1374.7181827725292;1384.9515266965607;1405.128820131525;1062.7608788022633;1067.1889364083197;1087.5377964365114;1099.780043991205;1101.2731597145846;6250.937490625036;6477.4170324671;6574.408303252731;6658.349136640325;6713.26154123046;485.1727804094082;494.70812220789907;497.8680649627851;499.19878594854737;512.5028722139518;4515.571020753023;4584.633229341644;4614.031053478807;4639.512851150648;4699.177643912301;11912.940435297767;12170.695732606579;12306.81539776904;12385.19496232742;12393.690157745948;11378.601748938747;11672.824907626393;12169.33068681231;12280.07899407548;12323.568675096509;8784.648614055366;8904.910950890408;8915.37592368541;8943.150400711791;8945.105489451003;6688.899666505104;6732.293109223657;6791.93208067913;6805.659717014229;6876.484263680144;10613.310134841211;10769.299995500267;11264.15518836107;11379.601713939972;11462.140339474407;11149.832752508557;11243.381614011309;11287.040601548631;11319.830202547133;11418.0865530759;7714.652840622298;8487.108853570286;8583.742487725378;8667.349948753996;8794.956025219833;9589.472579008221;9642.084002019797;9658.75853103678;9697.418154910727;9736.172425343924;8239.629216685144;8313.127121652382;8369.581520923808;8536.231739143506;8558.914410855812;8186.508809471451;8233.094359620318;8256.463329883538;8274.213949674771;8375.874361884698;7760.30157285847;7791.4935529190425;7809.648565814666;7899.68401263943;7915.05019397676;5663.461971112738;5826.155207494974;5842.152887831326;5884.735186916685;5897.410258974069;5836.883262334814;5846.210761547137;5904.380040095728;5955.940440595538;5990.131430942576 07:19:16 INFO - PROCESS | 24585 | |4;prototype.html;350.8701780341273;355.44727948040793;367.8914720157555;369.6340622783445;373.8654084529569;5837.387074357195;5865.472107510323;5871.3853690235155;5884.882302353951;5939.64362138272;5550.2784637997;5760.164776107462;5780.913286300709;5786.739596718147;5794.261721483559;4504.414426124599;4534.7099714644055;4545.6136228420455;4569.520200378962;4573.794179261941;4558.931616025762;4572.634189264851;4583.175028494869;4589.632829373642;4600.884977875547;4452.465704115511;4521.344405061264;4558.6581006424485;4574.313852922055;4577.176108300505;4505.963628365478;4526;4534.433195850519;4548.363229147889;4554.63562914966;4014.0767623446477;4014.6186112319283;4016.7991600419864;4021.77880216588;4025.5974402559805;5582.720863956826;5614.073677843151;5643.435656434365;5656.264685590888;5693.259876216107;5214.165733482662;5240.296903506376;5243.213517972296;5251.474852514756;5258.81594144207;6081.361457046991;6081.905257053729;6095.299040610343;6126.356732543063;6182.752689892399;4263.893402664927;4411.669124815651;4436.889077773049;4446.910506925791;4461.773012421578;6170.796694644546;6310.716017779165;6332.303446620868;6333.36666333363;6359;4464.374987501752;4488.551144885485;4488.977555112204;4517.977410112929;4548.204064288736;4516;4563.817447302137;4579.748113853703;4586.88532786683;4595.839145629954;5033.84898453047;5176.275321454999;5233.581313494911;5233.685978841282;5240.6069544784295;6112.297085835097;6119.5521791283845;6133.509319254449;6147.600405973598;6153.8461538461;1542.8919975601825;1567;1569.7331453652907;1574.4725516951721;1575.3698520591627;957.7461972577272;990.7869807991173;998.5756053677159;1010.6159659329408;1017.5522769981185;5186.611004174702;5241.985858131589;5269.314989051399;5288.338957630296;5293.814716484904;5364.022967253212;5466.72666366688;5499.312585926759;5540.36285827127;5580.525655319262;4954.603631709455;5216.26972223889;5224.582033437316;5233.790648374023;5311.893762124813;2906.346072133753;2934.987429336918;2948.6461624604754;2954.640865201988;2956.1427186116216;5635.900999305096;5670.901766346478;5694.9430505695245;5699.458551437607;5703.315602127771;5943.286805583358;6420.881109234035;6429.421352078335;6448.710257948429;6468.514861385415;6404.583702059351;6426.389492998158;6487;6499.252585952676;6502.674866256668;6077.4834139098675;6214.8135555933395;6291.96854015727;6293.465055470337;6315.494760419064;6192.225971753531;6202.751889924352;6228.283747369111;6243.906341404973;6287.528435367274;6135.723892424762;6245.375462453719;6344.460720838781;6408.61548307103;6422.165118534561;4542.409486766699;4605.861824145281;4614.400127983341;4615.907681846412;4619.69971951822;6132.264128304632;6213.347598502092;6244.843878903063;6338.397852204033;6369.426751592379;6038.580933480541;6063.361982810278;6067.392141082705;6086.817395478142;6105.358937311518;5915.792947246826;6035.879282414415;6064.090386441892;6066.848328791815;6122.969385153046;5955.225820643289;5979.820605381846;6010.188624535806;6018.969905150446;6043.3352331244405;6064.848378790565;6081.057436097412;6113.724882380215;6117.755289788359;6118.296395914527;5750.396208398225;5916.230889984447;5950;5950.9404905952115;5953.719950210725 07:19:16 INFO - PROCESS | 24585 | |5;yui.html;736.0946036375261;767.800371903305;810.4084018666373;883.6907082521117;926.6617684545134;16145.43490977816;16880.32478700852;16905.408310709114;16925.7461138083;16945.152742362865;15229.543113706606;15270.923645381785;15293.84706152938;15298.388064477407;15393.153376564313;733.9633018349087;868.5006121480159;869.9782505437352;878.9208971192592;889.1064480197392;882.1002577371078;884.8716936044269;885.8981217160044;886.1935638568904;890.3989806880362;938.7840796616782;939.8590211468266;940.4028441939383;941.3034354577597;942.0108885670053;915.2174890468686;926.8609708543738;929.256594724218;932.2588542109039;932.5616960028775;682.6245564939313;684.5858255755296;685.9128281673553;686.2211390072254;689.8516818883965;14320.498782542665;14421.78367324491;14448.422063117463;14479.855201447956;14637.194954277511;15572.688546229125;16126;16126.113063781488;16218.351265949348;16223.432179873647;13275.73448531024;13473.124246923919;13550.322483875767;13606.047576669636;13723.45106195751;4064.1058967027207;4095.9180816383805;4114.423980642712;4149.481314835645;4170.4995400551825;89699.10300896973;90867.09132908653;92899.53550232273;94295;97426;11856.585019524275;11923.523059077714;12103.213291136048;12227.633171004883;12349.073819463576;21942.122315107536;21970.45073873166;22029.559408812056;22045.448863778533;22091.558168836855;8682.175148796225;8786.824263514694;9098.135677110664;9159.587818548182;9233.630654773733;5040.79836806531;5101.897962040738;5130.563902068291;5184.455632158644;5230.503102205284;3924.9215015700097;4023.155137421116;4032.9798351008058;4040.4949381327333;4054.493188351456;699.5907394174465;702.0872865275223;708.0476758759461;715.3740477082553;716.5915428205873;732.5018987088831;768.8885111658778;849.2229609906866;850.3409857360595;866.3545658484469;10149.493268344839;10221.591136354462;10670.73323166927;11046.834297485544;11459.541618335339;659.423004870738;689.3141324382271;802.6428239433396;810.7810891059498;819.6311659753015;5085.186370180753;5165.819196328186;5223.190405487156;5342.839714808484;5346.572274218053;77318.61340693373;94333.5283323579;136427;138323.30838345946;141169.29415352858;102204.48897755463;113934.43032784783;115498.42250788861;117694;120207;99529.50235248922;100856.49571752241;101623.49188254011;102590.48704756428;103582;10008.79894412646;10098.293119481566;10183.287169898036;10222.948885255526;10256.02672450316;59626;60739;61301.693491532256;61416.45939978112;61446;49975.25037124373;51085.23372149347;65895.67052164709;86243;88941;12870.742585148057;12890.548830790878;13190.472381104648;13232.272225027331;13382.263975481443;14254.501092461715;14345.569632911029;14523.273836308354;14667.48663796762;15430.5370838875;13043.673908152372;13651.453941842612;13717.931410342884;14157.07978981404;14545.490907818175;12399.25604463735;12676.87323126757;13104.279264640156;13975.371108299947;14026.509072182425;13029.543965961146;13943.51197708116;13977.091489053179;14125.293735313398;14251.928740356232;10993.945030274797;11406.828897566376;11489.712757181138;12133.69665758363;12181.149968009362;11971;12055.276683399024;12166;12482.188657737219;12495.812562811747 07:19:16 INFO - PROCESS | 24585 | __end_tp_report 07:19:16 INFO - PROCESS | 24585 | __start_cc_report 07:19:16 INFO - PROCESS | 24585 | _x_x_mozilla_cycle_collect,321 07:19:16 INFO - PROCESS | 24585 | __end_cc_report 07:19:16 INFO - PROCESS | 24585 | __startTimestamp1472739556875__endTimestamp 07:19:16 INFO - PROCESS | 24585 | 07:19:16 INFO - PROCESS | 24585 | ------- Summary: start ------- 07:19:16 INFO - PROCESS | 24585 | Number of tests: 6 07:19:16 INFO - PROCESS | 24585 | 07:19:16 INFO - PROCESS | 24585 | [#0] dojo.html Cycles:165 Average:5870.04 Median:6121.76 stddev:680.90 (11.1%) stddev-sans-first:653.63 07:19:16 INFO - PROCESS | 24585 | Values: 3348.9 3364.5 3377.4 3391.6 3401.2 5866.1 5938.3 5939.3 5952.6 5974.6 5831.9 5859.6 5880.4 5888.1 5919.1 5293.4 5332.4 5358.1 5423.3 5434.5 5177.7 5194.2 5214.3 5308.9 5322.2 5346.7 5367.9 5368.5 5370.4 5409.4 5435.5 5442.6 5444.2 5458.4 5491.9 5146.1 5204.6 5219.5 5354.5 5359.5 5804.3 5822.3 5861.6 5864.4 5943.8 6245.3 6297.8 6307.7 6319.8 6345.3 6124.5 6225.6 6268.5 6301.4 6361.1 5930.4 5932.4 5949.9 5951.0 5954.3 6441.1 6465.8 6471.4 6503.8 6519.5 6063.1 6108.7 6133.0 6250.8 6269.7 6298.6 6318.1 6320.7 6323.8 6353.9 6317.3 6326.5 6327.1 6331.9 6336.0 6078.6 6141.7 6191.2 6299.4 6303.8 4806.2 4811.9 4812.2 4812.7 4842.9 4281.3 4284.7 4291.8 4303.6 4315.8 5862.1 5982.1 6006.4 6023.7 6103.5 6402.7 6428.3 6429.7 6446.9 6448.2 6112.1 6118.4 6134.8 6141.8 6145.9 5293.4 5432.6 5460.2 5518.8 5546.4 6568.5 6571.8 6572.8 6585.6 6598.9 6414.0 6440.1 6446.6 6450.6 6464.1 6273.3 6408.8 6415.5 6517.2 6601.4 6267.7 6276.2 6281.3 6292.5 6299.6 6322.9 6388.8 6391.7 6400.5 6413.4 6017.6 6116.9 6141.6 6251.8 6262.8 6126.7 6154.8 6159.7 6176.8 6180.5 6098.0 6133.4 6140.1 6148.7 6178.1 5996.5 6104.9 6179.0 6193.0 6229.9 6076.6 6119.6 6121.8 6123.1 6140.6 07:19:16 INFO - PROCESS | 24585 | 07:19:16 INFO - PROCESS | 24585 | [#1] ext.html Cycles:180 Average:67293.44 Median:25281.24 stddev:131522.03 (520.2%) stddev-sans-first:131795.59 07:19:16 INFO - PROCESS | 24585 | Values: 577.6 649.0 661.4 670.2 718.4 43276.0 47064.3 47414.8 47476.0 47603.5 47409.1 47478.3 47918.3 47952.8 48060.8 9038.6 9155.3 9171.8 9182.1 9212.9 9124.7 9153.9 9160.3 9167.1 9188.0 9274.7 9286.6 9289.7 9323.3 9339.3 9130.4 9215.7 9255.9 9260.6 9265.2 9123.2 9128.4 9177.4 9204.6 9213.0 45088.0 45238.5 45344.5 45354.8 45467.3 3194.0 3784.4 3801.4 3966.1 4026.0 35589.9 35861.3 36009.8 36212.6 36235.3 4596.5 4782.9 4815.3 4835.5 4871.1 384336.0 385824.0 387296.0 388407.0 390375.0 72606.3 74001.0 74003.3 74208.6 74250.6 41187.0 41588.8 41858.8 44200.8 44362.6 19815.1 20136.7 20136.9 20157.2 20244.9 14448.4 14502.7 14637.8 14645.0 14659.0 22535.9 22703.7 22826.2 22952.0 22978.8 7815.2 7890.9 8095.0 8095.3 8250.4 1004.4 1052.7 1065.1 1074.9 1100.5 34189.5 34613.3 34697.7 34927.5 35732.0 1158.3 1182.6 1188.6 1257.7 1278.5 17869.7 17958.7 18091.2 18261.8 18278.6 433161.0 558143.0 587702.0 588089.0 588884.0 71598.6 72527.0 72596.6 72603.3 72803.3 1490.3 1497.0 1520.2 1525.0 1536.6 35294.8 35941.8 36236.3 36692.0 36859.3 58463.0 63110.0 65239.0 65328.0 69417.3 525360.0 530963.0 531351.0 532545.0 533908.0 49029.5 49182.5 49505.0 49954.0 50051.2 52394.0 53385.5 53502.7 54307.5 55539.0 44686.6 45777.5 45966.0 46001.1 47098.3 44824.6 46506.8 46513.0 46979.5 47692.0 39228.8 44063.0 44456.6 44484.8 44683.0 37865.8 39454.6 39867.4 42300.4 42459.0 30912.5 31089.2 31334.6 31420.2 31853.2 07:19:16 INFO - PROCESS | 24585 | 07:19:16 INFO - PROCESS | 24585 | [#2] jquery.html Cycles:180 Average:28810.26 Median:2112.94 stddev:76616.63 (3626.1%) stddev-sans-first:76801.90 07:19:16 INFO - PROCESS | 24585 | Values: 415.2 415.6 419.2 428.0 446.5 19108.9 20286.3 20819.8 21903.0 22096.4 18734.3 19023.4 19064.5 19142.3 20509.9 5895.5 6132.5 6133.2 6141.3 6141.4 5557.6 5817.4 5926.1 5955.8 5957.0 5750.7 5796.5 5801.2 5805.4 5818.6 5879.4 5891.5 5965.3 5988.6 6133.0 5959.2 5977.3 6008.9 6082.3 6170.9 14437.0 14739.7 14748.7 21939.3 24928.9 2406.6 2474.6 2692.4 2809.3 2815.9 10423.3 10794.6 10985.1 11410.5 15033.3 2002.1 2005.2 2034.5 2043.3 2059.4 81990.6 84290.2 86250.0 86554.6 86935.6 10111.3 10427.4 10837.8 11652.5 11727.6 16562.3 16734.1 16769.7 16813.2 16824.7 8447.0 8611.0 8866.2 8978.8 9115.8 8562.8 8595.0 8630.9 8822.5 8837.9 4899.5 5100.6 5118.4 5118.8 5233.1 1965.8 2070.3 2109.5 2116.4 2122.2 959.4 1022.9 1031.5 1042.7 1085.9 20175.2 20712.7 20806.3 21003.0 21066.9 1002.5 1062.5 1067.0 1083.7 1156.8 10632.7 11542.8 11593.4 11615.8 11632.9 239083.0 497884.0 499267.0 502520.0 505099.0 92587.5 99581.0 100380.0 102168.5 105279.0 1061.3 1076.0 1109.4 1110.8 1124.5 16176.7 18272.0 18669.6 18763.0 19090.9 44208.8 45517.3 45639.3 47115.0 47285.0 64479.0 65003.0 65688.3 66210.7 67250.7 8791.7 8845.9 8897.7 8944.2 9061.4 12449.4 13788.3 14086.4 14165.1 14378.4 12071.6 12281.8 12522.6 12598.9 12640.2 12328.5 12334.4 12426.9 12473.3 12590.3 12293.1 12335.9 12439.5 12511.6 12542.5 7703.9 8158.8 8852.4 8882.2 9060.3 11934.5 12045.8 12291.6 12486.3 12546.5 07:19:16 INFO - PROCESS | 24585 | 07:19:16 INFO - PROCESS | 24585 | [#3] mootools.html Cycles:180 Average:6399.30 Median:2620.36 stddev:3669.50 (140.0%) stddev-sans-first:3659.75 07:19:16 INFO - PROCESS | 24585 | Values: 1295.9 1422.6 1427.4 1841.2 1852.3 8609.5 9104.8 9254.5 9806.1 9834.3 9374.6 9740.8 9766.5 9789.9 9805.9 2545.6 2563.4 2565.0 2575.5 2588.9 2512.5 2600.9 2603.6 2605.8 2607.6 2526.0 2550.7 2594.5 2595.4 2596.1 2480.9 2488.9 2522.5 2534.7 2552.0 2463.9 2479.6 2489.7 2498.1 2527.3 9702.7 9867.0 9868.3 9874.6 9887.9 5636.4 5792.2 5801.5 5808.2 5819.4 3743.5 3799.1 3826.7 3840.1 3900.1 1279.9 1308.2 1309.3 1323.5 1325.1 13541.7 13587.1 13624.9 13686.5 13748.1 4854.8 4924.8 5040.9 5106.2 5244.3 11405.7 11407.6 11435.5 11519.5 11520.4 5872.1 5875.8 5878.1 5880.2 5888.6 4755.5 5205.2 5278.6 5321.4 5393.1 4308.8 4351.4 4438.9 4443.8 4456.6 1367.4 1373.2 1374.7 1385.0 1405.1 1062.8 1067.2 1087.5 1099.8 1101.3 6250.9 6477.4 6574.4 6658.3 6713.3 485.2 494.7 497.9 499.2 512.5 4515.6 4584.6 4614.0 4639.5 4699.2 11912.9 12170.7 12306.8 12385.2 12393.7 11378.6 11672.8 12169.3 12280.1 12323.6 8784.6 8904.9 8915.4 8943.2 8945.1 6688.9 6732.3 6791.9 6805.7 6876.5 10613.3 10769.3 11264.2 11379.6 11462.1 11149.8 11243.4 11287.0 11319.8 11418.1 7714.7 8487.1 8583.7 8667.3 8795.0 9589.5 9642.1 9658.8 9697.4 9736.2 8239.6 8313.1 8369.6 8536.2 8558.9 8186.5 8233.1 8256.5 8274.2 8375.9 7760.3 7791.5 7809.6 7899.7 7915.1 5663.5 5826.2 5842.2 5884.7 5897.4 5836.9 5846.2 5904.4 5955.9 5990.1 07:19:16 INFO - PROCESS | 24585 | 07:19:16 INFO - PROCESS | 24585 | [#4] prototype.html Cycles:180 Average:5054.45 Median:5639.67 stddev:1482.96 (26.3%) stddev-sans-first:1444.49 07:19:16 INFO - PROCESS | 24585 | Values: 350.9 355.4 367.9 369.6 373.9 5837.4 5865.5 5871.4 5884.9 5939.6 5550.3 5760.2 5780.9 5786.7 5794.3 4504.4 4534.7 4545.6 4569.5 4573.8 4558.9 4572.6 4583.2 4589.6 4600.9 4452.5 4521.3 4558.7 4574.3 4577.2 4506.0 4526.0 4534.4 4548.4 4554.6 4014.1 4014.6 4016.8 4021.8 4025.6 5582.7 5614.1 5643.4 5656.3 5693.3 5214.2 5240.3 5243.2 5251.5 5258.8 6081.4 6081.9 6095.3 6126.4 6182.8 4263.9 4411.7 4436.9 4446.9 4461.8 6170.8 6310.7 6332.3 6333.4 6359.0 4464.4 4488.6 4489.0 4518.0 4548.2 4516.0 4563.8 4579.7 4586.9 4595.8 5033.8 5176.3 5233.6 5233.7 5240.6 6112.3 6119.6 6133.5 6147.6 6153.8 1542.9 1567.0 1569.7 1574.5 1575.4 957.7 990.8 998.6 1010.6 1017.6 5186.6 5242.0 5269.3 5288.3 5293.8 5364.0 5466.7 5499.3 5540.4 5580.5 4954.6 5216.3 5224.6 5233.8 5311.9 2906.3 2935.0 2948.6 2954.6 2956.1 5635.9 5670.9 5694.9 5699.5 5703.3 5943.3 6420.9 6429.4 6448.7 6468.5 6404.6 6426.4 6487.0 6499.3 6502.7 6077.5 6214.8 6292.0 6293.5 6315.5 6192.2 6202.8 6228.3 6243.9 6287.5 6135.7 6245.4 6344.5 6408.6 6422.2 4542.4 4605.9 4614.4 4615.9 4619.7 6132.3 6213.3 6244.8 6338.4 6369.4 6038.6 6063.4 6067.4 6086.8 6105.4 5915.8 6035.9 6064.1 6066.8 6123.0 5955.2 5979.8 6010.2 6019.0 6043.3 6064.8 6081.1 6113.7 6117.8 6118.3 5750.4 5916.2 5950.0 5950.9 5953.7 07:19:16 INFO - PROCESS | 24585 | 07:19:16 INFO - PROCESS | 24585 | [#5] yui.html Cycles:180 Average:22609.56 Median:22068.50 stddev:33511.90 (151.9%) stddev-sans-first:33565.67 07:19:16 INFO - PROCESS | 24585 | Values: 736.1 767.8 810.4 883.7 926.7 16145.4 16880.3 16905.4 16925.7 16945.2 15229.5 15270.9 15293.8 15298.4 15393.2 734.0 868.5 870.0 878.9 889.1 882.1 884.9 885.9 886.2 890.4 938.8 939.9 940.4 941.3 942.0 915.2 926.9 929.3 932.3 932.6 682.6 684.6 685.9 686.2 689.9 14320.5 14421.8 14448.4 14479.9 14637.2 15572.7 16126.0 16126.1 16218.4 16223.4 13275.7 13473.1 13550.3 13606.0 13723.5 4064.1 4095.9 4114.4 4149.5 4170.5 89699.1 90867.1 92899.5 94295.0 97426.0 11856.6 11923.5 12103.2 12227.6 12349.1 21942.1 21970.5 22029.6 22045.4 22091.6 8682.2 8786.8 9098.1 9159.6 9233.6 5040.8 5101.9 5130.6 5184.5 5230.5 3924.9 4023.2 4033.0 4040.5 4054.5 699.6 702.1 708.0 715.4 716.6 732.5 768.9 849.2 850.3 866.4 10149.5 10221.6 10670.7 11046.8 11459.5 659.4 689.3 802.6 810.8 819.6 5085.2 5165.8 5223.2 5342.8 5346.6 77318.6 94333.5 136427.0 138323.3 141169.3 102204.5 113934.4 115498.4 117694.0 120207.0 99529.5 100856.5 101623.5 102590.5 103582.0 10008.8 10098.3 10183.3 10222.9 10256.0 59626.0 60739.0 61301.7 61416.5 61446.0 49975.3 51085.2 65895.7 86243.0 88941.0 12870.7 12890.5 13190.5 13232.3 13382.3 14254.5 14345.6 14523.3 14667.5 15430.5 13043.7 13651.5 13717.9 14157.1 14545.5 12399.3 12676.9 13104.3 13975.4 14026.5 13029.5 13943.5 13977.1 14125.3 14251.9 10993.9 11406.8 11489.7 12133.7 12181.1 11971.0 12055.3 12166.0 12482.2 12495.8 07:19:16 INFO - PROCESS | 24585 | -------- Summary: end -------- 07:19:16 INFO - PROCESS | 24585 | 07:19:17 INFO - TEST-INFO | 24585: exit 0 07:19:17 INFO - TEST-OK | dromaeo_css | took 1111314ms 07:19:17 INFO - TEST-START | kraken 07:19:17 INFO - operating with platform_type : linux_ 07:19:17 INFO - Initialising browser for kraken test... 07:19:17 INFO - TEST-INFO | started process 24848 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8WxvZh/profile http://localhost:52281/getInfo.html) 07:19:22 INFO - PROCESS | 24848 | __metrics Screen width/height:1600/1200 07:19:22 INFO - PROCESS | 24848 | colorDepth:24 07:19:22 INFO - PROCESS | 24848 | Browser inner width/height: 1024/697 07:19:22 INFO - PROCESS | 24848 | __metrics 07:19:22 ERROR - PROCESS | 24848 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 07:19:23 INFO - TEST-INFO | 24848: exit 0 07:19:23 INFO - Browser initialized. 07:19:23 INFO - Running cycle 1/1 for kraken test... 07:19:23 INFO - TEST-INFO | started process 24979 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8WxvZh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:19:35 INFO - PROCESS | 24979 | RSS: Main: 152715264 07:19:35 INFO - PROCESS | 24979 | 07:19:38 INFO - PROCESS | 24979 | Cycle 1(1): loaded http://localhost:52281/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52281/tests/kraken/driver.html?testName=audio-beat-detection) 07:19:38 INFO - PROCESS | 24979 | RSS: Main: 157859840 07:19:38 INFO - PROCESS | 24979 | 07:19:41 INFO - PROCESS | 24979 | Cycle 1(1): loaded http://localhost:52281/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52281/tests/kraken/driver.html?testName=audio-dft) 07:19:42 INFO - PROCESS | 24979 | RSS: Main: 156356608 07:19:42 INFO - PROCESS | 24979 | 07:19:44 INFO - PROCESS | 24979 | Cycle 1(1): loaded http://localhost:52281/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52281/tests/kraken/driver.html?testName=audio-fft) 07:19:45 INFO - PROCESS | 24979 | RSS: Main: 157405184 07:19:45 INFO - PROCESS | 24979 | 07:19:47 INFO - PROCESS | 24979 | Cycle 1(1): loaded http://localhost:52281/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52281/tests/kraken/driver.html?testName=audio-oscillator) 07:19:48 INFO - PROCESS | 24979 | RSS: Main: 157081600 07:19:48 INFO - PROCESS | 24979 | 07:19:50 INFO - PROCESS | 24979 | Cycle 1(1): loaded http://localhost:52281/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52281/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:19:51 INFO - PROCESS | 24979 | RSS: Main: 157143040 07:19:51 INFO - PROCESS | 24979 | 07:19:54 INFO - PROCESS | 24979 | Cycle 1(1): loaded http://localhost:52281/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52281/tests/kraken/driver.html?testName=imaging-darkroom) 07:19:54 INFO - PROCESS | 24979 | RSS: Main: 156483584 07:19:54 INFO - PROCESS | 24979 | 07:19:58 INFO - PROCESS | 24979 | Cycle 1(1): loaded http://localhost:52281/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52281/tests/kraken/driver.html?testName=imaging-desaturate) 07:19:58 INFO - PROCESS | 24979 | RSS: Main: 155566080 07:19:58 INFO - PROCESS | 24979 | 07:20:01 INFO - PROCESS | 24979 | Cycle 1(1): loaded http://localhost:52281/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52281/tests/kraken/driver.html?testName=json-parse-financial) 07:20:02 INFO - PROCESS | 24979 | RSS: Main: 156721152 07:20:02 INFO - PROCESS | 24979 | 07:20:03 INFO - PROCESS | 24979 | Cycle 1(1): loaded http://localhost:52281/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52281/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:20:04 INFO - PROCESS | 24979 | RSS: Main: 156712960 07:20:04 INFO - PROCESS | 24979 | 07:20:06 INFO - PROCESS | 24979 | Cycle 1(1): loaded http://localhost:52281/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52281/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:20:06 INFO - PROCESS | 24979 | RSS: Main: 156766208 07:20:06 INFO - PROCESS | 24979 | 07:20:08 INFO - PROCESS | 24979 | Cycle 1(1): loaded http://localhost:52281/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52281/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:20:09 INFO - PROCESS | 24979 | RSS: Main: 157192192 07:20:09 INFO - PROCESS | 24979 | 07:20:12 INFO - PROCESS | 24979 | Cycle 1(1): loaded http://localhost:52281/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:20:12 INFO - PROCESS | 24979 | RSS: Main: 157442048 07:20:12 INFO - PROCESS | 24979 | 07:20:15 INFO - PROCESS | 24979 | Cycle 1(1): loaded http://localhost:52281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:20:16 INFO - PROCESS | 24979 | RSS: Main: 157495296 07:20:16 INFO - PROCESS | 24979 | 07:20:17 INFO - PROCESS | 24979 | Cycle 1(1): loaded http://localhost:52281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52281/tests/kraken/driver.html?testName=ai-astar) 07:20:17 INFO - PROCESS | 24979 | RSS: Main: 158380032 07:20:17 INFO - PROCESS | 24979 | 07:20:17 INFO - PROCESS | 24979 | __start_tp_report 07:20:17 INFO - PROCESS | 24979 | _x_x_mozilla_page_load 07:20:17 INFO - PROCESS | 24979 | _x_x_mozilla_page_load_details 07:20:17 INFO - PROCESS | 24979 | |i|pagename|runs| 07:20:17 INFO - PROCESS | 24979 | |0;ai-astar;99;110;104;110;111;111;110;110;110;111 07:20:17 INFO - PROCESS | 24979 | |1;audio-beat-detection;148;117;147;176;118;156;143;117;171;122 07:20:17 INFO - PROCESS | 24979 | |2;audio-dft;162;162;162;162;162;161;162;165;162;161 07:20:17 INFO - PROCESS | 24979 | |3;audio-fft;76;73;77;183;76;75;75;74;169;75 07:20:17 INFO - PROCESS | 24979 | |4;audio-oscillator;84;85;150;83;82;84;151;84;83;142 07:20:17 INFO - PROCESS | 24979 | |5;imaging-gaussian-blur;119;118;119;118;119;118;117;117;118;118 07:20:17 INFO - PROCESS | 24979 | |6;imaging-darkroom;148;149;149;148;148;150;147;147;149;147 07:20:17 INFO - PROCESS | 24979 | |7;imaging-desaturate;96;96;97;95;96;95;96;96;96;95 07:20:17 INFO - PROCESS | 24979 | |8;json-parse-financial;52;51;51;50;60;51;54;51;50;54 07:20:17 INFO - PROCESS | 24979 | |9;json-stringify-tinderbox;59;61;59;59;60;60;59;60;59;58 07:20:17 INFO - PROCESS | 24979 | |10;stanford-crypto-aes;78;72;80;73;71;73;73;72;76;72 07:20:17 INFO - PROCESS | 24979 | |11;stanford-crypto-ccm;123;133;121;125;140;130;122;118;155;121 07:20:17 INFO - PROCESS | 24979 | |12;stanford-crypto-pbkdf2;162;157;155;154;155;154;156;162;156;154 07:20:17 INFO - PROCESS | 24979 | |13;stanford-crypto-sha256-iterative;63;62;62;65;63;62;61;63;60;60 07:20:17 INFO - PROCESS | 24979 | __end_tp_report 07:20:17 INFO - PROCESS | 24979 | __start_cc_report 07:20:17 INFO - PROCESS | 24979 | _x_x_mozilla_cycle_collect,851 07:20:17 INFO - PROCESS | 24979 | __end_cc_report 07:20:17 INFO - PROCESS | 24979 | __startTimestamp1472739617952__endTimestamp 07:20:17 INFO - PROCESS | 24979 | 07:20:17 INFO - PROCESS | 24979 | ------- Summary: start ------- 07:20:17 INFO - PROCESS | 24979 | Number of tests: 14 07:20:17 INFO - PROCESS | 24979 | 07:20:17 INFO - PROCESS | 24979 | [#0] ai-astar Cycles:10 Average:108.60 Median:110.50 stddev:3.95 (3.6%) stddev-sans-first:2.18 07:20:17 INFO - PROCESS | 24979 | Values: 99.0 110.0 104.0 110.0 111.0 111.0 110.0 110.0 110.0 111.0 07:20:17 INFO - PROCESS | 24979 | 07:20:17 INFO - PROCESS | 24979 | [#1] audio-beat-detection Cycles:10 Average:141.50 Median:147.50 stddev:22.31 (15.1%) stddev-sans-first:23.54 07:20:17 INFO - PROCESS | 24979 | Values: 148.0 117.0 147.0 176.0 118.0 156.0 143.0 117.0 171.0 122.0 07:20:17 INFO - PROCESS | 24979 | 07:20:17 INFO - PROCESS | 24979 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:1.10 (0.7%) stddev-sans-first:1.17 07:20:17 INFO - PROCESS | 24979 | Values: 162.0 162.0 162.0 162.0 162.0 161.0 162.0 165.0 162.0 161.0 07:20:17 INFO - PROCESS | 24979 | 07:20:17 INFO - PROCESS | 24979 | [#3] audio-fft Cycles:10 Average:95.30 Median:75.00 stddev:42.67 (56.9%) stddev-sans-first:44.69 07:20:17 INFO - PROCESS | 24979 | Values: 76.0 73.0 77.0 183.0 76.0 75.0 75.0 74.0 169.0 75.0 07:20:17 INFO - PROCESS | 24979 | 07:20:17 INFO - PROCESS | 24979 | [#4] audio-oscillator Cycles:10 Average:102.80 Median:83.50 stddev:31.06 (37.2%) stddev-sans-first:32.19 07:20:17 INFO - PROCESS | 24979 | Values: 84.0 85.0 150.0 83.0 82.0 84.0 151.0 84.0 83.0 142.0 07:20:17 INFO - PROCESS | 24979 | 07:20:17 INFO - PROCESS | 24979 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:0.74 (0.6%) stddev-sans-first:0.71 07:20:17 INFO - PROCESS | 24979 | Values: 119.0 118.0 119.0 118.0 119.0 118.0 117.0 117.0 118.0 118.0 07:20:17 INFO - PROCESS | 24979 | 07:20:17 INFO - PROCESS | 24979 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.50 stddev:1.03 (0.7%) stddev-sans-first:1.09 07:20:17 INFO - PROCESS | 24979 | Values: 148.0 149.0 149.0 148.0 148.0 150.0 147.0 147.0 149.0 147.0 07:20:17 INFO - PROCESS | 24979 | 07:20:17 INFO - PROCESS | 24979 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 07:20:17 INFO - PROCESS | 24979 | Values: 96.0 96.0 97.0 95.0 96.0 95.0 96.0 96.0 96.0 95.0 07:20:17 INFO - PROCESS | 24979 | 07:20:17 INFO - PROCESS | 24979 | [#8] json-parse-financial Cycles:10 Average:52.40 Median:51.50 stddev:3.03 (5.9%) stddev-sans-first:3.21 07:20:17 INFO - PROCESS | 24979 | Values: 52.0 51.0 51.0 50.0 60.0 51.0 54.0 51.0 50.0 54.0 07:20:17 INFO - PROCESS | 24979 | 07:20:17 INFO - PROCESS | 24979 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.50 stddev:0.84 (1.4%) stddev-sans-first:0.88 07:20:17 INFO - PROCESS | 24979 | Values: 59.0 61.0 59.0 59.0 60.0 60.0 59.0 60.0 59.0 58.0 07:20:17 INFO - PROCESS | 24979 | 07:20:17 INFO - PROCESS | 24979 | [#10] stanford-crypto-aes Cycles:10 Average:74.00 Median:73.00 stddev:2.98 (4.1%) stddev-sans-first:2.79 07:20:17 INFO - PROCESS | 24979 | Values: 78.0 72.0 80.0 73.0 71.0 73.0 73.0 72.0 76.0 72.0 07:20:17 INFO - PROCESS | 24979 | 07:20:17 INFO - PROCESS | 24979 | [#11] stanford-crypto-ccm Cycles:10 Average:128.80 Median:127.50 stddev:11.37 (8.9%) stddev-sans-first:11.86 07:20:17 INFO - PROCESS | 24979 | Values: 123.0 133.0 121.0 125.0 140.0 130.0 122.0 118.0 155.0 121.0 07:20:17 INFO - PROCESS | 24979 | 07:20:17 INFO - PROCESS | 24979 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.50 Median:156.00 stddev:3.06 (2.0%) stddev-sans-first:2.52 07:20:17 INFO - PROCESS | 24979 | Values: 162.0 157.0 155.0 154.0 155.0 154.0 156.0 162.0 156.0 154.0 07:20:17 INFO - PROCESS | 24979 | 07:20:17 INFO - PROCESS | 24979 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.10 Median:62.50 stddev:1.52 (2.4%) stddev-sans-first:1.58 07:20:17 INFO - PROCESS | 24979 | Values: 63.0 62.0 62.0 65.0 63.0 62.0 61.0 63.0 60.0 60.0 07:20:17 INFO - PROCESS | 24979 | -------- Summary: end -------- 07:20:17 INFO - PROCESS | 24979 | 07:20:18 INFO - TEST-INFO | 24979: exit 0 07:20:18 INFO - TEST-OK | kraken | took 61285ms 07:20:18 INFO - SUITE-END | took 1172s 07:20:19 INFO - Completed test suite (00:19:32) 07:20:19 INFO - javascript benchmark 07:20:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7856.724689110007, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3348.9497657535135, 3364.461686130219, 3377.3751855906676, 3391.5930088389396, 3401.1667141550324, 5866.149408335788, 5938.346781853993, 5939.287285525732, 5952.58331916766, 5974.641521508707, 5831.9416805831925, 5859.589828711981, 5880.441358070987, 5888.11678248263, 5919.112133180025, 5293.417724050351, 5332.413434522199, 5358.089124848766, 5423.349198096214, 5434.510894019538, 5177.715225662587, 5194.168932970725, 5214.348206474191, 5308.867278318035, 5322.20166974953, 5346.705931173784, 5367.919481207766, 5368.543673787733, 5370.355557333126, 5409.350877894639, 5435.456454354572, 5442.564594832404, 5444.210589464526, 5458.372287186985, 5491.862703432406, 5146.125158723026, 5204.583633309327, 5219.451957544441, 5354.544863686591, 5359.517643412073, 5804.303483581955, 5822.272215973004, 5861.589688721791, 5864.442877926633, 5943.821685349447, 6245.3442388549, 6297.842553936142, 6307.716152773136, 6319.842003949892, 6345.302016778151, 6124.472479235491, 6225.626462412224, 6268.529860260499, 6301.369863013662, 6361.077643741632, 5930.406959304079, 5932.377100404396, 5949.9107513387335, 5950.999999999956, 5954.255718035246, 6441.130447389636, 6465.806025819233, 6471.352864713491, 6503.772367967098, 6519.543631945813, 6063.090536419572, 6108.664023478663, 6132.969335153385, 6250.812475625738, 6269.655168965751, 6298.590591611531, 6318.083877837687, 6320.652364119926, 6323.7786677466065, 6353.904691429632, 6317.273513545909, 6326.4622507087415, 6327.050942358683, 6331.905021424683, 6335.968320158369, 6078.635281883101, 6141.670122563582, 6191.226096737908, 6299.370062993664, 6303.7793677222, 4806.2310030394965, 4811.927821082687, 4812.205986012339, 4812.663113582015, 4842.927356089662, 4281.293586558245, 4284.657227421799, 4291.828326866953, 4303.63419109373, 4315.762633055212, 5862.091375836752, 5982.132590774313, 6006.429389208019, 6023.728932198062, 6103.450689437972, 6402.743890244338, 6428.325025872309, 6429.742810287629, 6446.871062578723, 6448.226212854487, 6112.144299798032, 6118.357572454917, 6134.754609815557, 6141.785037523665, 6145.907811382833, 5293.364796224478, 5432.619716619878, 5460.235567020621, 5518.834434966958, 5546.389897111315, 6568.474522038226, 6571.80284591463, 6572.76995305162, 6585.6377899216, 6598.90101648466, 6413.967930160319, 6440.066190402459, 6446.580972236789, 6450.645214513247, 6464.127342808661, 6273.341299163704, 6408.839779005562, 6415.486761059197, 6517.152770139852, 6601.405873471219, 6267.6866156692895, 6276.152719382825, 6281.309056003927, 6292.52806039558, 6299.559030867796, 6322.873542529215, 6388.776392826228, 6391.6804159792755, 6400.487960963019, 6413.35866413355, 6017.608855424559, 6116.938830611637, 6141.631502109888, 6251.78118765841, 6262.780802671885, 6126.663033533198, 6154.815355539341, 6159.692015399301, 6176.845578860564, 6180.47465965398, 6097.96334623124, 6133.44798968095, 6140.140380346666, 6148.661823599566, 6178.073289006685, 5996.520278377807, 6104.9389506106145, 6178.969105154445, 6193.040078787795, 6229.906551401823, 6076.574639775174, 6119.632822030692, 6121.755129794758, 6123.08153776937, 6140.5701600887505], "value": 5822.855556047501, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.6447484796848, 648.9805305840825, 661.3981277037894, 670.1723371636028, 718.3642476408384, 43276.0, 47064.29403558941, 47414.76292618541, 47476.0, 47603.52396476039, 47409.051818963686, 47478.287825682644, 47918.28122578164, 47952.760236198774, 48060.75969620147, 9038.63845446183, 9155.313351498631, 9171.816563668723, 9182.127697868726, 9212.907870921306, 9124.726258212264, 9153.908460915405, 9160.312976526788, 9167.12912273333, 9187.95406022969, 9274.721758347227, 9286.628534858597, 9289.72130836076, 9323.347365684405, 9339.299552533554, 9130.360874738737, 9215.677451289239, 9255.861162082574, 9260.629574817, 9265.16613504781, 9123.224525915306, 9128.361014728971, 9177.403468774508, 9204.585793639302, 9213.032631573655, 45088.0, 45238.54761452376, 45344.54655453436, 45354.77322613366, 45467.31799023017, 3194.0, 3784.375578029622, 3801.4107813288983, 3966.127451960564, 4025.9798701006603, 35589.93230203098, 35861.28277434437, 36009.81995090034, 36212.63787362119, 36235.275294493964, 4596.471405788344, 4782.928256076161, 4815.253635686439, 4835.540623640749, 4871.0744958458135, 384336.0, 385824.0, 387296.0, 388407.0, 390375.0, 72606.27393725995, 74001.0, 74003.25996739963, 74208.62895685594, 74250.62874685592, 41186.9703257421, 41588.79205603953, 41858.790706046275, 44200.77899610481, 44362.556374436484, 19815.10832012563, 20136.697949530768, 20136.89247091424, 20157.19371225164, 20244.898775506324, 14448.422063117569, 14502.709945801025, 14637.780433293508, 14645.0, 14659.0, 22535.873206339616, 22703.659445108337, 22826.201082962016, 22952.0, 22978.770212297663, 7815.179406162385, 7890.8816367754525, 8094.952523738131, 8095.2714255717265, 8250.422470427013, 1004.352192835617, 1052.7473406382567, 1065.08934860693, 1074.9301295415773, 1100.4827730966433, 34189.48715769265, 34613.307733845184, 34697.653023469444, 34927.476087858704, 35732.0, 1158.3223814068865, 1182.6392950150287, 1188.6374655730085, 1257.6981524434252, 1278.520554791953, 17869.7319540207, 17958.714003710047, 18091.185896634684, 18261.817381826277, 18278.63442731138, 433161.0, 558143.0, 587702.0, 588089.0, 588884.0, 71598.64200678964, 72527.0, 72596.63701681458, 72603.27396725965, 72803.27196728071, 1490.2623201515103, 1497.0194522587722, 1520.1639098495782, 1524.9542513724828, 1536.6312085099496, 35294.82352588221, 35941.82029089942, 36236.27527449383, 36692.0, 36859.262814743015, 58463.0, 63110.0, 65239.0, 65328.0, 69417.30582694108, 525360.0, 530963.0, 531351.0, 532545.0, 533908.0, 49029.50970490249, 49182.508174919225, 49505.0, 49954.0, 50051.24923126083, 52394.0, 53385.46614533805, 53502.73248633732, 54307.45692543024, 55539.0, 44686.55313446824, 45777.54222457733, 45966.0, 46001.079978400914, 47098.29352559783, 44824.55175448204, 46506.767466162455, 46513.0, 46979.53020469751, 47692.0, 39228.803855980535, 44063.0, 44456.555434446534, 44484.77757611191, 44683.0, 37865.81067094647, 39454.60545394509, 39867.40198896961, 42300.36549451699, 42459.0, 30912.53631195489, 31089.222769430944, 31334.595833748994, 31420.214494637818, 31853.20366990751], "value": 22305.47711231259, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.2421830159957, 415.5553557693269, 419.1805021183586, 427.9957200427996, 446.48208078628795, 19108.90445547772, 20286.28997985071, 20819.791802081974, 21903.0, 22096.447588810246, 18734.344297949574, 19023.429297121074, 19064.523386915334, 19142.330018449356, 20509.897450512763, 5895.498882594974, 6132.540059495534, 6133.233345831771, 6141.2937512186, 6141.385861413867, 5557.6109672322955, 5817.389174136718, 5926.051831706928, 5955.791547295846, 5956.970215148918, 5750.7412166452405, 5796.536277097843, 5801.187833703285, 5805.36141024487, 5818.563607729416, 5879.382664820175, 5891.5286777057945, 5965.254343207099, 5988.640681559121, 6133.0, 5959.165716799652, 5977.282726072855, 6008.939910600881, 6082.330943596201, 6170.907436388457, 14437.0, 14739.705205895929, 14748.705025899422, 21939.341819745434, 24928.875355623288, 2406.554787364343, 2474.6288056791445, 2692.3538350795866, 2809.2555472799722, 2815.9014434494898, 10423.278324341481, 10794.622188223375, 10985.121190304837, 11410.543578256942, 15033.323500442506, 2002.149086638173, 2005.1979208316643, 2034.4506983114625, 2043.2746375036945, 2059.423361458794, 81990.59004704998, 84290.15709842945, 86250.0, 86554.5672271641, 86935.56532217361, 10111.292209545261, 10427.374357538572, 10837.783244335069, 11652.53389864413, 11727.589534366256, 16562.254698538596, 16734.079625620707, 16769.664606707796, 16813.15934203285, 16824.74762878558, 8446.957765211135, 8610.956945215234, 8866.162827895141, 8978.775530611656, 9115.772105697411, 8562.828743425222, 8595.026545947623, 8630.913690863137, 8822.51476168804, 8837.867431988525, 4899.510048995072, 5100.591952643779, 5118.360204974379, 5118.795248190031, 5233.058049551041, 1965.7935916728538, 2070.285751415759, 2109.493721506827, 2116.386247988097, 2122.204173434962, 959.4147569982305, 1022.9181665466893, 1031.4842578710645, 1042.7080417483116, 1085.880553139154, 20175.192992280437, 20712.689309660367, 20806.271780487612, 21003.0, 21066.89466552688, 1002.4937406609615, 1062.4634559547533, 1067.0076828549522, 1083.6532309660834, 1156.797560426922, 10632.681019569425, 11542.826857596974, 11593.420328983517, 11615.825762613567, 11632.883671163348, 239083.0, 497884.0, 499267.0, 502520.0, 505099.0, 92587.53706231425, 99581.0, 100380.0, 102168.48915755373, 105279.0, 1061.2624226162743, 1075.956961721538, 1109.3676604335612, 1110.7945030169283, 1124.4939777100337, 16176.67646647084, 18272.0, 18669.626607468046, 18763.0, 19090.904545477184, 44208.778956105016, 45517.31724024208, 45639.31541026953, 47114.997639928275, 47285.0, 64479.0, 65003.0, 65688.34311656823, 66210.66894665688, 67250.65498690096, 8791.736247912573, 8845.911540884767, 8897.688580899638, 8944.150305720947, 9061.41100828444, 12449.439775209956, 13788.310584470937, 14086.36611352512, 14165.079269847427, 14378.424863005781, 12071.637850864488, 12281.815772763237, 12522.561710340095, 12598.937005314914, 12640.178388404724, 12328.506859725869, 12334.444949977093, 12426.937865310616, 12473.313967731861, 12590.307533085768, 12293.139480236297, 12335.938320308342, 12439.502419903465, 12511.56209532662, 12542.482521832015, 7703.922960770321, 8158.796030099295, 8852.424592401474, 8882.15619516145, 9060.275177985877, 11934.462949167135, 12045.819312710491, 12291.56979505713, 12486.250824950532, 12546.498140074294], "value": 9689.075070220233, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1295.9028072894532, 1422.5732280315906, 1427.4147599484213, 1841.2082804394106, 1852.3331600623774, 8609.483430994145, 9104.817903641931, 9254.537273136333, 9806.11744942956, 9834.31159818813, 9374.578143983521, 9740.805183896318, 9766.462844543546, 9789.853152202722, 9805.901940980588, 2545.618157276405, 2563.3976015636313, 2565.0252903896585, 2575.4591535777417, 2588.9093881714143, 2512.5351809915223, 2600.8569528675916, 2603.648507451498, 2605.817592768507, 2607.569750991084, 2526.0, 2550.693916729995, 2594.4940736556377, 2595.4419799743146, 2596.117320111162, 2480.8635525046116, 2488.9004439822475, 2522.533331333709, 2534.6831646044243, 2552.0429838810446, 2463.8521688698734, 2479.6280557916275, 2489.7012358517095, 2498.0757119865584, 2527.2797252783052, 9702.660406885725, 9866.950665246628, 9868.259880508991, 9874.60501579936, 9887.90112098877, 5636.351819540764, 5792.218050563162, 5801.535877129862, 5808.244928159313, 5819.359870414293, 3743.5320584926885, 3799.088218827489, 3826.712996525244, 3840.116773142193, 3900.0834803821363, 1279.891209247215, 1308.2019967819622, 1309.3126108792865, 1323.5499930023839, 1325.1121748428577, 13541.661458463519, 13587.116837405636, 13624.93187534056, 13686.452541898312, 13748.106373085717, 4854.757262136879, 4924.8276310328965, 5040.873978150576, 5106.208537676666, 5244.344456942882, 11405.657830265105, 11407.600733974272, 11435.485403156712, 11519.539218431337, 11520.423978801027, 5872.060470324727, 5875.823725288163, 5878.088896221093, 5880.176775251468, 5888.558358123158, 4755.548222918817, 5205.167173252262, 5278.630495865329, 5321.361436627552, 5393.056215162331, 4308.827646894089, 4351.36905148758, 4438.911221775546, 4443.822247110079, 4456.598906098402, 1367.3710093357167, 1373.1623709537175, 1374.7181827725292, 1384.9515266965607, 1405.128820131525, 1062.7608788022633, 1067.1889364083197, 1087.5377964365114, 1099.780043991205, 1101.2731597145846, 6250.937490625036, 6477.4170324671, 6574.408303252731, 6658.349136640325, 6713.26154123046, 485.1727804094082, 494.70812220789907, 497.8680649627851, 499.19878594854737, 512.5028722139518, 4515.571020753023, 4584.633229341644, 4614.031053478807, 4639.512851150648, 4699.177643912301, 11912.940435297767, 12170.695732606579, 12306.81539776904, 12385.19496232742, 12393.690157745948, 11378.601748938747, 11672.824907626393, 12169.33068681231, 12280.07899407548, 12323.568675096509, 8784.648614055366, 8904.910950890408, 8915.37592368541, 8943.150400711791, 8945.105489451003, 6688.899666505104, 6732.293109223657, 6791.93208067913, 6805.659717014229, 6876.484263680144, 10613.310134841211, 10769.299995500267, 11264.15518836107, 11379.601713939972, 11462.140339474407, 11149.832752508557, 11243.381614011309, 11287.040601548631, 11319.830202547133, 11418.0865530759, 7714.652840622298, 8487.108853570286, 8583.742487725378, 8667.349948753996, 8794.956025219833, 9589.472579008221, 9642.084002019797, 9658.75853103678, 9697.418154910727, 9736.172425343924, 8239.629216685144, 8313.127121652382, 8369.581520923808, 8536.231739143506, 8558.914410855812, 8186.508809471451, 8233.094359620318, 8256.463329883538, 8274.213949674771, 8375.874361884698, 7760.30157285847, 7791.4935529190425, 7809.648565814666, 7899.68401263943, 7915.05019397676, 5663.461971112738, 5826.155207494974, 5842.152887831326, 5884.735186916685, 5897.410258974069, 5836.883262334814, 5846.210761547137, 5904.380040095728, 5955.940440595538, 5990.131430942576], "value": 5024.422865970075, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.8701780341273, 355.44727948040793, 367.8914720157555, 369.6340622783445, 373.8654084529569, 5837.387074357195, 5865.472107510323, 5871.3853690235155, 5884.882302353951, 5939.64362138272, 5550.2784637997, 5760.164776107462, 5780.913286300709, 5786.739596718147, 5794.261721483559, 4504.414426124599, 4534.7099714644055, 4545.6136228420455, 4569.520200378962, 4573.794179261941, 4558.931616025762, 4572.634189264851, 4583.175028494869, 4589.632829373642, 4600.884977875547, 4452.465704115511, 4521.344405061264, 4558.6581006424485, 4574.313852922055, 4577.176108300505, 4505.963628365478, 4526.0, 4534.433195850519, 4548.363229147889, 4554.63562914966, 4014.0767623446477, 4014.6186112319283, 4016.7991600419864, 4021.77880216588, 4025.5974402559805, 5582.720863956826, 5614.073677843151, 5643.435656434365, 5656.264685590888, 5693.259876216107, 5214.165733482662, 5240.296903506376, 5243.213517972296, 5251.474852514756, 5258.81594144207, 6081.361457046991, 6081.905257053729, 6095.299040610343, 6126.356732543063, 6182.752689892399, 4263.893402664927, 4411.669124815651, 4436.889077773049, 4446.910506925791, 4461.773012421578, 6170.796694644546, 6310.716017779165, 6332.303446620868, 6333.36666333363, 6359.0, 4464.374987501752, 4488.551144885485, 4488.977555112204, 4517.977410112929, 4548.204064288736, 4516.0, 4563.817447302137, 4579.748113853703, 4586.88532786683, 4595.839145629954, 5033.84898453047, 5176.275321454999, 5233.581313494911, 5233.685978841282, 5240.6069544784295, 6112.297085835097, 6119.5521791283845, 6133.509319254449, 6147.600405973598, 6153.8461538461, 1542.8919975601825, 1567.0, 1569.7331453652907, 1574.4725516951721, 1575.3698520591627, 957.7461972577272, 990.7869807991173, 998.5756053677159, 1010.6159659329408, 1017.5522769981185, 5186.611004174702, 5241.985858131589, 5269.314989051399, 5288.338957630296, 5293.814716484904, 5364.022967253212, 5466.72666366688, 5499.312585926759, 5540.36285827127, 5580.525655319262, 4954.603631709455, 5216.26972223889, 5224.582033437316, 5233.790648374023, 5311.893762124813, 2906.346072133753, 2934.987429336918, 2948.6461624604754, 2954.640865201988, 2956.1427186116216, 5635.900999305096, 5670.901766346478, 5694.9430505695245, 5699.458551437607, 5703.315602127771, 5943.286805583358, 6420.881109234035, 6429.421352078335, 6448.710257948429, 6468.514861385415, 6404.583702059351, 6426.389492998158, 6487.0, 6499.252585952676, 6502.674866256668, 6077.4834139098675, 6214.8135555933395, 6291.96854015727, 6293.465055470337, 6315.494760419064, 6192.225971753531, 6202.751889924352, 6228.283747369111, 6243.906341404973, 6287.528435367274, 6135.723892424762, 6245.375462453719, 6344.460720838781, 6408.61548307103, 6422.165118534561, 4542.409486766699, 4605.861824145281, 4614.400127983341, 4615.907681846412, 4619.69971951822, 6132.264128304632, 6213.347598502092, 6244.843878903063, 6338.397852204033, 6369.426751592379, 6038.580933480541, 6063.361982810278, 6067.392141082705, 6086.817395478142, 6105.358937311518, 5915.792947246826, 6035.879282414415, 6064.090386441892, 6066.848328791815, 6122.969385153046, 5955.225820643289, 5979.820605381846, 6010.188624535806, 6018.969905150446, 6043.3352331244405, 6064.848378790565, 6081.057436097412, 6113.724882380215, 6117.755289788359, 6118.296395914527, 5750.396208398225, 5916.230889984447, 5950.0, 5950.9404905952115, 5953.719950210725], "value": 4580.454496658046, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [736.0946036375261, 767.800371903305, 810.4084018666373, 883.6907082521117, 926.6617684545134, 16145.43490977816, 16880.32478700852, 16905.408310709114, 16925.7461138083, 16945.152742362865, 15229.543113706606, 15270.923645381785, 15293.84706152938, 15298.388064477407, 15393.153376564313, 733.9633018349087, 868.5006121480159, 869.9782505437352, 878.9208971192592, 889.1064480197392, 882.1002577371078, 884.8716936044269, 885.8981217160044, 886.1935638568904, 890.3989806880362, 938.7840796616782, 939.8590211468266, 940.4028441939383, 941.3034354577597, 942.0108885670053, 915.2174890468686, 926.8609708543738, 929.256594724218, 932.2588542109039, 932.5616960028775, 682.6245564939313, 684.5858255755296, 685.9128281673553, 686.2211390072254, 689.8516818883965, 14320.498782542665, 14421.78367324491, 14448.422063117463, 14479.855201447956, 14637.194954277511, 15572.688546229125, 16126.0, 16126.113063781488, 16218.351265949348, 16223.432179873647, 13275.73448531024, 13473.124246923919, 13550.322483875767, 13606.047576669636, 13723.45106195751, 4064.1058967027207, 4095.9180816383805, 4114.423980642712, 4149.481314835645, 4170.4995400551825, 89699.10300896973, 90867.09132908653, 92899.53550232273, 94295.0, 97426.0, 11856.585019524275, 11923.523059077714, 12103.213291136048, 12227.633171004883, 12349.073819463576, 21942.122315107536, 21970.45073873166, 22029.559408812056, 22045.448863778533, 22091.558168836855, 8682.175148796225, 8786.824263514694, 9098.135677110664, 9159.587818548182, 9233.630654773733, 5040.79836806531, 5101.897962040738, 5130.563902068291, 5184.455632158644, 5230.503102205284, 3924.9215015700097, 4023.155137421116, 4032.9798351008058, 4040.4949381327333, 4054.493188351456, 699.5907394174465, 702.0872865275223, 708.0476758759461, 715.3740477082553, 716.5915428205873, 732.5018987088831, 768.8885111658778, 849.2229609906866, 850.3409857360595, 866.3545658484469, 10149.493268344839, 10221.591136354462, 10670.73323166927, 11046.834297485544, 11459.541618335339, 659.423004870738, 689.3141324382271, 802.6428239433396, 810.7810891059498, 819.6311659753015, 5085.186370180753, 5165.819196328186, 5223.190405487156, 5342.839714808484, 5346.572274218053, 77318.61340693373, 94333.5283323579, 136427.0, 138323.30838345946, 141169.29415352858, 102204.48897755463, 113934.43032784783, 115498.42250788861, 117694.0, 120207.0, 99529.50235248922, 100856.49571752241, 101623.49188254011, 102590.48704756428, 103582.0, 10008.79894412646, 10098.293119481566, 10183.287169898036, 10222.948885255526, 10256.02672450316, 59626.0, 60739.0, 61301.693491532256, 61416.45939978112, 61446.0, 49975.25037124373, 51085.23372149347, 65895.67052164709, 86243.0, 88941.0, 12870.742585148057, 12890.548830790878, 13190.472381104648, 13232.272225027331, 13382.263975481443, 14254.501092461715, 14345.569632911029, 14523.273836308354, 14667.48663796762, 15430.5370838875, 13043.673908152372, 13651.453941842612, 13717.931410342884, 14157.07978981404, 14545.490907818175, 12399.25604463735, 12676.87323126757, 13104.279264640156, 13975.371108299947, 14026.509072182425, 13029.543965961146, 13943.51197708116, 13977.091489053179, 14125.293735313398, 14251.928740356232, 10993.945030274797, 11406.828897566376, 11489.712757181138, 12133.69665758363, 12181.149968009362, 11971.0, 12055.276683399024, 12166.0, 12482.188657737219, 12495.812562811747], "value": 8120.497923712827, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1505.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 110.0, 104.0, 110.0, 111.0, 111.0, 110.0, 110.0, 110.0, 111.0], "value": 108.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 117.0, 147.0, 176.0, 118.0, 156.0, 143.0, 117.0, 171.0, 122.0], "value": 141.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 162.0, 162.0, 161.0, 162.0, 165.0, 162.0, 161.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 77.0, 183.0, 76.0, 75.0, 75.0, 74.0, 169.0, 75.0], "value": 95.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 150.0, 83.0, 82.0, 84.0, 151.0, 84.0, 83.0, 142.0], "value": 102.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 119.0, 118.0, 119.0, 118.0, 117.0, 117.0, 118.0, 118.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 149.0, 148.0, 148.0, 150.0, 147.0, 147.0, 149.0, 147.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 51.0, 50.0, 60.0, 51.0, 54.0, 51.0, 50.0, 54.0], "value": 52.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 59.0, 59.0, 60.0, 60.0, 59.0, 60.0, 59.0, 58.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 72.0, 80.0, 73.0, 71.0, 73.0, 73.0, 72.0, 76.0, 72.0], "value": 74.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 133.0, 121.0, 125.0, 140.0, 130.0, 122.0, 118.0, 155.0, 121.0], "value": 128.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 157.0, 155.0, 154.0, 155.0, 154.0, 156.0, 162.0, 156.0, 154.0], "value": 156.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 65.0, 63.0, 62.0, 61.0, 63.0, 60.0, 60.0], "value": 62.1, "unit": "score"}]}]} 07:20:19 INFO - Return code: 0 07:20:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:20:19 ERROR - # TBPL SUCCESS # 07:20:19 INFO - Running post-action listener: _resource_record_post_action 07:20:19 INFO - [mozharness: 2016-09-01 14:20:19.257776Z] Finished run-tests step (success) 07:20:19 INFO - Running post-run listener: _resource_record_post_run 07:20:19 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 483328; Write bytes: 327553024; Read time: 56; Write time: 316780 07:20:19 INFO - TinderboxPrint: CPU usage
13.3% 07:20:19 INFO - TinderboxPrint: I/O read bytes / time
483,328 / 56 07:20:19 INFO - TinderboxPrint: I/O write bytes / time
327,553,024 / 316,780 07:20:19 INFO - TinderboxPrint: CPU idle
8,234.0 (86.7%) 07:20:19 INFO - TinderboxPrint: CPU user
1,201.7 (12.7%) 07:20:19 INFO - TinderboxPrint: Swap in / out
0 / 0 07:20:19 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 79253504; Read time: 0; Write time: 102968 07:20:19 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 483328; Write bytes: 248299520; Read time: 56; Write time: 213812 07:20:19 INFO - Running post-run listener: _upload_blobber_files 07:20:19 INFO - Blob upload gear active. 07:20:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:20:19 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 07:20:19 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:20:19 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:20:20 INFO - (blobuploader) - INFO - Open directory for files ... 07:20:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:20:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:20:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:20:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:20:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:20:26 INFO - (blobuploader) - INFO - Done attempting. 07:20:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:20:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:20:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:20:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:20:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:20:27 INFO - (blobuploader) - INFO - Done attempting. 07:20:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:20:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:20:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:20:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:20:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:20:28 INFO - (blobuploader) - INFO - Done attempting. 07:20:28 INFO - (blobuploader) - INFO - Iteration through files over. 07:20:28 INFO - Return code: 0 07:20:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:20:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:20:28 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8f492768e86aae6b272db3f3ca2393e5c3ed068c381527a27eb0c8d8aef05bead800bec583f7a37d2ba0a77f80340478753edc301b090763334b1bb0b806a1b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bb3736a70dde0f822c132596458844b445d847ed3b94ded4aa3ea237f396b12309af241f5201cf8d1cdbb97e81bb8c6f34370e5885447a1c84a707ae7c058479", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/deca220c64aba989e3bed88f3b298dfc932eae1d4935c04de462126362970afdad53146d22076048dc89525d1d5933840b6d7c5d602cf72a3e168d2fa013eb7c"} 07:20:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:20:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:20:28 INFO - Contents: 07:20:28 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8f492768e86aae6b272db3f3ca2393e5c3ed068c381527a27eb0c8d8aef05bead800bec583f7a37d2ba0a77f80340478753edc301b090763334b1bb0b806a1b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bb3736a70dde0f822c132596458844b445d847ed3b94ded4aa3ea237f396b12309af241f5201cf8d1cdbb97e81bb8c6f34370e5885447a1c84a707ae7c058479", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/deca220c64aba989e3bed88f3b298dfc932eae1d4935c04de462126362970afdad53146d22076048dc89525d1d5933840b6d7c5d602cf72a3e168d2fa013eb7c"} 07:20:28 INFO - Running post-run listener: copy_logs_to_upload_dir 07:20:28 INFO - Copying logs to upload dir... 07:20:28 INFO - mkdir: /builds/slave/test/build/upload/logs 07:20:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1680.696404 ========= master_lag: 4.40 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 5 secs) (at 2016-09-01 07:20:32.297493) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 07:20:32.306088) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1472737324.396277-1139027901 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8f492768e86aae6b272db3f3ca2393e5c3ed068c381527a27eb0c8d8aef05bead800bec583f7a37d2ba0a77f80340478753edc301b090763334b1bb0b806a1b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bb3736a70dde0f822c132596458844b445d847ed3b94ded4aa3ea237f396b12309af241f5201cf8d1cdbb97e81bb8c6f34370e5885447a1c84a707ae7c058479", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/deca220c64aba989e3bed88f3b298dfc932eae1d4935c04de462126362970afdad53146d22076048dc89525d1d5933840b6d7c5d602cf72a3e168d2fa013eb7c"} build_url:https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011258 build_url: 'https://queue.taskcluster.net/v1/task/f5E-LrHRSJO8XO67pPY81g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8f492768e86aae6b272db3f3ca2393e5c3ed068c381527a27eb0c8d8aef05bead800bec583f7a37d2ba0a77f80340478753edc301b090763334b1bb0b806a1b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bb3736a70dde0f822c132596458844b445d847ed3b94ded4aa3ea237f396b12309af241f5201cf8d1cdbb97e81bb8c6f34370e5885447a1c84a707ae7c058479", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/deca220c64aba989e3bed88f3b298dfc932eae1d4935c04de462126362970afdad53146d22076048dc89525d1d5933840b6d7c5d602cf72a3e168d2fa013eb7c"}' ========= master_lag: 0.55 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 07:20:32.872209) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 07:20:32.872535) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1472737324.396277-1139027901 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004474 ========= master_lag: 0.70 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 07:20:33.575952) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 07:20:33.576252) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 07:20:33.617435) ========= ========= Total master_lag: 5.86 =========