builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-008 starttime: 1471260770.76 results: success (0) buildid: 20160815012516 builduid: d1661f2f04924304abc0bbee7dae6820 revision: 0463f6653d4830bb793fb43678161dc08b827389 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-15 04:32:50.765370) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-15 04:32:50.765984) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-15 04:32:50.766325) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-15 04:32:50.781099) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 04:32:50.781389) ========= 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=32c5991c409366f7fec8a718000001d2-1471259115.130713-1805668120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-15 04:32:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-08-15 04:32:51 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.388979 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 04:32:51.184005) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 04:32:51.184328) ========= 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=32c5991c409366f7fec8a718000001d2-1471259115.130713-1805668120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019954 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 04:32:51.233626) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-15 04:32:51.233980) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0463f6653d4830bb793fb43678161dc08b827389 --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 0463f6653d4830bb793fb43678161dc08b827389 --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=32c5991c409366f7fec8a718000001d2-1471259115.130713-1805668120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-15 04:32:51,898 truncating revision to first 12 chars 2016-08-15 04:32:51,898 Setting DEBUG logging. 2016-08-15 04:32:51,898 attempt 1/10 2016-08-15 04:32:51,898 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0463f6653d48?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-15 04:32:52,669 unpacking tar archive at: mozilla-aurora-0463f6653d48/testing/mozharness/ program finished with exit code 0 elapsedTime=1.098970 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-15 04:32:52.346534) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-15 04:32:52.346857) ========= script_repo_revision: 0463f6653d4830bb793fb43678161dc08b827389 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-15 04:32:52.347305) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-15 04:32:52.347584) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-15 04:32:52.356981) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 3 secs) (at 2016-08-15 04:32:52.357281) ========= /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=32c5991c409366f7fec8a718000001d2-1471259115.130713-1805668120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:32:53 INFO - MultiFileLogger online at 20160815 04:32:53 in /builds/slave/test 04:32:53 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 04:32:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:32:53 INFO - {'append_to_log': False, 04:32:53 INFO - 'base_work_dir': '/builds/slave/test', 04:32:53 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:32:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:32:53 INFO - 'branch': 'Mozilla-Aurora', 04:32:53 INFO - 'buildbot_json_path': 'buildprops.json', 04:32:53 INFO - 'config_files': ('talos/linux_config.py',), 04:32:53 INFO - 'default_actions': ('clobber', 04:32:53 INFO - 'read-buildbot-config', 04:32:53 INFO - 'download-and-extract', 04:32:53 INFO - 'populate-webroot', 04:32:53 INFO - 'create-virtualenv', 04:32:53 INFO - 'install', 04:32:53 INFO - 'run-tests'), 04:32:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:32:53 INFO - 'download_minidump_stackwalk': True, 04:32:53 INFO - 'download_symbols': 'ondemand', 04:32:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:32:53 INFO - 'tooltool.py': '/tools/tooltool.py', 04:32:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:32:53 INFO - '/tools/misc-python/virtualenv.py')}, 04:32:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:32:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:32:53 INFO - 'installer_path': 'installer.exe', 04:32:53 INFO - 'log_level': 'info', 04:32:53 INFO - 'log_name': 'talos', 04:32:53 INFO - 'log_to_console': True, 04:32:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:32:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:32:53 INFO - 'opt_config_files': (), 04:32:53 INFO - 'pip_index': False, 04:32:53 INFO - 'sps_profile': False, 04:32:53 INFO - 'sps_profile_interval': 0, 04:32:53 INFO - 'suite': 'dromaeojs-e10s', 04:32:53 INFO - 'system_bits': '32', 04:32:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:32:53 INFO - 'title': 'talos-linux64-ix-008', 04:32:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:32:53 INFO - 'use_talos_json': True, 04:32:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:32:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:32:53 INFO - 'work_dir': 'build'} 04:32:53 INFO - [mozharness: 2016-08-15 11:32:53.107305Z] Running clobber step. 04:32:53 INFO - Running pre-action listener: _resource_record_pre_action 04:32:53 INFO - Running main action method: clobber 04:32:53 INFO - rmtree: /builds/slave/test/build 04:32:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:32:53 INFO - Running post-action listener: _resource_record_post_action 04:32:53 INFO - [mozharness: 2016-08-15 11:32:53.569844Z] Finished clobber step (success) 04:32:53 INFO - [mozharness: 2016-08-15 11:32:53.569944Z] Running read-buildbot-config step. 04:32:53 INFO - Running pre-action listener: _resource_record_pre_action 04:32:53 INFO - Running main action method: read_buildbot_config 04:32:53 INFO - Using buildbot properties: 04:32:53 INFO - { 04:32:53 INFO - "project": "", 04:32:53 INFO - "product": "firefox", 04:32:53 INFO - "script_repo_revision": "production", 04:32:53 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 04:32:53 INFO - "repository": "", 04:32:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 04:32:53 INFO - "buildid": "20160815012516", 04:32:53 INFO - "pgo_build": "True", 04:32:53 INFO - "basedir": "/builds/slave/test", 04:32:53 INFO - "buildnumber": 463, 04:32:53 INFO - "slavename": "talos-linux64-ix-008", 04:32:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:32:53 INFO - "platform": "ubuntu64_hw", 04:32:53 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 04:32:53 INFO - "branch": "mozilla-aurora", 04:32:53 INFO - "repo_path": "releases/mozilla-aurora", 04:32:53 INFO - "revision": "0463f6653d4830bb793fb43678161dc08b827389", 04:32:53 INFO - "stage_platform": "linux64-pgo", 04:32:53 INFO - "builduid": "d1661f2f04924304abc0bbee7dae6820", 04:32:53 INFO - "slavebuilddir": "test" 04:32:53 INFO - } 04:32:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/Flf0mpjSS3KHx9D2Avsy5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 04:32:53 INFO - Running post-action listener: _resource_record_post_action 04:32:53 INFO - [mozharness: 2016-08-15 11:32:53.572393Z] Finished read-buildbot-config step (success) 04:32:53 INFO - [mozharness: 2016-08-15 11:32:53.572482Z] Running download-and-extract step. 04:32:53 INFO - Running pre-action listener: _resource_record_pre_action 04:32:53 INFO - Running main action method: download_and_extract 04:32:53 INFO - mkdir: /builds/slave/test/build/tests 04:32: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')]} 04:32:53 INFO - https://queue.taskcluster.net/v1/task/Flf0mpjSS3KHx9D2Avsy5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:32:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Flf0mpjSS3KHx9D2Avsy5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 04:32:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Flf0mpjSS3KHx9D2Avsy5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 04:32:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Flf0mpjSS3KHx9D2Avsy5g/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 04:32:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Flf0mpjSS3KHx9D2Avsy5g/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 04:32:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Flf0mpjSS3KHx9D2Avsy5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 04:32:53 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 04:32:53 INFO - retry: Failed, sleeping 30 seconds before retrying 04:33:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Flf0mpjSS3KHx9D2Avsy5g/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 04:33:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Flf0mpjSS3KHx9D2Avsy5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 04:33:23 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 04:33:23 INFO - retry: Failed, sleeping 60 seconds before retrying 04:34:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Flf0mpjSS3KHx9D2Avsy5g/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 04:34:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Flf0mpjSS3KHx9D2Avsy5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 04:34:23 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 04:34:23 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Flf0mpjSS3KHx9D2Avsy5g/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! 04:34:23 INFO - Caught exception: HTTP Error 404: Not Found 04:34:23 INFO - Caught exception: HTTP Error 404: Not Found 04:34:23 INFO - Caught exception: HTTP Error 404: Not Found 04:34:23 INFO - trying https://queue.taskcluster.net/v1/task/Flf0mpjSS3KHx9D2Avsy5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 04:34:23 INFO - Downloading https://queue.taskcluster.net/v1/task/Flf0mpjSS3KHx9D2Avsy5g/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 04:34:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Flf0mpjSS3KHx9D2Avsy5g/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 04:34:24 INFO - Downloaded 1361 bytes. 04:34:24 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 04:34:24 INFO - Using the following test package requirements: 04:34:24 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 04:34:24 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 04:34:24 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 04:34:24 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 04:34:24 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 04:34:24 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 04:34:24 INFO - u'jsshell-linux-x86_64.zip'], 04:34:24 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 04:34:24 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 04:34:24 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 04:34:24 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 04:34:24 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 04:34:24 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 04:34:24 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 04:34:24 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 04:34:24 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 04:34:24 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 04:34:24 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 04:34:24 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:34:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:24 INFO - https://queue.taskcluster.net/v1/task/Flf0mpjSS3KHx9D2Avsy5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:34:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Flf0mpjSS3KHx9D2Avsy5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 04:34:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Flf0mpjSS3KHx9D2Avsy5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 04:34:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Flf0mpjSS3KHx9D2Avsy5g/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 04:34:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Flf0mpjSS3KHx9D2Avsy5g/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 04:34:24 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Flf0mpjSS3KHx9D2Avsy5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 04:34:24 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 04:34:24 INFO - retry: Failed, sleeping 30 seconds before retrying 04:34:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Flf0mpjSS3KHx9D2Avsy5g/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 04:34:54 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Flf0mpjSS3KHx9D2Avsy5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 04:34:54 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 04:34:54 INFO - retry: Failed, sleeping 60 seconds before retrying 04:35:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Flf0mpjSS3KHx9D2Avsy5g/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 04:35:54 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Flf0mpjSS3KHx9D2Avsy5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 04:35:54 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 04:35:54 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Flf0mpjSS3KHx9D2Avsy5g/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! 04:35:54 INFO - Caught exception: HTTP Error 404: Not Found 04:35:54 INFO - Caught exception: HTTP Error 404: Not Found 04:35:54 INFO - Caught exception: HTTP Error 404: Not Found 04:35:54 INFO - trying https://queue.taskcluster.net/v1/task/Flf0mpjSS3KHx9D2Avsy5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 04:35:54 INFO - Downloading https://queue.taskcluster.net/v1/task/Flf0mpjSS3KHx9D2Avsy5g/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 04:35:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Flf0mpjSS3KHx9D2Avsy5g/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 04:35:55 INFO - Downloaded 21766161 bytes. 04:35:55 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'] 04:35:55 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 04:35:56 INFO - Return code: 0 04:35:56 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 04:35:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:56 INFO - https://queue.taskcluster.net/v1/task/Flf0mpjSS3KHx9D2Avsy5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:35:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Flf0mpjSS3KHx9D2Avsy5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 04:35:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Flf0mpjSS3KHx9D2Avsy5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 04:35:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Flf0mpjSS3KHx9D2Avsy5g/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 04:35:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Flf0mpjSS3KHx9D2Avsy5g/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 04:35:56 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Flf0mpjSS3KHx9D2Avsy5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 04:35:56 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 04:35:56 INFO - retry: Failed, sleeping 30 seconds before retrying 04:36:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Flf0mpjSS3KHx9D2Avsy5g/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 04:36:26 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Flf0mpjSS3KHx9D2Avsy5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 04:36:26 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 04:36:26 INFO - retry: Failed, sleeping 60 seconds before retrying 04:37:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Flf0mpjSS3KHx9D2Avsy5g/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 04:37:26 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Flf0mpjSS3KHx9D2Avsy5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 04:37:26 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 04:37:26 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Flf0mpjSS3KHx9D2Avsy5g/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! 04:37:26 INFO - Caught exception: HTTP Error 404: Not Found 04:37:26 INFO - Caught exception: HTTP Error 404: Not Found 04:37:26 INFO - Caught exception: HTTP Error 404: Not Found 04:37:26 INFO - trying https://queue.taskcluster.net/v1/task/Flf0mpjSS3KHx9D2Avsy5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 04:37:26 INFO - Downloading https://queue.taskcluster.net/v1/task/Flf0mpjSS3KHx9D2Avsy5g/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 04:37:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Flf0mpjSS3KHx9D2Avsy5g/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 04:37:27 INFO - Downloaded 21766161 bytes. 04:37:27 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'] 04:37:27 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 04:37:28 INFO - Return code: 0 04:37:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:28 INFO - https://queue.taskcluster.net/v1/task/Flf0mpjSS3KHx9D2Avsy5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:37:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Flf0mpjSS3KHx9D2Avsy5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 04:37:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Flf0mpjSS3KHx9D2Avsy5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 04:37:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Flf0mpjSS3KHx9D2Avsy5g/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 04:37:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Flf0mpjSS3KHx9D2Avsy5g/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 04:37:28 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Flf0mpjSS3KHx9D2Avsy5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 04:37:28 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 04:37:28 INFO - retry: Failed, sleeping 30 seconds before retrying 04:37:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Flf0mpjSS3KHx9D2Avsy5g/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 04:37:58 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Flf0mpjSS3KHx9D2Avsy5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 04:37:58 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 04:37:58 INFO - retry: Failed, sleeping 60 seconds before retrying 04:38:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Flf0mpjSS3KHx9D2Avsy5g/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 04:38:58 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Flf0mpjSS3KHx9D2Avsy5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 04:38:58 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 04:38:58 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Flf0mpjSS3KHx9D2Avsy5g/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! 04:38:58 INFO - Caught exception: HTTP Error 404: Not Found 04:38:58 INFO - Caught exception: HTTP Error 404: Not Found 04:38:58 INFO - Caught exception: HTTP Error 404: Not Found 04:38:58 INFO - trying https://queue.taskcluster.net/v1/task/Flf0mpjSS3KHx9D2Avsy5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 04:38:58 INFO - Downloading https://queue.taskcluster.net/v1/task/Flf0mpjSS3KHx9D2Avsy5g/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 04:38:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Flf0mpjSS3KHx9D2Avsy5g/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 04:39:00 INFO - Downloaded 14413723 bytes. 04:39:00 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'] 04:39:00 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 04:39:00 INFO - Return code: 0 04:39: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')]} 04:39:00 INFO - https://queue.taskcluster.net/v1/task/Flf0mpjSS3KHx9D2Avsy5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:39:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Flf0mpjSS3KHx9D2Avsy5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 04:39:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Flf0mpjSS3KHx9D2Avsy5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 04:39:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Flf0mpjSS3KHx9D2Avsy5g/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 04:39:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Flf0mpjSS3KHx9D2Avsy5g/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 04:39:00 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Flf0mpjSS3KHx9D2Avsy5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 04:39:00 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 04:39:00 INFO - retry: Failed, sleeping 30 seconds before retrying 04:39:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Flf0mpjSS3KHx9D2Avsy5g/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 04:39:30 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Flf0mpjSS3KHx9D2Avsy5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 04:39:30 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 04:39:30 INFO - retry: Failed, sleeping 60 seconds before retrying 04:40:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Flf0mpjSS3KHx9D2Avsy5g/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 04:40:31 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Flf0mpjSS3KHx9D2Avsy5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 04:40:31 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 04:40:31 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Flf0mpjSS3KHx9D2Avsy5g/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! 04:40:31 INFO - Caught exception: HTTP Error 404: Not Found 04:40:31 INFO - Caught exception: HTTP Error 404: Not Found 04:40:31 INFO - Caught exception: HTTP Error 404: Not Found 04:40:31 INFO - trying https://queue.taskcluster.net/v1/task/Flf0mpjSS3KHx9D2Avsy5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 04:40:31 INFO - Downloading https://queue.taskcluster.net/v1/task/Flf0mpjSS3KHx9D2Avsy5g/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 04:40:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Flf0mpjSS3KHx9D2Avsy5g/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 04:40:33 INFO - Downloaded 63772588 bytes. 04:40:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Flf0mpjSS3KHx9D2Avsy5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 04:40:33 INFO - mkdir: /builds/slave/test/properties 04:40:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:40:33 INFO - Writing to file /builds/slave/test/properties/build_url 04:40:33 INFO - Contents: 04:40:33 INFO - build_url:https://queue.taskcluster.net/v1/task/Flf0mpjSS3KHx9D2Avsy5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 04:40:33 INFO - Running post-action listener: _resource_record_post_action 04:40:33 INFO - Running post-action listener: set_extra_try_arguments 04:40:33 INFO - [mozharness: 2016-08-15 11:40:33.866733Z] Finished download-and-extract step (success) 04:40:33 INFO - [mozharness: 2016-08-15 11:40:33.866964Z] Running populate-webroot step. 04:40:33 INFO - Running pre-action listener: _resource_record_pre_action 04:40:33 INFO - Running main action method: populate_webroot 04:40:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:40:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:40:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:40:33 INFO - '--tppagecycles', 04:40:33 INFO - '7'], 04:40:33 INFO - 'tests': ['tsvgm']}}, 04:40:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:40:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:40:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:40:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:40:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:40:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:40:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:33 INFO - 'talos_options': ['--disable-e10s'], 04:40:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:40:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:40:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:33 INFO - 'talos_options': ['--disable-e10s'], 04:40:33 INFO - 'tests': ['damp', 'tps']}, 04:40:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:33 INFO - 'tests': ['damp', 'tps']}, 04:40:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:40:33 INFO - 'tests': ['dromaeo_dom']}, 04:40:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:40:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:40:33 INFO - 'tests': ['basic_compositor_video']}, 04:40:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:40:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:40:33 INFO - 'tests': ['a11yr', 04:40:33 INFO - 'ts_paint', 04:40:33 INFO - 'tpaint', 04:40:33 INFO - 'sessionrestore', 04:40:33 INFO - 'sessionrestore_no_auto_restore', 04:40:33 INFO - 'tabpaint']}, 04:40:33 INFO - 'other-e10s': {'tests': ['a11yr', 04:40:33 INFO - 'ts_paint', 04:40:33 INFO - 'tpaint', 04:40:33 INFO - 'sessionrestore', 04:40:33 INFO - 'sessionrestore_no_auto_restore', 04:40:33 INFO - 'tabpaint']}, 04:40:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:40:33 INFO - 'ts_paint', 04:40:33 INFO - 'tpaint', 04:40:33 INFO - 'sessionrestore', 04:40:33 INFO - 'sessionrestore_no_auto_restore', 04:40:33 INFO - 'tabpaint']}, 04:40:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:40:33 INFO - 'ts_paint', 04:40:33 INFO - 'tpaint', 04:40:33 INFO - 'sessionrestore', 04:40:33 INFO - 'sessionrestore_no_auto_restore', 04:40:33 INFO - 'tabpaint']}, 04:40:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:40:33 INFO - 'tests': ['a11yr', 04:40:33 INFO - 'ts_paint', 04:40:33 INFO - 'tpaint', 04:40:33 INFO - 'sessionrestore', 04:40:33 INFO - 'sessionrestore_no_auto_restore', 04:40:33 INFO - 'tabpaint']}, 04:40:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:40:33 INFO - 'tests': ['a11yr', 04:40:33 INFO - 'ts_paint', 04:40:33 INFO - 'tpaint', 04:40:33 INFO - 'sessionrestore', 04:40:33 INFO - 'sessionrestore_no_auto_restore', 04:40:33 INFO - 'tabpaint']}, 04:40:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:40:33 INFO - 'tests': ['tsvgx', 04:40:33 INFO - 'tsvgr_opacity', 04:40:33 INFO - 'tart', 04:40:33 INFO - 'tscrollx', 04:40:33 INFO - 'cart']}, 04:40:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:40:33 INFO - 'tsvgr_opacity', 04:40:33 INFO - 'tart', 04:40:33 INFO - 'tscrollx', 04:40:33 INFO - 'cart']}, 04:40:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:33 INFO - 'talos_options': ['--disable-e10s'], 04:40:33 INFO - 'tests': ['tp5o']}, 04:40:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:33 INFO - 'tests': ['tp5o']}, 04:40:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:33 INFO - 'talos_options': ['--disable-e10s', 04:40:33 INFO - '--xperf_path', 04:40:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:40:33 INFO - 'tests': ['tp5n']}, 04:40:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:33 INFO - 'talos_options': ['--xperf_path', 04:40:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:40:33 INFO - 'tests': ['tp5n']}}, 04:40:33 INFO - 'talos.zip': {'path': '', 04:40:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:40:33 INFO - Running post-action listener: _resource_record_post_action 04:40:33 INFO - [mozharness: 2016-08-15 11:40:33.885853Z] Finished populate-webroot step (success) 04:40:33 INFO - [mozharness: 2016-08-15 11:40:33.885940Z] Running create-virtualenv step. 04:40:33 INFO - Running pre-action listener: _resource_record_pre_action 04:40:33 INFO - Running main action method: create_virtualenv 04:40:33 INFO - Creating virtualenv /builds/slave/test/build/venv 04:40:33 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 04:40:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:40:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:40:33 INFO - Using real prefix '/usr' 04:40:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:40:34 INFO - Installing distribute.............................................................................................................................................................................................done. 04:40:36 INFO - Installing pip.................done. 04:40:36 INFO - Return code: 0 04:40:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:40:36 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')]} 04:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:36 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')]} 04:40:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:36 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 0x2908030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b37400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc6570>, '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 0x2bc7470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7900>, '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': '32c5991c409366f7fec8a718000001d2-1471259115.130713-1805668120', '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 04:40:36 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 04:40:36 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 04:40:36 INFO - Using env: {'DISPLAY': ':0', 04:40:36 INFO - 'HOME': '/home/cltbld', 04:40:36 INFO - 'LANG': 'en_US.UTF-8', 04:40:36 INFO - 'LANGUAGE': 'en_US:en', 04:40:36 INFO - 'LOGNAME': 'cltbld', 04:40:36 INFO - 'MAIL': '/var/mail/cltbld', 04:40:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:36 INFO - 'MOZ_NO_REMOTE': '1', 04:40:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:36 INFO - 'NO_EM_RESTART': '1', 04:40:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:36 INFO - 'PWD': '/builds/slave/test', 04:40:36 INFO - 'SHELL': '/bin/bash', 04:40:36 INFO - 'SHLVL': '1', 04:40:36 INFO - 'TERM': 'linux', 04:40:36 INFO - 'TMOUT': '86400', 04:40:36 INFO - 'USER': 'cltbld', 04:40:36 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471259115.130713-1805668120', 04:40:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:36 INFO - '_': '/tools/buildbot/bin/python'} 04:40:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:36 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 04:40:36 INFO - Cleaning up... 04:40:36 INFO - Return code: 0 04:40:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:40:36 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')]} 04:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:36 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')]} 04:40:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:36 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 0x2908030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b37400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc6570>, '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 0x2bc7470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7900>, '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': '32c5991c409366f7fec8a718000001d2-1471259115.130713-1805668120', '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 04:40:36 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 04:40:36 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 04:40:36 INFO - Using env: {'DISPLAY': ':0', 04:40:36 INFO - 'HOME': '/home/cltbld', 04:40:36 INFO - 'LANG': 'en_US.UTF-8', 04:40:36 INFO - 'LANGUAGE': 'en_US:en', 04:40:36 INFO - 'LOGNAME': 'cltbld', 04:40:36 INFO - 'MAIL': '/var/mail/cltbld', 04:40:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:36 INFO - 'MOZ_NO_REMOTE': '1', 04:40:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:36 INFO - 'NO_EM_RESTART': '1', 04:40:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:36 INFO - 'PWD': '/builds/slave/test', 04:40:36 INFO - 'SHELL': '/bin/bash', 04:40:36 INFO - 'SHLVL': '1', 04:40:36 INFO - 'TERM': 'linux', 04:40:36 INFO - 'TMOUT': '86400', 04:40:36 INFO - 'USER': 'cltbld', 04:40:36 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471259115.130713-1805668120', 04:40:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:36 INFO - '_': '/tools/buildbot/bin/python'} 04:40:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:36 INFO - Downloading/unpacking psutil>=3.1.1 04:40:36 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 04:40:36 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 04:40:36 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 04:40:36 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 04:40:36 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 04:40:36 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 04:40:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:40:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:40:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:40:38 INFO - Installing collected packages: psutil 04:40:38 INFO - Running setup.py install for psutil 04:40:38 INFO - building 'psutil._psutil_linux' extension 04:40:38 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 04:40:39 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 04:40:39 INFO - building 'psutil._psutil_posix' extension 04:40:39 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 04:40:39 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 04:40:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:40:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:40:39 INFO - Successfully installed psutil 04:40:39 INFO - Cleaning up... 04:40:39 INFO - Return code: 0 04:40:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:40:39 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')]} 04:40:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:39 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')]} 04:40:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:39 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 0x2908030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b37400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc6570>, '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 0x2bc7470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7900>, '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': '32c5991c409366f7fec8a718000001d2-1471259115.130713-1805668120', '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 04:40:39 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 04:40:39 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 04:40:39 INFO - Using env: {'DISPLAY': ':0', 04:40:39 INFO - 'HOME': '/home/cltbld', 04:40:39 INFO - 'LANG': 'en_US.UTF-8', 04:40:39 INFO - 'LANGUAGE': 'en_US:en', 04:40:39 INFO - 'LOGNAME': 'cltbld', 04:40:39 INFO - 'MAIL': '/var/mail/cltbld', 04:40:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:39 INFO - 'MOZ_NO_REMOTE': '1', 04:40:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:39 INFO - 'NO_EM_RESTART': '1', 04:40:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:39 INFO - 'PWD': '/builds/slave/test', 04:40:39 INFO - 'SHELL': '/bin/bash', 04:40:39 INFO - 'SHLVL': '1', 04:40:39 INFO - 'TERM': 'linux', 04:40:39 INFO - 'TMOUT': '86400', 04:40:39 INFO - 'USER': 'cltbld', 04:40:39 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471259115.130713-1805668120', 04:40:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:39 INFO - '_': '/tools/buildbot/bin/python'} 04:40:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:40:39 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 04:40:39 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 04:40:39 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 04:40:39 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 04:40:39 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 04:40:39 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 04:40:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:40:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:40:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:40:41 INFO - Installing collected packages: mozsystemmonitor 04:40:41 INFO - Running setup.py install for mozsystemmonitor 04:40:41 INFO - Successfully installed mozsystemmonitor 04:40:41 INFO - Cleaning up... 04:40:41 INFO - Return code: 0 04:40:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:40:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:41 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 0x2908030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b37400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc6570>, '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 0x2bc7470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7900>, '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': '32c5991c409366f7fec8a718000001d2-1471259115.130713-1805668120', '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 04:40:41 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 04:40:41 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 04:40:41 INFO - Using env: {'DISPLAY': ':0', 04:40:41 INFO - 'HOME': '/home/cltbld', 04:40:41 INFO - 'LANG': 'en_US.UTF-8', 04:40:41 INFO - 'LANGUAGE': 'en_US:en', 04:40:41 INFO - 'LOGNAME': 'cltbld', 04:40:41 INFO - 'MAIL': '/var/mail/cltbld', 04:40:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:41 INFO - 'MOZ_NO_REMOTE': '1', 04:40:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:41 INFO - 'NO_EM_RESTART': '1', 04:40:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:41 INFO - 'PWD': '/builds/slave/test', 04:40:41 INFO - 'SHELL': '/bin/bash', 04:40:41 INFO - 'SHLVL': '1', 04:40:41 INFO - 'TERM': 'linux', 04:40:41 INFO - 'TMOUT': '86400', 04:40:41 INFO - 'USER': 'cltbld', 04:40:41 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471259115.130713-1805668120', 04:40:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:41 INFO - '_': '/tools/buildbot/bin/python'} 04:40:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:41 INFO - Downloading/unpacking jsonschema==2.5.1 04:40:41 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 04:40:41 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 04:40:41 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 04:40:41 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 04:40:41 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 04:40:41 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 04:40:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:40:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:40:43 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 04:40:43 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 04:40:43 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 04:40:43 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 04:40:43 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 04:40:43 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 04:40:44 INFO - Downloading functools32-3.2.3-2.tar.gz 04:40:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:40:44 INFO - warning: no files found matching '*.txt' 04:40:44 INFO - no previously-included directories found matching 'build' 04:40:44 INFO - no previously-included directories found matching 'dist' 04:40:44 INFO - no previously-included directories found matching '.git*' 04:40:44 INFO - Installing collected packages: jsonschema, functools32 04:40:44 INFO - Running setup.py install for functools32 04:40:44 INFO - warning: no files found matching '*.txt' 04:40:44 INFO - no previously-included directories found matching 'build' 04:40:44 INFO - no previously-included directories found matching 'dist' 04:40:44 INFO - no previously-included directories found matching '.git*' 04:40:44 INFO - Successfully installed jsonschema functools32 04:40:44 INFO - Cleaning up... 04:40:44 INFO - Return code: 0 04:40:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:40:44 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')]} 04:40:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:44 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')]} 04:40:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:44 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 0x2908030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b37400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc6570>, '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 0x2bc7470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7900>, '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': '32c5991c409366f7fec8a718000001d2-1471259115.130713-1805668120', '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 04:40:44 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 04:40:44 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 04:40:44 INFO - Using env: {'DISPLAY': ':0', 04:40:44 INFO - 'HOME': '/home/cltbld', 04:40:44 INFO - 'LANG': 'en_US.UTF-8', 04:40:44 INFO - 'LANGUAGE': 'en_US:en', 04:40:44 INFO - 'LOGNAME': 'cltbld', 04:40:44 INFO - 'MAIL': '/var/mail/cltbld', 04:40:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:44 INFO - 'MOZ_NO_REMOTE': '1', 04:40:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:44 INFO - 'NO_EM_RESTART': '1', 04:40:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:44 INFO - 'PWD': '/builds/slave/test', 04:40:44 INFO - 'SHELL': '/bin/bash', 04:40:44 INFO - 'SHLVL': '1', 04:40:44 INFO - 'TERM': 'linux', 04:40:44 INFO - 'TMOUT': '86400', 04:40:44 INFO - 'USER': 'cltbld', 04:40:44 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471259115.130713-1805668120', 04:40:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:44 INFO - '_': '/tools/buildbot/bin/python'} 04:40:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:40:44 INFO - Cleaning up... 04:40:44 INFO - Return code: 0 04:40:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:40:44 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')]} 04:40:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:44 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')]} 04:40:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:44 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 0x2908030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b37400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc6570>, '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 0x2bc7470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7900>, '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': '32c5991c409366f7fec8a718000001d2-1471259115.130713-1805668120', '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 04:40:44 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 04:40:44 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 04:40:44 INFO - Using env: {'DISPLAY': ':0', 04:40:44 INFO - 'HOME': '/home/cltbld', 04:40:44 INFO - 'LANG': 'en_US.UTF-8', 04:40:44 INFO - 'LANGUAGE': 'en_US:en', 04:40:44 INFO - 'LOGNAME': 'cltbld', 04:40:44 INFO - 'MAIL': '/var/mail/cltbld', 04:40:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:44 INFO - 'MOZ_NO_REMOTE': '1', 04:40:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:44 INFO - 'NO_EM_RESTART': '1', 04:40:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:44 INFO - 'PWD': '/builds/slave/test', 04:40:44 INFO - 'SHELL': '/bin/bash', 04:40:44 INFO - 'SHLVL': '1', 04:40:44 INFO - 'TERM': 'linux', 04:40:44 INFO - 'TMOUT': '86400', 04:40:44 INFO - 'USER': 'cltbld', 04:40:44 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471259115.130713-1805668120', 04:40:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:44 INFO - '_': '/tools/buildbot/bin/python'} 04:40:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:44 INFO - Downloading/unpacking blobuploader==1.2.4 04:40:44 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 04:40:44 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 04:40:44 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 04:40:44 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 04:40:44 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 04:40:44 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 04:40:46 INFO - Downloading blobuploader-1.2.4.tar.gz 04:40:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:40:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:40: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 04:40: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 04:40: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 04:40: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 04:40: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 04:40: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 04:40:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:40:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:40:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:40:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:40:47 INFO - Downloading docopt-0.6.1.tar.gz 04:40:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:40:47 INFO - Installing collected packages: blobuploader, requests, docopt 04:40:47 INFO - Running setup.py install for blobuploader 04:40:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:40:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:40:47 INFO - Running setup.py install for requests 04:40:47 INFO - Running setup.py install for docopt 04:40:48 INFO - Successfully installed blobuploader requests docopt 04:40:48 INFO - Cleaning up... 04:40:48 INFO - Return code: 0 04:40:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:40:48 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')]} 04:40:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:48 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')]} 04:40:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:48 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 0x2908030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b37400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc6570>, '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 0x2bc7470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7900>, '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': '32c5991c409366f7fec8a718000001d2-1471259115.130713-1805668120', '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 04:40:48 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 04:40:48 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 04:40:48 INFO - Using env: {'DISPLAY': ':0', 04:40:48 INFO - 'HOME': '/home/cltbld', 04:40:48 INFO - 'LANG': 'en_US.UTF-8', 04:40:48 INFO - 'LANGUAGE': 'en_US:en', 04:40:48 INFO - 'LOGNAME': 'cltbld', 04:40:48 INFO - 'MAIL': '/var/mail/cltbld', 04:40:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:48 INFO - 'MOZ_NO_REMOTE': '1', 04:40:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:48 INFO - 'NO_EM_RESTART': '1', 04:40:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:48 INFO - 'PWD': '/builds/slave/test', 04:40:48 INFO - 'SHELL': '/bin/bash', 04:40:48 INFO - 'SHLVL': '1', 04:40:48 INFO - 'TERM': 'linux', 04:40:48 INFO - 'TMOUT': '86400', 04:40:48 INFO - 'USER': 'cltbld', 04:40:48 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471259115.130713-1805668120', 04:40:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:48 INFO - '_': '/tools/buildbot/bin/python'} 04:40:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:40:48 INFO - Running setup.py (path:/tmp/pip-NLaLRK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:40:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:40:48 INFO - Running setup.py (path:/tmp/pip-jVbK9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:40:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:40:48 INFO - Running setup.py (path:/tmp/pip-Tg7aUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:40:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:40:48 INFO - Running setup.py (path:/tmp/pip-5BQNCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:40:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:40:48 INFO - Running setup.py (path:/tmp/pip-dxEUOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:40:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:40:48 INFO - Running setup.py (path:/tmp/pip-2km5Xy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:40:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:40:48 INFO - Running setup.py (path:/tmp/pip-RlBHyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:40:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:40:48 INFO - Running setup.py (path:/tmp/pip-u9HbIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:40:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:40:48 INFO - Running setup.py (path:/tmp/pip-iDt5nV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:40:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:40:48 INFO - Running setup.py (path:/tmp/pip-NiSAN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:40:49 INFO - Running setup.py (path:/tmp/pip-TXyIgF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:40:49 INFO - Running setup.py (path:/tmp/pip-63JbjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:40:49 INFO - Running setup.py (path:/tmp/pip-PLfNeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:40:49 INFO - Running setup.py (path:/tmp/pip-q6vTxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:40:49 INFO - Running setup.py (path:/tmp/pip-Quf4ji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:40:49 INFO - Running setup.py (path:/tmp/pip-BsMMKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:40:49 INFO - Running setup.py (path:/tmp/pip-Q6gFUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:40:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:40:49 INFO - Running setup.py install for manifestparser 04:40:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:40:49 INFO - Running setup.py install for mozcrash 04:40:49 INFO - Running setup.py install for mozdebug 04:40:49 INFO - Running setup.py install for mozdevice 04:40:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:40:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:40:49 INFO - Running setup.py install for mozfile 04:40:50 INFO - Running setup.py install for mozhttpd 04:40:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:40:50 INFO - Running setup.py install for mozinfo 04:40:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:40:50 INFO - Running setup.py install for mozInstall 04:40:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:40:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:40:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:40:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:40:50 INFO - Running setup.py install for mozleak 04:40:50 INFO - Running setup.py install for mozlog 04:40:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:40:50 INFO - Running setup.py install for moznetwork 04:40:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:40:50 INFO - Running setup.py install for mozprocess 04:40:50 INFO - Running setup.py install for mozprofile 04:40:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:40:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:40:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:40:50 INFO - Running setup.py install for mozrunner 04:40:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:40:51 INFO - Running setup.py install for mozscreenshot 04:40:51 INFO - Running setup.py install for moztest 04:40:51 INFO - Running setup.py install for mozversion 04:40:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:40:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:40:51 INFO - Cleaning up... 04:40:51 INFO - Return code: 0 04:40:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:40: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')]} 04:40:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40: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')]} 04:40:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:51 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 0x2908030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b37400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc6570>, '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 0x2bc7470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7900>, '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': '32c5991c409366f7fec8a718000001d2-1471259115.130713-1805668120', '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 04:40:51 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 04:40:51 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 04:40:51 INFO - Using env: {'DISPLAY': ':0', 04:40:51 INFO - 'HOME': '/home/cltbld', 04:40:51 INFO - 'LANG': 'en_US.UTF-8', 04:40:51 INFO - 'LANGUAGE': 'en_US:en', 04:40:51 INFO - 'LOGNAME': 'cltbld', 04:40:51 INFO - 'MAIL': '/var/mail/cltbld', 04:40:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:51 INFO - 'MOZ_NO_REMOTE': '1', 04:40:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:51 INFO - 'NO_EM_RESTART': '1', 04:40:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:51 INFO - 'PWD': '/builds/slave/test', 04:40:51 INFO - 'SHELL': '/bin/bash', 04:40:51 INFO - 'SHLVL': '1', 04:40:51 INFO - 'TERM': 'linux', 04:40:51 INFO - 'TMOUT': '86400', 04:40:51 INFO - 'USER': 'cltbld', 04:40:51 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471259115.130713-1805668120', 04:40:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:51 INFO - '_': '/tools/buildbot/bin/python'} 04:40:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:40:51 INFO - Running setup.py (path:/tmp/pip-SvC0MW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:40:51 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)) 04:40:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:40:51 INFO - Running setup.py (path:/tmp/pip-8d5z4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:40:51 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)) 04:40:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:40:51 INFO - Running setup.py (path:/tmp/pip-73ciPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:40:51 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)) 04:40:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:40:51 INFO - Running setup.py (path:/tmp/pip-b7HRVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:40:51 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)) 04:40:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:40:51 INFO - Running setup.py (path:/tmp/pip-8oeKRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:40:51 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)) 04:40:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:40:51 INFO - Running setup.py (path:/tmp/pip-Dao6er-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:40:51 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)) 04:40:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:40:52 INFO - Running setup.py (path:/tmp/pip-2QZNeD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:40:52 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)) 04:40:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:40:52 INFO - Running setup.py (path:/tmp/pip-Ofhl30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:40:52 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)) 04:40:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:40:52 INFO - Running setup.py (path:/tmp/pip-jvW1Z2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:40:52 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)) 04:40:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:40:52 INFO - Running setup.py (path:/tmp/pip-8MRADO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:40:52 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)) 04:40:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:40:52 INFO - Running setup.py (path:/tmp/pip-1KZ9Pu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:40:52 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)) 04:40:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:40:52 INFO - Running setup.py (path:/tmp/pip-zVLbpU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:40:52 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)) 04:40:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:40:52 INFO - Running setup.py (path:/tmp/pip-Y1XW0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:40:52 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)) 04:40:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:40:52 INFO - Running setup.py (path:/tmp/pip-q40jCu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:40:52 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)) 04:40:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:40:52 INFO - Running setup.py (path:/tmp/pip-dbJMXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:40:52 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)) 04:40:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:40:52 INFO - Running setup.py (path:/tmp/pip-Vr1AuM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:40:52 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)) 04:40:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:40:52 INFO - Running setup.py (path:/tmp/pip-J4dgmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:40:52 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)) 04:40:52 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)) 04:40:52 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)) 04:40:52 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)) 04:40:52 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)) 04:40:52 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)) 04:40:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:40:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:40:54 INFO - Downloading blessings-1.6.tar.gz 04:40:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:40:54 INFO - Installing collected packages: blessings 04:40:54 INFO - Running setup.py install for blessings 04:40:54 INFO - Successfully installed blessings 04:40:54 INFO - Cleaning up... 04:40:54 INFO - Return code: 0 04:40:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:40:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:40:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:40:55 INFO - Reading from file tmpfile_stdout 04:40:55 INFO - Current package versions: 04:40:55 INFO - argparse == 1.2.1 04:40:55 INFO - blessings == 1.6 04:40:55 INFO - blobuploader == 1.2.4 04:40:55 INFO - docopt == 0.6.1 04:40:55 INFO - functools32 == 3.2.3-2 04:40:55 INFO - jsonschema == 2.5.1 04:40:55 INFO - manifestparser == 1.1 04:40:55 INFO - mozInstall == 1.12 04:40:55 INFO - mozcrash == 0.17 04:40:55 INFO - mozdebug == 0.1 04:40:55 INFO - mozdevice == 0.48 04:40:55 INFO - mozfile == 1.2 04:40:55 INFO - mozhttpd == 0.7 04:40:55 INFO - mozinfo == 0.9 04:40:55 INFO - mozleak == 0.1 04:40:55 INFO - mozlog == 3.3 04:40:55 INFO - moznetwork == 0.27 04:40:55 INFO - mozprocess == 0.23 04:40:55 INFO - mozprofile == 0.28 04:40:55 INFO - mozrunner == 6.12 04:40:55 INFO - mozscreenshot == 0.1 04:40:55 INFO - mozsystemmonitor == 0.3 04:40:55 INFO - moztest == 0.7 04:40:55 INFO - mozversion == 1.4 04:40:55 INFO - psutil == 3.1.1 04:40:55 INFO - requests == 1.2.3 04:40:55 INFO - wsgiref == 0.1.2 04:40:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:40:55 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')]} 04:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:55 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')]} 04:40:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:55 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 0x2908030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b37400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc6570>, '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 0x2bc7470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7900>, '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': '32c5991c409366f7fec8a718000001d2-1471259115.130713-1805668120', '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 04:40:55 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 04:40:55 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 04:40:55 INFO - Using env: {'DISPLAY': ':0', 04:40:55 INFO - 'HOME': '/home/cltbld', 04:40:55 INFO - 'LANG': 'en_US.UTF-8', 04:40:55 INFO - 'LANGUAGE': 'en_US:en', 04:40:55 INFO - 'LOGNAME': 'cltbld', 04:40:55 INFO - 'MAIL': '/var/mail/cltbld', 04:40:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:55 INFO - 'MOZ_NO_REMOTE': '1', 04:40:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:55 INFO - 'NO_EM_RESTART': '1', 04:40:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:55 INFO - 'PWD': '/builds/slave/test', 04:40:55 INFO - 'SHELL': '/bin/bash', 04:40:55 INFO - 'SHLVL': '1', 04:40:55 INFO - 'TERM': 'linux', 04:40:55 INFO - 'TMOUT': '86400', 04:40:55 INFO - 'USER': 'cltbld', 04:40:55 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471259115.130713-1805668120', 04:40:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:55 INFO - '_': '/tools/buildbot/bin/python'} 04:40:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:55 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)) 04:40:55 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)) 04:40:55 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)) 04:40:55 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)) 04:40:55 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)) 04:40:55 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)) 04:40:55 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)) 04:40:55 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)) 04:40:55 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)) 04:40:55 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)) 04:40:55 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)) 04:40:55 INFO - Cleaning up... 04:40:55 INFO - Return code: 0 04:40:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:40:55 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')]} 04:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:55 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')]} 04:40:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:55 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 0x2908030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b37400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc6570>, '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 0x2bc7470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7900>, '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': '32c5991c409366f7fec8a718000001d2-1471259115.130713-1805668120', '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 04:40:55 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 04:40:55 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 04:40:55 INFO - Using env: {'DISPLAY': ':0', 04:40:55 INFO - 'HOME': '/home/cltbld', 04:40:55 INFO - 'LANG': 'en_US.UTF-8', 04:40:55 INFO - 'LANGUAGE': 'en_US:en', 04:40:55 INFO - 'LOGNAME': 'cltbld', 04:40:55 INFO - 'MAIL': '/var/mail/cltbld', 04:40:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:55 INFO - 'MOZ_NO_REMOTE': '1', 04:40:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:55 INFO - 'NO_EM_RESTART': '1', 04:40:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:55 INFO - 'PWD': '/builds/slave/test', 04:40:55 INFO - 'SHELL': '/bin/bash', 04:40:55 INFO - 'SHLVL': '1', 04:40:55 INFO - 'TERM': 'linux', 04:40:55 INFO - 'TMOUT': '86400', 04:40:55 INFO - 'USER': 'cltbld', 04:40:55 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471259115.130713-1805668120', 04:40:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:55 INFO - '_': '/tools/buildbot/bin/python'} 04:40:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:40:55 INFO - Cleaning up... 04:40:55 INFO - Return code: 0 04:40:55 INFO - Running post-action listener: _resource_record_post_action 04:40:55 INFO - Running post-action listener: _start_resource_monitoring 04:40:55 INFO - Starting resource monitoring. 04:40:55 INFO - [mozharness: 2016-08-15 11:40:55.621708Z] Finished create-virtualenv step (success) 04:40:55 INFO - [mozharness: 2016-08-15 11:40:55.622140Z] Running install step. 04:40:55 INFO - Running pre-action listener: _resource_record_pre_action 04:40:55 INFO - Running main action method: install 04:40:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:40:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:40:55 INFO - Reading from file tmpfile_stdout 04:40:55 INFO - Detecting whether we're running mozinstall >=1.0... 04:40:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:40:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:40:55 INFO - Reading from file tmpfile_stdout 04:40:55 INFO - Output received: 04:40:55 INFO - Usage: mozinstall [options] installer 04:40:55 INFO - Options: 04:40:55 INFO - -h, --help show this help message and exit 04:40:55 INFO - -d DEST, --destination=DEST 04:40:55 INFO - Directory to install application into. [default: 04:40:55 INFO - "/builds/slave/test"] 04:40:55 INFO - --app=APP Application being installed. [default: firefox] 04:40:55 INFO - mkdir: /builds/slave/test/build/application 04:40:55 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'] 04:40:55 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 04:41:12 INFO - Reading from file tmpfile_stdout 04:41:12 INFO - Output received: 04:41:12 INFO - /builds/slave/test/build/application/firefox/firefox 04:41:12 INFO - Running post-action listener: _resource_record_post_action 04:41:12 INFO - [mozharness: 2016-08-15 11:41:12.257577Z] Finished install step (success) 04:41:12 INFO - [mozharness: 2016-08-15 11:41:12.257851Z] Running run-tests step. 04:41:12 INFO - Running pre-action listener: _resource_record_pre_action 04:41:12 INFO - Running main action method: run_tests 04:41:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:41:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:41:12 INFO - Python 2.7.3 04:41:12 INFO - Return code: 0 04:41:12 INFO - grabbing minidump binary from tooltool 04:41:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:12 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 0x2bc6570>, '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 0x2bc7470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:41:12 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 04:41:12 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 04:41:12 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 04:41:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:41:12 INFO - Return code: 0 04:41:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:41:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:41:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:41:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:41:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:41:12 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/Flf0mpjSS3KHx9D2Avsy5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 04:41:12 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/Flf0mpjSS3KHx9D2Avsy5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 04:41:12 INFO - Using env: {'DISPLAY': ':0', 04:41:12 INFO - 'HOME': '/home/cltbld', 04:41:12 INFO - 'LANG': 'en_US.UTF-8', 04:41:12 INFO - 'LANGUAGE': 'en_US:en', 04:41:12 INFO - 'LOGNAME': 'cltbld', 04:41:12 INFO - 'MAIL': '/var/mail/cltbld', 04:41:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:41:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:41:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:12 INFO - 'MOZ_NO_REMOTE': '1', 04:41:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:41:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:12 INFO - 'NO_EM_RESTART': '1', 04:41:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:12 INFO - 'PWD': '/builds/slave/test', 04:41:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:41:12 INFO - 'SHELL': '/bin/bash', 04:41:12 INFO - 'SHLVL': '1', 04:41:12 INFO - 'TERM': 'linux', 04:41:12 INFO - 'TMOUT': '86400', 04:41:12 INFO - 'USER': 'cltbld', 04:41:12 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471259115.130713-1805668120', 04:41:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:12 INFO - '_': '/tools/buildbot/bin/python'} 04:41:12 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/Flf0mpjSS3KHx9D2Avsy5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 04:41:12 INFO - mozversion application_buildid: 20160815012516 04:41:12 INFO - mozversion application_changeset: 0463f6653d4830bb793fb43678161dc08b827389 04:41:12 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:41:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:41:12 INFO - mozversion application_name: Firefox 04:41:12 INFO - mozversion application_remotingname: firefox-dev 04:41:12 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:41:12 INFO - mozversion application_vendor: Mozilla 04:41:12 INFO - mozversion application_version: 50.0a2 04:41:12 INFO - mozversion platform_buildid: 20160815012516 04:41:12 INFO - mozversion platform_changeset: 0463f6653d4830bb793fb43678161dc08b827389 04:41:12 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:41:12 INFO - mozversion platform_version: 50.0a2 04:41:12 INFO - using testdate: 1471261272 04:41:12 INFO - actual date: 1471261272 04:41:12 INFO - starting webserver on 'localhost:33195' 04:41:12 INFO - SUITE-START | Running 2 tests 04:41:12 INFO - TEST-START | dromaeo_css 04:41:12 INFO - operating with platform_type : linux_ 04:41:12 INFO - Initialising browser for dromaeo_css test... 04:41:12 INFO - TEST-INFO | started process 11733 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp699bc8/profile http://localhost:33195/getInfo.html) 04:41:17 INFO - PROCESS | 11733 | __metrics Screen width/height:1600/1200 04:41:17 INFO - PROCESS | 11733 | colorDepth:24 04:41:17 INFO - PROCESS | 11733 | Browser inner width/height: 1024/697 04:41:17 INFO - PROCESS | 11733 | __metrics 04:41:17 ERROR - PROCESS | 11733 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 04:41:18 INFO - TEST-INFO | 11733: exit 0 04:41:18 INFO - Browser initialized. 04:41:18 INFO - Running cycle 1/1 for dromaeo_css test... 04:41:18 INFO - TEST-INFO | started process 11864 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp699bc8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:41:30 INFO - PROCESS | 11864 | RSS: Main: 152248320 04:41:30 INFO - PROCESS | 11864 | 04:42:20 INFO - PROCESS | 11864 | 1471261340062 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] 04:44:28 INFO - PROCESS | 11864 | Cycle 1(1): loaded http://localhost:33195/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33195/tests/dromaeo/cssquery-ext.html) 04:44:29 INFO - PROCESS | 11864 | RSS: Main: 157597696 04:44:29 INFO - PROCESS | 11864 | 04:47:31 INFO - PROCESS | 11864 | Cycle 1(1): loaded http://localhost:33195/tests/dromaeo/cssquery-ext.html (next: http://localhost:33195/tests/dromaeo/cssquery-jquery.html) 04:47:32 INFO - PROCESS | 11864 | RSS: Main: 153509888 04:47:32 INFO - PROCESS | 11864 | 04:50:34 INFO - PROCESS | 11864 | Cycle 1(1): loaded http://localhost:33195/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33195/tests/dromaeo/cssquery-mootools.html) 04:50:34 INFO - PROCESS | 11864 | RSS: Main: 154718208 04:50:34 INFO - PROCESS | 11864 | 04:53:36 INFO - PROCESS | 11864 | Cycle 1(1): loaded http://localhost:33195/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33195/tests/dromaeo/cssquery-prototype.html) 04:53:37 INFO - PROCESS | 11864 | RSS: Main: 153202688 04:53:37 INFO - PROCESS | 11864 | 04:56:39 INFO - PROCESS | 11864 | Cycle 1(1): loaded http://localhost:33195/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33195/tests/dromaeo/cssquery-yui.html) 04:56:40 INFO - PROCESS | 11864 | RSS: Main: 154759168 04:56:40 INFO - PROCESS | 11864 | 04:59:42 INFO - PROCESS | 11864 | Cycle 1(1): loaded http://localhost:33195/tests/dromaeo/cssquery-yui.html (next: http://localhost:33195/tests/dromaeo/cssquery-dojo.html) 04:59:42 INFO - PROCESS | 11864 | RSS: Main: 155258880 04:59:42 INFO - PROCESS | 11864 | 04:59:42 INFO - PROCESS | 11864 | __start_tp_report 04:59:42 INFO - PROCESS | 11864 | _x_x_mozilla_page_load 04:59:42 INFO - PROCESS | 11864 | _x_x_mozilla_page_load_details 04:59:42 INFO - PROCESS | 11864 | |i|pagename|runs| 04:59:42 INFO - PROCESS | 11864 | |0;dojo.html;3340.064781861079;3369.730421566275;3370.932581348373;3397.6092749333834;3398.320335932814;5802.216700745398;5853.063509838416;5898.970505147479;5905.881882362351;5926.466618004379;5784.3058832940105;5847.5614328925285;5867.530597552196;5870.148828419877;5886.058230683092;5276.551493123089;5342.252084708144;5346.331708536433;5354.9196762048605;5378.542823859977;5198.662086964354;5210.9218361724415;5235.607329450288;5256.684598924057;5350.250964864903;5228.215767634847;5270.789168433258;5285.445028272034;5293.04725149473;5348.839534813962;5323.414424413311;5332.173513105456;5352.2506849041165;5353.170258609883;5385.730713464351;5067.822626208065;5089.287499750038;5102.387713474407;5251.212318152269;5251.789928402859;5624.775008999635;5655.208270842086;5674.716264186774;5675.659460432346;5745.913811292834;6072.787452439187;6090.36051214625;6111.54163437744;6124.448799608057;6128.816135515942;5998.070299103602;6119.258838874104;6139.062858969381;6144.692765361759;6167.47133675191;5857.062869940789;5865.736041878125;5871.882562348729;5875.206847075633;5882.47057764799;6326.9683651581445;6360.618362898241;6363.61818290904;6367.586106903036;6391.2330520337855;5871.295444546597;6005.429484198994;6038.818835434944;6059.666718330446;6143.078538219213;6166.445019948226;6207.596506227081;6220.720067596969;6228.875422491525;6237.313895471494;6185.195924529872;6193.287771906288;6198.6280823150755;6210.068489726577;6213.347598502182;5978.55160862937;6099.146119543268;6118.3755344619085;6168.1056246843955;6187.535934804908;4719.716816990992;4743.905121897543;4761.9047619048115;4762.571368576845;4791.880202994883;4221.68337374692;4237.470316210473;4239.0674051708575;4239.491261048694;4247.66018718508;5762.855928601818;5905.40945905406;5913.349531551526;5979.910301345483;5992.250968628921;6204.100405441276;6272.09054687077;6272.686365681698;6275.905861412082;6295.3389894060465;6007.429294217042;6015.819525414245;6019.337872833985;6023.939760602426;6026.5178785697035;5161.690298582097;5241.056609810271;5287.154055351202;5384.40771515133;5387.164989426645;6313.084602732578;6368.395002474757;6377.075324077982;6396;6407.583507072025;6194.318624951342;6194.81415557534;6195.2255968004;6197.938020619827;6207.96896015517;6112.358202388685;6347.270063942706;6357.014662727284;6376.075469057054;6376.107344971801;6132.9062451666905;6139.377767117422;6141.240538582634;6141.385861414002;6143.911070236141;6256.843578910563;6291.748330066746;6298.496120310456;6299.6535190564955;6299.937000629935;5880.176775251382;6024.789132380346;6055.757769689163;6078.513718902565;6106.32830388648;6127.128444391353;6129.847850912788;6130.004390691762;6138.224991630204;6139.921477737097;5971.253593300838;5999.280086389661;6062.848428789315;6066.908996365147;6087.908681369694;5841.795537156179;6034.939650603438;6041.305249896318;6149.385061493815;6167.044108163242;5991.131285963598;5992.790252341147;6001.849953751192;6013.819585412444;6024.969875150597 04:59:42 INFO - PROCESS | 11864 | |1;ext.html;583.6789765628903;643.1670986073035;654.7217432591148;662.423691388492;710.7476845719773;41932.58067419325;46636.5336346636;46747.29879051813;46836;46868;47222.763886180524;47304;47689.523104768945;47925.76037119818;48070.278945815844;9092.181703646655;9219.769505762342;9224.769380765501;9245.907540924605;9258.305627077962;9208.907910920872;9223.631054757801;9230.123138301851;9306;9320.580573874191;9339.673111441101;9369.67206147785;9386.81226375472;9395.060493950585;9405.81188376232;9220.21628161607;9284.953575232148;9311.906880931172;9313.580888859984;9335.95332023339;9155.954220228923;9245.72262832116;9256.537173141316;9268.582913768829;9297.070292970717;36396.090097747765;36618.45072323917;36629.450558241646;36681.44977825335;36876.631233687585;3797.2025874566375;3871.8064096795047;3986.8405263789414;4033.5361433435237;4043.5754245804355;34151;34434.31131377383;34605;34631;34705.479417808754;4697.577218050357;4761.381020467317;4777.61779057678;4782.163121453732;4871.683340582887;380001;380202;380891;380965;383219.9999999972;56667.71666141643;57163.714181428826;57164.428355716744;57208.42791572031;57365.71317143471;38754;40081;40136;67118.66440667765;67435.66282168558;17956.1021948902;18202.54493637643;18372.448826535227;18375.54061148482;18448.169832357577;14001;14153.43386264538;14170.149791012573;14189.78715319271;14219.431222750974;20910.268140615004;21069.894650526956;21163.47091322729;21182.576348472943;21285.78714212838;7484.850302993909;7532.322091011835;7579.62101894903;7610.277023682741;7796.9220307796195;1025.3437799808128;1053.5733028123623;1059.3220338983058;1143.2111842828422;1228.238492134882;33558.49662255068;33774.662253377646;33926.66073339284;34361.31277374439;34365;1191.6961174900346;1200.117913333699;1206.6681662542871;1257.25821765159;1260.823484712141;17498.462722905108;17891.821081789276;17903.10484475797;17917;18122.72815907736;621728;623352;629911;629954;631533;63342.36657633457;63789.36210637927;63824.36175638184;63962.6801865997;64326;1440.1215258692189;1453.345994302568;1465.5383554180398;1488.2335597167466;1503.7218114648824;32384.514232287005;32717.836410817792;32964.67035329616;33453;33599.3280134391;55115.724421377636;55347;55444;55631.443685562626;55749.72125139349;468206;473136;474008;475937;476957;30605.540916886708;30815.69184308218;31353.686463135076;31386.843065785437;31507.21231969219;51512.742436287575;52071.73964130155;52090.47909521008;52386.73806631095;52489;44388.55611443844;44518.3322250173;44527;45768.77115614401;46560.301595476776;43766.23505877012;44951.32573011342;45195.548044519135;45940.081198376516;46152;37827.810860945516;44130.77934610307;45346;46235;46605.76697116493;37563.81218093892;37610;38287.80856095702;39513.60486395214;40412.393814092226;29200.56199157057;30325.848370758005;30349;30398;30887 04:59:42 INFO - PROCESS | 11864 | |2;jquery.html;406.4857954687319;421.5126115413247;436.54599216814506;437.5012485766227;437.85769624871915;19063.809361906377;20652.277170299007;20738.792612073874;21057.26299579515;21266.787332126674;20130.58484279518;20709.896450517725;20785.896070519626;20966.37100886972;21216.57566848666;5835.474807267356;6021.969890150565;6036.456718895299;6037.335893051761;6066.939330606704;5742.827715168531;5958.880822383571;5961.791337303195;5973.22348094747;6066.757329706807;5987.760489580412;6043.516518678495;6080.027195648697;6084.330723620398;6087.756489740427;6127.387261273881;6250.718717657694;6267.59260648061;6280.434760871521;6339.302676705559;5818.2145410369485;5966.134910437962;5996.580239383245;6014;6036.275646922398;14886.776698349533;15028.699426011419;15116.54650360491;15212.695746085126;15238.46665366718;2397.832151749378;2429.2347910408344;2452.5340185364726;2461.8399804012683;3146.8583913723937;10956.452177391098;10964.671059868217;11049.723756906062;11273.154513411528;11587.710307242301;1976.2292705844732;2033.2578608807678;2090.4878304815265;2108.3042595943302;2119.6502577074916;84921;85982.57008714978;86012;86284;87386.12613873843;11670.70823229426;11688.70778230551;11729.765404692029;11779.764404712028;11911.463984120735;16628.58428539272;16660.250288737036;16678.916605417136;16685.332586696397;16808.495745127664;8187.426880118334;8258.059356051323;8393.454425462325;8723.869141962876;8794.296456283482;7847.843043139105;7958.204179581995;8196.918030819616;8340.541270230075;8497.192766687278;4979.178435558092;5054.292399064134;5086.567641750493;5087.26234695967;5204.0372531081875;2098.800613941673;2126.6278401280024;2127.1810353013893;2147.119680930811;2156.5147841735484;938.3384713776908;999.4802702594756;1044.1385856668278;1058.528954615189;1094.669975979189;20312.289069882485;20603.278885238946;20784.584308313748;21008.369748907557;21143.365699029055;1000.8298589239702;1010.2019404670228;1049.6955882793904;1067.3542506783285;1120.171073405674;10677.252592318619;11550.249233799776;11659.766804664028;11690.298582084932;11764.529418823151;510386;515091;518814;520161;526405;92707;93024;94791;101724.49137754412;102581.48709256406;1052.8578641883248;1084.5336505302637;1104.1884215101893;1116.2576886370473;1117.379854180921;18218.908905455388;18600.720989185444;18939.526511836764;19125.31723986318;19315.227390904205;44050.77974610106;44741;45728;45979.850503737674;46166;57751.4224857746;60385.69807150936;60995;62835.371646282954;68166;8967.551622418723;9205.631774728936;9263.76840578964;9417.905820941703;9654.179394751525;14164.575062748134;14406.351714172677;14584.562463126123;14962.32669529852;15108.093514389171;12332.19840710351;12386.75226495483;12703.618891433272;12902.806457903327;13053.934730326288;7066.717331306896;11641.59254426091;12265.69335766613;12320.876791232331;12537.623871283877;12261.87738122643;12355.32045737493;12542.310172940575;12738.426770795151;12889.291088990196;9313;9414.105659962293;9419.905800941902;9425.104615061558;9543.856842147234;11589.478473468545;11894;12191.878081219074;12386.850405114028;12921.935390323364 04:59:42 INFO - PROCESS | 11864 | |3;mootools.html;1579.8973066750661;1627.1457484820469;1822.7994920558735;1887.3771655353735;1888.433469959012;8682.609282582283;9178.495182764946;9303.627854885814;9838.360506567069;9850.310478266525;9365.391249568773;9543.80912381752;9804.803903921917;9835.65575204868;9880.456574888378;2561.0780119157134;2599.83101098428;2613.202973093206;2628.88170032349;2629.8685065746636;2543.7074736405366;2620.4759048190344;2631.789456843448;2636.789056875455;2642.616820561027;2588.870556472178;2617.254082586463;2645.4444566641027;2648.4835457085874;2650.2181856352327;2501.8123640727017;2534.3917459809695;2578.9097381591555;2593.0664960614163;2593.23499567628;2478.1821998740375;2508.059477695864;2519.370157460635;2577.1753039027517;2578.355411147213;9776;9812.313138080337;9819;9825.606975720963;9871.60513579456;5706.4864162225185;5817.621854579439;5858.384869588717;5859.53123750099;5882.470577648032;3605.278944211142;3648.908777280563;3706.092007458163;3750.8687195948282;3823.388257878726;1161.117550661495;1216.4282787090053;1237.8638349781518;1244.7946088895321;1255.918365306252;14309.427622895071;14402.279886005657;14546.34541445648;14600.926995365062;14629.853701462956;5140.511651393112;5195.220716892421;5299.708516031578;5326.307580014573;5469.15228139639;12129.33288669114;12155;12156.270623762603;12163.331016794162;12168.148229623841;6062.9090563641585;6113.419225173601;6120.60216085953;6121.540884433685;6123.693815309306;4832.8791780205775;5262.342207224097;5391.676499410048;5418.431064738224;5463.344398672185;4451.643868490513;4557.703749256288;4572.862814115515;4619.514950930171;4646.581807637262;1424.1170474305998;1469.897107202507;1479.0829685595;1481.3185934470048;1489.508462207469;1032.6488993742164;1037.4657051618422;1052.5421441672743;1056.1761825775907;1069.5775168808277;6388.872222555523;6404.455621272244;6426.935730642727;6524.836879077966;6558.311377305409;496.1045313209691;497.2566013809378;507.9695218286915;514.0720998597493;522.589767032885;4270.701050926467;4283.764392958355;4291.871243862689;4294.463192100988;4314.072474418015;12233.632991010283;12585.748285034248;12712.110152289251;12719.491220351267;12729.745405091846;11833.290002599699;12391.876081239072;12504.312262825631;12543.93728031354;12580.182288151242;8666.653333866574;9016.549172541347;9027.593758280893;9030.774230644287;9040.819183616422;6385.712642931172;6586.37429444202;6646.268910419946;6665.266820649627;6831.385175334045;11245.212835101463;11570.421478926188;11587.42062896835;11682;11762.235454695418;11865.347405892759;11883.346415947206;11968.76062478728;12048.096392770753;12051.33717645538;8035.477693949874;8505;8765.474071555727;8830.293576513735;9026.45841249527;9911.405315681082;10003.599856005678;10036.598536058476;10056.094951454405;10060.69817905464;8631.611577478903;8843.806086178283;8887.422317549339;8948.373613846969;9027.36808423404;8283.37874659391;8529.530875801891;8540.060593334852;8709.782255443411;8873.778155545904;7746.264104910025;7865.292123708894;7872.881906771288;7880;7880.369570434466;5651.2935883014625;5687.488126068673;5736.827895163152;5820.94179058204;5855.9121613176685;5763;5777.480026797609;5784.4504772046585;5846.795362162304;5861.296644402699 04:59:42 INFO - PROCESS | 11864 | |4;prototype.html;350.7790092241887;354.4736066940593;355.3355225727888;360.1698085911972;363.34235034587414;5858.73635686394;5872.911906321408;5884.235049443577;5926.970365148179;5932.1991531143285;5657.462541058603;5715.828525144252;5748.626339287944;5801.767929282834;5838.241028666278;4500.212462819002;4538.319252112176;4539.54604539545;4559.954400455986;4561.703489273204;4532.391001194578;4551.317302404649;4558.430196225472;4570.908581828361;4579.862604121881;4298.677599180074;4398.626116780078;4544.204764166274;4549.909001819961;4560.8403705870305;4503.752293623849;4512.278035514302;4514.480834704018;4521.299198624219;4528.3886675298745;3992.3811809169624;4020.959790402117;4028.8115006072985;4030.4760381150554;4037.858674946392;5437.483439073281;5698.886022279573;5711.143328500758;5722.713864306768;5751.4536119068625;5144.151215049513;5187.924830067966;5196.402413722432;5205;5221.530062294411;6145.9692701536205;6160.213538073998;6160.476359509447;6175.5985860919345;6246.406591373812;4157.563455837154;4338.652907767371;4371.956280437187;4381.298992161271;4407.140607581523;6318.87362252757;6384.7126879290545;6396.744130234832;6408.166938298038;6420.646864422455;4491.8203271869415;4497.730136191839;4501.099780044005;4508.706934049276;4513.796879140446;4414.183376075436;4502.369668246448;4502.684812063124;4521.3896124023495;4530.77346132692;5168.715720635401;5197.792088316501;5198.726312053571;5200.869978250574;5230.843074707765;5903.852403689856;6187.679620142447;6192.566520343623;6217.316095229521;6248.9062664060075;1529.8087739032621;1557.6105973506624;1560.1263292555977;1561.234994852514;1563.8357972412732;948.6537413843897;972.6158167523788;988.2242439684813;991.3110388280076;997.3666721631816;5160.587153027749;5200.97399513;5203.349581302337;5222.895542089137;5238.947610523922;5487.9541854270465;5508.91736623951;5512.476314750093;5521.806736764194;5607.327120745536;5795.246617939725;5946.405359464019;5997.7001149942325;6007.699615019232;6012.939870601325;3298.070628682248;3337.5327454156436;3344.946341902293;3361.9663803361655;3389.57630296213;6290.8427289317215;6446.709898054599;6480.189976252968;6502.869942601122;6552.541322107407;6379.521535884827;6393.648349340738;6429.32492088324;6436.549441539048;6476.5466417350335;6366.9681651591445;6410.358964103552;6477.805665830033;6500.3174666659315;6515.804525864231;6260.780872669617;6267.843303917256;6288.72986047262;6309.832680954039;6336.112944187726;5930;6227.626342419469;6253.343398943228;6267.2479302484;6281.528885333527;6476.179054357952;6477.514186435942;6503.512236582181;6521.347865213441;6538;4427.734335939854;4460.3532487789735;4470.888227794331;4485.842995495142;4516.774161291856;6200.193974783249;6396.496823246441;6422.42198202164;6433.453156481752;6444.323346048597;6150.723217455135;6199.56603037783;6210.472109870711;6224.408681175281;6251.843703907439;6077.11881777131;6187.16473276102;6219.689015549114;6286.277078136073;6290.842728931813;6099.542534310033;6123.357047510125;6151.446369826737;6153.169322141453;6206.410391012847;6204.472619827366;6298.968505157628;6309.769594928945;6320.5575609706875;6334.746610135543;5788.797392091256;5834.124881267844;5988.970055149696;6061.333253342217;6081.27024757032 04:59:42 INFO - PROCESS | 11864 | |5;yui.html;843.5276245302628;857.1300130367678;875.5622188905547;878.7012415778638;929.2983797233088;15842;17184.140792960363;17224.483265502025;17231.741523877154;17254.56863578411;16039;16122.113283769388;16172.75740863888;16182.75725864113;16182.919085404557;847.563504795031;879.5909901895617;899.7975455522488;910.0762725833284;917.5962576466367;877.2850127146355;884.60192913189;884.884964954555;884.9336299777542;885.0308911741665;927.2906226736518;927.6521304510809;928.679605536089;929.6095639831287;930.0374112793261;918.17364372065;921.8893732752113;922.460360689001;922.9307801914849;925.9583318750672;673.7742856143198;675.1021141881336;675.4765057080753;676.9898451523231;678.2606958415302;16257.51227463178;16260.674786504322;16283.267252973645;16348.509544713677;16373.42693005739;14014.439422423091;14372.137671739729;14577.562673119717;14834.406623735038;14952.775708364383;13386.799198012037;13521.053526253167;13610;13761.289065037998;13867.791983120262;4013.3979903014783;4041.898952526181;4053.837846486137;4067.877963661095;4135.627793498599;88300.11699882984;88640;89779.55110224537;93557;93567.53216233876;12272.815907761391;12468.127231093918;12551.748965020648;12678.873211267954;12772;23124.190653327052;23156.18953336625;23200.18799342015;23215;23253;8967.686130985385;9174.082591740773;9396.389234699722;9469.47917864524;9588.952055239819;4853.514648535118;4868.099401610713;4907.779149938261;4950.8267210647455;5026.472220416877;3850.172212974168;3938.940915886264;3995.4805875236034;3995.6603688686205;4012.6990475713856;643.6073994863129;657.2769953051605;658.2857599504591;659.868026394723;691.5297597633557;608.9708392816127;654.2998991079594;664.3854434648028;687.4294335701455;690.1338819781142;9026.323025773094;9160.175584197454;9178.265738740885;9465.574049167804;9769.267304952156;705.0693085127582;719.4244604316526;733.6588486353871;742.6175519607407;782.2021538031177;4308.89227769302;4653.278741795028;4729.101470720552;4767.69010014348;4936.407631084293;132441;133493;136565.3171734135;139220;142931.2853435747;87858;103604.48197758963;108051;108180;110688;88497;93719;94121;95155;95824;9246.398984066014;9424.95287523558;9687.321887468092;9813.26400519978;9906.554205060645;51015.48984510256;51297.487025129274;52315.21527177019;52643.73678131585;53726.46273537371;72026;73210;81581;82244;84013;13337.866621333662;13517;13529;13986.090904091201;14061.648458788612;14775.704485910437;14931.92534037323;14989.175595342362;15127.243637817845;16213;12641.936790316358;12697.301648409057;13026.674333141747;13157.802632960706;13469.326533673473;12400.56598019065;12626.179298345578;12789.872101278868;13018.869811302146;13150.60548183556;12535.310557919038;12541.811872821732;12715.300658463873;13212.867871321163;13502.662433439242;10054;10237.48812559384;10513.158947284352;10650.786984260427;10802;10429;11132.88867111351;11133.393195650135;11255.268407553483;11414.315141091562 04:59:42 INFO - PROCESS | 11864 | __end_tp_report 04:59:42 INFO - PROCESS | 11864 | __start_cc_report 04:59:42 INFO - PROCESS | 11864 | _x_x_mozilla_cycle_collect,316 04:59:42 INFO - PROCESS | 11864 | __end_cc_report 04:59:42 INFO - PROCESS | 11864 | __startTimestamp1471262382856__endTimestamp 04:59:42 INFO - PROCESS | 11864 | 04:59:42 INFO - PROCESS | 11864 | ------- Summary: start ------- 04:59:42 INFO - PROCESS | 11864 | Number of tests: 6 04:59:42 INFO - PROCESS | 11864 | 04:59:42 INFO - PROCESS | 11864 | [#0] dojo.html Cycles:165 Average:5763.58 Median:6013.82 stddev:649.32 (10.8%) stddev-sans-first:622.85 04:59:42 INFO - PROCESS | 11864 | Values: 3340.1 3369.7 3370.9 3397.6 3398.3 5802.2 5853.1 5899.0 5905.9 5926.5 5784.3 5847.6 5867.5 5870.1 5886.1 5276.6 5342.3 5346.3 5354.9 5378.5 5198.7 5210.9 5235.6 5256.7 5350.3 5228.2 5270.8 5285.4 5293.0 5348.8 5323.4 5332.2 5352.3 5353.2 5385.7 5067.8 5089.3 5102.4 5251.2 5251.8 5624.8 5655.2 5674.7 5675.7 5745.9 6072.8 6090.4 6111.5 6124.4 6128.8 5998.1 6119.3 6139.1 6144.7 6167.5 5857.1 5865.7 5871.9 5875.2 5882.5 6327.0 6360.6 6363.6 6367.6 6391.2 5871.3 6005.4 6038.8 6059.7 6143.1 6166.4 6207.6 6220.7 6228.9 6237.3 6185.2 6193.3 6198.6 6210.1 6213.3 5978.6 6099.1 6118.4 6168.1 6187.5 4719.7 4743.9 4761.9 4762.6 4791.9 4221.7 4237.5 4239.1 4239.5 4247.7 5762.9 5905.4 5913.3 5979.9 5992.3 6204.1 6272.1 6272.7 6275.9 6295.3 6007.4 6015.8 6019.3 6023.9 6026.5 5161.7 5241.1 5287.2 5384.4 5387.2 6313.1 6368.4 6377.1 6396.0 6407.6 6194.3 6194.8 6195.2 6197.9 6208.0 6112.4 6347.3 6357.0 6376.1 6376.1 6132.9 6139.4 6141.2 6141.4 6143.9 6256.8 6291.7 6298.5 6299.7 6299.9 5880.2 6024.8 6055.8 6078.5 6106.3 6127.1 6129.8 6130.0 6138.2 6139.9 5971.3 5999.3 6062.8 6066.9 6087.9 5841.8 6034.9 6041.3 6149.4 6167.0 5991.1 5992.8 6001.8 6013.8 6025.0 04:59:42 INFO - PROCESS | 11864 | 04:59:42 INFO - PROCESS | 11864 | [#1] ext.html Cycles:180 Average:65717.71 Median:45073.44 stddev:134109.48 (297.5%) stddev-sans-first:134396.53 04:59:42 INFO - PROCESS | 11864 | Values: 583.7 643.2 654.7 662.4 710.7 41932.6 46636.5 46747.3 46836.0 46868.0 47222.8 47304.0 47689.5 47925.8 48070.3 9092.2 9219.8 9224.8 9245.9 9258.3 9208.9 9223.6 9230.1 9306.0 9320.6 9339.7 9369.7 9386.8 9395.1 9405.8 9220.2 9285.0 9311.9 9313.6 9336.0 9156.0 9245.7 9256.5 9268.6 9297.1 36396.1 36618.5 36629.5 36681.4 36876.6 3797.2 3871.8 3986.8 4033.5 4043.6 34151.0 34434.3 34605.0 34631.0 34705.5 4697.6 4761.4 4777.6 4782.2 4871.7 380001.0 380202.0 380891.0 380965.0 383220.0 56667.7 57163.7 57164.4 57208.4 57365.7 38754.0 40081.0 40136.0 67118.7 67435.7 17956.1 18202.5 18372.4 18375.5 18448.2 14001.0 14153.4 14170.1 14189.8 14219.4 20910.3 21069.9 21163.5 21182.6 21285.8 7484.9 7532.3 7579.6 7610.3 7796.9 1025.3 1053.6 1059.3 1143.2 1228.2 33558.5 33774.7 33926.7 34361.3 34365.0 1191.7 1200.1 1206.7 1257.3 1260.8 17498.5 17891.8 17903.1 17917.0 18122.7 621728.0 623352.0 629911.0 629954.0 631533.0 63342.4 63789.4 63824.4 63962.7 64326.0 1440.1 1453.3 1465.5 1488.2 1503.7 32384.5 32717.8 32964.7 33453.0 33599.3 55115.7 55347.0 55444.0 55631.4 55749.7 468206.0 473136.0 474008.0 475937.0 476957.0 30605.5 30815.7 31353.7 31386.8 31507.2 51512.7 52071.7 52090.5 52386.7 52489.0 44388.6 44518.3 44527.0 45768.8 46560.3 43766.2 44951.3 45195.5 45940.1 46152.0 37827.8 44130.8 45346.0 46235.0 46605.8 37563.8 37610.0 38287.8 39513.6 40412.4 29200.6 30325.8 30349.0 30398.0 30887.0 04:59:42 INFO - PROCESS | 11864 | 04:59:42 INFO - PROCESS | 11864 | [#2] jquery.html Cycles:180 Average:30555.58 Median:11696.98 stddev:85477.04 (730.8%) stddev-sans-first:85686.85 04:59:42 INFO - PROCESS | 11864 | Values: 406.5 421.5 436.5 437.5 437.9 19063.8 20652.3 20738.8 21057.3 21266.8 20130.6 20709.9 20785.9 20966.4 21216.6 5835.5 6022.0 6036.5 6037.3 6066.9 5742.8 5958.9 5961.8 5973.2 6066.8 5987.8 6043.5 6080.0 6084.3 6087.8 6127.4 6250.7 6267.6 6280.4 6339.3 5818.2 5966.1 5996.6 6014.0 6036.3 14886.8 15028.7 15116.5 15212.7 15238.5 2397.8 2429.2 2452.5 2461.8 3146.9 10956.5 10964.7 11049.7 11273.2 11587.7 1976.2 2033.3 2090.5 2108.3 2119.7 84921.0 85982.6 86012.0 86284.0 87386.1 11670.7 11688.7 11729.8 11779.8 11911.5 16628.6 16660.3 16678.9 16685.3 16808.5 8187.4 8258.1 8393.5 8723.9 8794.3 7847.8 7958.2 8196.9 8340.5 8497.2 4979.2 5054.3 5086.6 5087.3 5204.0 2098.8 2126.6 2127.2 2147.1 2156.5 938.3 999.5 1044.1 1058.5 1094.7 20312.3 20603.3 20784.6 21008.4 21143.4 1000.8 1010.2 1049.7 1067.4 1120.2 10677.3 11550.2 11659.8 11690.3 11764.5 510386.0 515091.0 518814.0 520161.0 526405.0 92707.0 93024.0 94791.0 101724.5 102581.5 1052.9 1084.5 1104.2 1116.3 1117.4 18218.9 18600.7 18939.5 19125.3 19315.2 44050.8 44741.0 45728.0 45979.9 46166.0 57751.4 60385.7 60995.0 62835.4 68166.0 8967.6 9205.6 9263.8 9417.9 9654.2 14164.6 14406.4 14584.6 14962.3 15108.1 12332.2 12386.8 12703.6 12902.8 13053.9 7066.7 11641.6 12265.7 12320.9 12537.6 12261.9 12355.3 12542.3 12738.4 12889.3 9313.0 9414.1 9419.9 9425.1 9543.9 11589.5 11894.0 12191.9 12386.9 12921.9 04:59:42 INFO - PROCESS | 11864 | 04:59:42 INFO - PROCESS | 11864 | [#3] mootools.html Cycles:180 Average:6544.23 Median:4565.28 stddev:3835.60 (84.0%) stddev-sans-first:3828.22 04:59:42 INFO - PROCESS | 11864 | Values: 1579.9 1627.1 1822.8 1887.4 1888.4 8682.6 9178.5 9303.6 9838.4 9850.3 9365.4 9543.8 9804.8 9835.7 9880.5 2561.1 2599.8 2613.2 2628.9 2629.9 2543.7 2620.5 2631.8 2636.8 2642.6 2588.9 2617.3 2645.4 2648.5 2650.2 2501.8 2534.4 2578.9 2593.1 2593.2 2478.2 2508.1 2519.4 2577.2 2578.4 9776.0 9812.3 9819.0 9825.6 9871.6 5706.5 5817.6 5858.4 5859.5 5882.5 3605.3 3648.9 3706.1 3750.9 3823.4 1161.1 1216.4 1237.9 1244.8 1255.9 14309.4 14402.3 14546.3 14600.9 14629.9 5140.5 5195.2 5299.7 5326.3 5469.2 12129.3 12155.0 12156.3 12163.3 12168.1 6062.9 6113.4 6120.6 6121.5 6123.7 4832.9 5262.3 5391.7 5418.4 5463.3 4451.6 4557.7 4572.9 4619.5 4646.6 1424.1 1469.9 1479.1 1481.3 1489.5 1032.6 1037.5 1052.5 1056.2 1069.6 6388.9 6404.5 6426.9 6524.8 6558.3 496.1 497.3 508.0 514.1 522.6 4270.7 4283.8 4291.9 4294.5 4314.1 12233.6 12585.7 12712.1 12719.5 12729.7 11833.3 12391.9 12504.3 12543.9 12580.2 8666.7 9016.5 9027.6 9030.8 9040.8 6385.7 6586.4 6646.3 6665.3 6831.4 11245.2 11570.4 11587.4 11682.0 11762.2 11865.3 11883.3 11968.8 12048.1 12051.3 8035.5 8505.0 8765.5 8830.3 9026.5 9911.4 10003.6 10036.6 10056.1 10060.7 8631.6 8843.8 8887.4 8948.4 9027.4 8283.4 8529.5 8540.1 8709.8 8873.8 7746.3 7865.3 7872.9 7880.0 7880.4 5651.3 5687.5 5736.8 5820.9 5855.9 5763.0 5777.5 5784.5 5846.8 5861.3 04:59:42 INFO - PROCESS | 11864 | 04:59:42 INFO - PROCESS | 11864 | [#4] prototype.html Cycles:180 Average:5132.12 Median:5817.95 stddev:1522.76 (26.2%) stddev-sans-first:1484.14 04:59:42 INFO - PROCESS | 11864 | Values: 350.8 354.5 355.3 360.2 363.3 5858.7 5872.9 5884.2 5927.0 5932.2 5657.5 5715.8 5748.6 5801.8 5838.2 4500.2 4538.3 4539.5 4560.0 4561.7 4532.4 4551.3 4558.4 4570.9 4579.9 4298.7 4398.6 4544.2 4549.9 4560.8 4503.8 4512.3 4514.5 4521.3 4528.4 3992.4 4021.0 4028.8 4030.5 4037.9 5437.5 5698.9 5711.1 5722.7 5751.5 5144.2 5187.9 5196.4 5205.0 5221.5 6146.0 6160.2 6160.5 6175.6 6246.4 4157.6 4338.7 4372.0 4381.3 4407.1 6318.9 6384.7 6396.7 6408.2 6420.6 4491.8 4497.7 4501.1 4508.7 4513.8 4414.2 4502.4 4502.7 4521.4 4530.8 5168.7 5197.8 5198.7 5200.9 5230.8 5903.9 6187.7 6192.6 6217.3 6248.9 1529.8 1557.6 1560.1 1561.2 1563.8 948.7 972.6 988.2 991.3 997.4 5160.6 5201.0 5203.3 5222.9 5238.9 5488.0 5508.9 5512.5 5521.8 5607.3 5795.2 5946.4 5997.7 6007.7 6012.9 3298.1 3337.5 3344.9 3362.0 3389.6 6290.8 6446.7 6480.2 6502.9 6552.5 6379.5 6393.6 6429.3 6436.5 6476.5 6367.0 6410.4 6477.8 6500.3 6515.8 6260.8 6267.8 6288.7 6309.8 6336.1 5930.0 6227.6 6253.3 6267.2 6281.5 6476.2 6477.5 6503.5 6521.3 6538.0 4427.7 4460.4 4470.9 4485.8 4516.8 6200.2 6396.5 6422.4 6433.5 6444.3 6150.7 6199.6 6210.5 6224.4 6251.8 6077.1 6187.2 6219.7 6286.3 6290.8 6099.5 6123.4 6151.4 6153.2 6206.4 6204.5 6299.0 6309.8 6320.6 6334.7 5788.8 5834.1 5989.0 6061.3 6081.3 04:59:42 INFO - PROCESS | 11864 | 04:59:42 INFO - PROCESS | 11864 | [#5] yui.html Cycles:180 Average:22533.13 Median:4691.19 stddev:33687.47 (718.1%) stddev-sans-first:33742.61 04:59:42 INFO - PROCESS | 11864 | Values: 843.5 857.1 875.6 878.7 929.3 15842.0 17184.1 17224.5 17231.7 17254.6 16039.0 16122.1 16172.8 16182.8 16182.9 847.6 879.6 899.8 910.1 917.6 877.3 884.6 884.9 884.9 885.0 927.3 927.7 928.7 929.6 930.0 918.2 921.9 922.5 922.9 926.0 673.8 675.1 675.5 677.0 678.3 16257.5 16260.7 16283.3 16348.5 16373.4 14014.4 14372.1 14577.6 14834.4 14952.8 13386.8 13521.1 13610.0 13761.3 13867.8 4013.4 4041.9 4053.8 4067.9 4135.6 88300.1 88640.0 89779.6 93557.0 93567.5 12272.8 12468.1 12551.7 12678.9 12772.0 23124.2 23156.2 23200.2 23215.0 23253.0 8967.7 9174.1 9396.4 9469.5 9589.0 4853.5 4868.1 4907.8 4950.8 5026.5 3850.2 3938.9 3995.5 3995.7 4012.7 643.6 657.3 658.3 659.9 691.5 609.0 654.3 664.4 687.4 690.1 9026.3 9160.2 9178.3 9465.6 9769.3 705.1 719.4 733.7 742.6 782.2 4308.9 4653.3 4729.1 4767.7 4936.4 132441.0 133493.0 136565.3 139220.0 142931.3 87858.0 103604.5 108051.0 108180.0 110688.0 88497.0 93719.0 94121.0 95155.0 95824.0 9246.4 9425.0 9687.3 9813.3 9906.6 51015.5 51297.5 52315.2 52643.7 53726.5 72026.0 73210.0 81581.0 82244.0 84013.0 13337.9 13517.0 13529.0 13986.1 14061.6 14775.7 14931.9 14989.2 15127.2 16213.0 12641.9 12697.3 13026.7 13157.8 13469.3 12400.6 12626.2 12789.9 13018.9 13150.6 12535.3 12541.8 12715.3 13212.9 13502.7 10054.0 10237.5 10513.2 10650.8 10802.0 10429.0 11132.9 11133.4 11255.3 11414.3 04:59:42 INFO - PROCESS | 11864 | -------- Summary: end -------- 04:59:42 INFO - PROCESS | 11864 | 04:59:43 INFO - TEST-INFO | 11864: exit 0 04:59:43 INFO - TEST-OK | dromaeo_css | took 1110983ms 04:59:43 INFO - TEST-START | kraken 04:59:43 INFO - operating with platform_type : linux_ 04:59:43 INFO - Initialising browser for kraken test... 04:59:43 INFO - TEST-INFO | started process 12135 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSKxWwy/profile http://localhost:33195/getInfo.html) 04:59:47 INFO - PROCESS | 12135 | __metrics Screen width/height:1600/1200 04:59:47 INFO - PROCESS | 12135 | colorDepth:24 04:59:47 INFO - PROCESS | 12135 | Browser inner width/height: 1024/697 04:59:47 INFO - PROCESS | 12135 | __metrics 04:59:48 ERROR - PROCESS | 12135 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 04:59:49 INFO - TEST-INFO | 12135: exit 0 04:59:49 INFO - Browser initialized. 04:59:49 INFO - Running cycle 1/1 for kraken test... 04:59:49 INFO - TEST-INFO | started process 12261 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSKxWwy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:00:01 INFO - PROCESS | 12261 | RSS: Main: 152780800 05:00:01 INFO - PROCESS | 12261 | 05:00:03 INFO - PROCESS | 12261 | Cycle 1(1): loaded http://localhost:33195/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33195/tests/kraken/driver.html?testName=audio-beat-detection) 05:00:04 INFO - PROCESS | 12261 | RSS: Main: 158007296 05:00:04 INFO - PROCESS | 12261 | 05:00:07 INFO - PROCESS | 12261 | Cycle 1(1): loaded http://localhost:33195/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33195/tests/kraken/driver.html?testName=audio-dft) 05:00:07 INFO - PROCESS | 12261 | RSS: Main: 156241920 05:00:07 INFO - PROCESS | 12261 | 05:00:10 INFO - PROCESS | 12261 | Cycle 1(1): loaded http://localhost:33195/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33195/tests/kraken/driver.html?testName=audio-fft) 05:00:11 INFO - PROCESS | 12261 | RSS: Main: 157093888 05:00:11 INFO - PROCESS | 12261 | 05:00:13 INFO - PROCESS | 12261 | Cycle 1(1): loaded http://localhost:33195/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33195/tests/kraken/driver.html?testName=audio-oscillator) 05:00:13 INFO - PROCESS | 12261 | RSS: Main: 156614656 05:00:13 INFO - PROCESS | 12261 | 05:00:15 INFO - PROCESS | 12261 | Cycle 1(1): loaded http://localhost:33195/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33195/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:00:16 INFO - PROCESS | 12261 | RSS: Main: 156569600 05:00:16 INFO - PROCESS | 12261 | 05:00:19 INFO - PROCESS | 12261 | Cycle 1(1): loaded http://localhost:33195/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33195/tests/kraken/driver.html?testName=imaging-darkroom) 05:00:20 INFO - PROCESS | 12261 | RSS: Main: 155750400 05:00:20 INFO - PROCESS | 12261 | 05:00:23 INFO - PROCESS | 12261 | Cycle 1(1): loaded http://localhost:33195/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33195/tests/kraken/driver.html?testName=imaging-desaturate) 05:00:24 INFO - PROCESS | 12261 | RSS: Main: 156794880 05:00:24 INFO - PROCESS | 12261 | 05:00:27 INFO - PROCESS | 12261 | Cycle 1(1): loaded http://localhost:33195/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33195/tests/kraken/driver.html?testName=json-parse-financial) 05:00:27 INFO - PROCESS | 12261 | RSS: Main: 157646848 05:00:27 INFO - PROCESS | 12261 | 05:00:29 INFO - PROCESS | 12261 | Cycle 1(1): loaded http://localhost:33195/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33195/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:00:29 INFO - PROCESS | 12261 | RSS: Main: 156938240 05:00:29 INFO - PROCESS | 12261 | 05:00:31 INFO - PROCESS | 12261 | Cycle 1(1): loaded http://localhost:33195/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33195/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:00:32 INFO - PROCESS | 12261 | RSS: Main: 157118464 05:00:32 INFO - PROCESS | 12261 | 05:00:34 INFO - PROCESS | 12261 | Cycle 1(1): loaded http://localhost:33195/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33195/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:00:34 INFO - PROCESS | 12261 | RSS: Main: 157298688 05:00:34 INFO - PROCESS | 12261 | 05:00:37 INFO - PROCESS | 12261 | Cycle 1(1): loaded http://localhost:33195/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33195/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:00:38 INFO - PROCESS | 12261 | RSS: Main: 157528064 05:00:38 INFO - PROCESS | 12261 | 05:00:40 INFO - PROCESS | 12261 | Cycle 1(1): loaded http://localhost:33195/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33195/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:00:41 INFO - PROCESS | 12261 | RSS: Main: 158015488 05:00:41 INFO - PROCESS | 12261 | 05:00:43 INFO - PROCESS | 12261 | Cycle 1(1): loaded http://localhost:33195/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33195/tests/kraken/driver.html?testName=ai-astar) 05:00:43 INFO - PROCESS | 12261 | RSS: Main: 158789632 05:00:43 INFO - PROCESS | 12261 | 05:00:43 INFO - PROCESS | 12261 | __start_tp_report 05:00:43 INFO - PROCESS | 12261 | _x_x_mozilla_page_load 05:00:43 INFO - PROCESS | 12261 | _x_x_mozilla_page_load_details 05:00:43 INFO - PROCESS | 12261 | |i|pagename|runs| 05:00:43 INFO - PROCESS | 12261 | |0;ai-astar;100;111;105;111;110;115;110;110;111;110 05:00:43 INFO - PROCESS | 12261 | |1;audio-beat-detection;142;116;148;179;118;145;145;122;176;122 05:00:43 INFO - PROCESS | 12261 | |2;audio-dft;163;162;162;161;162;166;160;160;166;161 05:00:43 INFO - PROCESS | 12261 | |3;audio-fft;76;74;76;170;77;76;76;75;163;74 05:00:43 INFO - PROCESS | 12261 | |4;audio-oscillator;84;82;148;82;83;84;139;85;84;153 05:00:43 INFO - PROCESS | 12261 | |5;imaging-gaussian-blur;117;118;117;117;118;117;120;117;117;117 05:00:43 INFO - PROCESS | 12261 | |6;imaging-darkroom;146;147;146;147;148;148;148;148;146;147 05:00:43 INFO - PROCESS | 12261 | |7;imaging-desaturate;95;95;96;96;95;95;96;95;95;95 05:00:43 INFO - PROCESS | 12261 | |8;json-parse-financial;50;50;52;51;51;53;50;51;51;54 05:00:43 INFO - PROCESS | 12261 | |9;json-stringify-tinderbox;60;60;59;60;59;58;59;59;59;59 05:00:43 INFO - PROCESS | 12261 | |10;stanford-crypto-aes;73;73;82;73;73;81;73;79;73;75 05:00:43 INFO - PROCESS | 12261 | |11;stanford-crypto-ccm;120;118;124;120;124;119;116;116;167;128 05:00:43 INFO - PROCESS | 12261 | |12;stanford-crypto-pbkdf2;153;151;151;152;153;150;149;150;149;150 05:00:43 INFO - PROCESS | 12261 | |13;stanford-crypto-sha256-iterative;61;63;64;60;63;61;60;62;60;59 05:00:43 INFO - PROCESS | 12261 | __end_tp_report 05:00:43 INFO - PROCESS | 12261 | __start_cc_report 05:00:43 INFO - PROCESS | 12261 | _x_x_mozilla_cycle_collect,842 05:00:43 INFO - PROCESS | 12261 | __end_cc_report 05:00:43 INFO - PROCESS | 12261 | __startTimestamp1471262443259__endTimestamp 05:00:43 INFO - PROCESS | 12261 | 05:00:43 INFO - PROCESS | 12261 | ------- Summary: start ------- 05:00:43 INFO - PROCESS | 12261 | Number of tests: 14 05:00:43 INFO - PROCESS | 12261 | 05:00:43 INFO - PROCESS | 12261 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.50 stddev:4.06 (3.7%) stddev-sans-first:2.55 05:00:43 INFO - PROCESS | 12261 | Values: 100.0 111.0 105.0 111.0 110.0 115.0 110.0 110.0 111.0 110.0 05:00:43 INFO - PROCESS | 12261 | 05:00:43 INFO - PROCESS | 12261 | [#1] audio-beat-detection Cycles:10 Average:141.30 Median:145.00 stddev:22.67 (15.6%) stddev-sans-first:24.05 05:00:43 INFO - PROCESS | 12261 | Values: 142.0 116.0 148.0 179.0 118.0 145.0 145.0 122.0 176.0 122.0 05:00:43 INFO - PROCESS | 12261 | 05:00:43 INFO - PROCESS | 12261 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.00 stddev:2.16 (1.3%) stddev-sans-first:2.28 05:00:43 INFO - PROCESS | 12261 | Values: 163.0 162.0 162.0 161.0 162.0 166.0 160.0 160.0 166.0 161.0 05:00:43 INFO - PROCESS | 12261 | 05:00:43 INFO - PROCESS | 12261 | [#3] audio-fft Cycles:10 Average:93.70 Median:76.00 stddev:38.42 (50.5%) stddev-sans-first:40.21 05:00:43 INFO - PROCESS | 12261 | Values: 76.0 74.0 76.0 170.0 77.0 76.0 76.0 75.0 163.0 74.0 05:00:43 INFO - PROCESS | 12261 | 05:00:43 INFO - PROCESS | 12261 | [#4] audio-oscillator Cycles:10 Average:102.40 Median:83.50 stddev:30.74 (36.8%) stddev-sans-first:31.88 05:00:43 INFO - PROCESS | 12261 | Values: 84.0 82.0 148.0 82.0 83.0 84.0 139.0 85.0 84.0 153.0 05:00:43 INFO - PROCESS | 12261 | 05:00:43 INFO - PROCESS | 12261 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.00 stddev:0.97 (0.8%) stddev-sans-first:1.01 05:00:43 INFO - PROCESS | 12261 | Values: 117.0 118.0 117.0 117.0 118.0 117.0 120.0 117.0 117.0 117.0 05:00:43 INFO - PROCESS | 12261 | 05:00:43 INFO - PROCESS | 12261 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.50 stddev:0.88 (0.6%) stddev-sans-first:0.83 05:00:43 INFO - PROCESS | 12261 | Values: 146.0 147.0 146.0 147.0 148.0 148.0 148.0 148.0 146.0 147.0 05:00:43 INFO - PROCESS | 12261 | 05:00:43 INFO - PROCESS | 12261 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 05:00:43 INFO - PROCESS | 12261 | Values: 95.0 95.0 96.0 96.0 95.0 95.0 96.0 95.0 95.0 95.0 05:00:43 INFO - PROCESS | 12261 | 05:00:43 INFO - PROCESS | 12261 | [#8] json-parse-financial Cycles:10 Average:51.30 Median:51.00 stddev:1.34 (2.6%) stddev-sans-first:1.33 05:00:43 INFO - PROCESS | 12261 | Values: 50.0 50.0 52.0 51.0 51.0 53.0 50.0 51.0 51.0 54.0 05:00:43 INFO - PROCESS | 12261 | 05:00:43 INFO - PROCESS | 12261 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:59.00 stddev:0.63 (1.1%) stddev-sans-first:0.60 05:00:43 INFO - PROCESS | 12261 | Values: 60.0 60.0 59.0 60.0 59.0 58.0 59.0 59.0 59.0 59.0 05:00:43 INFO - PROCESS | 12261 | 05:00:43 INFO - PROCESS | 12261 | [#10] stanford-crypto-aes Cycles:10 Average:75.50 Median:74.00 stddev:3.69 (5.0%) stddev-sans-first:3.80 05:00:43 INFO - PROCESS | 12261 | Values: 73.0 73.0 82.0 73.0 73.0 81.0 73.0 79.0 73.0 75.0 05:00:43 INFO - PROCESS | 12261 | 05:00:43 INFO - PROCESS | 12261 | [#11] stanford-crypto-ccm Cycles:10 Average:125.20 Median:122.00 stddev:15.17 (12.4%) stddev-sans-first:15.97 05:00:43 INFO - PROCESS | 12261 | Values: 120.0 118.0 124.0 120.0 124.0 119.0 116.0 116.0 167.0 128.0 05:00:43 INFO - PROCESS | 12261 | 05:00:43 INFO - PROCESS | 12261 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.80 Median:151.00 stddev:1.48 (1.0%) stddev-sans-first:1.33 05:00:43 INFO - PROCESS | 12261 | Values: 153.0 151.0 151.0 152.0 153.0 150.0 149.0 150.0 149.0 150.0 05:00:43 INFO - PROCESS | 12261 | 05:00:43 INFO - PROCESS | 12261 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.30 Median:61.50 stddev:1.64 (2.7%) stddev-sans-first:1.73 05:00:43 INFO - PROCESS | 12261 | Values: 61.0 63.0 64.0 60.0 63.0 61.0 60.0 62.0 60.0 59.0 05:00:43 INFO - PROCESS | 12261 | -------- Summary: end -------- 05:00:43 INFO - PROCESS | 12261 | 05:00:44 INFO - TEST-INFO | 12261: exit 0 05:00:44 INFO - TEST-OK | kraken | took 60647ms 05:00:44 INFO - SUITE-END | took 1171s 05:00:44 INFO - Completed test suite (00:19:31) 05:00:44 INFO - javascript benchmark 05:00:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7793.611111047689, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3340.064781861079, 3369.730421566275, 3370.932581348373, 3397.6092749333834, 3398.320335932814, 5802.216700745398, 5853.063509838416, 5898.970505147479, 5905.881882362351, 5926.466618004379, 5784.3058832940105, 5847.5614328925285, 5867.530597552196, 5870.148828419877, 5886.058230683092, 5276.551493123089, 5342.252084708144, 5346.331708536433, 5354.9196762048605, 5378.542823859977, 5198.662086964354, 5210.9218361724415, 5235.607329450288, 5256.684598924057, 5350.250964864903, 5228.215767634847, 5270.789168433258, 5285.445028272034, 5293.04725149473, 5348.839534813962, 5323.414424413311, 5332.173513105456, 5352.2506849041165, 5353.170258609883, 5385.730713464351, 5067.822626208065, 5089.287499750038, 5102.387713474407, 5251.212318152269, 5251.789928402859, 5624.775008999635, 5655.208270842086, 5674.716264186774, 5675.659460432346, 5745.913811292834, 6072.787452439187, 6090.36051214625, 6111.54163437744, 6124.448799608057, 6128.816135515942, 5998.070299103602, 6119.258838874104, 6139.062858969381, 6144.692765361759, 6167.47133675191, 5857.062869940789, 5865.736041878125, 5871.882562348729, 5875.206847075633, 5882.47057764799, 6326.9683651581445, 6360.618362898241, 6363.61818290904, 6367.586106903036, 6391.2330520337855, 5871.295444546597, 6005.429484198994, 6038.818835434944, 6059.666718330446, 6143.078538219213, 6166.445019948226, 6207.596506227081, 6220.720067596969, 6228.875422491525, 6237.313895471494, 6185.195924529872, 6193.287771906288, 6198.6280823150755, 6210.068489726577, 6213.347598502182, 5978.55160862937, 6099.146119543268, 6118.3755344619085, 6168.1056246843955, 6187.535934804908, 4719.716816990992, 4743.905121897543, 4761.9047619048115, 4762.571368576845, 4791.880202994883, 4221.68337374692, 4237.470316210473, 4239.0674051708575, 4239.491261048694, 4247.66018718508, 5762.855928601818, 5905.40945905406, 5913.349531551526, 5979.910301345483, 5992.250968628921, 6204.100405441276, 6272.09054687077, 6272.686365681698, 6275.905861412082, 6295.3389894060465, 6007.429294217042, 6015.819525414245, 6019.337872833985, 6023.939760602426, 6026.5178785697035, 5161.690298582097, 5241.056609810271, 5287.154055351202, 5384.40771515133, 5387.164989426645, 6313.084602732578, 6368.395002474757, 6377.075324077982, 6396.0, 6407.583507072025, 6194.318624951342, 6194.81415557534, 6195.2255968004, 6197.938020619827, 6207.96896015517, 6112.358202388685, 6347.270063942706, 6357.014662727284, 6376.075469057054, 6376.107344971801, 6132.9062451666905, 6139.377767117422, 6141.240538582634, 6141.385861414002, 6143.911070236141, 6256.843578910563, 6291.748330066746, 6298.496120310456, 6299.6535190564955, 6299.937000629935, 5880.176775251382, 6024.789132380346, 6055.757769689163, 6078.513718902565, 6106.32830388648, 6127.128444391353, 6129.847850912788, 6130.004390691762, 6138.224991630204, 6139.921477737097, 5971.253593300838, 5999.280086389661, 6062.848428789315, 6066.908996365147, 6087.908681369694, 5841.795537156179, 6034.939650603438, 6041.305249896318, 6149.385061493815, 6167.044108163242, 5991.131285963598, 5992.790252341147, 6001.849953751192, 6013.819585412444, 6024.969875150597], "value": 5720.0105735875095, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.6789765628903, 643.1670986073035, 654.7217432591148, 662.423691388492, 710.7476845719773, 41932.58067419325, 46636.5336346636, 46747.29879051813, 46836.0, 46868.0, 47222.763886180524, 47304.0, 47689.523104768945, 47925.76037119818, 48070.278945815844, 9092.181703646655, 9219.769505762342, 9224.769380765501, 9245.907540924605, 9258.305627077962, 9208.907910920872, 9223.631054757801, 9230.123138301851, 9306.0, 9320.580573874191, 9339.673111441101, 9369.67206147785, 9386.81226375472, 9395.060493950585, 9405.81188376232, 9220.21628161607, 9284.953575232148, 9311.906880931172, 9313.580888859984, 9335.95332023339, 9155.954220228923, 9245.72262832116, 9256.537173141316, 9268.582913768829, 9297.070292970717, 36396.090097747765, 36618.45072323917, 36629.450558241646, 36681.44977825335, 36876.631233687585, 3797.2025874566375, 3871.8064096795047, 3986.8405263789414, 4033.5361433435237, 4043.5754245804355, 34151.0, 34434.31131377383, 34605.0, 34631.0, 34705.479417808754, 4697.577218050357, 4761.381020467317, 4777.61779057678, 4782.163121453732, 4871.683340582887, 380001.0, 380202.0, 380891.0, 380965.0, 383219.9999999972, 56667.71666141643, 57163.714181428826, 57164.428355716744, 57208.42791572031, 57365.71317143471, 38754.0, 40081.0, 40136.0, 67118.66440667765, 67435.66282168558, 17956.1021948902, 18202.54493637643, 18372.448826535227, 18375.54061148482, 18448.169832357577, 14001.0, 14153.43386264538, 14170.149791012573, 14189.78715319271, 14219.431222750974, 20910.268140615004, 21069.894650526956, 21163.47091322729, 21182.576348472943, 21285.78714212838, 7484.850302993909, 7532.322091011835, 7579.62101894903, 7610.277023682741, 7796.9220307796195, 1025.3437799808128, 1053.5733028123623, 1059.3220338983058, 1143.2111842828422, 1228.238492134882, 33558.49662255068, 33774.662253377646, 33926.66073339284, 34361.31277374439, 34365.0, 1191.6961174900346, 1200.117913333699, 1206.6681662542871, 1257.25821765159, 1260.823484712141, 17498.462722905108, 17891.821081789276, 17903.10484475797, 17917.0, 18122.72815907736, 621728.0, 623352.0, 629911.0, 629954.0, 631533.0, 63342.36657633457, 63789.36210637927, 63824.36175638184, 63962.6801865997, 64326.0, 1440.1215258692189, 1453.345994302568, 1465.5383554180398, 1488.2335597167466, 1503.7218114648824, 32384.514232287005, 32717.836410817792, 32964.67035329616, 33453.0, 33599.3280134391, 55115.724421377636, 55347.0, 55444.0, 55631.443685562626, 55749.72125139349, 468206.0, 473136.0, 474008.0, 475937.0, 476957.0, 30605.540916886708, 30815.69184308218, 31353.686463135076, 31386.843065785437, 31507.21231969219, 51512.742436287575, 52071.73964130155, 52090.47909521008, 52386.73806631095, 52489.0, 44388.55611443844, 44518.3322250173, 44527.0, 45768.77115614401, 46560.301595476776, 43766.23505877012, 44951.32573011342, 45195.548044519135, 45940.081198376516, 46152.0, 37827.810860945516, 44130.77934610307, 45346.0, 46235.0, 46605.76697116493, 37563.81218093892, 37610.0, 38287.80856095702, 39513.60486395214, 40412.393814092226, 29200.56199157057, 30325.848370758005, 30349.0, 30398.0, 30887.0], "value": 21382.80177338537, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.4857954687319, 421.5126115413247, 436.54599216814506, 437.5012485766227, 437.85769624871915, 19063.809361906377, 20652.277170299007, 20738.792612073874, 21057.26299579515, 21266.787332126674, 20130.58484279518, 20709.896450517725, 20785.896070519626, 20966.37100886972, 21216.57566848666, 5835.474807267356, 6021.969890150565, 6036.456718895299, 6037.335893051761, 6066.939330606704, 5742.827715168531, 5958.880822383571, 5961.791337303195, 5973.22348094747, 6066.757329706807, 5987.760489580412, 6043.516518678495, 6080.027195648697, 6084.330723620398, 6087.756489740427, 6127.387261273881, 6250.718717657694, 6267.59260648061, 6280.434760871521, 6339.302676705559, 5818.2145410369485, 5966.134910437962, 5996.580239383245, 6014.0, 6036.275646922398, 14886.776698349533, 15028.699426011419, 15116.54650360491, 15212.695746085126, 15238.46665366718, 2397.832151749378, 2429.2347910408344, 2452.5340185364726, 2461.8399804012683, 3146.8583913723937, 10956.452177391098, 10964.671059868217, 11049.723756906062, 11273.154513411528, 11587.710307242301, 1976.2292705844732, 2033.2578608807678, 2090.4878304815265, 2108.3042595943302, 2119.6502577074916, 84921.0, 85982.57008714978, 86012.0, 86284.0, 87386.12613873843, 11670.70823229426, 11688.70778230551, 11729.765404692029, 11779.764404712028, 11911.463984120735, 16628.58428539272, 16660.250288737036, 16678.916605417136, 16685.332586696397, 16808.495745127664, 8187.426880118334, 8258.059356051323, 8393.454425462325, 8723.869141962876, 8794.296456283482, 7847.843043139105, 7958.204179581995, 8196.918030819616, 8340.541270230075, 8497.192766687278, 4979.178435558092, 5054.292399064134, 5086.567641750493, 5087.26234695967, 5204.0372531081875, 2098.800613941673, 2126.6278401280024, 2127.1810353013893, 2147.119680930811, 2156.5147841735484, 938.3384713776908, 999.4802702594756, 1044.1385856668278, 1058.528954615189, 1094.669975979189, 20312.289069882485, 20603.278885238946, 20784.584308313748, 21008.369748907557, 21143.365699029055, 1000.8298589239702, 1010.2019404670228, 1049.6955882793904, 1067.3542506783285, 1120.171073405674, 10677.252592318619, 11550.249233799776, 11659.766804664028, 11690.298582084932, 11764.529418823151, 510386.0, 515091.0, 518814.0, 520161.0, 526405.0, 92707.0, 93024.0, 94791.0, 101724.49137754412, 102581.48709256406, 1052.8578641883248, 1084.5336505302637, 1104.1884215101893, 1116.2576886370473, 1117.379854180921, 18218.908905455388, 18600.720989185444, 18939.526511836764, 19125.31723986318, 19315.227390904205, 44050.77974610106, 44741.0, 45728.0, 45979.850503737674, 46166.0, 57751.4224857746, 60385.69807150936, 60995.0, 62835.371646282954, 68166.0, 8967.551622418723, 9205.631774728936, 9263.76840578964, 9417.905820941703, 9654.179394751525, 14164.575062748134, 14406.351714172677, 14584.562463126123, 14962.32669529852, 15108.093514389171, 12332.19840710351, 12386.75226495483, 12703.618891433272, 12902.806457903327, 13053.934730326288, 7066.717331306896, 11641.59254426091, 12265.69335766613, 12320.876791232331, 12537.623871283877, 12261.87738122643, 12355.32045737493, 12542.310172940575, 12738.426770795151, 12889.291088990196, 9313.0, 9414.105659962293, 9419.905800941902, 9425.104615061558, 9543.856842147234, 11589.478473468545, 11894.0, 12191.878081219074, 12386.850405114028, 12921.935390323364], "value": 9712.742639985518, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1579.8973066750661, 1627.1457484820469, 1822.7994920558735, 1887.3771655353735, 1888.433469959012, 8682.609282582283, 9178.495182764946, 9303.627854885814, 9838.360506567069, 9850.310478266525, 9365.391249568773, 9543.80912381752, 9804.803903921917, 9835.65575204868, 9880.456574888378, 2561.0780119157134, 2599.83101098428, 2613.202973093206, 2628.88170032349, 2629.8685065746636, 2543.7074736405366, 2620.4759048190344, 2631.789456843448, 2636.789056875455, 2642.616820561027, 2588.870556472178, 2617.254082586463, 2645.4444566641027, 2648.4835457085874, 2650.2181856352327, 2501.8123640727017, 2534.3917459809695, 2578.9097381591555, 2593.0664960614163, 2593.23499567628, 2478.1821998740375, 2508.059477695864, 2519.370157460635, 2577.1753039027517, 2578.355411147213, 9776.0, 9812.313138080337, 9819.0, 9825.606975720963, 9871.60513579456, 5706.4864162225185, 5817.621854579439, 5858.384869588717, 5859.53123750099, 5882.470577648032, 3605.278944211142, 3648.908777280563, 3706.092007458163, 3750.8687195948282, 3823.388257878726, 1161.117550661495, 1216.4282787090053, 1237.8638349781518, 1244.7946088895321, 1255.918365306252, 14309.427622895071, 14402.279886005657, 14546.34541445648, 14600.926995365062, 14629.853701462956, 5140.511651393112, 5195.220716892421, 5299.708516031578, 5326.307580014573, 5469.15228139639, 12129.33288669114, 12155.0, 12156.270623762603, 12163.331016794162, 12168.148229623841, 6062.9090563641585, 6113.419225173601, 6120.60216085953, 6121.540884433685, 6123.693815309306, 4832.8791780205775, 5262.342207224097, 5391.676499410048, 5418.431064738224, 5463.344398672185, 4451.643868490513, 4557.703749256288, 4572.862814115515, 4619.514950930171, 4646.581807637262, 1424.1170474305998, 1469.897107202507, 1479.0829685595, 1481.3185934470048, 1489.508462207469, 1032.6488993742164, 1037.4657051618422, 1052.5421441672743, 1056.1761825775907, 1069.5775168808277, 6388.872222555523, 6404.455621272244, 6426.935730642727, 6524.836879077966, 6558.311377305409, 496.1045313209691, 497.2566013809378, 507.9695218286915, 514.0720998597493, 522.589767032885, 4270.701050926467, 4283.764392958355, 4291.871243862689, 4294.463192100988, 4314.072474418015, 12233.632991010283, 12585.748285034248, 12712.110152289251, 12719.491220351267, 12729.745405091846, 11833.290002599699, 12391.876081239072, 12504.312262825631, 12543.93728031354, 12580.182288151242, 8666.653333866574, 9016.549172541347, 9027.593758280893, 9030.774230644287, 9040.819183616422, 6385.712642931172, 6586.37429444202, 6646.268910419946, 6665.266820649627, 6831.385175334045, 11245.212835101463, 11570.421478926188, 11587.42062896835, 11682.0, 11762.235454695418, 11865.347405892759, 11883.346415947206, 11968.76062478728, 12048.096392770753, 12051.33717645538, 8035.477693949874, 8505.0, 8765.474071555727, 8830.293576513735, 9026.45841249527, 9911.405315681082, 10003.599856005678, 10036.598536058476, 10056.094951454405, 10060.69817905464, 8631.611577478903, 8843.806086178283, 8887.422317549339, 8948.373613846969, 9027.36808423404, 8283.37874659391, 8529.530875801891, 8540.060593334852, 8709.782255443411, 8873.778155545904, 7746.264104910025, 7865.292123708894, 7872.881906771288, 7880.0, 7880.369570434466, 5651.2935883014625, 5687.488126068673, 5736.827895163152, 5820.94179058204, 5855.9121613176685, 5763.0, 5777.480026797609, 5784.4504772046585, 5846.795362162304, 5861.296644402699], "value": 5109.551588333856, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.7790092241887, 354.4736066940593, 355.3355225727888, 360.1698085911972, 363.34235034587414, 5858.73635686394, 5872.911906321408, 5884.235049443577, 5926.970365148179, 5932.1991531143285, 5657.462541058603, 5715.828525144252, 5748.626339287944, 5801.767929282834, 5838.241028666278, 4500.212462819002, 4538.319252112176, 4539.54604539545, 4559.954400455986, 4561.703489273204, 4532.391001194578, 4551.317302404649, 4558.430196225472, 4570.908581828361, 4579.862604121881, 4298.677599180074, 4398.626116780078, 4544.204764166274, 4549.909001819961, 4560.8403705870305, 4503.752293623849, 4512.278035514302, 4514.480834704018, 4521.299198624219, 4528.3886675298745, 3992.3811809169624, 4020.959790402117, 4028.8115006072985, 4030.4760381150554, 4037.858674946392, 5437.483439073281, 5698.886022279573, 5711.143328500758, 5722.713864306768, 5751.4536119068625, 5144.151215049513, 5187.924830067966, 5196.402413722432, 5205.0, 5221.530062294411, 6145.9692701536205, 6160.213538073998, 6160.476359509447, 6175.5985860919345, 6246.406591373812, 4157.563455837154, 4338.652907767371, 4371.956280437187, 4381.298992161271, 4407.140607581523, 6318.87362252757, 6384.7126879290545, 6396.744130234832, 6408.166938298038, 6420.646864422455, 4491.8203271869415, 4497.730136191839, 4501.099780044005, 4508.706934049276, 4513.796879140446, 4414.183376075436, 4502.369668246448, 4502.684812063124, 4521.3896124023495, 4530.77346132692, 5168.715720635401, 5197.792088316501, 5198.726312053571, 5200.869978250574, 5230.843074707765, 5903.852403689856, 6187.679620142447, 6192.566520343623, 6217.316095229521, 6248.9062664060075, 1529.8087739032621, 1557.6105973506624, 1560.1263292555977, 1561.234994852514, 1563.8357972412732, 948.6537413843897, 972.6158167523788, 988.2242439684813, 991.3110388280076, 997.3666721631816, 5160.587153027749, 5200.97399513, 5203.349581302337, 5222.895542089137, 5238.947610523922, 5487.9541854270465, 5508.91736623951, 5512.476314750093, 5521.806736764194, 5607.327120745536, 5795.246617939725, 5946.405359464019, 5997.7001149942325, 6007.699615019232, 6012.939870601325, 3298.070628682248, 3337.5327454156436, 3344.946341902293, 3361.9663803361655, 3389.57630296213, 6290.8427289317215, 6446.709898054599, 6480.189976252968, 6502.869942601122, 6552.541322107407, 6379.521535884827, 6393.648349340738, 6429.32492088324, 6436.549441539048, 6476.5466417350335, 6366.9681651591445, 6410.358964103552, 6477.805665830033, 6500.3174666659315, 6515.804525864231, 6260.780872669617, 6267.843303917256, 6288.72986047262, 6309.832680954039, 6336.112944187726, 5930.0, 6227.626342419469, 6253.343398943228, 6267.2479302484, 6281.528885333527, 6476.179054357952, 6477.514186435942, 6503.512236582181, 6521.347865213441, 6538.0, 4427.734335939854, 4460.3532487789735, 4470.888227794331, 4485.842995495142, 4516.774161291856, 6200.193974783249, 6396.496823246441, 6422.42198202164, 6433.453156481752, 6444.323346048597, 6150.723217455135, 6199.56603037783, 6210.472109870711, 6224.408681175281, 6251.843703907439, 6077.11881777131, 6187.16473276102, 6219.689015549114, 6286.277078136073, 6290.842728931813, 6099.542534310033, 6123.357047510125, 6151.446369826737, 6153.169322141453, 6206.410391012847, 6204.472619827366, 6298.968505157628, 6309.769594928945, 6320.5575609706875, 6334.746610135543, 5788.797392091256, 5834.124881267844, 5988.970055149696, 6061.333253342217, 6081.27024757032], "value": 4640.775182131196, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [843.5276245302628, 857.1300130367678, 875.5622188905547, 878.7012415778638, 929.2983797233088, 15842.0, 17184.140792960363, 17224.483265502025, 17231.741523877154, 17254.56863578411, 16039.0, 16122.113283769388, 16172.75740863888, 16182.75725864113, 16182.919085404557, 847.563504795031, 879.5909901895617, 899.7975455522488, 910.0762725833284, 917.5962576466367, 877.2850127146355, 884.60192913189, 884.884964954555, 884.9336299777542, 885.0308911741665, 927.2906226736518, 927.6521304510809, 928.679605536089, 929.6095639831287, 930.0374112793261, 918.17364372065, 921.8893732752113, 922.460360689001, 922.9307801914849, 925.9583318750672, 673.7742856143198, 675.1021141881336, 675.4765057080753, 676.9898451523231, 678.2606958415302, 16257.51227463178, 16260.674786504322, 16283.267252973645, 16348.509544713677, 16373.42693005739, 14014.439422423091, 14372.137671739729, 14577.562673119717, 14834.406623735038, 14952.775708364383, 13386.799198012037, 13521.053526253167, 13610.0, 13761.289065037998, 13867.791983120262, 4013.3979903014783, 4041.898952526181, 4053.837846486137, 4067.877963661095, 4135.627793498599, 88300.11699882984, 88640.0, 89779.55110224537, 93557.0, 93567.53216233876, 12272.815907761391, 12468.127231093918, 12551.748965020648, 12678.873211267954, 12772.0, 23124.190653327052, 23156.18953336625, 23200.18799342015, 23215.0, 23253.0, 8967.686130985385, 9174.082591740773, 9396.389234699722, 9469.47917864524, 9588.952055239819, 4853.514648535118, 4868.099401610713, 4907.779149938261, 4950.8267210647455, 5026.472220416877, 3850.172212974168, 3938.940915886264, 3995.4805875236034, 3995.6603688686205, 4012.6990475713856, 643.6073994863129, 657.2769953051605, 658.2857599504591, 659.868026394723, 691.5297597633557, 608.9708392816127, 654.2998991079594, 664.3854434648028, 687.4294335701455, 690.1338819781142, 9026.323025773094, 9160.175584197454, 9178.265738740885, 9465.574049167804, 9769.267304952156, 705.0693085127582, 719.4244604316526, 733.6588486353871, 742.6175519607407, 782.2021538031177, 4308.89227769302, 4653.278741795028, 4729.101470720552, 4767.69010014348, 4936.407631084293, 132441.0, 133493.0, 136565.3171734135, 139220.0, 142931.2853435747, 87858.0, 103604.48197758963, 108051.0, 108180.0, 110688.0, 88497.0, 93719.0, 94121.0, 95155.0, 95824.0, 9246.398984066014, 9424.95287523558, 9687.321887468092, 9813.26400519978, 9906.554205060645, 51015.48984510256, 51297.487025129274, 52315.21527177019, 52643.73678131585, 53726.46273537371, 72026.0, 73210.0, 81581.0, 82244.0, 84013.0, 13337.866621333662, 13517.0, 13529.0, 13986.090904091201, 14061.648458788612, 14775.704485910437, 14931.92534037323, 14989.175595342362, 15127.243637817845, 16213.0, 12641.936790316358, 12697.301648409057, 13026.674333141747, 13157.802632960706, 13469.326533673473, 12400.56598019065, 12626.179298345578, 12789.872101278868, 13018.869811302146, 13150.60548183556, 12535.310557919038, 12541.811872821732, 12715.300658463873, 13212.867871321163, 13502.662433439242, 10054.0, 10237.48812559384, 10513.158947284352, 10650.786984260427, 10802.0, 10429.0, 11132.88867111351, 11133.393195650135, 11255.268407553483, 11414.315141091562], "value": 7954.556627255311, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1492.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 111.0, 105.0, 111.0, 110.0, 115.0, 110.0, 110.0, 111.0, 110.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 116.0, 148.0, 179.0, 118.0, 145.0, 145.0, 122.0, 176.0, 122.0], "value": 141.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 161.0, 162.0, 166.0, 160.0, 160.0, 166.0, 161.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 76.0, 170.0, 77.0, 76.0, 76.0, 75.0, 163.0, 74.0], "value": 93.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 148.0, 82.0, 83.0, 84.0, 139.0, 85.0, 84.0, 153.0], "value": 102.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 120.0, 117.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 147.0, 148.0, 148.0, 148.0, 148.0, 146.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 52.0, 51.0, 51.0, 53.0, 50.0, 51.0, 51.0, 54.0], "value": 51.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 60.0, 59.0, 58.0, 59.0, 59.0, 59.0, 59.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 82.0, 73.0, 73.0, 81.0, 73.0, 79.0, 73.0, 75.0], "value": 75.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 118.0, 124.0, 120.0, 124.0, 119.0, 116.0, 116.0, 167.0, 128.0], "value": 125.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 151.0, 151.0, 152.0, 153.0, 150.0, 149.0, 150.0, 149.0, 150.0], "value": 150.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 64.0, 60.0, 63.0, 61.0, 60.0, 62.0, 60.0, 59.0], "value": 61.3, "unit": "score"}]}]} 05:00:44 INFO - Return code: 0 05:00:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:00:44 ERROR - # TBPL SUCCESS # 05:00:44 INFO - Running post-action listener: _resource_record_post_action 05:00:44 INFO - [mozharness: 2016-08-15 12:00:44.581154Z] Finished run-tests step (success) 05:00:44 INFO - Running post-run listener: _resource_record_post_run 05:00:44 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 328761344; Read time: 8; Write time: 335772 05:00:44 INFO - TinderboxPrint: CPU usage
13.2% 05:00:44 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 05:00:44 INFO - TinderboxPrint: I/O write bytes / time
328,761,344 / 335,772 05:00:44 INFO - TinderboxPrint: CPU idle
8,222.4 (86.7%) 05:00:44 INFO - TinderboxPrint: CPU user
1,199.7 (12.7%) 05:00:44 INFO - TinderboxPrint: Swap in / out
0 / 0 05:00:44 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 78745600; Read time: 0; Write time: 114432 05:00:44 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 249401344; Read time: 0; Write time: 221340 05:00:45 INFO - Running post-run listener: _upload_blobber_files 05:00:45 INFO - Blob upload gear active. 05:00:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:00:45 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 05:00:45 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'] 05:00:45 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 05:00:45 INFO - (blobuploader) - INFO - Open directory for files ... 05:00:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:00:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:00:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:00:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:00:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:00:54 INFO - (blobuploader) - INFO - Done attempting. 05:00:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:00:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:00:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:00:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:00:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:00:55 INFO - (blobuploader) - INFO - Done attempting. 05:00:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:00:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:00:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:00:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:00:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:00:56 INFO - (blobuploader) - INFO - Done attempting. 05:00:56 INFO - (blobuploader) - INFO - Iteration through files over. 05:00:56 INFO - Return code: 0 05:00:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:00:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:00:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a9588c075d3534a38ab774148522619452ce21cc71638aec98a8a7f45121df911d390be2125f755540ade6c7994475b1705667267900678ba31fb377379dda2c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7debc5a3ead9a9fa558a3883b36f0b8f8013c2dc1d29ddf07f63c670ca993b405efc01be9d961b897771908e07f4b78f13dc75271100c9bc6ad2de831790572d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3635f61a53d521ce0e03fa49731e3208dc785c80c4d5f043f5e50caa14e65b85d8cb185ffe61c7916feeab0dc79fc3ead32b9d7ff8ed867b8fbc69e0b54cbe33"} 05:00:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:00:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:00:56 INFO - Contents: 05:00:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a9588c075d3534a38ab774148522619452ce21cc71638aec98a8a7f45121df911d390be2125f755540ade6c7994475b1705667267900678ba31fb377379dda2c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7debc5a3ead9a9fa558a3883b36f0b8f8013c2dc1d29ddf07f63c670ca993b405efc01be9d961b897771908e07f4b78f13dc75271100c9bc6ad2de831790572d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3635f61a53d521ce0e03fa49731e3208dc785c80c4d5f043f5e50caa14e65b85d8cb185ffe61c7916feeab0dc79fc3ead32b9d7ff8ed867b8fbc69e0b54cbe33"} 05:00:56 INFO - Running post-run listener: copy_logs_to_upload_dir 05:00:56 INFO - Copying logs to upload dir... 05:00:56 INFO - mkdir: /builds/slave/test/build/upload/logs 05:00:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1683.457174 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 3 secs) (at 2016-08-15 05:00:55.833405) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-15 05:00:55.836993) ========= 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=32c5991c409366f7fec8a718000001d2-1471259115.130713-1805668120 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/a9588c075d3534a38ab774148522619452ce21cc71638aec98a8a7f45121df911d390be2125f755540ade6c7994475b1705667267900678ba31fb377379dda2c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7debc5a3ead9a9fa558a3883b36f0b8f8013c2dc1d29ddf07f63c670ca993b405efc01be9d961b897771908e07f4b78f13dc75271100c9bc6ad2de831790572d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3635f61a53d521ce0e03fa49731e3208dc785c80c4d5f043f5e50caa14e65b85d8cb185ffe61c7916feeab0dc79fc3ead32b9d7ff8ed867b8fbc69e0b54cbe33"} build_url:https://queue.taskcluster.net/v1/task/Flf0mpjSS3KHx9D2Avsy5g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011130 build_url: 'https://queue.taskcluster.net/v1/task/Flf0mpjSS3KHx9D2Avsy5g/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/a9588c075d3534a38ab774148522619452ce21cc71638aec98a8a7f45121df911d390be2125f755540ade6c7994475b1705667267900678ba31fb377379dda2c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7debc5a3ead9a9fa558a3883b36f0b8f8013c2dc1d29ddf07f63c670ca993b405efc01be9d961b897771908e07f4b78f13dc75271100c9bc6ad2de831790572d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3635f61a53d521ce0e03fa49731e3208dc785c80c4d5f043f5e50caa14e65b85d8cb185ffe61c7916feeab0dc79fc3ead32b9d7ff8ed867b8fbc69e0b54cbe33"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-15 05:00:55.870603) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 05:00:55.871194) ========= 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=32c5991c409366f7fec8a718000001d2-1471259115.130713-1805668120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004486 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 05:00:55.954268) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-15 05:00:55.954687) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-15 05:00:55.955163) ========= ========= Total master_lag: 0.18 =========