builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-048 starttime: 1470420418.93 results: success (0) buildid: 20160805072232 builduid: 16f5b19919d6424fb6c268c5705c0fd7 revision: 307fe134b473938131cb0f28db52cf371883f663 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 11:06:58.934789) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 11:06:58.935345) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-05 11:06:58.935617) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-05 11:06:58.950342) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 11:06:58.950600) ========= 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=fa44defc139c4ba8574fe040000001db-1470419619.168255-1719598066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-05 11:07:00-- 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% 38.9M=0s 2016-08-05 11:07:00 (38.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110976 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 11:06:59.077635) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 11:06:59.077935) ========= 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=fa44defc139c4ba8574fe040000001db-1470419619.168255-1719598066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015639 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 11:06:59.127537) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 11:06:59.127839) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 307fe134b473938131cb0f28db52cf371883f663 --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 307fe134b473938131cb0f28db52cf371883f663 --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=fa44defc139c4ba8574fe040000001db-1470419619.168255-1719598066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-05 11:07:00,454 truncating revision to first 12 chars 2016-08-05 11:07:00,454 Setting DEBUG logging. 2016-08-05 11:07:00,454 attempt 1/10 2016-08-05 11:07:00,454 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/307fe134b473?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-05 11:07:00,743 unpacking tar archive at: mozilla-aurora-307fe134b473/testing/mozharness/ program finished with exit code 0 elapsedTime=0.612437 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 11:06:59.752730) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 11:06:59.753061) ========= script_repo_revision: 307fe134b473938131cb0f28db52cf371883f663 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 11:06:59.753460) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 11:06:59.753762) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 11:06:59.761909) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 59 secs) (at 2016-08-05 11:06:59.762170) ========= /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=fa44defc139c4ba8574fe040000001db-1470419619.168255-1719598066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:07:01 INFO - MultiFileLogger online at 20160805 11:07:01 in /builds/slave/test 11:07:01 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 11:07:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:07:01 INFO - {'append_to_log': False, 11:07:01 INFO - 'base_work_dir': '/builds/slave/test', 11:07:01 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:07:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:07:01 INFO - 'branch': 'Mozilla-Aurora', 11:07:01 INFO - 'buildbot_json_path': 'buildprops.json', 11:07:01 INFO - 'config_files': ('talos/linux_config.py',), 11:07:01 INFO - 'default_actions': ('clobber', 11:07:01 INFO - 'read-buildbot-config', 11:07:01 INFO - 'download-and-extract', 11:07:01 INFO - 'populate-webroot', 11:07:01 INFO - 'create-virtualenv', 11:07:01 INFO - 'install', 11:07:01 INFO - 'run-tests'), 11:07:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:07:01 INFO - 'download_minidump_stackwalk': True, 11:07:01 INFO - 'download_symbols': 'ondemand', 11:07:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:07:01 INFO - 'tooltool.py': '/tools/tooltool.py', 11:07:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:07:01 INFO - '/tools/misc-python/virtualenv.py')}, 11:07:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:07:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:07:01 INFO - 'installer_path': 'installer.exe', 11:07:01 INFO - 'log_level': 'info', 11:07:01 INFO - 'log_name': 'talos', 11:07:01 INFO - 'log_to_console': True, 11:07:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:07:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:07:01 INFO - 'opt_config_files': (), 11:07:01 INFO - 'pip_index': False, 11:07:01 INFO - 'sps_profile': False, 11:07:01 INFO - 'sps_profile_interval': 0, 11:07:01 INFO - 'suite': 'dromaeojs-e10s', 11:07:01 INFO - 'system_bits': '32', 11:07:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:07:01 INFO - 'title': 'talos-linux64-ix-048', 11:07:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:07:01 INFO - 'use_talos_json': True, 11:07:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:07:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:07:01 INFO - 'work_dir': 'build'} 11:07:01 INFO - [mozharness: 2016-08-05 18:07:01.178317Z] Running clobber step. 11:07:01 INFO - Running pre-action listener: _resource_record_pre_action 11:07:01 INFO - Running main action method: clobber 11:07:01 INFO - rmtree: /builds/slave/test/build 11:07:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:07:01 INFO - Running post-action listener: _resource_record_post_action 11:07:01 INFO - [mozharness: 2016-08-05 18:07:01.640700Z] Finished clobber step (success) 11:07:01 INFO - [mozharness: 2016-08-05 18:07:01.640802Z] Running read-buildbot-config step. 11:07:01 INFO - Running pre-action listener: _resource_record_pre_action 11:07:01 INFO - Running main action method: read_buildbot_config 11:07:01 INFO - Using buildbot properties: 11:07:01 INFO - { 11:07:01 INFO - "project": "", 11:07:01 INFO - "product": "firefox", 11:07:01 INFO - "script_repo_revision": "production", 11:07:01 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 11:07:01 INFO - "repository": "", 11:07:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 11:07:01 INFO - "buildid": "20160805072232", 11:07:01 INFO - "pgo_build": "True", 11:07:01 INFO - "basedir": "/builds/slave/test", 11:07:01 INFO - "buildnumber": 461, 11:07:01 INFO - "slavename": "talos-linux64-ix-048", 11:07:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:07:01 INFO - "platform": "ubuntu64_hw", 11:07:01 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 11:07:01 INFO - "branch": "mozilla-aurora", 11:07:01 INFO - "repo_path": "releases/mozilla-aurora", 11:07:01 INFO - "revision": "307fe134b473938131cb0f28db52cf371883f663", 11:07:01 INFO - "stage_platform": "linux64-pgo", 11:07:01 INFO - "builduid": "16f5b19919d6424fb6c268c5705c0fd7", 11:07:01 INFO - "slavebuilddir": "test" 11:07:01 INFO - } 11:07:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 11:07:01 INFO - Running post-action listener: _resource_record_post_action 11:07:01 INFO - [mozharness: 2016-08-05 18:07:01.643286Z] Finished read-buildbot-config step (success) 11:07:01 INFO - [mozharness: 2016-08-05 18:07:01.643377Z] Running download-and-extract step. 11:07:01 INFO - Running pre-action listener: _resource_record_pre_action 11:07:01 INFO - Running main action method: download_and_extract 11:07:01 INFO - mkdir: /builds/slave/test/build/tests 11:07:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:01 INFO - https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:07:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 11:07:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 11:07:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 11:07:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 11:07:01 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 11:07:01 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 11:07:01 INFO - retry: Failed, sleeping 30 seconds before retrying 11:07:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 11:07:31 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 11:07:31 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 11:07:31 INFO - retry: Failed, sleeping 60 seconds before retrying 11:08:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 11:08:31 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 11:08:31 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 11:08:31 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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! 11:08:31 INFO - Caught exception: HTTP Error 404: Not Found 11:08:31 INFO - Caught exception: HTTP Error 404: Not Found 11:08:31 INFO - Caught exception: HTTP Error 404: Not Found 11:08:31 INFO - trying https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 11:08:31 INFO - Downloading https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/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 11:08:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/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 11:08:32 INFO - Downloaded 1361 bytes. 11:08:32 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 11:08:32 INFO - Using the following test package requirements: 11:08:32 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 11:08:32 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 11:08:32 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 11:08:32 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 11:08:32 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 11:08:32 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 11:08:32 INFO - u'jsshell-linux-x86_64.zip'], 11:08:32 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 11:08:32 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 11:08:32 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 11:08:32 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 11:08:32 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 11:08:32 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 11:08:32 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 11:08:32 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 11:08:32 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 11:08:32 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 11:08:32 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 11:08:32 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:08:32 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')]} 11:08:32 INFO - https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:08:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 11:08:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 11:08:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 11:08:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 11:08:32 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 11:08:32 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 11:08:32 INFO - retry: Failed, sleeping 30 seconds before retrying 11:09:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 11:09:02 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 11:09:02 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 11:09:02 INFO - retry: Failed, sleeping 60 seconds before retrying 11:10:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 11:10:02 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 11:10:02 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 11:10:02 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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! 11:10:02 INFO - Caught exception: HTTP Error 404: Not Found 11:10:02 INFO - Caught exception: HTTP Error 404: Not Found 11:10:02 INFO - Caught exception: HTTP Error 404: Not Found 11:10:02 INFO - trying https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 11:10:02 INFO - Downloading https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/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 11:10:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/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 11:10:03 INFO - Downloaded 21765973 bytes. 11:10:03 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'] 11:10:03 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 11:10:04 INFO - Return code: 0 11:10:04 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 11:10:04 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')]} 11:10:04 INFO - https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:10:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 11:10:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 11:10:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 11:10:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 11:10:04 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 11:10:04 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 11:10:04 INFO - retry: Failed, sleeping 30 seconds before retrying 11:10:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 11:10:34 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 11:10:34 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 11:10:34 INFO - retry: Failed, sleeping 60 seconds before retrying 11:11:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 11:11:34 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 11:11:34 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 11:11:34 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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! 11:11:34 INFO - Caught exception: HTTP Error 404: Not Found 11:11:34 INFO - Caught exception: HTTP Error 404: Not Found 11:11:34 INFO - Caught exception: HTTP Error 404: Not Found 11:11:34 INFO - trying https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 11:11:34 INFO - Downloading https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/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 11:11:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/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 11:11:35 INFO - Downloaded 21765973 bytes. 11:11:35 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'] 11:11:35 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 11:11:37 INFO - Return code: 0 11:11:37 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')]} 11:11:37 INFO - https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:11:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 11:11:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 11:11:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 11:11:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 11:11:37 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 11:11:37 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 11:11:37 INFO - retry: Failed, sleeping 30 seconds before retrying 11:12:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 11:12:07 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 11:12:07 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 11:12:07 INFO - retry: Failed, sleeping 60 seconds before retrying 11:13:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 11:13:07 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 11:13:07 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 11:13:07 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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! 11:13:07 INFO - Caught exception: HTTP Error 404: Not Found 11:13:07 INFO - Caught exception: HTTP Error 404: Not Found 11:13:07 INFO - Caught exception: HTTP Error 404: Not Found 11:13:07 INFO - trying https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 11:13:07 INFO - Downloading https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/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 11:13:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/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 11:13:08 INFO - Downloaded 14413723 bytes. 11:13:08 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'] 11:13:08 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 11:13:08 INFO - Return code: 0 11:13:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:08 INFO - https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:13:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 11:13:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 11:13:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 11:13:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 11:13:08 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 11:13:08 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 11:13:08 INFO - retry: Failed, sleeping 30 seconds before retrying 11:13:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 11:13:38 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 11:13:38 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 11:13:38 INFO - retry: Failed, sleeping 60 seconds before retrying 11:14:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 11:14:38 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 11:14:38 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 11:14:38 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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! 11:14:38 INFO - Caught exception: HTTP Error 404: Not Found 11:14:38 INFO - Caught exception: HTTP Error 404: Not Found 11:14:38 INFO - Caught exception: HTTP Error 404: Not Found 11:14:38 INFO - trying https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 11:14:38 INFO - Downloading https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/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 11:14:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/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 11:14:42 INFO - Downloaded 63764898 bytes. 11:14:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 11:14:42 INFO - mkdir: /builds/slave/test/properties 11:14:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:14:42 INFO - Writing to file /builds/slave/test/properties/build_url 11:14:42 INFO - Contents: 11:14:42 INFO - build_url:https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 11:14:43 INFO - Running post-action listener: _resource_record_post_action 11:14:43 INFO - Running post-action listener: set_extra_try_arguments 11:14:43 INFO - [mozharness: 2016-08-05 18:14:43.472768Z] Finished download-and-extract step (success) 11:14:43 INFO - [mozharness: 2016-08-05 18:14:43.473022Z] Running populate-webroot step. 11:14:43 INFO - Running pre-action listener: _resource_record_pre_action 11:14:43 INFO - Running main action method: populate_webroot 11:14:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:14:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:14:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:14:43 INFO - '--tppagecycles', 11:14:43 INFO - '7'], 11:14:43 INFO - 'tests': ['tsvgm']}}, 11:14:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:14:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:14:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:14:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:14:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:14:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:14:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:43 INFO - 'talos_options': ['--disable-e10s'], 11:14:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:14:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:14:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:43 INFO - 'talos_options': ['--disable-e10s'], 11:14:43 INFO - 'tests': ['damp', 'tps']}, 11:14:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:43 INFO - 'tests': ['damp', 'tps']}, 11:14:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:14:43 INFO - 'tests': ['dromaeo_dom']}, 11:14:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:14:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:14:43 INFO - 'tests': ['basic_compositor_video']}, 11:14:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:14:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:14:43 INFO - 'tests': ['a11yr', 11:14:43 INFO - 'ts_paint', 11:14:43 INFO - 'tpaint', 11:14:43 INFO - 'sessionrestore', 11:14:43 INFO - 'sessionrestore_no_auto_restore', 11:14:43 INFO - 'tabpaint']}, 11:14:43 INFO - 'other-e10s': {'tests': ['a11yr', 11:14:43 INFO - 'ts_paint', 11:14:43 INFO - 'tpaint', 11:14:43 INFO - 'sessionrestore', 11:14:43 INFO - 'sessionrestore_no_auto_restore', 11:14:43 INFO - 'tabpaint']}, 11:14:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:14:43 INFO - 'ts_paint', 11:14:43 INFO - 'tpaint', 11:14:43 INFO - 'sessionrestore', 11:14:43 INFO - 'sessionrestore_no_auto_restore', 11:14:43 INFO - 'tabpaint']}, 11:14:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:14:43 INFO - 'ts_paint', 11:14:43 INFO - 'tpaint', 11:14:43 INFO - 'sessionrestore', 11:14:43 INFO - 'sessionrestore_no_auto_restore', 11:14:43 INFO - 'tabpaint']}, 11:14:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:14:43 INFO - 'tests': ['a11yr', 11:14:43 INFO - 'ts_paint', 11:14:43 INFO - 'tpaint', 11:14:43 INFO - 'sessionrestore', 11:14:43 INFO - 'sessionrestore_no_auto_restore', 11:14:43 INFO - 'tabpaint']}, 11:14:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:14:43 INFO - 'tests': ['a11yr', 11:14:43 INFO - 'ts_paint', 11:14:43 INFO - 'tpaint', 11:14:43 INFO - 'sessionrestore', 11:14:43 INFO - 'sessionrestore_no_auto_restore', 11:14:43 INFO - 'tabpaint']}, 11:14:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:14:43 INFO - 'tests': ['tsvgx', 11:14:43 INFO - 'tsvgr_opacity', 11:14:43 INFO - 'tart', 11:14:43 INFO - 'tscrollx', 11:14:43 INFO - 'cart']}, 11:14:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:14:43 INFO - 'tsvgr_opacity', 11:14:43 INFO - 'tart', 11:14:43 INFO - 'tscrollx', 11:14:43 INFO - 'cart']}, 11:14:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:43 INFO - 'talos_options': ['--disable-e10s'], 11:14:43 INFO - 'tests': ['tp5o']}, 11:14:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:43 INFO - 'tests': ['tp5o']}, 11:14:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:43 INFO - 'talos_options': ['--disable-e10s', 11:14:43 INFO - '--xperf_path', 11:14:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:14:43 INFO - 'tests': ['tp5n']}, 11:14:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:43 INFO - 'talos_options': ['--xperf_path', 11:14:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:14:43 INFO - 'tests': ['tp5n']}}, 11:14:43 INFO - 'talos.zip': {'path': '', 11:14:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:14:43 INFO - Running post-action listener: _resource_record_post_action 11:14:43 INFO - [mozharness: 2016-08-05 18:14:43.496683Z] Finished populate-webroot step (success) 11:14:43 INFO - [mozharness: 2016-08-05 18:14:43.496773Z] Running create-virtualenv step. 11:14:43 INFO - Running pre-action listener: _resource_record_pre_action 11:14:43 INFO - Running main action method: create_virtualenv 11:14:43 INFO - Creating virtualenv /builds/slave/test/build/venv 11:14:43 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 11:14:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:14:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:14:43 INFO - Using real prefix '/usr' 11:14:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:14:44 INFO - Installing distribute.............................................................................................................................................................................................done. 11:14:46 INFO - Installing pip.................done. 11:14:46 INFO - Return code: 0 11:14:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:14: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')]} 11:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14: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')]} 11:14:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:46 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 0x1cec030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1faa570>, '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 0x1fab470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fab900>, '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': 'fa44defc139c4ba8574fe040000001db-1470419619.168255-1719598066', '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 11:14:46 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 11:14:46 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 11:14:46 INFO - Using env: {'DISPLAY': ':0', 11:14:46 INFO - 'HOME': '/home/cltbld', 11:14:46 INFO - 'LANG': 'en_US.UTF-8', 11:14:46 INFO - 'LANGUAGE': 'en_US:en', 11:14:46 INFO - 'LOGNAME': 'cltbld', 11:14:46 INFO - 'MAIL': '/var/mail/cltbld', 11:14:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:46 INFO - 'MOZ_NO_REMOTE': '1', 11:14:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:46 INFO - 'NO_EM_RESTART': '1', 11:14:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:46 INFO - 'PWD': '/builds/slave/test', 11:14:46 INFO - 'SHELL': '/bin/bash', 11:14:46 INFO - 'SHLVL': '1', 11:14:46 INFO - 'TERM': 'linux', 11:14:46 INFO - 'TMOUT': '86400', 11:14:46 INFO - 'USER': 'cltbld', 11:14:46 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1470419619.168255-1719598066', 11:14:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:46 INFO - '_': '/tools/buildbot/bin/python'} 11:14:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:46 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 11:14:46 INFO - Cleaning up... 11:14:46 INFO - Return code: 0 11:14:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:14: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')]} 11:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14: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')]} 11:14:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:46 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 0x1cec030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1faa570>, '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 0x1fab470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fab900>, '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': 'fa44defc139c4ba8574fe040000001db-1470419619.168255-1719598066', '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 11:14:46 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 11:14:46 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 11:14:46 INFO - Using env: {'DISPLAY': ':0', 11:14:46 INFO - 'HOME': '/home/cltbld', 11:14:46 INFO - 'LANG': 'en_US.UTF-8', 11:14:46 INFO - 'LANGUAGE': 'en_US:en', 11:14:46 INFO - 'LOGNAME': 'cltbld', 11:14:46 INFO - 'MAIL': '/var/mail/cltbld', 11:14:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:46 INFO - 'MOZ_NO_REMOTE': '1', 11:14:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:46 INFO - 'NO_EM_RESTART': '1', 11:14:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:46 INFO - 'PWD': '/builds/slave/test', 11:14:46 INFO - 'SHELL': '/bin/bash', 11:14:46 INFO - 'SHLVL': '1', 11:14:46 INFO - 'TERM': 'linux', 11:14:46 INFO - 'TMOUT': '86400', 11:14:46 INFO - 'USER': 'cltbld', 11:14:46 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1470419619.168255-1719598066', 11:14:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:46 INFO - '_': '/tools/buildbot/bin/python'} 11:14:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:46 INFO - Downloading/unpacking psutil>=3.1.1 11:14:46 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 11:14:46 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 11:14:46 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 11:14:46 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 11:14:46 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 11:14:46 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 11:14:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:14:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:14:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:14:48 INFO - Installing collected packages: psutil 11:14:48 INFO - Running setup.py install for psutil 11:14:48 INFO - building 'psutil._psutil_linux' extension 11:14:48 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 11:14:48 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 11:14:48 INFO - building 'psutil._psutil_posix' extension 11:14:48 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 11:14:48 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 11:14:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:14:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:14:49 INFO - Successfully installed psutil 11:14:49 INFO - Cleaning up... 11:14:49 INFO - Return code: 0 11:14:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:14:49 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')]} 11:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:49 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')]} 11:14:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:49 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 0x1cec030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1faa570>, '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 0x1fab470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fab900>, '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': 'fa44defc139c4ba8574fe040000001db-1470419619.168255-1719598066', '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 11:14:49 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 11:14:49 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 11:14:49 INFO - Using env: {'DISPLAY': ':0', 11:14:49 INFO - 'HOME': '/home/cltbld', 11:14:49 INFO - 'LANG': 'en_US.UTF-8', 11:14:49 INFO - 'LANGUAGE': 'en_US:en', 11:14:49 INFO - 'LOGNAME': 'cltbld', 11:14:49 INFO - 'MAIL': '/var/mail/cltbld', 11:14:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:49 INFO - 'MOZ_NO_REMOTE': '1', 11:14:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:49 INFO - 'NO_EM_RESTART': '1', 11:14:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:49 INFO - 'PWD': '/builds/slave/test', 11:14:49 INFO - 'SHELL': '/bin/bash', 11:14:49 INFO - 'SHLVL': '1', 11:14:49 INFO - 'TERM': 'linux', 11:14:49 INFO - 'TMOUT': '86400', 11:14:49 INFO - 'USER': 'cltbld', 11:14:49 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1470419619.168255-1719598066', 11:14:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:49 INFO - '_': '/tools/buildbot/bin/python'} 11:14:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:14:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:14:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:14:51 INFO - Installing collected packages: mozsystemmonitor 11:14:51 INFO - Running setup.py install for mozsystemmonitor 11:14:51 INFO - Successfully installed mozsystemmonitor 11:14:51 INFO - Cleaning up... 11:14:51 INFO - Return code: 0 11:14:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:14:51 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')]} 11:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:51 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')]} 11:14:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:51 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 0x1cec030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1faa570>, '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 0x1fab470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fab900>, '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': 'fa44defc139c4ba8574fe040000001db-1470419619.168255-1719598066', '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 11:14:51 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 11:14:51 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 11:14:51 INFO - Using env: {'DISPLAY': ':0', 11:14:51 INFO - 'HOME': '/home/cltbld', 11:14:51 INFO - 'LANG': 'en_US.UTF-8', 11:14:51 INFO - 'LANGUAGE': 'en_US:en', 11:14:51 INFO - 'LOGNAME': 'cltbld', 11:14:51 INFO - 'MAIL': '/var/mail/cltbld', 11:14:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:51 INFO - 'MOZ_NO_REMOTE': '1', 11:14:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:51 INFO - 'NO_EM_RESTART': '1', 11:14:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:51 INFO - 'PWD': '/builds/slave/test', 11:14:51 INFO - 'SHELL': '/bin/bash', 11:14:51 INFO - 'SHLVL': '1', 11:14:51 INFO - 'TERM': 'linux', 11:14:51 INFO - 'TMOUT': '86400', 11:14:51 INFO - 'USER': 'cltbld', 11:14:51 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1470419619.168255-1719598066', 11:14:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:51 INFO - '_': '/tools/buildbot/bin/python'} 11:14:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:51 INFO - Downloading/unpacking jsonschema==2.5.1 11:14:51 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 11:14:51 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 11:14:51 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 11:14:51 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 11:14:51 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 11:14:51 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 11:14:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:14:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:14:53 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 11:14:53 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 11:14:53 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 11:14:53 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 11:14:53 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 11:14:53 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 11:14:53 INFO - Downloading functools32-3.2.3-2.tar.gz 11:14:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:14:53 INFO - warning: no files found matching '*.txt' 11:14:53 INFO - no previously-included directories found matching 'build' 11:14:53 INFO - no previously-included directories found matching 'dist' 11:14:53 INFO - no previously-included directories found matching '.git*' 11:14:53 INFO - Installing collected packages: jsonschema, functools32 11:14:53 INFO - Running setup.py install for functools32 11:14:53 INFO - warning: no files found matching '*.txt' 11:14:53 INFO - no previously-included directories found matching 'build' 11:14:53 INFO - no previously-included directories found matching 'dist' 11:14:53 INFO - no previously-included directories found matching '.git*' 11:14:53 INFO - Successfully installed jsonschema functools32 11:14:53 INFO - Cleaning up... 11:14:53 INFO - Return code: 0 11:14:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:14:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:53 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 0x1cec030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1faa570>, '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 0x1fab470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fab900>, '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': 'fa44defc139c4ba8574fe040000001db-1470419619.168255-1719598066', '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 11:14:53 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 11:14:53 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 11:14:53 INFO - Using env: {'DISPLAY': ':0', 11:14:53 INFO - 'HOME': '/home/cltbld', 11:14:53 INFO - 'LANG': 'en_US.UTF-8', 11:14:53 INFO - 'LANGUAGE': 'en_US:en', 11:14:53 INFO - 'LOGNAME': 'cltbld', 11:14:53 INFO - 'MAIL': '/var/mail/cltbld', 11:14:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:53 INFO - 'MOZ_NO_REMOTE': '1', 11:14:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:53 INFO - 'NO_EM_RESTART': '1', 11:14:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:53 INFO - 'PWD': '/builds/slave/test', 11:14:53 INFO - 'SHELL': '/bin/bash', 11:14:53 INFO - 'SHLVL': '1', 11:14:53 INFO - 'TERM': 'linux', 11:14:53 INFO - 'TMOUT': '86400', 11:14:53 INFO - 'USER': 'cltbld', 11:14:53 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1470419619.168255-1719598066', 11:14:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:53 INFO - '_': '/tools/buildbot/bin/python'} 11:14:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:14:54 INFO - Cleaning up... 11:14:54 INFO - Return code: 0 11:14:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:54 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 0x1cec030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1faa570>, '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 0x1fab470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fab900>, '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': 'fa44defc139c4ba8574fe040000001db-1470419619.168255-1719598066', '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 11:14:54 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 11:14:54 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 11:14:54 INFO - Using env: {'DISPLAY': ':0', 11:14:54 INFO - 'HOME': '/home/cltbld', 11:14:54 INFO - 'LANG': 'en_US.UTF-8', 11:14:54 INFO - 'LANGUAGE': 'en_US:en', 11:14:54 INFO - 'LOGNAME': 'cltbld', 11:14:54 INFO - 'MAIL': '/var/mail/cltbld', 11:14:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:54 INFO - 'MOZ_NO_REMOTE': '1', 11:14:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:54 INFO - 'NO_EM_RESTART': '1', 11:14:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:54 INFO - 'PWD': '/builds/slave/test', 11:14:54 INFO - 'SHELL': '/bin/bash', 11:14:54 INFO - 'SHLVL': '1', 11:14:54 INFO - 'TERM': 'linux', 11:14:54 INFO - 'TMOUT': '86400', 11:14:54 INFO - 'USER': 'cltbld', 11:14:54 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1470419619.168255-1719598066', 11:14:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:54 INFO - '_': '/tools/buildbot/bin/python'} 11:14:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:54 INFO - Downloading/unpacking blobuploader==1.2.4 11:14:54 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 11:14:54 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 11:14:54 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 11:14:54 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 11:14:54 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 11:14:54 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 11:14:56 INFO - Downloading blobuploader-1.2.4.tar.gz 11:14:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:14:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:14:56 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 11:14:56 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 11:14:56 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 11:14:56 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 11:14:56 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 11:14:56 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 11:14:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:14:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:14:56 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 11:14:56 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 11:14:56 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 11:14:56 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 11:14:56 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 11:14:56 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 11:14:56 INFO - Downloading docopt-0.6.1.tar.gz 11:14:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:14:57 INFO - Installing collected packages: blobuploader, requests, docopt 11:14:57 INFO - Running setup.py install for blobuploader 11:14:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:14:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:14:57 INFO - Running setup.py install for requests 11:14:57 INFO - Running setup.py install for docopt 11:14:57 INFO - Successfully installed blobuploader requests docopt 11:14:57 INFO - Cleaning up... 11:14:57 INFO - Return code: 0 11:14:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:14:57 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')]} 11:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:57 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')]} 11:14:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:57 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 0x1cec030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1faa570>, '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 0x1fab470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fab900>, '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': 'fa44defc139c4ba8574fe040000001db-1470419619.168255-1719598066', '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 11:14:57 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 11:14:57 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 11:14:57 INFO - Using env: {'DISPLAY': ':0', 11:14:57 INFO - 'HOME': '/home/cltbld', 11:14:57 INFO - 'LANG': 'en_US.UTF-8', 11:14:57 INFO - 'LANGUAGE': 'en_US:en', 11:14:57 INFO - 'LOGNAME': 'cltbld', 11:14:57 INFO - 'MAIL': '/var/mail/cltbld', 11:14:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:57 INFO - 'MOZ_NO_REMOTE': '1', 11:14:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:57 INFO - 'NO_EM_RESTART': '1', 11:14:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:57 INFO - 'PWD': '/builds/slave/test', 11:14:57 INFO - 'SHELL': '/bin/bash', 11:14:57 INFO - 'SHLVL': '1', 11:14:57 INFO - 'TERM': 'linux', 11:14:57 INFO - 'TMOUT': '86400', 11:14:57 INFO - 'USER': 'cltbld', 11:14:57 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1470419619.168255-1719598066', 11:14:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:57 INFO - '_': '/tools/buildbot/bin/python'} 11:14:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:14:57 INFO - Running setup.py (path:/tmp/pip-jlsXsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:14:57 INFO - Running setup.py (path:/tmp/pip-fgXmb1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:14:57 INFO - Running setup.py (path:/tmp/pip-13LteM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:14:58 INFO - Running setup.py (path:/tmp/pip-Pptdww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:14:58 INFO - Running setup.py (path:/tmp/pip-_s3_XH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:14:58 INFO - Running setup.py (path:/tmp/pip-BtpoVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:14:58 INFO - Running setup.py (path:/tmp/pip-7LWefy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:14:58 INFO - Running setup.py (path:/tmp/pip-glutiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:14:58 INFO - Running setup.py (path:/tmp/pip-SEBEl6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:14:58 INFO - Running setup.py (path:/tmp/pip-qi6jZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:14:58 INFO - Running setup.py (path:/tmp/pip-7EVm_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:14:58 INFO - Running setup.py (path:/tmp/pip-FK3o9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:14:58 INFO - Running setup.py (path:/tmp/pip-RfQix4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:14:58 INFO - Running setup.py (path:/tmp/pip-igUGjJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:14:58 INFO - Running setup.py (path:/tmp/pip-Kr9E49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:14:58 INFO - Running setup.py (path:/tmp/pip-DGhZ6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:14:58 INFO - Running setup.py (path:/tmp/pip-rRt6rS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:14:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:14:59 INFO - Running setup.py install for manifestparser 11:14:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:14:59 INFO - Running setup.py install for mozcrash 11:14:59 INFO - Running setup.py install for mozdebug 11:14:59 INFO - Running setup.py install for mozdevice 11:14:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:14:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:14:59 INFO - Running setup.py install for mozfile 11:14:59 INFO - Running setup.py install for mozhttpd 11:14:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:14:59 INFO - Running setup.py install for mozinfo 11:14:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:14:59 INFO - Running setup.py install for mozInstall 11:14:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:14:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:14:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:14:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:14:59 INFO - Running setup.py install for mozleak 11:14:59 INFO - Running setup.py install for mozlog 11:15:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:15:00 INFO - Running setup.py install for moznetwork 11:15:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:15:00 INFO - Running setup.py install for mozprocess 11:15:00 INFO - Running setup.py install for mozprofile 11:15:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:15:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:15:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:15:00 INFO - Running setup.py install for mozrunner 11:15:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:15:00 INFO - Running setup.py install for mozscreenshot 11:15:00 INFO - Running setup.py install for moztest 11:15:00 INFO - Running setup.py install for mozversion 11:15:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:15:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:15:00 INFO - Cleaning up... 11:15:00 INFO - Return code: 0 11:15:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:15:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:00 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 0x1cec030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1faa570>, '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 0x1fab470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fab900>, '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': 'fa44defc139c4ba8574fe040000001db-1470419619.168255-1719598066', '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 11:15:00 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 11:15:00 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 11:15:00 INFO - Using env: {'DISPLAY': ':0', 11:15:00 INFO - 'HOME': '/home/cltbld', 11:15:00 INFO - 'LANG': 'en_US.UTF-8', 11:15:00 INFO - 'LANGUAGE': 'en_US:en', 11:15:00 INFO - 'LOGNAME': 'cltbld', 11:15:00 INFO - 'MAIL': '/var/mail/cltbld', 11:15:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:00 INFO - 'MOZ_NO_REMOTE': '1', 11:15:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:00 INFO - 'NO_EM_RESTART': '1', 11:15:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:00 INFO - 'PWD': '/builds/slave/test', 11:15:00 INFO - 'SHELL': '/bin/bash', 11:15:00 INFO - 'SHLVL': '1', 11:15:00 INFO - 'TERM': 'linux', 11:15:00 INFO - 'TMOUT': '86400', 11:15:00 INFO - 'USER': 'cltbld', 11:15:00 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1470419619.168255-1719598066', 11:15:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:00 INFO - '_': '/tools/buildbot/bin/python'} 11:15:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:15:01 INFO - Running setup.py (path:/tmp/pip-VnbbES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:15:01 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)) 11:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:15:01 INFO - Running setup.py (path:/tmp/pip-doaUVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:15:01 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)) 11:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:15:01 INFO - Running setup.py (path:/tmp/pip-KU0J6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:15:01 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)) 11:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:15:01 INFO - Running setup.py (path:/tmp/pip-fJes4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:15:01 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)) 11:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:15:01 INFO - Running setup.py (path:/tmp/pip-wimVXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:15:01 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)) 11:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:15:01 INFO - Running setup.py (path:/tmp/pip-fsOnCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:15:01 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)) 11:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:15:01 INFO - Running setup.py (path:/tmp/pip-08MfWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:15:01 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)) 11:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:15:01 INFO - Running setup.py (path:/tmp/pip-UKs9kC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:15:01 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)) 11:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:15:01 INFO - Running setup.py (path:/tmp/pip-LRO74E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:15:01 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)) 11:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:15:01 INFO - Running setup.py (path:/tmp/pip-af9bj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:15:01 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)) 11:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:15:01 INFO - Running setup.py (path:/tmp/pip-gypMos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:15:01 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)) 11:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:15:01 INFO - Running setup.py (path:/tmp/pip-sc5zw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:15:01 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)) 11:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:15:01 INFO - Running setup.py (path:/tmp/pip-LAqSMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:15:01 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)) 11:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:15:01 INFO - Running setup.py (path:/tmp/pip-D9bOeL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:15:02 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)) 11:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:15:02 INFO - Running setup.py (path:/tmp/pip-YSlYKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:15:02 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)) 11:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:15:02 INFO - Running setup.py (path:/tmp/pip-EdF0gx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:15:02 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)) 11:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:15:02 INFO - Running setup.py (path:/tmp/pip-xiOHeC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:15:02 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)) 11:15:02 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)) 11:15:02 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)) 11:15:02 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)) 11:15:02 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)) 11:15:02 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)) 11:15:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:15:02 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 11:15:02 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 11:15:02 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 11:15:02 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 11:15:02 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 11:15:02 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 11:15:04 INFO - Downloading blessings-1.6.tar.gz 11:15:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:15:04 INFO - Installing collected packages: blessings 11:15:04 INFO - Running setup.py install for blessings 11:15:04 INFO - Successfully installed blessings 11:15:04 INFO - Cleaning up... 11:15:04 INFO - Return code: 0 11:15:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:15:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:15:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:15:04 INFO - Reading from file tmpfile_stdout 11:15:04 INFO - Current package versions: 11:15:04 INFO - argparse == 1.2.1 11:15:04 INFO - blessings == 1.6 11:15:04 INFO - blobuploader == 1.2.4 11:15:04 INFO - docopt == 0.6.1 11:15:04 INFO - functools32 == 3.2.3-2 11:15:04 INFO - jsonschema == 2.5.1 11:15:04 INFO - manifestparser == 1.1 11:15:04 INFO - mozInstall == 1.12 11:15:04 INFO - mozcrash == 0.17 11:15:04 INFO - mozdebug == 0.1 11:15:04 INFO - mozdevice == 0.48 11:15:04 INFO - mozfile == 1.2 11:15:04 INFO - mozhttpd == 0.7 11:15:04 INFO - mozinfo == 0.9 11:15:04 INFO - mozleak == 0.1 11:15:04 INFO - mozlog == 3.3 11:15:04 INFO - moznetwork == 0.27 11:15:04 INFO - mozprocess == 0.23 11:15:04 INFO - mozprofile == 0.28 11:15:04 INFO - mozrunner == 6.12 11:15:04 INFO - mozscreenshot == 0.1 11:15:04 INFO - mozsystemmonitor == 0.3 11:15:04 INFO - moztest == 0.7 11:15:04 INFO - mozversion == 1.4 11:15:04 INFO - psutil == 3.1.1 11:15:04 INFO - requests == 1.2.3 11:15:04 INFO - wsgiref == 0.1.2 11:15:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:15:04 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')]} 11:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:04 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')]} 11:15:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:04 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 0x1cec030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1faa570>, '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 0x1fab470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fab900>, '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': 'fa44defc139c4ba8574fe040000001db-1470419619.168255-1719598066', '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 11:15:04 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 11:15:04 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 11:15:04 INFO - Using env: {'DISPLAY': ':0', 11:15:04 INFO - 'HOME': '/home/cltbld', 11:15:04 INFO - 'LANG': 'en_US.UTF-8', 11:15:04 INFO - 'LANGUAGE': 'en_US:en', 11:15:04 INFO - 'LOGNAME': 'cltbld', 11:15:04 INFO - 'MAIL': '/var/mail/cltbld', 11:15:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:04 INFO - 'MOZ_NO_REMOTE': '1', 11:15:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:04 INFO - 'NO_EM_RESTART': '1', 11:15:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:04 INFO - 'PWD': '/builds/slave/test', 11:15:04 INFO - 'SHELL': '/bin/bash', 11:15:04 INFO - 'SHLVL': '1', 11:15:04 INFO - 'TERM': 'linux', 11:15:04 INFO - 'TMOUT': '86400', 11:15:04 INFO - 'USER': 'cltbld', 11:15:04 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1470419619.168255-1719598066', 11:15:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:04 INFO - '_': '/tools/buildbot/bin/python'} 11:15:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:04 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)) 11:15:04 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)) 11:15:04 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)) 11:15:04 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)) 11:15:04 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)) 11:15:04 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)) 11:15:04 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)) 11:15:04 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)) 11:15:04 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)) 11:15:04 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)) 11:15:04 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)) 11:15:04 INFO - Cleaning up... 11:15:04 INFO - Return code: 0 11:15:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:15:04 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')]} 11:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:04 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')]} 11:15:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:04 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 0x1cec030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1faa570>, '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 0x1fab470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fab900>, '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': 'fa44defc139c4ba8574fe040000001db-1470419619.168255-1719598066', '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 11:15:04 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 11:15:04 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 11:15:04 INFO - Using env: {'DISPLAY': ':0', 11:15:04 INFO - 'HOME': '/home/cltbld', 11:15:04 INFO - 'LANG': 'en_US.UTF-8', 11:15:04 INFO - 'LANGUAGE': 'en_US:en', 11:15:04 INFO - 'LOGNAME': 'cltbld', 11:15:04 INFO - 'MAIL': '/var/mail/cltbld', 11:15:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:04 INFO - 'MOZ_NO_REMOTE': '1', 11:15:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:04 INFO - 'NO_EM_RESTART': '1', 11:15:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:04 INFO - 'PWD': '/builds/slave/test', 11:15:04 INFO - 'SHELL': '/bin/bash', 11:15:04 INFO - 'SHLVL': '1', 11:15:04 INFO - 'TERM': 'linux', 11:15:04 INFO - 'TMOUT': '86400', 11:15:04 INFO - 'USER': 'cltbld', 11:15:04 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1470419619.168255-1719598066', 11:15:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:04 INFO - '_': '/tools/buildbot/bin/python'} 11:15:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:15:05 INFO - Cleaning up... 11:15:05 INFO - Return code: 0 11:15:05 INFO - Running post-action listener: _resource_record_post_action 11:15:05 INFO - Running post-action listener: _start_resource_monitoring 11:15:05 INFO - Starting resource monitoring. 11:15:05 INFO - [mozharness: 2016-08-05 18:15:05.092866Z] Finished create-virtualenv step (success) 11:15:05 INFO - [mozharness: 2016-08-05 18:15:05.093336Z] Running install step. 11:15:05 INFO - Running pre-action listener: _resource_record_pre_action 11:15:05 INFO - Running main action method: install 11:15:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:15:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:15:05 INFO - Reading from file tmpfile_stdout 11:15:05 INFO - Detecting whether we're running mozinstall >=1.0... 11:15:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:15:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:15:05 INFO - Reading from file tmpfile_stdout 11:15:05 INFO - Output received: 11:15:05 INFO - Usage: mozinstall [options] installer 11:15:05 INFO - Options: 11:15:05 INFO - -h, --help show this help message and exit 11:15:05 INFO - -d DEST, --destination=DEST 11:15:05 INFO - Directory to install application into. [default: 11:15:05 INFO - "/builds/slave/test"] 11:15:05 INFO - --app=APP Application being installed. [default: firefox] 11:15:05 INFO - mkdir: /builds/slave/test/build/application 11:15:05 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'] 11:15:05 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 11:15:21 INFO - Reading from file tmpfile_stdout 11:15:21 INFO - Output received: 11:15:21 INFO - /builds/slave/test/build/application/firefox/firefox 11:15:21 INFO - Running post-action listener: _resource_record_post_action 11:15:21 INFO - [mozharness: 2016-08-05 18:15:21.359226Z] Finished install step (success) 11:15:21 INFO - [mozharness: 2016-08-05 18:15:21.359506Z] Running run-tests step. 11:15:21 INFO - Running pre-action listener: _resource_record_pre_action 11:15:21 INFO - Running main action method: run_tests 11:15:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:15:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:15:21 INFO - Python 2.7.3 11:15:21 INFO - Return code: 0 11:15:21 INFO - grabbing minidump binary from tooltool 11:15: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')]} 11:15:21 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1faa570>, '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 0x1fab470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fab900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:15:21 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:15:21 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:15:21 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:15:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:15:21 INFO - Return code: 0 11:15:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:15:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:15:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:15:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:15:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:15:21 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/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 11:15:21 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/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --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 11:15:21 INFO - Using env: {'DISPLAY': ':0', 11:15:21 INFO - 'HOME': '/home/cltbld', 11:15:21 INFO - 'LANG': 'en_US.UTF-8', 11:15:21 INFO - 'LANGUAGE': 'en_US:en', 11:15:21 INFO - 'LOGNAME': 'cltbld', 11:15:21 INFO - 'MAIL': '/var/mail/cltbld', 11:15:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:15:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:15:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:21 INFO - 'MOZ_NO_REMOTE': '1', 11:15:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:15:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:21 INFO - 'NO_EM_RESTART': '1', 11:15:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:21 INFO - 'PWD': '/builds/slave/test', 11:15:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:15:21 INFO - 'SHELL': '/bin/bash', 11:15:21 INFO - 'SHLVL': '1', 11:15:21 INFO - 'TERM': 'linux', 11:15:21 INFO - 'TMOUT': '86400', 11:15:21 INFO - 'USER': 'cltbld', 11:15:21 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1470419619.168255-1719598066', 11:15:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:21 INFO - '_': '/tools/buildbot/bin/python'} 11:15:21 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/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 11:15:21 INFO - mozversion application_buildid: 20160805072232 11:15:21 INFO - mozversion application_changeset: 307fe134b473938131cb0f28db52cf371883f663 11:15:21 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:15:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:15:21 INFO - mozversion application_name: Firefox 11:15:21 INFO - mozversion application_remotingname: firefox-dev 11:15:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:15:21 INFO - mozversion application_vendor: Mozilla 11:15:21 INFO - mozversion application_version: 50.0a2 11:15:21 INFO - mozversion platform_buildid: 20160805072232 11:15:21 INFO - mozversion platform_changeset: 307fe134b473938131cb0f28db52cf371883f663 11:15:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:15:21 INFO - mozversion platform_version: 50.0a2 11:15:21 INFO - using testdate: 1470420921 11:15:21 INFO - actual date: 1470420921 11:15:21 INFO - starting webserver on 'localhost:41174' 11:15:21 INFO - SUITE-START | Running 2 tests 11:15:21 INFO - TEST-START | dromaeo_css 11:15:21 INFO - operating with platform_type : linux_ 11:15:21 INFO - Initialising browser for dromaeo_css test... 11:15:21 INFO - TEST-INFO | started process 23128 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyzVMjQ/profile http://localhost:41174/getInfo.html) 11:15:26 INFO - PROCESS | 23128 | __metrics Screen width/height:1600/1200 11:15:26 INFO - PROCESS | 23128 | colorDepth:24 11:15:26 INFO - PROCESS | 23128 | Browser inner width/height: 1024/697 11:15:26 INFO - PROCESS | 23128 | __metrics 11:15:27 ERROR - PROCESS | 23128 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 11:15:27 INFO - TEST-INFO | 23128: exit 0 11:15:27 INFO - Browser initialized. 11:15:27 INFO - Running cycle 1/1 for dromaeo_css test... 11:15:27 INFO - TEST-INFO | started process 23254 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyzVMjQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:15:39 INFO - PROCESS | 23254 | RSS: Main: 152465408 11:15:39 INFO - PROCESS | 23254 | 11:16:29 INFO - PROCESS | 23254 | 1470420989326 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] 11:18:37 INFO - PROCESS | 23254 | Cycle 1(1): loaded http://localhost:41174/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41174/tests/dromaeo/cssquery-ext.html) 11:18:39 INFO - PROCESS | 23254 | RSS: Main: 158384128 11:18:39 INFO - PROCESS | 23254 | 11:21:41 INFO - PROCESS | 23254 | Cycle 1(1): loaded http://localhost:41174/tests/dromaeo/cssquery-ext.html (next: http://localhost:41174/tests/dromaeo/cssquery-jquery.html) 11:21:41 INFO - PROCESS | 23254 | RSS: Main: 153018368 11:21:41 INFO - PROCESS | 23254 | 11:24:43 INFO - PROCESS | 23254 | Cycle 1(1): loaded http://localhost:41174/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41174/tests/dromaeo/cssquery-mootools.html) 11:24:43 INFO - PROCESS | 23254 | RSS: Main: 153325568 11:24:43 INFO - PROCESS | 23254 | 11:27:45 INFO - PROCESS | 23254 | Cycle 1(1): loaded http://localhost:41174/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41174/tests/dromaeo/cssquery-prototype.html) 11:27:46 INFO - PROCESS | 23254 | RSS: Main: 152100864 11:27:46 INFO - PROCESS | 23254 | 11:30:48 INFO - PROCESS | 23254 | Cycle 1(1): loaded http://localhost:41174/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41174/tests/dromaeo/cssquery-yui.html) 11:30:49 INFO - PROCESS | 23254 | RSS: Main: 154734592 11:30:49 INFO - PROCESS | 23254 | 11:33:51 INFO - PROCESS | 23254 | Cycle 1(1): loaded http://localhost:41174/tests/dromaeo/cssquery-yui.html (next: http://localhost:41174/tests/dromaeo/cssquery-dojo.html) 11:33:51 INFO - PROCESS | 23254 | RSS: Main: 155443200 11:33:51 INFO - PROCESS | 23254 | 11:33:51 INFO - PROCESS | 23254 | __start_tp_report 11:33:51 INFO - PROCESS | 23254 | _x_x_mozilla_page_load 11:33:51 INFO - PROCESS | 23254 | _x_x_mozilla_page_load_details 11:33:51 INFO - PROCESS | 23254 | |i|pagename|runs| 11:33:51 INFO - PROCESS | 23254 | |0;dojo.html;3348.84930178142;3372.376110419571;3373.190434295769;3386.3058073095017;3399;5804.390538993398;5814.2441482607255;5852.122181672751;5852.561057920651;5875.529957603392;5819.650820950746;5822;5850.502707269877;5857.824265272038;5862.032764593837;5226.634135610509;5290.259363689087;5293.735313234342;5320.14877619581;5343.332083489564;5178.119719647669;5180.481951804827;5254.343207099113;5264.315638966929;5306;5213.7393130343335;5219.086659834533;5239.240310155025;5325.866853328659;5376.731163441832;5310.230016647564;5330.253764472977;5340.118880384752;5340.412554618989;5355.116405793039;5123.8206662767;5147.897042059138;5147.897042059175;5188.766505507261;5301.390340110859;5685.800996965087;5766.6448384629575;5773.826785196451;5792.218050563204;5827.4755272025295;6233.5948163369685;6265.934791085527;6267.435930766253;6283.622982621057;6287.559870809046;6123.069106197319;6134.079888016789;6245.968770156165;6295.338989406138;6305.306416294204;5744.712764361765;5820.35976042635;5837.270341207349;5857.326407463111;5873.500752436048;6294.937050629526;6309.621422714652;6357.523185760994;6361.9045714314325;6366.26787919386;5929.644221346647;6056.528932209105;6112.989854784112;6118.388161183935;6125.418085281891;6172.321044685081;6249.281332646713;6324.9051264231075;6326.367363263636;6334.3032266450655;6229.190205273286;6268.686565671698;6278.811635650938;6282.183316168869;6282.434580887742;6080.604760690541;6094.878102437927;6283.654399008007;6299.653519056405;6321.557490975588;4698.177818881751;4702.482726900038;4722.504137065627;4763.571278584944;4811.446683631427;4247.193033323659;4255.638270746959;4270.889568712158;4275.722078064916;4282.957170428256;5975.52195824333;6012.338642749294;6018.789342373084;6018.969905150446;6029.728662210211;6109.28320792043;6175.722092505848;6180.072989051679;6185.597936134137;6248.250209974741;5930.851728706731;5988.401159884064;6001.489873360726;6013.0980352946535;6022.337542870281;5285.814996475105;5343.385510666245;5375.865603359947;5395.055865223649;5397.487238712316;6404.327545607644;6436.163298771224;6469.967650161719;6544.640044797487;6562.80311590653;6255.31191568918;6262;6270.467010304175;6274.309825919237;6328.272248691459;6218.751249949952;6535.934640653532;6549.377809108127;6551.148350714377;6558.704858281293;6084.178635884276;6109.816705498843;6135.84660383494;6141.36327073057;6161.630302181883;6209.316975132822;6247.406496382836;6249.78125765596;6257.09272155544;6276.215473065867;5929.970350148222;6085.817425477243;6152.384761523812;6159.846003849761;6169.259688837368;6043.486303664238;6081.5134789217645;6082.239720034996;6118.76967209854;6121.727351053096;6070.575059745775;6088.056351265561;6099.420555047263;6104.725287361991;6110.358412366638;5934.6142500737315;6108.175396321618;6124.38756124384;6180.783672571439;6200.441960223421;5843.620164689281;5849.356570777296;5888.499477544457;5921.61509501881;5949.494292985145 11:33:51 INFO - PROCESS | 23254 | |1;ext.html;582.1558739827249;629.4838232649224;641.5092454272481;662.1491383572107;692.1521136607653;41779.16441671165;46692;47080.52919470804;47090;47151.292730608984;47514.28728569074;47899;47971.520284797145;48132.75933620336;48172.27741583879;9124.726258212248;9265.305102117369;9288.767780805467;9295.814083718322;9317.673881414152;9153.954230228874;9301.395409298408;9302.953485232565;9307.441553506778;9316.487593182372;9285.860712089325;9314.394564353295;9339.673111441101;9347.392419492746;9353.11145441182;9182.31132665046;9277.97942226358;9293.21007714345;9296.163345298923;9310.627574896997;9292;9316.394434361813;9320.067993200693;9351;9366.906330936672;43747.34378984318;43990;44201.11597768027;44403.77798110989;44472.555274447164;3881.922361552753;3950.308695978221;3971.225611005855;4189.183109293689;4375.584319489643;34031.829840850885;34558.82720586381;34599.82700086509;34883.82558087193;34917.30165396678;4441.444819397575;4460.553944605546;4494.348319493655;4508.301213311942;4508.864734057984;350468;356941;358762;362100;363646;67046.66476667585;67443.32556674468;67674.66162669254;67849.32150678529;68039.65980170068;67955;68219.65890170616;68257.31742682609;68351;68380.6580967092;17368.739468907977;18118.728219076726;18324;18648.254069837054;18700.06499675011;14762.778558321634;15058.924705376403;15071.849281507264;15078.623034424227;15128.848711512965;20363.796362036486;20507.8974605129;20564.897175514026;20680.689789653166;20821.89589052045;7733.7679869604;7767.36885254103;7979.880301795478;7992.400569957276;8048.396370272253;1092.5029111754134;1120.0479592346603;1124.5691973623896;1187.9724038706456;1247.8689737577606;34733.47899781505;34794.82602586971;35087.29825403529;35132.82433587867;35215.11962200965;1220.9877901221053;1223.7919553675897;1232.4084439469104;1271.2753730373784;1302.5571305755898;18257;18351.816481835012;18357.7246341305;18406.35577754772;18445.631087378177;544227;553338;554152;568338;885098;65453;66277.66861165663;66301;66606;66919.33080669228;1478.2682572126866;1480.9259537023106;1493.1253397433643;1493.7087267982638;1499.3852520466555;34651.4802277961;35912.8204358987;35927.64072359243;36154.63845361512;36309.63690363168;58242.7087864558;58375.70812145912;59177.704111479165;59252;59272;514234;518787;519123;519422;520179;31756.20609484689;33444.1638959028;33502.66497335093;33544.83227583847;33564.66435335615;54029.45970540401;54133.66361357143;54181;54785.726071370984;55882;46075.53924460713;46151.3077303834;46975.29537056878;47997.76001119972;48521.27218091802;48409.75795121002;48566.27150592815;48915.75542122267;49115.50884491109;49217;39778.801105995444;44922.66240894096;46522.76738616285;48615.27077093917;49433;38951.220975580894;40462.797686011385;40843.59156408398;41226;41766.37350439685;31160.22099447532;31495.370092598478;31698.366032679678;31716;32021.8398908004 11:33:51 INFO - PROCESS | 23254 | |2;jquery.html;413.4583695359078;414.54814252464814;417.4427139768409;420.298102169377;436.8296364417878;18953.241870325186;19708.704369434454;20439.080241389136;21093.57812843746;21350.786492135074;20267.189312427487;20367;20473.18107275707;20624.9687515624;20866.37400877976;5946.79186228481;6125.785597504088;6143.907841382383;6161.383861613847;6164.260288765355;5988.251468566429;6009.789657361993;6013.037913933771;6076.605020673642;6079.300880398744;5831;5994.980853254935;6022.187004754368;6024.246969128859;6024.307204671453;5951.910721339162;5957.404259574029;5990.610610310359;6012.5791194616395;6016.518678505709;5380.461953804627;5384.326959130109;5425.864353391157;5426.91859622102;5432.728363581845;24118.879405603035;24438.755612443827;24479.755202447926;24716;24937.750622493724;2766.432881259357;2984.925376865574;3075.692430756929;3138.76459265556;3326.600807903043;15269.770953435596;15454.304556294994;15785.13181775002;15928.522144335688;16065;2061.2167376396874;2159;2185.1041073159927;2238.362066810951;2251.9774802252095;77375.22624773793;78314.21685783184;79438.60280698618;81423.59288203581;81978.59010704968;11296;11475.54097836094;11618.76762464763;11710.82891710839;12552.372381380894;16219.270132843814;16242.269097890623;16253.69970402365;16262.268197931122;16314.857959942927;8849.778755531035;9061.54692265384;9106.726798196065;9156.771080722901;9316.301277404222;8374.623141958626;8438.746837594881;8590.441621294596;8858.069902660256;8888.244499217639;6896.793096207121;7049.859002820018;7117.252688467636;7139.464540159405;7232.421406287484;1975.032234205229;2068.43118142512;2074.4399012266604;2091.0276721324353;2188.1466228171025;962.7448726087592;1060.48036462133;1068.0974576482859;1070.5610699613278;1078.4931082391263;20618.896905515678;21185.576288474145;21219.15123395047;21465.141394344053;21552.13791448356;1096.6874440784338;1097.319661809683;1098.1763677242068;1099.5052226498108;1120.7030137013699;11754.412279385997;11898.583549575724;12010;12164.452599633038;12202.633920982385;522000;528575;533604;543425;547325;50260.497395026316;54149.72925135428;80258;84849.57575212084;85568.57215714006;1084.1976937066513;1097.8902109789117;1100.2793170473353;1103.8454616353717;1109.2457129152092;14513.92743036278;17663.38178163758;18724.157412916178;18987.525311867314;19025.80974190296;29726.405471890874;39626;40207.396889046104;40926;41228.350865965025;60598;62041.65983596464;62114;63075.36924630879;64031.6798416005;9029.503377314311;9198.54007299619;9427.528623568931;9488.098630630078;9561.856572151562;13571.52499662507;13755.17468951866;13820.585382438543;14272.785908211592;14400.973362188168;12587.93706031464;12730.618081457571;12732;12859.357032148542;12865.742685146057;11924.880751192377;12013.819792702941;12067.879321207027;12185.451654675384;13040.282784446947;11870.940645296718;12192.390380480763;12264.754704905674;12346.691332716753;12404.317762522787;8095.797605059921;8233.135520770233;8359.95820020896;9546.18857397129;9618.903810962081;9958.402495850272;12502.437390317276;12539.623811285675;12594.307313097868;12854.421551030038 11:33:51 INFO - PROCESS | 23254 | |3;mootools.html;1543.706695727812;1569.4350033987766;1742.407581422316;1864.6457173137094;1868.6729822281097;8487.91512084879;8964.462132272069;9042.683506077288;9709.854352184713;9768.609255629766;9180;9443.433393996347;9456.196223321025;9463.81072378552;9471.857922131156;2434.1602147259214;2474.5793215153376;2479;2490.5766019776593;2494.3390001649577;2406.3502854229346;2541.2503311523146;2546.401595625027;2548.6941567011986;2552.8595927223996;2503.249025292414;2507.022261318087;2535.771780539751;2542.834715743471;2545.185540627;2405.530921470323;2423.333583264599;2425.1875621666763;2451;2458;2341.953160936772;2349.6827928229814;2355.5759963206615;2357.669926210332;2367.0768400323886;9472.336936414455;9511.857322140173;9613.56738946742;9622.855657165148;9633.229341652652;5502.367227768817;5594.608377413582;5643.717814109319;5646.604737668365;5649.548036157139;3416.6070901846356;3550.0769799852224;3601.6398360163776;3620.0587847159663;3687.520622319108;1157.1841851494676;1188.5305304404712;1244.3715923458597;1258.9685257868534;1293.1336004876755;13262.602121936357;13283;13286.800697989538;13312.201267923858;13375.33123343829;4798.256270278112;4865.464798872121;5013.097642424325;5021.6735912165595;5103.744812759347;11174.888251117547;11187.888121118685;11189.944050279859;11213.439328033566;11228.719282018015;5703.201551782754;5714.599978001583;5721.799737009268;5723.942760572424;5725.942740572625;4596.057808149321;5088.821891233789;5148.330717006766;5154.381474223117;5267.051930652519;4301.763403012865;4323.113761678848;4353.4122893408985;4362.367456718758;4372.868813935587;1261.6908857330013;1315.046591221357;1324.09961226367;1328.973420531584;1336.432016393029;989.1147423056324;993.0615568287899;1009.2934945538153;1009.6012075230243;1014.7666036811574;6137;6234.470070044006;6371.904421433682;6446.548741588043;6491.318411566812;1080.152080616712;1127.6053381316474;1149.844770955927;1153.377176324792;1159.7622487390065;4142.834286628501;4234.343676730112;4279.507856596531;4294.26997410441;4329.76186309756;11851.585194518151;11987.580434684918;12227.938860305641;12309.56916507918;12315;11955.163138580216;12099.153059285942;12140.635780926586;12142.514299428101;12155.696107597203;8692.52191129494;8733.214010739064;8816.691415800544;8823.691170808863;8826.249768769598;6367.968160159169;6470.22357317125;6470.708818103102;6497.675116244074;6545.574537655038;10442;10896.564137434414;10991.780164396827;10998.670039898816;11071.335719856834;10772.89227107719;11080.39057851826;11174.49714762854;11182.273152245078;11288.322700637988;7786.104597971306;8275.255227029596;8479.448835825651;8525.232729054414;8666.090060543553;9363.625454981724;9371.578278977326;9391.483468409304;9398.01320861327;9451.243900487807;7658.234176582298;7813.882791758015;8071.677132914852;8091.55496447701;8153.877691834746;7747.34147597438;7782.844343113219;7832.177621349676;7924.603769811371;8039.075506316614;7483.588402637907;7642.235776422313;7655.61721913891;7689.577073261024;7722.420818438752;5543.750531226024;5585.441455854545;5603.859903502445;5622.32532096151;5730.025895597675;5382.569394448513;5426.891462170814;5509.724513774376;5533.087040638249;5550.0564903965615 11:33:51 INFO - PROCESS | 23254 | |4;prototype.html;340.71550255536624;356.2572037302225;357.1927443976612;357.5923447270111;357.77996532132715;5828.562857785661;5863.1205319202145;5908.497777688896;5966;5969.552283578732;5759.366469688331;5869.266341707286;5883.646761244916;5885.49973252273;5888.11678248263;4432.512423633398;4579.175748365293;4579.335996280537;4612.215923293048;4632.583067523922;4592.7014744041535;4602.447706275251;4608.608268297182;4621.491635920046;4628.352030715702;4552.8634140975655;4578.748168850712;4582.175208462475;4609.170349337118;4613.400257966459;4457.955420445786;4507.481639611454;4608.9308660370125;4621.168189725848;4623.220060276784;4002.3796311571755;4025.1547175093265;4026.778527181004;4042.2319759245943;4045.1707399982934;5687.431256874321;5697.202391665171;5719.6854173020465;5727.398623144593;5749.568782341299;4939.901201975977;5158.92261616076;5271.998320319127;5273.3935597406025;5287.603429742785;6018.187544681456;6031;6057.545684073668;6062.636241825505;6121.938780612181;4312.059573192076;4378.9709418286675;4379.693421460499;4380.773383452606;4381.518033016366;6235.721677056193;6279.497640188774;6300.27546832111;6331.461825744817;6379.776707815251;4428.601425871687;4428.870637987357;4474.597286244189;4484.910301793946;4501.167284052461;4532.342810292555;4535.433070866142;4542.659300552472;4544.909101818012;4552.292890166188;5018.824341148043;5123.462036486189;5144.176931690911;5145.996530676557;5188.429272779991;6049.364816694272;6058.303295121117;6059.363971727609;6075.210222671025;6106.358832322631;1542.1980570103483;1563.7177514438279;1572.3631929068745;1572.606848287928;1573.6309410812437;1004.5780772075746;1055.8363453664695;1062.4315990944808;1071.6195750508457;1079.1582565598846;5872.324682661549;5877.9118313225335;5880.970595147082;5970.223870896755;6002.879942401215;6021.789237376671;6234.189555357774;6258.15514905491;6309.526785491014;6311.589746666452;5859.619124756877;5885.735141918624;5898.616589921641;5926.822195334147;5929.644221346733;3278.541004259406;3315.419801534722;3352.7317814574776;3356.56364672591;3371.696547310754;6211;6431.260405053479;6482.416582507597;6489.70796314167;6515.218173819172;6163.476104531165;6386.680665966683;6423.903641445382;6435.742570297136;6522.836929076716;6294.559380843297;6423.903641445382;6462.095306657072;6509.576877503042;6510.446612037935;6252.874942501034;6268.028455589391;6296.229658950047;6333.5116247680835;6338.809835704752;6035.185249991195;6161.168242287234;6188.44304012641;6231.781887633911;6240.719167637558;6481.708323125376;6553.590977939766;6553.803385898431;6588.242352129375;6605.867882642224;4332.50176229725;4489.842855500173;4504;4510.797014134438;4528.43394575678;6294.8111556653375;6295.324487092876;6309.432151106423;6333.493320534439;6355.14205582259;6022.668753218615;6206.596571222856;6222.906656400067;6240.12638230639;6290.804747098036;6132.509399248139;6150.692465376624;6164.568480206342;6166;6170.784022559189;6153.569250152446;6160;6160.291566469913;6162.106494558354;6178.69106544662;5940.79207227745;6182.659953702409;6191;6245.344238854855;6266.717997690023;6025.517958563217;6073.423024812636;6091.634501929899;6097.847553811191;6105.504151482915 11:33:51 INFO - PROCESS | 23254 | |5;yui.html;838.1576515601821;840.2731637133877;854.3165467625897;918.6784625381115;960.9807803843919;16159.192040397991;18366.35717749879;18430.170642321093;18490.537736556595;18604.25582976681;15629.531114066596;16232.863699541036;16387.83612163878;16537.83462165378;16709.66580668389;873.3144481581959;904.5296445848155;906.1346414174448;907.1971305394708;909.236241557092;894.9552522373888;898.3262553085186;899.4693131052678;901.2249465459699;901.4185850126697;951.5575257505259;951.6954574536152;954.265215783846;954.8376775948105;957.593022965237;941.5480569326727;942.241495596045;943.1181844974936;944.0889541592362;944.900785417535;694.8262934266434;695.9512834101615;697.9685914133876;699.6606645776794;700.726716580534;14998.325075371635;15048.398064077424;15149.469768558047;15173.924130379277;15492.612684682861;14203.218822964733;15378.923105384514;15488.380464781396;15568.455104071303;15961.760573591406;12982.740345193044;13050.934745326213;13069;13158.407871645799;13231.073824832265;4041.7777022263763;4070.69469789764;4093.9590604093873;4118.567550407224;4127.174565086994;65805;66224.66887665531;67156.6642166786;72656.273437266;91110.08889911082;11596;11618.825717614243;11768.411579420994;11793.705157371134;12152;21785.782142178694;22599.774002260096;22675.092996280295;23518.176863809684;23731.525369492512;8480;9150.450972941644;9228.953855230815;9437.528123593793;9531.285153613506;4929.383827021622;4990.50094990498;5297.655652382583;5313.30926979498;5335.653182543122;3965.405189221582;4133.276676581586;4134;4146.150039241948;4154.709170358106;687.1685260834446;690.9792706218822;713.2225873797586;713.6645776485044;714.4106112457243;637.626988211892;648.4229036157823;653.4086651580327;675.3584095109666;705.1784670858495;10327.535260913126;10334.534945927451;10661.466926653637;10667.83998240027;10723;766.31797700047;773.8761798112275;779.1779672445624;782.0732432068017;783.3693876429415;5095.464976177522;5102.2346648003095;5133.153029750124;5209.218617207373;5215.217717342429;115650.42174789072;115875;116323;120392;129713;86065.13934860697;90382;94356.52821735847;94696.52651736834;101050.98949010563;80273.59863200647;88634.11365886258;89524.55237723769;90812;90940.54529727441;9765.60937562518;10045;10255.897441025494;10343.741406464898;10401.68794936153;51620.48379516157;51922.740386297824;52674.47325526849;53154.2026869605;54408.183877241085;73682;76366;81249.18750812416;83435.16564834517;84943.57528212319;13232.272225027331;13515.932420337835;13712.93143534276;13960.092593981359;14077.436902523785;14957.476488322856;15246.923765381101;15604.843951560339;15633.29650165768;15924.92037539805;14245.145291282557;14439.639009024439;14505.347259373142;14505.564833055025;14760.409583616965;14120.576382708536;14265.857341426452;14385;14453.927730361282;14504;14097.718045638825;14479.85520144785;14481.275936202937;14755.621260400732;14901.925490372912;10579.62971296001;10588.417637030037;10799.460026998462;11306.208565400671;11527.654170374903;10497.632582859564;10659.573617055541;11416.543338266709;11454.713632159262;11594.6521604352 11:33:51 INFO - PROCESS | 23254 | __end_tp_report 11:33:51 INFO - PROCESS | 23254 | __start_cc_report 11:33:51 INFO - PROCESS | 23254 | _x_x_mozilla_cycle_collect,327 11:33:51 INFO - PROCESS | 23254 | __end_cc_report 11:33:51 INFO - PROCESS | 23254 | __startTimestamp1470422031853__endTimestamp 11:33:51 INFO - PROCESS | 23254 | 11:33:51 INFO - PROCESS | 23254 | ------- Summary: start ------- 11:33:51 INFO - PROCESS | 23254 | Number of tests: 6 11:33:51 INFO - PROCESS | 23254 | 11:33:51 INFO - PROCESS | 23254 | [#0] dojo.html Cycles:165 Average:5790.57 Median:6029.73 stddev:665.60 (11.0%) stddev-sans-first:639.48 11:33:51 INFO - PROCESS | 23254 | Values: 3348.8 3372.4 3373.2 3386.3 3399.0 5804.4 5814.2 5852.1 5852.6 5875.5 5819.7 5822.0 5850.5 5857.8 5862.0 5226.6 5290.3 5293.7 5320.1 5343.3 5178.1 5180.5 5254.3 5264.3 5306.0 5213.7 5219.1 5239.2 5325.9 5376.7 5310.2 5330.3 5340.1 5340.4 5355.1 5123.8 5147.9 5147.9 5188.8 5301.4 5685.8 5766.6 5773.8 5792.2 5827.5 6233.6 6265.9 6267.4 6283.6 6287.6 6123.1 6134.1 6246.0 6295.3 6305.3 5744.7 5820.4 5837.3 5857.3 5873.5 6294.9 6309.6 6357.5 6361.9 6366.3 5929.6 6056.5 6113.0 6118.4 6125.4 6172.3 6249.3 6324.9 6326.4 6334.3 6229.2 6268.7 6278.8 6282.2 6282.4 6080.6 6094.9 6283.7 6299.7 6321.6 4698.2 4702.5 4722.5 4763.6 4811.4 4247.2 4255.6 4270.9 4275.7 4283.0 5975.5 6012.3 6018.8 6019.0 6029.7 6109.3 6175.7 6180.1 6185.6 6248.3 5930.9 5988.4 6001.5 6013.1 6022.3 5285.8 5343.4 5375.9 5395.1 5397.5 6404.3 6436.2 6470.0 6544.6 6562.8 6255.3 6262.0 6270.5 6274.3 6328.3 6218.8 6535.9 6549.4 6551.1 6558.7 6084.2 6109.8 6135.8 6141.4 6161.6 6209.3 6247.4 6249.8 6257.1 6276.2 5930.0 6085.8 6152.4 6159.8 6169.3 6043.5 6081.5 6082.2 6118.8 6121.7 6070.6 6088.1 6099.4 6104.7 6110.4 5934.6 6108.2 6124.4 6180.8 6200.4 5843.6 5849.4 5888.5 5921.6 5949.5 11:33:51 INFO - PROCESS | 23254 | 11:33:51 INFO - PROCESS | 23254 | [#1] ext.html Cycles:180 Average:67882.35 Median:46607.38 stddev:137506.31 (295.0%) stddev-sans-first:137799.21 11:33:51 INFO - PROCESS | 23254 | Values: 582.2 629.5 641.5 662.1 692.2 41779.2 46692.0 47080.5 47090.0 47151.3 47514.3 47899.0 47971.5 48132.8 48172.3 9124.7 9265.3 9288.8 9295.8 9317.7 9154.0 9301.4 9303.0 9307.4 9316.5 9285.9 9314.4 9339.7 9347.4 9353.1 9182.3 9278.0 9293.2 9296.2 9310.6 9292.0 9316.4 9320.1 9351.0 9366.9 43747.3 43990.0 44201.1 44403.8 44472.6 3881.9 3950.3 3971.2 4189.2 4375.6 34031.8 34558.8 34599.8 34883.8 34917.3 4441.4 4460.6 4494.3 4508.3 4508.9 350468.0 356941.0 358762.0 362100.0 363646.0 67046.7 67443.3 67674.7 67849.3 68039.7 67955.0 68219.7 68257.3 68351.0 68380.7 17368.7 18118.7 18324.0 18648.3 18700.1 14762.8 15058.9 15071.8 15078.6 15128.8 20363.8 20507.9 20564.9 20680.7 20821.9 7733.8 7767.4 7979.9 7992.4 8048.4 1092.5 1120.0 1124.6 1188.0 1247.9 34733.5 34794.8 35087.3 35132.8 35215.1 1221.0 1223.8 1232.4 1271.3 1302.6 18257.0 18351.8 18357.7 18406.4 18445.6 544227.0 553338.0 554152.0 568338.0 885098.0 65453.0 66277.7 66301.0 66606.0 66919.3 1478.3 1480.9 1493.1 1493.7 1499.4 34651.5 35912.8 35927.6 36154.6 36309.6 58242.7 58375.7 59177.7 59252.0 59272.0 514234.0 518787.0 519123.0 519422.0 520179.0 31756.2 33444.2 33502.7 33544.8 33564.7 54029.5 54133.7 54181.0 54785.7 55882.0 46075.5 46151.3 46975.3 47997.8 48521.3 48409.8 48566.3 48915.8 49115.5 49217.0 39778.8 44922.7 46522.8 48615.3 49433.0 38951.2 40462.8 40843.6 41226.0 41766.4 31160.2 31495.4 31698.4 31716.0 32021.8 11:33:51 INFO - PROCESS | 23254 | 11:33:51 INFO - PROCESS | 23254 | [#2] jquery.html Cycles:180 Average:30366.14 Median:24597.88 stddev:87563.89 (356.0%) stddev-sans-first:87780.65 11:33:51 INFO - PROCESS | 23254 | Values: 413.5 414.5 417.4 420.3 436.8 18953.2 19708.7 20439.1 21093.6 21350.8 20267.2 20367.0 20473.2 20625.0 20866.4 5946.8 6125.8 6143.9 6161.4 6164.3 5988.3 6009.8 6013.0 6076.6 6079.3 5831.0 5995.0 6022.2 6024.2 6024.3 5951.9 5957.4 5990.6 6012.6 6016.5 5380.5 5384.3 5425.9 5426.9 5432.7 24118.9 24438.8 24479.8 24716.0 24937.8 2766.4 2984.9 3075.7 3138.8 3326.6 15269.8 15454.3 15785.1 15928.5 16065.0 2061.2 2159.0 2185.1 2238.4 2252.0 77375.2 78314.2 79438.6 81423.6 81978.6 11296.0 11475.5 11618.8 11710.8 12552.4 16219.3 16242.3 16253.7 16262.3 16314.9 8849.8 9061.5 9106.7 9156.8 9316.3 8374.6 8438.7 8590.4 8858.1 8888.2 6896.8 7049.9 7117.3 7139.5 7232.4 1975.0 2068.4 2074.4 2091.0 2188.1 962.7 1060.5 1068.1 1070.6 1078.5 20618.9 21185.6 21219.2 21465.1 21552.1 1096.7 1097.3 1098.2 1099.5 1120.7 11754.4 11898.6 12010.0 12164.5 12202.6 522000.0 528575.0 533604.0 543425.0 547325.0 50260.5 54149.7 80258.0 84849.6 85568.6 1084.2 1097.9 1100.3 1103.8 1109.2 14513.9 17663.4 18724.2 18987.5 19025.8 29726.4 39626.0 40207.4 40926.0 41228.4 60598.0 62041.7 62114.0 63075.4 64031.7 9029.5 9198.5 9427.5 9488.1 9561.9 13571.5 13755.2 13820.6 14272.8 14401.0 12587.9 12730.6 12732.0 12859.4 12865.7 11924.9 12013.8 12067.9 12185.5 13040.3 11870.9 12192.4 12264.8 12346.7 12404.3 8095.8 8233.1 8360.0 9546.2 9618.9 9958.4 12502.4 12539.6 12594.3 12854.4 11:33:51 INFO - PROCESS | 23254 | 11:33:51 INFO - PROCESS | 23254 | [#3] mootools.html Cycles:180 Average:6249.70 Median:4357.89 stddev:3591.41 (82.4%) stddev-sans-first:3584.08 11:33:51 INFO - PROCESS | 23254 | Values: 1543.7 1569.4 1742.4 1864.6 1868.7 8487.9 8964.5 9042.7 9709.9 9768.6 9180.0 9443.4 9456.2 9463.8 9471.9 2434.2 2474.6 2479.0 2490.6 2494.3 2406.4 2541.3 2546.4 2548.7 2552.9 2503.2 2507.0 2535.8 2542.8 2545.2 2405.5 2423.3 2425.2 2451.0 2458.0 2342.0 2349.7 2355.6 2357.7 2367.1 9472.3 9511.9 9613.6 9622.9 9633.2 5502.4 5594.6 5643.7 5646.6 5649.5 3416.6 3550.1 3601.6 3620.1 3687.5 1157.2 1188.5 1244.4 1259.0 1293.1 13262.6 13283.0 13286.8 13312.2 13375.3 4798.3 4865.5 5013.1 5021.7 5103.7 11174.9 11187.9 11189.9 11213.4 11228.7 5703.2 5714.6 5721.8 5723.9 5725.9 4596.1 5088.8 5148.3 5154.4 5267.1 4301.8 4323.1 4353.4 4362.4 4372.9 1261.7 1315.0 1324.1 1329.0 1336.4 989.1 993.1 1009.3 1009.6 1014.8 6137.0 6234.5 6371.9 6446.5 6491.3 1080.2 1127.6 1149.8 1153.4 1159.8 4142.8 4234.3 4279.5 4294.3 4329.8 11851.6 11987.6 12227.9 12309.6 12315.0 11955.2 12099.2 12140.6 12142.5 12155.7 8692.5 8733.2 8816.7 8823.7 8826.2 6368.0 6470.2 6470.7 6497.7 6545.6 10442.0 10896.6 10991.8 10998.7 11071.3 10772.9 11080.4 11174.5 11182.3 11288.3 7786.1 8275.3 8479.4 8525.2 8666.1 9363.6 9371.6 9391.5 9398.0 9451.2 7658.2 7813.9 8071.7 8091.6 8153.9 7747.3 7782.8 7832.2 7924.6 8039.1 7483.6 7642.2 7655.6 7689.6 7722.4 5543.8 5585.4 5603.9 5622.3 5730.0 5382.6 5426.9 5509.7 5533.1 5550.1 11:33:51 INFO - PROCESS | 23254 | 11:33:51 INFO - PROCESS | 23254 | [#4] prototype.html Cycles:180 Average:5170.55 Median:5886.93 stddev:1520.53 (25.8%) stddev-sans-first:1480.95 11:33:51 INFO - PROCESS | 23254 | Values: 340.7 356.3 357.2 357.6 357.8 5828.6 5863.1 5908.5 5966.0 5969.6 5759.4 5869.3 5883.6 5885.5 5888.1 4432.5 4579.2 4579.3 4612.2 4632.6 4592.7 4602.4 4608.6 4621.5 4628.4 4552.9 4578.7 4582.2 4609.2 4613.4 4458.0 4507.5 4608.9 4621.2 4623.2 4002.4 4025.2 4026.8 4042.2 4045.2 5687.4 5697.2 5719.7 5727.4 5749.6 4939.9 5158.9 5272.0 5273.4 5287.6 6018.2 6031.0 6057.5 6062.6 6121.9 4312.1 4379.0 4379.7 4380.8 4381.5 6235.7 6279.5 6300.3 6331.5 6379.8 4428.6 4428.9 4474.6 4484.9 4501.2 4532.3 4535.4 4542.7 4544.9 4552.3 5018.8 5123.5 5144.2 5146.0 5188.4 6049.4 6058.3 6059.4 6075.2 6106.4 1542.2 1563.7 1572.4 1572.6 1573.6 1004.6 1055.8 1062.4 1071.6 1079.2 5872.3 5877.9 5881.0 5970.2 6002.9 6021.8 6234.2 6258.2 6309.5 6311.6 5859.6 5885.7 5898.6 5926.8 5929.6 3278.5 3315.4 3352.7 3356.6 3371.7 6211.0 6431.3 6482.4 6489.7 6515.2 6163.5 6386.7 6423.9 6435.7 6522.8 6294.6 6423.9 6462.1 6509.6 6510.4 6252.9 6268.0 6296.2 6333.5 6338.8 6035.2 6161.2 6188.4 6231.8 6240.7 6481.7 6553.6 6553.8 6588.2 6605.9 4332.5 4489.8 4504.0 4510.8 4528.4 6294.8 6295.3 6309.4 6333.5 6355.1 6022.7 6206.6 6222.9 6240.1 6290.8 6132.5 6150.7 6164.6 6166.0 6170.8 6153.6 6160.0 6160.3 6162.1 6178.7 5940.8 6182.7 6191.0 6245.3 6266.7 6025.5 6073.4 6091.6 6097.8 6105.5 11:33:51 INFO - PROCESS | 23254 | 11:33:51 INFO - PROCESS | 23254 | [#5] yui.html Cycles:180 Average:21367.24 Median:4130.23 stddev:30142.28 (729.8%) stddev-sans-first:30187.42 11:33:51 INFO - PROCESS | 23254 | Values: 838.2 840.3 854.3 918.7 961.0 16159.2 18366.4 18430.2 18490.5 18604.3 15629.5 16232.9 16387.8 16537.8 16709.7 873.3 904.5 906.1 907.2 909.2 895.0 898.3 899.5 901.2 901.4 951.6 951.7 954.3 954.8 957.6 941.5 942.2 943.1 944.1 944.9 694.8 696.0 698.0 699.7 700.7 14998.3 15048.4 15149.5 15173.9 15492.6 14203.2 15378.9 15488.4 15568.5 15961.8 12982.7 13050.9 13069.0 13158.4 13231.1 4041.8 4070.7 4094.0 4118.6 4127.2 65805.0 66224.7 67156.7 72656.3 91110.1 11596.0 11618.8 11768.4 11793.7 12152.0 21785.8 22599.8 22675.1 23518.2 23731.5 8480.0 9150.5 9229.0 9437.5 9531.3 4929.4 4990.5 5297.7 5313.3 5335.7 3965.4 4133.3 4134.0 4146.2 4154.7 687.2 691.0 713.2 713.7 714.4 637.6 648.4 653.4 675.4 705.2 10327.5 10334.5 10661.5 10667.8 10723.0 766.3 773.9 779.2 782.1 783.4 5095.5 5102.2 5133.2 5209.2 5215.2 115650.4 115875.0 116323.0 120392.0 129713.0 86065.1 90382.0 94356.5 94696.5 101051.0 80273.6 88634.1 89524.6 90812.0 90940.5 9765.6 10045.0 10255.9 10343.7 10401.7 51620.5 51922.7 52674.5 53154.2 54408.2 73682.0 76366.0 81249.2 83435.2 84943.6 13232.3 13515.9 13712.9 13960.1 14077.4 14957.5 15246.9 15604.8 15633.3 15924.9 14245.1 14439.6 14505.3 14505.6 14760.4 14120.6 14265.9 14385.0 14453.9 14504.0 14097.7 14479.9 14481.3 14755.6 14901.9 10579.6 10588.4 10799.5 11306.2 11527.7 10497.6 10659.6 11416.5 11454.7 11594.7 11:33:51 INFO - PROCESS | 23254 | -------- Summary: end -------- 11:33:51 INFO - PROCESS | 23254 | 11:33:52 INFO - TEST-INFO | 23254: exit 0 11:33:52 INFO - TEST-OK | dromaeo_css | took 1110939ms 11:33:52 INFO - TEST-START | kraken 11:33:52 INFO - operating with platform_type : linux_ 11:33:52 INFO - Initialising browser for kraken test... 11:33:52 INFO - TEST-INFO | started process 23521 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp62AyAC/profile http://localhost:41174/getInfo.html) 11:33:57 INFO - PROCESS | 23521 | __metrics Screen width/height:1600/1200 11:33:57 INFO - PROCESS | 23521 | colorDepth:24 11:33:57 INFO - PROCESS | 23521 | Browser inner width/height: 1024/697 11:33:57 INFO - PROCESS | 23521 | __metrics 11:33:57 ERROR - PROCESS | 23521 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 11:33:58 INFO - TEST-INFO | 23521: exit 0 11:33:58 INFO - Browser initialized. 11:33:58 INFO - Running cycle 1/1 for kraken test... 11:33:58 INFO - TEST-INFO | started process 23643 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp62AyAC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:34:10 INFO - PROCESS | 23643 | RSS: Main: 152846336 11:34:10 INFO - PROCESS | 23643 | 11:34:12 INFO - PROCESS | 23643 | Cycle 1(1): loaded http://localhost:41174/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41174/tests/kraken/driver.html?testName=audio-beat-detection) 11:34:13 INFO - PROCESS | 23643 | RSS: Main: 158330880 11:34:13 INFO - PROCESS | 23643 | 11:34:16 INFO - PROCESS | 23643 | Cycle 1(1): loaded http://localhost:41174/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41174/tests/kraken/driver.html?testName=audio-dft) 11:34:17 INFO - PROCESS | 23643 | RSS: Main: 157048832 11:34:17 INFO - PROCESS | 23643 | 11:34:19 INFO - PROCESS | 23643 | Cycle 1(1): loaded http://localhost:41174/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41174/tests/kraken/driver.html?testName=audio-fft) 11:34:20 INFO - PROCESS | 23643 | RSS: Main: 157933568 11:34:20 INFO - PROCESS | 23643 | 11:34:22 INFO - PROCESS | 23643 | Cycle 1(1): loaded http://localhost:41174/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41174/tests/kraken/driver.html?testName=audio-oscillator) 11:34:23 INFO - PROCESS | 23643 | RSS: Main: 157212672 11:34:23 INFO - PROCESS | 23643 | 11:34:25 INFO - PROCESS | 23643 | Cycle 1(1): loaded http://localhost:41174/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41174/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:34:25 INFO - PROCESS | 23643 | RSS: Main: 157581312 11:34:25 INFO - PROCESS | 23643 | 11:34:29 INFO - PROCESS | 23643 | Cycle 1(1): loaded http://localhost:41174/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41174/tests/kraken/driver.html?testName=imaging-darkroom) 11:34:29 INFO - PROCESS | 23643 | RSS: Main: 156860416 11:34:29 INFO - PROCESS | 23643 | 11:34:33 INFO - PROCESS | 23643 | Cycle 1(1): loaded http://localhost:41174/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41174/tests/kraken/driver.html?testName=imaging-desaturate) 11:34:33 INFO - PROCESS | 23643 | RSS: Main: 155398144 11:34:33 INFO - PROCESS | 23643 | 11:34:36 INFO - PROCESS | 23643 | Cycle 1(1): loaded http://localhost:41174/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41174/tests/kraken/driver.html?testName=json-parse-financial) 11:34:37 INFO - PROCESS | 23643 | RSS: Main: 156573696 11:34:37 INFO - PROCESS | 23643 | 11:34:38 INFO - PROCESS | 23643 | Cycle 1(1): loaded http://localhost:41174/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41174/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:34:39 INFO - PROCESS | 23643 | RSS: Main: 156782592 11:34:39 INFO - PROCESS | 23643 | 11:34:41 INFO - PROCESS | 23643 | Cycle 1(1): loaded http://localhost:41174/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41174/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:34:41 INFO - PROCESS | 23643 | RSS: Main: 157138944 11:34:41 INFO - PROCESS | 23643 | 11:34:43 INFO - PROCESS | 23643 | Cycle 1(1): loaded http://localhost:41174/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41174/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:34:44 INFO - PROCESS | 23643 | RSS: Main: 156983296 11:34:44 INFO - PROCESS | 23643 | 11:34:46 INFO - PROCESS | 23643 | Cycle 1(1): loaded http://localhost:41174/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41174/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:34:47 INFO - PROCESS | 23643 | RSS: Main: 157511680 11:34:47 INFO - PROCESS | 23643 | 11:34:50 INFO - PROCESS | 23643 | Cycle 1(1): loaded http://localhost:41174/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41174/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:34:50 INFO - PROCESS | 23643 | RSS: Main: 158244864 11:34:50 INFO - PROCESS | 23643 | 11:34:52 INFO - PROCESS | 23643 | Cycle 1(1): loaded http://localhost:41174/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41174/tests/kraken/driver.html?testName=ai-astar) 11:34:52 INFO - PROCESS | 23643 | RSS: Main: 158851072 11:34:52 INFO - PROCESS | 23643 | 11:34:52 INFO - PROCESS | 23643 | __start_tp_report 11:34:52 INFO - PROCESS | 23643 | _x_x_mozilla_page_load 11:34:52 INFO - PROCESS | 23643 | _x_x_mozilla_page_load_details 11:34:52 INFO - PROCESS | 23643 | |i|pagename|runs| 11:34:52 INFO - PROCESS | 23643 | |0;ai-astar;100;110;105;109;112;112;111;110;109;110 11:34:52 INFO - PROCESS | 23643 | |1;audio-beat-detection;141;116;151;171;117;150;146;121;182;114 11:34:52 INFO - PROCESS | 23643 | |2;audio-dft;164;163;162;162;162;163;162;162;162;161 11:34:52 INFO - PROCESS | 23643 | |3;audio-fft;75;75;74;165;78;75;80;76;164;77 11:34:52 INFO - PROCESS | 23643 | |4;audio-oscillator;84;84;163;86;86;87;138;85;84;144 11:34:52 INFO - PROCESS | 23643 | |5;imaging-gaussian-blur;118;118;117;117;118;118;117;117;117;117 11:34:52 INFO - PROCESS | 23643 | |6;imaging-darkroom;148;148;146;147;147;149;148;150;148;147 11:34:52 INFO - PROCESS | 23643 | |7;imaging-desaturate;95;96;96;95;96;95;97;96;95;96 11:34:52 INFO - PROCESS | 23643 | |8;json-parse-financial;51;53;51;51;53;55;52;60;51;52 11:34:52 INFO - PROCESS | 23643 | |9;json-stringify-tinderbox;61;65;60;62;62;65;61;62;63;62 11:34:52 INFO - PROCESS | 23643 | |10;stanford-crypto-aes;72;73;72;73;74;72;74;73;73;72 11:34:52 INFO - PROCESS | 23643 | |11;stanford-crypto-ccm;137;131;120;125;120;129;118;117;158;126 11:34:52 INFO - PROCESS | 23643 | |12;stanford-crypto-pbkdf2;164;153;154;152;151;154;153;153;152;156 11:34:52 INFO - PROCESS | 23643 | |13;stanford-crypto-sha256-iterative;62;63;66;65;66;62;61;61;60;62 11:34:52 INFO - PROCESS | 23643 | __end_tp_report 11:34:52 INFO - PROCESS | 23643 | __start_cc_report 11:34:52 INFO - PROCESS | 23643 | _x_x_mozilla_cycle_collect,874 11:34:52 INFO - PROCESS | 23643 | __end_cc_report 11:34:52 INFO - PROCESS | 23643 | __startTimestamp1470422092762__endTimestamp 11:34:52 INFO - PROCESS | 23643 | 11:34:52 INFO - PROCESS | 23643 | ------- Summary: start ------- 11:34:52 INFO - PROCESS | 23643 | Number of tests: 14 11:34:52 INFO - PROCESS | 23643 | 11:34:52 INFO - PROCESS | 23643 | [#0] ai-astar Cycles:10 Average:108.80 Median:110.00 stddev:3.68 (3.3%) stddev-sans-first:2.11 11:34:52 INFO - PROCESS | 23643 | Values: 100.0 110.0 105.0 109.0 112.0 112.0 111.0 110.0 109.0 110.0 11:34:52 INFO - PROCESS | 23643 | 11:34:52 INFO - PROCESS | 23643 | [#1] audio-beat-detection Cycles:10 Average:140.90 Median:148.00 stddev:23.84 (16.1%) stddev-sans-first:25.29 11:34:52 INFO - PROCESS | 23643 | Values: 141.0 116.0 151.0 171.0 117.0 150.0 146.0 121.0 182.0 114.0 11:34:52 INFO - PROCESS | 23643 | 11:34:52 INFO - PROCESS | 23643 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.60 11:34:52 INFO - PROCESS | 23643 | Values: 164.0 163.0 162.0 162.0 162.0 163.0 162.0 162.0 162.0 161.0 11:34:52 INFO - PROCESS | 23643 | 11:34:52 INFO - PROCESS | 23643 | [#3] audio-fft Cycles:10 Average:93.90 Median:75.50 stddev:37.25 (49.3%) stddev-sans-first:38.88 11:34:52 INFO - PROCESS | 23643 | Values: 75.0 75.0 74.0 165.0 78.0 75.0 80.0 76.0 164.0 77.0 11:34:52 INFO - PROCESS | 23643 | 11:34:52 INFO - PROCESS | 23643 | [#4] audio-oscillator Cycles:10 Average:104.10 Median:84.50 stddev:31.15 (36.9%) stddev-sans-first:32.18 11:34:52 INFO - PROCESS | 23643 | Values: 84.0 84.0 163.0 86.0 86.0 87.0 138.0 85.0 84.0 144.0 11:34:52 INFO - PROCESS | 23643 | 11:34:52 INFO - PROCESS | 23643 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 11:34:52 INFO - PROCESS | 23643 | Values: 118.0 118.0 117.0 117.0 118.0 118.0 117.0 117.0 117.0 117.0 11:34:52 INFO - PROCESS | 23643 | 11:34:52 INFO - PROCESS | 23643 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:1.14 (0.8%) stddev-sans-first:1.20 11:34:52 INFO - PROCESS | 23643 | Values: 148.0 148.0 146.0 147.0 147.0 149.0 148.0 150.0 148.0 147.0 11:34:52 INFO - PROCESS | 23643 | 11:34:52 INFO - PROCESS | 23643 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 11:34:52 INFO - PROCESS | 23643 | Values: 95.0 96.0 96.0 95.0 96.0 95.0 97.0 96.0 95.0 96.0 11:34:52 INFO - PROCESS | 23643 | 11:34:52 INFO - PROCESS | 23643 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:52.50 stddev:2.81 (5.3%) stddev-sans-first:2.89 11:34:52 INFO - PROCESS | 23643 | Values: 51.0 53.0 51.0 51.0 53.0 55.0 52.0 60.0 51.0 52.0 11:34:52 INFO - PROCESS | 23643 | 11:34:52 INFO - PROCESS | 23643 | [#9] json-stringify-tinderbox Cycles:10 Average:62.30 Median:62.00 stddev:1.64 (2.6%) stddev-sans-first:1.67 11:34:52 INFO - PROCESS | 23643 | Values: 61.0 65.0 60.0 62.0 62.0 65.0 61.0 62.0 63.0 62.0 11:34:52 INFO - PROCESS | 23643 | 11:34:52 INFO - PROCESS | 23643 | [#10] stanford-crypto-aes Cycles:10 Average:72.80 Median:73.00 stddev:0.79 (1.1%) stddev-sans-first:0.78 11:34:52 INFO - PROCESS | 23643 | Values: 72.0 73.0 72.0 73.0 74.0 72.0 74.0 73.0 73.0 72.0 11:34:52 INFO - PROCESS | 23643 | 11:34:52 INFO - PROCESS | 23643 | [#11] stanford-crypto-ccm Cycles:10 Average:128.10 Median:127.50 stddev:12.26 (9.6%) stddev-sans-first:12.57 11:34:52 INFO - PROCESS | 23643 | Values: 137.0 131.0 120.0 125.0 120.0 129.0 118.0 117.0 158.0 126.0 11:34:52 INFO - PROCESS | 23643 | 11:34:52 INFO - PROCESS | 23643 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.20 Median:153.50 stddev:3.71 (2.4%) stddev-sans-first:1.45 11:34:52 INFO - PROCESS | 23643 | Values: 164.0 153.0 154.0 152.0 151.0 154.0 153.0 153.0 152.0 156.0 11:34:52 INFO - PROCESS | 23643 | 11:34:52 INFO - PROCESS | 23643 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:62.50 stddev:2.15 (3.4%) stddev-sans-first:2.26 11:34:52 INFO - PROCESS | 23643 | Values: 62.0 63.0 66.0 65.0 66.0 62.0 61.0 61.0 60.0 62.0 11:34:52 INFO - PROCESS | 23643 | -------- Summary: end -------- 11:34:52 INFO - PROCESS | 23643 | 11:34:53 INFO - TEST-INFO | 23643: exit 0 11:34:53 INFO - TEST-OK | kraken | took 61151ms 11:34:53 INFO - SUITE-END | took 1172s 11:34:53 INFO - Completed test suite (00:19:32) 11:34:53 INFO - javascript benchmark 11:34:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7876.228955132624, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3348.84930178142, 3372.376110419571, 3373.190434295769, 3386.3058073095017, 3399.0, 5804.390538993398, 5814.2441482607255, 5852.122181672751, 5852.561057920651, 5875.529957603392, 5819.650820950746, 5822.0, 5850.502707269877, 5857.824265272038, 5862.032764593837, 5226.634135610509, 5290.259363689087, 5293.735313234342, 5320.14877619581, 5343.332083489564, 5178.119719647669, 5180.481951804827, 5254.343207099113, 5264.315638966929, 5306.0, 5213.7393130343335, 5219.086659834533, 5239.240310155025, 5325.866853328659, 5376.731163441832, 5310.230016647564, 5330.253764472977, 5340.118880384752, 5340.412554618989, 5355.116405793039, 5123.8206662767, 5147.897042059138, 5147.897042059175, 5188.766505507261, 5301.390340110859, 5685.800996965087, 5766.6448384629575, 5773.826785196451, 5792.218050563204, 5827.4755272025295, 6233.5948163369685, 6265.934791085527, 6267.435930766253, 6283.622982621057, 6287.559870809046, 6123.069106197319, 6134.079888016789, 6245.968770156165, 6295.338989406138, 6305.306416294204, 5744.712764361765, 5820.35976042635, 5837.270341207349, 5857.326407463111, 5873.500752436048, 6294.937050629526, 6309.621422714652, 6357.523185760994, 6361.9045714314325, 6366.26787919386, 5929.644221346647, 6056.528932209105, 6112.989854784112, 6118.388161183935, 6125.418085281891, 6172.321044685081, 6249.281332646713, 6324.9051264231075, 6326.367363263636, 6334.3032266450655, 6229.190205273286, 6268.686565671698, 6278.811635650938, 6282.183316168869, 6282.434580887742, 6080.604760690541, 6094.878102437927, 6283.654399008007, 6299.653519056405, 6321.557490975588, 4698.177818881751, 4702.482726900038, 4722.504137065627, 4763.571278584944, 4811.446683631427, 4247.193033323659, 4255.638270746959, 4270.889568712158, 4275.722078064916, 4282.957170428256, 5975.52195824333, 6012.338642749294, 6018.789342373084, 6018.969905150446, 6029.728662210211, 6109.28320792043, 6175.722092505848, 6180.072989051679, 6185.597936134137, 6248.250209974741, 5930.851728706731, 5988.401159884064, 6001.489873360726, 6013.0980352946535, 6022.337542870281, 5285.814996475105, 5343.385510666245, 5375.865603359947, 5395.055865223649, 5397.487238712316, 6404.327545607644, 6436.163298771224, 6469.967650161719, 6544.640044797487, 6562.80311590653, 6255.31191568918, 6262.0, 6270.467010304175, 6274.309825919237, 6328.272248691459, 6218.751249949952, 6535.934640653532, 6549.377809108127, 6551.148350714377, 6558.704858281293, 6084.178635884276, 6109.816705498843, 6135.84660383494, 6141.36327073057, 6161.630302181883, 6209.316975132822, 6247.406496382836, 6249.78125765596, 6257.09272155544, 6276.215473065867, 5929.970350148222, 6085.817425477243, 6152.384761523812, 6159.846003849761, 6169.259688837368, 6043.486303664238, 6081.5134789217645, 6082.239720034996, 6118.76967209854, 6121.727351053096, 6070.575059745775, 6088.056351265561, 6099.420555047263, 6104.725287361991, 6110.358412366638, 5934.6142500737315, 6108.175396321618, 6124.38756124384, 6180.783672571439, 6200.441960223421, 5843.620164689281, 5849.356570777296, 5888.499477544457, 5921.61509501881, 5949.494292985145], "value": 5745.234335669219, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.1558739827249, 629.4838232649224, 641.5092454272481, 662.1491383572107, 692.1521136607653, 41779.16441671165, 46692.0, 47080.52919470804, 47090.0, 47151.292730608984, 47514.28728569074, 47899.0, 47971.520284797145, 48132.75933620336, 48172.27741583879, 9124.726258212248, 9265.305102117369, 9288.767780805467, 9295.814083718322, 9317.673881414152, 9153.954230228874, 9301.395409298408, 9302.953485232565, 9307.441553506778, 9316.487593182372, 9285.860712089325, 9314.394564353295, 9339.673111441101, 9347.392419492746, 9353.11145441182, 9182.31132665046, 9277.97942226358, 9293.21007714345, 9296.163345298923, 9310.627574896997, 9292.0, 9316.394434361813, 9320.067993200693, 9351.0, 9366.906330936672, 43747.34378984318, 43990.0, 44201.11597768027, 44403.77798110989, 44472.555274447164, 3881.922361552753, 3950.308695978221, 3971.225611005855, 4189.183109293689, 4375.584319489643, 34031.829840850885, 34558.82720586381, 34599.82700086509, 34883.82558087193, 34917.30165396678, 4441.444819397575, 4460.553944605546, 4494.348319493655, 4508.301213311942, 4508.864734057984, 350468.0, 356941.0, 358762.0, 362100.0, 363646.0, 67046.66476667585, 67443.32556674468, 67674.66162669254, 67849.32150678529, 68039.65980170068, 67955.0, 68219.65890170616, 68257.31742682609, 68351.0, 68380.6580967092, 17368.739468907977, 18118.728219076726, 18324.0, 18648.254069837054, 18700.06499675011, 14762.778558321634, 15058.924705376403, 15071.849281507264, 15078.623034424227, 15128.848711512965, 20363.796362036486, 20507.8974605129, 20564.897175514026, 20680.689789653166, 20821.89589052045, 7733.7679869604, 7767.36885254103, 7979.880301795478, 7992.400569957276, 8048.396370272253, 1092.5029111754134, 1120.0479592346603, 1124.5691973623896, 1187.9724038706456, 1247.8689737577606, 34733.47899781505, 34794.82602586971, 35087.29825403529, 35132.82433587867, 35215.11962200965, 1220.9877901221053, 1223.7919553675897, 1232.4084439469104, 1271.2753730373784, 1302.5571305755898, 18257.0, 18351.816481835012, 18357.7246341305, 18406.35577754772, 18445.631087378177, 544227.0, 553338.0, 554152.0, 568338.0, 885098.0, 65453.0, 66277.66861165663, 66301.0, 66606.0, 66919.33080669228, 1478.2682572126866, 1480.9259537023106, 1493.1253397433643, 1493.7087267982638, 1499.3852520466555, 34651.4802277961, 35912.8204358987, 35927.64072359243, 36154.63845361512, 36309.63690363168, 58242.7087864558, 58375.70812145912, 59177.704111479165, 59252.0, 59272.0, 514234.0, 518787.0, 519123.0, 519422.0, 520179.0, 31756.20609484689, 33444.1638959028, 33502.66497335093, 33544.83227583847, 33564.66435335615, 54029.45970540401, 54133.66361357143, 54181.0, 54785.726071370984, 55882.0, 46075.53924460713, 46151.3077303834, 46975.29537056878, 47997.76001119972, 48521.27218091802, 48409.75795121002, 48566.27150592815, 48915.75542122267, 49115.50884491109, 49217.0, 39778.801105995444, 44922.66240894096, 46522.76738616285, 48615.27077093917, 49433.0, 38951.220975580894, 40462.797686011385, 40843.59156408398, 41226.0, 41766.37350439685, 31160.22099447532, 31495.370092598478, 31698.366032679678, 31716.0, 32021.8398908004], "value": 22229.405285695528, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.4583695359078, 414.54814252464814, 417.4427139768409, 420.298102169377, 436.8296364417878, 18953.241870325186, 19708.704369434454, 20439.080241389136, 21093.57812843746, 21350.786492135074, 20267.189312427487, 20367.0, 20473.18107275707, 20624.9687515624, 20866.37400877976, 5946.79186228481, 6125.785597504088, 6143.907841382383, 6161.383861613847, 6164.260288765355, 5988.251468566429, 6009.789657361993, 6013.037913933771, 6076.605020673642, 6079.300880398744, 5831.0, 5994.980853254935, 6022.187004754368, 6024.246969128859, 6024.307204671453, 5951.910721339162, 5957.404259574029, 5990.610610310359, 6012.5791194616395, 6016.518678505709, 5380.461953804627, 5384.326959130109, 5425.864353391157, 5426.91859622102, 5432.728363581845, 24118.879405603035, 24438.755612443827, 24479.755202447926, 24716.0, 24937.750622493724, 2766.432881259357, 2984.925376865574, 3075.692430756929, 3138.76459265556, 3326.600807903043, 15269.770953435596, 15454.304556294994, 15785.13181775002, 15928.522144335688, 16065.0, 2061.2167376396874, 2159.0, 2185.1041073159927, 2238.362066810951, 2251.9774802252095, 77375.22624773793, 78314.21685783184, 79438.60280698618, 81423.59288203581, 81978.59010704968, 11296.0, 11475.54097836094, 11618.76762464763, 11710.82891710839, 12552.372381380894, 16219.270132843814, 16242.269097890623, 16253.69970402365, 16262.268197931122, 16314.857959942927, 8849.778755531035, 9061.54692265384, 9106.726798196065, 9156.771080722901, 9316.301277404222, 8374.623141958626, 8438.746837594881, 8590.441621294596, 8858.069902660256, 8888.244499217639, 6896.793096207121, 7049.859002820018, 7117.252688467636, 7139.464540159405, 7232.421406287484, 1975.032234205229, 2068.43118142512, 2074.4399012266604, 2091.0276721324353, 2188.1466228171025, 962.7448726087592, 1060.48036462133, 1068.0974576482859, 1070.5610699613278, 1078.4931082391263, 20618.896905515678, 21185.576288474145, 21219.15123395047, 21465.141394344053, 21552.13791448356, 1096.6874440784338, 1097.319661809683, 1098.1763677242068, 1099.5052226498108, 1120.7030137013699, 11754.412279385997, 11898.583549575724, 12010.0, 12164.452599633038, 12202.633920982385, 522000.0, 528575.0, 533604.0, 543425.0, 547325.0, 50260.497395026316, 54149.72925135428, 80258.0, 84849.57575212084, 85568.57215714006, 1084.1976937066513, 1097.8902109789117, 1100.2793170473353, 1103.8454616353717, 1109.2457129152092, 14513.92743036278, 17663.38178163758, 18724.157412916178, 18987.525311867314, 19025.80974190296, 29726.405471890874, 39626.0, 40207.396889046104, 40926.0, 41228.350865965025, 60598.0, 62041.65983596464, 62114.0, 63075.36924630879, 64031.6798416005, 9029.503377314311, 9198.54007299619, 9427.528623568931, 9488.098630630078, 9561.856572151562, 13571.52499662507, 13755.17468951866, 13820.585382438543, 14272.785908211592, 14400.973362188168, 12587.93706031464, 12730.618081457571, 12732.0, 12859.357032148542, 12865.742685146057, 11924.880751192377, 12013.819792702941, 12067.879321207027, 12185.451654675384, 13040.282784446947, 11870.940645296718, 12192.390380480763, 12264.754704905674, 12346.691332716753, 12404.317762522787, 8095.797605059921, 8233.135520770233, 8359.95820020896, 9546.18857397129, 9618.903810962081, 9958.402495850272, 12502.437390317276, 12539.623811285675, 12594.307313097868, 12854.421551030038], "value": 9932.293906476192, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1543.706695727812, 1569.4350033987766, 1742.407581422316, 1864.6457173137094, 1868.6729822281097, 8487.91512084879, 8964.462132272069, 9042.683506077288, 9709.854352184713, 9768.609255629766, 9180.0, 9443.433393996347, 9456.196223321025, 9463.81072378552, 9471.857922131156, 2434.1602147259214, 2474.5793215153376, 2479.0, 2490.5766019776593, 2494.3390001649577, 2406.3502854229346, 2541.2503311523146, 2546.401595625027, 2548.6941567011986, 2552.8595927223996, 2503.249025292414, 2507.022261318087, 2535.771780539751, 2542.834715743471, 2545.185540627, 2405.530921470323, 2423.333583264599, 2425.1875621666763, 2451.0, 2458.0, 2341.953160936772, 2349.6827928229814, 2355.5759963206615, 2357.669926210332, 2367.0768400323886, 9472.336936414455, 9511.857322140173, 9613.56738946742, 9622.855657165148, 9633.229341652652, 5502.367227768817, 5594.608377413582, 5643.717814109319, 5646.604737668365, 5649.548036157139, 3416.6070901846356, 3550.0769799852224, 3601.6398360163776, 3620.0587847159663, 3687.520622319108, 1157.1841851494676, 1188.5305304404712, 1244.3715923458597, 1258.9685257868534, 1293.1336004876755, 13262.602121936357, 13283.0, 13286.800697989538, 13312.201267923858, 13375.33123343829, 4798.256270278112, 4865.464798872121, 5013.097642424325, 5021.6735912165595, 5103.744812759347, 11174.888251117547, 11187.888121118685, 11189.944050279859, 11213.439328033566, 11228.719282018015, 5703.201551782754, 5714.599978001583, 5721.799737009268, 5723.942760572424, 5725.942740572625, 4596.057808149321, 5088.821891233789, 5148.330717006766, 5154.381474223117, 5267.051930652519, 4301.763403012865, 4323.113761678848, 4353.4122893408985, 4362.367456718758, 4372.868813935587, 1261.6908857330013, 1315.046591221357, 1324.09961226367, 1328.973420531584, 1336.432016393029, 989.1147423056324, 993.0615568287899, 1009.2934945538153, 1009.6012075230243, 1014.7666036811574, 6137.0, 6234.470070044006, 6371.904421433682, 6446.548741588043, 6491.318411566812, 1080.152080616712, 1127.6053381316474, 1149.844770955927, 1153.377176324792, 1159.7622487390065, 4142.834286628501, 4234.343676730112, 4279.507856596531, 4294.26997410441, 4329.76186309756, 11851.585194518151, 11987.580434684918, 12227.938860305641, 12309.56916507918, 12315.0, 11955.163138580216, 12099.153059285942, 12140.635780926586, 12142.514299428101, 12155.696107597203, 8692.52191129494, 8733.214010739064, 8816.691415800544, 8823.691170808863, 8826.249768769598, 6367.968160159169, 6470.22357317125, 6470.708818103102, 6497.675116244074, 6545.574537655038, 10442.0, 10896.564137434414, 10991.780164396827, 10998.670039898816, 11071.335719856834, 10772.89227107719, 11080.39057851826, 11174.49714762854, 11182.273152245078, 11288.322700637988, 7786.104597971306, 8275.255227029596, 8479.448835825651, 8525.232729054414, 8666.090060543553, 9363.625454981724, 9371.578278977326, 9391.483468409304, 9398.01320861327, 9451.243900487807, 7658.234176582298, 7813.882791758015, 8071.677132914852, 8091.55496447701, 8153.877691834746, 7747.34147597438, 7782.844343113219, 7832.177621349676, 7924.603769811371, 8039.075506316614, 7483.588402637907, 7642.235776422313, 7655.61721913891, 7689.577073261024, 7722.420818438752, 5543.750531226024, 5585.441455854545, 5603.859903502445, 5622.32532096151, 5730.025895597675, 5382.569394448513, 5426.891462170814, 5509.724513774376, 5533.087040638249, 5550.0564903965615], "value": 4992.117104884595, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.71550255536624, 356.2572037302225, 357.1927443976612, 357.5923447270111, 357.77996532132715, 5828.562857785661, 5863.1205319202145, 5908.497777688896, 5966.0, 5969.552283578732, 5759.366469688331, 5869.266341707286, 5883.646761244916, 5885.49973252273, 5888.11678248263, 4432.512423633398, 4579.175748365293, 4579.335996280537, 4612.215923293048, 4632.583067523922, 4592.7014744041535, 4602.447706275251, 4608.608268297182, 4621.491635920046, 4628.352030715702, 4552.8634140975655, 4578.748168850712, 4582.175208462475, 4609.170349337118, 4613.400257966459, 4457.955420445786, 4507.481639611454, 4608.9308660370125, 4621.168189725848, 4623.220060276784, 4002.3796311571755, 4025.1547175093265, 4026.778527181004, 4042.2319759245943, 4045.1707399982934, 5687.431256874321, 5697.202391665171, 5719.6854173020465, 5727.398623144593, 5749.568782341299, 4939.901201975977, 5158.92261616076, 5271.998320319127, 5273.3935597406025, 5287.603429742785, 6018.187544681456, 6031.0, 6057.545684073668, 6062.636241825505, 6121.938780612181, 4312.059573192076, 4378.9709418286675, 4379.693421460499, 4380.773383452606, 4381.518033016366, 6235.721677056193, 6279.497640188774, 6300.27546832111, 6331.461825744817, 6379.776707815251, 4428.601425871687, 4428.870637987357, 4474.597286244189, 4484.910301793946, 4501.167284052461, 4532.342810292555, 4535.433070866142, 4542.659300552472, 4544.909101818012, 4552.292890166188, 5018.824341148043, 5123.462036486189, 5144.176931690911, 5145.996530676557, 5188.429272779991, 6049.364816694272, 6058.303295121117, 6059.363971727609, 6075.210222671025, 6106.358832322631, 1542.1980570103483, 1563.7177514438279, 1572.3631929068745, 1572.606848287928, 1573.6309410812437, 1004.5780772075746, 1055.8363453664695, 1062.4315990944808, 1071.6195750508457, 1079.1582565598846, 5872.324682661549, 5877.9118313225335, 5880.970595147082, 5970.223870896755, 6002.879942401215, 6021.789237376671, 6234.189555357774, 6258.15514905491, 6309.526785491014, 6311.589746666452, 5859.619124756877, 5885.735141918624, 5898.616589921641, 5926.822195334147, 5929.644221346733, 3278.541004259406, 3315.419801534722, 3352.7317814574776, 3356.56364672591, 3371.696547310754, 6211.0, 6431.260405053479, 6482.416582507597, 6489.70796314167, 6515.218173819172, 6163.476104531165, 6386.680665966683, 6423.903641445382, 6435.742570297136, 6522.836929076716, 6294.559380843297, 6423.903641445382, 6462.095306657072, 6509.576877503042, 6510.446612037935, 6252.874942501034, 6268.028455589391, 6296.229658950047, 6333.5116247680835, 6338.809835704752, 6035.185249991195, 6161.168242287234, 6188.44304012641, 6231.781887633911, 6240.719167637558, 6481.708323125376, 6553.590977939766, 6553.803385898431, 6588.242352129375, 6605.867882642224, 4332.50176229725, 4489.842855500173, 4504.0, 4510.797014134438, 4528.43394575678, 6294.8111556653375, 6295.324487092876, 6309.432151106423, 6333.493320534439, 6355.14205582259, 6022.668753218615, 6206.596571222856, 6222.906656400067, 6240.12638230639, 6290.804747098036, 6132.509399248139, 6150.692465376624, 6164.568480206342, 6166.0, 6170.784022559189, 6153.569250152446, 6160.0, 6160.291566469913, 6162.106494558354, 6178.69106544662, 5940.79207227745, 6182.659953702409, 6191.0, 6245.344238854855, 6266.717997690023, 6025.517958563217, 6073.423024812636, 6091.634501929899, 6097.847553811191, 6105.504151482915], "value": 4681.934690791678, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [838.1576515601821, 840.2731637133877, 854.3165467625897, 918.6784625381115, 960.9807803843919, 16159.192040397991, 18366.35717749879, 18430.170642321093, 18490.537736556595, 18604.25582976681, 15629.531114066596, 16232.863699541036, 16387.83612163878, 16537.83462165378, 16709.66580668389, 873.3144481581959, 904.5296445848155, 906.1346414174448, 907.1971305394708, 909.236241557092, 894.9552522373888, 898.3262553085186, 899.4693131052678, 901.2249465459699, 901.4185850126697, 951.5575257505259, 951.6954574536152, 954.265215783846, 954.8376775948105, 957.593022965237, 941.5480569326727, 942.241495596045, 943.1181844974936, 944.0889541592362, 944.900785417535, 694.8262934266434, 695.9512834101615, 697.9685914133876, 699.6606645776794, 700.726716580534, 14998.325075371635, 15048.398064077424, 15149.469768558047, 15173.924130379277, 15492.612684682861, 14203.218822964733, 15378.923105384514, 15488.380464781396, 15568.455104071303, 15961.760573591406, 12982.740345193044, 13050.934745326213, 13069.0, 13158.407871645799, 13231.073824832265, 4041.7777022263763, 4070.69469789764, 4093.9590604093873, 4118.567550407224, 4127.174565086994, 65805.0, 66224.66887665531, 67156.6642166786, 72656.273437266, 91110.08889911082, 11596.0, 11618.825717614243, 11768.411579420994, 11793.705157371134, 12152.0, 21785.782142178694, 22599.774002260096, 22675.092996280295, 23518.176863809684, 23731.525369492512, 8480.0, 9150.450972941644, 9228.953855230815, 9437.528123593793, 9531.285153613506, 4929.383827021622, 4990.50094990498, 5297.655652382583, 5313.30926979498, 5335.653182543122, 3965.405189221582, 4133.276676581586, 4134.0, 4146.150039241948, 4154.709170358106, 687.1685260834446, 690.9792706218822, 713.2225873797586, 713.6645776485044, 714.4106112457243, 637.626988211892, 648.4229036157823, 653.4086651580327, 675.3584095109666, 705.1784670858495, 10327.535260913126, 10334.534945927451, 10661.466926653637, 10667.83998240027, 10723.0, 766.31797700047, 773.8761798112275, 779.1779672445624, 782.0732432068017, 783.3693876429415, 5095.464976177522, 5102.2346648003095, 5133.153029750124, 5209.218617207373, 5215.217717342429, 115650.42174789072, 115875.0, 116323.0, 120392.0, 129713.0, 86065.13934860697, 90382.0, 94356.52821735847, 94696.52651736834, 101050.98949010563, 80273.59863200647, 88634.11365886258, 89524.55237723769, 90812.0, 90940.54529727441, 9765.60937562518, 10045.0, 10255.897441025494, 10343.741406464898, 10401.68794936153, 51620.48379516157, 51922.740386297824, 52674.47325526849, 53154.2026869605, 54408.183877241085, 73682.0, 76366.0, 81249.18750812416, 83435.16564834517, 84943.57528212319, 13232.272225027331, 13515.932420337835, 13712.93143534276, 13960.092593981359, 14077.436902523785, 14957.476488322856, 15246.923765381101, 15604.843951560339, 15633.29650165768, 15924.92037539805, 14245.145291282557, 14439.639009024439, 14505.347259373142, 14505.564833055025, 14760.409583616965, 14120.576382708536, 14265.857341426452, 14385.0, 14453.927730361282, 14504.0, 14097.718045638825, 14479.85520144785, 14481.275936202937, 14755.621260400732, 14901.925490372912, 10579.62971296001, 10588.417637030037, 10799.460026998462, 11306.208565400671, 11527.654170374903, 10497.632582859564, 10659.573617055541, 11416.543338266709, 11454.713632159262, 11594.6521604352], "value": 8051.430032485558, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1504.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 110.0, 105.0, 109.0, 112.0, 112.0, 111.0, 110.0, 109.0, 110.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 116.0, 151.0, 171.0, 117.0, 150.0, 146.0, 121.0, 182.0, 114.0], "value": 140.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 162.0, 162.0, 162.0, 163.0, 162.0, 162.0, 162.0, 161.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 165.0, 78.0, 75.0, 80.0, 76.0, 164.0, 77.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 163.0, 86.0, 86.0, 87.0, 138.0, 85.0, 84.0, 144.0], "value": 104.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 146.0, 147.0, 147.0, 149.0, 148.0, 150.0, 148.0, 147.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 97.0, 96.0, 95.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 53.0, 51.0, 51.0, 53.0, 55.0, 52.0, 60.0, 51.0, 52.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 65.0, 60.0, 62.0, 62.0, 65.0, 61.0, 62.0, 63.0, 62.0], "value": 62.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 72.0, 73.0, 74.0, 72.0, 74.0, 73.0, 73.0, 72.0], "value": 72.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 131.0, 120.0, 125.0, 120.0, 129.0, 118.0, 117.0, 158.0, 126.0], "value": 128.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 153.0, 154.0, 152.0, 151.0, 154.0, 153.0, 153.0, 152.0, 156.0], "value": 154.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 66.0, 65.0, 66.0, 62.0, 61.0, 61.0, 60.0, 62.0], "value": 62.8, "unit": "score"}]}]} 11:34:54 INFO - Return code: 0 11:34:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:34:54 ERROR - # TBPL SUCCESS # 11:34:54 INFO - Running post-action listener: _resource_record_post_action 11:34:54 INFO - [mozharness: 2016-08-05 18:34:54.087019Z] Finished run-tests step (success) 11:34:54 INFO - Running post-run listener: _resource_record_post_run 11:34:54 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 262144; Write bytes: 326819840; Read time: 28; Write time: 286756 11:34:54 INFO - TinderboxPrint: CPU usage
13.2% 11:34:54 INFO - TinderboxPrint: I/O read bytes / time
262,144 / 28 11:34:54 INFO - TinderboxPrint: I/O write bytes / time
326,819,840 / 286,756 11:34:54 INFO - TinderboxPrint: CPU idle
8,226.6 (86.8%) 11:34:54 INFO - TinderboxPrint: CPU user
1,196.2 (12.6%) 11:34:54 INFO - TinderboxPrint: Swap in / out
0 / 0 11:34:54 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 78499840; Read time: 0; Write time: 84064 11:34:54 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 262144; Write bytes: 247816192; Read time: 28; Write time: 202688 11:34:54 INFO - Running post-run listener: _upload_blobber_files 11:34:54 INFO - Blob upload gear active. 11:34:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:34:54 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 11:34:54 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'] 11:34:54 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 11:34:55 INFO - (blobuploader) - INFO - Open directory for files ... 11:34:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:34:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:34:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:34:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:34:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:34:55 INFO - (blobuploader) - INFO - Done attempting. 11:34:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:34:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:34:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:34:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:34:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:34:56 INFO - (blobuploader) - INFO - Done attempting. 11:34:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:34:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:34:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:35:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:35:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:35:00 INFO - (blobuploader) - INFO - Done attempting. 11:35:00 INFO - (blobuploader) - INFO - Iteration through files over. 11:35:00 INFO - Return code: 0 11:35:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:35:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:35:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b55b7e0f032c4054b0a0e7c5dc113f42baa38a88d5dfeca0f8fc43f8caee2d7a3de43e44c7ba812067daadae78ae2f894cea60dbd0dc7ffd77aed1d1c15ef9e6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/48b92ee6532e0c4128cb07b14161307c730e9ffdb22d3d22d174b7ea045aec9691f56804b08de31dd39c2d408f56e85c82628343fbb694b9434bf295c6066e96", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/add041af3fa25bff2bb1981900f69876f3fa34ddd3fb6582fd87c7772034259d2cad52ab884a74d6da3522b5e2cb6daf4e4fb03e14f2b11987471acddd9d4c2c"} 11:35:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:35:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:35:00 INFO - Contents: 11:35:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b55b7e0f032c4054b0a0e7c5dc113f42baa38a88d5dfeca0f8fc43f8caee2d7a3de43e44c7ba812067daadae78ae2f894cea60dbd0dc7ffd77aed1d1c15ef9e6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/48b92ee6532e0c4128cb07b14161307c730e9ffdb22d3d22d174b7ea045aec9691f56804b08de31dd39c2d408f56e85c82628343fbb694b9434bf295c6066e96", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/add041af3fa25bff2bb1981900f69876f3fa34ddd3fb6582fd87c7772034259d2cad52ab884a74d6da3522b5e2cb6daf4e4fb03e14f2b11987471acddd9d4c2c"} 11:35:00 INFO - Running post-run listener: copy_logs_to_upload_dir 11:35:00 INFO - Copying logs to upload dir... 11:35:00 INFO - mkdir: /builds/slave/test/build/upload/logs 11:35:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1679.748346 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 59 secs) (at 2016-08-05 11:34:59.511682) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 11:34:59.515698) ========= 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=fa44defc139c4ba8574fe040000001db-1470419619.168255-1719598066 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/b55b7e0f032c4054b0a0e7c5dc113f42baa38a88d5dfeca0f8fc43f8caee2d7a3de43e44c7ba812067daadae78ae2f894cea60dbd0dc7ffd77aed1d1c15ef9e6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/48b92ee6532e0c4128cb07b14161307c730e9ffdb22d3d22d174b7ea045aec9691f56804b08de31dd39c2d408f56e85c82628343fbb694b9434bf295c6066e96", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/add041af3fa25bff2bb1981900f69876f3fa34ddd3fb6582fd87c7772034259d2cad52ab884a74d6da3522b5e2cb6daf4e4fb03e14f2b11987471acddd9d4c2c"} build_url:https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011224 build_url: 'https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/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/b55b7e0f032c4054b0a0e7c5dc113f42baa38a88d5dfeca0f8fc43f8caee2d7a3de43e44c7ba812067daadae78ae2f894cea60dbd0dc7ffd77aed1d1c15ef9e6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/48b92ee6532e0c4128cb07b14161307c730e9ffdb22d3d22d174b7ea045aec9691f56804b08de31dd39c2d408f56e85c82628343fbb694b9434bf295c6066e96", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/add041af3fa25bff2bb1981900f69876f3fa34ddd3fb6582fd87c7772034259d2cad52ab884a74d6da3522b5e2cb6daf4e4fb03e14f2b11987471acddd9d4c2c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 11:34:59.543315) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 11:34:59.543678) ========= 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=fa44defc139c4ba8574fe040000001db-1470419619.168255-1719598066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004560 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 11:34:59.629112) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 11:34:59.629989) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 11:34:59.631505) ========= ========= Total master_lag: 0.16 =========