builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-017 starttime: 1476811903.59 results: success (0) buildid: 20161018073421 builduid: 55238dae8d544f269eb61c99c41f23eb revision: edf1854ea77ebddca4a8ce78526d041aebb1a796 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-18 10:31:43.592641) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-18 10:31:43.593169) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-18 10:31:43.593605) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-18 10:31:43.613026) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 10:31:43.613395) ========= 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=0333a256a5e4f052382dd180000001b1-1476811776.911966-932705347 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-18 10:31:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 21.3M=0.001s 2016-10-18 10:31:43 (21.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122679 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 10:31:43.751214) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 10:31:43.751548) ========= 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=0333a256a5e4f052382dd180000001b1-1476811776.911966-932705347 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016122 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 10:31:43.803372) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 10:31:43.804007) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev edf1854ea77ebddca4a8ce78526d041aebb1a796 --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-beta --rev edf1854ea77ebddca4a8ce78526d041aebb1a796 --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=0333a256a5e4f052382dd180000001b1-1476811776.911966-932705347 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-18 10:31:43,840 truncating revision to first 12 chars 2016-10-18 10:31:43,840 Setting DEBUG logging. 2016-10-18 10:31:43,840 attempt 1/10 2016-10-18 10:31:43,840 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/edf1854ea77e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-18 10:31:44,187 unpacking tar archive at: mozilla-beta-edf1854ea77e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.742934 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 10:31:44.563645) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-18 10:31:44.563973) ========= script_repo_revision: edf1854ea77ebddca4a8ce78526d041aebb1a796 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-18 10:31:44.564374) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-18 10:31:44.564665) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-18 10:31:44.574081) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 0 secs) (at 2016-10-18 10:31:44.574477) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=0333a256a5e4f052382dd180000001b1-1476811776.911966-932705347 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:31:44 INFO - MultiFileLogger online at 20161018 10:31:44 in /builds/slave/test 10:31:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 10:31:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:31:44 INFO - {'append_to_log': False, 10:31:44 INFO - 'base_work_dir': '/builds/slave/test', 10:31:44 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:31:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:31:44 INFO - 'branch': 'Mozilla-Beta', 10:31:44 INFO - 'buildbot_json_path': 'buildprops.json', 10:31:44 INFO - 'config_files': ('talos/linux_config.py',), 10:31:44 INFO - 'default_actions': ('clobber', 10:31:44 INFO - 'read-buildbot-config', 10:31:44 INFO - 'download-and-extract', 10:31:44 INFO - 'populate-webroot', 10:31:44 INFO - 'create-virtualenv', 10:31:44 INFO - 'install', 10:31:44 INFO - 'run-tests'), 10:31:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:31:44 INFO - 'download_minidump_stackwalk': True, 10:31:44 INFO - 'download_symbols': 'ondemand', 10:31:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:31:44 INFO - 'tooltool.py': '/tools/tooltool.py', 10:31:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:31:44 INFO - '/tools/misc-python/virtualenv.py')}, 10:31:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:31:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:31:44 INFO - 'installer_path': 'installer.exe', 10:31:44 INFO - 'log_level': 'info', 10:31:44 INFO - 'log_name': 'talos', 10:31:44 INFO - 'log_to_console': True, 10:31:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:31:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:31:44 INFO - 'opt_config_files': (), 10:31:44 INFO - 'pip_index': False, 10:31:44 INFO - 'sps_profile': False, 10:31:44 INFO - 'sps_profile_interval': 0, 10:31:44 INFO - 'suite': 'dromaeojs-e10s', 10:31:44 INFO - 'system_bits': '32', 10:31:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:31:44 INFO - 'title': 'talos-linux64-ix-017', 10:31:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:31:44 INFO - 'use_talos_json': True, 10:31:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:31:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:31:44 INFO - 'work_dir': 'build'} 10:31:44 INFO - [mozharness: 2016-10-18 17:31:44.704828Z] Running clobber step. 10:31:44 INFO - Running pre-action listener: _resource_record_pre_action 10:31:44 INFO - Running main action method: clobber 10:31:44 INFO - rmtree: /builds/slave/test/build 10:31:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:31:45 INFO - Running post-action listener: _resource_record_post_action 10:31:45 INFO - [mozharness: 2016-10-18 17:31:45.160958Z] Finished clobber step (success) 10:31:45 INFO - [mozharness: 2016-10-18 17:31:45.161315Z] Running read-buildbot-config step. 10:31:45 INFO - Running pre-action listener: _resource_record_pre_action 10:31:45 INFO - Running main action method: read_buildbot_config 10:31:45 INFO - Using buildbot properties: 10:31:45 INFO - { 10:31:45 INFO - "project": "", 10:31:45 INFO - "product": "firefox", 10:31:45 INFO - "script_repo_revision": "production", 10:31:45 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 10:31:45 INFO - "repository": "", 10:31:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 10:31:45 INFO - "buildid": "20161018073421", 10:31:45 INFO - "pgo_build": "True", 10:31:45 INFO - "basedir": "/builds/slave/test", 10:31:45 INFO - "buildnumber": 289, 10:31:45 INFO - "slavename": "talos-linux64-ix-017", 10:31:45 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:31:45 INFO - "platform": "ubuntu64_hw", 10:31:45 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 10:31:45 INFO - "branch": "mozilla-beta", 10:31:45 INFO - "repo_path": "releases/mozilla-beta", 10:31:45 INFO - "revision": "edf1854ea77ebddca4a8ce78526d041aebb1a796", 10:31:45 INFO - "stage_platform": "linux64-pgo", 10:31:45 INFO - "builduid": "55238dae8d544f269eb61c99c41f23eb", 10:31:45 INFO - "slavebuilddir": "test" 10:31:45 INFO - } 10:31:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2. 10:31:45 INFO - Running post-action listener: _resource_record_post_action 10:31:45 INFO - [mozharness: 2016-10-18 17:31:45.163763Z] Finished read-buildbot-config step (success) 10:31:45 INFO - [mozharness: 2016-10-18 17:31:45.163852Z] Running download-and-extract step. 10:31:45 INFO - Running pre-action listener: _resource_record_pre_action 10:31:45 INFO - Running main action method: download_and_extract 10:31:45 INFO - mkdir: /builds/slave/test/build/tests 10:31:45 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')]} 10:31:45 INFO - https://queue.taskcluster.net/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:31:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 10:31:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 10:31:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 10:31:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:31:45 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 10:31:45 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 10:31:45 INFO - retry: Failed, sleeping 30 seconds before retrying 10:32:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #2 10:32:15 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 10:32:15 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 10:32:15 INFO - retry: Failed, sleeping 60 seconds before retrying 10:33:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #3 10:33:15 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 10:33:15 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 10:33:15 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json! 10:33:15 INFO - Caught exception: HTTP Error 404: Not Found 10:33:15 INFO - Caught exception: HTTP Error 404: Not Found 10:33:15 INFO - Caught exception: HTTP Error 404: Not Found 10:33:15 INFO - trying https://queue.taskcluster.net/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 10:33:15 INFO - Downloading https://queue.taskcluster.net/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 10:33:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:33:15 INFO - Downloaded 1327 bytes. 10:33:15 INFO - Reading from file /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 10:33:15 INFO - Using the following test package requirements: 10:33:15 INFO - {u'common': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 10:33:15 INFO - u'cppunittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 10:33:15 INFO - u'firefox-50.0.en-US.linux-x86_64.cppunittest.tests.zip'], 10:33:15 INFO - u'gtest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 10:33:15 INFO - u'firefox-50.0.en-US.linux-x86_64.gtest.tests.zip'], 10:33:15 INFO - u'jittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 10:33:15 INFO - u'jsshell-linux-x86_64.zip'], 10:33:15 INFO - u'mochitest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 10:33:15 INFO - u'firefox-50.0.en-US.linux-x86_64.mochitest.tests.zip'], 10:33:15 INFO - u'mozbase': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 10:33:15 INFO - u'reftest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 10:33:15 INFO - u'firefox-50.0.en-US.linux-x86_64.reftest.tests.zip'], 10:33:15 INFO - u'talos': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 10:33:15 INFO - u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'], 10:33:15 INFO - u'web-platform': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 10:33:15 INFO - u'firefox-50.0.en-US.linux-x86_64.web-platform.tests.zip'], 10:33:15 INFO - u'xpcshell': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 10:33:15 INFO - u'firefox-50.0.en-US.linux-x86_64.xpcshell.tests.zip']} 10:33:15 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:33: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')]} 10:33:15 INFO - https://queue.taskcluster.net/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:33:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 10:33:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 10:33:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 10:33:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:33:15 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 10:33:15 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 10:33:15 INFO - retry: Failed, sleeping 30 seconds before retrying 10:33:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #2 10:33:45 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 10:33:45 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 10:33:45 INFO - retry: Failed, sleeping 60 seconds before retrying 10:34:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #3 10:34:46 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 10:34:46 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 10:34:46 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip! 10:34:46 INFO - Caught exception: HTTP Error 404: Not Found 10:34:46 INFO - Caught exception: HTTP Error 404: Not Found 10:34:46 INFO - Caught exception: HTTP Error 404: Not Found 10:34:46 INFO - trying https://queue.taskcluster.net/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 10:34:46 INFO - Downloading https://queue.taskcluster.net/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 10:34:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:34:47 INFO - Downloaded 21773021 bytes. 10:34:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:34:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:34:48 INFO - Return code: 0 10:34:48 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:34:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:34:48 INFO - https://queue.taskcluster.net/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:34:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 10:34:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 10:34:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 10:34:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:34:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 10:34:48 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 10:34:48 INFO - retry: Failed, sleeping 30 seconds before retrying 10:35:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #2 10:35:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 10:35:18 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 10:35:18 INFO - retry: Failed, sleeping 60 seconds before retrying 10:36:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #3 10:36:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 10:36:18 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 10:36:18 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip! 10:36:18 INFO - Caught exception: HTTP Error 404: Not Found 10:36:18 INFO - Caught exception: HTTP Error 404: Not Found 10:36:18 INFO - Caught exception: HTTP Error 404: Not Found 10:36:18 INFO - trying https://queue.taskcluster.net/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 10:36:18 INFO - Downloading https://queue.taskcluster.net/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 10:36:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:36:26 INFO - Downloaded 21773021 bytes. 10:36:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:36:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:36:28 INFO - Return code: 0 10:36:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:28 INFO - https://queue.taskcluster.net/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:36:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 10:36:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 10:36:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 10:36:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:36:28 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 10:36:28 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 10:36:28 INFO - retry: Failed, sleeping 30 seconds before retrying 10:36:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 10:36:58 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 10:36:58 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 10:36:58 INFO - retry: Failed, sleeping 60 seconds before retrying 10:37:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 10:37:58 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 10:37:58 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 10:37:58 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip! 10:37:58 INFO - Caught exception: HTTP Error 404: Not Found 10:37:58 INFO - Caught exception: HTTP Error 404: Not Found 10:37:58 INFO - Caught exception: HTTP Error 404: Not Found 10:37:58 INFO - trying https://queue.taskcluster.net/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 10:37:58 INFO - Downloading https://queue.taskcluster.net/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 10:37:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:37:59 INFO - Downloaded 14413762 bytes. 10:37:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:37:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:37:59 INFO - Return code: 0 10:37:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:37:59 INFO - https://queue.taskcluster.net/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:37:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 10:37:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 10:37:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 10:37:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:37:59 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 10:37:59 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 10:37:59 INFO - retry: Failed, sleeping 30 seconds before retrying 10:38:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #2 10:38:29 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 10:38:29 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 10:38:29 INFO - retry: Failed, sleeping 60 seconds before retrying 10:39:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #3 10:39:29 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 10:39:29 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 10:39:29 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2! 10:39:29 INFO - Caught exception: HTTP Error 404: Not Found 10:39:29 INFO - Caught exception: HTTP Error 404: Not Found 10:39:29 INFO - Caught exception: HTTP Error 404: Not Found 10:39:29 INFO - trying https://queue.taskcluster.net/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 10:39:29 INFO - Downloading https://queue.taskcluster.net/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 10:39:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:39:30 INFO - Downloaded 56781271 bytes. 10:39:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 10:39:30 INFO - mkdir: /builds/slave/test/properties 10:39:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:39:30 INFO - Writing to file /builds/slave/test/properties/build_url 10:39:30 INFO - Contents: 10:39:30 INFO - build_url:https://queue.taskcluster.net/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 10:39:31 INFO - Running post-action listener: _resource_record_post_action 10:39:31 INFO - Running post-action listener: set_extra_try_arguments 10:39:31 INFO - [mozharness: 2016-10-18 17:39:31.244687Z] Finished download-and-extract step (success) 10:39:31 INFO - [mozharness: 2016-10-18 17:39:31.244923Z] Running populate-webroot step. 10:39:31 INFO - Running pre-action listener: _resource_record_pre_action 10:39:31 INFO - Running main action method: populate_webroot 10:39:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:39:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:39:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:39:31 INFO - '--tppagecycles', 10:39:31 INFO - '7'], 10:39:31 INFO - 'tests': ['tsvgm']}}, 10:39:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:39:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:39:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:39:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:39:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:39:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:39:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:39:31 INFO - 'talos_options': ['--disable-e10s'], 10:39:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:39:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:39:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:39:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:39:31 INFO - 'talos_options': ['--disable-e10s'], 10:39:31 INFO - 'tests': ['damp', 'tps']}, 10:39:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:39:31 INFO - 'tests': ['damp', 'tps']}, 10:39:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:39:31 INFO - 'tests': ['dromaeo_dom']}, 10:39:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:39:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:39:31 INFO - 'tests': ['basic_compositor_video']}, 10:39:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:39:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:39:31 INFO - 'tests': ['a11yr', 10:39:31 INFO - 'ts_paint', 10:39:31 INFO - 'tpaint', 10:39:31 INFO - 'sessionrestore', 10:39:31 INFO - 'sessionrestore_no_auto_restore', 10:39:31 INFO - 'tabpaint']}, 10:39:31 INFO - 'other-e10s': {'tests': ['a11yr', 10:39:31 INFO - 'ts_paint', 10:39:31 INFO - 'tpaint', 10:39:31 INFO - 'sessionrestore', 10:39:31 INFO - 'sessionrestore_no_auto_restore', 10:39:31 INFO - 'tabpaint']}, 10:39:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:39:31 INFO - 'ts_paint', 10:39:31 INFO - 'tpaint', 10:39:31 INFO - 'sessionrestore', 10:39:31 INFO - 'sessionrestore_no_auto_restore', 10:39:31 INFO - 'tabpaint']}, 10:39:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:39:31 INFO - 'ts_paint', 10:39:31 INFO - 'tpaint', 10:39:31 INFO - 'sessionrestore', 10:39:31 INFO - 'sessionrestore_no_auto_restore', 10:39:31 INFO - 'tabpaint']}, 10:39:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:39:31 INFO - 'tests': ['a11yr', 10:39:31 INFO - 'ts_paint', 10:39:31 INFO - 'tpaint', 10:39:31 INFO - 'sessionrestore', 10:39:31 INFO - 'sessionrestore_no_auto_restore', 10:39:31 INFO - 'tabpaint']}, 10:39:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:39:31 INFO - 'tests': ['a11yr', 10:39:31 INFO - 'ts_paint', 10:39:31 INFO - 'tpaint', 10:39:31 INFO - 'sessionrestore', 10:39:31 INFO - 'sessionrestore_no_auto_restore', 10:39:31 INFO - 'tabpaint']}, 10:39:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:39:31 INFO - 'tests': ['tsvgx', 10:39:31 INFO - 'tsvgr_opacity', 10:39:31 INFO - 'tart', 10:39:31 INFO - 'tscrollx', 10:39:31 INFO - 'cart']}, 10:39:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:39:31 INFO - 'tsvgr_opacity', 10:39:31 INFO - 'tart', 10:39:31 INFO - 'tscrollx', 10:39:31 INFO - 'cart']}, 10:39:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:39:31 INFO - 'talos_options': ['--disable-e10s'], 10:39:31 INFO - 'tests': ['tp5o']}, 10:39:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:39:31 INFO - 'tests': ['tp5o']}, 10:39:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:39:31 INFO - 'talos_options': ['--disable-e10s', 10:39:31 INFO - '--xperf_path', 10:39:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:39:31 INFO - 'tests': ['tp5n']}, 10:39:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:39:31 INFO - 'talos_options': ['--xperf_path', 10:39:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:39:31 INFO - 'tests': ['tp5n']}}, 10:39:31 INFO - 'talos.zip': {'path': '', 10:39:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:39:31 INFO - Running post-action listener: _resource_record_post_action 10:39:31 INFO - [mozharness: 2016-10-18 17:39:31.263489Z] Finished populate-webroot step (success) 10:39:31 INFO - [mozharness: 2016-10-18 17:39:31.263578Z] Running create-virtualenv step. 10:39:31 INFO - Running pre-action listener: _resource_record_pre_action 10:39:31 INFO - Running main action method: create_virtualenv 10:39:31 INFO - Creating virtualenv /builds/slave/test/build/venv 10:39:31 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 10:39:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:39:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:39:31 INFO - Using real prefix '/usr' 10:39:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:39:31 INFO - Installing distribute.............................................................................................................................................................................................done. 10:39:33 INFO - Installing pip.................done. 10:39:33 INFO - Return code: 0 10:39:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:39:33 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')]} 10:39:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:33 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')]} 10:39:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:33 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 0x1ba4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd3400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e62570>, '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 0x1e63470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e63900>, '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': '0333a256a5e4f052382dd180000001b1-1476811776.911966-932705347', '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 10:39:33 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 10:39:33 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 10:39:33 INFO - Using env: {'DISPLAY': ':0', 10:39:33 INFO - 'HOME': '/home/cltbld', 10:39:33 INFO - 'LANG': 'en_US.UTF-8', 10:39:33 INFO - 'LANGUAGE': 'en_US:en', 10:39:33 INFO - 'LOGNAME': 'cltbld', 10:39:33 INFO - 'MAIL': '/var/mail/cltbld', 10:39:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:33 INFO - 'MOZ_NO_REMOTE': '1', 10:39:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:39:33 INFO - 'NO_EM_RESTART': '1', 10:39:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:39:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:33 INFO - 'PWD': '/builds/slave/test', 10:39:33 INFO - 'SHELL': '/bin/bash', 10:39:33 INFO - 'SHLVL': '1', 10:39:33 INFO - 'TERM': 'linux', 10:39:33 INFO - 'TMOUT': '86400', 10:39:33 INFO - 'USER': 'cltbld', 10:39:33 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476811776.911966-932705347', 10:39:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:33 INFO - '_': '/tools/buildbot/bin/python'} 10:39:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:34 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 10:39:34 INFO - Cleaning up... 10:39:34 INFO - Return code: 0 10:39:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:39:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:39:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:39:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:34 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 0x1ba4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd3400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e62570>, '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 0x1e63470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e63900>, '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': '0333a256a5e4f052382dd180000001b1-1476811776.911966-932705347', '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 10:39:34 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 10:39:34 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 10:39:34 INFO - Using env: {'DISPLAY': ':0', 10:39:34 INFO - 'HOME': '/home/cltbld', 10:39:34 INFO - 'LANG': 'en_US.UTF-8', 10:39:34 INFO - 'LANGUAGE': 'en_US:en', 10:39:34 INFO - 'LOGNAME': 'cltbld', 10:39:34 INFO - 'MAIL': '/var/mail/cltbld', 10:39:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:34 INFO - 'MOZ_NO_REMOTE': '1', 10:39:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:39:34 INFO - 'NO_EM_RESTART': '1', 10:39:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:39:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:34 INFO - 'PWD': '/builds/slave/test', 10:39:34 INFO - 'SHELL': '/bin/bash', 10:39:34 INFO - 'SHLVL': '1', 10:39:34 INFO - 'TERM': 'linux', 10:39:34 INFO - 'TMOUT': '86400', 10:39:34 INFO - 'USER': 'cltbld', 10:39:34 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476811776.911966-932705347', 10:39:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:34 INFO - '_': '/tools/buildbot/bin/python'} 10:39:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:34 INFO - Downloading/unpacking psutil>=3.1.1 10:39:34 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 10:39:34 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 10:39:34 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 10:39:34 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 10:39:34 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 10:39:34 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 10:39:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:39:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:39:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:39:36 INFO - Installing collected packages: psutil 10:39:36 INFO - Running setup.py install for psutil 10:39:36 INFO - building 'psutil._psutil_linux' extension 10:39:36 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 10:39:36 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 10:39:36 INFO - building 'psutil._psutil_posix' extension 10:39:36 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 10:39:36 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 10:39:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:39:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:39:36 INFO - Successfully installed psutil 10:39:36 INFO - Cleaning up... 10:39:36 INFO - Return code: 0 10:39:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:39: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')]} 10:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39: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')]} 10:39:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd3400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e62570>, '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 0x1e63470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e63900>, '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': '0333a256a5e4f052382dd180000001b1-1476811776.911966-932705347', '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 10:39:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:39:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:39:36 INFO - Using env: {'DISPLAY': ':0', 10:39:36 INFO - 'HOME': '/home/cltbld', 10:39:36 INFO - 'LANG': 'en_US.UTF-8', 10:39:36 INFO - 'LANGUAGE': 'en_US:en', 10:39:36 INFO - 'LOGNAME': 'cltbld', 10:39:36 INFO - 'MAIL': '/var/mail/cltbld', 10:39:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:36 INFO - 'MOZ_NO_REMOTE': '1', 10:39:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:39:36 INFO - 'NO_EM_RESTART': '1', 10:39:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:39:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:36 INFO - 'PWD': '/builds/slave/test', 10:39:36 INFO - 'SHELL': '/bin/bash', 10:39:36 INFO - 'SHLVL': '1', 10:39:36 INFO - 'TERM': 'linux', 10:39:36 INFO - 'TMOUT': '86400', 10:39:36 INFO - 'USER': 'cltbld', 10:39:36 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476811776.911966-932705347', 10:39:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:36 INFO - '_': '/tools/buildbot/bin/python'} 10:39:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:39:37 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 10:39:37 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 10:39:37 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 10:39:37 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 10:39:37 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 10:39:37 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 10:39:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:39:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:39:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:39:39 INFO - Installing collected packages: mozsystemmonitor 10:39:39 INFO - Running setup.py install for mozsystemmonitor 10:39:39 INFO - Successfully installed mozsystemmonitor 10:39:39 INFO - Cleaning up... 10:39:39 INFO - Return code: 0 10:39:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:39:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:39:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:39:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1ba4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd3400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e62570>, '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 0x1e63470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e63900>, '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': '0333a256a5e4f052382dd180000001b1-1476811776.911966-932705347', '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 10:39:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:39:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:39:39 INFO - Using env: {'DISPLAY': ':0', 10:39:39 INFO - 'HOME': '/home/cltbld', 10:39:39 INFO - 'LANG': 'en_US.UTF-8', 10:39:39 INFO - 'LANGUAGE': 'en_US:en', 10:39:39 INFO - 'LOGNAME': 'cltbld', 10:39:39 INFO - 'MAIL': '/var/mail/cltbld', 10:39:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:39 INFO - 'MOZ_NO_REMOTE': '1', 10:39:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:39:39 INFO - 'NO_EM_RESTART': '1', 10:39:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:39:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:39 INFO - 'PWD': '/builds/slave/test', 10:39:39 INFO - 'SHELL': '/bin/bash', 10:39:39 INFO - 'SHLVL': '1', 10:39:39 INFO - 'TERM': 'linux', 10:39:39 INFO - 'TMOUT': '86400', 10:39:39 INFO - 'USER': 'cltbld', 10:39:39 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476811776.911966-932705347', 10:39:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:39 INFO - '_': '/tools/buildbot/bin/python'} 10:39:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:39 INFO - Downloading/unpacking jsonschema==2.5.1 10:39:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:39:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:39:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:39:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:39:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:39:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:39:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:39:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:39:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:39:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:39:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:39:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:39:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:39:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:39:41 INFO - Downloading functools32-3.2.3-2.tar.gz 10:39:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:39:41 INFO - warning: no files found matching '*.txt' 10:39:41 INFO - no previously-included directories found matching 'build' 10:39:41 INFO - no previously-included directories found matching 'dist' 10:39:41 INFO - no previously-included directories found matching '.git*' 10:39:41 INFO - Installing collected packages: jsonschema, functools32 10:39:41 INFO - Running setup.py install for functools32 10:39:41 INFO - warning: no files found matching '*.txt' 10:39:41 INFO - no previously-included directories found matching 'build' 10:39:41 INFO - no previously-included directories found matching 'dist' 10:39:41 INFO - no previously-included directories found matching '.git*' 10:39:41 INFO - Successfully installed jsonschema functools32 10:39:41 INFO - Cleaning up... 10:39:41 INFO - Return code: 0 10:39:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:39:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:39:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:39:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1ba4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd3400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e62570>, '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 0x1e63470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e63900>, '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': '0333a256a5e4f052382dd180000001b1-1476811776.911966-932705347', '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 10:39:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:39:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:39:41 INFO - Using env: {'DISPLAY': ':0', 10:39:41 INFO - 'HOME': '/home/cltbld', 10:39:41 INFO - 'LANG': 'en_US.UTF-8', 10:39:41 INFO - 'LANGUAGE': 'en_US:en', 10:39:41 INFO - 'LOGNAME': 'cltbld', 10:39:41 INFO - 'MAIL': '/var/mail/cltbld', 10:39:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:41 INFO - 'MOZ_NO_REMOTE': '1', 10:39:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:39:41 INFO - 'NO_EM_RESTART': '1', 10:39:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:39:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:41 INFO - 'PWD': '/builds/slave/test', 10:39:41 INFO - 'SHELL': '/bin/bash', 10:39:41 INFO - 'SHLVL': '1', 10:39:41 INFO - 'TERM': 'linux', 10:39:41 INFO - 'TMOUT': '86400', 10:39:41 INFO - 'USER': 'cltbld', 10:39:41 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476811776.911966-932705347', 10:39:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:41 INFO - '_': '/tools/buildbot/bin/python'} 10:39:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:39:42 INFO - Cleaning up... 10:39:42 INFO - Return code: 0 10:39:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:39:42 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')]} 10:39:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:42 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')]} 10:39:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:42 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 0x1ba4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd3400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e62570>, '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 0x1e63470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e63900>, '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': '0333a256a5e4f052382dd180000001b1-1476811776.911966-932705347', '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 10:39:42 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 10:39:42 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 10:39:42 INFO - Using env: {'DISPLAY': ':0', 10:39:42 INFO - 'HOME': '/home/cltbld', 10:39:42 INFO - 'LANG': 'en_US.UTF-8', 10:39:42 INFO - 'LANGUAGE': 'en_US:en', 10:39:42 INFO - 'LOGNAME': 'cltbld', 10:39:42 INFO - 'MAIL': '/var/mail/cltbld', 10:39:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:42 INFO - 'MOZ_NO_REMOTE': '1', 10:39:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:39:42 INFO - 'NO_EM_RESTART': '1', 10:39:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:39:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:42 INFO - 'PWD': '/builds/slave/test', 10:39:42 INFO - 'SHELL': '/bin/bash', 10:39:42 INFO - 'SHLVL': '1', 10:39:42 INFO - 'TERM': 'linux', 10:39:42 INFO - 'TMOUT': '86400', 10:39:42 INFO - 'USER': 'cltbld', 10:39:42 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476811776.911966-932705347', 10:39:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:42 INFO - '_': '/tools/buildbot/bin/python'} 10:39:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:42 INFO - Downloading/unpacking blobuploader==1.2.4 10:39:42 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 10:39:42 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 10:39:42 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 10:39:42 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 10:39:42 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 10:39:42 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 10:39:44 INFO - Downloading blobuploader-1.2.4.tar.gz 10:39:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:39:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:39:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:39:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:39:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:39:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:39:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:39:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:39:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:39:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:39:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:39:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:39:44 INFO - Downloading docopt-0.6.1.tar.gz 10:39:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:39:44 INFO - Installing collected packages: blobuploader, requests, docopt 10:39:44 INFO - Running setup.py install for blobuploader 10:39:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:39:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:39:45 INFO - Running setup.py install for requests 10:39:45 INFO - Running setup.py install for docopt 10:39:45 INFO - Successfully installed blobuploader requests docopt 10:39:45 INFO - Cleaning up... 10:39:45 INFO - Return code: 0 10:39:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:39:45 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')]} 10:39:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:45 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')]} 10:39:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:45 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 0x1ba4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd3400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e62570>, '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 0x1e63470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e63900>, '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': '0333a256a5e4f052382dd180000001b1-1476811776.911966-932705347', '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 10:39:45 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 10:39:45 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 10:39:45 INFO - Using env: {'DISPLAY': ':0', 10:39:45 INFO - 'HOME': '/home/cltbld', 10:39:45 INFO - 'LANG': 'en_US.UTF-8', 10:39:45 INFO - 'LANGUAGE': 'en_US:en', 10:39:45 INFO - 'LOGNAME': 'cltbld', 10:39:45 INFO - 'MAIL': '/var/mail/cltbld', 10:39:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:45 INFO - 'MOZ_NO_REMOTE': '1', 10:39:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:39:45 INFO - 'NO_EM_RESTART': '1', 10:39:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:39:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:45 INFO - 'PWD': '/builds/slave/test', 10:39:45 INFO - 'SHELL': '/bin/bash', 10:39:45 INFO - 'SHLVL': '1', 10:39:45 INFO - 'TERM': 'linux', 10:39:45 INFO - 'TMOUT': '86400', 10:39:45 INFO - 'USER': 'cltbld', 10:39:45 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476811776.911966-932705347', 10:39:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:45 INFO - '_': '/tools/buildbot/bin/python'} 10:39:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:39:45 INFO - Running setup.py (path:/tmp/pip-Pu7kqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:39:45 INFO - Running setup.py (path:/tmp/pip-8pyM7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:39:45 INFO - Running setup.py (path:/tmp/pip-SwYycW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:39:45 INFO - Running setup.py (path:/tmp/pip-iRPvqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:39:46 INFO - Running setup.py (path:/tmp/pip-Wh5x8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:39:46 INFO - Running setup.py (path:/tmp/pip-uDxD_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:39:46 INFO - Running setup.py (path:/tmp/pip-c5wbfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:39:46 INFO - Running setup.py (path:/tmp/pip-417Z3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:39:46 INFO - Running setup.py (path:/tmp/pip-7XwRuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:39:46 INFO - Running setup.py (path:/tmp/pip-w5yNBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:39:46 INFO - Running setup.py (path:/tmp/pip-OTpc_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:39:46 INFO - Running setup.py (path:/tmp/pip-nkGpCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:39:46 INFO - Running setup.py (path:/tmp/pip-45DFcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:39:46 INFO - Running setup.py (path:/tmp/pip-1m4SU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:39:46 INFO - Running setup.py (path:/tmp/pip-jm5jU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:39:46 INFO - Running setup.py (path:/tmp/pip-wGp2C3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:39:46 INFO - Running setup.py (path:/tmp/pip-GCN5a3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:39:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:39:46 INFO - Running setup.py install for manifestparser 10:39:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:39:47 INFO - Running setup.py install for mozcrash 10:39:47 INFO - Running setup.py install for mozdebug 10:39:47 INFO - Running setup.py install for mozdevice 10:39:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:39:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:39:47 INFO - Running setup.py install for mozfile 10:39:47 INFO - Running setup.py install for mozhttpd 10:39:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:39:47 INFO - Running setup.py install for mozinfo 10:39:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:39:47 INFO - Running setup.py install for mozInstall 10:39:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:39:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:39:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:39:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:39:47 INFO - Running setup.py install for mozleak 10:39:47 INFO - Running setup.py install for mozlog 10:39:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:39:47 INFO - Running setup.py install for moznetwork 10:39:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:39:48 INFO - Running setup.py install for mozprocess 10:39:48 INFO - Running setup.py install for mozprofile 10:39:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:39:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:39:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:39:48 INFO - Running setup.py install for mozrunner 10:39:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:39:48 INFO - Running setup.py install for mozscreenshot 10:39:48 INFO - Running setup.py install for moztest 10:39:48 INFO - Running setup.py install for mozversion 10:39:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:39:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:39:48 INFO - Cleaning up... 10:39:48 INFO - Return code: 0 10:39:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:39:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:39:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:48 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 0x1ba4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd3400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e62570>, '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 0x1e63470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e63900>, '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': '0333a256a5e4f052382dd180000001b1-1476811776.911966-932705347', '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 10:39:48 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 10:39:48 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 10:39:48 INFO - Using env: {'DISPLAY': ':0', 10:39:48 INFO - 'HOME': '/home/cltbld', 10:39:48 INFO - 'LANG': 'en_US.UTF-8', 10:39:48 INFO - 'LANGUAGE': 'en_US:en', 10:39:48 INFO - 'LOGNAME': 'cltbld', 10:39:48 INFO - 'MAIL': '/var/mail/cltbld', 10:39:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:48 INFO - 'MOZ_NO_REMOTE': '1', 10:39:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:39:48 INFO - 'NO_EM_RESTART': '1', 10:39:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:39:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:48 INFO - 'PWD': '/builds/slave/test', 10:39:48 INFO - 'SHELL': '/bin/bash', 10:39:48 INFO - 'SHLVL': '1', 10:39:48 INFO - 'TERM': 'linux', 10:39:48 INFO - 'TMOUT': '86400', 10:39:48 INFO - 'USER': 'cltbld', 10:39:48 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476811776.911966-932705347', 10:39:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:48 INFO - '_': '/tools/buildbot/bin/python'} 10:39:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:39:48 INFO - Running setup.py (path:/tmp/pip-kEg2lI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:39:49 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)) 10:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:39:49 INFO - Running setup.py (path:/tmp/pip-2S4S9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:39:49 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)) 10:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:39:49 INFO - Running setup.py (path:/tmp/pip-oT_bPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:39:49 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)) 10:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:39:49 INFO - Running setup.py (path:/tmp/pip-r1F9o5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:39:49 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)) 10:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:39:49 INFO - Running setup.py (path:/tmp/pip-g5e5IW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:39:49 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)) 10:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:39:49 INFO - Running setup.py (path:/tmp/pip-Dy_GaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:39:49 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)) 10:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:39:49 INFO - Running setup.py (path:/tmp/pip-kPNFPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:39:49 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)) 10:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:39:49 INFO - Running setup.py (path:/tmp/pip-WcEk9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:39:49 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)) 10:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:39:49 INFO - Running setup.py (path:/tmp/pip-xC99sc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:39:49 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)) 10:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:39:49 INFO - Running setup.py (path:/tmp/pip-jFItak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:39:49 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)) 10:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:39:49 INFO - Running setup.py (path:/tmp/pip-LF4FAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:39:49 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)) 10:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:39:49 INFO - Running setup.py (path:/tmp/pip-sVsWiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:39:49 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)) 10:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:39:49 INFO - Running setup.py (path:/tmp/pip-XBuMGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:39:49 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)) 10:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:39:49 INFO - Running setup.py (path:/tmp/pip-F_z4pq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:39:50 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)) 10:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:39:50 INFO - Running setup.py (path:/tmp/pip-9WNdnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:39:50 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)) 10:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:39:50 INFO - Running setup.py (path:/tmp/pip-sA2fXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:39:50 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)) 10:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:39:50 INFO - Running setup.py (path:/tmp/pip-oPsys6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:39:50 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)) 10:39:50 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)) 10:39:50 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)) 10:39:50 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)) 10:39:50 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)) 10:39:50 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)) 10:39:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:39:50 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 10:39:50 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 10:39:50 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 10:39:50 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 10:39:50 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 10:39:50 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 10:39:52 INFO - Downloading blessings-1.6.tar.gz 10:39:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:39:52 INFO - Installing collected packages: blessings 10:39:52 INFO - Running setup.py install for blessings 10:39:52 INFO - Successfully installed blessings 10:39:52 INFO - Cleaning up... 10:39:52 INFO - Return code: 0 10:39:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:39:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:39:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:39:52 INFO - Reading from file tmpfile_stdout 10:39:52 INFO - Current package versions: 10:39:52 INFO - argparse == 1.2.1 10:39:52 INFO - blessings == 1.6 10:39:52 INFO - blobuploader == 1.2.4 10:39:52 INFO - docopt == 0.6.1 10:39:52 INFO - functools32 == 3.2.3-2 10:39:52 INFO - jsonschema == 2.5.1 10:39:52 INFO - manifestparser == 1.1 10:39:52 INFO - mozInstall == 1.12 10:39:52 INFO - mozcrash == 0.17 10:39:52 INFO - mozdebug == 0.1 10:39:52 INFO - mozdevice == 0.48 10:39:52 INFO - mozfile == 1.2 10:39:52 INFO - mozhttpd == 0.7 10:39:52 INFO - mozinfo == 0.9 10:39:52 INFO - mozleak == 0.1 10:39:52 INFO - mozlog == 3.3 10:39:52 INFO - moznetwork == 0.27 10:39:52 INFO - mozprocess == 0.23 10:39:52 INFO - mozprofile == 0.28 10:39:52 INFO - mozrunner == 6.12 10:39:52 INFO - mozscreenshot == 0.1 10:39:52 INFO - mozsystemmonitor == 0.3 10:39:52 INFO - moztest == 0.7 10:39:52 INFO - mozversion == 1.4 10:39:52 INFO - psutil == 3.1.1 10:39:52 INFO - requests == 1.2.3 10:39:52 INFO - wsgiref == 0.1.2 10:39:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:39:52 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')]} 10:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:52 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')]} 10:39:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:52 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 0x1ba4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd3400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e62570>, '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 0x1e63470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e63900>, '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': '0333a256a5e4f052382dd180000001b1-1476811776.911966-932705347', '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 10:39:52 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 10:39:52 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 10:39:52 INFO - Using env: {'DISPLAY': ':0', 10:39:52 INFO - 'HOME': '/home/cltbld', 10:39:52 INFO - 'LANG': 'en_US.UTF-8', 10:39:52 INFO - 'LANGUAGE': 'en_US:en', 10:39:52 INFO - 'LOGNAME': 'cltbld', 10:39:52 INFO - 'MAIL': '/var/mail/cltbld', 10:39:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:52 INFO - 'MOZ_NO_REMOTE': '1', 10:39:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:39:52 INFO - 'NO_EM_RESTART': '1', 10:39:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:39:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:52 INFO - 'PWD': '/builds/slave/test', 10:39:52 INFO - 'SHELL': '/bin/bash', 10:39:52 INFO - 'SHLVL': '1', 10:39:52 INFO - 'TERM': 'linux', 10:39:52 INFO - 'TMOUT': '86400', 10:39:52 INFO - 'USER': 'cltbld', 10:39:52 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476811776.911966-932705347', 10:39:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:52 INFO - '_': '/tools/buildbot/bin/python'} 10:39:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:52 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)) 10:39:52 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)) 10:39:52 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)) 10:39:52 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)) 10:39:52 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)) 10:39:52 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)) 10:39:52 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)) 10:39:52 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)) 10:39:52 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)) 10:39:52 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)) 10:39:52 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)) 10:39:52 INFO - Cleaning up... 10:39:52 INFO - Return code: 0 10:39:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:39:52 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')]} 10:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:52 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')]} 10:39:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:52 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 0x1ba4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd3400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e62570>, '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 0x1e63470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e63900>, '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': '0333a256a5e4f052382dd180000001b1-1476811776.911966-932705347', '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 10:39:52 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 10:39:52 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 10:39:52 INFO - Using env: {'DISPLAY': ':0', 10:39:52 INFO - 'HOME': '/home/cltbld', 10:39:52 INFO - 'LANG': 'en_US.UTF-8', 10:39:52 INFO - 'LANGUAGE': 'en_US:en', 10:39:52 INFO - 'LOGNAME': 'cltbld', 10:39:52 INFO - 'MAIL': '/var/mail/cltbld', 10:39:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:52 INFO - 'MOZ_NO_REMOTE': '1', 10:39:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:39:52 INFO - 'NO_EM_RESTART': '1', 10:39:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:39:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:52 INFO - 'PWD': '/builds/slave/test', 10:39:52 INFO - 'SHELL': '/bin/bash', 10:39:52 INFO - 'SHLVL': '1', 10:39:52 INFO - 'TERM': 'linux', 10:39:52 INFO - 'TMOUT': '86400', 10:39:52 INFO - 'USER': 'cltbld', 10:39:52 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476811776.911966-932705347', 10:39:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:52 INFO - '_': '/tools/buildbot/bin/python'} 10:39:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:39:53 INFO - Cleaning up... 10:39:53 INFO - Return code: 0 10:39:53 INFO - Running post-action listener: _resource_record_post_action 10:39:53 INFO - Running post-action listener: _start_resource_monitoring 10:39:53 INFO - Starting resource monitoring. 10:39:53 INFO - [mozharness: 2016-10-18 17:39:53.083006Z] Finished create-virtualenv step (success) 10:39:53 INFO - [mozharness: 2016-10-18 17:39:53.083443Z] Running install step. 10:39:53 INFO - Running pre-action listener: _resource_record_pre_action 10:39:53 INFO - Running main action method: install 10:39:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:39:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:39:53 INFO - Reading from file tmpfile_stdout 10:39:53 INFO - Detecting whether we're running mozinstall >=1.0... 10:39:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:39:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:39:53 INFO - Reading from file tmpfile_stdout 10:39:53 INFO - Output received: 10:39:53 INFO - Usage: mozinstall [options] installer 10:39:53 INFO - Options: 10:39:53 INFO - -h, --help show this help message and exit 10:39:53 INFO - -d DEST, --destination=DEST 10:39:53 INFO - Directory to install application into. [default: 10:39:53 INFO - "/builds/slave/test"] 10:39:53 INFO - --app=APP Application being installed. [default: firefox] 10:39:53 INFO - mkdir: /builds/slave/test/build/application 10:39:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:39:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:40:06 INFO - Reading from file tmpfile_stdout 10:40:06 INFO - Output received: 10:40:06 INFO - /builds/slave/test/build/application/firefox/firefox 10:40:06 INFO - Running post-action listener: _resource_record_post_action 10:40:06 INFO - [mozharness: 2016-10-18 17:40:06.863190Z] Finished install step (success) 10:40:06 INFO - [mozharness: 2016-10-18 17:40:06.863473Z] Running run-tests step. 10:40:06 INFO - Running pre-action listener: _resource_record_pre_action 10:40:06 INFO - Running main action method: run_tests 10:40:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:40:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:40:06 INFO - Python 2.7.3 10:40:06 INFO - Return code: 0 10:40:06 INFO - grabbing minidump binary from tooltool 10:40: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')]} 10:40:06 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 0x1e62570>, '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 0x1e63470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e63900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:40:06 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 10:40:06 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 10:40:06 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 10:40:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:40:06 INFO - Return code: 0 10:40:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:40:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:40:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:40:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:40:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:40:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 10:40:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 10:40:06 INFO - Using env: {'DISPLAY': ':0', 10:40:06 INFO - 'HOME': '/home/cltbld', 10:40:06 INFO - 'LANG': 'en_US.UTF-8', 10:40:06 INFO - 'LANGUAGE': 'en_US:en', 10:40:06 INFO - 'LOGNAME': 'cltbld', 10:40:06 INFO - 'MAIL': '/var/mail/cltbld', 10:40:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:40:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:40:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:40:06 INFO - 'MOZ_NO_REMOTE': '1', 10:40:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:40:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:40:06 INFO - 'NO_EM_RESTART': '1', 10:40:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:40:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:40:06 INFO - 'PWD': '/builds/slave/test', 10:40:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:40:06 INFO - 'SHELL': '/bin/bash', 10:40:06 INFO - 'SHLVL': '1', 10:40:06 INFO - 'TERM': 'linux', 10:40:06 INFO - 'TMOUT': '86400', 10:40:06 INFO - 'USER': 'cltbld', 10:40:06 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476811776.911966-932705347', 10:40:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:40:06 INFO - '_': '/tools/buildbot/bin/python'} 10:40:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 10:40:07 INFO - mozversion application_buildid: 20161018073421 10:40:07 INFO - mozversion application_changeset: edf1854ea77ebddca4a8ce78526d041aebb1a796 10:40:07 INFO - mozversion application_display_name: Firefox 10:40:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:40:07 INFO - mozversion application_name: Firefox 10:40:07 INFO - mozversion application_remotingname: firefox 10:40:07 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:40:07 INFO - mozversion application_vendor: Mozilla 10:40:07 INFO - mozversion application_version: 50.0 10:40:07 INFO - mozversion platform_buildid: 20161018073421 10:40:07 INFO - mozversion platform_changeset: edf1854ea77ebddca4a8ce78526d041aebb1a796 10:40:07 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:40:07 INFO - mozversion platform_version: 50.0 10:40:07 INFO - using testdate: 1476812407 10:40:07 INFO - actual date: 1476812407 10:40:07 INFO - starting webserver on 'localhost:55153' 10:40:07 INFO - SUITE-START | Running 2 tests 10:40:07 INFO - TEST-START | dromaeo_css 10:40:07 INFO - operating with platform_type : linux_ 10:40:07 INFO - Initialising browser for dromaeo_css test... 10:40:07 INFO - TEST-INFO | started process 10336 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuXyyWG/profile http://localhost:55153/getInfo.html) 10:40:11 INFO - PROCESS | 10336 | __metrics Screen width/height:1600/1200 10:40:11 INFO - PROCESS | 10336 | colorDepth:24 10:40:11 INFO - PROCESS | 10336 | Browser inner width/height: 1024/697 10:40:11 INFO - PROCESS | 10336 | __metrics 10:40:11 ERROR - PROCESS | 10336 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 10:40:12 INFO - TEST-INFO | 10336: exit 0 10:40:12 INFO - Browser initialized. 10:40:12 INFO - Running cycle 1/1 for dromaeo_css test... 10:40:12 INFO - TEST-INFO | started process 10461 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuXyyWG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:40:24 INFO - PROCESS | 10461 | RSS: Main: 149889024 10:40:24 INFO - PROCESS | 10461 | 10:41:13 INFO - PROCESS | 10461 | 1476812473910 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] 10:43:22 INFO - PROCESS | 10461 | Cycle 1(1): loaded http://localhost:55153/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55153/tests/dromaeo/cssquery-ext.html) 10:43:23 INFO - PROCESS | 10461 | RSS: Main: 158269440 10:43:23 INFO - PROCESS | 10461 | 10:46:25 INFO - PROCESS | 10461 | Cycle 1(1): loaded http://localhost:55153/tests/dromaeo/cssquery-ext.html (next: http://localhost:55153/tests/dromaeo/cssquery-jquery.html) 10:46:26 INFO - PROCESS | 10461 | RSS: Main: 155492352 10:46:26 INFO - PROCESS | 10461 | 10:49:27 INFO - PROCESS | 10461 | Cycle 1(1): loaded http://localhost:55153/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55153/tests/dromaeo/cssquery-mootools.html) 10:49:28 INFO - PROCESS | 10461 | RSS: Main: 155140096 10:49:28 INFO - PROCESS | 10461 | 10:52:30 INFO - PROCESS | 10461 | Cycle 1(1): loaded http://localhost:55153/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55153/tests/dromaeo/cssquery-prototype.html) 10:52:30 INFO - PROCESS | 10461 | RSS: Main: 156672000 10:52:30 INFO - PROCESS | 10461 | 10:55:33 INFO - PROCESS | 10461 | Cycle 1(1): loaded http://localhost:55153/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55153/tests/dromaeo/cssquery-yui.html) 10:55:33 INFO - PROCESS | 10461 | RSS: Main: 157982720 10:55:33 INFO - PROCESS | 10461 | 10:58:36 INFO - PROCESS | 10461 | Cycle 1(1): loaded http://localhost:55153/tests/dromaeo/cssquery-yui.html (next: http://localhost:55153/tests/dromaeo/cssquery-dojo.html) 10:58:36 INFO - PROCESS | 10461 | RSS: Main: 157106176 10:58:36 INFO - PROCESS | 10461 | 10:58:36 INFO - PROCESS | 10461 | __start_tp_report 10:58:36 INFO - PROCESS | 10461 | _x_x_mozilla_page_load 10:58:36 INFO - PROCESS | 10461 | _x_x_mozilla_page_load_details 10:58:36 INFO - PROCESS | 10461 | |i|pagename|runs| 10:58:36 INFO - PROCESS | 10461 | |0;dojo.html;3333.9833300833493;3354.1949932016314;3375.257443362461;3376.409128402532;3384.6446123157066;5878.617889837163;5962.8807423851495;5979.581429299946;5994.760209591611;6017.669028203447;5987.6407415555095;6000.099985002252;6000.789972350969;6031.487323577501;6050.606710563821;5375.623706340548;5434.592405569579;5448.318960129984;5493.23094766733;5495.395506494282;5480.013597552439;5480.972595137038;5495.313085864267;5498.780048798043;5517.034518959186;5304.17785243286;5316.20256961455;5464.043792336345;5468.48049435303;5512.228288039678;5331;5437.13005919055;5443.265159203516;5444.373897001817;5478.068728316196;5344.091504444254;5378.085725426687;5389.9191512127345;5411.756470958777;5431.782728690887;5757.050086735683;5817.447342502498;5925.259342582177;5934.4257400616325;6015.789447369321;6268.247810262797;6388.520860935449;6395.136656551353;6405.48756099511;6426.839329016765;6433.099366088752;6437.517186211006;6441.806745797634;6445.581037232611;6471.482281417475;5806.477417032487;5820.941790582125;5975.43233392827;5984.491318237955;6023.819285421444;6345.33373995733;6479.611223326616;6496.187976502937;6513.283538810727;6513.381228783258;6207.068939658997;6268.2478102627065;6268.49852011838;6268.717907694165;6293.370662933761;6181.8454538636;6220.315765265817;6320.683965801692;6374.298827129012;6376.776812811529;6153.538484613672;6281.748730050746;6318.62088274705;6330.8417289567205;6341.175647165839;6333.113364129025;6335.3981371769605;6354.936450635434;6363.872722545523;6390.968045159744;4700.741459219776;4771.689840160448;4845;4851.417829860439;4896.926546101811;4245.68157388191;4293.742375457483;4319.33050377192;4347.739135651871;4349.434573505424;6146.0473626587955;6158.137860699506;6166.290876549254;6202.41077097675;6228.937710622927;6148.538859585549;6327.778527751507;6398.328175541501;6433.324500927335;6443.838904027437;6144.600600960924;6189.071639254058;6206.565540412128;6232.532560058014;6275;5574.247476590689;5578.8047418340975;5578.967890940189;5591.9720401397735;5593;6424.871502569922;6459.063435801782;6466.418022377915;6739.393454589111;6753.054572359873;6408.61548307103;6417.069524918954;6420.711068002044;6422.807315780534;6424.807255782334;6611.900821487778;6664.700088496126;6666.699998499982;6668.133142691419;6685.699143538455;6008.579399442172;6212.534059945432;6212.689365531795;6241.594296370721;6306.117143599991;6454.806355809334;6475.352464753487;6480;6485.092087107714;6501.674916254263;6286.937130628635;6295.937040629535;6301.180846489927;6327.082573026977;6337;5992.43071908168;6188.0717892314715;6204.317525072148;6302.527310451826;6308.71610777507;6203.348648392034;6204.627722336674;6208.410201030895;6230.7819226326865;6267.905981410374;6289.056641503811;6353.523485738496;6370.299267080525;6392.264889537577;6396.264429590657;5971.940280597312;6070.0591408331775;6122.459144589048;6137.907931381123;6191.752329906753 10:58:36 INFO - PROCESS | 10461 | |1;ext.html;580.6864293281628;628.864794069275;645.799802061361;665.8668266346732;720.7981765105773;41536.792316038416;45529.54470455299;45688.54311456884;45790.31314530285;45800.77099614497;47078.76460617701;47226.527734722644;47401.28898066532;47604.52395476044;47899.52100478994;9173.357864949456;9319.440833550008;9322.394044387127;9322.720318390458;9325.95337023314;9071.092890710943;9099.863502047441;9120.543972801366;9158.954205228998;9187.816243675123;9235.492047937361;9244.583993720298;9274.953625231898;9278.721638350826;9282.257419406431;9219.032001639833;9236;9242.214411775007;9251.861222081641;9257.537123143817;9231.907680923172;9267.165955064076;9285.396449230779;9288.442693438416;9288.814223715555;45372.77313613444;45757.54242457566;45821;45882.311765323546;45912.77043614794;3638.3632864248916;3945.585713500099;4021.4369988201674;4231.97884010581;4269.722468039598;35236.64763352359;35323.29353412943;35461.82269088664;35485;35617.10957226064;4482.238019536687;4525.547445255481;4548.818047278105;4553.453585569753;4633.4671512775785;378338;379992;380526.0973695142;382053;383084;64793.352066479674;64812.351876481574;65026;65104.67447662731;65204.673976630766;67470.32529674738;67706;67720;67781.66109169423;68049.65975170191;17048.65902681964;17718.202680879393;17819.821801781814;18244.63510729778;18271.26914923388;13526;13650.385732642055;13671.863281367258;13695.589132326046;13711.108777929403;20537;20548.38354849357;20699.172033118506;20796.79203207979;20878.582428351347;7457.366123879422;7530.209328020479;7598.35413989806;7767.417443691746;7814.452988290879;1066.3974854207347;1136.6817291158488;1162.8546431696038;1174.5654107980101;1176.053277111916;34909.82545087258;35204.119897002776;35245.118872028404;35421.64578354183;35849.64150358515;1201.7055821323656;1208.5649166300125;1227.7298994221258;1232.8643849176583;1244.104244943639;18318;18326.083695815156;18498.722519162224;18560.907195463937;18598.349057783184;630896;635219;635641;638059;640132;66737.33262667408;67376.32623673798;67449.66275168593;67477.66261168662;67648;1459.4672944375438;1460.2844606142914;1471.0805746408494;1475.3655927951083;1507.9547613571392;32620;33838.32323353568;33934;34454.31091378108;34587;57109;57678.423215768984;57877.71061144667;57895.71052144712;58137;486254;487008;487900;488184;488318;32420.35159296848;32456.188595285308;32949.83525082359;33062.17344566405;33129.337413252084;53070.46929530655;53649.19526207188;53835.19247211373;54160.729196353765;54905;44997.77501112474;47185;47293.29060064033;47516.76241618908;48532.2720159205;45876;47047.29429058635;47359.28961065518;47401.52598473971;48191.5180848187;41680;43837.78081109574;44761.55238447574;45682.771586141855;49222.261666075756;40472.79763601163;41376;41463.37804932989;41577.58422415737;42064.579354206064;31007.224819379695;31133.8443307782;31433.52849707302;31984.520232197003;32047.198820029687 10:58:36 INFO - PROCESS | 10461 | |2;jquery.html;394.144705988006;398.2731514985153;430.6296584936954;431.4154320895186;439.71418577924356;19152.42542723717;19972.800271997276;20493.282735104276;20759.792402075993;20861.374158775223;19639.705404418946;20432.591348173028;20641.277555285567;20752.169913203492;20766.79233207671;5463.672179669223;5589.608727389084;5596.244506991545;5605.915911261334;5625.6905870177325;5693.658380497183;5849.122631605251;5882.588218824684;6016.127661489081;6032.065029920369;5987.341392446828;6005.879882402372;6009.09863520471;6025.879482410349;6048.3346831848685;5892.587518873681;5927.962606543838;5962.582619216657;5998.460138587505;6006.609570377911;5927.733252003627;6071.150038994544;6073.878522429571;6077.36187700294;6077.635341879457;14987.100773953598;17388.56528586783;20111;25071.498570028678;25181.49637007268;2264.116994372196;2266.9206577769864;2289.9198528051606;2318.7101612298293;2788.3168623687125;10840.349579025205;10853.34879907208;10886.129109671207;10896;14054.156750594895;1854.545636319097;1928.0745242283642;1928.2287085166047;1952.4045166224296;1960.8431325493925;87787.56106219492;89779.55110224472;91068;91261;92343;11577.884221157849;11702.941485292518;11758.118141139448;11820.70448238801;11940.761184776256;17021.06384148859;17045.40341088056;17066.31734730597;17067;17071.743923841153;8105.797355066053;8488.957555212308;8596.957015214884;8679.826403472021;8704;8304.584770761438;8330.208630180123;8357.080721120672;8363.330933525303;8523.488590684456;4999.775010124553;5106.412762532282;5161.2516185152945;5225.4774522548205;5226.5818734501145;2113.2181092995384;2113.9577208455744;2154.6229409853213;2176.33621745366;2220.2118248022043;923.4643906534194;1002.4488820753842;1047.3349423116376;1073.897979691928;1087.6736978906297;18469.90765046166;19887.204511819655;19915.402537923885;20549.178032878815;20758.377248682562;1036.3419228789621;1044.2533588484118;1059.1103473082494;1077.5258886090096;1105.4969988655143;10950.890491094988;11285.492152853141;11323.320600763816;11338.2630129043;11393.487293071666;553206;566467;567656;568367;572172;61871.690641546506;90499;90996.54501727581;97170;101343;1064.1061508332882;1092.7759809239246;1119.3339962722168;1122.7586068995206;1125.189863298424;18300.542486437946;18306.359277425225;18603.255869765057;18838.905805470884;19076.713849291995;42520;43435.34846977235;43467.56532434635;44416.7779161115;44681.32978005397;59970.40029599648;64655;65580.67209663922;65619.34380656324;66120.66939665463;8456.492610443393;8718.60766265507;8800;8817.647294108421;8877.689280875138;12282;12746.745065098832;12868.420921058387;13167.341632918124;13247.138935969131;11539;11715.472803724024;11746.353950532803;11757.294562326288;11834.585789497327;11438.37088960082;11498.770024599295;11677;11712.648620541397;11751.47118379692;11385.601503947322;11610.6516804496;11730.70673233176;11961.820572691591;11968.581099661471;7520.210377910241;7982.321502672105;8647;8805.207531322212;8841.646334146562;11220.887791121984;11306.604268850551;11442.542298307975;11459.598914037968;11487.8276825846 10:58:36 INFO - PROCESS | 10461 | |3;mootools.html;1567.7334853074976;1589.4516391844813;1768.4694591622517;1831.7343985122166;1865.7201419787039;8621.05168431472;9056.13966673165;9148.58831352589;9782.26633002524;9787.755306117342;9275.582598783054;9468.147866691996;9738.269629777777;9768.267379946516;9785.902140978587;2536.4673418582074;2596.792256619475;2598.22053383985;2610.138654244095;2611.503814275291;2523.470071285032;2624.4619852930105;2632.605109233611;2636.1037247335903;2636.3277364272085;2476.6037434010564;2549.3499157714755;2579.57437022891;2586.2629150692055;2591.326255173659;2493.47636996231;2500.087468074158;2537.746225377466;2564.923052308415;2569.293444302813;2504.7745702886646;2516.484120755241;2537.581299085649;2561.5005074010573;2567.679040119985;9794.16749576287;9847.212223022212;9892.703218903373;9897.4556399398;9912.90087099127;5440.455954404568;5603.3836278009385;5619.803306884281;5625.212470254168;5647.29408823897;3625.23869987303;3754.5869954305003;3827.158025234444;3831.5593706723525;3839.9616003840165;1158.5192145259707;1175.2830773228325;1181.6691326428613;1239.962801115968;1249.6875781054737;13511.324433778273;13897.16617002983;13986.440542378394;14277;14371.209583472904;5040.7479626019285;5043.067032598908;5096.490350964874;5142.922856157161;5312.9734351328;11792.29246245228;11808.586699465477;11849.052075833913;11858.051355891508;11886.227395219283;5540.584456165804;5541.6120871539415;5542.974549708317;5543.029969755276;5566.610337276352;4569.954300456953;4931.260310953386;5015.22264049073;5020.221865610836;5051.570616497639;4523;4569.908601827945;4616.6537509686905;4634.606058484999;4645.070985802853;1391.902566820333;1439.9712005760036;1463.8609332113433;1468.9779653305209;1475.8819294456418;1020.8264595018716;1058.7459009837582;1085.9674209773718;1094.0919037199105;1096.5010920031366;6506.967465162644;6739.191297044386;6748.966255168692;6930.237673855871;7024.1571011478945;462.145031691375;468.27651278774374;469.1250817225849;487.4053654541454;492.12156301003256;4757.666963312604;4785.832495862698;4786.018866132435;4806.303086052503;4810.182269014276;12084.093692972887;12384.504619815107;12446.439910204062;12461.439235234437;12627.810582841264;12428.502859885502;12430.875691242973;12435.626931192079;12462.12765106452;12503.18729282612;9008.59461324242;9020.909790902138;9121.133492318218;9138.725838224997;9181.54092295396;6519.576227545194;6538.248101468202;6578;6612.23959244693;6633.2371777246235;11019.504122314354;11050.834237486604;11223.10215182767;11568.537258509565;11571.884281157081;11353.37556434404;11377.601783937522;11646.359450230319;11693.532258709556;11816.172867899164;7740.883886741591;8316.750497485085;8519.616617252363;8881.689140880038;8944.195022447751;9537.284703647116;9593.328467007243;9620;9631.855522167314;9648.565814538502;8425.241728244488;8532.274756645505;8554.401191916506;8636.050034496326;8667.609957552051;8303.95848020756;8359.205875441823;8391.454555453876;8392.28665563434;8640.82718345617;7591.3547348473785;7593.8860917085185;7613.695452181851;7678.155402905788;7691.769246922601;5639.7180140993605;5796.101604251347;5829.59192856496;5949.1076338549565;5992.340842507234;5693.715314234189;5737.885242295048;5789.507891829242;5810.622309549865;5843.94156058451 10:58:36 INFO - PROCESS | 10461 | |4;prototype.html;350.97192224622034;355.6603443711255;358.446200620042;362.21941715602884;364.3787342580898;5818.127280907861;5852.209951656525;5871.2367392239;5895.911561326584;5909.970450147744;5608.298962629671;5707.400722924085;5723.9713801430935;5790.073588225885;5828.213191219184;4466.79899404526;4489.214387482186;4506.752128632924;4508.368828364031;4511.323301504768;4503.527129651388;4517.344984977176;4526.479454862683;4537.319402089696;4572.382728331666;4482.148391805546;4542.341360502725;4550.929327156136;4551.044280701057;4555.567221114005;4255.702100852942;4422.889427764299;4448.488423831236;4461.196984542781;4468.218061839198;3951.209758048402;3951.486306780129;3954.130091379892;3961.207758448293;3978.741381810173;5549.278593782823;5589.972050139723;5628.9305032043785;5631.521320687705;5666.045214401025;5013.54607163922;5104.64267501275;5106.923396149061;5115.693058416507;5119.795208191705;5905.114232865061;5956.791512297049;5957.6127551709;6031.8793624127275;6046.706838144923;4258.6380157686635;4356.215881141393;4363.236433624134;4368.825246990116;4369.868903932887;6139.465133716571;6264.812055638338;6285.214348206474;6287.616724320688;6327.936720632781;4423.115376924564;4458.130664520388;4459.888502787457;4479.670571302904;4500.594946454835;4539.863804085882;4545.204589196877;4546.272596384562;4548.703619468436;4560.749158796298;5014.871653877848;5104.302509507939;5145.897082058338;5187.950759449996;5195.324607801037;6038.879222415527;6064.514838812885;6080.635161890301;6082.817515474543;6085.756569737161;1553.2156261088305;1554.6113471632093;1554.9426390054646;1566.644852202859;1574.7559128335126;945.3004776465366;986.9439699521444;987.4223579206101;996.689353500145;1015.8527013582989;5155.484451554815;5183.352080989876;5188.9740551297;5191.922121168185;5222.302751605744;5435.891282174334;5467.507924286754;5488.396276409591;5490.313710786152;5515.61390702655;4944.283078953532;5103;5153.330067091254;5212.374515058142;5216.200410858248;2874.2526942994973;2900.0429858146763;2905.985470072636;2919.4161167766533;2936.500794864878;5555.888822235569;5595.244641973363;5609.663420194802;5613.687924124704;5654.180143879197;5174.9650069986155;5479.972600136974;5480.698561579072;5493.450654934474;5503.972480137573;5590.664560126405;5613.971930140405;5625.521830644441;5642.322921249394;5655.321361436654;5228.294534918604;5428.59285553593;5447.945520544744;5460.91808622863;5493.725313734377;5326.0826102603805;5333.5465685784975;5340.546053585489;5350.625456218183;5409.052741013311;6290.175849003921;6484.790028935518;6485.319041500575;6512.697460507823;6553.246376666553;4426.1369033038245;4436.911261774811;4438.755868427267;4456.888577785451;4471.821127154877;6095.75616975316;6156.476699480594;6206.410391012847;6231.53263505248;6276.686165691606;6052.515798736179;6062.030075187949;6090;6118.143459915705;6120.540959427972;5885.882282354414;6121.296050954019;6123.938760612336;6127.632342059491;6129.295131059806;6040.75836966534;6055.273367195965;6079.544034197541;6110.602810817282;6115.205023346936;6167.784127555514;6170.228721409824;6171.722272497658;6179.907301390393;6185.319614842274;5788.479036886701;5928.673922934107;5960.76156953717;5970.910436343545;6024.337322894566 10:58:36 INFO - PROCESS | 10461 | |5;yui.html;795.6459375577866;819.8483280593094;861.8362511122887;896.5069211933437;929.6792606550738;15027.39890404384;15468.38126474941;16165.353385864551;16180.676386472263;16743.581410464743;16125.83874161261;16876.746848797247;16881.577960550992;16914.577135571617;16973.2362043708;858.107568129145;870.5168631409565;876.701921346742;879.0857508191473;882.7263548300016;842.8904242448473;866.5537248317122;873.057098333798;873.6112429968634;875.0199776250577;921.4563407589521;926.5598840550718;927.3740225347897;931.9021502742216;932.724846170378;923.3305853256403;926.8841394825647;928.0302084321866;928.9674861379887;931.74842792446;679.0730652659084;681.0839420978825;681.2778454837887;681.6080753566719;682.7712716240065;14228.715425691531;14251.216183109926;14261;14262.286885655676;14287.499937502138;15736;15950.840491595052;15959.680806383923;15970.281337339848;16026.198690065567;11970.521179152824;12029.278243305429;12040.759184816343;12119.878801211964;12260.81608775869;3884.766913985142;3906;3944.9013774655577;3958;3995.320795464778;70038;72569;91476.54261728715;92186;92368.53815730945;12238.694032649255;12567.937160314323;12664.6833829155;12861.935690321676;12871.099023068295;22512.549749004927;22832.65751013736;22891.771082288964;22913.88543057274;22926.19758308451;8537.060923298432;8602.913970860336;8832.205101540892;9050.592723327467;9116.49859257734;4622.6764126510825;4674.252119660906;4729.983053643415;4751.8574442766085;4918.163912134945;3579.731520136;3789.1853251551047;3799.962000379961;3800.8859734208017;3811.104390468238;656.1306269193337;658.6574981009848;661.444386715152;661.5865084322298;684.6131935456451;806.790234539024;814.5484924885529;817.0219549741279;847.2713466418875;873.8601823708176;9750.658726944665;10053.69838904834;10141.695749127539;10282.897171028193;10419.374837509773;756.3797685897512;797.3063434811751;803.9839203215903;806.766037849029;807.1968391450545;4927.507249275115;5064.949350506447;5074.4671809460215;5141.974290128525;5146.897062058738;112923;133536;138225;140736;143262;112297;113337.4333128329;113869;115456;123398.38300808618;101796.49101754444;104155.4792226034;104968;106157;108626.45686771515;9606.711798646053;9744.101361799714;9781.320049813201;9880.703578892644;9959.302848800515;50941.74529127479;51255;60053.69973150106;60089.098663520956;62433.68783156055;78904.60547697225;79235;79837;79967;83985;13712.286751990629;13737.725245495234;13777.724445511234;14278.571642850731;14351.856481435052;14277.571672849832;14396.640083997983;14612.269386530843;14651.92674036623;15071.849281507044;12883.162594431333;13400.93299533496;13519.864801351861;14545.781813272597;14563.781543277071;13610.86389136096;13721.588352349445;14850.257487125817;14916.55250342448;14924.701505969602;13456.25990570528;13647.522336718168;14751.483698070946;14805.259737012891;14957.17735524513;11476.770464590494;12032.338221397908;12517.56188533397;12879.935600321938;12888;12570.497180112692;12756.87243127594;12847.678808029874;12972.870271297166;13007.804882926574 10:58:36 INFO - PROCESS | 10461 | __end_tp_report 10:58:36 INFO - PROCESS | 10461 | __start_cc_report 10:58:36 INFO - PROCESS | 10461 | _x_x_mozilla_cycle_collect,354 10:58:36 INFO - PROCESS | 10461 | __end_cc_report 10:58:36 INFO - PROCESS | 10461 | __startTimestamp1476813516536__endTimestamp 10:58:36 INFO - PROCESS | 10461 | 10:58:36 INFO - PROCESS | 10461 | ------- Summary: start ------- 10:58:36 INFO - PROCESS | 10461 | Number of tests: 6 10:58:36 INFO - PROCESS | 10461 | 10:58:36 INFO - PROCESS | 10461 | [#0] dojo.html Cycles:165 Average:5932.83 Median:6203.35 stddev:690.26 (11.1%) stddev-sans-first:661.58 10:58:36 INFO - PROCESS | 10461 | Values: 3334.0 3354.2 3375.3 3376.4 3384.6 5878.6 5962.9 5979.6 5994.8 6017.7 5987.6 6000.1 6000.8 6031.5 6050.6 5375.6 5434.6 5448.3 5493.2 5495.4 5480.0 5481.0 5495.3 5498.8 5517.0 5304.2 5316.2 5464.0 5468.5 5512.2 5331.0 5437.1 5443.3 5444.4 5478.1 5344.1 5378.1 5389.9 5411.8 5431.8 5757.1 5817.4 5925.3 5934.4 6015.8 6268.2 6388.5 6395.1 6405.5 6426.8 6433.1 6437.5 6441.8 6445.6 6471.5 5806.5 5820.9 5975.4 5984.5 6023.8 6345.3 6479.6 6496.2 6513.3 6513.4 6207.1 6268.2 6268.5 6268.7 6293.4 6181.8 6220.3 6320.7 6374.3 6376.8 6153.5 6281.7 6318.6 6330.8 6341.2 6333.1 6335.4 6354.9 6363.9 6391.0 4700.7 4771.7 4845.0 4851.4 4896.9 4245.7 4293.7 4319.3 4347.7 4349.4 6146.0 6158.1 6166.3 6202.4 6228.9 6148.5 6327.8 6398.3 6433.3 6443.8 6144.6 6189.1 6206.6 6232.5 6275.0 5574.2 5578.8 5579.0 5592.0 5593.0 6424.9 6459.1 6466.4 6739.4 6753.1 6408.6 6417.1 6420.7 6422.8 6424.8 6611.9 6664.7 6666.7 6668.1 6685.7 6008.6 6212.5 6212.7 6241.6 6306.1 6454.8 6475.4 6480.0 6485.1 6501.7 6286.9 6295.9 6301.2 6327.1 6337.0 5992.4 6188.1 6204.3 6302.5 6308.7 6203.3 6204.6 6208.4 6230.8 6267.9 6289.1 6353.5 6370.3 6392.3 6396.3 5971.9 6070.1 6122.5 6137.9 6191.8 10:58:36 INFO - PROCESS | 10461 | 10:58:36 INFO - PROCESS | 10461 | [#1] ext.html Cycles:180 Average:67813.93 Median:45810.89 stddev:136117.66 (297.1%) stddev-sans-first:136405.91 10:58:36 INFO - PROCESS | 10461 | Values: 580.7 628.9 645.8 665.9 720.8 41536.8 45529.5 45688.5 45790.3 45800.8 47078.8 47226.5 47401.3 47604.5 47899.5 9173.4 9319.4 9322.4 9322.7 9326.0 9071.1 9099.9 9120.5 9159.0 9187.8 9235.5 9244.6 9275.0 9278.7 9282.3 9219.0 9236.0 9242.2 9251.9 9257.5 9231.9 9267.2 9285.4 9288.4 9288.8 45372.8 45757.5 45821.0 45882.3 45912.8 3638.4 3945.6 4021.4 4232.0 4269.7 35236.6 35323.3 35461.8 35485.0 35617.1 4482.2 4525.5 4548.8 4553.5 4633.5 378338.0 379992.0 380526.1 382053.0 383084.0 64793.4 64812.4 65026.0 65104.7 65204.7 67470.3 67706.0 67720.0 67781.7 68049.7 17048.7 17718.2 17819.8 18244.6 18271.3 13526.0 13650.4 13671.9 13695.6 13711.1 20537.0 20548.4 20699.2 20796.8 20878.6 7457.4 7530.2 7598.4 7767.4 7814.5 1066.4 1136.7 1162.9 1174.6 1176.1 34909.8 35204.1 35245.1 35421.6 35849.6 1201.7 1208.6 1227.7 1232.9 1244.1 18318.0 18326.1 18498.7 18560.9 18598.3 630896.0 635219.0 635641.0 638059.0 640132.0 66737.3 67376.3 67449.7 67477.7 67648.0 1459.5 1460.3 1471.1 1475.4 1508.0 32620.0 33838.3 33934.0 34454.3 34587.0 57109.0 57678.4 57877.7 57895.7 58137.0 486254.0 487008.0 487900.0 488184.0 488318.0 32420.4 32456.2 32949.8 33062.2 33129.3 53070.5 53649.2 53835.2 54160.7 54905.0 44997.8 47185.0 47293.3 47516.8 48532.3 45876.0 47047.3 47359.3 47401.5 48191.5 41680.0 43837.8 44761.6 45682.8 49222.3 40472.8 41376.0 41463.4 41577.6 42064.6 31007.2 31133.8 31433.5 31984.5 32047.2 10:58:36 INFO - PROCESS | 10461 | 10:58:36 INFO - PROCESS | 10461 | [#2] jquery.html Cycles:180 Average:31718.43 Median:2165.48 stddev:93033.69 (4296.2%) stddev-sans-first:93264.95 10:58:36 INFO - PROCESS | 10461 | Values: 394.1 398.3 430.6 431.4 439.7 19152.4 19972.8 20493.3 20759.8 20861.4 19639.7 20432.6 20641.3 20752.2 20766.8 5463.7 5589.6 5596.2 5605.9 5625.7 5693.7 5849.1 5882.6 6016.1 6032.1 5987.3 6005.9 6009.1 6025.9 6048.3 5892.6 5928.0 5962.6 5998.5 6006.6 5927.7 6071.2 6073.9 6077.4 6077.6 14987.1 17388.6 20111.0 25071.5 25181.5 2264.1 2266.9 2289.9 2318.7 2788.3 10840.3 10853.3 10886.1 10896.0 14054.2 1854.5 1928.1 1928.2 1952.4 1960.8 87787.6 89779.6 91068.0 91261.0 92343.0 11577.9 11702.9 11758.1 11820.7 11940.8 17021.1 17045.4 17066.3 17067.0 17071.7 8105.8 8489.0 8597.0 8679.8 8704.0 8304.6 8330.2 8357.1 8363.3 8523.5 4999.8 5106.4 5161.3 5225.5 5226.6 2113.2 2114.0 2154.6 2176.3 2220.2 923.5 1002.4 1047.3 1073.9 1087.7 18469.9 19887.2 19915.4 20549.2 20758.4 1036.3 1044.3 1059.1 1077.5 1105.5 10950.9 11285.5 11323.3 11338.3 11393.5 553206.0 566467.0 567656.0 568367.0 572172.0 61871.7 90499.0 90996.5 97170.0 101343.0 1064.1 1092.8 1119.3 1122.8 1125.2 18300.5 18306.4 18603.3 18838.9 19076.7 42520.0 43435.3 43467.6 44416.8 44681.3 59970.4 64655.0 65580.7 65619.3 66120.7 8456.5 8718.6 8800.0 8817.6 8877.7 12282.0 12746.7 12868.4 13167.3 13247.1 11539.0 11715.5 11746.4 11757.3 11834.6 11438.4 11498.8 11677.0 11712.6 11751.5 11385.6 11610.7 11730.7 11961.8 11968.6 7520.2 7982.3 8647.0 8805.2 8841.6 11220.9 11306.6 11442.5 11459.6 11487.8 10:58:36 INFO - PROCESS | 10461 | 10:58:36 INFO - PROCESS | 10461 | [#3] mootools.html Cycles:180 Average:6449.70 Median:4785.93 stddev:3750.25 (78.4%) stddev-sans-first:3742.83 10:58:36 INFO - PROCESS | 10461 | Values: 1567.7 1589.5 1768.5 1831.7 1865.7 8621.1 9056.1 9148.6 9782.3 9787.8 9275.6 9468.1 9738.3 9768.3 9785.9 2536.5 2596.8 2598.2 2610.1 2611.5 2523.5 2624.5 2632.6 2636.1 2636.3 2476.6 2549.3 2579.6 2586.3 2591.3 2493.5 2500.1 2537.7 2564.9 2569.3 2504.8 2516.5 2537.6 2561.5 2567.7 9794.2 9847.2 9892.7 9897.5 9912.9 5440.5 5603.4 5619.8 5625.2 5647.3 3625.2 3754.6 3827.2 3831.6 3840.0 1158.5 1175.3 1181.7 1240.0 1249.7 13511.3 13897.2 13986.4 14277.0 14371.2 5040.7 5043.1 5096.5 5142.9 5313.0 11792.3 11808.6 11849.1 11858.1 11886.2 5540.6 5541.6 5543.0 5543.0 5566.6 4570.0 4931.3 5015.2 5020.2 5051.6 4523.0 4569.9 4616.7 4634.6 4645.1 1391.9 1440.0 1463.9 1469.0 1475.9 1020.8 1058.7 1086.0 1094.1 1096.5 6507.0 6739.2 6749.0 6930.2 7024.2 462.1 468.3 469.1 487.4 492.1 4757.7 4785.8 4786.0 4806.3 4810.2 12084.1 12384.5 12446.4 12461.4 12627.8 12428.5 12430.9 12435.6 12462.1 12503.2 9008.6 9020.9 9121.1 9138.7 9181.5 6519.6 6538.2 6578.0 6612.2 6633.2 11019.5 11050.8 11223.1 11568.5 11571.9 11353.4 11377.6 11646.4 11693.5 11816.2 7740.9 8316.8 8519.6 8881.7 8944.2 9537.3 9593.3 9620.0 9631.9 9648.6 8425.2 8532.3 8554.4 8636.1 8667.6 8304.0 8359.2 8391.5 8392.3 8640.8 7591.4 7593.9 7613.7 7678.2 7691.8 5639.7 5796.1 5829.6 5949.1 5992.3 5693.7 5737.9 5789.5 5810.6 5843.9 10:58:36 INFO - PROCESS | 10461 | 10:58:36 INFO - PROCESS | 10461 | [#4] prototype.html Cycles:180 Average:4931.31 Median:5454.43 stddev:1431.69 (26.2%) stddev-sans-first:1393.82 10:58:36 INFO - PROCESS | 10461 | Values: 351.0 355.7 358.4 362.2 364.4 5818.1 5852.2 5871.2 5895.9 5910.0 5608.3 5707.4 5724.0 5790.1 5828.2 4466.8 4489.2 4506.8 4508.4 4511.3 4503.5 4517.3 4526.5 4537.3 4572.4 4482.1 4542.3 4550.9 4551.0 4555.6 4255.7 4422.9 4448.5 4461.2 4468.2 3951.2 3951.5 3954.1 3961.2 3978.7 5549.3 5590.0 5628.9 5631.5 5666.0 5013.5 5104.6 5106.9 5115.7 5119.8 5905.1 5956.8 5957.6 6031.9 6046.7 4258.6 4356.2 4363.2 4368.8 4369.9 6139.5 6264.8 6285.2 6287.6 6327.9 4423.1 4458.1 4459.9 4479.7 4500.6 4539.9 4545.2 4546.3 4548.7 4560.7 5014.9 5104.3 5145.9 5188.0 5195.3 6038.9 6064.5 6080.6 6082.8 6085.8 1553.2 1554.6 1554.9 1566.6 1574.8 945.3 986.9 987.4 996.7 1015.9 5155.5 5183.4 5189.0 5191.9 5222.3 5435.9 5467.5 5488.4 5490.3 5515.6 4944.3 5103.0 5153.3 5212.4 5216.2 2874.3 2900.0 2906.0 2919.4 2936.5 5555.9 5595.2 5609.7 5613.7 5654.2 5175.0 5480.0 5480.7 5493.5 5504.0 5590.7 5614.0 5625.5 5642.3 5655.3 5228.3 5428.6 5447.9 5460.9 5493.7 5326.1 5333.5 5340.5 5350.6 5409.1 6290.2 6484.8 6485.3 6512.7 6553.2 4426.1 4436.9 4438.8 4456.9 4471.8 6095.8 6156.5 6206.4 6231.5 6276.7 6052.5 6062.0 6090.0 6118.1 6120.5 5885.9 6121.3 6123.9 6127.6 6129.3 6040.8 6055.3 6079.5 6110.6 6115.2 6167.8 6170.2 6171.7 6179.9 6185.3 5788.5 5928.7 5960.8 5970.9 6024.3 10:58:36 INFO - PROCESS | 10461 | 10:58:36 INFO - PROCESS | 10461 | [#5] yui.html Cycles:180 Average:23221.52 Median:3794.57 stddev:34818.91 (917.6%) stddev-sans-first:34875.87 10:58:36 INFO - PROCESS | 10461 | Values: 795.6 819.8 861.8 896.5 929.7 15027.4 15468.4 16165.4 16180.7 16743.6 16125.8 16876.7 16881.6 16914.6 16973.2 858.1 870.5 876.7 879.1 882.7 842.9 866.6 873.1 873.6 875.0 921.5 926.6 927.4 931.9 932.7 923.3 926.9 928.0 929.0 931.7 679.1 681.1 681.3 681.6 682.8 14228.7 14251.2 14261.0 14262.3 14287.5 15736.0 15950.8 15959.7 15970.3 16026.2 11970.5 12029.3 12040.8 12119.9 12260.8 3884.8 3906.0 3944.9 3958.0 3995.3 70038.0 72569.0 91476.5 92186.0 92368.5 12238.7 12567.9 12664.7 12861.9 12871.1 22512.5 22832.7 22891.8 22913.9 22926.2 8537.1 8602.9 8832.2 9050.6 9116.5 4622.7 4674.3 4730.0 4751.9 4918.2 3579.7 3789.2 3800.0 3800.9 3811.1 656.1 658.7 661.4 661.6 684.6 806.8 814.5 817.0 847.3 873.9 9750.7 10053.7 10141.7 10282.9 10419.4 756.4 797.3 804.0 806.8 807.2 4927.5 5064.9 5074.5 5142.0 5146.9 112923.0 133536.0 138225.0 140736.0 143262.0 112297.0 113337.4 113869.0 115456.0 123398.4 101796.5 104155.5 104968.0 106157.0 108626.5 9606.7 9744.1 9781.3 9880.7 9959.3 50941.7 51255.0 60053.7 60089.1 62433.7 78904.6 79235.0 79837.0 79967.0 83985.0 13712.3 13737.7 13777.7 14278.6 14351.9 14277.6 14396.6 14612.3 14651.9 15071.8 12883.2 13400.9 13519.9 14545.8 14563.8 13610.9 13721.6 14850.3 14916.6 14924.7 13456.3 13647.5 14751.5 14805.3 14957.2 11476.8 12032.3 12517.6 12879.9 12888.0 12570.5 12756.9 12847.7 12972.9 13007.8 10:58:36 INFO - PROCESS | 10461 | -------- Summary: end -------- 10:58:36 INFO - PROCESS | 10461 | 10:58:37 INFO - TEST-INFO | 10461: exit 0 10:58:37 INFO - TEST-OK | dromaeo_css | took 1110059ms 10:58:37 INFO - TEST-START | kraken 10:58:37 INFO - operating with platform_type : linux_ 10:58:37 INFO - Initialising browser for kraken test... 10:58:37 INFO - TEST-INFO | started process 10700 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKjYGyO/profile http://localhost:55153/getInfo.html) 10:58:41 INFO - PROCESS | 10700 | __metrics Screen width/height:1600/1200 10:58:41 INFO - PROCESS | 10700 | colorDepth:24 10:58:41 INFO - PROCESS | 10700 | Browser inner width/height: 1024/697 10:58:41 INFO - PROCESS | 10700 | __metrics 10:58:41 ERROR - PROCESS | 10700 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 10:58:42 INFO - TEST-INFO | 10700: exit 0 10:58:42 INFO - Browser initialized. 10:58:42 INFO - Running cycle 1/1 for kraken test... 10:58:42 INFO - TEST-INFO | started process 10824 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKjYGyO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:58:54 INFO - PROCESS | 10824 | RSS: Main: 150597632 10:58:54 INFO - PROCESS | 10824 | 10:58:56 INFO - PROCESS | 10824 | Cycle 1(1): loaded http://localhost:55153/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55153/tests/kraken/driver.html?testName=audio-beat-detection) 10:58:57 INFO - PROCESS | 10824 | RSS: Main: 156807168 10:58:57 INFO - PROCESS | 10824 | 10:59:00 INFO - PROCESS | 10824 | Cycle 1(1): loaded http://localhost:55153/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55153/tests/kraken/driver.html?testName=audio-dft) 10:59:00 INFO - PROCESS | 10824 | RSS: Main: 155381760 10:59:00 INFO - PROCESS | 10824 | 10:59:03 INFO - PROCESS | 10824 | Cycle 1(1): loaded http://localhost:55153/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55153/tests/kraken/driver.html?testName=audio-fft) 10:59:04 INFO - PROCESS | 10824 | RSS: Main: 155791360 10:59:04 INFO - PROCESS | 10824 | 10:59:06 INFO - PROCESS | 10824 | Cycle 1(1): loaded http://localhost:55153/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55153/tests/kraken/driver.html?testName=audio-oscillator) 10:59:06 INFO - PROCESS | 10824 | RSS: Main: 156139520 10:59:06 INFO - PROCESS | 10824 | 10:59:09 INFO - PROCESS | 10824 | Cycle 1(1): loaded http://localhost:55153/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55153/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:59:09 INFO - PROCESS | 10824 | RSS: Main: 156348416 10:59:09 INFO - PROCESS | 10824 | 10:59:12 INFO - PROCESS | 10824 | Cycle 1(1): loaded http://localhost:55153/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55153/tests/kraken/driver.html?testName=imaging-darkroom) 10:59:13 INFO - PROCESS | 10824 | RSS: Main: 156233728 10:59:13 INFO - PROCESS | 10824 | 10:59:16 INFO - PROCESS | 10824 | Cycle 1(1): loaded http://localhost:55153/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55153/tests/kraken/driver.html?testName=imaging-desaturate) 10:59:17 INFO - PROCESS | 10824 | RSS: Main: 156811264 10:59:17 INFO - PROCESS | 10824 | 10:59:20 INFO - PROCESS | 10824 | Cycle 1(1): loaded http://localhost:55153/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55153/tests/kraken/driver.html?testName=json-parse-financial) 10:59:20 INFO - PROCESS | 10824 | RSS: Main: 156561408 10:59:20 INFO - PROCESS | 10824 | 10:59:22 INFO - PROCESS | 10824 | Cycle 1(1): loaded http://localhost:55153/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55153/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:59:23 INFO - PROCESS | 10824 | RSS: Main: 156151808 10:59:23 INFO - PROCESS | 10824 | 10:59:24 INFO - PROCESS | 10824 | Cycle 1(1): loaded http://localhost:55153/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55153/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:59:25 INFO - PROCESS | 10824 | RSS: Main: 155967488 10:59:25 INFO - PROCESS | 10824 | 10:59:27 INFO - PROCESS | 10824 | Cycle 1(1): loaded http://localhost:55153/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55153/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:59:28 INFO - PROCESS | 10824 | RSS: Main: 156508160 10:59:28 INFO - PROCESS | 10824 | 10:59:30 INFO - PROCESS | 10824 | Cycle 1(1): loaded http://localhost:55153/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55153/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:59:31 INFO - PROCESS | 10824 | RSS: Main: 156815360 10:59:31 INFO - PROCESS | 10824 | 10:59:33 INFO - PROCESS | 10824 | Cycle 1(1): loaded http://localhost:55153/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55153/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:59:34 INFO - PROCESS | 10824 | RSS: Main: 156762112 10:59:34 INFO - PROCESS | 10824 | 10:59:36 INFO - PROCESS | 10824 | Cycle 1(1): loaded http://localhost:55153/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55153/tests/kraken/driver.html?testName=ai-astar) 10:59:36 INFO - PROCESS | 10824 | RSS: Main: 159027200 10:59:36 INFO - PROCESS | 10824 | 10:59:36 INFO - PROCESS | 10824 | __start_tp_report 10:59:36 INFO - PROCESS | 10824 | _x_x_mozilla_page_load 10:59:36 INFO - PROCESS | 10824 | _x_x_mozilla_page_load_details 10:59:36 INFO - PROCESS | 10824 | |i|pagename|runs| 10:59:36 INFO - PROCESS | 10824 | |0;ai-astar;100;112;105;109;111;111;111;110;110;109 10:59:36 INFO - PROCESS | 10824 | |1;audio-beat-detection;145;117;142;174;117;139;145;121;190;117 10:59:36 INFO - PROCESS | 10824 | |2;audio-dft;162;163;164;162;162;161;159;162;161;161 10:59:36 INFO - PROCESS | 10824 | |3;audio-fft;80;75;75;183;76;74;74;76;169;75 10:59:36 INFO - PROCESS | 10824 | |4;audio-oscillator;83;83;154;83;84;84;130;92;83;135 10:59:36 INFO - PROCESS | 10824 | |5;imaging-gaussian-blur;117;117;117;117;117;118;117;118;117;117 10:59:36 INFO - PROCESS | 10824 | |6;imaging-darkroom;147;148;148;147;147;146;148;146;146;147 10:59:36 INFO - PROCESS | 10824 | |7;imaging-desaturate;95;95;95;98;95;94;95;95;96;94 10:59:36 INFO - PROCESS | 10824 | |8;json-parse-financial;52;50;52;52;51;52;52;52;52;53 10:59:36 INFO - PROCESS | 10824 | |9;json-stringify-tinderbox;60;60;60;59;60;59;59;59;60;60 10:59:36 INFO - PROCESS | 10824 | |10;stanford-crypto-aes;73;73;73;75;74;73;74;81;77;78 10:59:36 INFO - PROCESS | 10824 | |11;stanford-crypto-ccm;122;126;132;120;123;119;132;131;158;131 10:59:36 INFO - PROCESS | 10824 | |12;stanford-crypto-pbkdf2;155;157;160;157;157;152;154;150;150;151 10:59:36 INFO - PROCESS | 10824 | |13;stanford-crypto-sha256-iterative;64;61;66;61;61;62;61;61;61;64 10:59:36 INFO - PROCESS | 10824 | __end_tp_report 10:59:36 INFO - PROCESS | 10824 | __start_cc_report 10:59:36 INFO - PROCESS | 10824 | _x_x_mozilla_cycle_collect,876 10:59:36 INFO - PROCESS | 10824 | __end_cc_report 10:59:36 INFO - PROCESS | 10824 | __startTimestamp1476813576450__endTimestamp 10:59:36 INFO - PROCESS | 10824 | 10:59:36 INFO - PROCESS | 10824 | ------- Summary: start ------- 10:59:36 INFO - PROCESS | 10824 | Number of tests: 14 10:59:36 INFO - PROCESS | 10824 | 10:59:36 INFO - PROCESS | 10824 | [#0] ai-astar Cycles:10 Average:108.80 Median:110.50 stddev:3.65 (3.3%) stddev-sans-first:2.05 10:59:36 INFO - PROCESS | 10824 | Values: 100.0 112.0 105.0 109.0 111.0 111.0 111.0 110.0 110.0 109.0 10:59:36 INFO - PROCESS | 10824 | 10:59:36 INFO - PROCESS | 10824 | [#1] audio-beat-detection Cycles:10 Average:140.70 Median:143.50 stddev:25.06 (17.5%) stddev-sans-first:26.54 10:59:36 INFO - PROCESS | 10824 | Values: 145.0 117.0 142.0 174.0 117.0 139.0 145.0 121.0 190.0 117.0 10:59:36 INFO - PROCESS | 10824 | 10:59:36 INFO - PROCESS | 10824 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.34 (0.8%) stddev-sans-first:1.41 10:59:36 INFO - PROCESS | 10824 | Values: 162.0 163.0 164.0 162.0 162.0 161.0 159.0 162.0 161.0 161.0 10:59:36 INFO - PROCESS | 10824 | 10:59:36 INFO - PROCESS | 10824 | [#3] audio-fft Cycles:10 Average:95.70 Median:75.00 stddev:42.48 (56.6%) stddev-sans-first:44.68 10:59:36 INFO - PROCESS | 10824 | Values: 80.0 75.0 75.0 183.0 76.0 74.0 74.0 76.0 169.0 75.0 10:59:36 INFO - PROCESS | 10824 | 10:59:36 INFO - PROCESS | 10824 | [#4] audio-oscillator Cycles:10 Average:101.10 Median:83.00 stddev:27.41 (33.0%) stddev-sans-first:28.28 10:59:36 INFO - PROCESS | 10824 | Values: 83.0 83.0 154.0 83.0 84.0 84.0 130.0 92.0 83.0 135.0 10:59:36 INFO - PROCESS | 10824 | 10:59:36 INFO - PROCESS | 10824 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:59:36 INFO - PROCESS | 10824 | Values: 117.0 117.0 117.0 117.0 117.0 118.0 117.0 118.0 117.0 117.0 10:59:36 INFO - PROCESS | 10824 | 10:59:36 INFO - PROCESS | 10824 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 10:59:36 INFO - PROCESS | 10824 | Values: 147.0 148.0 148.0 147.0 147.0 146.0 148.0 146.0 146.0 147.0 10:59:36 INFO - PROCESS | 10824 | 10:59:36 INFO - PROCESS | 10824 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:1.14 (1.2%) stddev-sans-first:1.20 10:59:36 INFO - PROCESS | 10824 | Values: 95.0 95.0 95.0 98.0 95.0 94.0 95.0 95.0 96.0 94.0 10:59:36 INFO - PROCESS | 10824 | 10:59:36 INFO - PROCESS | 10824 | [#8] json-parse-financial Cycles:10 Average:51.80 Median:52.00 stddev:0.79 (1.5%) stddev-sans-first:0.83 10:59:36 INFO - PROCESS | 10824 | Values: 52.0 50.0 52.0 52.0 51.0 52.0 52.0 52.0 52.0 53.0 10:59:36 INFO - PROCESS | 10824 | 10:59:36 INFO - PROCESS | 10824 | [#9] json-stringify-tinderbox Cycles:10 Average:59.60 Median:60.00 stddev:0.52 (0.9%) stddev-sans-first:0.53 10:59:36 INFO - PROCESS | 10824 | Values: 60.0 60.0 60.0 59.0 60.0 59.0 59.0 59.0 60.0 60.0 10:59:36 INFO - PROCESS | 10824 | 10:59:36 INFO - PROCESS | 10824 | [#10] stanford-crypto-aes Cycles:10 Average:75.10 Median:74.50 stddev:2.73 (3.7%) stddev-sans-first:2.78 10:59:36 INFO - PROCESS | 10824 | Values: 73.0 73.0 73.0 75.0 74.0 73.0 74.0 81.0 77.0 78.0 10:59:36 INFO - PROCESS | 10824 | 10:59:36 INFO - PROCESS | 10824 | [#11] stanford-crypto-ccm Cycles:10 Average:129.40 Median:131.00 stddev:11.26 (8.6%) stddev-sans-first:11.62 10:59:36 INFO - PROCESS | 10824 | Values: 122.0 126.0 132.0 120.0 123.0 119.0 132.0 131.0 158.0 131.0 10:59:36 INFO - PROCESS | 10824 | 10:59:36 INFO - PROCESS | 10824 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.30 Median:156.00 stddev:3.47 (2.2%) stddev-sans-first:3.67 10:59:36 INFO - PROCESS | 10824 | Values: 155.0 157.0 160.0 157.0 157.0 152.0 154.0 150.0 150.0 151.0 10:59:36 INFO - PROCESS | 10824 | 10:59:36 INFO - PROCESS | 10824 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.20 Median:61.50 stddev:1.81 (2.9%) stddev-sans-first:1.80 10:59:36 INFO - PROCESS | 10824 | Values: 64.0 61.0 66.0 61.0 61.0 62.0 61.0 61.0 61.0 64.0 10:59:36 INFO - PROCESS | 10824 | -------- Summary: end -------- 10:59:36 INFO - PROCESS | 10824 | 10:59:37 INFO - TEST-INFO | 10824: exit 0 10:59:37 INFO - TEST-OK | kraken | took 60132ms 10:59:37 INFO - SUITE-END | took 1170s 10:59:37 INFO - Completed test suite (00:19:30) 10:59:37 INFO - javascript benchmark 10:59:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7823.61663892326, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3333.9833300833493, 3354.1949932016314, 3375.257443362461, 3376.409128402532, 3384.6446123157066, 5878.617889837163, 5962.8807423851495, 5979.581429299946, 5994.760209591611, 6017.669028203447, 5987.6407415555095, 6000.099985002252, 6000.789972350969, 6031.487323577501, 6050.606710563821, 5375.623706340548, 5434.592405569579, 5448.318960129984, 5493.23094766733, 5495.395506494282, 5480.013597552439, 5480.972595137038, 5495.313085864267, 5498.780048798043, 5517.034518959186, 5304.17785243286, 5316.20256961455, 5464.043792336345, 5468.48049435303, 5512.228288039678, 5331.0, 5437.13005919055, 5443.265159203516, 5444.373897001817, 5478.068728316196, 5344.091504444254, 5378.085725426687, 5389.9191512127345, 5411.756470958777, 5431.782728690887, 5757.050086735683, 5817.447342502498, 5925.259342582177, 5934.4257400616325, 6015.789447369321, 6268.247810262797, 6388.520860935449, 6395.136656551353, 6405.48756099511, 6426.839329016765, 6433.099366088752, 6437.517186211006, 6441.806745797634, 6445.581037232611, 6471.482281417475, 5806.477417032487, 5820.941790582125, 5975.43233392827, 5984.491318237955, 6023.819285421444, 6345.33373995733, 6479.611223326616, 6496.187976502937, 6513.283538810727, 6513.381228783258, 6207.068939658997, 6268.2478102627065, 6268.49852011838, 6268.717907694165, 6293.370662933761, 6181.8454538636, 6220.315765265817, 6320.683965801692, 6374.298827129012, 6376.776812811529, 6153.538484613672, 6281.748730050746, 6318.62088274705, 6330.8417289567205, 6341.175647165839, 6333.113364129025, 6335.3981371769605, 6354.936450635434, 6363.872722545523, 6390.968045159744, 4700.741459219776, 4771.689840160448, 4845.0, 4851.417829860439, 4896.926546101811, 4245.68157388191, 4293.742375457483, 4319.33050377192, 4347.739135651871, 4349.434573505424, 6146.0473626587955, 6158.137860699506, 6166.290876549254, 6202.41077097675, 6228.937710622927, 6148.538859585549, 6327.778527751507, 6398.328175541501, 6433.324500927335, 6443.838904027437, 6144.600600960924, 6189.071639254058, 6206.565540412128, 6232.532560058014, 6275.0, 5574.247476590689, 5578.8047418340975, 5578.967890940189, 5591.9720401397735, 5593.0, 6424.871502569922, 6459.063435801782, 6466.418022377915, 6739.393454589111, 6753.054572359873, 6408.61548307103, 6417.069524918954, 6420.711068002044, 6422.807315780534, 6424.807255782334, 6611.900821487778, 6664.700088496126, 6666.699998499982, 6668.133142691419, 6685.699143538455, 6008.579399442172, 6212.534059945432, 6212.689365531795, 6241.594296370721, 6306.117143599991, 6454.806355809334, 6475.352464753487, 6480.0, 6485.092087107714, 6501.674916254263, 6286.937130628635, 6295.937040629535, 6301.180846489927, 6327.082573026977, 6337.0, 5992.43071908168, 6188.0717892314715, 6204.317525072148, 6302.527310451826, 6308.71610777507, 6203.348648392034, 6204.627722336674, 6208.410201030895, 6230.7819226326865, 6267.905981410374, 6289.056641503811, 6353.523485738496, 6370.299267080525, 6392.264889537577, 6396.264429590657, 5971.940280597312, 6070.0591408331775, 6122.459144589048, 6137.907931381123, 6191.752329906753], "value": 5884.414448884524, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.6864293281628, 628.864794069275, 645.799802061361, 665.8668266346732, 720.7981765105773, 41536.792316038416, 45529.54470455299, 45688.54311456884, 45790.31314530285, 45800.77099614497, 47078.76460617701, 47226.527734722644, 47401.28898066532, 47604.52395476044, 47899.52100478994, 9173.357864949456, 9319.440833550008, 9322.394044387127, 9322.720318390458, 9325.95337023314, 9071.092890710943, 9099.863502047441, 9120.543972801366, 9158.954205228998, 9187.816243675123, 9235.492047937361, 9244.583993720298, 9274.953625231898, 9278.721638350826, 9282.257419406431, 9219.032001639833, 9236.0, 9242.214411775007, 9251.861222081641, 9257.537123143817, 9231.907680923172, 9267.165955064076, 9285.396449230779, 9288.442693438416, 9288.814223715555, 45372.77313613444, 45757.54242457566, 45821.0, 45882.311765323546, 45912.77043614794, 3638.3632864248916, 3945.585713500099, 4021.4369988201674, 4231.97884010581, 4269.722468039598, 35236.64763352359, 35323.29353412943, 35461.82269088664, 35485.0, 35617.10957226064, 4482.238019536687, 4525.547445255481, 4548.818047278105, 4553.453585569753, 4633.4671512775785, 378338.0, 379992.0, 380526.0973695142, 382053.0, 383084.0, 64793.352066479674, 64812.351876481574, 65026.0, 65104.67447662731, 65204.673976630766, 67470.32529674738, 67706.0, 67720.0, 67781.66109169423, 68049.65975170191, 17048.65902681964, 17718.202680879393, 17819.821801781814, 18244.63510729778, 18271.26914923388, 13526.0, 13650.385732642055, 13671.863281367258, 13695.589132326046, 13711.108777929403, 20537.0, 20548.38354849357, 20699.172033118506, 20796.79203207979, 20878.582428351347, 7457.366123879422, 7530.209328020479, 7598.35413989806, 7767.417443691746, 7814.452988290879, 1066.3974854207347, 1136.6817291158488, 1162.8546431696038, 1174.5654107980101, 1176.053277111916, 34909.82545087258, 35204.119897002776, 35245.118872028404, 35421.64578354183, 35849.64150358515, 1201.7055821323656, 1208.5649166300125, 1227.7298994221258, 1232.8643849176583, 1244.104244943639, 18318.0, 18326.083695815156, 18498.722519162224, 18560.907195463937, 18598.349057783184, 630896.0, 635219.0, 635641.0, 638059.0, 640132.0, 66737.33262667408, 67376.32623673798, 67449.66275168593, 67477.66261168662, 67648.0, 1459.4672944375438, 1460.2844606142914, 1471.0805746408494, 1475.3655927951083, 1507.9547613571392, 32620.0, 33838.32323353568, 33934.0, 34454.31091378108, 34587.0, 57109.0, 57678.423215768984, 57877.71061144667, 57895.71052144712, 58137.0, 486254.0, 487008.0, 487900.0, 488184.0, 488318.0, 32420.35159296848, 32456.188595285308, 32949.83525082359, 33062.17344566405, 33129.337413252084, 53070.46929530655, 53649.19526207188, 53835.19247211373, 54160.729196353765, 54905.0, 44997.77501112474, 47185.0, 47293.29060064033, 47516.76241618908, 48532.2720159205, 45876.0, 47047.29429058635, 47359.28961065518, 47401.52598473971, 48191.5180848187, 41680.0, 43837.78081109574, 44761.55238447574, 45682.771586141855, 49222.261666075756, 40472.79763601163, 41376.0, 41463.37804932989, 41577.58422415737, 42064.579354206064, 31007.224819379695, 31133.8443307782, 31433.52849707302, 31984.520232197003, 32047.198820029687], "value": 22038.182385903125, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.144705988006, 398.2731514985153, 430.6296584936954, 431.4154320895186, 439.71418577924356, 19152.42542723717, 19972.800271997276, 20493.282735104276, 20759.792402075993, 20861.374158775223, 19639.705404418946, 20432.591348173028, 20641.277555285567, 20752.169913203492, 20766.79233207671, 5463.672179669223, 5589.608727389084, 5596.244506991545, 5605.915911261334, 5625.6905870177325, 5693.658380497183, 5849.122631605251, 5882.588218824684, 6016.127661489081, 6032.065029920369, 5987.341392446828, 6005.879882402372, 6009.09863520471, 6025.879482410349, 6048.3346831848685, 5892.587518873681, 5927.962606543838, 5962.582619216657, 5998.460138587505, 6006.609570377911, 5927.733252003627, 6071.150038994544, 6073.878522429571, 6077.36187700294, 6077.635341879457, 14987.100773953598, 17388.56528586783, 20111.0, 25071.498570028678, 25181.49637007268, 2264.116994372196, 2266.9206577769864, 2289.9198528051606, 2318.7101612298293, 2788.3168623687125, 10840.349579025205, 10853.34879907208, 10886.129109671207, 10896.0, 14054.156750594895, 1854.545636319097, 1928.0745242283642, 1928.2287085166047, 1952.4045166224296, 1960.8431325493925, 87787.56106219492, 89779.55110224472, 91068.0, 91261.0, 92343.0, 11577.884221157849, 11702.941485292518, 11758.118141139448, 11820.70448238801, 11940.761184776256, 17021.06384148859, 17045.40341088056, 17066.31734730597, 17067.0, 17071.743923841153, 8105.797355066053, 8488.957555212308, 8596.957015214884, 8679.826403472021, 8704.0, 8304.584770761438, 8330.208630180123, 8357.080721120672, 8363.330933525303, 8523.488590684456, 4999.775010124553, 5106.412762532282, 5161.2516185152945, 5225.4774522548205, 5226.5818734501145, 2113.2181092995384, 2113.9577208455744, 2154.6229409853213, 2176.33621745366, 2220.2118248022043, 923.4643906534194, 1002.4488820753842, 1047.3349423116376, 1073.897979691928, 1087.6736978906297, 18469.90765046166, 19887.204511819655, 19915.402537923885, 20549.178032878815, 20758.377248682562, 1036.3419228789621, 1044.2533588484118, 1059.1103473082494, 1077.5258886090096, 1105.4969988655143, 10950.890491094988, 11285.492152853141, 11323.320600763816, 11338.2630129043, 11393.487293071666, 553206.0, 566467.0, 567656.0, 568367.0, 572172.0, 61871.690641546506, 90499.0, 90996.54501727581, 97170.0, 101343.0, 1064.1061508332882, 1092.7759809239246, 1119.3339962722168, 1122.7586068995206, 1125.189863298424, 18300.542486437946, 18306.359277425225, 18603.255869765057, 18838.905805470884, 19076.713849291995, 42520.0, 43435.34846977235, 43467.56532434635, 44416.7779161115, 44681.32978005397, 59970.40029599648, 64655.0, 65580.67209663922, 65619.34380656324, 66120.66939665463, 8456.492610443393, 8718.60766265507, 8800.0, 8817.647294108421, 8877.689280875138, 12282.0, 12746.745065098832, 12868.420921058387, 13167.341632918124, 13247.138935969131, 11539.0, 11715.472803724024, 11746.353950532803, 11757.294562326288, 11834.585789497327, 11438.37088960082, 11498.770024599295, 11677.0, 11712.648620541397, 11751.47118379692, 11385.601503947322, 11610.6516804496, 11730.70673233176, 11961.820572691591, 11968.581099661471, 7520.210377910241, 7982.321502672105, 8647.0, 8805.207531322212, 8841.646334146562, 11220.887791121984, 11306.604268850551, 11442.542298307975, 11459.598914037968, 11487.8276825846], "value": 9604.801465512044, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1567.7334853074976, 1589.4516391844813, 1768.4694591622517, 1831.7343985122166, 1865.7201419787039, 8621.05168431472, 9056.13966673165, 9148.58831352589, 9782.26633002524, 9787.755306117342, 9275.582598783054, 9468.147866691996, 9738.269629777777, 9768.267379946516, 9785.902140978587, 2536.4673418582074, 2596.792256619475, 2598.22053383985, 2610.138654244095, 2611.503814275291, 2523.470071285032, 2624.4619852930105, 2632.605109233611, 2636.1037247335903, 2636.3277364272085, 2476.6037434010564, 2549.3499157714755, 2579.57437022891, 2586.2629150692055, 2591.326255173659, 2493.47636996231, 2500.087468074158, 2537.746225377466, 2564.923052308415, 2569.293444302813, 2504.7745702886646, 2516.484120755241, 2537.581299085649, 2561.5005074010573, 2567.679040119985, 9794.16749576287, 9847.212223022212, 9892.703218903373, 9897.4556399398, 9912.90087099127, 5440.455954404568, 5603.3836278009385, 5619.803306884281, 5625.212470254168, 5647.29408823897, 3625.23869987303, 3754.5869954305003, 3827.158025234444, 3831.5593706723525, 3839.9616003840165, 1158.5192145259707, 1175.2830773228325, 1181.6691326428613, 1239.962801115968, 1249.6875781054737, 13511.324433778273, 13897.16617002983, 13986.440542378394, 14277.0, 14371.209583472904, 5040.7479626019285, 5043.067032598908, 5096.490350964874, 5142.922856157161, 5312.9734351328, 11792.29246245228, 11808.586699465477, 11849.052075833913, 11858.051355891508, 11886.227395219283, 5540.584456165804, 5541.6120871539415, 5542.974549708317, 5543.029969755276, 5566.610337276352, 4569.954300456953, 4931.260310953386, 5015.22264049073, 5020.221865610836, 5051.570616497639, 4523.0, 4569.908601827945, 4616.6537509686905, 4634.606058484999, 4645.070985802853, 1391.902566820333, 1439.9712005760036, 1463.8609332113433, 1468.9779653305209, 1475.8819294456418, 1020.8264595018716, 1058.7459009837582, 1085.9674209773718, 1094.0919037199105, 1096.5010920031366, 6506.967465162644, 6739.191297044386, 6748.966255168692, 6930.237673855871, 7024.1571011478945, 462.145031691375, 468.27651278774374, 469.1250817225849, 487.4053654541454, 492.12156301003256, 4757.666963312604, 4785.832495862698, 4786.018866132435, 4806.303086052503, 4810.182269014276, 12084.093692972887, 12384.504619815107, 12446.439910204062, 12461.439235234437, 12627.810582841264, 12428.502859885502, 12430.875691242973, 12435.626931192079, 12462.12765106452, 12503.18729282612, 9008.59461324242, 9020.909790902138, 9121.133492318218, 9138.725838224997, 9181.54092295396, 6519.576227545194, 6538.248101468202, 6578.0, 6612.23959244693, 6633.2371777246235, 11019.504122314354, 11050.834237486604, 11223.10215182767, 11568.537258509565, 11571.884281157081, 11353.37556434404, 11377.601783937522, 11646.359450230319, 11693.532258709556, 11816.172867899164, 7740.883886741591, 8316.750497485085, 8519.616617252363, 8881.689140880038, 8944.195022447751, 9537.284703647116, 9593.328467007243, 9620.0, 9631.855522167314, 9648.565814538502, 8425.241728244488, 8532.274756645505, 8554.401191916506, 8636.050034496326, 8667.609957552051, 8303.95848020756, 8359.205875441823, 8391.454555453876, 8392.28665563434, 8640.82718345617, 7591.3547348473785, 7593.8860917085185, 7613.695452181851, 7678.155402905788, 7691.769246922601, 5639.7180140993605, 5796.101604251347, 5829.59192856496, 5949.1076338549565, 5992.340842507234, 5693.715314234189, 5737.885242295048, 5789.507891829242, 5810.622309549865, 5843.94156058451], "value": 5044.572559546457, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.97192224622034, 355.6603443711255, 358.446200620042, 362.21941715602884, 364.3787342580898, 5818.127280907861, 5852.209951656525, 5871.2367392239, 5895.911561326584, 5909.970450147744, 5608.298962629671, 5707.400722924085, 5723.9713801430935, 5790.073588225885, 5828.213191219184, 4466.79899404526, 4489.214387482186, 4506.752128632924, 4508.368828364031, 4511.323301504768, 4503.527129651388, 4517.344984977176, 4526.479454862683, 4537.319402089696, 4572.382728331666, 4482.148391805546, 4542.341360502725, 4550.929327156136, 4551.044280701057, 4555.567221114005, 4255.702100852942, 4422.889427764299, 4448.488423831236, 4461.196984542781, 4468.218061839198, 3951.209758048402, 3951.486306780129, 3954.130091379892, 3961.207758448293, 3978.741381810173, 5549.278593782823, 5589.972050139723, 5628.9305032043785, 5631.521320687705, 5666.045214401025, 5013.54607163922, 5104.64267501275, 5106.923396149061, 5115.693058416507, 5119.795208191705, 5905.114232865061, 5956.791512297049, 5957.6127551709, 6031.8793624127275, 6046.706838144923, 4258.6380157686635, 4356.215881141393, 4363.236433624134, 4368.825246990116, 4369.868903932887, 6139.465133716571, 6264.812055638338, 6285.214348206474, 6287.616724320688, 6327.936720632781, 4423.115376924564, 4458.130664520388, 4459.888502787457, 4479.670571302904, 4500.594946454835, 4539.863804085882, 4545.204589196877, 4546.272596384562, 4548.703619468436, 4560.749158796298, 5014.871653877848, 5104.302509507939, 5145.897082058338, 5187.950759449996, 5195.324607801037, 6038.879222415527, 6064.514838812885, 6080.635161890301, 6082.817515474543, 6085.756569737161, 1553.2156261088305, 1554.6113471632093, 1554.9426390054646, 1566.644852202859, 1574.7559128335126, 945.3004776465366, 986.9439699521444, 987.4223579206101, 996.689353500145, 1015.8527013582989, 5155.484451554815, 5183.352080989876, 5188.9740551297, 5191.922121168185, 5222.302751605744, 5435.891282174334, 5467.507924286754, 5488.396276409591, 5490.313710786152, 5515.61390702655, 4944.283078953532, 5103.0, 5153.330067091254, 5212.374515058142, 5216.200410858248, 2874.2526942994973, 2900.0429858146763, 2905.985470072636, 2919.4161167766533, 2936.500794864878, 5555.888822235569, 5595.244641973363, 5609.663420194802, 5613.687924124704, 5654.180143879197, 5174.9650069986155, 5479.972600136974, 5480.698561579072, 5493.450654934474, 5503.972480137573, 5590.664560126405, 5613.971930140405, 5625.521830644441, 5642.322921249394, 5655.321361436654, 5228.294534918604, 5428.59285553593, 5447.945520544744, 5460.91808622863, 5493.725313734377, 5326.0826102603805, 5333.5465685784975, 5340.546053585489, 5350.625456218183, 5409.052741013311, 6290.175849003921, 6484.790028935518, 6485.319041500575, 6512.697460507823, 6553.246376666553, 4426.1369033038245, 4436.911261774811, 4438.755868427267, 4456.888577785451, 4471.821127154877, 6095.75616975316, 6156.476699480594, 6206.410391012847, 6231.53263505248, 6276.686165691606, 6052.515798736179, 6062.030075187949, 6090.0, 6118.143459915705, 6120.540959427972, 5885.882282354414, 6121.296050954019, 6123.938760612336, 6127.632342059491, 6129.295131059806, 6040.75836966534, 6055.273367195965, 6079.544034197541, 6110.602810817282, 6115.205023346936, 6167.784127555514, 6170.228721409824, 6171.722272497658, 6179.907301390393, 6185.319614842274, 5788.479036886701, 5928.673922934107, 5960.76156953717, 5970.910436343545, 6024.337322894566], "value": 4476.815065814572, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [795.6459375577866, 819.8483280593094, 861.8362511122887, 896.5069211933437, 929.6792606550738, 15027.39890404384, 15468.38126474941, 16165.353385864551, 16180.676386472263, 16743.581410464743, 16125.83874161261, 16876.746848797247, 16881.577960550992, 16914.577135571617, 16973.2362043708, 858.107568129145, 870.5168631409565, 876.701921346742, 879.0857508191473, 882.7263548300016, 842.8904242448473, 866.5537248317122, 873.057098333798, 873.6112429968634, 875.0199776250577, 921.4563407589521, 926.5598840550718, 927.3740225347897, 931.9021502742216, 932.724846170378, 923.3305853256403, 926.8841394825647, 928.0302084321866, 928.9674861379887, 931.74842792446, 679.0730652659084, 681.0839420978825, 681.2778454837887, 681.6080753566719, 682.7712716240065, 14228.715425691531, 14251.216183109926, 14261.0, 14262.286885655676, 14287.499937502138, 15736.0, 15950.840491595052, 15959.680806383923, 15970.281337339848, 16026.198690065567, 11970.521179152824, 12029.278243305429, 12040.759184816343, 12119.878801211964, 12260.81608775869, 3884.766913985142, 3906.0, 3944.9013774655577, 3958.0, 3995.320795464778, 70038.0, 72569.0, 91476.54261728715, 92186.0, 92368.53815730945, 12238.694032649255, 12567.937160314323, 12664.6833829155, 12861.935690321676, 12871.099023068295, 22512.549749004927, 22832.65751013736, 22891.771082288964, 22913.88543057274, 22926.19758308451, 8537.060923298432, 8602.913970860336, 8832.205101540892, 9050.592723327467, 9116.49859257734, 4622.6764126510825, 4674.252119660906, 4729.983053643415, 4751.8574442766085, 4918.163912134945, 3579.731520136, 3789.1853251551047, 3799.962000379961, 3800.8859734208017, 3811.104390468238, 656.1306269193337, 658.6574981009848, 661.444386715152, 661.5865084322298, 684.6131935456451, 806.790234539024, 814.5484924885529, 817.0219549741279, 847.2713466418875, 873.8601823708176, 9750.658726944665, 10053.69838904834, 10141.695749127539, 10282.897171028193, 10419.374837509773, 756.3797685897512, 797.3063434811751, 803.9839203215903, 806.766037849029, 807.1968391450545, 4927.507249275115, 5064.949350506447, 5074.4671809460215, 5141.974290128525, 5146.897062058738, 112923.0, 133536.0, 138225.0, 140736.0, 143262.0, 112297.0, 113337.4333128329, 113869.0, 115456.0, 123398.38300808618, 101796.49101754444, 104155.4792226034, 104968.0, 106157.0, 108626.45686771515, 9606.711798646053, 9744.101361799714, 9781.320049813201, 9880.703578892644, 9959.302848800515, 50941.74529127479, 51255.0, 60053.69973150106, 60089.098663520956, 62433.68783156055, 78904.60547697225, 79235.0, 79837.0, 79967.0, 83985.0, 13712.286751990629, 13737.725245495234, 13777.724445511234, 14278.571642850731, 14351.856481435052, 14277.571672849832, 14396.640083997983, 14612.269386530843, 14651.92674036623, 15071.849281507044, 12883.162594431333, 13400.93299533496, 13519.864801351861, 14545.781813272597, 14563.781543277071, 13610.86389136096, 13721.588352349445, 14850.257487125817, 14916.55250342448, 14924.701505969602, 13456.25990570528, 13647.522336718168, 14751.483698070946, 14805.259737012891, 14957.17735524513, 11476.770464590494, 12032.338221397908, 12517.56188533397, 12879.935600321938, 12888.0, 12570.497180112692, 12756.87243127594, 12847.678808029874, 12972.870271297166, 13007.804882926574], "value": 8151.591227013053, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1499.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 112.0, 105.0, 109.0, 111.0, 111.0, 111.0, 110.0, 110.0, 109.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 117.0, 142.0, 174.0, 117.0, 139.0, 145.0, 121.0, 190.0, 117.0], "value": 140.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 164.0, 162.0, 162.0, 161.0, 159.0, 162.0, 161.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 75.0, 75.0, 183.0, 76.0, 74.0, 74.0, 76.0, 169.0, 75.0], "value": 95.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 154.0, 83.0, 84.0, 84.0, 130.0, 92.0, 83.0, 135.0], "value": 101.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 147.0, 147.0, 146.0, 148.0, 146.0, 146.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 98.0, 95.0, 94.0, 95.0, 95.0, 96.0, 94.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 50.0, 52.0, 52.0, 51.0, 52.0, 52.0, 52.0, 52.0, 53.0], "value": 51.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 59.0, 60.0, 59.0, 59.0, 59.0, 60.0, 60.0], "value": 59.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 75.0, 74.0, 73.0, 74.0, 81.0, 77.0, 78.0], "value": 75.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 126.0, 132.0, 120.0, 123.0, 119.0, 132.0, 131.0, 158.0, 131.0], "value": 129.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 157.0, 160.0, 157.0, 157.0, 152.0, 154.0, 150.0, 150.0, 151.0], "value": 154.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 61.0, 66.0, 61.0, 61.0, 62.0, 61.0, 61.0, 61.0, 64.0], "value": 62.2, "unit": "score"}]}]} 10:59:37 INFO - Return code: 0 10:59:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:59:37 ERROR - # TBPL SUCCESS # 10:59:37 INFO - Running post-action listener: _resource_record_post_action 10:59:37 INFO - [mozharness: 2016-10-18 17:59:37.747873Z] Finished run-tests step (success) 10:59:37 INFO - Running post-run listener: _resource_record_post_run 10:59:37 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 1929216; Write bytes: 291504128; Read time: 96; Write time: 186716 10:59:37 INFO - TinderboxPrint: CPU usage
13.2% 10:59:37 INFO - TinderboxPrint: I/O read bytes / time
1,929,216 / 96 10:59:37 INFO - TinderboxPrint: I/O write bytes / time
291,504,128 / 186,716 10:59:37 INFO - TinderboxPrint: CPU idle
8,197.9 (86.8%) 10:59:37 INFO - TinderboxPrint: CPU user
1,198.0 (12.7%) 10:59:37 INFO - TinderboxPrint: Swap in / out
0 / 0 10:59:37 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 70074368; Read time: 0; Write time: 71480 10:59:37 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 196608; Write bytes: 221429760; Read time: 56; Write time: 115236 10:59:38 INFO - Running post-run listener: _upload_blobber_files 10:59:38 INFO - Blob upload gear active. 10:59:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:59:38 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 10:59:38 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:59:38 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:59:38 INFO - (blobuploader) - INFO - Open directory for files ... 10:59:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:59:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:59:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:59:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:59:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:59:39 INFO - (blobuploader) - INFO - Done attempting. 10:59:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:59:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:59:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:59:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:59:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:59:40 INFO - (blobuploader) - INFO - Done attempting. 10:59:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:59:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:59:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:59:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:59:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:59:45 INFO - (blobuploader) - INFO - Done attempting. 10:59:45 INFO - (blobuploader) - INFO - Iteration through files over. 10:59:45 INFO - Return code: 0 10:59:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:59:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:59:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/065b481d9744e6c9dae5f34ab5d285f10d61794c5f79d97666ec6e31a07fe3312e3e3793b5ec8eb6f2f92a256e9e3dd070c1a01999100c898d1bc1aee574d2ce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ff67e8ad64842797e96d77f15dced51b0e55bd2b77971d18d4d1ba1aa3b1077452ffa0cc869fb51a53a55d7da8538c8a01e9c67835ba4d0120191e15a3fbbc12", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8ff24f65e65f08e0b5a9b64cf98170a207d5a198b53faef243cec2169f3cb5bba649fb4c5ee3383266909617b0fa75a62df63ef85ede548335398ac920b7636e"} 10:59:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:59:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:59:45 INFO - Contents: 10:59:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/065b481d9744e6c9dae5f34ab5d285f10d61794c5f79d97666ec6e31a07fe3312e3e3793b5ec8eb6f2f92a256e9e3dd070c1a01999100c898d1bc1aee574d2ce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ff67e8ad64842797e96d77f15dced51b0e55bd2b77971d18d4d1ba1aa3b1077452ffa0cc869fb51a53a55d7da8538c8a01e9c67835ba4d0120191e15a3fbbc12", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8ff24f65e65f08e0b5a9b64cf98170a207d5a198b53faef243cec2169f3cb5bba649fb4c5ee3383266909617b0fa75a62df63ef85ede548335398ac920b7636e"} 10:59:45 INFO - Running post-run listener: copy_logs_to_upload_dir 10:59:45 INFO - Copying logs to upload dir... 10:59:45 INFO - mkdir: /builds/slave/test/build/upload/logs 10:59:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1680.536282 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 0 secs) (at 2016-10-18 10:59:45.120575) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-18 10:59:45.126400) ========= 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=0333a256a5e4f052382dd180000001b1-1476811776.911966-932705347 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-Beta/sha512/065b481d9744e6c9dae5f34ab5d285f10d61794c5f79d97666ec6e31a07fe3312e3e3793b5ec8eb6f2f92a256e9e3dd070c1a01999100c898d1bc1aee574d2ce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ff67e8ad64842797e96d77f15dced51b0e55bd2b77971d18d4d1ba1aa3b1077452ffa0cc869fb51a53a55d7da8538c8a01e9c67835ba4d0120191e15a3fbbc12", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8ff24f65e65f08e0b5a9b64cf98170a207d5a198b53faef243cec2169f3cb5bba649fb4c5ee3383266909617b0fa75a62df63ef85ede548335398ac920b7636e"} build_url:https://queue.taskcluster.net/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011433 build_url: 'https://queue.taskcluster.net/v1/task/f0NdiXdYTi6DwqQaWAHnKw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/065b481d9744e6c9dae5f34ab5d285f10d61794c5f79d97666ec6e31a07fe3312e3e3793b5ec8eb6f2f92a256e9e3dd070c1a01999100c898d1bc1aee574d2ce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ff67e8ad64842797e96d77f15dced51b0e55bd2b77971d18d4d1ba1aa3b1077452ffa0cc869fb51a53a55d7da8538c8a01e9c67835ba4d0120191e15a3fbbc12", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8ff24f65e65f08e0b5a9b64cf98170a207d5a198b53faef243cec2169f3cb5bba649fb4c5ee3383266909617b0fa75a62df63ef85ede548335398ac920b7636e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-18 10:59:45.152491) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 10:59:45.152847) ========= 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=0333a256a5e4f052382dd180000001b1-1476811776.911966-932705347 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004558 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 10:59:45.235669) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-18 10:59:45.236000) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-18 10:59:45.236343) ========= ========= Total master_lag: 0.17 =========