builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-064 starttime: 1471292476.02 results: success (0) buildid: 20160815113516 builduid: 35b4b0f77bc14ca2a0aaf3663e37cd11 revision: 0d2e9c07cc9aa30ea762348152efc7c168f3c69e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-15 13:21:16.017526) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-15 13:21:16.017976) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-15 13:21:16.021082) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-15 13:21:16.050576) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 13:21:16.050943) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1471292363.15098-1427898245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-15 13:21:16-- 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% 223M=0s 2016-08-15 13:21:17 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.133127 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 13:21:16.206667) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 13:21:16.206983) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1471292363.15098-1427898245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016433 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 13:21:16.263411) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-15 13:21:16.263846) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0d2e9c07cc9aa30ea762348152efc7c168f3c69e --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 0d2e9c07cc9aa30ea762348152efc7c168f3c69e --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=a12cd81e0ef515edd9e0d800000001bb-1471292363.15098-1427898245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-15 13:21:17,177 truncating revision to first 12 chars 2016-08-15 13:21:17,177 Setting DEBUG logging. 2016-08-15 13:21:17,177 attempt 1/10 2016-08-15 13:21:17,177 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0d2e9c07cc9a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-15 13:21:18,354 unpacking tar archive at: mozilla-aurora-0d2e9c07cc9a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.514772 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-15 13:21:17.898044) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-15 13:21:17.898612) ========= script_repo_revision: 0d2e9c07cc9aa30ea762348152efc7c168f3c69e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-15 13:21:17.899289) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-15 13:21:17.899788) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-15 13:21:17.911954) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 57 secs) (at 2016-08-15 13:21:17.912442) ========= /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=a12cd81e0ef515edd9e0d800000001bb-1471292363.15098-1427898245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:21:18 INFO - MultiFileLogger online at 20160815 13:21:18 in /builds/slave/test 13:21:18 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 13:21:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:21:18 INFO - {'append_to_log': False, 13:21:18 INFO - 'base_work_dir': '/builds/slave/test', 13:21:18 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:21:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:21:18 INFO - 'branch': 'Mozilla-Aurora', 13:21:18 INFO - 'buildbot_json_path': 'buildprops.json', 13:21:18 INFO - 'config_files': ('talos/linux_config.py',), 13:21:18 INFO - 'default_actions': ('clobber', 13:21:18 INFO - 'read-buildbot-config', 13:21:18 INFO - 'download-and-extract', 13:21:18 INFO - 'populate-webroot', 13:21:18 INFO - 'create-virtualenv', 13:21:18 INFO - 'install', 13:21:18 INFO - 'run-tests'), 13:21:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:21:18 INFO - 'download_minidump_stackwalk': True, 13:21:18 INFO - 'download_symbols': 'ondemand', 13:21:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:21:18 INFO - 'tooltool.py': '/tools/tooltool.py', 13:21:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:21:18 INFO - '/tools/misc-python/virtualenv.py')}, 13:21:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:21:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:21:18 INFO - 'installer_path': 'installer.exe', 13:21:18 INFO - 'log_level': 'info', 13:21:18 INFO - 'log_name': 'talos', 13:21:18 INFO - 'log_to_console': True, 13:21:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:21:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:21:18 INFO - 'opt_config_files': (), 13:21:18 INFO - 'pip_index': False, 13:21:18 INFO - 'sps_profile': False, 13:21:18 INFO - 'sps_profile_interval': 0, 13:21:18 INFO - 'suite': 'dromaeojs-e10s', 13:21:18 INFO - 'system_bits': '32', 13:21:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:21:18 INFO - 'title': 'talos-linux64-ix-064', 13:21:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:21:18 INFO - 'use_talos_json': True, 13:21:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:21:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:21:18 INFO - 'work_dir': 'build'} 13:21:18 INFO - [mozharness: 2016-08-15 20:21:18.919230Z] Running clobber step. 13:21:18 INFO - Running pre-action listener: _resource_record_pre_action 13:21:18 INFO - Running main action method: clobber 13:21:18 INFO - rmtree: /builds/slave/test/build 13:21:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:21:19 INFO - Running post-action listener: _resource_record_post_action 13:21:19 INFO - [mozharness: 2016-08-15 20:21:19.384026Z] Finished clobber step (success) 13:21:19 INFO - [mozharness: 2016-08-15 20:21:19.384128Z] Running read-buildbot-config step. 13:21:19 INFO - Running pre-action listener: _resource_record_pre_action 13:21:19 INFO - Running main action method: read_buildbot_config 13:21:19 INFO - Using buildbot properties: 13:21:19 INFO - { 13:21:19 INFO - "project": "", 13:21:19 INFO - "product": "firefox", 13:21:19 INFO - "script_repo_revision": "production", 13:21:19 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 13:21:19 INFO - "repository": "", 13:21:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 13:21:19 INFO - "buildid": "20160815113516", 13:21:19 INFO - "pgo_build": "True", 13:21:19 INFO - "basedir": "/builds/slave/test", 13:21:19 INFO - "buildnumber": 500, 13:21:19 INFO - "slavename": "talos-linux64-ix-064", 13:21:19 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:21:19 INFO - "platform": "ubuntu64_hw", 13:21:19 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 13:21:19 INFO - "branch": "mozilla-aurora", 13:21:19 INFO - "repo_path": "releases/mozilla-aurora", 13:21:19 INFO - "revision": "0d2e9c07cc9aa30ea762348152efc7c168f3c69e", 13:21:19 INFO - "stage_platform": "linux64-pgo", 13:21:19 INFO - "builduid": "35b4b0f77bc14ca2a0aaf3663e37cd11", 13:21:19 INFO - "slavebuilddir": "test" 13:21:19 INFO - } 13:21:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/WGaWHuEjTtG7qz5hSvKC1A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 13:21:19 INFO - Running post-action listener: _resource_record_post_action 13:21:19 INFO - [mozharness: 2016-08-15 20:21:19.386538Z] Finished read-buildbot-config step (success) 13:21:19 INFO - [mozharness: 2016-08-15 20:21:19.386627Z] Running download-and-extract step. 13:21:19 INFO - Running pre-action listener: _resource_record_pre_action 13:21:19 INFO - Running main action method: download_and_extract 13:21:19 INFO - mkdir: /builds/slave/test/build/tests 13:21:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:21:19 INFO - https://queue.taskcluster.net/v1/task/WGaWHuEjTtG7qz5hSvKC1A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:21:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGaWHuEjTtG7qz5hSvKC1A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 13:21:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGaWHuEjTtG7qz5hSvKC1A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 13:21:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGaWHuEjTtG7qz5hSvKC1A/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 13:21:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGaWHuEjTtG7qz5hSvKC1A/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 13:21:19 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGaWHuEjTtG7qz5hSvKC1A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 13:21:19 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 13:21:19 INFO - retry: Failed, sleeping 30 seconds before retrying 13:21:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGaWHuEjTtG7qz5hSvKC1A/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 13:21:49 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGaWHuEjTtG7qz5hSvKC1A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 13:21:49 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 13:21:49 INFO - retry: Failed, sleeping 60 seconds before retrying 13:22:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGaWHuEjTtG7qz5hSvKC1A/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 13:22:49 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGaWHuEjTtG7qz5hSvKC1A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 13:22:49 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 13:22:49 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGaWHuEjTtG7qz5hSvKC1A/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! 13:22:49 INFO - Caught exception: HTTP Error 404: Not Found 13:22:49 INFO - Caught exception: HTTP Error 404: Not Found 13:22:49 INFO - Caught exception: HTTP Error 404: Not Found 13:22:49 INFO - trying https://queue.taskcluster.net/v1/task/WGaWHuEjTtG7qz5hSvKC1A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 13:22:49 INFO - Downloading https://queue.taskcluster.net/v1/task/WGaWHuEjTtG7qz5hSvKC1A/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 13:22:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WGaWHuEjTtG7qz5hSvKC1A/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 13:22:50 INFO - Downloaded 1361 bytes. 13:22:50 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 13:22:50 INFO - Using the following test package requirements: 13:22:50 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 13:22:50 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 13:22:50 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 13:22:50 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 13:22:50 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 13:22:50 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 13:22:50 INFO - u'jsshell-linux-x86_64.zip'], 13:22:50 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 13:22:50 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 13:22:50 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 13:22:50 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 13:22:50 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 13:22:50 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 13:22:50 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 13:22:50 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 13:22:50 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 13:22:50 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 13:22:50 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 13:22:50 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:22:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:22:50 INFO - https://queue.taskcluster.net/v1/task/WGaWHuEjTtG7qz5hSvKC1A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:22:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGaWHuEjTtG7qz5hSvKC1A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 13:22:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGaWHuEjTtG7qz5hSvKC1A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 13:22:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGaWHuEjTtG7qz5hSvKC1A/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 13:22:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGaWHuEjTtG7qz5hSvKC1A/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 13:22:50 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGaWHuEjTtG7qz5hSvKC1A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 13:22:50 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 13:22:50 INFO - retry: Failed, sleeping 30 seconds before retrying 13:23:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGaWHuEjTtG7qz5hSvKC1A/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 13:23:20 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGaWHuEjTtG7qz5hSvKC1A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 13:23:20 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 13:23:20 INFO - retry: Failed, sleeping 60 seconds before retrying 13:24:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGaWHuEjTtG7qz5hSvKC1A/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 13:24:20 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGaWHuEjTtG7qz5hSvKC1A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 13:24:20 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 13:24:20 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGaWHuEjTtG7qz5hSvKC1A/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! 13:24:20 INFO - Caught exception: HTTP Error 404: Not Found 13:24:20 INFO - Caught exception: HTTP Error 404: Not Found 13:24:20 INFO - Caught exception: HTTP Error 404: Not Found 13:24:20 INFO - trying https://queue.taskcluster.net/v1/task/WGaWHuEjTtG7qz5hSvKC1A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 13:24:20 INFO - Downloading https://queue.taskcluster.net/v1/task/WGaWHuEjTtG7qz5hSvKC1A/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 13:24:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WGaWHuEjTtG7qz5hSvKC1A/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 13:24:21 INFO - Downloaded 21766567 bytes. 13:24:21 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'] 13:24:21 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 13:24:22 INFO - Return code: 0 13:24:22 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 13:24:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:24:22 INFO - https://queue.taskcluster.net/v1/task/WGaWHuEjTtG7qz5hSvKC1A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:24:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGaWHuEjTtG7qz5hSvKC1A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 13:24:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGaWHuEjTtG7qz5hSvKC1A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 13:24:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGaWHuEjTtG7qz5hSvKC1A/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 13:24:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGaWHuEjTtG7qz5hSvKC1A/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 13:24:22 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGaWHuEjTtG7qz5hSvKC1A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 13:24:22 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 13:24:22 INFO - retry: Failed, sleeping 30 seconds before retrying 13:24:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGaWHuEjTtG7qz5hSvKC1A/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 13:24:52 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGaWHuEjTtG7qz5hSvKC1A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 13:24:52 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 13:24:52 INFO - retry: Failed, sleeping 60 seconds before retrying 13:25:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGaWHuEjTtG7qz5hSvKC1A/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 13:25:52 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGaWHuEjTtG7qz5hSvKC1A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 13:25:52 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 13:25:52 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGaWHuEjTtG7qz5hSvKC1A/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! 13:25:52 INFO - Caught exception: HTTP Error 404: Not Found 13:25:52 INFO - Caught exception: HTTP Error 404: Not Found 13:25:52 INFO - Caught exception: HTTP Error 404: Not Found 13:25:52 INFO - trying https://queue.taskcluster.net/v1/task/WGaWHuEjTtG7qz5hSvKC1A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 13:25:52 INFO - Downloading https://queue.taskcluster.net/v1/task/WGaWHuEjTtG7qz5hSvKC1A/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 13:25:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WGaWHuEjTtG7qz5hSvKC1A/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 13:25:53 INFO - Downloaded 21766567 bytes. 13:25:53 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'] 13:25:53 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 13:25:54 INFO - Return code: 0 13:25:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:25:54 INFO - https://queue.taskcluster.net/v1/task/WGaWHuEjTtG7qz5hSvKC1A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:25:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGaWHuEjTtG7qz5hSvKC1A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 13:25:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGaWHuEjTtG7qz5hSvKC1A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 13:25:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGaWHuEjTtG7qz5hSvKC1A/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 13:25:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGaWHuEjTtG7qz5hSvKC1A/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 13:25:54 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGaWHuEjTtG7qz5hSvKC1A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 13:25:54 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 13:25:54 INFO - retry: Failed, sleeping 30 seconds before retrying 13:26:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGaWHuEjTtG7qz5hSvKC1A/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 13:26:24 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGaWHuEjTtG7qz5hSvKC1A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 13:26:24 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 13:26:24 INFO - retry: Failed, sleeping 60 seconds before retrying 13:27:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGaWHuEjTtG7qz5hSvKC1A/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 13:27:25 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGaWHuEjTtG7qz5hSvKC1A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 13:27:25 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 13:27:25 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGaWHuEjTtG7qz5hSvKC1A/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! 13:27:25 INFO - Caught exception: HTTP Error 404: Not Found 13:27:25 INFO - Caught exception: HTTP Error 404: Not Found 13:27:25 INFO - Caught exception: HTTP Error 404: Not Found 13:27:25 INFO - trying https://queue.taskcluster.net/v1/task/WGaWHuEjTtG7qz5hSvKC1A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 13:27:25 INFO - Downloading https://queue.taskcluster.net/v1/task/WGaWHuEjTtG7qz5hSvKC1A/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 13:27:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WGaWHuEjTtG7qz5hSvKC1A/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 13:27:25 INFO - Downloaded 14413723 bytes. 13:27:25 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'] 13:27:25 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 13:27:26 INFO - Return code: 0 13:27:26 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')]} 13:27:26 INFO - https://queue.taskcluster.net/v1/task/WGaWHuEjTtG7qz5hSvKC1A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:27:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGaWHuEjTtG7qz5hSvKC1A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 13:27:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGaWHuEjTtG7qz5hSvKC1A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 13:27:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGaWHuEjTtG7qz5hSvKC1A/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 13:27:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGaWHuEjTtG7qz5hSvKC1A/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 13:27:26 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGaWHuEjTtG7qz5hSvKC1A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 13:27:26 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 13:27:26 INFO - retry: Failed, sleeping 30 seconds before retrying 13:27:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGaWHuEjTtG7qz5hSvKC1A/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 13:27:56 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGaWHuEjTtG7qz5hSvKC1A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 13:27:56 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 13:27:56 INFO - retry: Failed, sleeping 60 seconds before retrying 13:28:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGaWHuEjTtG7qz5hSvKC1A/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 13:28:56 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGaWHuEjTtG7qz5hSvKC1A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 13:28:56 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 13:28:56 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGaWHuEjTtG7qz5hSvKC1A/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! 13:28:56 INFO - Caught exception: HTTP Error 404: Not Found 13:28:56 INFO - Caught exception: HTTP Error 404: Not Found 13:28:56 INFO - Caught exception: HTTP Error 404: Not Found 13:28:56 INFO - trying https://queue.taskcluster.net/v1/task/WGaWHuEjTtG7qz5hSvKC1A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 13:28:56 INFO - Downloading https://queue.taskcluster.net/v1/task/WGaWHuEjTtG7qz5hSvKC1A/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 13:28:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WGaWHuEjTtG7qz5hSvKC1A/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 13:28:57 INFO - Downloaded 63772441 bytes. 13:28:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WGaWHuEjTtG7qz5hSvKC1A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 13:28:57 INFO - mkdir: /builds/slave/test/properties 13:28:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:28:57 INFO - Writing to file /builds/slave/test/properties/build_url 13:28:57 INFO - Contents: 13:28:57 INFO - build_url:https://queue.taskcluster.net/v1/task/WGaWHuEjTtG7qz5hSvKC1A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 13:28:58 INFO - Running post-action listener: _resource_record_post_action 13:28:58 INFO - Running post-action listener: set_extra_try_arguments 13:28:58 INFO - [mozharness: 2016-08-15 20:28:58.210705Z] Finished download-and-extract step (success) 13:28:58 INFO - [mozharness: 2016-08-15 20:28:58.210936Z] Running populate-webroot step. 13:28:58 INFO - Running pre-action listener: _resource_record_pre_action 13:28:58 INFO - Running main action method: populate_webroot 13:28:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:28:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:28:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:28:58 INFO - '--tppagecycles', 13:28:58 INFO - '7'], 13:28:58 INFO - 'tests': ['tsvgm']}}, 13:28:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:28:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:28:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:28:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:28:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:28:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:28:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:28:58 INFO - 'talos_options': ['--disable-e10s'], 13:28:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:28:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:28:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:28:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:28:58 INFO - 'talos_options': ['--disable-e10s'], 13:28:58 INFO - 'tests': ['damp', 'tps']}, 13:28:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:28:58 INFO - 'tests': ['damp', 'tps']}, 13:28:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:28:58 INFO - 'tests': ['dromaeo_dom']}, 13:28:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:28:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:28:58 INFO - 'tests': ['basic_compositor_video']}, 13:28:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:28:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:28:58 INFO - 'tests': ['a11yr', 13:28:58 INFO - 'ts_paint', 13:28:58 INFO - 'tpaint', 13:28:58 INFO - 'sessionrestore', 13:28:58 INFO - 'sessionrestore_no_auto_restore', 13:28:58 INFO - 'tabpaint']}, 13:28:58 INFO - 'other-e10s': {'tests': ['a11yr', 13:28:58 INFO - 'ts_paint', 13:28:58 INFO - 'tpaint', 13:28:58 INFO - 'sessionrestore', 13:28:58 INFO - 'sessionrestore_no_auto_restore', 13:28:58 INFO - 'tabpaint']}, 13:28:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:28:58 INFO - 'ts_paint', 13:28:58 INFO - 'tpaint', 13:28:58 INFO - 'sessionrestore', 13:28:58 INFO - 'sessionrestore_no_auto_restore', 13:28:58 INFO - 'tabpaint']}, 13:28:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:28:58 INFO - 'ts_paint', 13:28:58 INFO - 'tpaint', 13:28:58 INFO - 'sessionrestore', 13:28:58 INFO - 'sessionrestore_no_auto_restore', 13:28:58 INFO - 'tabpaint']}, 13:28:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:28:58 INFO - 'tests': ['a11yr', 13:28:58 INFO - 'ts_paint', 13:28:58 INFO - 'tpaint', 13:28:58 INFO - 'sessionrestore', 13:28:58 INFO - 'sessionrestore_no_auto_restore', 13:28:58 INFO - 'tabpaint']}, 13:28:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:28:58 INFO - 'tests': ['a11yr', 13:28:58 INFO - 'ts_paint', 13:28:58 INFO - 'tpaint', 13:28:58 INFO - 'sessionrestore', 13:28:58 INFO - 'sessionrestore_no_auto_restore', 13:28:58 INFO - 'tabpaint']}, 13:28:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:28:58 INFO - 'tests': ['tsvgx', 13:28:58 INFO - 'tsvgr_opacity', 13:28:58 INFO - 'tart', 13:28:58 INFO - 'tscrollx', 13:28:58 INFO - 'cart']}, 13:28:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:28:58 INFO - 'tsvgr_opacity', 13:28:58 INFO - 'tart', 13:28:58 INFO - 'tscrollx', 13:28:58 INFO - 'cart']}, 13:28:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:28:58 INFO - 'talos_options': ['--disable-e10s'], 13:28:58 INFO - 'tests': ['tp5o']}, 13:28:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:28:58 INFO - 'tests': ['tp5o']}, 13:28:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:28:58 INFO - 'talos_options': ['--disable-e10s', 13:28:58 INFO - '--xperf_path', 13:28:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:28:58 INFO - 'tests': ['tp5n']}, 13:28:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:28:58 INFO - 'talos_options': ['--xperf_path', 13:28:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:28:58 INFO - 'tests': ['tp5n']}}, 13:28:58 INFO - 'talos.zip': {'path': '', 13:28:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:28:58 INFO - Running post-action listener: _resource_record_post_action 13:28:58 INFO - [mozharness: 2016-08-15 20:28:58.229619Z] Finished populate-webroot step (success) 13:28:58 INFO - [mozharness: 2016-08-15 20:28:58.229707Z] Running create-virtualenv step. 13:28:58 INFO - Running pre-action listener: _resource_record_pre_action 13:28:58 INFO - Running main action method: create_virtualenv 13:28:58 INFO - Creating virtualenv /builds/slave/test/build/venv 13:28:58 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 13:28:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:28:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:28:58 INFO - Using real prefix '/usr' 13:28:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:28:58 INFO - Installing distribute.............................................................................................................................................................................................done. 13:29:00 INFO - Installing pip.................done. 13:29:00 INFO - Return code: 0 13:29:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:29: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')]} 13:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:29:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29: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')]} 13:29:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:29:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:00 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 0x23e2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2611400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a0570>, '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 0x26a1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a1900>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1471292363.15098-1427898245', '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 13:29:00 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 13:29:00 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 13:29:00 INFO - Using env: {'DISPLAY': ':0', 13:29:00 INFO - 'HOME': '/home/cltbld', 13:29:00 INFO - 'LANG': 'en_US.UTF-8', 13:29:00 INFO - 'LANGUAGE': 'en_US:en', 13:29:00 INFO - 'LOGNAME': 'cltbld', 13:29:00 INFO - 'MAIL': '/var/mail/cltbld', 13:29:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:29:00 INFO - 'MOZ_NO_REMOTE': '1', 13:29:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:29:00 INFO - 'NO_EM_RESTART': '1', 13:29:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:29:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:29:00 INFO - 'PWD': '/builds/slave/test', 13:29:00 INFO - 'SHELL': '/bin/bash', 13:29:00 INFO - 'SHLVL': '1', 13:29:00 INFO - 'TERM': 'linux', 13:29:00 INFO - 'TMOUT': '86400', 13:29:00 INFO - 'USER': 'cltbld', 13:29:00 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1471292363.15098-1427898245', 13:29:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:29:00 INFO - '_': '/tools/buildbot/bin/python'} 13:29:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:29:01 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 13:29:01 INFO - Cleaning up... 13:29:01 INFO - Return code: 0 13:29:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:29:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:29:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:29:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:29:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:29:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x23e2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2611400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a0570>, '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 0x26a1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a1900>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1471292363.15098-1427898245', '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 13:29:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:29:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:29:01 INFO - Using env: {'DISPLAY': ':0', 13:29:01 INFO - 'HOME': '/home/cltbld', 13:29:01 INFO - 'LANG': 'en_US.UTF-8', 13:29:01 INFO - 'LANGUAGE': 'en_US:en', 13:29:01 INFO - 'LOGNAME': 'cltbld', 13:29:01 INFO - 'MAIL': '/var/mail/cltbld', 13:29:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:29:01 INFO - 'MOZ_NO_REMOTE': '1', 13:29:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:29:01 INFO - 'NO_EM_RESTART': '1', 13:29:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:29:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:29:01 INFO - 'PWD': '/builds/slave/test', 13:29:01 INFO - 'SHELL': '/bin/bash', 13:29:01 INFO - 'SHLVL': '1', 13:29:01 INFO - 'TERM': 'linux', 13:29:01 INFO - 'TMOUT': '86400', 13:29:01 INFO - 'USER': 'cltbld', 13:29:01 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1471292363.15098-1427898245', 13:29:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:29:01 INFO - '_': '/tools/buildbot/bin/python'} 13:29:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:29:01 INFO - Downloading/unpacking psutil>=3.1.1 13:29:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:29:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:29:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:29:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:29:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:29:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:29:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:29:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:29:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:29:03 INFO - Installing collected packages: psutil 13:29:03 INFO - Running setup.py install for psutil 13:29:03 INFO - building 'psutil._psutil_linux' extension 13:29:03 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 13:29:03 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 13:29:03 INFO - building 'psutil._psutil_posix' extension 13:29:03 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 13:29:03 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 13:29:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:29:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:29:03 INFO - Successfully installed psutil 13:29:03 INFO - Cleaning up... 13:29:03 INFO - Return code: 0 13:29:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:29:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:29:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:29:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:29:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:29:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:03 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 0x23e2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2611400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a0570>, '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 0x26a1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a1900>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1471292363.15098-1427898245', '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 13:29:03 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 13:29:03 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 13:29:03 INFO - Using env: {'DISPLAY': ':0', 13:29:03 INFO - 'HOME': '/home/cltbld', 13:29:03 INFO - 'LANG': 'en_US.UTF-8', 13:29:03 INFO - 'LANGUAGE': 'en_US:en', 13:29:03 INFO - 'LOGNAME': 'cltbld', 13:29:03 INFO - 'MAIL': '/var/mail/cltbld', 13:29:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:29:03 INFO - 'MOZ_NO_REMOTE': '1', 13:29:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:29:03 INFO - 'NO_EM_RESTART': '1', 13:29:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:29:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:29:03 INFO - 'PWD': '/builds/slave/test', 13:29:03 INFO - 'SHELL': '/bin/bash', 13:29:03 INFO - 'SHLVL': '1', 13:29:03 INFO - 'TERM': 'linux', 13:29:03 INFO - 'TMOUT': '86400', 13:29:03 INFO - 'USER': 'cltbld', 13:29:03 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1471292363.15098-1427898245', 13:29:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:29:03 INFO - '_': '/tools/buildbot/bin/python'} 13:29:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:29:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:29:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:29:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:29:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:29:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:29:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:29:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:29:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:29:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:29:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:29:05 INFO - Installing collected packages: mozsystemmonitor 13:29:05 INFO - Running setup.py install for mozsystemmonitor 13:29:06 INFO - Successfully installed mozsystemmonitor 13:29:06 INFO - Cleaning up... 13:29:06 INFO - Return code: 0 13:29:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:29:06 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')]} 13:29:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:29:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:06 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')]} 13:29:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:29:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:06 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 0x23e2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2611400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a0570>, '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 0x26a1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a1900>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1471292363.15098-1427898245', '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 13:29:06 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 13:29:06 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 13:29:06 INFO - Using env: {'DISPLAY': ':0', 13:29:06 INFO - 'HOME': '/home/cltbld', 13:29:06 INFO - 'LANG': 'en_US.UTF-8', 13:29:06 INFO - 'LANGUAGE': 'en_US:en', 13:29:06 INFO - 'LOGNAME': 'cltbld', 13:29:06 INFO - 'MAIL': '/var/mail/cltbld', 13:29:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:29:06 INFO - 'MOZ_NO_REMOTE': '1', 13:29:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:29:06 INFO - 'NO_EM_RESTART': '1', 13:29:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:29:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:29:06 INFO - 'PWD': '/builds/slave/test', 13:29:06 INFO - 'SHELL': '/bin/bash', 13:29:06 INFO - 'SHLVL': '1', 13:29:06 INFO - 'TERM': 'linux', 13:29:06 INFO - 'TMOUT': '86400', 13:29:06 INFO - 'USER': 'cltbld', 13:29:06 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1471292363.15098-1427898245', 13:29:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:29:06 INFO - '_': '/tools/buildbot/bin/python'} 13:29:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:29:06 INFO - Downloading/unpacking jsonschema==2.5.1 13:29:06 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 13:29:06 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 13:29:06 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 13:29:06 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 13:29:06 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 13:29:06 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 13:29:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:29:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:29:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:29:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:29:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:29:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:29:08 INFO - Downloading functools32-3.2.3-2.tar.gz 13:29:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:29:08 INFO - warning: no files found matching '*.txt' 13:29:08 INFO - no previously-included directories found matching 'build' 13:29:08 INFO - no previously-included directories found matching 'dist' 13:29:08 INFO - no previously-included directories found matching '.git*' 13:29:08 INFO - Installing collected packages: jsonschema, functools32 13:29:08 INFO - Running setup.py install for functools32 13:29:08 INFO - warning: no files found matching '*.txt' 13:29:08 INFO - no previously-included directories found matching 'build' 13:29:08 INFO - no previously-included directories found matching 'dist' 13:29:08 INFO - no previously-included directories found matching '.git*' 13:29:08 INFO - Successfully installed jsonschema functools32 13:29:08 INFO - Cleaning up... 13:29:08 INFO - Return code: 0 13:29:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:29:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:29:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:29:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:29:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x23e2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2611400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a0570>, '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 0x26a1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a1900>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1471292363.15098-1427898245', '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 13:29:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:29:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:29:08 INFO - Using env: {'DISPLAY': ':0', 13:29:08 INFO - 'HOME': '/home/cltbld', 13:29:08 INFO - 'LANG': 'en_US.UTF-8', 13:29:08 INFO - 'LANGUAGE': 'en_US:en', 13:29:08 INFO - 'LOGNAME': 'cltbld', 13:29:08 INFO - 'MAIL': '/var/mail/cltbld', 13:29:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:29:08 INFO - 'MOZ_NO_REMOTE': '1', 13:29:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:29:08 INFO - 'NO_EM_RESTART': '1', 13:29:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:29:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:29:08 INFO - 'PWD': '/builds/slave/test', 13:29:08 INFO - 'SHELL': '/bin/bash', 13:29:08 INFO - 'SHLVL': '1', 13:29:08 INFO - 'TERM': 'linux', 13:29:08 INFO - 'TMOUT': '86400', 13:29:08 INFO - 'USER': 'cltbld', 13:29:08 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1471292363.15098-1427898245', 13:29:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:29:08 INFO - '_': '/tools/buildbot/bin/python'} 13:29:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:29:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:29:08 INFO - Cleaning up... 13:29:08 INFO - Return code: 0 13:29:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:29:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:29:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:29:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:29:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x23e2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2611400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a0570>, '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 0x26a1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a1900>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1471292363.15098-1427898245', '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 13:29:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:29:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:29:08 INFO - Using env: {'DISPLAY': ':0', 13:29:08 INFO - 'HOME': '/home/cltbld', 13:29:08 INFO - 'LANG': 'en_US.UTF-8', 13:29:08 INFO - 'LANGUAGE': 'en_US:en', 13:29:08 INFO - 'LOGNAME': 'cltbld', 13:29:08 INFO - 'MAIL': '/var/mail/cltbld', 13:29:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:29:08 INFO - 'MOZ_NO_REMOTE': '1', 13:29:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:29:08 INFO - 'NO_EM_RESTART': '1', 13:29:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:29:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:29:08 INFO - 'PWD': '/builds/slave/test', 13:29:08 INFO - 'SHELL': '/bin/bash', 13:29:08 INFO - 'SHLVL': '1', 13:29:08 INFO - 'TERM': 'linux', 13:29:08 INFO - 'TMOUT': '86400', 13:29:08 INFO - 'USER': 'cltbld', 13:29:08 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1471292363.15098-1427898245', 13:29:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:29:08 INFO - '_': '/tools/buildbot/bin/python'} 13:29:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:29:09 INFO - Downloading/unpacking blobuploader==1.2.4 13:29:09 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 13:29:09 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 13:29:09 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 13:29:09 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 13:29:09 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 13:29:09 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 13:29:10 INFO - Downloading blobuploader-1.2.4.tar.gz 13:29:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:29:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:29:11 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 13:29:11 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 13:29:11 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 13:29:11 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 13:29:11 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 13:29:11 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 13:29:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:29:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:29:11 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 13:29:11 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 13:29:11 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 13:29:11 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 13:29:11 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 13:29:11 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 13:29:11 INFO - Downloading docopt-0.6.1.tar.gz 13:29:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:29:11 INFO - Installing collected packages: blobuploader, requests, docopt 13:29:11 INFO - Running setup.py install for blobuploader 13:29:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:29:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:29:11 INFO - Running setup.py install for requests 13:29:12 INFO - Running setup.py install for docopt 13:29:12 INFO - Successfully installed blobuploader requests docopt 13:29:12 INFO - Cleaning up... 13:29:12 INFO - Return code: 0 13:29:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:29: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')]} 13:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:29:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29: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')]} 13:29:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:29:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:12 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 0x23e2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2611400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a0570>, '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 0x26a1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a1900>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1471292363.15098-1427898245', '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 13:29:12 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 13:29:12 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 13:29:12 INFO - Using env: {'DISPLAY': ':0', 13:29:12 INFO - 'HOME': '/home/cltbld', 13:29:12 INFO - 'LANG': 'en_US.UTF-8', 13:29:12 INFO - 'LANGUAGE': 'en_US:en', 13:29:12 INFO - 'LOGNAME': 'cltbld', 13:29:12 INFO - 'MAIL': '/var/mail/cltbld', 13:29:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:29:12 INFO - 'MOZ_NO_REMOTE': '1', 13:29:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:29:12 INFO - 'NO_EM_RESTART': '1', 13:29:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:29:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:29:12 INFO - 'PWD': '/builds/slave/test', 13:29:12 INFO - 'SHELL': '/bin/bash', 13:29:12 INFO - 'SHLVL': '1', 13:29:12 INFO - 'TERM': 'linux', 13:29:12 INFO - 'TMOUT': '86400', 13:29:12 INFO - 'USER': 'cltbld', 13:29:12 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1471292363.15098-1427898245', 13:29:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:29:12 INFO - '_': '/tools/buildbot/bin/python'} 13:29:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:29:12 INFO - Running setup.py (path:/tmp/pip-b2yeht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:29:12 INFO - Running setup.py (path:/tmp/pip-7zP1zi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:29:12 INFO - Running setup.py (path:/tmp/pip-hdoOa6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:29:12 INFO - Running setup.py (path:/tmp/pip-M4FP1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:29:12 INFO - Running setup.py (path:/tmp/pip-LGAV2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:29:12 INFO - Running setup.py (path:/tmp/pip-g6GkR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:29:12 INFO - Running setup.py (path:/tmp/pip-gowqPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:29:13 INFO - Running setup.py (path:/tmp/pip-jYnaGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:29:13 INFO - Running setup.py (path:/tmp/pip-ojeTv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:29:13 INFO - Running setup.py (path:/tmp/pip-b0HxB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:29:13 INFO - Running setup.py (path:/tmp/pip-jyzP2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:29:13 INFO - Running setup.py (path:/tmp/pip-ZiAcjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:29:13 INFO - Running setup.py (path:/tmp/pip-frXt8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:29:13 INFO - Running setup.py (path:/tmp/pip-DDRhcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:29:13 INFO - Running setup.py (path:/tmp/pip-YnItwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:29:13 INFO - Running setup.py (path:/tmp/pip-NSMIQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:29:13 INFO - Running setup.py (path:/tmp/pip-4CyVo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:29:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:29:13 INFO - Running setup.py install for manifestparser 13:29:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:29:13 INFO - Running setup.py install for mozcrash 13:29:13 INFO - Running setup.py install for mozdebug 13:29:14 INFO - Running setup.py install for mozdevice 13:29:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:29:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:29:14 INFO - Running setup.py install for mozfile 13:29:14 INFO - Running setup.py install for mozhttpd 13:29:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:29:14 INFO - Running setup.py install for mozinfo 13:29:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:29:14 INFO - Running setup.py install for mozInstall 13:29:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:29:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:29:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:29:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:29:14 INFO - Running setup.py install for mozleak 13:29:14 INFO - Running setup.py install for mozlog 13:29:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:29:14 INFO - Running setup.py install for moznetwork 13:29:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:29:14 INFO - Running setup.py install for mozprocess 13:29:15 INFO - Running setup.py install for mozprofile 13:29:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:29:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:29:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:29:15 INFO - Running setup.py install for mozrunner 13:29:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:29:15 INFO - Running setup.py install for mozscreenshot 13:29:15 INFO - Running setup.py install for moztest 13:29:15 INFO - Running setup.py install for mozversion 13:29:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:29:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:29:15 INFO - Cleaning up... 13:29:15 INFO - Return code: 0 13:29:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:29:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:29:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:29:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:29:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:29:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:15 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 0x23e2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2611400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a0570>, '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 0x26a1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a1900>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1471292363.15098-1427898245', '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 13:29:15 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 13:29:15 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 13:29:15 INFO - Using env: {'DISPLAY': ':0', 13:29:15 INFO - 'HOME': '/home/cltbld', 13:29:15 INFO - 'LANG': 'en_US.UTF-8', 13:29:15 INFO - 'LANGUAGE': 'en_US:en', 13:29:15 INFO - 'LOGNAME': 'cltbld', 13:29:15 INFO - 'MAIL': '/var/mail/cltbld', 13:29:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:29:15 INFO - 'MOZ_NO_REMOTE': '1', 13:29:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:29:15 INFO - 'NO_EM_RESTART': '1', 13:29:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:29:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:29:15 INFO - 'PWD': '/builds/slave/test', 13:29:15 INFO - 'SHELL': '/bin/bash', 13:29:15 INFO - 'SHLVL': '1', 13:29:15 INFO - 'TERM': 'linux', 13:29:15 INFO - 'TMOUT': '86400', 13:29:15 INFO - 'USER': 'cltbld', 13:29:15 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1471292363.15098-1427898245', 13:29:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:29:15 INFO - '_': '/tools/buildbot/bin/python'} 13:29:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:29:15 INFO - Running setup.py (path:/tmp/pip-5AaaHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:29:15 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)) 13:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:29:15 INFO - Running setup.py (path:/tmp/pip-WlcLQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:29:15 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)) 13:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:29:15 INFO - Running setup.py (path:/tmp/pip-YBiYSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:29:15 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)) 13:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:29:16 INFO - Running setup.py (path:/tmp/pip-LM3BxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:29:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:29:16 INFO - Running setup.py (path:/tmp/pip-bgYrnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:29:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:29:16 INFO - Running setup.py (path:/tmp/pip-zI1dMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:29:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:29:16 INFO - Running setup.py (path:/tmp/pip-ibJVgI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:29:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:29:16 INFO - Running setup.py (path:/tmp/pip-uR937H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:29:16 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)) 13:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:29:16 INFO - Running setup.py (path:/tmp/pip-0rTZbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:29:16 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)) 13:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:29:16 INFO - Running setup.py (path:/tmp/pip-Tksbdt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:29:16 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)) 13:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:29:16 INFO - Running setup.py (path:/tmp/pip-Pwv0fg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:29:16 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)) 13:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:29:16 INFO - Running setup.py (path:/tmp/pip-Nn1Yfu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:29:16 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)) 13:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:29:16 INFO - Running setup.py (path:/tmp/pip-0N8kTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:29:16 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)) 13:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:29:16 INFO - Running setup.py (path:/tmp/pip-jUIj31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:29:16 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)) 13:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:29:16 INFO - Running setup.py (path:/tmp/pip-_fu4DH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:29:16 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)) 13:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:29:16 INFO - Running setup.py (path:/tmp/pip-T6zQSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:29:16 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)) 13:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:29:16 INFO - Running setup.py (path:/tmp/pip-cBhjlW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:29:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:29:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:29:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:29:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:29:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:29:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:29:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:29:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:29:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:29:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:29:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:29:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:29:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:29:18 INFO - Downloading blessings-1.6.tar.gz 13:29:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:29:18 INFO - Installing collected packages: blessings 13:29:18 INFO - Running setup.py install for blessings 13:29:19 INFO - Successfully installed blessings 13:29:19 INFO - Cleaning up... 13:29:19 INFO - Return code: 0 13:29:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:29:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:29:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:29:19 INFO - Reading from file tmpfile_stdout 13:29:19 INFO - Current package versions: 13:29:19 INFO - argparse == 1.2.1 13:29:19 INFO - blessings == 1.6 13:29:19 INFO - blobuploader == 1.2.4 13:29:19 INFO - docopt == 0.6.1 13:29:19 INFO - functools32 == 3.2.3-2 13:29:19 INFO - jsonschema == 2.5.1 13:29:19 INFO - manifestparser == 1.1 13:29:19 INFO - mozInstall == 1.12 13:29:19 INFO - mozcrash == 0.17 13:29:19 INFO - mozdebug == 0.1 13:29:19 INFO - mozdevice == 0.48 13:29:19 INFO - mozfile == 1.2 13:29:19 INFO - mozhttpd == 0.7 13:29:19 INFO - mozinfo == 0.9 13:29:19 INFO - mozleak == 0.1 13:29:19 INFO - mozlog == 3.3 13:29:19 INFO - moznetwork == 0.27 13:29:19 INFO - mozprocess == 0.23 13:29:19 INFO - mozprofile == 0.28 13:29:19 INFO - mozrunner == 6.12 13:29:19 INFO - mozscreenshot == 0.1 13:29:19 INFO - mozsystemmonitor == 0.3 13:29:19 INFO - moztest == 0.7 13:29:19 INFO - mozversion == 1.4 13:29:19 INFO - psutil == 3.1.1 13:29:19 INFO - requests == 1.2.3 13:29:19 INFO - wsgiref == 0.1.2 13:29:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:29:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:29:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:29:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:29:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:29:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2611400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a0570>, '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 0x26a1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a1900>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1471292363.15098-1427898245', '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 13:29:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:29:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:29:19 INFO - Using env: {'DISPLAY': ':0', 13:29:19 INFO - 'HOME': '/home/cltbld', 13:29:19 INFO - 'LANG': 'en_US.UTF-8', 13:29:19 INFO - 'LANGUAGE': 'en_US:en', 13:29:19 INFO - 'LOGNAME': 'cltbld', 13:29:19 INFO - 'MAIL': '/var/mail/cltbld', 13:29:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:29:19 INFO - 'MOZ_NO_REMOTE': '1', 13:29:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:29:19 INFO - 'NO_EM_RESTART': '1', 13:29:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:29:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:29:19 INFO - 'PWD': '/builds/slave/test', 13:29:19 INFO - 'SHELL': '/bin/bash', 13:29:19 INFO - 'SHLVL': '1', 13:29:19 INFO - 'TERM': 'linux', 13:29:19 INFO - 'TMOUT': '86400', 13:29:19 INFO - 'USER': 'cltbld', 13:29:19 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1471292363.15098-1427898245', 13:29:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:29:19 INFO - '_': '/tools/buildbot/bin/python'} 13:29:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:29:19 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)) 13:29:19 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)) 13:29:19 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)) 13:29:19 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)) 13:29:19 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)) 13:29:19 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)) 13:29:19 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)) 13:29:19 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)) 13:29:19 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)) 13:29:19 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)) 13:29:19 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)) 13:29:19 INFO - Cleaning up... 13:29:19 INFO - Return code: 0 13:29:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:29:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:29:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:29:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:29:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:29:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:19 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 0x23e2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2611400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a0570>, '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 0x26a1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a1900>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1471292363.15098-1427898245', '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 13:29:19 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 13:29:19 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 13:29:19 INFO - Using env: {'DISPLAY': ':0', 13:29:19 INFO - 'HOME': '/home/cltbld', 13:29:19 INFO - 'LANG': 'en_US.UTF-8', 13:29:19 INFO - 'LANGUAGE': 'en_US:en', 13:29:19 INFO - 'LOGNAME': 'cltbld', 13:29:19 INFO - 'MAIL': '/var/mail/cltbld', 13:29:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:29:19 INFO - 'MOZ_NO_REMOTE': '1', 13:29:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:29:19 INFO - 'NO_EM_RESTART': '1', 13:29:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:29:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:29:19 INFO - 'PWD': '/builds/slave/test', 13:29:19 INFO - 'SHELL': '/bin/bash', 13:29:19 INFO - 'SHLVL': '1', 13:29:19 INFO - 'TERM': 'linux', 13:29:19 INFO - 'TMOUT': '86400', 13:29:19 INFO - 'USER': 'cltbld', 13:29:19 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1471292363.15098-1427898245', 13:29:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:29:19 INFO - '_': '/tools/buildbot/bin/python'} 13:29:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:29:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:29:19 INFO - Cleaning up... 13:29:19 INFO - Return code: 0 13:29:19 INFO - Running post-action listener: _resource_record_post_action 13:29:19 INFO - Running post-action listener: _start_resource_monitoring 13:29:19 INFO - Starting resource monitoring. 13:29:19 INFO - [mozharness: 2016-08-15 20:29:19.836917Z] Finished create-virtualenv step (success) 13:29:19 INFO - [mozharness: 2016-08-15 20:29:19.837352Z] Running install step. 13:29:19 INFO - Running pre-action listener: _resource_record_pre_action 13:29:19 INFO - Running main action method: install 13:29:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:29:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:29:20 INFO - Reading from file tmpfile_stdout 13:29:20 INFO - Detecting whether we're running mozinstall >=1.0... 13:29:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:29:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:29:20 INFO - Reading from file tmpfile_stdout 13:29:20 INFO - Output received: 13:29:20 INFO - Usage: mozinstall [options] installer 13:29:20 INFO - Options: 13:29:20 INFO - -h, --help show this help message and exit 13:29:20 INFO - -d DEST, --destination=DEST 13:29:20 INFO - Directory to install application into. [default: 13:29:20 INFO - "/builds/slave/test"] 13:29:20 INFO - --app=APP Application being installed. [default: firefox] 13:29:20 INFO - mkdir: /builds/slave/test/build/application 13:29:20 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'] 13:29:20 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 13:29:36 INFO - Reading from file tmpfile_stdout 13:29:36 INFO - Output received: 13:29:36 INFO - /builds/slave/test/build/application/firefox/firefox 13:29:36 INFO - Running post-action listener: _resource_record_post_action 13:29:36 INFO - [mozharness: 2016-08-15 20:29:36.125298Z] Finished install step (success) 13:29:36 INFO - [mozharness: 2016-08-15 20:29:36.125574Z] Running run-tests step. 13:29:36 INFO - Running pre-action listener: _resource_record_pre_action 13:29:36 INFO - Running main action method: run_tests 13:29:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:29:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:29:36 INFO - Python 2.7.3 13:29:36 INFO - Return code: 0 13:29:36 INFO - grabbing minidump binary from tooltool 13:29: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')]} 13:29:36 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 0x26a0570>, '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 0x26a1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a1900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:29:36 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 13:29:36 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 13:29:36 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 13:29:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:29:36 INFO - Return code: 0 13:29:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:29:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:29:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:29:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:29:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:29:36 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/WGaWHuEjTtG7qz5hSvKC1A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 13:29:36 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/WGaWHuEjTtG7qz5hSvKC1A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --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 13:29:36 INFO - Using env: {'DISPLAY': ':0', 13:29:36 INFO - 'HOME': '/home/cltbld', 13:29:36 INFO - 'LANG': 'en_US.UTF-8', 13:29:36 INFO - 'LANGUAGE': 'en_US:en', 13:29:36 INFO - 'LOGNAME': 'cltbld', 13:29:36 INFO - 'MAIL': '/var/mail/cltbld', 13:29:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:29:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:29:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:29:36 INFO - 'MOZ_NO_REMOTE': '1', 13:29:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:29:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:29:36 INFO - 'NO_EM_RESTART': '1', 13:29:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:29:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:29:36 INFO - 'PWD': '/builds/slave/test', 13:29:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:29:36 INFO - 'SHELL': '/bin/bash', 13:29:36 INFO - 'SHLVL': '1', 13:29:36 INFO - 'TERM': 'linux', 13:29:36 INFO - 'TMOUT': '86400', 13:29:36 INFO - 'USER': 'cltbld', 13:29:36 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1471292363.15098-1427898245', 13:29:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:29:36 INFO - '_': '/tools/buildbot/bin/python'} 13:29:36 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/WGaWHuEjTtG7qz5hSvKC1A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 13:29:36 INFO - mozversion application_buildid: 20160815113516 13:29:36 INFO - mozversion application_changeset: 0d2e9c07cc9aa30ea762348152efc7c168f3c69e 13:29:36 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:29:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:29:36 INFO - mozversion application_name: Firefox 13:29:36 INFO - mozversion application_remotingname: firefox-dev 13:29:36 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:29:36 INFO - mozversion application_vendor: Mozilla 13:29:36 INFO - mozversion application_version: 50.0a2 13:29:36 INFO - mozversion platform_buildid: 20160815113516 13:29:36 INFO - mozversion platform_changeset: 0d2e9c07cc9aa30ea762348152efc7c168f3c69e 13:29:36 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:29:36 INFO - mozversion platform_version: 50.0a2 13:29:36 INFO - using testdate: 1471292976 13:29:36 INFO - actual date: 1471292976 13:29:36 INFO - starting webserver on 'localhost:60726' 13:29:36 INFO - SUITE-START | Running 2 tests 13:29:36 INFO - TEST-START | dromaeo_css 13:29:36 INFO - operating with platform_type : linux_ 13:29:36 INFO - Initialising browser for dromaeo_css test... 13:29:36 INFO - TEST-INFO | started process 12796 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp82yPTc/profile http://localhost:60726/getInfo.html) 13:29:41 INFO - PROCESS | 12796 | __metrics Screen width/height:1600/1200 13:29:41 INFO - PROCESS | 12796 | colorDepth:24 13:29:41 INFO - PROCESS | 12796 | Browser inner width/height: 1024/697 13:29:41 INFO - PROCESS | 12796 | __metrics 13:29:42 ERROR - PROCESS | 12796 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 13:29:42 INFO - TEST-INFO | 12796: exit 0 13:29:42 INFO - Browser initialized. 13:29:42 INFO - Running cycle 1/1 for dromaeo_css test... 13:29:42 INFO - TEST-INFO | started process 12926 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp82yPTc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:29:54 INFO - PROCESS | 12926 | RSS: Main: 152526848 13:29:54 INFO - PROCESS | 12926 | 13:30:44 INFO - PROCESS | 12926 | 1471293044373 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] 13:32:52 INFO - PROCESS | 12926 | Cycle 1(1): loaded http://localhost:60726/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60726/tests/dromaeo/cssquery-ext.html) 13:32:54 INFO - PROCESS | 12926 | RSS: Main: 158097408 13:32:54 INFO - PROCESS | 12926 | 13:35:56 INFO - PROCESS | 12926 | Cycle 1(1): loaded http://localhost:60726/tests/dromaeo/cssquery-ext.html (next: http://localhost:60726/tests/dromaeo/cssquery-jquery.html) 13:35:56 INFO - PROCESS | 12926 | RSS: Main: 153186304 13:35:56 INFO - PROCESS | 12926 | 13:38:58 INFO - PROCESS | 12926 | Cycle 1(1): loaded http://localhost:60726/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60726/tests/dromaeo/cssquery-mootools.html) 13:38:59 INFO - PROCESS | 12926 | RSS: Main: 153395200 13:38:59 INFO - PROCESS | 12926 | 13:42:00 INFO - PROCESS | 12926 | Cycle 1(1): loaded http://localhost:60726/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60726/tests/dromaeo/cssquery-prototype.html) 13:42:01 INFO - PROCESS | 12926 | RSS: Main: 152297472 13:42:01 INFO - PROCESS | 12926 | 13:45:04 INFO - PROCESS | 12926 | Cycle 1(1): loaded http://localhost:60726/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60726/tests/dromaeo/cssquery-yui.html) 13:45:04 INFO - PROCESS | 12926 | RSS: Main: 155283456 13:45:04 INFO - PROCESS | 12926 | 13:48:06 INFO - PROCESS | 12926 | Cycle 1(1): loaded http://localhost:60726/tests/dromaeo/cssquery-yui.html (next: http://localhost:60726/tests/dromaeo/cssquery-dojo.html) 13:48:07 INFO - PROCESS | 12926 | RSS: Main: 155836416 13:48:07 INFO - PROCESS | 12926 | 13:48:07 INFO - PROCESS | 12926 | __start_tp_report 13:48:07 INFO - PROCESS | 12926 | _x_x_mozilla_page_load 13:48:07 INFO - PROCESS | 12926 | _x_x_mozilla_page_load_details 13:48:07 INFO - PROCESS | 12926 | |i|pagename|runs| 13:48:07 INFO - PROCESS | 12926 | |0;dojo.html;3383.204946837493;3415.026717385545;3418.3163367326542;3423.8972830815082;3441.8967430977063;5853.619514731539;5955.2853657561045;5959.523238140949;5965.701714914258;5977.82066538004;5853.268341457318;5908.379620139888;5909.320428150753;5915.556333275011;5925.762969481227;5314.5216930476345;5333.679979201261;5340.839774806743;5397.082495975694;5439.265699130607;5241.161414173733;5246.554042906358;5278.1291086970605;5298.337707786527;5303.337082864642;5344.893102137955;5393.083175860113;5394.32570928634;5396.865078373053;5422.783088676449;5373.005993891143;5389.9191512127345;5392.487713667196;5392.865178370533;5395.406505284415;5167.819126330598;5198.2722418861385;5217.895642087137;5300.602454815904;5401.540869026137;5813.331466881321;5885.205497257858;5891.499222566087;5893.145493903403;5919.5560332974765;6271.843203919893;6309.968450157719;6340.3659634036685;6342.524310676671;6348.873022539569;6118.082287656843;6120.877582448326;6378.77674281398;6379.617222966637;6387.233531976146;5711.114777209539;5812.273465816773;5820.708964551798;5843.590948633598;5843.824685259449;6298.212723409574;6301.873962520815;6339.714712837934;6355.936440635627;6362.0774987627465;5994.100884867217;6122.479589234876;6124.74712746768;6130.785422510191;6145.508359331243;6226;6365.554411191172;6376.426121649074;6403.103565500834;6407.903881441782;6337.65142917144;6355.586886852339;6366.458850997625;6374.872502549923;6389.6805159741825;6070.7875224366935;6152.538559608047;6365.267994180728;6371.872562548723;6386;4731.4795372509;4790.754403854953;4791.592714619296;4816.759162041884;4819.759012049383;4245.150969806051;4254.446921900133;4262.808173632194;4270.380794784801;4305.4187684662165;5855.121731740188;5887.499562537232;6003.699815009232;6057.575969682168;6059.272887253558;6268.874622507525;6401.3278605746655;6414.03789431589;6425.132607098076;6439.227292724903;6102.877942441126;6108.755649774048;6113.786017489456;6132.724027418777;6134.9079763803575;5302.867428314323;5373.167159090269;5480;5480.04099282624;5543.972280138573;6457.418832305021;6609.471242300604;6631.10480085192;6640.468762498988;6648.368405001517;6348.269948955929;6383.265924418752;6412.9358706414205;6417.550771445954;6426.742930282736;6382.489400848014;6394;6544.116544266653;6545.116409284686;6628.337166283333;6140.710450805381;6270.090836828543;6272.435480806749;6275.278342990615;6285.434310911857;6346.428821406095;6372.267189273108;6396.232452105777;6409.359064093554;6409.391107844747;6092.390760923872;6109.495762817309;6245.219347581552;6249.625022498664;6252.624842509464;6113.2969708482315;6157.89157951573;6175.197224360804;6228;6233.5636505446;6130.080487926668;6152.107944347955;6175.919214137598;6191.783287584913;6200.286966998853;5991.041433370814;6116.487945662109;6184.690765461619;6281.654509001866;6308.08532762756;6012;6127.080937859357;6131.534031361382;6144.324124346408;6145.6927153641245 13:48:07 INFO - PROCESS | 12926 | |1;ext.html;578.8957987562239;640.9935900640994;654.3718030690534;658.1707049118111;703.3529153179074;43799.343009854834;47883;48021.759891200585;48404;48463.75768121159;47782.76108619452;48276.51723482764;48360.51639483604;48392.27411588829;48416.515834841644;9161.26709863211;9207.95396023019;9242.02958689338;9273;9289.860652090225;9284.860727089099;9287.257019438463;9348.57931393089;9351.158395744382;9361.906380936205;9399.671011514598;9419.29355298352;9434.528273586327;9448.527573621326;9482;9354.06459354066;9367.110124538192;9373.250139988784;9375.859362109573;9418.811623767555;9299.674511392137;9334.019927907608;9345.345825792198;9353.158215760546;9362.719118426457;44917.32624010643;45247.32129018068;45324.77337613291;45349;45378;3310.702036816698;3699.9445008324897;3704.629537046301;3807.847686092553;3830.157365379612;33800.83099584511;33810.154746131295;34059.659403405894;34068.659313406795;34409;4617.561331673519;4633.837815676435;4634.837780677693;4651.2557990721325;4667.439907211123;333962;334604;337052;337817;338926;40225;40342.39486407706;40461.19077618431;40489.79755101265;40510;38981.22037559289;39084.21831563353;39848.80075599661;41288;43031.35452968208;16290;16506.917465412596;16528.338866445447;16556.42052528156;16594.75107873383;13272.800907986388;13487.865121348857;13512.256825874474;13532.661683457993;13564;21353.78646213549;21441.67837482439;21444.142234310766;21499.355019349445;21529.67705484419;7474.289942455458;7684.846303073908;7715.22847715224;7827.804304892423;7832.725854595175;1027.1320733979776;1093.1746531368765;1147.1281825812443;1159.686884541169;1168.696139003865;34048.829755851555;34530.82734586311;34698.47952280718;34727.47908781371;34740.47889281663;1174.266083697689;1201.6635342104225;1218.1959906461693;1270.555305643036;1303.4069498378215;17516.299348025936;18367.35714249995;18547.25810967573;19381.709274360896;19699.21203151858;397276;546873;553696;553765;555051;64997.67501162464;65470.67264663742;65687.34312656813;65712.67143664251;65722.67138664276;1424.4159894443228;1435.7559214933488;1457.511733569245;1466.0690461556987;1469.5003698742264;32292.677073228966;34230;34492.82753586216;34943.65056349404;35006.64993350034;56420.43579564152;57326.7133664329;57383;57486.425135748104;57512;533222;534683;534867;535174;535342;31204.843975779975;31206.375872482877;31216.21959450941;31335.529967050967;31432.528512072793;53764.462355375945;53938;54014;54050.45949540612;54203;44950;45152.774236129924;45339.54660453485;46181;47158;43781;44879;45250.32124518201;45777;46383.76808115938;45704;46024.30963535616;46126;46159;49151.50848491612;38640.22719545537;39609.80195099006;40213;41207.96980075522;41968.79015604902;30311;30874.228144296572;31378.686213137575;31493.8425307872;31888.202794930312 13:48:07 INFO - PROCESS | 12926 | |2;jquery.html;399.9140184860256;405.36560283156837;414.9522804877438;417.9707420480566;426.726894787336;14413.207273599948;18551;19391.903040484776;19917.800821991794;19934.501637459052;19473.902630486864;19490;19658.311959081435;19732.802671973313;19885.005749712527;5771.422857714237;5812.593118481708;5859.824205273849;5897.439743224387;5936.198613187207;5857.238558987326;5928.7332070056955;5929.584929054968;5941.524678025748;5941.584089113764;5699.886002279952;5811.709414529278;5837.211976383198;5845.56158288128;5880.147378630096;5808.912866307009;5821.27234095738;5823.039198532237;5830.183774271605;5836.6789826559525;5215.765290561933;5232.581393488512;5248.685078895279;5257.185136303879;5263.973680131613;22980.77019229803;23241.883790580938;23528.29415117532;23635.172768953005;23796;2552.4767422678306;2580.664513613237;2589.3656054266826;2675.357914100621;2724.0738149029426;14671.33978970949;14884;14995.925020374938;15088.471903483325;15431.691366172727;1676.3546034776577;1916.463390250718;2042.1831267492973;2077.6468000439963;2102.5899949509853;87292.56353718191;87811;88942.99999999936;89039;89842;11236.269642473213;11270.380129092815;11304.321740695585;11485.71285717847;11678.124140689482;15339.463118791013;15382.538523844303;15441.768373474408;15459.381624734884;15476.613084672748;8339.708110216114;8495.192956669107;8515.659373625109;8591.226789588842;8640.222379985831;8029.4379393441895;8046.637901294339;8151.633176507072;8339.20777526134;8446.493210407396;4783.736894470768;4852.393450818648;4908.11653902301;4918.680285781413;4960.975195124001;2049.4978730210896;2060.1862264405477;2069.3998740365428;2078.5323302257175;2097.297405369188;905.6015353244551;1001.5543083327849;1008.0826447932346;1014.4065721552827;1027.8406846938738;18939.90530047341;19261.22955081809;19792.70310945337;19986.400407987785;20119.698204526943;1017.2624846985876;1036.0727149201573;1037.5382954585289;1070.855434516346;1091.2034215022918;10418.635347762793;11135.498902549405;11173.553057877756;11255.831162532568;11268.605598804003;530597;531928;541261;541854;553460;90966.54516727374;94059;94484.00265831247;99252.5037374823;100368.49815750874;1034.7620047388991;1051.321897376188;1072.0994364733506;1083.864516935383;1087.228068071678;16154.596135096717;18522.166502507687;18533.258669653602;18740;18745.90627046856;45951.54048459473;45986;48612.75693621509;48691;49604.25593616026;69093;69231;69734.65132674304;69857.3014269871;70196.64901675664;8877.955610222167;8919.955400222958;8940.5082720451;9054.456732596065;9077.45535267886;10414.479276036016;13828;14035.36840842185;14048.578542643738;14117.2235527047;11737.941310293394;12212.694682633006;12311.19977201479;12324.50701971911;12334.136610437183;11794.469248883992;11998.340091294713;12046.096542759153;12116.394180290774;12264.816027759769;11934.641960741192;12158.817617735918;12212.755744884875;12228.449719762453;12268.631941041784;8923.464592124494;8950.194482496607;8969.416987895765;9017.684381046633;9080.273578113603;9319.813603728024;11752.823707644564;11765.823512647146;11933.701657458285;12281.447334869774 13:48:07 INFO - PROCESS | 12926 | |3;mootools.html;1513.0845838267849;1556.3541130430867;1732.7487514310426;1850.6021205440836;1870.3827736846843;8604.26863716585;9047.864282035775;9209.861852072225;9976.102150806426;9983.20134389248;8640.96308442986;8829.117088291168;9016.233620142279;9021.278297736182;9043.909560904389;2481.4168670362496;2510.3849556858504;2525.9242222733255;2527.936801579957;2529.4435224250637;2429.708434987795;2494.638277449769;2496.7128780190237;2508.2726009457238;2517.5216708825265;2458.4468494588664;2478.3680161558777;2502.2868482482495;2504.8121390895662;2520.0045981837256;2382.19005538117;2392.629142482909;2393.365758074112;2407.2898494943856;2425.0663494554724;2411.9517609647883;2419.4677171022345;2421.32202983165;2421.3946513371657;2462.0890270599994;9616.711498655051;9643.855342169873;9664.613415463373;9745.707628771148;9775.951120244425;5580.525655319262;5706.914396284017;5738.139279108125;5738.167965644958;5752.741126649311;3586.5337506124297;3707.3326801175776;3761.9247615047548;3773.0001549589106;3792.2984247914223;1238.2322959764913;1305.2560040776762;1318.6110097521255;1321.4383886848052;1336.1515437697133;12988.155769874928;13375.19748815084;13421.463141474329;13446.93276533611;13910.956678249071;4766.594839438687;4845.563899249014;4918.6556941014505;4919.77860996256;5052.595792336604;11573.710657233636;11623.88376116228;11626.941865290619;11640.708982275342;11676.357800320893;5619.353774315924;5623.437656234344;5634;5651.660900345993;5659.717014149276;4595.287730401793;5036.496350365008;5089.134847076006;5110.770015349318;5167.483251674803;4264.189803937242;4365.628921541641;4384.101259241847;4410.3825464435;4428.070105277928;1311.799703271515;1380.2132784313046;1381.412899517701;1389.6942672612008;1390.707951330232;899.5457294066586;989.6288891665625;1017.765913839821;1040.0535512683573;1045.9790804184026;6286.685665716695;6287.402696743802;6439.774607888701;6472.385123413268;6514.674266286666;474.8860273534396;485.8178183181307;486.29972839112276;493.9975300123476;499.88502644391264;4169.97915010423;4234.174336004449;4245.511766146933;4256.7658778766845;4261.701680882308;11524.769504609862;11905.583304584472;11929.403529823474;11951.76096478083;11977.700557485958;11376.089912806956;11782.764344713058;11835.704107397212;11896;11931;8320.791980200422;8734.388592798443;8738.737837864874;8743;8762.255208307237;6515.771947981798;6586.637734924433;6623.768168114286;6734.22556406;6820.863582728417;10735.463226838783;10946;11050.226484146033;11094.445277736242;11274.774504510027;11394.430278485877;11400.828987565359;11433.656990290305;11503.884961150616;11562.710932226762;8394.328453723809;8483.95758021206;8501.829963400574;8575.914240857512;8577.528235947082;9048.773780655536;9214.401063930824;9255.76860578491;9256.768580785534;9259.12038356382;8277.172282771675;8341.12418196105;8343.666253349798;8485.363597730318;8489.575521224038;8069.556174410229;8148.22591853773;8235;8333.624986875726;8450.619722112642;7681.001469808889;7686.961565192362;7766.145723970471;7771.766846994599;7777.105632852295;5524.06090964545;5721.342045664635;5848.824535263949;5857.824265272048;5885.470307672159;5598.552115830642;5713.257276554022;5739.081746920473;5802;5837.09525023622 13:48:07 INFO - PROCESS | 12926 | |4;prototype.html;344.4007427076886;348.030734404683;349.19162139646716;349.87579409309694;353.3568904593641;5724.198612194291;5900.911486327708;5908.970455147729;5910.34986151523;5957.136215248786;5777.913331300034;5794.884102317951;5796.768359097861;5803.245578074855;5855.677937713424;4115.773632450207;4468.396766436522;4485.0805584855025;4489.865304040884;4502.077074199781;4477.619402350804;4491.7754112294415;4526.140033393661;4530.954690453086;4532.297493888453;4451.910961780763;4467.82128714851;4497.257952437843;4497.505274419811;4525.954740452603;4266.9999999999845;4460.553944605546;4463.152001119793;4473.82104715811;4481.8655440336515;3908.5895980922164;3921.274564205631;3939.527256729182;3941.1723538057045;3948.2893079245723;5638.661680299154;5659.717014149317;5717.714114294268;5718.628289161191;5751.654900705971;4979.1784355581285;5147.922781158286;5168.22476628505;5171.818986335498;5200.141976573861;6026.6986650667295;6032.607880487798;6038.516918646497;6116.908246376308;6163;4203.726757760766;4339.457567804025;4369.497507786614;4376.124775045004;4400.603945644875;6281.371862813728;6291.7797877074545;6300.747970081191;6302.653354065525;6310.463610593105;4387.254166791653;4401.097774956191;4407.2507673695545;4419.535948725402;4425.977870110629;4288.463942007249;4442.644588432918;4449.688521803443;4460.531644177379;4462.085272519126;5075.56857667095;5084.745762711849;5089.6691715038405;5090.592752579785;5116;6042.154098426224;6043.909341359883;6095.6952152392205;6153.261798499625;6167.444929956326;1532.601523603871;1533.2640332640394;1557.8753699703996;1559.3840433029118;1565.577294130601;964.3924327673661;964.9614015439445;1031.4120951057826;1059.7085801404676;1061.75048863517;5845.3570107289015;5860.589758716934;5865.970670146708;5871.412858714094;5902.58681892272;6081.540430296697;6145.262568491809;6147.538934579835;6218.471429928416;6228.096925945712;5695.202671625976;5855.560832937546;5876.559258055578;5881.676507792027;5914.822555323347;3283.1627934876456;3290.3090351026076;3302.108430723691;3309.9503507447407;3320.2529430877858;6161.938380616137;6297.338779428094;6349.492040636738;6472.385123413268;6555.80332590023;6336.398042185985;6396.392342727527;6420.500827049269;6431.839204019937;6454.580452270588;6320.4311611955145;6477.57895736785;6503.7073331700185;6585.473162147016;6590.670466476657;6243.687815609111;6275.341089185752;6294.622322660655;6300.117983482408;6310.968445157929;6190.889934186231;6244.875102498016;6254.780317837978;6262.624242545279;6301.905471418024;6387.968060159669;6492.091107245084;6497.642629655415;6506.544541882212;6527.5757075789925;4383.978080109579;4384;4404.801783919667;4420.723327486411;4440.777961101868;6241.843953901189;6330.177076979963;6341.03685196752;6354.904676429765;6386.179938717629;6156.415140561639;6158.414950579688;6190.350013248544;6195.566310358232;6212.751489940351;5881.823545293648;6136.938630613637;6139.508839292936;6168.982117950488;6197.25632924052;5836.562257830595;6026.578139530367;6044.818655440344;6075.362086980804;6108.236470441195;6170.753169873155;6208.565400421927;6210.130581718653;6225.968870155621;6245.250569931637;5928.34788173292;6073.817785466443;6076.726547305293;6082.695865206633;6089.908651370321 13:48:07 INFO - PROCESS | 12926 | |5;yui.html;807.4993504027503;843.3253397282176;876.6493402638945;903.439867282285;932.547714358536;16439.2602332895;16642;17736;18130.18414171362;18192.818071819278;16331.673366532663;16359.83640163598;16373.59066023347;16394.09832459214;16516.83483165168;857.8455877941968;859.6518410043911;872.3457406944791;876.3514998900799;876.509154873273;839.47532792005;870.4298684361753;872.2498651159997;873.5108339329964;876.0538618292229;932.883389576303;934.0379409208526;937.1799675284126;939.0468674295596;939.5959737312953;931.7065124485799;935.7707361696393;938.7277689470045;942.5098948546718;943.8348289049458;683.9589624622539;685.0717278088168;685.7359916432159;688.9758858439981;690.4096997067485;15445.613859653486;15459.768103478344;15480.458183963507;15513.689726205526;15534.689306213926;15749.763753543706;15878.761818572731;16114.838851611452;16137.596560085974;16310.673786524321;13051.21692698441;13334.733305333935;13535.18788872661;13596.728065438636;13969.161850289016;4006.098627808749;4010.7393019453643;4063.2482990646827;4091.1817636472824;4146.958530414688;90425;91920;92538;92970;93566;12346.13577049598;12406.937965310297;12643.11498195136;12644.873551264554;12706;23397.181098661466;23408.882955585454;23414.297571072893;23433;23511.41221469477;9303.209227215762;9365.812683746288;9383.483908384967;9606.087421694929;9683.080107389787;5197.558207552324;5266.131088370453;5418.45815418455;5449.863753406196;5570.832875013756;3898.590647981978;3987.900302492461;4017.357222844331;4031.5968403160036;4037.9798101009897;696.3558708195001;699.5068476723898;707.5895980331395;721.1238345410247;725.0103608574258;643.856781610339;802.4182467710863;810.4003037752138;815.2906970935325;836.7908022994252;10022.54898529568;10817.080548153495;11561;11729.120315976335;11759.529618815322;772.9343005844567;783.1933108897845;790.1426951757408;790.8339248757825;811.3711873298123;4944.629152813553;5196.948030519722;5275.57795376369;5335.413104558495;5379.408265090837;126785;132452;135466;138273.3086334582;139380;79078;82989.58505207556;112847;120927;123577;99056.50471747595;102729.48635256776;105337;105374.47312763387;105637.47181264198;10105.39367637944;10132.79734405293;10209.642662507074;10224.1820654346;10329.535170917477;56220.43779562152;56240;57244.71377643085;58182.7090864543;60010.69994649999;78723;88845.55577222073;89735.55132224558;89875.55062224648;91215;12339.13626046168;12382.75234495287;12576.371181441074;12901.741965160832;12939.288339141438;14834.10995340283;14859.182744949132;14881;14887.627809304853;14914;12914.612561623166;12918.22490650564;12924.030697697899;13099.279539625411;13188.142770719873;13455.932720336335;13485.123466974615;13505.662358441117;13674.863251367358;14210.644733881736;13820.376003590165;13985.8401447809;14127.64680882986;14347.35436905321;14707.338169782599;10455.462869982715;10528.526216320437;10756;10814.134869210287;11063.72340691489;10820.89179108199;11155.832662509907;11247.550097995989;11324.6036388726;11334 13:48:07 INFO - PROCESS | 12926 | __end_tp_report 13:48:07 INFO - PROCESS | 12926 | __start_cc_report 13:48:07 INFO - PROCESS | 12926 | _x_x_mozilla_cycle_collect,350 13:48:07 INFO - PROCESS | 12926 | __end_cc_report 13:48:07 INFO - PROCESS | 12926 | __startTimestamp1471294087122__endTimestamp 13:48:07 INFO - PROCESS | 12926 | 13:48:07 INFO - PROCESS | 12926 | ------- Summary: start ------- 13:48:07 INFO - PROCESS | 12926 | Number of tests: 6 13:48:07 INFO - PROCESS | 12926 | 13:48:07 INFO - PROCESS | 12926 | [#0] dojo.html Cycles:165 Average:5866.12 Median:6120.88 stddev:680.73 (11.1%) stddev-sans-first:654.36 13:48:07 INFO - PROCESS | 12926 | Values: 3383.2 3415.0 3418.3 3423.9 3441.9 5853.6 5955.3 5959.5 5965.7 5977.8 5853.3 5908.4 5909.3 5915.6 5925.8 5314.5 5333.7 5340.8 5397.1 5439.3 5241.2 5246.6 5278.1 5298.3 5303.3 5344.9 5393.1 5394.3 5396.9 5422.8 5373.0 5389.9 5392.5 5392.9 5395.4 5167.8 5198.3 5217.9 5300.6 5401.5 5813.3 5885.2 5891.5 5893.1 5919.6 6271.8 6310.0 6340.4 6342.5 6348.9 6118.1 6120.9 6378.8 6379.6 6387.2 5711.1 5812.3 5820.7 5843.6 5843.8 6298.2 6301.9 6339.7 6355.9 6362.1 5994.1 6122.5 6124.7 6130.8 6145.5 6226.0 6365.6 6376.4 6403.1 6407.9 6337.7 6355.6 6366.5 6374.9 6389.7 6070.8 6152.5 6365.3 6371.9 6386.0 4731.5 4790.8 4791.6 4816.8 4819.8 4245.2 4254.4 4262.8 4270.4 4305.4 5855.1 5887.5 6003.7 6057.6 6059.3 6268.9 6401.3 6414.0 6425.1 6439.2 6102.9 6108.8 6113.8 6132.7 6134.9 5302.9 5373.2 5480.0 5480.0 5544.0 6457.4 6609.5 6631.1 6640.5 6648.4 6348.3 6383.3 6412.9 6417.6 6426.7 6382.5 6394.0 6544.1 6545.1 6628.3 6140.7 6270.1 6272.4 6275.3 6285.4 6346.4 6372.3 6396.2 6409.4 6409.4 6092.4 6109.5 6245.2 6249.6 6252.6 6113.3 6157.9 6175.2 6228.0 6233.6 6130.1 6152.1 6175.9 6191.8 6200.3 5991.0 6116.5 6184.7 6281.7 6308.1 6012.0 6127.1 6131.5 6144.3 6145.7 13:48:07 INFO - PROCESS | 12926 | 13:48:07 INFO - PROCESS | 12926 | [#1] ext.html Cycles:180 Average:63092.70 Median:45051.39 stddev:125849.34 (279.3%) stddev-sans-first:126114.85 13:48:07 INFO - PROCESS | 12926 | Values: 578.9 641.0 654.4 658.2 703.4 43799.3 47883.0 48021.8 48404.0 48463.8 47782.8 48276.5 48360.5 48392.3 48416.5 9161.3 9208.0 9242.0 9273.0 9289.9 9284.9 9287.3 9348.6 9351.2 9361.9 9399.7 9419.3 9434.5 9448.5 9482.0 9354.1 9367.1 9373.3 9375.9 9418.8 9299.7 9334.0 9345.3 9353.2 9362.7 44917.3 45247.3 45324.8 45349.0 45378.0 3310.7 3699.9 3704.6 3807.8 3830.2 33800.8 33810.2 34059.7 34068.7 34409.0 4617.6 4633.8 4634.8 4651.3 4667.4 333962.0 334604.0 337052.0 337817.0 338926.0 40225.0 40342.4 40461.2 40489.8 40510.0 38981.2 39084.2 39848.8 41288.0 43031.4 16290.0 16506.9 16528.3 16556.4 16594.8 13272.8 13487.9 13512.3 13532.7 13564.0 21353.8 21441.7 21444.1 21499.4 21529.7 7474.3 7684.8 7715.2 7827.8 7832.7 1027.1 1093.2 1147.1 1159.7 1168.7 34048.8 34530.8 34698.5 34727.5 34740.5 1174.3 1201.7 1218.2 1270.6 1303.4 17516.3 18367.4 18547.3 19381.7 19699.2 397276.0 546873.0 553696.0 553765.0 555051.0 64997.7 65470.7 65687.3 65712.7 65722.7 1424.4 1435.8 1457.5 1466.1 1469.5 32292.7 34230.0 34492.8 34943.7 35006.6 56420.4 57326.7 57383.0 57486.4 57512.0 533222.0 534683.0 534867.0 535174.0 535342.0 31204.8 31206.4 31216.2 31335.5 31432.5 53764.5 53938.0 54014.0 54050.5 54203.0 44950.0 45152.8 45339.5 46181.0 47158.0 43781.0 44879.0 45250.3 45777.0 46383.8 45704.0 46024.3 46126.0 46159.0 49151.5 38640.2 39609.8 40213.0 41208.0 41968.8 30311.0 30874.2 31378.7 31493.8 31888.2 13:48:07 INFO - PROCESS | 12926 | 13:48:07 INFO - PROCESS | 12926 | [#2] jquery.html Cycles:180 Average:31479.99 Median:23385.09 stddev:89058.15 (380.8%) stddev-sans-first:89277.41 13:48:07 INFO - PROCESS | 12926 | Values: 399.9 405.4 415.0 418.0 426.7 14413.2 18551.0 19391.9 19917.8 19934.5 19473.9 19490.0 19658.3 19732.8 19885.0 5771.4 5812.6 5859.8 5897.4 5936.2 5857.2 5928.7 5929.6 5941.5 5941.6 5699.9 5811.7 5837.2 5845.6 5880.1 5808.9 5821.3 5823.0 5830.2 5836.7 5215.8 5232.6 5248.7 5257.2 5264.0 22980.8 23241.9 23528.3 23635.2 23796.0 2552.5 2580.7 2589.4 2675.4 2724.1 14671.3 14884.0 14995.9 15088.5 15431.7 1676.4 1916.5 2042.2 2077.6 2102.6 87292.6 87811.0 88943.0 89039.0 89842.0 11236.3 11270.4 11304.3 11485.7 11678.1 15339.5 15382.5 15441.8 15459.4 15476.6 8339.7 8495.2 8515.7 8591.2 8640.2 8029.4 8046.6 8151.6 8339.2 8446.5 4783.7 4852.4 4908.1 4918.7 4961.0 2049.5 2060.2 2069.4 2078.5 2097.3 905.6 1001.6 1008.1 1014.4 1027.8 18939.9 19261.2 19792.7 19986.4 20119.7 1017.3 1036.1 1037.5 1070.9 1091.2 10418.6 11135.5 11173.6 11255.8 11268.6 530597.0 531928.0 541261.0 541854.0 553460.0 90966.5 94059.0 94484.0 99252.5 100368.5 1034.8 1051.3 1072.1 1083.9 1087.2 16154.6 18522.2 18533.3 18740.0 18745.9 45951.5 45986.0 48612.8 48691.0 49604.3 69093.0 69231.0 69734.7 69857.3 70196.6 8878.0 8920.0 8940.5 9054.5 9077.5 10414.5 13828.0 14035.4 14048.6 14117.2 11737.9 12212.7 12311.2 12324.5 12334.1 11794.5 11998.3 12046.1 12116.4 12264.8 11934.6 12158.8 12212.8 12228.4 12268.6 8923.5 8950.2 8969.4 9017.7 9080.3 9319.8 11752.8 11765.8 11933.7 12281.4 13:48:07 INFO - PROCESS | 12926 | 13:48:07 INFO - PROCESS | 12926 | [#3] mootools.html Cycles:180 Average:6283.04 Median:4806.08 stddev:3630.90 (75.5%) stddev-sans-first:3623.39 13:48:07 INFO - PROCESS | 12926 | Values: 1513.1 1556.4 1732.7 1850.6 1870.4 8604.3 9047.9 9209.9 9976.1 9983.2 8641.0 8829.1 9016.2 9021.3 9043.9 2481.4 2510.4 2525.9 2527.9 2529.4 2429.7 2494.6 2496.7 2508.3 2517.5 2458.4 2478.4 2502.3 2504.8 2520.0 2382.2 2392.6 2393.4 2407.3 2425.1 2412.0 2419.5 2421.3 2421.4 2462.1 9616.7 9643.9 9664.6 9745.7 9776.0 5580.5 5706.9 5738.1 5738.2 5752.7 3586.5 3707.3 3761.9 3773.0 3792.3 1238.2 1305.3 1318.6 1321.4 1336.2 12988.2 13375.2 13421.5 13446.9 13911.0 4766.6 4845.6 4918.7 4919.8 5052.6 11573.7 11623.9 11626.9 11640.7 11676.4 5619.4 5623.4 5634.0 5651.7 5659.7 4595.3 5036.5 5089.1 5110.8 5167.5 4264.2 4365.6 4384.1 4410.4 4428.1 1311.8 1380.2 1381.4 1389.7 1390.7 899.5 989.6 1017.8 1040.1 1046.0 6286.7 6287.4 6439.8 6472.4 6514.7 474.9 485.8 486.3 494.0 499.9 4170.0 4234.2 4245.5 4256.8 4261.7 11524.8 11905.6 11929.4 11951.8 11977.7 11376.1 11782.8 11835.7 11896.0 11931.0 8320.8 8734.4 8738.7 8743.0 8762.3 6515.8 6586.6 6623.8 6734.2 6820.9 10735.5 10946.0 11050.2 11094.4 11274.8 11394.4 11400.8 11433.7 11503.9 11562.7 8394.3 8484.0 8501.8 8575.9 8577.5 9048.8 9214.4 9255.8 9256.8 9259.1 8277.2 8341.1 8343.7 8485.4 8489.6 8069.6 8148.2 8235.0 8333.6 8450.6 7681.0 7687.0 7766.1 7771.8 7777.1 5524.1 5721.3 5848.8 5857.8 5885.5 5598.6 5713.3 5739.1 5802.0 5837.1 13:48:07 INFO - PROCESS | 12926 | 13:48:07 INFO - PROCESS | 12926 | [#4] prototype.html Cycles:180 Average:5130.86 Median:5873.99 stddev:1531.00 (26.1%) stddev-sans-first:1492.55 13:48:07 INFO - PROCESS | 12926 | Values: 344.4 348.0 349.2 349.9 353.4 5724.2 5900.9 5909.0 5910.3 5957.1 5777.9 5794.9 5796.8 5803.2 5855.7 4115.8 4468.4 4485.1 4489.9 4502.1 4477.6 4491.8 4526.1 4531.0 4532.3 4451.9 4467.8 4497.3 4497.5 4526.0 4267.0 4460.6 4463.2 4473.8 4481.9 3908.6 3921.3 3939.5 3941.2 3948.3 5638.7 5659.7 5717.7 5718.6 5751.7 4979.2 5147.9 5168.2 5171.8 5200.1 6026.7 6032.6 6038.5 6116.9 6163.0 4203.7 4339.5 4369.5 4376.1 4400.6 6281.4 6291.8 6300.7 6302.7 6310.5 4387.3 4401.1 4407.3 4419.5 4426.0 4288.5 4442.6 4449.7 4460.5 4462.1 5075.6 5084.7 5089.7 5090.6 5116.0 6042.2 6043.9 6095.7 6153.3 6167.4 1532.6 1533.3 1557.9 1559.4 1565.6 964.4 965.0 1031.4 1059.7 1061.8 5845.4 5860.6 5866.0 5871.4 5902.6 6081.5 6145.3 6147.5 6218.5 6228.1 5695.2 5855.6 5876.6 5881.7 5914.8 3283.2 3290.3 3302.1 3310.0 3320.3 6161.9 6297.3 6349.5 6472.4 6555.8 6336.4 6396.4 6420.5 6431.8 6454.6 6320.4 6477.6 6503.7 6585.5 6590.7 6243.7 6275.3 6294.6 6300.1 6311.0 6190.9 6244.9 6254.8 6262.6 6301.9 6388.0 6492.1 6497.6 6506.5 6527.6 4384.0 4384.0 4404.8 4420.7 4440.8 6241.8 6330.2 6341.0 6354.9 6386.2 6156.4 6158.4 6190.4 6195.6 6212.8 5881.8 6136.9 6139.5 6169.0 6197.3 5836.6 6026.6 6044.8 6075.4 6108.2 6170.8 6208.6 6210.1 6226.0 6245.3 5928.3 6073.8 6076.7 6082.7 6089.9 13:48:07 INFO - PROCESS | 12926 | 13:48:07 INFO - PROCESS | 12926 | [#5] yui.html Cycles:180 Average:23377.54 Median:23472.21 stddev:34826.97 (148.4%) stddev-sans-first:34883.43 13:48:07 INFO - PROCESS | 12926 | Values: 807.5 843.3 876.6 903.4 932.5 16439.3 16642.0 17736.0 18130.2 18192.8 16331.7 16359.8 16373.6 16394.1 16516.8 857.8 859.7 872.3 876.4 876.5 839.5 870.4 872.2 873.5 876.1 932.9 934.0 937.2 939.0 939.6 931.7 935.8 938.7 942.5 943.8 684.0 685.1 685.7 689.0 690.4 15445.6 15459.8 15480.5 15513.7 15534.7 15749.8 15878.8 16114.8 16137.6 16310.7 13051.2 13334.7 13535.2 13596.7 13969.2 4006.1 4010.7 4063.2 4091.2 4147.0 90425.0 91920.0 92538.0 92970.0 93566.0 12346.1 12406.9 12643.1 12644.9 12706.0 23397.2 23408.9 23414.3 23433.0 23511.4 9303.2 9365.8 9383.5 9606.1 9683.1 5197.6 5266.1 5418.5 5449.9 5570.8 3898.6 3987.9 4017.4 4031.6 4038.0 696.4 699.5 707.6 721.1 725.0 643.9 802.4 810.4 815.3 836.8 10022.5 10817.1 11561.0 11729.1 11759.5 772.9 783.2 790.1 790.8 811.4 4944.6 5196.9 5275.6 5335.4 5379.4 126785.0 132452.0 135466.0 138273.3 139380.0 79078.0 82989.6 112847.0 120927.0 123577.0 99056.5 102729.5 105337.0 105374.5 105637.5 10105.4 10132.8 10209.6 10224.2 10329.5 56220.4 56240.0 57244.7 58182.7 60010.7 78723.0 88845.6 89735.6 89875.6 91215.0 12339.1 12382.8 12576.4 12901.7 12939.3 14834.1 14859.2 14881.0 14887.6 14914.0 12914.6 12918.2 12924.0 13099.3 13188.1 13455.9 13485.1 13505.7 13674.9 14210.6 13820.4 13985.8 14127.6 14347.4 14707.3 10455.5 10528.5 10756.0 10814.1 11063.7 10820.9 11155.8 11247.6 11324.6 11334.0 13:48:07 INFO - PROCESS | 12926 | -------- Summary: end -------- 13:48:07 INFO - PROCESS | 12926 | 13:48:07 INFO - TEST-INFO | 12926: exit 0 13:48:07 INFO - TEST-OK | dromaeo_css | took 1111554ms 13:48:07 INFO - TEST-START | kraken 13:48:07 INFO - operating with platform_type : linux_ 13:48:07 INFO - Initialising browser for kraken test... 13:48:07 INFO - TEST-INFO | started process 13192 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplIJyBa/profile http://localhost:60726/getInfo.html) 13:48:12 INFO - PROCESS | 13192 | __metrics Screen width/height:1600/1200 13:48:12 INFO - PROCESS | 13192 | colorDepth:24 13:48:12 INFO - PROCESS | 13192 | Browser inner width/height: 1024/697 13:48:12 INFO - PROCESS | 13192 | __metrics 13:48:13 ERROR - PROCESS | 13192 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 13:48:14 INFO - TEST-INFO | 13192: exit 0 13:48:14 INFO - Browser initialized. 13:48:14 INFO - Running cycle 1/1 for kraken test... 13:48:14 INFO - TEST-INFO | started process 13317 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplIJyBa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:48:26 INFO - PROCESS | 13317 | RSS: Main: 152641536 13:48:26 INFO - PROCESS | 13317 | 13:48:28 INFO - PROCESS | 13317 | Cycle 1(1): loaded http://localhost:60726/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60726/tests/kraken/driver.html?testName=audio-beat-detection) 13:48:29 INFO - PROCESS | 13317 | RSS: Main: 157990912 13:48:29 INFO - PROCESS | 13317 | 13:48:32 INFO - PROCESS | 13317 | Cycle 1(1): loaded http://localhost:60726/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60726/tests/kraken/driver.html?testName=audio-dft) 13:48:32 INFO - PROCESS | 13317 | RSS: Main: 155897856 13:48:32 INFO - PROCESS | 13317 | 13:48:35 INFO - PROCESS | 13317 | Cycle 1(1): loaded http://localhost:60726/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60726/tests/kraken/driver.html?testName=audio-fft) 13:48:36 INFO - PROCESS | 13317 | RSS: Main: 157110272 13:48:36 INFO - PROCESS | 13317 | 13:48:38 INFO - PROCESS | 13317 | Cycle 1(1): loaded http://localhost:60726/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60726/tests/kraken/driver.html?testName=audio-oscillator) 13:48:38 INFO - PROCESS | 13317 | RSS: Main: 156536832 13:48:38 INFO - PROCESS | 13317 | 13:48:41 INFO - PROCESS | 13317 | Cycle 1(1): loaded http://localhost:60726/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60726/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:48:41 INFO - PROCESS | 13317 | RSS: Main: 156446720 13:48:41 INFO - PROCESS | 13317 | 13:48:44 INFO - PROCESS | 13317 | Cycle 1(1): loaded http://localhost:60726/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60726/tests/kraken/driver.html?testName=imaging-darkroom) 13:48:45 INFO - PROCESS | 13317 | RSS: Main: 156622848 13:48:45 INFO - PROCESS | 13317 | 13:48:48 INFO - PROCESS | 13317 | Cycle 1(1): loaded http://localhost:60726/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60726/tests/kraken/driver.html?testName=imaging-desaturate) 13:48:49 INFO - PROCESS | 13317 | RSS: Main: 156209152 13:48:49 INFO - PROCESS | 13317 | 13:48:52 INFO - PROCESS | 13317 | Cycle 1(1): loaded http://localhost:60726/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60726/tests/kraken/driver.html?testName=json-parse-financial) 13:48:52 INFO - PROCESS | 13317 | RSS: Main: 158060544 13:48:52 INFO - PROCESS | 13317 | 13:48:54 INFO - PROCESS | 13317 | Cycle 1(1): loaded http://localhost:60726/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60726/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:48:55 INFO - PROCESS | 13317 | RSS: Main: 157499392 13:48:55 INFO - PROCESS | 13317 | 13:48:56 INFO - PROCESS | 13317 | Cycle 1(1): loaded http://localhost:60726/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60726/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:48:57 INFO - PROCESS | 13317 | RSS: Main: 156585984 13:48:57 INFO - PROCESS | 13317 | 13:48:59 INFO - PROCESS | 13317 | Cycle 1(1): loaded http://localhost:60726/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60726/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:49:00 INFO - PROCESS | 13317 | RSS: Main: 157224960 13:49:00 INFO - PROCESS | 13317 | 13:49:02 INFO - PROCESS | 13317 | Cycle 1(1): loaded http://localhost:60726/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60726/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:49:03 INFO - PROCESS | 13317 | RSS: Main: 157462528 13:49:03 INFO - PROCESS | 13317 | 13:49:06 INFO - PROCESS | 13317 | Cycle 1(1): loaded http://localhost:60726/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60726/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:49:06 INFO - PROCESS | 13317 | RSS: Main: 157888512 13:49:06 INFO - PROCESS | 13317 | 13:49:08 INFO - PROCESS | 13317 | Cycle 1(1): loaded http://localhost:60726/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60726/tests/kraken/driver.html?testName=ai-astar) 13:49:08 INFO - PROCESS | 13317 | RSS: Main: 158806016 13:49:08 INFO - PROCESS | 13317 | 13:49:08 INFO - PROCESS | 13317 | __start_tp_report 13:49:08 INFO - PROCESS | 13317 | _x_x_mozilla_page_load 13:49:08 INFO - PROCESS | 13317 | _x_x_mozilla_page_load_details 13:49:08 INFO - PROCESS | 13317 | |i|pagename|runs| 13:49:08 INFO - PROCESS | 13317 | |0;ai-astar;102;112;104;112;112;111;112;110;112;112 13:49:08 INFO - PROCESS | 13317 | |1;audio-beat-detection;148;115;154;173;118;141;143;128;181;115 13:49:08 INFO - PROCESS | 13317 | |2;audio-dft;163;163;162;162;163;164;163;162;163;173 13:49:08 INFO - PROCESS | 13317 | |3;audio-fft;77;75;76;184;76;77;77;76;163;75 13:49:08 INFO - PROCESS | 13317 | |4;audio-oscillator;83;84;151;85;84;84;138;84;84;155 13:49:08 INFO - PROCESS | 13317 | |5;imaging-gaussian-blur;117;118;117;118;117;121;118;118;118;117 13:49:08 INFO - PROCESS | 13317 | |6;imaging-darkroom;148;149;149;148;147;147;149;148;147;148 13:49:08 INFO - PROCESS | 13317 | |7;imaging-desaturate;95;95;97;96;96;95;95;96;95;94 13:49:08 INFO - PROCESS | 13317 | |8;json-parse-financial;53;52;52;52;54;53;52;52;54;53 13:49:08 INFO - PROCESS | 13317 | |9;json-stringify-tinderbox;61;64;60;59;59;59;58;58;59;59 13:49:08 INFO - PROCESS | 13317 | |10;stanford-crypto-aes;73;73;73;78;74;72;72;73;76;81 13:49:08 INFO - PROCESS | 13317 | |11;stanford-crypto-ccm;133;124;126;119;138;122;128;122;158;118 13:49:08 INFO - PROCESS | 13317 | |12;stanford-crypto-pbkdf2;159;156;155;151;151;151;153;150;157;153 13:49:08 INFO - PROCESS | 13317 | |13;stanford-crypto-sha256-iterative;64;61;62;61;62;62;60;64;64;61 13:49:08 INFO - PROCESS | 13317 | __end_tp_report 13:49:08 INFO - PROCESS | 13317 | __start_cc_report 13:49:08 INFO - PROCESS | 13317 | _x_x_mozilla_cycle_collect,872 13:49:08 INFO - PROCESS | 13317 | __end_cc_report 13:49:08 INFO - PROCESS | 13317 | __startTimestamp1471294148540__endTimestamp 13:49:08 INFO - PROCESS | 13317 | 13:49:08 INFO - PROCESS | 13317 | ------- Summary: start ------- 13:49:08 INFO - PROCESS | 13317 | Number of tests: 14 13:49:08 INFO - PROCESS | 13317 | 13:49:08 INFO - PROCESS | 13317 | [#0] ai-astar Cycles:10 Average:109.90 Median:112.00 stddev:3.73 (3.3%) stddev-sans-first:2.64 13:49:08 INFO - PROCESS | 13317 | Values: 102.0 112.0 104.0 112.0 112.0 111.0 112.0 110.0 112.0 112.0 13:49:08 INFO - PROCESS | 13317 | 13:49:08 INFO - PROCESS | 13317 | [#1] audio-beat-detection Cycles:10 Average:141.60 Median:145.50 stddev:23.32 (16.0%) stddev-sans-first:24.61 13:49:08 INFO - PROCESS | 13317 | Values: 148.0 115.0 154.0 173.0 118.0 141.0 143.0 128.0 181.0 115.0 13:49:08 INFO - PROCESS | 13317 | 13:49:08 INFO - PROCESS | 13317 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.00 stddev:3.29 (2.0%) stddev-sans-first:3.48 13:49:08 INFO - PROCESS | 13317 | Values: 163.0 163.0 162.0 162.0 163.0 164.0 163.0 162.0 163.0 173.0 13:49:08 INFO - PROCESS | 13317 | 13:49:08 INFO - PROCESS | 13317 | [#3] audio-fft Cycles:10 Average:95.60 Median:76.00 stddev:41.36 (54.4%) stddev-sans-first:43.32 13:49:08 INFO - PROCESS | 13317 | Values: 77.0 75.0 76.0 184.0 76.0 77.0 77.0 76.0 163.0 75.0 13:49:08 INFO - PROCESS | 13317 | 13:49:08 INFO - PROCESS | 13317 | [#4] audio-oscillator Cycles:10 Average:103.20 Median:84.00 stddev:31.20 (37.1%) stddev-sans-first:32.23 13:49:08 INFO - PROCESS | 13317 | Values: 83.0 84.0 151.0 85.0 84.0 84.0 138.0 84.0 84.0 155.0 13:49:08 INFO - PROCESS | 13317 | 13:49:08 INFO - PROCESS | 13317 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:1.20 (1.0%) stddev-sans-first:1.22 13:49:08 INFO - PROCESS | 13317 | Values: 117.0 118.0 117.0 118.0 117.0 121.0 118.0 118.0 118.0 117.0 13:49:08 INFO - PROCESS | 13317 | 13:49:08 INFO - PROCESS | 13317 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 13:49:08 INFO - PROCESS | 13317 | Values: 148.0 149.0 149.0 148.0 147.0 147.0 149.0 148.0 147.0 148.0 13:49:08 INFO - PROCESS | 13317 | 13:49:08 INFO - PROCESS | 13317 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.84 (0.9%) stddev-sans-first:0.88 13:49:08 INFO - PROCESS | 13317 | Values: 95.0 95.0 97.0 96.0 96.0 95.0 95.0 96.0 95.0 94.0 13:49:08 INFO - PROCESS | 13317 | 13:49:08 INFO - PROCESS | 13317 | [#8] json-parse-financial Cycles:10 Average:52.70 Median:53.00 stddev:0.82 (1.6%) stddev-sans-first:0.87 13:49:08 INFO - PROCESS | 13317 | Values: 53.0 52.0 52.0 52.0 54.0 53.0 52.0 52.0 54.0 53.0 13:49:08 INFO - PROCESS | 13317 | 13:49:08 INFO - PROCESS | 13317 | [#9] json-stringify-tinderbox Cycles:10 Average:59.60 Median:59.00 stddev:1.78 (3.0%) stddev-sans-first:1.81 13:49:08 INFO - PROCESS | 13317 | Values: 61.0 64.0 60.0 59.0 59.0 59.0 58.0 58.0 59.0 59.0 13:49:08 INFO - PROCESS | 13317 | 13:49:08 INFO - PROCESS | 13317 | [#10] stanford-crypto-aes Cycles:10 Average:74.50 Median:73.50 stddev:2.95 (4.0%) stddev-sans-first:3.08 13:49:08 INFO - PROCESS | 13317 | Values: 73.0 73.0 73.0 78.0 74.0 72.0 72.0 73.0 76.0 81.0 13:49:08 INFO - PROCESS | 13317 | 13:49:08 INFO - PROCESS | 13317 | [#11] stanford-crypto-ccm Cycles:10 Average:128.80 Median:127.00 stddev:11.98 (9.4%) stddev-sans-first:12.61 13:49:08 INFO - PROCESS | 13317 | Values: 133.0 124.0 126.0 119.0 138.0 122.0 128.0 122.0 158.0 118.0 13:49:08 INFO - PROCESS | 13317 | 13:49:08 INFO - PROCESS | 13317 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.60 Median:154.00 stddev:3.03 (2.0%) stddev-sans-first:2.50 13:49:08 INFO - PROCESS | 13317 | Values: 159.0 156.0 155.0 151.0 151.0 151.0 153.0 150.0 157.0 153.0 13:49:08 INFO - PROCESS | 13317 | 13:49:08 INFO - PROCESS | 13317 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.10 Median:62.00 stddev:1.45 (2.3%) stddev-sans-first:1.36 13:49:08 INFO - PROCESS | 13317 | Values: 64.0 61.0 62.0 61.0 62.0 62.0 60.0 64.0 64.0 61.0 13:49:08 INFO - PROCESS | 13317 | -------- Summary: end -------- 13:49:08 INFO - PROCESS | 13317 | 13:49:09 INFO - TEST-INFO | 13317: exit 0 13:49:09 INFO - TEST-OK | kraken | took 61558ms 13:49:09 INFO - SUITE-END | took 1173s 13:49:09 INFO - Completed test suite (00:19:33) 13:49:09 INFO - javascript benchmark 13:49:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7793.978984851366, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3383.204946837493, 3415.026717385545, 3418.3163367326542, 3423.8972830815082, 3441.8967430977063, 5853.619514731539, 5955.2853657561045, 5959.523238140949, 5965.701714914258, 5977.82066538004, 5853.268341457318, 5908.379620139888, 5909.320428150753, 5915.556333275011, 5925.762969481227, 5314.5216930476345, 5333.679979201261, 5340.839774806743, 5397.082495975694, 5439.265699130607, 5241.161414173733, 5246.554042906358, 5278.1291086970605, 5298.337707786527, 5303.337082864642, 5344.893102137955, 5393.083175860113, 5394.32570928634, 5396.865078373053, 5422.783088676449, 5373.005993891143, 5389.9191512127345, 5392.487713667196, 5392.865178370533, 5395.406505284415, 5167.819126330598, 5198.2722418861385, 5217.895642087137, 5300.602454815904, 5401.540869026137, 5813.331466881321, 5885.205497257858, 5891.499222566087, 5893.145493903403, 5919.5560332974765, 6271.843203919893, 6309.968450157719, 6340.3659634036685, 6342.524310676671, 6348.873022539569, 6118.082287656843, 6120.877582448326, 6378.77674281398, 6379.617222966637, 6387.233531976146, 5711.114777209539, 5812.273465816773, 5820.708964551798, 5843.590948633598, 5843.824685259449, 6298.212723409574, 6301.873962520815, 6339.714712837934, 6355.936440635627, 6362.0774987627465, 5994.100884867217, 6122.479589234876, 6124.74712746768, 6130.785422510191, 6145.508359331243, 6226.0, 6365.554411191172, 6376.426121649074, 6403.103565500834, 6407.903881441782, 6337.65142917144, 6355.586886852339, 6366.458850997625, 6374.872502549923, 6389.6805159741825, 6070.7875224366935, 6152.538559608047, 6365.267994180728, 6371.872562548723, 6386.0, 4731.4795372509, 4790.754403854953, 4791.592714619296, 4816.759162041884, 4819.759012049383, 4245.150969806051, 4254.446921900133, 4262.808173632194, 4270.380794784801, 4305.4187684662165, 5855.121731740188, 5887.499562537232, 6003.699815009232, 6057.575969682168, 6059.272887253558, 6268.874622507525, 6401.3278605746655, 6414.03789431589, 6425.132607098076, 6439.227292724903, 6102.877942441126, 6108.755649774048, 6113.786017489456, 6132.724027418777, 6134.9079763803575, 5302.867428314323, 5373.167159090269, 5480.0, 5480.04099282624, 5543.972280138573, 6457.418832305021, 6609.471242300604, 6631.10480085192, 6640.468762498988, 6648.368405001517, 6348.269948955929, 6383.265924418752, 6412.9358706414205, 6417.550771445954, 6426.742930282736, 6382.489400848014, 6394.0, 6544.116544266653, 6545.116409284686, 6628.337166283333, 6140.710450805381, 6270.090836828543, 6272.435480806749, 6275.278342990615, 6285.434310911857, 6346.428821406095, 6372.267189273108, 6396.232452105777, 6409.359064093554, 6409.391107844747, 6092.390760923872, 6109.495762817309, 6245.219347581552, 6249.625022498664, 6252.624842509464, 6113.2969708482315, 6157.89157951573, 6175.197224360804, 6228.0, 6233.5636505446, 6130.080487926668, 6152.107944347955, 6175.919214137598, 6191.783287584913, 6200.286966998853, 5991.041433370814, 6116.487945662109, 6184.690765461619, 6281.654509001866, 6308.08532762756, 6012.0, 6127.080937859357, 6131.534031361382, 6144.324124346408, 6145.6927153641245], "value": 5819.320358208882, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.8957987562239, 640.9935900640994, 654.3718030690534, 658.1707049118111, 703.3529153179074, 43799.343009854834, 47883.0, 48021.759891200585, 48404.0, 48463.75768121159, 47782.76108619452, 48276.51723482764, 48360.51639483604, 48392.27411588829, 48416.515834841644, 9161.26709863211, 9207.95396023019, 9242.02958689338, 9273.0, 9289.860652090225, 9284.860727089099, 9287.257019438463, 9348.57931393089, 9351.158395744382, 9361.906380936205, 9399.671011514598, 9419.29355298352, 9434.528273586327, 9448.527573621326, 9482.0, 9354.06459354066, 9367.110124538192, 9373.250139988784, 9375.859362109573, 9418.811623767555, 9299.674511392137, 9334.019927907608, 9345.345825792198, 9353.158215760546, 9362.719118426457, 44917.32624010643, 45247.32129018068, 45324.77337613291, 45349.0, 45378.0, 3310.702036816698, 3699.9445008324897, 3704.629537046301, 3807.847686092553, 3830.157365379612, 33800.83099584511, 33810.154746131295, 34059.659403405894, 34068.659313406795, 34409.0, 4617.561331673519, 4633.837815676435, 4634.837780677693, 4651.2557990721325, 4667.439907211123, 333962.0, 334604.0, 337052.0, 337817.0, 338926.0, 40225.0, 40342.39486407706, 40461.19077618431, 40489.79755101265, 40510.0, 38981.22037559289, 39084.21831563353, 39848.80075599661, 41288.0, 43031.35452968208, 16290.0, 16506.917465412596, 16528.338866445447, 16556.42052528156, 16594.75107873383, 13272.800907986388, 13487.865121348857, 13512.256825874474, 13532.661683457993, 13564.0, 21353.78646213549, 21441.67837482439, 21444.142234310766, 21499.355019349445, 21529.67705484419, 7474.289942455458, 7684.846303073908, 7715.22847715224, 7827.804304892423, 7832.725854595175, 1027.1320733979776, 1093.1746531368765, 1147.1281825812443, 1159.686884541169, 1168.696139003865, 34048.829755851555, 34530.82734586311, 34698.47952280718, 34727.47908781371, 34740.47889281663, 1174.266083697689, 1201.6635342104225, 1218.1959906461693, 1270.555305643036, 1303.4069498378215, 17516.299348025936, 18367.35714249995, 18547.25810967573, 19381.709274360896, 19699.21203151858, 397276.0, 546873.0, 553696.0, 553765.0, 555051.0, 64997.67501162464, 65470.67264663742, 65687.34312656813, 65712.67143664251, 65722.67138664276, 1424.4159894443228, 1435.7559214933488, 1457.511733569245, 1466.0690461556987, 1469.5003698742264, 32292.677073228966, 34230.0, 34492.82753586216, 34943.65056349404, 35006.64993350034, 56420.43579564152, 57326.7133664329, 57383.0, 57486.425135748104, 57512.0, 533222.0, 534683.0, 534867.0, 535174.0, 535342.0, 31204.843975779975, 31206.375872482877, 31216.21959450941, 31335.529967050967, 31432.528512072793, 53764.462355375945, 53938.0, 54014.0, 54050.45949540612, 54203.0, 44950.0, 45152.774236129924, 45339.54660453485, 46181.0, 47158.0, 43781.0, 44879.0, 45250.32124518201, 45777.0, 46383.76808115938, 45704.0, 46024.30963535616, 46126.0, 46159.0, 49151.50848491612, 38640.22719545537, 39609.80195099006, 40213.0, 41207.96980075522, 41968.79015604902, 30311.0, 30874.228144296572, 31378.686213137575, 31493.8425307872, 31888.202794930312], "value": 21168.122744899967, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.9140184860256, 405.36560283156837, 414.9522804877438, 417.9707420480566, 426.726894787336, 14413.207273599948, 18551.0, 19391.903040484776, 19917.800821991794, 19934.501637459052, 19473.902630486864, 19490.0, 19658.311959081435, 19732.802671973313, 19885.005749712527, 5771.422857714237, 5812.593118481708, 5859.824205273849, 5897.439743224387, 5936.198613187207, 5857.238558987326, 5928.7332070056955, 5929.584929054968, 5941.524678025748, 5941.584089113764, 5699.886002279952, 5811.709414529278, 5837.211976383198, 5845.56158288128, 5880.147378630096, 5808.912866307009, 5821.27234095738, 5823.039198532237, 5830.183774271605, 5836.6789826559525, 5215.765290561933, 5232.581393488512, 5248.685078895279, 5257.185136303879, 5263.973680131613, 22980.77019229803, 23241.883790580938, 23528.29415117532, 23635.172768953005, 23796.0, 2552.4767422678306, 2580.664513613237, 2589.3656054266826, 2675.357914100621, 2724.0738149029426, 14671.33978970949, 14884.0, 14995.925020374938, 15088.471903483325, 15431.691366172727, 1676.3546034776577, 1916.463390250718, 2042.1831267492973, 2077.6468000439963, 2102.5899949509853, 87292.56353718191, 87811.0, 88942.99999999936, 89039.0, 89842.0, 11236.269642473213, 11270.380129092815, 11304.321740695585, 11485.71285717847, 11678.124140689482, 15339.463118791013, 15382.538523844303, 15441.768373474408, 15459.381624734884, 15476.613084672748, 8339.708110216114, 8495.192956669107, 8515.659373625109, 8591.226789588842, 8640.222379985831, 8029.4379393441895, 8046.637901294339, 8151.633176507072, 8339.20777526134, 8446.493210407396, 4783.736894470768, 4852.393450818648, 4908.11653902301, 4918.680285781413, 4960.975195124001, 2049.4978730210896, 2060.1862264405477, 2069.3998740365428, 2078.5323302257175, 2097.297405369188, 905.6015353244551, 1001.5543083327849, 1008.0826447932346, 1014.4065721552827, 1027.8406846938738, 18939.90530047341, 19261.22955081809, 19792.70310945337, 19986.400407987785, 20119.698204526943, 1017.2624846985876, 1036.0727149201573, 1037.5382954585289, 1070.855434516346, 1091.2034215022918, 10418.635347762793, 11135.498902549405, 11173.553057877756, 11255.831162532568, 11268.605598804003, 530597.0, 531928.0, 541261.0, 541854.0, 553460.0, 90966.54516727374, 94059.0, 94484.00265831247, 99252.5037374823, 100368.49815750874, 1034.7620047388991, 1051.321897376188, 1072.0994364733506, 1083.864516935383, 1087.228068071678, 16154.596135096717, 18522.166502507687, 18533.258669653602, 18740.0, 18745.90627046856, 45951.54048459473, 45986.0, 48612.75693621509, 48691.0, 49604.25593616026, 69093.0, 69231.0, 69734.65132674304, 69857.3014269871, 70196.64901675664, 8877.955610222167, 8919.955400222958, 8940.5082720451, 9054.456732596065, 9077.45535267886, 10414.479276036016, 13828.0, 14035.36840842185, 14048.578542643738, 14117.2235527047, 11737.941310293394, 12212.694682633006, 12311.19977201479, 12324.50701971911, 12334.136610437183, 11794.469248883992, 11998.340091294713, 12046.096542759153, 12116.394180290774, 12264.816027759769, 11934.641960741192, 12158.817617735918, 12212.755744884875, 12228.449719762453, 12268.631941041784, 8923.464592124494, 8950.194482496607, 8969.416987895765, 9017.684381046633, 9080.273578113603, 9319.813603728024, 11752.823707644564, 11765.823512647146, 11933.701657458285, 12281.447334869774], "value": 9673.616306027536, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1513.0845838267849, 1556.3541130430867, 1732.7487514310426, 1850.6021205440836, 1870.3827736846843, 8604.26863716585, 9047.864282035775, 9209.861852072225, 9976.102150806426, 9983.20134389248, 8640.96308442986, 8829.117088291168, 9016.233620142279, 9021.278297736182, 9043.909560904389, 2481.4168670362496, 2510.3849556858504, 2525.9242222733255, 2527.936801579957, 2529.4435224250637, 2429.708434987795, 2494.638277449769, 2496.7128780190237, 2508.2726009457238, 2517.5216708825265, 2458.4468494588664, 2478.3680161558777, 2502.2868482482495, 2504.8121390895662, 2520.0045981837256, 2382.19005538117, 2392.629142482909, 2393.365758074112, 2407.2898494943856, 2425.0663494554724, 2411.9517609647883, 2419.4677171022345, 2421.32202983165, 2421.3946513371657, 2462.0890270599994, 9616.711498655051, 9643.855342169873, 9664.613415463373, 9745.707628771148, 9775.951120244425, 5580.525655319262, 5706.914396284017, 5738.139279108125, 5738.167965644958, 5752.741126649311, 3586.5337506124297, 3707.3326801175776, 3761.9247615047548, 3773.0001549589106, 3792.2984247914223, 1238.2322959764913, 1305.2560040776762, 1318.6110097521255, 1321.4383886848052, 1336.1515437697133, 12988.155769874928, 13375.19748815084, 13421.463141474329, 13446.93276533611, 13910.956678249071, 4766.594839438687, 4845.563899249014, 4918.6556941014505, 4919.77860996256, 5052.595792336604, 11573.710657233636, 11623.88376116228, 11626.941865290619, 11640.708982275342, 11676.357800320893, 5619.353774315924, 5623.437656234344, 5634.0, 5651.660900345993, 5659.717014149276, 4595.287730401793, 5036.496350365008, 5089.134847076006, 5110.770015349318, 5167.483251674803, 4264.189803937242, 4365.628921541641, 4384.101259241847, 4410.3825464435, 4428.070105277928, 1311.799703271515, 1380.2132784313046, 1381.412899517701, 1389.6942672612008, 1390.707951330232, 899.5457294066586, 989.6288891665625, 1017.765913839821, 1040.0535512683573, 1045.9790804184026, 6286.685665716695, 6287.402696743802, 6439.774607888701, 6472.385123413268, 6514.674266286666, 474.8860273534396, 485.8178183181307, 486.29972839112276, 493.9975300123476, 499.88502644391264, 4169.97915010423, 4234.174336004449, 4245.511766146933, 4256.7658778766845, 4261.701680882308, 11524.769504609862, 11905.583304584472, 11929.403529823474, 11951.76096478083, 11977.700557485958, 11376.089912806956, 11782.764344713058, 11835.704107397212, 11896.0, 11931.0, 8320.791980200422, 8734.388592798443, 8738.737837864874, 8743.0, 8762.255208307237, 6515.771947981798, 6586.637734924433, 6623.768168114286, 6734.22556406, 6820.863582728417, 10735.463226838783, 10946.0, 11050.226484146033, 11094.445277736242, 11274.774504510027, 11394.430278485877, 11400.828987565359, 11433.656990290305, 11503.884961150616, 11562.710932226762, 8394.328453723809, 8483.95758021206, 8501.829963400574, 8575.914240857512, 8577.528235947082, 9048.773780655536, 9214.401063930824, 9255.76860578491, 9256.768580785534, 9259.12038356382, 8277.172282771675, 8341.12418196105, 8343.666253349798, 8485.363597730318, 8489.575521224038, 8069.556174410229, 8148.22591853773, 8235.0, 8333.624986875726, 8450.619722112642, 7681.001469808889, 7686.961565192362, 7766.145723970471, 7771.766846994599, 7777.105632852295, 5524.06090964545, 5721.342045664635, 5848.824535263949, 5857.824265272048, 5885.470307672159, 5598.552115830642, 5713.257276554022, 5739.081746920473, 5802.0, 5837.09525023622], "value": 4923.824071094049, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.4007427076886, 348.030734404683, 349.19162139646716, 349.87579409309694, 353.3568904593641, 5724.198612194291, 5900.911486327708, 5908.970455147729, 5910.34986151523, 5957.136215248786, 5777.913331300034, 5794.884102317951, 5796.768359097861, 5803.245578074855, 5855.677937713424, 4115.773632450207, 4468.396766436522, 4485.0805584855025, 4489.865304040884, 4502.077074199781, 4477.619402350804, 4491.7754112294415, 4526.140033393661, 4530.954690453086, 4532.297493888453, 4451.910961780763, 4467.82128714851, 4497.257952437843, 4497.505274419811, 4525.954740452603, 4266.9999999999845, 4460.553944605546, 4463.152001119793, 4473.82104715811, 4481.8655440336515, 3908.5895980922164, 3921.274564205631, 3939.527256729182, 3941.1723538057045, 3948.2893079245723, 5638.661680299154, 5659.717014149317, 5717.714114294268, 5718.628289161191, 5751.654900705971, 4979.1784355581285, 5147.922781158286, 5168.22476628505, 5171.818986335498, 5200.141976573861, 6026.6986650667295, 6032.607880487798, 6038.516918646497, 6116.908246376308, 6163.0, 4203.726757760766, 4339.457567804025, 4369.497507786614, 4376.124775045004, 4400.603945644875, 6281.371862813728, 6291.7797877074545, 6300.747970081191, 6302.653354065525, 6310.463610593105, 4387.254166791653, 4401.097774956191, 4407.2507673695545, 4419.535948725402, 4425.977870110629, 4288.463942007249, 4442.644588432918, 4449.688521803443, 4460.531644177379, 4462.085272519126, 5075.56857667095, 5084.745762711849, 5089.6691715038405, 5090.592752579785, 5116.0, 6042.154098426224, 6043.909341359883, 6095.6952152392205, 6153.261798499625, 6167.444929956326, 1532.601523603871, 1533.2640332640394, 1557.8753699703996, 1559.3840433029118, 1565.577294130601, 964.3924327673661, 964.9614015439445, 1031.4120951057826, 1059.7085801404676, 1061.75048863517, 5845.3570107289015, 5860.589758716934, 5865.970670146708, 5871.412858714094, 5902.58681892272, 6081.540430296697, 6145.262568491809, 6147.538934579835, 6218.471429928416, 6228.096925945712, 5695.202671625976, 5855.560832937546, 5876.559258055578, 5881.676507792027, 5914.822555323347, 3283.1627934876456, 3290.3090351026076, 3302.108430723691, 3309.9503507447407, 3320.2529430877858, 6161.938380616137, 6297.338779428094, 6349.492040636738, 6472.385123413268, 6555.80332590023, 6336.398042185985, 6396.392342727527, 6420.500827049269, 6431.839204019937, 6454.580452270588, 6320.4311611955145, 6477.57895736785, 6503.7073331700185, 6585.473162147016, 6590.670466476657, 6243.687815609111, 6275.341089185752, 6294.622322660655, 6300.117983482408, 6310.968445157929, 6190.889934186231, 6244.875102498016, 6254.780317837978, 6262.624242545279, 6301.905471418024, 6387.968060159669, 6492.091107245084, 6497.642629655415, 6506.544541882212, 6527.5757075789925, 4383.978080109579, 4384.0, 4404.801783919667, 4420.723327486411, 4440.777961101868, 6241.843953901189, 6330.177076979963, 6341.03685196752, 6354.904676429765, 6386.179938717629, 6156.415140561639, 6158.414950579688, 6190.350013248544, 6195.566310358232, 6212.751489940351, 5881.823545293648, 6136.938630613637, 6139.508839292936, 6168.982117950488, 6197.25632924052, 5836.562257830595, 6026.578139530367, 6044.818655440344, 6075.362086980804, 6108.236470441195, 6170.753169873155, 6208.565400421927, 6210.130581718653, 6225.968870155621, 6245.250569931637, 5928.34788173292, 6073.817785466443, 6076.726547305293, 6082.695865206633, 6089.908651370321], "value": 4637.07703450945, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [807.4993504027503, 843.3253397282176, 876.6493402638945, 903.439867282285, 932.547714358536, 16439.2602332895, 16642.0, 17736.0, 18130.18414171362, 18192.818071819278, 16331.673366532663, 16359.83640163598, 16373.59066023347, 16394.09832459214, 16516.83483165168, 857.8455877941968, 859.6518410043911, 872.3457406944791, 876.3514998900799, 876.509154873273, 839.47532792005, 870.4298684361753, 872.2498651159997, 873.5108339329964, 876.0538618292229, 932.883389576303, 934.0379409208526, 937.1799675284126, 939.0468674295596, 939.5959737312953, 931.7065124485799, 935.7707361696393, 938.7277689470045, 942.5098948546718, 943.8348289049458, 683.9589624622539, 685.0717278088168, 685.7359916432159, 688.9758858439981, 690.4096997067485, 15445.613859653486, 15459.768103478344, 15480.458183963507, 15513.689726205526, 15534.689306213926, 15749.763753543706, 15878.761818572731, 16114.838851611452, 16137.596560085974, 16310.673786524321, 13051.21692698441, 13334.733305333935, 13535.18788872661, 13596.728065438636, 13969.161850289016, 4006.098627808749, 4010.7393019453643, 4063.2482990646827, 4091.1817636472824, 4146.958530414688, 90425.0, 91920.0, 92538.0, 92970.0, 93566.0, 12346.13577049598, 12406.937965310297, 12643.11498195136, 12644.873551264554, 12706.0, 23397.181098661466, 23408.882955585454, 23414.297571072893, 23433.0, 23511.41221469477, 9303.209227215762, 9365.812683746288, 9383.483908384967, 9606.087421694929, 9683.080107389787, 5197.558207552324, 5266.131088370453, 5418.45815418455, 5449.863753406196, 5570.832875013756, 3898.590647981978, 3987.900302492461, 4017.357222844331, 4031.5968403160036, 4037.9798101009897, 696.3558708195001, 699.5068476723898, 707.5895980331395, 721.1238345410247, 725.0103608574258, 643.856781610339, 802.4182467710863, 810.4003037752138, 815.2906970935325, 836.7908022994252, 10022.54898529568, 10817.080548153495, 11561.0, 11729.120315976335, 11759.529618815322, 772.9343005844567, 783.1933108897845, 790.1426951757408, 790.8339248757825, 811.3711873298123, 4944.629152813553, 5196.948030519722, 5275.57795376369, 5335.413104558495, 5379.408265090837, 126785.0, 132452.0, 135466.0, 138273.3086334582, 139380.0, 79078.0, 82989.58505207556, 112847.0, 120927.0, 123577.0, 99056.50471747595, 102729.48635256776, 105337.0, 105374.47312763387, 105637.47181264198, 10105.39367637944, 10132.79734405293, 10209.642662507074, 10224.1820654346, 10329.535170917477, 56220.43779562152, 56240.0, 57244.71377643085, 58182.7090864543, 60010.69994649999, 78723.0, 88845.55577222073, 89735.55132224558, 89875.55062224648, 91215.0, 12339.13626046168, 12382.75234495287, 12576.371181441074, 12901.741965160832, 12939.288339141438, 14834.10995340283, 14859.182744949132, 14881.0, 14887.627809304853, 14914.0, 12914.612561623166, 12918.22490650564, 12924.030697697899, 13099.279539625411, 13188.142770719873, 13455.932720336335, 13485.123466974615, 13505.662358441117, 13674.863251367358, 14210.644733881736, 13820.376003590165, 13985.8401447809, 14127.64680882986, 14347.35436905321, 14707.338169782599, 10455.462869982715, 10528.526216320437, 10756.0, 10814.134869210287, 11063.72340691489, 10820.89179108199, 11155.832662509907, 11247.550097995989, 11324.6036388726, 11334.0], "value": 8238.057106450837, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1506.6999999999996, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 104.0, 112.0, 112.0, 111.0, 112.0, 110.0, 112.0, 112.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 115.0, 154.0, 173.0, 118.0, 141.0, 143.0, 128.0, 181.0, 115.0], "value": 141.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 162.0, 163.0, 164.0, 163.0, 162.0, 163.0, 173.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 76.0, 184.0, 76.0, 77.0, 77.0, 76.0, 163.0, 75.0], "value": 95.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 151.0, 85.0, 84.0, 84.0, 138.0, 84.0, 84.0, 155.0], "value": 103.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 117.0, 121.0, 118.0, 118.0, 118.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 149.0, 148.0, 147.0, 147.0, 149.0, 148.0, 147.0, 148.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 94.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 52.0, 52.0, 54.0, 53.0, 52.0, 52.0, 54.0, 53.0], "value": 52.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 64.0, 60.0, 59.0, 59.0, 59.0, 58.0, 58.0, 59.0, 59.0], "value": 59.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 78.0, 74.0, 72.0, 72.0, 73.0, 76.0, 81.0], "value": 74.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 124.0, 126.0, 119.0, 138.0, 122.0, 128.0, 122.0, 158.0, 118.0], "value": 128.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 156.0, 155.0, 151.0, 151.0, 151.0, 153.0, 150.0, 157.0, 153.0], "value": 153.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 61.0, 62.0, 61.0, 62.0, 62.0, 60.0, 64.0, 64.0, 61.0], "value": 62.1, "unit": "score"}]}]} 13:49:09 INFO - Return code: 0 13:49:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:49:09 ERROR - # TBPL SUCCESS # 13:49:09 INFO - Running post-action listener: _resource_record_post_action 13:49:09 INFO - [mozharness: 2016-08-15 20:49:09.860608Z] Finished run-tests step (success) 13:49:09 INFO - Running post-run listener: _resource_record_post_run 13:49:09 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 286720; Write bytes: 324694016; Read time: 368; Write time: 225208 13:49:09 INFO - TinderboxPrint: CPU usage
13.2% 13:49:09 INFO - TinderboxPrint: I/O read bytes / time
286,720 / 368 13:49:09 INFO - TinderboxPrint: I/O write bytes / time
324,694,016 / 225,208 13:49:09 INFO - TinderboxPrint: CPU idle
8,231.6 (86.8%) 13:49:09 INFO - TinderboxPrint: CPU user
1,196.9 (12.6%) 13:49:09 INFO - TinderboxPrint: Swap in / out
0 / 0 13:49:09 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 8192; Write bytes: 78303232; Read time: 176; Write time: 78200 13:49:09 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 274432; Write bytes: 245116928; Read time: 180; Write time: 146964 13:49:10 INFO - Running post-run listener: _upload_blobber_files 13:49:10 INFO - Blob upload gear active. 13:49:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:49:10 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 13:49:10 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'] 13:49:10 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 13:49:10 INFO - (blobuploader) - INFO - Open directory for files ... 13:49:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:49:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:49:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:49:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:49:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:49:11 INFO - (blobuploader) - INFO - Done attempting. 13:49:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:49:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:49:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:49:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:49:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:49:15 INFO - (blobuploader) - INFO - Done attempting. 13:49:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:49:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:49:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:49:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:49:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:49:15 INFO - (blobuploader) - INFO - Done attempting. 13:49:15 INFO - (blobuploader) - INFO - Iteration through files over. 13:49:15 INFO - Return code: 0 13:49:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:49:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:49:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/32580ca2c277104ebe48fd04bc5cb6d6f4d340f85652e6289abf2f8fa4e05aedfe27b90fe5771be979a576a6c5b7b513be4dbb783dfe0fefd1ed87e7688a15b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4e1bf5d47fe735b7fda467c3131b6f258cebf9b38ddedb1ba14c88397cfb46c7219cc6088d9d9f54cc63dd5e5e22c63865a3d678429ab8f301f1962c5ec135e8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/232ce20277859444611b13ff6c284041cddb580b885029b7b15eb37bdd166192e59945dcbb5dfd7c1f88719f38244cb6ed826873188ce41f836ba9c152eca1de"} 13:49:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:49:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:49:15 INFO - Contents: 13:49:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/32580ca2c277104ebe48fd04bc5cb6d6f4d340f85652e6289abf2f8fa4e05aedfe27b90fe5771be979a576a6c5b7b513be4dbb783dfe0fefd1ed87e7688a15b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4e1bf5d47fe735b7fda467c3131b6f258cebf9b38ddedb1ba14c88397cfb46c7219cc6088d9d9f54cc63dd5e5e22c63865a3d678429ab8f301f1962c5ec135e8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/232ce20277859444611b13ff6c284041cddb580b885029b7b15eb37bdd166192e59945dcbb5dfd7c1f88719f38244cb6ed826873188ce41f836ba9c152eca1de"} 13:49:15 INFO - Running post-run listener: copy_logs_to_upload_dir 13:49:15 INFO - Copying logs to upload dir... 13:49:15 INFO - mkdir: /builds/slave/test/build/upload/logs 13:49:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1677.112477 ========= master_lag: -0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 57 secs) (at 2016-08-15 13:49:15.007203) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-15 13:49:15.010879) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1471292363.15098-1427898245 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/32580ca2c277104ebe48fd04bc5cb6d6f4d340f85652e6289abf2f8fa4e05aedfe27b90fe5771be979a576a6c5b7b513be4dbb783dfe0fefd1ed87e7688a15b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4e1bf5d47fe735b7fda467c3131b6f258cebf9b38ddedb1ba14c88397cfb46c7219cc6088d9d9f54cc63dd5e5e22c63865a3d678429ab8f301f1962c5ec135e8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/232ce20277859444611b13ff6c284041cddb580b885029b7b15eb37bdd166192e59945dcbb5dfd7c1f88719f38244cb6ed826873188ce41f836ba9c152eca1de"} build_url:https://queue.taskcluster.net/v1/task/WGaWHuEjTtG7qz5hSvKC1A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011413 build_url: 'https://queue.taskcluster.net/v1/task/WGaWHuEjTtG7qz5hSvKC1A/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/32580ca2c277104ebe48fd04bc5cb6d6f4d340f85652e6289abf2f8fa4e05aedfe27b90fe5771be979a576a6c5b7b513be4dbb783dfe0fefd1ed87e7688a15b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4e1bf5d47fe735b7fda467c3131b6f258cebf9b38ddedb1ba14c88397cfb46c7219cc6088d9d9f54cc63dd5e5e22c63865a3d678429ab8f301f1962c5ec135e8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/232ce20277859444611b13ff6c284041cddb580b885029b7b15eb37bdd166192e59945dcbb5dfd7c1f88719f38244cb6ed826873188ce41f836ba9c152eca1de"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-15 13:49:15.037188) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 13:49:15.037583) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1471292363.15098-1427898245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004405 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 13:49:15.122590) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-15 13:49:15.122906) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-15 13:49:15.123214) ========= ========= Total master_lag: 0.26 =========