builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-058 starttime: 1478388021.26 results: success (0) buildid: 20161103181821 builduid: d984d1bb7c314f73889b19df79c575c9 revision: 24b8f08f77565f859898b45f62d2132ccc64c6d8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-05 16:20:21.262667) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-05 16:20:21.263171) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-05 16:20:21.263511) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-05 16:20:21.278461) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 16:20:21.278861) ========= 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=0e2a256762fed810e2f0f810000001b3-1478388020.996873-1638991663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-05 16:20:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-11-05 16:20:21 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.074736 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 16:20:21.368000) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 16:20:21.368360) ========= 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=0e2a256762fed810e2f0f810000001b3-1478388020.996873-1638991663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013279 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 16:20:21.417830) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 16:20:21.418700) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 24b8f08f77565f859898b45f62d2132ccc64c6d8 --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 24b8f08f77565f859898b45f62d2132ccc64c6d8 --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=0e2a256762fed810e2f0f810000001b3-1478388020.996873-1638991663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-05 16:20:21,853 truncating revision to first 12 chars 2016-11-05 16:20:21,854 Setting DEBUG logging. 2016-11-05 16:20:21,854 attempt 1/10 2016-11-05 16:20:21,854 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/24b8f08f7756?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-05 16:20:22,344 unpacking tar archive at: mozilla-beta-24b8f08f7756/testing/mozharness/ program finished with exit code 0 elapsedTime=0.816081 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 16:20:22.250624) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-05 16:20:22.251004) ========= script_repo_revision: 24b8f08f77565f859898b45f62d2132ccc64c6d8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-05 16:20:22.251440) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-05 16:20:22.251760) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-05 16:20:22.262402) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 52 secs) (at 2016-11-05 16:20:22.262750) ========= /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=0e2a256762fed810e2f0f810000001b3-1478388020.996873-1638991663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:20:22 INFO - MultiFileLogger online at 20161105 16:20:22 in /builds/slave/test 16:20:22 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 16:20:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:20:22 INFO - {'append_to_log': False, 16:20:22 INFO - 'base_work_dir': '/builds/slave/test', 16:20:22 INFO - 'blob_upload_branch': 'Mozilla-Beta', 16:20:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:20:22 INFO - 'branch': 'Mozilla-Beta', 16:20:22 INFO - 'buildbot_json_path': 'buildprops.json', 16:20:22 INFO - 'config_files': ('talos/linux_config.py',), 16:20:22 INFO - 'default_actions': ('clobber', 16:20:22 INFO - 'read-buildbot-config', 16:20:22 INFO - 'download-and-extract', 16:20:22 INFO - 'populate-webroot', 16:20:22 INFO - 'create-virtualenv', 16:20:22 INFO - 'install', 16:20:22 INFO - 'run-tests'), 16:20:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:20:22 INFO - 'download_minidump_stackwalk': True, 16:20:22 INFO - 'download_symbols': 'ondemand', 16:20:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:20:22 INFO - 'tooltool.py': '/tools/tooltool.py', 16:20:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:20:22 INFO - '/tools/misc-python/virtualenv.py')}, 16:20:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:20:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:20:22 INFO - 'installer_path': 'installer.exe', 16:20:22 INFO - 'log_level': 'info', 16:20:22 INFO - 'log_name': 'talos', 16:20:22 INFO - 'log_to_console': True, 16:20:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:20:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:20:22 INFO - 'opt_config_files': (), 16:20:22 INFO - 'pip_index': False, 16:20:22 INFO - 'sps_profile': False, 16:20:22 INFO - 'sps_profile_interval': 0, 16:20:22 INFO - 'suite': 'dromaeojs-e10s', 16:20:22 INFO - 'system_bits': '32', 16:20:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:20:22 INFO - 'title': 'talos-linux64-ix-058', 16:20:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:20:22 INFO - 'use_talos_json': True, 16:20:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:20:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:20:22 INFO - 'work_dir': 'build'} 16:20:22 INFO - [mozharness: 2016-11-05 23:20:22.791426Z] Running clobber step. 16:20:22 INFO - Running pre-action listener: _resource_record_pre_action 16:20:22 INFO - Running main action method: clobber 16:20:22 INFO - rmtree: /builds/slave/test/build 16:20:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:20:23 INFO - Running post-action listener: _resource_record_post_action 16:20:23 INFO - [mozharness: 2016-11-05 23:20:23.284364Z] Finished clobber step (success) 16:20:23 INFO - [mozharness: 2016-11-05 23:20:23.284466Z] Running read-buildbot-config step. 16:20:23 INFO - Running pre-action listener: _resource_record_pre_action 16:20:23 INFO - Running main action method: read_buildbot_config 16:20:23 INFO - Using buildbot properties: 16:20:23 INFO - { 16:20:23 INFO - "project": "", 16:20:23 INFO - "product": "firefox", 16:20:23 INFO - "script_repo_revision": "production", 16:20:23 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 16:20:23 INFO - "repository": "", 16:20:23 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 16:20:23 INFO - "buildid": "20161103181821", 16:20:23 INFO - "pgo_build": "True", 16:20:23 INFO - "basedir": "/builds/slave/test", 16:20:23 INFO - "buildnumber": 180, 16:20:23 INFO - "slavename": "talos-linux64-ix-058", 16:20:23 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:20:23 INFO - "platform": "ubuntu64_hw", 16:20:23 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 16:20:23 INFO - "branch": "mozilla-beta", 16:20:23 INFO - "repo_path": "releases/mozilla-beta", 16:20:23 INFO - "revision": "24b8f08f77565f859898b45f62d2132ccc64c6d8", 16:20:23 INFO - "stage_platform": "linux64-pgo", 16:20:23 INFO - "builduid": "d984d1bb7c314f73889b19df79c575c9", 16:20:23 INFO - "slavebuilddir": "test" 16:20:23 INFO - } 16:20:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/cPEudMkWRHGTOZCvuHLilg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2. 16:20:23 INFO - Running post-action listener: _resource_record_post_action 16:20:23 INFO - [mozharness: 2016-11-05 23:20:23.286908Z] Finished read-buildbot-config step (success) 16:20:23 INFO - [mozharness: 2016-11-05 23:20:23.286998Z] Running download-and-extract step. 16:20:23 INFO - Running pre-action listener: _resource_record_pre_action 16:20:23 INFO - Running main action method: download_and_extract 16:20:23 INFO - mkdir: /builds/slave/test/build/tests 16:20:23 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')]} 16:20:23 INFO - https://queue.taskcluster.net/v1/task/cPEudMkWRHGTOZCvuHLilg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:20:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPEudMkWRHGTOZCvuHLilg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 16:20:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPEudMkWRHGTOZCvuHLilg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 16:20:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPEudMkWRHGTOZCvuHLilg/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 16:20:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPEudMkWRHGTOZCvuHLilg/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 16:20:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPEudMkWRHGTOZCvuHLilg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 16:20:23 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 16:20:23 INFO - retry: Failed, sleeping 30 seconds before retrying 16:20:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPEudMkWRHGTOZCvuHLilg/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 16:20:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPEudMkWRHGTOZCvuHLilg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 16:20:53 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 16:20:53 INFO - retry: Failed, sleeping 60 seconds before retrying 16:21:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPEudMkWRHGTOZCvuHLilg/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 16:21:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPEudMkWRHGTOZCvuHLilg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 16:21:53 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 16:21:53 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPEudMkWRHGTOZCvuHLilg/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! 16:21:53 INFO - Caught exception: HTTP Error 404: Not Found 16:21:53 INFO - Caught exception: HTTP Error 404: Not Found 16:21:53 INFO - Caught exception: HTTP Error 404: Not Found 16:21:53 INFO - trying https://queue.taskcluster.net/v1/task/cPEudMkWRHGTOZCvuHLilg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 16:21:53 INFO - Downloading https://queue.taskcluster.net/v1/task/cPEudMkWRHGTOZCvuHLilg/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 16:21:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cPEudMkWRHGTOZCvuHLilg/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 16:21:53 INFO - Downloaded 1327 bytes. 16:21:53 INFO - Reading from file /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 16:21:53 INFO - Using the following test package requirements: 16:21:53 INFO - {u'common': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 16:21:53 INFO - u'cppunittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 16:21:53 INFO - u'firefox-50.0.en-US.linux-x86_64.cppunittest.tests.zip'], 16:21:53 INFO - u'gtest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 16:21:53 INFO - u'firefox-50.0.en-US.linux-x86_64.gtest.tests.zip'], 16:21:53 INFO - u'jittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 16:21:53 INFO - u'jsshell-linux-x86_64.zip'], 16:21:53 INFO - u'mochitest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 16:21:53 INFO - u'firefox-50.0.en-US.linux-x86_64.mochitest.tests.zip'], 16:21:53 INFO - u'mozbase': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 16:21:53 INFO - u'reftest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 16:21:53 INFO - u'firefox-50.0.en-US.linux-x86_64.reftest.tests.zip'], 16:21:53 INFO - u'talos': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 16:21:53 INFO - u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'], 16:21:53 INFO - u'web-platform': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 16:21:53 INFO - u'firefox-50.0.en-US.linux-x86_64.web-platform.tests.zip'], 16:21:53 INFO - u'xpcshell': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 16:21:53 INFO - u'firefox-50.0.en-US.linux-x86_64.xpcshell.tests.zip']} 16:21:53 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:21:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:53 INFO - https://queue.taskcluster.net/v1/task/cPEudMkWRHGTOZCvuHLilg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:21:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPEudMkWRHGTOZCvuHLilg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 16:21:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPEudMkWRHGTOZCvuHLilg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 16:21:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPEudMkWRHGTOZCvuHLilg/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 16:21:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPEudMkWRHGTOZCvuHLilg/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 16:21:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPEudMkWRHGTOZCvuHLilg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 16:21:53 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 16:21:53 INFO - retry: Failed, sleeping 30 seconds before retrying 16:22:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPEudMkWRHGTOZCvuHLilg/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 16:22:24 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPEudMkWRHGTOZCvuHLilg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 16:22:24 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 16:22:24 INFO - retry: Failed, sleeping 60 seconds before retrying 16:23:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPEudMkWRHGTOZCvuHLilg/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 16:23:24 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPEudMkWRHGTOZCvuHLilg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 16:23:24 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 16:23:24 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPEudMkWRHGTOZCvuHLilg/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! 16:23:24 INFO - Caught exception: HTTP Error 404: Not Found 16:23:24 INFO - Caught exception: HTTP Error 404: Not Found 16:23:24 INFO - Caught exception: HTTP Error 404: Not Found 16:23:24 INFO - trying https://queue.taskcluster.net/v1/task/cPEudMkWRHGTOZCvuHLilg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 16:23:24 INFO - Downloading https://queue.taskcluster.net/v1/task/cPEudMkWRHGTOZCvuHLilg/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 16:23:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cPEudMkWRHGTOZCvuHLilg/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 16:23:24 INFO - Downloaded 21787606 bytes. 16:23:24 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'] 16:23:24 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 16:23:26 INFO - Return code: 0 16:23:26 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 16:23:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:23:26 INFO - https://queue.taskcluster.net/v1/task/cPEudMkWRHGTOZCvuHLilg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:23:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPEudMkWRHGTOZCvuHLilg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 16:23:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPEudMkWRHGTOZCvuHLilg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 16:23:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPEudMkWRHGTOZCvuHLilg/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 16:23:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPEudMkWRHGTOZCvuHLilg/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 16:23:26 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPEudMkWRHGTOZCvuHLilg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 16:23:26 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 16:23:26 INFO - retry: Failed, sleeping 30 seconds before retrying 16:23:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPEudMkWRHGTOZCvuHLilg/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 16:23:56 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPEudMkWRHGTOZCvuHLilg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 16:23:56 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 16:23:56 INFO - retry: Failed, sleeping 60 seconds before retrying 16:24:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPEudMkWRHGTOZCvuHLilg/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 16:24:56 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPEudMkWRHGTOZCvuHLilg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 16:24:56 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 16:24:56 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPEudMkWRHGTOZCvuHLilg/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! 16:24:56 INFO - Caught exception: HTTP Error 404: Not Found 16:24:56 INFO - Caught exception: HTTP Error 404: Not Found 16:24:56 INFO - Caught exception: HTTP Error 404: Not Found 16:24:56 INFO - trying https://queue.taskcluster.net/v1/task/cPEudMkWRHGTOZCvuHLilg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 16:24:56 INFO - Downloading https://queue.taskcluster.net/v1/task/cPEudMkWRHGTOZCvuHLilg/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 16:24:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cPEudMkWRHGTOZCvuHLilg/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 16:24:57 INFO - Downloaded 21787606 bytes. 16:24:57 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'] 16:24:57 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 16:24:58 INFO - Return code: 0 16:24:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:24:58 INFO - https://queue.taskcluster.net/v1/task/cPEudMkWRHGTOZCvuHLilg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:24:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPEudMkWRHGTOZCvuHLilg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 16:24:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPEudMkWRHGTOZCvuHLilg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 16:24:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPEudMkWRHGTOZCvuHLilg/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 16:24:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPEudMkWRHGTOZCvuHLilg/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 16:24:58 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPEudMkWRHGTOZCvuHLilg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 16:24:58 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 16:24:58 INFO - retry: Failed, sleeping 30 seconds before retrying 16:25:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPEudMkWRHGTOZCvuHLilg/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 16:25:28 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPEudMkWRHGTOZCvuHLilg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 16:25:28 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 16:25:28 INFO - retry: Failed, sleeping 60 seconds before retrying 16:26:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPEudMkWRHGTOZCvuHLilg/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 16:26:28 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPEudMkWRHGTOZCvuHLilg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 16:26:28 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 16:26:28 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPEudMkWRHGTOZCvuHLilg/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! 16:26:28 INFO - Caught exception: HTTP Error 404: Not Found 16:26:28 INFO - Caught exception: HTTP Error 404: Not Found 16:26:28 INFO - Caught exception: HTTP Error 404: Not Found 16:26:28 INFO - trying https://queue.taskcluster.net/v1/task/cPEudMkWRHGTOZCvuHLilg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 16:26:28 INFO - Downloading https://queue.taskcluster.net/v1/task/cPEudMkWRHGTOZCvuHLilg/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 16:26:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cPEudMkWRHGTOZCvuHLilg/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 16:26:29 INFO - Downloaded 14413770 bytes. 16:26:29 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'] 16:26:29 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 16:26:29 INFO - Return code: 0 16:26:29 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')]} 16:26:29 INFO - https://queue.taskcluster.net/v1/task/cPEudMkWRHGTOZCvuHLilg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:26:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPEudMkWRHGTOZCvuHLilg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 16:26:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPEudMkWRHGTOZCvuHLilg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 16:26:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPEudMkWRHGTOZCvuHLilg/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 16:26:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPEudMkWRHGTOZCvuHLilg/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 16:26:29 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPEudMkWRHGTOZCvuHLilg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 16:26:29 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 16:26:29 INFO - retry: Failed, sleeping 30 seconds before retrying 16:26:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPEudMkWRHGTOZCvuHLilg/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 16:26:59 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPEudMkWRHGTOZCvuHLilg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 16:26:59 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 16:26:59 INFO - retry: Failed, sleeping 60 seconds before retrying 16:27:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPEudMkWRHGTOZCvuHLilg/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 16:27:59 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPEudMkWRHGTOZCvuHLilg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 16:27:59 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 16:27:59 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPEudMkWRHGTOZCvuHLilg/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! 16:27:59 INFO - Caught exception: HTTP Error 404: Not Found 16:27:59 INFO - Caught exception: HTTP Error 404: Not Found 16:27:59 INFO - Caught exception: HTTP Error 404: Not Found 16:27:59 INFO - trying https://queue.taskcluster.net/v1/task/cPEudMkWRHGTOZCvuHLilg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 16:27:59 INFO - Downloading https://queue.taskcluster.net/v1/task/cPEudMkWRHGTOZCvuHLilg/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 16:27:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cPEudMkWRHGTOZCvuHLilg/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 16:28:00 INFO - Downloaded 56799929 bytes. 16:28:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cPEudMkWRHGTOZCvuHLilg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 16:28:00 INFO - mkdir: /builds/slave/test/properties 16:28:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:28:00 INFO - Writing to file /builds/slave/test/properties/build_url 16:28:00 INFO - Contents: 16:28:00 INFO - build_url:https://queue.taskcluster.net/v1/task/cPEudMkWRHGTOZCvuHLilg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 16:28:01 INFO - Running post-action listener: _resource_record_post_action 16:28:01 INFO - Running post-action listener: set_extra_try_arguments 16:28:01 INFO - [mozharness: 2016-11-05 23:28:01.544493Z] Finished download-and-extract step (success) 16:28:01 INFO - [mozharness: 2016-11-05 23:28:01.544725Z] Running populate-webroot step. 16:28:01 INFO - Running pre-action listener: _resource_record_pre_action 16:28:01 INFO - Running main action method: populate_webroot 16:28:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:28:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:28:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:28:01 INFO - '--tppagecycles', 16:28:01 INFO - '7'], 16:28:01 INFO - 'tests': ['tsvgm']}}, 16:28:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:28:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:28:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:28:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:28:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:28:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:28:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:01 INFO - 'talos_options': ['--disable-e10s'], 16:28:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:28:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:28:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:01 INFO - 'talos_options': ['--disable-e10s'], 16:28:01 INFO - 'tests': ['damp', 'tps']}, 16:28:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:01 INFO - 'tests': ['damp', 'tps']}, 16:28:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:28:01 INFO - 'tests': ['dromaeo_dom']}, 16:28:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:28:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:28:01 INFO - 'tests': ['basic_compositor_video']}, 16:28:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:28:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:28:01 INFO - 'tests': ['a11yr', 16:28:01 INFO - 'ts_paint', 16:28:01 INFO - 'tpaint', 16:28:01 INFO - 'sessionrestore', 16:28:01 INFO - 'sessionrestore_no_auto_restore', 16:28:01 INFO - 'tabpaint']}, 16:28:01 INFO - 'other-e10s': {'tests': ['a11yr', 16:28:01 INFO - 'ts_paint', 16:28:01 INFO - 'tpaint', 16:28:01 INFO - 'sessionrestore', 16:28:01 INFO - 'sessionrestore_no_auto_restore', 16:28:01 INFO - 'tabpaint']}, 16:28:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:28:01 INFO - 'ts_paint', 16:28:01 INFO - 'tpaint', 16:28:01 INFO - 'sessionrestore', 16:28:01 INFO - 'sessionrestore_no_auto_restore', 16:28:01 INFO - 'tabpaint']}, 16:28:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:28:01 INFO - 'ts_paint', 16:28:01 INFO - 'tpaint', 16:28:01 INFO - 'sessionrestore', 16:28:01 INFO - 'sessionrestore_no_auto_restore', 16:28:01 INFO - 'tabpaint']}, 16:28:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:28:01 INFO - 'tests': ['a11yr', 16:28:01 INFO - 'ts_paint', 16:28:01 INFO - 'tpaint', 16:28:01 INFO - 'sessionrestore', 16:28:01 INFO - 'sessionrestore_no_auto_restore', 16:28:01 INFO - 'tabpaint']}, 16:28:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:28:01 INFO - 'tests': ['a11yr', 16:28:01 INFO - 'ts_paint', 16:28:01 INFO - 'tpaint', 16:28:01 INFO - 'sessionrestore', 16:28:01 INFO - 'sessionrestore_no_auto_restore', 16:28:01 INFO - 'tabpaint']}, 16:28:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:28:01 INFO - 'tests': ['tsvgx', 16:28:01 INFO - 'tsvgr_opacity', 16:28:01 INFO - 'tart', 16:28:01 INFO - 'tscrollx', 16:28:01 INFO - 'cart']}, 16:28:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:28:01 INFO - 'tsvgr_opacity', 16:28:01 INFO - 'tart', 16:28:01 INFO - 'tscrollx', 16:28:01 INFO - 'cart']}, 16:28:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:01 INFO - 'talos_options': ['--disable-e10s'], 16:28:01 INFO - 'tests': ['tp5o']}, 16:28:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:01 INFO - 'tests': ['tp5o']}, 16:28:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:01 INFO - 'talos_options': ['--disable-e10s', 16:28:01 INFO - '--xperf_path', 16:28:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:28:01 INFO - 'tests': ['tp5n']}, 16:28:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:01 INFO - 'talos_options': ['--xperf_path', 16:28:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:28:01 INFO - 'tests': ['tp5n']}}, 16:28:01 INFO - 'talos.zip': {'path': '', 16:28:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:28:01 INFO - Running post-action listener: _resource_record_post_action 16:28:01 INFO - [mozharness: 2016-11-05 23:28:01.561410Z] Finished populate-webroot step (success) 16:28:01 INFO - [mozharness: 2016-11-05 23:28:01.561499Z] Running create-virtualenv step. 16:28:01 INFO - Running pre-action listener: _resource_record_pre_action 16:28:01 INFO - Running main action method: create_virtualenv 16:28:01 INFO - Creating virtualenv /builds/slave/test/build/venv 16:28:01 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 16:28:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:28:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:28:01 INFO - Using real prefix '/usr' 16:28:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:28:02 INFO - Installing distribute.............................................................................................................................................................................................done. 16:28:04 INFO - Installing pip.................done. 16:28:04 INFO - Return code: 0 16:28:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:28:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:28:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:28:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x277b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29aa400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a39570>, '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 0x2a3a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3a900>, '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': '0e2a256762fed810e2f0f810000001b3-1478388020.996873-1638991663', '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 16:28:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:28:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:28:04 INFO - Using env: {'DISPLAY': ':0', 16:28:04 INFO - 'HOME': '/home/cltbld', 16:28:04 INFO - 'LANG': 'en_US.UTF-8', 16:28:04 INFO - 'LANGUAGE': 'en_US:en', 16:28:04 INFO - 'LOGNAME': 'cltbld', 16:28:04 INFO - 'MAIL': '/var/mail/cltbld', 16:28:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:04 INFO - 'MOZ_NO_REMOTE': '1', 16:28:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:28:04 INFO - 'NO_EM_RESTART': '1', 16:28:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:28:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:04 INFO - 'PWD': '/builds/slave/test', 16:28:04 INFO - 'SHELL': '/bin/bash', 16:28:04 INFO - 'SHLVL': '1', 16:28:04 INFO - 'TERM': 'linux', 16:28:04 INFO - 'TMOUT': '86400', 16:28:04 INFO - 'USER': 'cltbld', 16:28:04 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1478388020.996873-1638991663', 16:28:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:04 INFO - '_': '/tools/buildbot/bin/python'} 16:28:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:04 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 16:28:04 INFO - Cleaning up... 16:28:04 INFO - Return code: 0 16:28:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:28:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:28:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:28:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x277b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29aa400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a39570>, '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 0x2a3a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3a900>, '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': '0e2a256762fed810e2f0f810000001b3-1478388020.996873-1638991663', '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 16:28:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:28:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:28:04 INFO - Using env: {'DISPLAY': ':0', 16:28:04 INFO - 'HOME': '/home/cltbld', 16:28:04 INFO - 'LANG': 'en_US.UTF-8', 16:28:04 INFO - 'LANGUAGE': 'en_US:en', 16:28:04 INFO - 'LOGNAME': 'cltbld', 16:28:04 INFO - 'MAIL': '/var/mail/cltbld', 16:28:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:04 INFO - 'MOZ_NO_REMOTE': '1', 16:28:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:28:04 INFO - 'NO_EM_RESTART': '1', 16:28:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:28:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:04 INFO - 'PWD': '/builds/slave/test', 16:28:04 INFO - 'SHELL': '/bin/bash', 16:28:04 INFO - 'SHLVL': '1', 16:28:04 INFO - 'TERM': 'linux', 16:28:04 INFO - 'TMOUT': '86400', 16:28:04 INFO - 'USER': 'cltbld', 16:28:04 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1478388020.996873-1638991663', 16:28:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:04 INFO - '_': '/tools/buildbot/bin/python'} 16:28:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:04 INFO - Downloading/unpacking psutil>=3.1.1 16:28:04 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 16:28:04 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 16:28:04 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 16:28:04 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 16:28:04 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 16:28:04 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 16:28:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:28:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:28:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:28:06 INFO - Installing collected packages: psutil 16:28:06 INFO - Running setup.py install for psutil 16:28:06 INFO - building 'psutil._psutil_linux' extension 16:28:06 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 16:28:06 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 16:28:06 INFO - building 'psutil._psutil_posix' extension 16:28:06 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 16:28:06 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 16:28:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:28:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:28:07 INFO - Successfully installed psutil 16:28:07 INFO - Cleaning up... 16:28:07 INFO - Return code: 0 16:28:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:28:07 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')]} 16:28:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:07 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')]} 16:28:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:07 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 0x277b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29aa400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a39570>, '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 0x2a3a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3a900>, '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': '0e2a256762fed810e2f0f810000001b3-1478388020.996873-1638991663', '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 16:28:07 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 16:28:07 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 16:28:07 INFO - Using env: {'DISPLAY': ':0', 16:28:07 INFO - 'HOME': '/home/cltbld', 16:28:07 INFO - 'LANG': 'en_US.UTF-8', 16:28:07 INFO - 'LANGUAGE': 'en_US:en', 16:28:07 INFO - 'LOGNAME': 'cltbld', 16:28:07 INFO - 'MAIL': '/var/mail/cltbld', 16:28:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:07 INFO - 'MOZ_NO_REMOTE': '1', 16:28:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:28:07 INFO - 'NO_EM_RESTART': '1', 16:28:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:28:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:07 INFO - 'PWD': '/builds/slave/test', 16:28:07 INFO - 'SHELL': '/bin/bash', 16:28:07 INFO - 'SHLVL': '1', 16:28:07 INFO - 'TERM': 'linux', 16:28:07 INFO - 'TMOUT': '86400', 16:28:07 INFO - 'USER': 'cltbld', 16:28:07 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1478388020.996873-1638991663', 16:28:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:07 INFO - '_': '/tools/buildbot/bin/python'} 16:28:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:28:07 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 16:28:07 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 16:28:07 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 16:28:07 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 16:28:07 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 16:28:07 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 16:28:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:28:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:28:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:28:09 INFO - Installing collected packages: mozsystemmonitor 16:28:09 INFO - Running setup.py install for mozsystemmonitor 16:28:09 INFO - Successfully installed mozsystemmonitor 16:28:09 INFO - Cleaning up... 16:28:09 INFO - Return code: 0 16:28:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:28:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:28:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:28:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x277b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29aa400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a39570>, '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 0x2a3a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3a900>, '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': '0e2a256762fed810e2f0f810000001b3-1478388020.996873-1638991663', '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 16:28:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:28:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:28:09 INFO - Using env: {'DISPLAY': ':0', 16:28:09 INFO - 'HOME': '/home/cltbld', 16:28:09 INFO - 'LANG': 'en_US.UTF-8', 16:28:09 INFO - 'LANGUAGE': 'en_US:en', 16:28:09 INFO - 'LOGNAME': 'cltbld', 16:28:09 INFO - 'MAIL': '/var/mail/cltbld', 16:28:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:09 INFO - 'MOZ_NO_REMOTE': '1', 16:28:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:28:09 INFO - 'NO_EM_RESTART': '1', 16:28:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:28:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:09 INFO - 'PWD': '/builds/slave/test', 16:28:09 INFO - 'SHELL': '/bin/bash', 16:28:09 INFO - 'SHLVL': '1', 16:28:09 INFO - 'TERM': 'linux', 16:28:09 INFO - 'TMOUT': '86400', 16:28:09 INFO - 'USER': 'cltbld', 16:28:09 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1478388020.996873-1638991663', 16:28:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:09 INFO - '_': '/tools/buildbot/bin/python'} 16:28:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:09 INFO - Downloading/unpacking jsonschema==2.5.1 16:28:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:28:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:28:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:28:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:28:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:28:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:28:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:28:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:28:11 INFO - Downloading functools32-3.2.3-2.tar.gz 16:28:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:28:11 INFO - warning: no files found matching '*.txt' 16:28:11 INFO - no previously-included directories found matching 'build' 16:28:11 INFO - no previously-included directories found matching 'dist' 16:28:11 INFO - no previously-included directories found matching '.git*' 16:28:11 INFO - Installing collected packages: jsonschema, functools32 16:28:11 INFO - Running setup.py install for functools32 16:28:12 INFO - warning: no files found matching '*.txt' 16:28:12 INFO - no previously-included directories found matching 'build' 16:28:12 INFO - no previously-included directories found matching 'dist' 16:28:12 INFO - no previously-included directories found matching '.git*' 16:28:12 INFO - Successfully installed jsonschema functools32 16:28:12 INFO - Cleaning up... 16:28:12 INFO - Return code: 0 16:28:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:28:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:28:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:28:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x277b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29aa400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a39570>, '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 0x2a3a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3a900>, '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': '0e2a256762fed810e2f0f810000001b3-1478388020.996873-1638991663', '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 16:28:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:28:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:28:12 INFO - Using env: {'DISPLAY': ':0', 16:28:12 INFO - 'HOME': '/home/cltbld', 16:28:12 INFO - 'LANG': 'en_US.UTF-8', 16:28:12 INFO - 'LANGUAGE': 'en_US:en', 16:28:12 INFO - 'LOGNAME': 'cltbld', 16:28:12 INFO - 'MAIL': '/var/mail/cltbld', 16:28:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:12 INFO - 'MOZ_NO_REMOTE': '1', 16:28:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:28:12 INFO - 'NO_EM_RESTART': '1', 16:28:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:28:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:12 INFO - 'PWD': '/builds/slave/test', 16:28:12 INFO - 'SHELL': '/bin/bash', 16:28:12 INFO - 'SHLVL': '1', 16:28:12 INFO - 'TERM': 'linux', 16:28:12 INFO - 'TMOUT': '86400', 16:28:12 INFO - 'USER': 'cltbld', 16:28:12 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1478388020.996873-1638991663', 16:28:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:12 INFO - '_': '/tools/buildbot/bin/python'} 16:28:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:28:12 INFO - Cleaning up... 16:28:12 INFO - Return code: 0 16:28:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:28:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:28:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:28:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x277b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29aa400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a39570>, '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 0x2a3a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3a900>, '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': '0e2a256762fed810e2f0f810000001b3-1478388020.996873-1638991663', '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 16:28:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:28:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:28:12 INFO - Using env: {'DISPLAY': ':0', 16:28:12 INFO - 'HOME': '/home/cltbld', 16:28:12 INFO - 'LANG': 'en_US.UTF-8', 16:28:12 INFO - 'LANGUAGE': 'en_US:en', 16:28:12 INFO - 'LOGNAME': 'cltbld', 16:28:12 INFO - 'MAIL': '/var/mail/cltbld', 16:28:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:12 INFO - 'MOZ_NO_REMOTE': '1', 16:28:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:28:12 INFO - 'NO_EM_RESTART': '1', 16:28:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:28:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:12 INFO - 'PWD': '/builds/slave/test', 16:28:12 INFO - 'SHELL': '/bin/bash', 16:28:12 INFO - 'SHLVL': '1', 16:28:12 INFO - 'TERM': 'linux', 16:28:12 INFO - 'TMOUT': '86400', 16:28:12 INFO - 'USER': 'cltbld', 16:28:12 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1478388020.996873-1638991663', 16:28:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:12 INFO - '_': '/tools/buildbot/bin/python'} 16:28:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:12 INFO - Downloading/unpacking blobuploader==1.2.4 16:28:12 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 16:28:12 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 16:28:12 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 16:28:12 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 16:28:12 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 16:28:12 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 16:28:14 INFO - Downloading blobuploader-1.2.4.tar.gz 16:28:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:28:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:28:14 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 16:28:14 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 16:28:14 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 16:28:14 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 16:28:14 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 16:28:14 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 16:28:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:28:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:28:14 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 16:28:14 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 16:28:14 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 16:28:14 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 16:28:14 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 16:28:14 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 16:28:15 INFO - Downloading docopt-0.6.1.tar.gz 16:28:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:28:15 INFO - Installing collected packages: blobuploader, requests, docopt 16:28:15 INFO - Running setup.py install for blobuploader 16:28:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:28:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:28:15 INFO - Running setup.py install for requests 16:28:15 INFO - Running setup.py install for docopt 16:28:15 INFO - Successfully installed blobuploader requests docopt 16:28:15 INFO - Cleaning up... 16:28:15 INFO - Return code: 0 16:28:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:28: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')]} 16:28:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28: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')]} 16:28:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:15 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 0x277b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29aa400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a39570>, '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 0x2a3a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3a900>, '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': '0e2a256762fed810e2f0f810000001b3-1478388020.996873-1638991663', '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 16:28:15 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 16:28:15 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 16:28:15 INFO - Using env: {'DISPLAY': ':0', 16:28:15 INFO - 'HOME': '/home/cltbld', 16:28:15 INFO - 'LANG': 'en_US.UTF-8', 16:28:15 INFO - 'LANGUAGE': 'en_US:en', 16:28:15 INFO - 'LOGNAME': 'cltbld', 16:28:15 INFO - 'MAIL': '/var/mail/cltbld', 16:28:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:15 INFO - 'MOZ_NO_REMOTE': '1', 16:28:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:28:15 INFO - 'NO_EM_RESTART': '1', 16:28:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:28:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:15 INFO - 'PWD': '/builds/slave/test', 16:28:15 INFO - 'SHELL': '/bin/bash', 16:28:15 INFO - 'SHLVL': '1', 16:28:15 INFO - 'TERM': 'linux', 16:28:15 INFO - 'TMOUT': '86400', 16:28:15 INFO - 'USER': 'cltbld', 16:28:15 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1478388020.996873-1638991663', 16:28:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:15 INFO - '_': '/tools/buildbot/bin/python'} 16:28:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:28:16 INFO - Running setup.py (path:/tmp/pip-wAeSv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:28:16 INFO - Running setup.py (path:/tmp/pip-_FkIcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:28:16 INFO - Running setup.py (path:/tmp/pip-HPjkCu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:28:16 INFO - Running setup.py (path:/tmp/pip-C0DIIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:28:16 INFO - Running setup.py (path:/tmp/pip-e_3dyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:28:16 INFO - Running setup.py (path:/tmp/pip-3oKx_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:28:16 INFO - Running setup.py (path:/tmp/pip-TUDTL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:28:16 INFO - Running setup.py (path:/tmp/pip-V74kkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:28:16 INFO - Running setup.py (path:/tmp/pip-i24Rmq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:28:16 INFO - Running setup.py (path:/tmp/pip-t1FlfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:28:16 INFO - Running setup.py (path:/tmp/pip-Hez0Uz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:28:16 INFO - Running setup.py (path:/tmp/pip-tdGg6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:28:16 INFO - Running setup.py (path:/tmp/pip-IuFE7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:28:17 INFO - Running setup.py (path:/tmp/pip-Ao_jUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:28:17 INFO - Running setup.py (path:/tmp/pip-YKSf6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:28:17 INFO - Running setup.py (path:/tmp/pip-9npcwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:28:17 INFO - Running setup.py (path:/tmp/pip-HtU_vc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:28:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:28:17 INFO - Running setup.py install for manifestparser 16:28:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:28:17 INFO - Running setup.py install for mozcrash 16:28:17 INFO - Running setup.py install for mozdebug 16:28:17 INFO - Running setup.py install for mozdevice 16:28:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:28:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:28:17 INFO - Running setup.py install for mozfile 16:28:17 INFO - Running setup.py install for mozhttpd 16:28:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:28:17 INFO - Running setup.py install for mozinfo 16:28:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:28:18 INFO - Running setup.py install for mozInstall 16:28:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:28:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:28:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:28:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:28:18 INFO - Running setup.py install for mozleak 16:28:18 INFO - Running setup.py install for mozlog 16:28:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:28:18 INFO - Running setup.py install for moznetwork 16:28:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:28:18 INFO - Running setup.py install for mozprocess 16:28:18 INFO - Running setup.py install for mozprofile 16:28:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:28:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:28:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:28:18 INFO - Running setup.py install for mozrunner 16:28:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:28:18 INFO - Running setup.py install for mozscreenshot 16:28:18 INFO - Running setup.py install for moztest 16:28:18 INFO - Running setup.py install for mozversion 16:28:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:28:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:28:19 INFO - Cleaning up... 16:28:19 INFO - Return code: 0 16:28:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:28:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:28:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:28:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:19 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 0x277b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29aa400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a39570>, '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 0x2a3a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3a900>, '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': '0e2a256762fed810e2f0f810000001b3-1478388020.996873-1638991663', '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 16:28:19 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 16:28:19 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 16:28:19 INFO - Using env: {'DISPLAY': ':0', 16:28:19 INFO - 'HOME': '/home/cltbld', 16:28:19 INFO - 'LANG': 'en_US.UTF-8', 16:28:19 INFO - 'LANGUAGE': 'en_US:en', 16:28:19 INFO - 'LOGNAME': 'cltbld', 16:28:19 INFO - 'MAIL': '/var/mail/cltbld', 16:28:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:19 INFO - 'MOZ_NO_REMOTE': '1', 16:28:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:28:19 INFO - 'NO_EM_RESTART': '1', 16:28:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:28:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:19 INFO - 'PWD': '/builds/slave/test', 16:28:19 INFO - 'SHELL': '/bin/bash', 16:28:19 INFO - 'SHLVL': '1', 16:28:19 INFO - 'TERM': 'linux', 16:28:19 INFO - 'TMOUT': '86400', 16:28:19 INFO - 'USER': 'cltbld', 16:28:19 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1478388020.996873-1638991663', 16:28:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:19 INFO - '_': '/tools/buildbot/bin/python'} 16:28:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:28:19 INFO - Running setup.py (path:/tmp/pip-Sw7HPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:28:19 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)) 16:28:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:28:19 INFO - Running setup.py (path:/tmp/pip-ra1kHt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:28:19 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)) 16:28:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:28:19 INFO - Running setup.py (path:/tmp/pip-lQXJ34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:28:19 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)) 16:28:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:28:19 INFO - Running setup.py (path:/tmp/pip-_OkMPt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:28:19 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)) 16:28:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:28:19 INFO - Running setup.py (path:/tmp/pip-E1ZKGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:28:19 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)) 16:28:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:28:19 INFO - Running setup.py (path:/tmp/pip-ClRdzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:28:19 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)) 16:28:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:28:19 INFO - Running setup.py (path:/tmp/pip-48YBun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:28:19 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)) 16:28:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:28:19 INFO - Running setup.py (path:/tmp/pip-kqku9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:28:19 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)) 16:28:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:28:19 INFO - Running setup.py (path:/tmp/pip-GGk7yy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:28:19 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)) 16:28:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:28:19 INFO - Running setup.py (path:/tmp/pip-uu8lYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:28:20 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)) 16:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:28:20 INFO - Running setup.py (path:/tmp/pip-F9lORp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:28:20 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)) 16:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:28:20 INFO - Running setup.py (path:/tmp/pip-XFJpTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:28:20 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)) 16:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:28:20 INFO - Running setup.py (path:/tmp/pip-913p2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:28:20 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)) 16:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:28:20 INFO - Running setup.py (path:/tmp/pip-Fa8cb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:28:20 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)) 16:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:28:20 INFO - Running setup.py (path:/tmp/pip-zAP5bg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:28:20 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)) 16:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:28:20 INFO - Running setup.py (path:/tmp/pip-VNILG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:28:20 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)) 16:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:28:20 INFO - Running setup.py (path:/tmp/pip-H5d4mP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:28:20 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)) 16:28:20 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)) 16:28:20 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)) 16:28:20 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)) 16:28:20 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)) 16:28:20 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)) 16:28:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:28:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:28:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:28:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:28:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:28:22 INFO - Downloading blessings-1.6.tar.gz 16:28:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:28:22 INFO - Installing collected packages: blessings 16:28:22 INFO - Running setup.py install for blessings 16:28:22 INFO - Successfully installed blessings 16:28:22 INFO - Cleaning up... 16:28:22 INFO - Return code: 0 16:28:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:28:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:28:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:28:23 INFO - Reading from file tmpfile_stdout 16:28:23 INFO - Current package versions: 16:28:23 INFO - argparse == 1.2.1 16:28:23 INFO - blessings == 1.6 16:28:23 INFO - blobuploader == 1.2.4 16:28:23 INFO - docopt == 0.6.1 16:28:23 INFO - functools32 == 3.2.3-2 16:28:23 INFO - jsonschema == 2.5.1 16:28:23 INFO - manifestparser == 1.1 16:28:23 INFO - mozInstall == 1.12 16:28:23 INFO - mozcrash == 0.17 16:28:23 INFO - mozdebug == 0.1 16:28:23 INFO - mozdevice == 0.48 16:28:23 INFO - mozfile == 1.2 16:28:23 INFO - mozhttpd == 0.7 16:28:23 INFO - mozinfo == 0.9 16:28:23 INFO - mozleak == 0.1 16:28:23 INFO - mozlog == 3.3 16:28:23 INFO - moznetwork == 0.27 16:28:23 INFO - mozprocess == 0.23 16:28:23 INFO - mozprofile == 0.28 16:28:23 INFO - mozrunner == 6.12 16:28:23 INFO - mozscreenshot == 0.1 16:28:23 INFO - mozsystemmonitor == 0.3 16:28:23 INFO - moztest == 0.7 16:28:23 INFO - mozversion == 1.4 16:28:23 INFO - psutil == 3.1.1 16:28:23 INFO - requests == 1.2.3 16:28:23 INFO - wsgiref == 0.1.2 16:28:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:28:23 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')]} 16:28:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:23 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')]} 16:28:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:23 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 0x277b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29aa400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a39570>, '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 0x2a3a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3a900>, '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': '0e2a256762fed810e2f0f810000001b3-1478388020.996873-1638991663', '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 16:28:23 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 16:28:23 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 16:28:23 INFO - Using env: {'DISPLAY': ':0', 16:28:23 INFO - 'HOME': '/home/cltbld', 16:28:23 INFO - 'LANG': 'en_US.UTF-8', 16:28:23 INFO - 'LANGUAGE': 'en_US:en', 16:28:23 INFO - 'LOGNAME': 'cltbld', 16:28:23 INFO - 'MAIL': '/var/mail/cltbld', 16:28:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:23 INFO - 'MOZ_NO_REMOTE': '1', 16:28:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:28:23 INFO - 'NO_EM_RESTART': '1', 16:28:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:28:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:23 INFO - 'PWD': '/builds/slave/test', 16:28:23 INFO - 'SHELL': '/bin/bash', 16:28:23 INFO - 'SHLVL': '1', 16:28:23 INFO - 'TERM': 'linux', 16:28:23 INFO - 'TMOUT': '86400', 16:28:23 INFO - 'USER': 'cltbld', 16:28:23 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1478388020.996873-1638991663', 16:28:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:23 INFO - '_': '/tools/buildbot/bin/python'} 16:28:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:23 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)) 16:28:23 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)) 16:28:23 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)) 16:28:23 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)) 16:28:23 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)) 16:28:23 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)) 16:28:23 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)) 16:28:23 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)) 16:28:23 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)) 16:28:23 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)) 16:28:23 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)) 16:28:23 INFO - Cleaning up... 16:28:23 INFO - Return code: 0 16:28:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:28:23 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')]} 16:28:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:23 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')]} 16:28:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:23 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 0x277b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29aa400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a39570>, '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 0x2a3a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3a900>, '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': '0e2a256762fed810e2f0f810000001b3-1478388020.996873-1638991663', '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 16:28:23 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 16:28:23 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 16:28:23 INFO - Using env: {'DISPLAY': ':0', 16:28:23 INFO - 'HOME': '/home/cltbld', 16:28:23 INFO - 'LANG': 'en_US.UTF-8', 16:28:23 INFO - 'LANGUAGE': 'en_US:en', 16:28:23 INFO - 'LOGNAME': 'cltbld', 16:28:23 INFO - 'MAIL': '/var/mail/cltbld', 16:28:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:23 INFO - 'MOZ_NO_REMOTE': '1', 16:28:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:28:23 INFO - 'NO_EM_RESTART': '1', 16:28:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:28:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:23 INFO - 'PWD': '/builds/slave/test', 16:28:23 INFO - 'SHELL': '/bin/bash', 16:28:23 INFO - 'SHLVL': '1', 16:28:23 INFO - 'TERM': 'linux', 16:28:23 INFO - 'TMOUT': '86400', 16:28:23 INFO - 'USER': 'cltbld', 16:28:23 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1478388020.996873-1638991663', 16:28:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:23 INFO - '_': '/tools/buildbot/bin/python'} 16:28:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:28:23 INFO - Cleaning up... 16:28:23 INFO - Return code: 0 16:28:23 INFO - Running post-action listener: _resource_record_post_action 16:28:23 INFO - Running post-action listener: _start_resource_monitoring 16:28:23 INFO - Starting resource monitoring. 16:28:23 INFO - [mozharness: 2016-11-05 23:28:23.553717Z] Finished create-virtualenv step (success) 16:28:23 INFO - [mozharness: 2016-11-05 23:28:23.554261Z] Running install step. 16:28:23 INFO - Running pre-action listener: _resource_record_pre_action 16:28:23 INFO - Running main action method: install 16:28:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:28:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:28:23 INFO - Reading from file tmpfile_stdout 16:28:23 INFO - Detecting whether we're running mozinstall >=1.0... 16:28:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:28:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:28:23 INFO - Reading from file tmpfile_stdout 16:28:23 INFO - Output received: 16:28:23 INFO - Usage: mozinstall [options] installer 16:28:23 INFO - Options: 16:28:23 INFO - -h, --help show this help message and exit 16:28:23 INFO - -d DEST, --destination=DEST 16:28:23 INFO - Directory to install application into. [default: 16:28:23 INFO - "/builds/slave/test"] 16:28:23 INFO - --app=APP Application being installed. [default: firefox] 16:28:23 INFO - mkdir: /builds/slave/test/build/application 16:28:23 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'] 16:28:23 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 16:28:37 INFO - Reading from file tmpfile_stdout 16:28:37 INFO - Output received: 16:28:37 INFO - /builds/slave/test/build/application/firefox/firefox 16:28:37 INFO - Running post-action listener: _resource_record_post_action 16:28:37 INFO - [mozharness: 2016-11-05 23:28:37.378594Z] Finished install step (success) 16:28:37 INFO - [mozharness: 2016-11-05 23:28:37.378723Z] Running run-tests step. 16:28:37 INFO - Running pre-action listener: _resource_record_pre_action 16:28:37 INFO - Running main action method: run_tests 16:28:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:28:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:28:37 INFO - Python 2.7.3 16:28:37 INFO - Return code: 0 16:28:37 INFO - grabbing minidump binary from tooltool 16:28:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:28:37 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 0x2a39570>, '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 0x2a3a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3a900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:28:37 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 16:28:37 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 16:28:37 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 16:28:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:28:37 INFO - Return code: 0 16:28:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:28:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:28:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:28:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:28:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:28:37 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/cPEudMkWRHGTOZCvuHLilg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 16:28:37 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/cPEudMkWRHGTOZCvuHLilg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --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 16:28:37 INFO - Using env: {'DISPLAY': ':0', 16:28:37 INFO - 'HOME': '/home/cltbld', 16:28:37 INFO - 'LANG': 'en_US.UTF-8', 16:28:37 INFO - 'LANGUAGE': 'en_US:en', 16:28:37 INFO - 'LOGNAME': 'cltbld', 16:28:37 INFO - 'MAIL': '/var/mail/cltbld', 16:28:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:28:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:28:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:37 INFO - 'MOZ_NO_REMOTE': '1', 16:28:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:28:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:28:37 INFO - 'NO_EM_RESTART': '1', 16:28:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:28:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:37 INFO - 'PWD': '/builds/slave/test', 16:28:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:28:37 INFO - 'SHELL': '/bin/bash', 16:28:37 INFO - 'SHLVL': '1', 16:28:37 INFO - 'TERM': 'linux', 16:28:37 INFO - 'TMOUT': '86400', 16:28:37 INFO - 'USER': 'cltbld', 16:28:37 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1478388020.996873-1638991663', 16:28:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:37 INFO - '_': '/tools/buildbot/bin/python'} 16:28:37 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/cPEudMkWRHGTOZCvuHLilg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 16:28:37 INFO - mozversion application_buildid: 20161103181821 16:28:37 INFO - mozversion application_changeset: 24b8f08f77565f859898b45f62d2132ccc64c6d8 16:28:37 INFO - mozversion application_display_name: Firefox 16:28:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:28:37 INFO - mozversion application_name: Firefox 16:28:37 INFO - mozversion application_remotingname: firefox 16:28:37 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 16:28:37 INFO - mozversion application_vendor: Mozilla 16:28:37 INFO - mozversion application_version: 50.0 16:28:37 INFO - mozversion platform_buildid: 20161103181821 16:28:37 INFO - mozversion platform_changeset: 24b8f08f77565f859898b45f62d2132ccc64c6d8 16:28:37 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 16:28:37 INFO - mozversion platform_version: 50.0 16:28:37 INFO - using testdate: 1478388517 16:28:37 INFO - actual date: 1478388517 16:28:37 INFO - starting webserver on 'localhost:49348' 16:28:37 INFO - SUITE-START | Running 2 tests 16:28:37 INFO - TEST-START | dromaeo_css 16:28:37 INFO - operating with platform_type : linux_ 16:28:37 INFO - Initialising browser for dromaeo_css test... 16:28:37 INFO - TEST-INFO | started process 15676 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpF41ipM/profile http://localhost:49348/getInfo.html) 16:28:42 INFO - PROCESS | 15676 | __metrics Screen width/height:1600/1200 16:28:42 INFO - PROCESS | 15676 | colorDepth:24 16:28:42 INFO - PROCESS | 15676 | Browser inner width/height: 1024/697 16:28:42 INFO - PROCESS | 15676 | __metrics 16:28:42 ERROR - PROCESS | 15676 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 16:28:43 INFO - TEST-INFO | 15676: exit 0 16:28:43 INFO - Browser initialized. 16:28:43 INFO - Running cycle 1/1 for dromaeo_css test... 16:28:43 INFO - TEST-INFO | started process 15803 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpF41ipM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:28:55 INFO - PROCESS | 15803 | RSS: Main: 150454272 16:28:55 INFO - PROCESS | 15803 | 16:29:45 INFO - PROCESS | 15803 | 1478388585102 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] 16:31:53 INFO - PROCESS | 15803 | Cycle 1(1): loaded http://localhost:49348/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49348/tests/dromaeo/cssquery-ext.html) 16:31:54 INFO - PROCESS | 15803 | RSS: Main: 158593024 16:31:54 INFO - PROCESS | 15803 | 16:34:56 INFO - PROCESS | 15803 | Cycle 1(1): loaded http://localhost:49348/tests/dromaeo/cssquery-ext.html (next: http://localhost:49348/tests/dromaeo/cssquery-jquery.html) 16:34:57 INFO - PROCESS | 15803 | RSS: Main: 155734016 16:34:57 INFO - PROCESS | 15803 | 16:37:58 INFO - PROCESS | 15803 | Cycle 1(1): loaded http://localhost:49348/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49348/tests/dromaeo/cssquery-mootools.html) 16:37:59 INFO - PROCESS | 15803 | RSS: Main: 155324416 16:37:59 INFO - PROCESS | 15803 | 16:41:01 INFO - PROCESS | 15803 | Cycle 1(1): loaded http://localhost:49348/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49348/tests/dromaeo/cssquery-prototype.html) 16:41:01 INFO - PROCESS | 15803 | RSS: Main: 157175808 16:41:01 INFO - PROCESS | 15803 | 16:44:04 INFO - PROCESS | 15803 | Cycle 1(1): loaded http://localhost:49348/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49348/tests/dromaeo/cssquery-yui.html) 16:44:04 INFO - PROCESS | 15803 | RSS: Main: 157990912 16:44:04 INFO - PROCESS | 15803 | 16:47:06 INFO - PROCESS | 15803 | Cycle 1(1): loaded http://localhost:49348/tests/dromaeo/cssquery-yui.html (next: http://localhost:49348/tests/dromaeo/cssquery-dojo.html) 16:47:07 INFO - PROCESS | 15803 | RSS: Main: 157790208 16:47:07 INFO - PROCESS | 15803 | 16:47:07 INFO - PROCESS | 15803 | __start_tp_report 16:47:07 INFO - PROCESS | 15803 | _x_x_mozilla_page_load 16:47:07 INFO - PROCESS | 15803 | _x_x_mozilla_page_load_details 16:47:07 INFO - PROCESS | 15803 | |i|pagename|runs| 16:47:07 INFO - PROCESS | 15803 | |0;dojo.html;3266.4120458317507;3278.6557411471786;3281.31092470581;3291.3417316536697;3304.1739565108724;5750.051241545145;5819.156222347757;5819.563532735046;5831.620944638601;5832.504237139849;5696.3733989261145;5728.369879313283;5740.5981581289325;5749.3388260350075;5751.856203594913;5180.2229665550185;5190.351206099238;5200.92198617021;5237.659552129099;5262.8684282892855;5260.631755777097;5260.763265653036;5261.316028916235;5278.577713782888;5303.814366497173;5068.037072956145;5106.387233531981;5249.527542521172;5250.868728281805;5261.447548007462;5136.460671629481;5149.639525233235;5198.40218374888;5243.213517972296;5320.388155362144;5154.458781827929;5161.4322424533275;5243.632945693803;5245.659032162897;5252.343457067866;5723.370429252779;5731.996900542388;5790.716912680805;5818.854528636818;5859.589828711992;5986.431289027535;6002.4897883679505;6084.665343406111;6119.8681629442035;6134.4172303631085;6071.119687645267;6155.138280640714;6158.507319414436;6187.3503282155625;6195.938040619581;5705.343885453143;5723.77104915807;5723.912456633227;5724.284464441945;5728.656280623134;6138.694953005908;6142.191841058572;6155.4767844732805;6164.044573091178;6228.065790131516;5952.345242023374;5994.250718660168;5994.520438364921;6000.459958603747;6033.698315084228;6003.3996600339615;6053.334133245339;6061.939160646957;6072.574919755663;6085.056816193497;5823.155642431909;6072.483838873745;6123;6138.419052470195;6140.723667434976;6156.753729850845;6165.506759459322;6167.290761562478;6177.722002509898;6183.196184495987;4732.763361831895;4736.384270044872;4741.35991641124;4750.192467280571;4754.78603462845;4093.815778289984;4134.255833949918;4155.542890282067;4172.99848036469;4235.8093885775215;5884.58807883444;5888.705564721747;5923.911141332884;5956.583039187215;5959.314678811992;6143.877122457526;6238.937610623926;6258.874822503524;6270.529710271748;6270.623762574261;5754.079347304411;5853.853653658693;5959.255093113361;5961.642301461926;6013.188219590299;5250.579953603703;5265.78936842522;5307.548858347007;5317.122674758699;5326.094563924142;6261.311255761862;6428.550001499943;6449.419552240321;6492.772752953624;6508.381703738138;6094.451499364901;6111.014442317695;6111.724972376165;6197.194364732556;6197.721102550306;6293.465055470337;6303.747850085945;6320.494360451061;6342.904856427065;6368.490520758421;5866.706664666664;6032.8793424132145;6035.69821508914;6047.183630210041;6053.636781793107;6039.5470339723815;6041.697915104315;6084.908726369196;6123.313124872426;6130.616155366224;5985.191999080069;5985.341612422717;6001.099835024781;6007.249093863267;6044.184035155197;5928.9407105928385;5964.821055368346;5984.19213406202;5996.850078748066;6010.54920880927;5877.265341832271;5963.791267305797;5992.221011268682;6038.426349496791;6080.665563394055;6029.216201893726;6036.396360363929;6112.510999120149;6122.5408094392205;6132.264128304632;5839.766409343749;5957.821265362046;5975;5977.312609049841;5991.370906054802 16:47:07 INFO - PROCESS | 15803 | |1;ext.html;592.908099244617;628.4092952624533;652.2368828470688;672.3612568060341;722.8373615936412;42840.78579607105;47188.52811471893;47422.525774742244;47426.5257347426;47568.76215618917;46320.53679463204;46326.073478530496;46497.53502464974;46542.30186547204;46669.6665166742;9054.185123338915;9205.263578913671;9212.815743685122;9212.953935230315;9213.493257870814;9054.547272636375;9179.173874351307;9180.403273787217;9196.172344488994;9197.954010229972;9202.447853128833;9221.170094691477;9226.492542910137;9247.537623118851;9294.860577091315;9070.682526111588;9076.636934522645;9093.045230250827;9219.492927888963;9225.354225204239;9138.086191380875;9140.54297285133;9165.816683666357;9175.954120229422;9187.448753074837;44612.776936115435;44855;44927.55072449266;45188.77405612951;45287;3596.8021758803256;3829.6744776694013;3838.654521093087;3855.1133239354826;4580.0152967112235;34758.82620586906;34894.12764680878;35218.82390588031;35432.82283588566;35915.82042089799;4692.882677933079;4721.976390118062;4734.526547345238;4746.52534746526;4791.928121078186;249593;254017;256164;256246;256973;62772;63089.36910630927;63117.05324420137;63255;63327;39198;39920.60079399169;40134;41840.37239441411;65551.67224163849;18890.149943252585;19119.90440047791;19134.71297930532;19149.425517234227;19171.32900348481;13475.730485390237;13547.729045419037;13566.118202316818;13573.932130339284;13627.182369057888;20467.181312747325;20653.380398588066;20788.896055519624;20809.89595052015;20906.268280610104;7472.5516469010945;7647.579383133981;7741.5742134183165;7842.803929901684;7876.077451592754;1086.6414083352474;1162.4652659776598;1190.6070996571111;1225.2648410953534;1240.49759847262;33644;33784.831075844464;33982.32035359279;34066;34586.654133458345;1157.8784227655974;1184.1710802438329;1198.8621308549455;1222.19335238742;1227.1777908801125;18093.54766130831;18105.547361316072;18201.908990454962;18286.908565457088;18305.26778928828;652796;657707;658086;661138;661928;61877.38122618806;62212.37787622066;62395.68802156051;62743.058854117226;62799.05801412983;1445.436279850859;1445.922787523281;1450.8259008918997;1500.9624759380883;1504.7742838574302;33116;33653.831730841186;33854.153646159044;33855;33893.3221335567;55216.17175742287;55529.16706249329;55918.16122758081;55963.44036559745;56004.43995559992;514863;516664;516923;517231;518496;31072.22319442032;31381.686183137877;31504.842475787475;31664.525032125;31742.20644483814;52249.47750522446;52657.73671131773;52943.20585191148;53003.734981324844;54211.45788542222;44518.554814452735;45347.54652453433;45513.544864552256;45914.540854592364;46627;44160.11679766451;45654.54345456503;45869.77065114653;46254.537454625024;46470.7676461629;44599.77700111479;44919.32621010753;45362.31956520721;45676.08647827091;45989.77005114953;38521.22957540777;39700.00749981274;39912.80043599763;39945.60054399419;40386.19227615373;29733;30112.84943575268;30577.54133688041;30620.693793061786;30889.536656950615 16:47:07 INFO - PROCESS | 15803 | |2;jquery.html;407.27505041026984;409.7254839257697;423.3839763144624;425.4702894895854;438.80473189430694;19522.21911123555;21183.47041323966;21221.57556848864;21454.463638409048;22243.888780556113;19525.21899124037;19884.900575497137;19975.80024199761;20111.29610463634;20582.794172058275;5101.9744901275535;5256.658317209388;5291.6031297652635;5301.973490132544;5309.840704778863;5224.2686023956485;5255.921161182585;5277.47225277473;5468.535174510172;5859.970700146515;5600.131979543177;5740.483356497914;5802.5938184327115;5842;5863.648181109126;5216.347956505437;5232.790688372461;5483.917741233865;5765.711714414262;5776.133579962997;5132.358455193101;5136.203888397267;5143.382794064699;5149.382074151126;5154.201098829687;11234.21360504765;14222.644433889132;22669.659955100688;23324;23459.76540234593;2325.3140323604407;2354.0819080558595;2452.350127216289;2549.107812265711;2734.3300891281565;9856.457894815781;10032.79934401308;10091.949540252252;10500.684979450552;10529.894701052968;2008.658528050235;2014.8791072535548;2019.1014998325752;2035.6436036447076;2097.276439628326;79819;82193.58903205565;83896;85787.57106214491;87424.5628771852;11315.717107072225;11422;11456.198066135457;11543.826842597367;11618;16068.517944461684;16152.515424537283;16181.919090404472;16217.918910405373;16244.837551624569;8170.509769413854;8263.628136733862;8372.41393102477;8474.661013559511;8537.786555336166;7763.844723105506;7932.801679957932;7971.561564114029;7989.161138080534;8151.673933042612;4770.475247722748;4957.429895562056;4973.055119527278;4973.950260497349;5026.195808670595;1868.6823240049225;1903.2957805611736;1905.285517930776;1983.890886001284;2121.1091341636547;1043.3009883378154;1074.6775967209805;1108.2740804772886;1157.8837233634342;1164.2257898497573;20474.79525204729;20655;20887;21050.684239736416;21098.727704875233;1041.734357738787;1049.371324831308;1072.3887384190937;1088.1784252889017;1176.8823117688162;10057.899421005843;11463.7963013884;11664.416779161009;11682;11737.413129343498;533688;536742;541489;542226;550418;88568.5571572151;89042.55478722564;96483.51758241164;96523.51738241264;97752.51123744478;1002.1481740520645;1011.8633984412157;1029.6087486755134;1030.006044167382;1032.8450732390202;17826.732599010767;18041.819581804015;18725.25098996025;18736.81263187405;18864.905675471535;42912;43361.78319108384;43980;45128;45881.77059114683;62336.688316558124;62584;63534.36465635469;64586.35413645803;64705.35294646993;9085.22775564058;9601.519924003633;9619.27855410861;9625.470599117116;9641.27690423235;11767.411629418666;13990;14034.578962631138;14417;14496.130232186102;12252.509899603916;12446.751064978469;12517.93741031289;12528.624141275777;12537.686557835763;12481.56314528987;12521.87478125207;12526.812097818722;12755.170913890568;12855.935720321339;12642.30467324306;12697.93651031739;12848.743025139633;12902.419391127609;13059.673508162372;9318.72043838686;9319.487428191514;9552.66565670226;9586.281028922998;9684.322097453392;9760.463174525185;12015.75968480643;12454.564090256797;12668.113232073667;12783.680407989503 16:47:07 INFO - PROCESS | 15803 | |3;mootools.html;1519.9848001519986;1520.4602366160016;1662.2602941690945;1810.5383127302543;1824.5712257619466;7534.962325188367;8425.915740842589;8515.361347898901;9058;9069;8626.353023523245;8928.062553431877;8931.240844528224;8935.687250946217;8950.104989501064;2397.4246180916543;2428;2438.231956933569;2445.254197469771;2449.081594402099;2394.7964423024064;2398.7721166489155;2440.036185706645;2448.1064411489765;2453.58289090855;2411.8794060297005;2426.5874801283735;2446.779789818916;2461.2493189577262;2462.9014839406404;2349.036894873111;2368.881555922197;2374.0147838647026;2375.726791418983;2396.532676128156;2370.1704403458825;2376.013954209001;2387.78509934105;2388.295452841416;2388.4387169015267;8925.598348074287;8934.061923498004;9034.232090272335;9045.502497362642;9061.68284110053;5195.818146364897;5340.732963351817;5341.385740639798;5341.813036543703;5347.983883062245;3326.617438994498;3393.253484233465;3464.9854626474876;3478.4434490481403;3506.2286297014616;1139.692283083571;1147.65570328901;1165.0388429545574;1171.689502281896;1172;12275;12294;12325.445354959049;12332.445039973223;12416.317102559356;4685.998310827225;4708.411448568929;4770.475247722748;4819.397575303087;4885.755712214375;10427.791444171075;10482.895171048192;10483.266171367932;10507.527161277761;10531.473426328654;5486.862828429242;5506.174073888948;5508.091164957737;5509.944900551023;5518.779248830002;4133.132042271097;4863.635227357962;5008;5016.272640467112;5071.619628527875;4141.8964525887095;4142.211629177171;4200.7479551227025;4207.579242075829;4221.662267018631;1293.7735896218123;1313.9737205255842;1318.3210646517052;1329.8869596084442;1332.600219934016;890.2077151335317;976.2580438866371;1005.4620777883797;1027.342500799489;1051.3376572759112;5765.1928729977835;5890.587658863924;5913.970430147908;5957.076653118774;6025.397460253939;461.07094205176594;464.91399091168245;476.6901514015848;486.17835857400877;1050.9894901051046;4137.834486620502;4257.4252475915355;4301.343982566672;4324.394584758136;4347.500037495728;10772.569097236023;11007.889921100686;11083.612073577386;11090.833637495443;11130.109591232682;10119.645812396679;10613.787724245627;10682.946585267024;10985.61550345734;11036.172287078502;8307.91997040393;8409.747707568782;8457.323414126979;8485.40602157843;8526.360522960678;6006.847028220433;6010.759569617167;6090.299615544269;6174.228221472316;6274.529410294337;10285.74285642865;10316.793664126826;10346.32748871321;10431.217658675781;10435;10346.120579750805;10348.430836304076;10353.06822385989;10449.582016719247;10467.267291289536;7708.807279818049;7946.841063178588;7970.083440404196;7992.040955085195;8172.42793004484;8751.474911505331;8830.690925817566;8862.601182946912;8862.95568522179;8894.021657617786;7880.802611672895;7925.247101525346;7983.760487185394;8022.799430014296;8256.091829898587;7491.175970643334;7696.384289256958;7857.371410287049;7920.089189743253;7953.2842044216295;7064.222935477196;7193.064901562763;7267.018952441353;7296.489245752747;7330.6701198445135;5265.842024739264;5289.391719952255;5329.333833270841;5338.652987555796;5349.1976203569775;5280.075986702389;5282.154855223146;5318.787248510016;5350.9732451337495;5383.865403364947 16:47:07 INFO - PROCESS | 15803 | |4;prototype.html;328.6492515760225;346.5183395080838;348.7123123423175;348.96335884732105;350.18057744876984;5625.465580769831;5755.58265528478;5821.417858214182;5902.409759024101;5909.2022576952095;5731.914021289674;5735.627184233022;5762.366139724627;5763.596548241625;5779.306483222009;4470;4475.731456112644;4496.415465989425;4509.6392288616835;4537.546245375469;4450.688451808374;4485.237509623355;4505.189065968125;4508.098380323932;4512.729236245819;4434.911301773963;4441.689081764278;4448.599626033656;4451.62161216297;4452.799624016927;4443.60007599316;4444.444444444419;4455.086707225028;4514;4527.939787396726;3892.785896775676;3912.8239229234755;3919.1965647042575;3983.8406463741417;4001.579834117405;5618.297712785902;5640.182173584807;5654.264945557093;5661.264035675377;5673.042800233913;5113.411957624847;5151.948480515184;5166.354205724285;5194.35070616173;5200.829813292017;5892.852678683024;6052.606580572248;6079.483243924272;6087.50856040273;6146.8770624587705;4332.718373305725;4334.501532323791;4339.739615623042;4339.978300108511;4349.325854492558;6181.7527298908435;6321.8620648283295;6338.271098823602;6352.983522636356;6354.841128971766;4422.756748378806;4450.2434586120435;4452.109578084396;4470.2177119004045;4498.167838949739;4541.614807483749;4550.840720574764;4550.908981820345;4555.863324100283;4560.931586026212;5202.76587553561;5207.323048003811;5216.60875434344;5217.869553261123;5224.138017227115;5916.674582897896;5931.139984702194;6087.391260873877;6117.663528505975;6170.413810687977;1538.7230298546144;1578.1556867076058;1579.1472604793282;1589.4754730938762;1593.7210988077272;971.8532132084067;997.2570435025807;1002.2460693785874;1002.3961661341795;1012.2610494339026;5134.589232861362;5144.30551875492;5190.636655434083;5228.712420816815;5257.868553286198;5424.7558859850615;5452.6183167177915;5520.392756796749;5558.638688485235;5585.944140558624;5019.322391477177;5180.601237665809;5218.243354713622;5247.580193584504;5286.7356632169;2923.7779287741046;2928.707129287054;2930.868110935013;2943.028800495831;2943.367176057158;5592.692401917852;5627.296587926509;5639.041362968305;5659.3208814941645;5671.489565939085;5251;5518.310211223597;5561.663002198729;5574.414686457944;5615.742869135891;5543.695096769636;5616.887662246814;5630.324361076697;5646.407127251661;5718.571107166979;5092.7199004053655;5449.5640348772795;5471.781128754806;5500.312460942382;5548.778048878;5322.600804939568;5380.946190538201;5398.352197736297;5399.78400863961;5422.240886276003;5566.888662226814;5617.662940223599;5639.802606908738;5642.435756424325;5643.234814940732;4048.696347773988;4053.3045524725726;4106.733062350938;4449.421575195204;4457.487388950182;6093.512518998381;6243.8126856194385;6247.468965138014;6255.906161407492;6258.43674069336;6105.572609917263;6112.083187521907;6136.7852125175405;6137.41694539018;6138.048602466625;6053.697315134314;6109.908351374644;6149.815505534841;6180.6600636965395;6187.628742275478;6062.969685151723;6078.7872424466705;6081.939180608138;6100.145979562776;6133.172021777182;6203.410675985774;6208.689565521616;6237.313895471585;6262.561620686691;6274.278457977209;5964.731587078679;5999.610025348338;6029.125776762257;6034.758609655564;6052.485538729257 16:47:07 INFO - PROCESS | 15803 | |5;yui.html;752.2176935986574;758.203885919784;788.4677842456344;790.5967956342265;803.6142651527266;12390.876091239084;12845.100842940998;12864.228146311229;12872.549460768863;12929.030322725797;12934.417951192196;12981.805272920914;13021.28382938938;13096.47614095435;13116.93441532791;709.9361057504824;843.7004863273542;844.5650489997656;847.9957600212006;858.2190206911712;857.3355649371756;864.0797550608581;864.360373323739;866.3285953386113;867.0072766682146;909.586138307072;913.6802119258273;916.3493919317293;916.8808054952847;921.0375157959948;913.1051569461964;914.4878867834034;915.8076803871195;916.8945571259324;918.7473444802699;670.2694063470791;674.5042393840523;675.1998881325595;675.8682056998887;677.8712044711489;13140.737185256337;13171.67070823237;13180.802287965687;13255.933720331434;13268.336583170803;15496.30266638004;15522;15637.530874073796;15669.764953525706;16145.192740362934;13120.081594288404;13260.734785304336;13337.533186338529;13363;13579.660508487268;4026.578799580535;4036.253293140778;4051.6150965658217;4080.326746086892;4156.293430116857;84885.57557212237;86353;87134.12865871387;88793;90628.54685726529;11515.19393642437;11572.36352000648;12142.939285303693;12349.135560510858;12473.75052498945;24364.634530482057;24616.876915615307;24639.26082217536;24655.506889862103;24715.382115447257;8658.350623703247;8886.333524985652;9062.410943288665;9278.11857873501;9282.164605185566;4943.233798761198;5121.180611102206;5143;5161.27742116104;5261.289725887033;3732.64539868712;3823.483829683013;3824.4072168813877;3834.578196398394;4069.7761623110423;721.6175427023686;723.6815801047522;726.7529040126383;728.5919884864387;745.2770812312049;711.8967749676372;747.7906186267853;760.4410758092797;778.696308439709;791.4618059719446;10114.848277275847;10171;10281.794364112677;10609.575616975235;10852.077573406192;654.3358491131505;668.9431398331196;761.7638532055081;797.5932274540027;798.2177466083155;4413.867583972486;4632.953670463319;4651.651126165551;4754.548317909793;4811.49479304675;122858;123116;123303;125712.37143814222;126649;64898.67550662217;81705;107456.46271768748;107938.46030769795;108544;95532;96491.03508964961;98400;99394.5030274844;100787;9288.251807318602;9532.666356677482;9679.467629280458;9743.464109474047;9777.17529441663;54573.727131365675;54597;55649.44350556443;55781.44218557762;56065;74813.25186748063;81548;83347.16652833637;83618.16381836103;84290;12360.38198090074;12526.624201273977;13340.066195366231;13363.599092027254;13525.323733813466;13912.721745565235;13936.58190254294;14087.647808804863;14161.787573186204;14661.92669036648;13051.673708157372;13393.330333483093;13409.731805364034;13853.37659805291;13981.650458738613;12904.870951290366;13074.803877941647;13244.602661920158;13398;13623.114497557626;11631.59289424866;11727.237729547553;11926.761464770483;12016.098792590416;12088.939555302168;9723.513824308899;9933.552990115606;10184.949075254577;10350.637727679496;10411.843822342822;10094.646687366201;10623.415712135908;10846.078083362687;10917.290376125526;10939.890601093886 16:47:07 INFO - PROCESS | 15803 | __end_tp_report 16:47:07 INFO - PROCESS | 15803 | __start_cc_report 16:47:07 INFO - PROCESS | 15803 | _x_x_mozilla_cycle_collect,313 16:47:07 INFO - PROCESS | 15803 | __end_cc_report 16:47:07 INFO - PROCESS | 15803 | __startTimestamp1478389627227__endTimestamp 16:47:07 INFO - PROCESS | 15803 | 16:47:07 INFO - PROCESS | 15803 | ------- Summary: start ------- 16:47:07 INFO - PROCESS | 15803 | Number of tests: 6 16:47:07 INFO - PROCESS | 15803 | 16:47:07 INFO - PROCESS | 15803 | [#0] dojo.html Cycles:165 Average:5707.64 Median:5964.82 stddev:650.55 (10.9%) stddev-sans-first:623.72 16:47:07 INFO - PROCESS | 15803 | Values: 3266.4 3278.7 3281.3 3291.3 3304.2 5750.1 5819.2 5819.6 5831.6 5832.5 5696.4 5728.4 5740.6 5749.3 5751.9 5180.2 5190.4 5200.9 5237.7 5262.9 5260.6 5260.8 5261.3 5278.6 5303.8 5068.0 5106.4 5249.5 5250.9 5261.4 5136.5 5149.6 5198.4 5243.2 5320.4 5154.5 5161.4 5243.6 5245.7 5252.3 5723.4 5732.0 5790.7 5818.9 5859.6 5986.4 6002.5 6084.7 6119.9 6134.4 6071.1 6155.1 6158.5 6187.4 6195.9 5705.3 5723.8 5723.9 5724.3 5728.7 6138.7 6142.2 6155.5 6164.0 6228.1 5952.3 5994.3 5994.5 6000.5 6033.7 6003.4 6053.3 6061.9 6072.6 6085.1 5823.2 6072.5 6123.0 6138.4 6140.7 6156.8 6165.5 6167.3 6177.7 6183.2 4732.8 4736.4 4741.4 4750.2 4754.8 4093.8 4134.3 4155.5 4173.0 4235.8 5884.6 5888.7 5923.9 5956.6 5959.3 6143.9 6238.9 6258.9 6270.5 6270.6 5754.1 5853.9 5959.3 5961.6 6013.2 5250.6 5265.8 5307.5 5317.1 5326.1 6261.3 6428.6 6449.4 6492.8 6508.4 6094.5 6111.0 6111.7 6197.2 6197.7 6293.5 6303.7 6320.5 6342.9 6368.5 5866.7 6032.9 6035.7 6047.2 6053.6 6039.5 6041.7 6084.9 6123.3 6130.6 5985.2 5985.3 6001.1 6007.2 6044.2 5928.9 5964.8 5984.2 5996.9 6010.5 5877.3 5963.8 5992.2 6038.4 6080.7 6029.2 6036.4 6112.5 6122.5 6132.3 5839.8 5957.8 5975.0 5977.3 5991.4 16:47:07 INFO - PROCESS | 15803 | 16:47:07 INFO - PROCESS | 15803 | [#1] ext.html Cycles:180 Average:64630.43 Median:45584.04 stddev:134989.87 (296.1%) stddev-sans-first:135282.92 16:47:07 INFO - PROCESS | 15803 | Values: 592.9 628.4 652.2 672.4 722.8 42840.8 47188.5 47422.5 47426.5 47568.8 46320.5 46326.1 46497.5 46542.3 46669.7 9054.2 9205.3 9212.8 9213.0 9213.5 9054.5 9179.2 9180.4 9196.2 9198.0 9202.4 9221.2 9226.5 9247.5 9294.9 9070.7 9076.6 9093.0 9219.5 9225.4 9138.1 9140.5 9165.8 9176.0 9187.4 44612.8 44855.0 44927.6 45188.8 45287.0 3596.8 3829.7 3838.7 3855.1 4580.0 34758.8 34894.1 35218.8 35432.8 35915.8 4692.9 4722.0 4734.5 4746.5 4791.9 249593.0 254017.0 256164.0 256246.0 256973.0 62772.0 63089.4 63117.1 63255.0 63327.0 39198.0 39920.6 40134.0 41840.4 65551.7 18890.1 19119.9 19134.7 19149.4 19171.3 13475.7 13547.7 13566.1 13573.9 13627.2 20467.2 20653.4 20788.9 20809.9 20906.3 7472.6 7647.6 7741.6 7842.8 7876.1 1086.6 1162.5 1190.6 1225.3 1240.5 33644.0 33784.8 33982.3 34066.0 34586.7 1157.9 1184.2 1198.9 1222.2 1227.2 18093.5 18105.5 18201.9 18286.9 18305.3 652796.0 657707.0 658086.0 661138.0 661928.0 61877.4 62212.4 62395.7 62743.1 62799.1 1445.4 1445.9 1450.8 1501.0 1504.8 33116.0 33653.8 33854.2 33855.0 33893.3 55216.2 55529.2 55918.2 55963.4 56004.4 514863.0 516664.0 516923.0 517231.0 518496.0 31072.2 31381.7 31504.8 31664.5 31742.2 52249.5 52657.7 52943.2 53003.7 54211.5 44518.6 45347.5 45513.5 45914.5 46627.0 44160.1 45654.5 45869.8 46254.5 46470.8 44599.8 44919.3 45362.3 45676.1 45989.8 38521.2 39700.0 39912.8 39945.6 40386.2 29733.0 30112.8 30577.5 30620.7 30889.5 16:47:07 INFO - PROCESS | 15803 | 16:47:07 INFO - PROCESS | 15803 | [#2] jquery.html Cycles:180 Average:30995.32 Median:12497.49 stddev:89037.10 (712.4%) stddev-sans-first:89257.25 16:47:07 INFO - PROCESS | 15803 | Values: 407.3 409.7 423.4 425.5 438.8 19522.2 21183.5 21221.6 21454.5 22243.9 19525.2 19884.9 19975.8 20111.3 20582.8 5102.0 5256.7 5291.6 5302.0 5309.8 5224.3 5255.9 5277.5 5468.5 5860.0 5600.1 5740.5 5802.6 5842.0 5863.6 5216.3 5232.8 5483.9 5765.7 5776.1 5132.4 5136.2 5143.4 5149.4 5154.2 11234.2 14222.6 22669.7 23324.0 23459.8 2325.3 2354.1 2452.4 2549.1 2734.3 9856.5 10032.8 10091.9 10500.7 10529.9 2008.7 2014.9 2019.1 2035.6 2097.3 79819.0 82193.6 83896.0 85787.6 87424.6 11315.7 11422.0 11456.2 11543.8 11618.0 16068.5 16152.5 16181.9 16217.9 16244.8 8170.5 8263.6 8372.4 8474.7 8537.8 7763.8 7932.8 7971.6 7989.2 8151.7 4770.5 4957.4 4973.1 4974.0 5026.2 1868.7 1903.3 1905.3 1983.9 2121.1 1043.3 1074.7 1108.3 1157.9 1164.2 20474.8 20655.0 20887.0 21050.7 21098.7 1041.7 1049.4 1072.4 1088.2 1176.9 10057.9 11463.8 11664.4 11682.0 11737.4 533688.0 536742.0 541489.0 542226.0 550418.0 88568.6 89042.6 96483.5 96523.5 97752.5 1002.1 1011.9 1029.6 1030.0 1032.8 17826.7 18041.8 18725.3 18736.8 18864.9 42912.0 43361.8 43980.0 45128.0 45881.8 62336.7 62584.0 63534.4 64586.4 64705.4 9085.2 9601.5 9619.3 9625.5 9641.3 11767.4 13990.0 14034.6 14417.0 14496.1 12252.5 12446.8 12517.9 12528.6 12537.7 12481.6 12521.9 12526.8 12755.2 12855.9 12642.3 12697.9 12848.7 12902.4 13059.7 9318.7 9319.5 9552.7 9586.3 9684.3 9760.5 12015.8 12454.6 12668.1 12783.7 16:47:07 INFO - PROCESS | 15803 | 16:47:07 INFO - PROCESS | 15803 | [#3] mootools.html Cycles:180 Average:5907.62 Median:462.99 stddev:3328.82 (719.0%) stddev-sans-first:3321.83 16:47:07 INFO - PROCESS | 15803 | Values: 1520.0 1520.5 1662.3 1810.5 1824.6 7535.0 8425.9 8515.4 9058.0 9069.0 8626.4 8928.1 8931.2 8935.7 8950.1 2397.4 2428.0 2438.2 2445.3 2449.1 2394.8 2398.8 2440.0 2448.1 2453.6 2411.9 2426.6 2446.8 2461.2 2462.9 2349.0 2368.9 2374.0 2375.7 2396.5 2370.2 2376.0 2387.8 2388.3 2388.4 8925.6 8934.1 9034.2 9045.5 9061.7 5195.8 5340.7 5341.4 5341.8 5348.0 3326.6 3393.3 3465.0 3478.4 3506.2 1139.7 1147.7 1165.0 1171.7 1172.0 12275.0 12294.0 12325.4 12332.4 12416.3 4686.0 4708.4 4770.5 4819.4 4885.8 10427.8 10482.9 10483.3 10507.5 10531.5 5486.9 5506.2 5508.1 5509.9 5518.8 4133.1 4863.6 5008.0 5016.3 5071.6 4141.9 4142.2 4200.7 4207.6 4221.7 1293.8 1314.0 1318.3 1329.9 1332.6 890.2 976.3 1005.5 1027.3 1051.3 5765.2 5890.6 5914.0 5957.1 6025.4 461.1 464.9 476.7 486.2 1051.0 4137.8 4257.4 4301.3 4324.4 4347.5 10772.6 11007.9 11083.6 11090.8 11130.1 10119.6 10613.8 10682.9 10985.6 11036.2 8307.9 8409.7 8457.3 8485.4 8526.4 6006.8 6010.8 6090.3 6174.2 6274.5 10285.7 10316.8 10346.3 10431.2 10435.0 10346.1 10348.4 10353.1 10449.6 10467.3 7708.8 7946.8 7970.1 7992.0 8172.4 8751.5 8830.7 8862.6 8863.0 8894.0 7880.8 7925.2 7983.8 8022.8 8256.1 7491.2 7696.4 7857.4 7920.1 7953.3 7064.2 7193.1 7267.0 7296.5 7330.7 5265.8 5289.4 5329.3 5338.7 5349.2 5280.1 5282.2 5318.8 5351.0 5383.9 16:47:07 INFO - PROCESS | 15803 | 16:47:07 INFO - PROCESS | 15803 | [#4] prototype.html Cycles:180 Average:4921.73 Median:5437.16 stddev:1426.81 (26.2%) stddev-sans-first:1388.54 16:47:07 INFO - PROCESS | 15803 | Values: 328.6 346.5 348.7 349.0 350.2 5625.5 5755.6 5821.4 5902.4 5909.2 5731.9 5735.6 5762.4 5763.6 5779.3 4470.0 4475.7 4496.4 4509.6 4537.5 4450.7 4485.2 4505.2 4508.1 4512.7 4434.9 4441.7 4448.6 4451.6 4452.8 4443.6 4444.4 4455.1 4514.0 4527.9 3892.8 3912.8 3919.2 3983.8 4001.6 5618.3 5640.2 5654.3 5661.3 5673.0 5113.4 5151.9 5166.4 5194.4 5200.8 5892.9 6052.6 6079.5 6087.5 6146.9 4332.7 4334.5 4339.7 4340.0 4349.3 6181.8 6321.9 6338.3 6353.0 6354.8 4422.8 4450.2 4452.1 4470.2 4498.2 4541.6 4550.8 4550.9 4555.9 4560.9 5202.8 5207.3 5216.6 5217.9 5224.1 5916.7 5931.1 6087.4 6117.7 6170.4 1538.7 1578.2 1579.1 1589.5 1593.7 971.9 997.3 1002.2 1002.4 1012.3 5134.6 5144.3 5190.6 5228.7 5257.9 5424.8 5452.6 5520.4 5558.6 5585.9 5019.3 5180.6 5218.2 5247.6 5286.7 2923.8 2928.7 2930.9 2943.0 2943.4 5592.7 5627.3 5639.0 5659.3 5671.5 5251.0 5518.3 5561.7 5574.4 5615.7 5543.7 5616.9 5630.3 5646.4 5718.6 5092.7 5449.6 5471.8 5500.3 5548.8 5322.6 5380.9 5398.4 5399.8 5422.2 5566.9 5617.7 5639.8 5642.4 5643.2 4048.7 4053.3 4106.7 4449.4 4457.5 6093.5 6243.8 6247.5 6255.9 6258.4 6105.6 6112.1 6136.8 6137.4 6138.0 6053.7 6109.9 6149.8 6180.7 6187.6 6063.0 6078.8 6081.9 6100.1 6133.2 6203.4 6208.7 6237.3 6262.6 6274.3 5964.7 5999.6 6029.1 6034.8 6052.5 16:47:07 INFO - PROCESS | 15803 | 16:47:07 INFO - PROCESS | 15803 | [#5] yui.html Cycles:180 Average:21839.17 Median:4118.31 stddev:32416.99 (787.1%) stddev-sans-first:32469.26 16:47:07 INFO - PROCESS | 15803 | Values: 752.2 758.2 788.5 790.6 803.6 12390.9 12845.1 12864.2 12872.5 12929.0 12934.4 12981.8 13021.3 13096.5 13116.9 709.9 843.7 844.6 848.0 858.2 857.3 864.1 864.4 866.3 867.0 909.6 913.7 916.3 916.9 921.0 913.1 914.5 915.8 916.9 918.7 670.3 674.5 675.2 675.9 677.9 13140.7 13171.7 13180.8 13255.9 13268.3 15496.3 15522.0 15637.5 15669.8 16145.2 13120.1 13260.7 13337.5 13363.0 13579.7 4026.6 4036.3 4051.6 4080.3 4156.3 84885.6 86353.0 87134.1 88793.0 90628.5 11515.2 11572.4 12142.9 12349.1 12473.8 24364.6 24616.9 24639.3 24655.5 24715.4 8658.4 8886.3 9062.4 9278.1 9282.2 4943.2 5121.2 5143.0 5161.3 5261.3 3732.6 3823.5 3824.4 3834.6 4069.8 721.6 723.7 726.8 728.6 745.3 711.9 747.8 760.4 778.7 791.5 10114.8 10171.0 10281.8 10609.6 10852.1 654.3 668.9 761.8 797.6 798.2 4413.9 4633.0 4651.7 4754.5 4811.5 122858.0 123116.0 123303.0 125712.4 126649.0 64898.7 81705.0 107456.5 107938.5 108544.0 95532.0 96491.0 98400.0 99394.5 100787.0 9288.3 9532.7 9679.5 9743.5 9777.2 54573.7 54597.0 55649.4 55781.4 56065.0 74813.3 81548.0 83347.2 83618.2 84290.0 12360.4 12526.6 13340.1 13363.6 13525.3 13912.7 13936.6 14087.6 14161.8 14661.9 13051.7 13393.3 13409.7 13853.4 13981.7 12904.9 13074.8 13244.6 13398.0 13623.1 11631.6 11727.2 11926.8 12016.1 12088.9 9723.5 9933.6 10184.9 10350.6 10411.8 10094.6 10623.4 10846.1 10917.3 10939.9 16:47:07 INFO - PROCESS | 15803 | -------- Summary: end -------- 16:47:07 INFO - PROCESS | 15803 | 16:47:07 INFO - TEST-INFO | 15803: exit 0 16:47:07 INFO - TEST-OK | dromaeo_css | took 1110258ms 16:47:07 INFO - TEST-START | kraken 16:47:07 INFO - operating with platform_type : linux_ 16:47:07 INFO - Initialising browser for kraken test... 16:47:07 INFO - TEST-INFO | started process 16042 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWN7C2W/profile http://localhost:49348/getInfo.html) 16:47:12 INFO - PROCESS | 16042 | __metrics Screen width/height:1600/1200 16:47:12 INFO - PROCESS | 16042 | colorDepth:24 16:47:12 INFO - PROCESS | 16042 | Browser inner width/height: 1024/697 16:47:12 INFO - PROCESS | 16042 | __metrics 16:47:12 ERROR - PROCESS | 16042 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 16:47:13 INFO - TEST-INFO | 16042: exit 0 16:47:13 INFO - Browser initialized. 16:47:13 INFO - Running cycle 1/1 for kraken test... 16:47:13 INFO - TEST-INFO | started process 16168 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWN7C2W/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:47:25 INFO - PROCESS | 16168 | RSS: Main: 150069248 16:47:25 INFO - PROCESS | 16168 | 16:47:27 INFO - PROCESS | 16168 | Cycle 1(1): loaded http://localhost:49348/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49348/tests/kraken/driver.html?testName=audio-beat-detection) 16:47:28 INFO - PROCESS | 16168 | RSS: Main: 156991488 16:47:28 INFO - PROCESS | 16168 | 16:47:31 INFO - PROCESS | 16168 | Cycle 1(1): loaded http://localhost:49348/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49348/tests/kraken/driver.html?testName=audio-dft) 16:47:32 INFO - PROCESS | 16168 | RSS: Main: 156037120 16:47:32 INFO - PROCESS | 16168 | 16:47:34 INFO - PROCESS | 16168 | Cycle 1(1): loaded http://localhost:49348/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49348/tests/kraken/driver.html?testName=audio-fft) 16:47:35 INFO - PROCESS | 16168 | RSS: Main: 157200384 16:47:35 INFO - PROCESS | 16168 | 16:47:37 INFO - PROCESS | 16168 | Cycle 1(1): loaded http://localhost:49348/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49348/tests/kraken/driver.html?testName=audio-oscillator) 16:47:38 INFO - PROCESS | 16168 | RSS: Main: 156880896 16:47:38 INFO - PROCESS | 16168 | 16:47:40 INFO - PROCESS | 16168 | Cycle 1(1): loaded http://localhost:49348/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49348/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:47:40 INFO - PROCESS | 16168 | RSS: Main: 156823552 16:47:40 INFO - PROCESS | 16168 | 16:47:44 INFO - PROCESS | 16168 | Cycle 1(1): loaded http://localhost:49348/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49348/tests/kraken/driver.html?testName=imaging-darkroom) 16:47:44 INFO - PROCESS | 16168 | RSS: Main: 156835840 16:47:44 INFO - PROCESS | 16168 | 16:47:48 INFO - PROCESS | 16168 | Cycle 1(1): loaded http://localhost:49348/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49348/tests/kraken/driver.html?testName=imaging-desaturate) 16:47:48 INFO - PROCESS | 16168 | RSS: Main: 157016064 16:47:48 INFO - PROCESS | 16168 | 16:47:51 INFO - PROCESS | 16168 | Cycle 1(1): loaded http://localhost:49348/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49348/tests/kraken/driver.html?testName=json-parse-financial) 16:47:52 INFO - PROCESS | 16168 | RSS: Main: 156205056 16:47:52 INFO - PROCESS | 16168 | 16:47:53 INFO - PROCESS | 16168 | Cycle 1(1): loaded http://localhost:49348/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49348/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:47:54 INFO - PROCESS | 16168 | RSS: Main: 155344896 16:47:54 INFO - PROCESS | 16168 | 16:47:56 INFO - PROCESS | 16168 | Cycle 1(1): loaded http://localhost:49348/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49348/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:47:56 INFO - PROCESS | 16168 | RSS: Main: 156651520 16:47:56 INFO - PROCESS | 16168 | 16:47:58 INFO - PROCESS | 16168 | Cycle 1(1): loaded http://localhost:49348/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49348/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:47:59 INFO - PROCESS | 16168 | RSS: Main: 156499968 16:47:59 INFO - PROCESS | 16168 | 16:48:01 INFO - PROCESS | 16168 | Cycle 1(1): loaded http://localhost:49348/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49348/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:48:02 INFO - PROCESS | 16168 | RSS: Main: 157683712 16:48:02 INFO - PROCESS | 16168 | 16:48:05 INFO - PROCESS | 16168 | Cycle 1(1): loaded http://localhost:49348/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49348/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:48:05 INFO - PROCESS | 16168 | RSS: Main: 157724672 16:48:05 INFO - PROCESS | 16168 | 16:48:07 INFO - PROCESS | 16168 | Cycle 1(1): loaded http://localhost:49348/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49348/tests/kraken/driver.html?testName=ai-astar) 16:48:07 INFO - PROCESS | 16168 | RSS: Main: 159068160 16:48:07 INFO - PROCESS | 16168 | 16:48:07 INFO - PROCESS | 16168 | __start_tp_report 16:48:07 INFO - PROCESS | 16168 | _x_x_mozilla_page_load 16:48:07 INFO - PROCESS | 16168 | _x_x_mozilla_page_load_details 16:48:07 INFO - PROCESS | 16168 | |i|pagename|runs| 16:48:07 INFO - PROCESS | 16168 | |0;ai-astar;100;111;105;112;111;111;111;111;110;112 16:48:07 INFO - PROCESS | 16168 | |1;audio-beat-detection;146;116;153;175;118;150;156;116;170;118 16:48:07 INFO - PROCESS | 16168 | |2;audio-dft;163;161;165;163;166;162;162;163;162;162 16:48:07 INFO - PROCESS | 16168 | |3;audio-fft;76;75;75;166;75;76;76;76;170;76 16:48:07 INFO - PROCESS | 16168 | |4;audio-oscillator;83;83;147;91;84;84;140;84;84;144 16:48:07 INFO - PROCESS | 16168 | |5;imaging-gaussian-blur;117;118;117;117;119;118;118;117;117;117 16:48:07 INFO - PROCESS | 16168 | |6;imaging-darkroom;147;148;148;147;146;147;147;147;146;148 16:48:07 INFO - PROCESS | 16168 | |7;imaging-desaturate;96;96;96;97;96;96;97;96;96;97 16:48:07 INFO - PROCESS | 16168 | |8;json-parse-financial;58;53;52;55;54;53;58;57;58;65 16:48:07 INFO - PROCESS | 16168 | |9;json-stringify-tinderbox;62;60;61;60;62;60;60;60;65;61 16:48:07 INFO - PROCESS | 16168 | |10;stanford-crypto-aes;72;73;73;74;74;73;73;73;78;73 16:48:07 INFO - PROCESS | 16168 | |11;stanford-crypto-ccm;119;125;122;119;119;118;120;117;163;126 16:48:07 INFO - PROCESS | 16168 | |12;stanford-crypto-pbkdf2;156;157;155;162;160;153;156;154;151;153 16:48:07 INFO - PROCESS | 16168 | |13;stanford-crypto-sha256-iterative;62;65;62;67;63;68;62;60;61;60 16:48:07 INFO - PROCESS | 16168 | __end_tp_report 16:48:07 INFO - PROCESS | 16168 | __start_cc_report 16:48:07 INFO - PROCESS | 16168 | _x_x_mozilla_cycle_collect,864 16:48:07 INFO - PROCESS | 16168 | __end_cc_report 16:48:07 INFO - PROCESS | 16168 | __startTimestamp1478389687669__endTimestamp 16:48:07 INFO - PROCESS | 16168 | 16:48:07 INFO - PROCESS | 16168 | ------- Summary: start ------- 16:48:07 INFO - PROCESS | 16168 | Number of tests: 14 16:48:07 INFO - PROCESS | 16168 | 16:48:07 INFO - PROCESS | 16168 | [#0] ai-astar Cycles:10 Average:109.40 Median:111.00 stddev:3.86 (3.5%) stddev-sans-first:2.13 16:48:07 INFO - PROCESS | 16168 | Values: 100.0 111.0 105.0 112.0 111.0 111.0 111.0 111.0 110.0 112.0 16:48:07 INFO - PROCESS | 16168 | 16:48:07 INFO - PROCESS | 16168 | [#1] audio-beat-detection Cycles:10 Average:141.80 Median:151.50 stddev:23.03 (15.2%) stddev-sans-first:24.38 16:48:07 INFO - PROCESS | 16168 | Values: 146.0 116.0 153.0 175.0 118.0 150.0 156.0 116.0 170.0 118.0 16:48:07 INFO - PROCESS | 16168 | 16:48:07 INFO - PROCESS | 16168 | [#2] audio-dft Cycles:10 Average:162.90 Median:163.00 stddev:1.52 (0.9%) stddev-sans-first:1.62 16:48:07 INFO - PROCESS | 16168 | Values: 163.0 161.0 165.0 163.0 166.0 162.0 162.0 163.0 162.0 162.0 16:48:07 INFO - PROCESS | 16168 | 16:48:07 INFO - PROCESS | 16168 | [#3] audio-fft Cycles:10 Average:94.10 Median:76.00 stddev:38.96 (51.3%) stddev-sans-first:40.77 16:48:07 INFO - PROCESS | 16168 | Values: 76.0 75.0 75.0 166.0 75.0 76.0 76.0 76.0 170.0 76.0 16:48:07 INFO - PROCESS | 16168 | 16:48:07 INFO - PROCESS | 16168 | [#4] audio-oscillator Cycles:10 Average:102.40 Median:84.00 stddev:28.62 (34.1%) stddev-sans-first:29.48 16:48:07 INFO - PROCESS | 16168 | Values: 83.0 83.0 147.0 91.0 84.0 84.0 140.0 84.0 84.0 144.0 16:48:07 INFO - PROCESS | 16168 | 16:48:07 INFO - PROCESS | 16168 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 16:48:07 INFO - PROCESS | 16168 | Values: 117.0 118.0 117.0 117.0 119.0 118.0 118.0 117.0 117.0 117.0 16:48:07 INFO - PROCESS | 16168 | 16:48:07 INFO - PROCESS | 16168 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 16:48:07 INFO - PROCESS | 16168 | Values: 147.0 148.0 148.0 147.0 146.0 147.0 147.0 147.0 146.0 148.0 16:48:07 INFO - PROCESS | 16168 | 16:48:07 INFO - PROCESS | 16168 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 16:48:07 INFO - PROCESS | 16168 | Values: 96.0 96.0 96.0 97.0 96.0 96.0 97.0 96.0 96.0 97.0 16:48:07 INFO - PROCESS | 16168 | 16:48:07 INFO - PROCESS | 16168 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:57.50 stddev:3.83 (6.7%) stddev-sans-first:4.01 16:48:07 INFO - PROCESS | 16168 | Values: 58.0 53.0 52.0 55.0 54.0 53.0 58.0 57.0 58.0 65.0 16:48:07 INFO - PROCESS | 16168 | 16:48:07 INFO - PROCESS | 16168 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:61.00 stddev:1.60 (2.6%) stddev-sans-first:1.66 16:48:07 INFO - PROCESS | 16168 | Values: 62.0 60.0 61.0 60.0 62.0 60.0 60.0 60.0 65.0 61.0 16:48:07 INFO - PROCESS | 16168 | 16:48:07 INFO - PROCESS | 16168 | [#10] stanford-crypto-aes Cycles:10 Average:73.60 Median:73.00 stddev:1.65 (2.3%) stddev-sans-first:1.64 16:48:07 INFO - PROCESS | 16168 | Values: 72.0 73.0 73.0 74.0 74.0 73.0 73.0 73.0 78.0 73.0 16:48:07 INFO - PROCESS | 16168 | 16:48:07 INFO - PROCESS | 16168 | [#11] stanford-crypto-ccm Cycles:10 Average:124.80 Median:121.00 stddev:13.74 (11.4%) stddev-sans-first:14.41 16:48:07 INFO - PROCESS | 16168 | Values: 119.0 125.0 122.0 119.0 119.0 118.0 120.0 117.0 163.0 126.0 16:48:07 INFO - PROCESS | 16168 | 16:48:07 INFO - PROCESS | 16168 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.70 Median:156.00 stddev:3.33 (2.1%) stddev-sans-first:3.54 16:48:07 INFO - PROCESS | 16168 | Values: 156.0 157.0 155.0 162.0 160.0 153.0 156.0 154.0 151.0 153.0 16:48:07 INFO - PROCESS | 16168 | 16:48:07 INFO - PROCESS | 16168 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:62.50 stddev:2.79 (4.5%) stddev-sans-first:2.93 16:48:07 INFO - PROCESS | 16168 | Values: 62.0 65.0 62.0 67.0 63.0 68.0 62.0 60.0 61.0 60.0 16:48:07 INFO - PROCESS | 16168 | -------- Summary: end -------- 16:48:07 INFO - PROCESS | 16168 | 16:48:08 INFO - TEST-INFO | 16168: exit 0 16:48:08 INFO - TEST-OK | kraken | took 60715ms 16:48:08 INFO - SUITE-END | took 1170s 16:48:08 INFO - Completed test suite (00:19:31) 16:48:08 INFO - javascript benchmark 16:48:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7572.9183118899, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3266.4120458317507, 3278.6557411471786, 3281.31092470581, 3291.3417316536697, 3304.1739565108724, 5750.051241545145, 5819.156222347757, 5819.563532735046, 5831.620944638601, 5832.504237139849, 5696.3733989261145, 5728.369879313283, 5740.5981581289325, 5749.3388260350075, 5751.856203594913, 5180.2229665550185, 5190.351206099238, 5200.92198617021, 5237.659552129099, 5262.8684282892855, 5260.631755777097, 5260.763265653036, 5261.316028916235, 5278.577713782888, 5303.814366497173, 5068.037072956145, 5106.387233531981, 5249.527542521172, 5250.868728281805, 5261.447548007462, 5136.460671629481, 5149.639525233235, 5198.40218374888, 5243.213517972296, 5320.388155362144, 5154.458781827929, 5161.4322424533275, 5243.632945693803, 5245.659032162897, 5252.343457067866, 5723.370429252779, 5731.996900542388, 5790.716912680805, 5818.854528636818, 5859.589828711992, 5986.431289027535, 6002.4897883679505, 6084.665343406111, 6119.8681629442035, 6134.4172303631085, 6071.119687645267, 6155.138280640714, 6158.507319414436, 6187.3503282155625, 6195.938040619581, 5705.343885453143, 5723.77104915807, 5723.912456633227, 5724.284464441945, 5728.656280623134, 6138.694953005908, 6142.191841058572, 6155.4767844732805, 6164.044573091178, 6228.065790131516, 5952.345242023374, 5994.250718660168, 5994.520438364921, 6000.459958603747, 6033.698315084228, 6003.3996600339615, 6053.334133245339, 6061.939160646957, 6072.574919755663, 6085.056816193497, 5823.155642431909, 6072.483838873745, 6123.0, 6138.419052470195, 6140.723667434976, 6156.753729850845, 6165.506759459322, 6167.290761562478, 6177.722002509898, 6183.196184495987, 4732.763361831895, 4736.384270044872, 4741.35991641124, 4750.192467280571, 4754.78603462845, 4093.815778289984, 4134.255833949918, 4155.542890282067, 4172.99848036469, 4235.8093885775215, 5884.58807883444, 5888.705564721747, 5923.911141332884, 5956.583039187215, 5959.314678811992, 6143.877122457526, 6238.937610623926, 6258.874822503524, 6270.529710271748, 6270.623762574261, 5754.079347304411, 5853.853653658693, 5959.255093113361, 5961.642301461926, 6013.188219590299, 5250.579953603703, 5265.78936842522, 5307.548858347007, 5317.122674758699, 5326.094563924142, 6261.311255761862, 6428.550001499943, 6449.419552240321, 6492.772752953624, 6508.381703738138, 6094.451499364901, 6111.014442317695, 6111.724972376165, 6197.194364732556, 6197.721102550306, 6293.465055470337, 6303.747850085945, 6320.494360451061, 6342.904856427065, 6368.490520758421, 5866.706664666664, 6032.8793424132145, 6035.69821508914, 6047.183630210041, 6053.636781793107, 6039.5470339723815, 6041.697915104315, 6084.908726369196, 6123.313124872426, 6130.616155366224, 5985.191999080069, 5985.341612422717, 6001.099835024781, 6007.249093863267, 6044.184035155197, 5928.9407105928385, 5964.821055368346, 5984.19213406202, 5996.850078748066, 6010.54920880927, 5877.265341832271, 5963.791267305797, 5992.221011268682, 6038.426349496791, 6080.665563394055, 6029.216201893726, 6036.396360363929, 6112.510999120149, 6122.5408094392205, 6132.264128304632, 5839.766409343749, 5957.821265362046, 5975.0, 5977.312609049841, 5991.370906054802], "value": 5663.089556322136, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.908099244617, 628.4092952624533, 652.2368828470688, 672.3612568060341, 722.8373615936412, 42840.78579607105, 47188.52811471893, 47422.525774742244, 47426.5257347426, 47568.76215618917, 46320.53679463204, 46326.073478530496, 46497.53502464974, 46542.30186547204, 46669.6665166742, 9054.185123338915, 9205.263578913671, 9212.815743685122, 9212.953935230315, 9213.493257870814, 9054.547272636375, 9179.173874351307, 9180.403273787217, 9196.172344488994, 9197.954010229972, 9202.447853128833, 9221.170094691477, 9226.492542910137, 9247.537623118851, 9294.860577091315, 9070.682526111588, 9076.636934522645, 9093.045230250827, 9219.492927888963, 9225.354225204239, 9138.086191380875, 9140.54297285133, 9165.816683666357, 9175.954120229422, 9187.448753074837, 44612.776936115435, 44855.0, 44927.55072449266, 45188.77405612951, 45287.0, 3596.8021758803256, 3829.6744776694013, 3838.654521093087, 3855.1133239354826, 4580.0152967112235, 34758.82620586906, 34894.12764680878, 35218.82390588031, 35432.82283588566, 35915.82042089799, 4692.882677933079, 4721.976390118062, 4734.526547345238, 4746.52534746526, 4791.928121078186, 249593.0, 254017.0, 256164.0, 256246.0, 256973.0, 62772.0, 63089.36910630927, 63117.05324420137, 63255.0, 63327.0, 39198.0, 39920.60079399169, 40134.0, 41840.37239441411, 65551.67224163849, 18890.149943252585, 19119.90440047791, 19134.71297930532, 19149.425517234227, 19171.32900348481, 13475.730485390237, 13547.729045419037, 13566.118202316818, 13573.932130339284, 13627.182369057888, 20467.181312747325, 20653.380398588066, 20788.896055519624, 20809.89595052015, 20906.268280610104, 7472.5516469010945, 7647.579383133981, 7741.5742134183165, 7842.803929901684, 7876.077451592754, 1086.6414083352474, 1162.4652659776598, 1190.6070996571111, 1225.2648410953534, 1240.49759847262, 33644.0, 33784.831075844464, 33982.32035359279, 34066.0, 34586.654133458345, 1157.8784227655974, 1184.1710802438329, 1198.8621308549455, 1222.19335238742, 1227.1777908801125, 18093.54766130831, 18105.547361316072, 18201.908990454962, 18286.908565457088, 18305.26778928828, 652796.0, 657707.0, 658086.0, 661138.0, 661928.0, 61877.38122618806, 62212.37787622066, 62395.68802156051, 62743.058854117226, 62799.05801412983, 1445.436279850859, 1445.922787523281, 1450.8259008918997, 1500.9624759380883, 1504.7742838574302, 33116.0, 33653.831730841186, 33854.153646159044, 33855.0, 33893.3221335567, 55216.17175742287, 55529.16706249329, 55918.16122758081, 55963.44036559745, 56004.43995559992, 514863.0, 516664.0, 516923.0, 517231.0, 518496.0, 31072.22319442032, 31381.686183137877, 31504.842475787475, 31664.525032125, 31742.20644483814, 52249.47750522446, 52657.73671131773, 52943.20585191148, 53003.734981324844, 54211.45788542222, 44518.554814452735, 45347.54652453433, 45513.544864552256, 45914.540854592364, 46627.0, 44160.11679766451, 45654.54345456503, 45869.77065114653, 46254.537454625024, 46470.7676461629, 44599.77700111479, 44919.32621010753, 45362.31956520721, 45676.08647827091, 45989.77005114953, 38521.22957540777, 39700.00749981274, 39912.80043599763, 39945.60054399419, 40386.19227615373, 29733.0, 30112.84943575268, 30577.54133688041, 30620.693793061786, 30889.536656950615], "value": 21412.155158446734, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.27505041026984, 409.7254839257697, 423.3839763144624, 425.4702894895854, 438.80473189430694, 19522.21911123555, 21183.47041323966, 21221.57556848864, 21454.463638409048, 22243.888780556113, 19525.21899124037, 19884.900575497137, 19975.80024199761, 20111.29610463634, 20582.794172058275, 5101.9744901275535, 5256.658317209388, 5291.6031297652635, 5301.973490132544, 5309.840704778863, 5224.2686023956485, 5255.921161182585, 5277.47225277473, 5468.535174510172, 5859.970700146515, 5600.131979543177, 5740.483356497914, 5802.5938184327115, 5842.0, 5863.648181109126, 5216.347956505437, 5232.790688372461, 5483.917741233865, 5765.711714414262, 5776.133579962997, 5132.358455193101, 5136.203888397267, 5143.382794064699, 5149.382074151126, 5154.201098829687, 11234.21360504765, 14222.644433889132, 22669.659955100688, 23324.0, 23459.76540234593, 2325.3140323604407, 2354.0819080558595, 2452.350127216289, 2549.107812265711, 2734.3300891281565, 9856.457894815781, 10032.79934401308, 10091.949540252252, 10500.684979450552, 10529.894701052968, 2008.658528050235, 2014.8791072535548, 2019.1014998325752, 2035.6436036447076, 2097.276439628326, 79819.0, 82193.58903205565, 83896.0, 85787.57106214491, 87424.5628771852, 11315.717107072225, 11422.0, 11456.198066135457, 11543.826842597367, 11618.0, 16068.517944461684, 16152.515424537283, 16181.919090404472, 16217.918910405373, 16244.837551624569, 8170.509769413854, 8263.628136733862, 8372.41393102477, 8474.661013559511, 8537.786555336166, 7763.844723105506, 7932.801679957932, 7971.561564114029, 7989.161138080534, 8151.673933042612, 4770.475247722748, 4957.429895562056, 4973.055119527278, 4973.950260497349, 5026.195808670595, 1868.6823240049225, 1903.2957805611736, 1905.285517930776, 1983.890886001284, 2121.1091341636547, 1043.3009883378154, 1074.6775967209805, 1108.2740804772886, 1157.8837233634342, 1164.2257898497573, 20474.79525204729, 20655.0, 20887.0, 21050.684239736416, 21098.727704875233, 1041.734357738787, 1049.371324831308, 1072.3887384190937, 1088.1784252889017, 1176.8823117688162, 10057.899421005843, 11463.7963013884, 11664.416779161009, 11682.0, 11737.413129343498, 533688.0, 536742.0, 541489.0, 542226.0, 550418.0, 88568.5571572151, 89042.55478722564, 96483.51758241164, 96523.51738241264, 97752.51123744478, 1002.1481740520645, 1011.8633984412157, 1029.6087486755134, 1030.006044167382, 1032.8450732390202, 17826.732599010767, 18041.819581804015, 18725.25098996025, 18736.81263187405, 18864.905675471535, 42912.0, 43361.78319108384, 43980.0, 45128.0, 45881.77059114683, 62336.688316558124, 62584.0, 63534.36465635469, 64586.35413645803, 64705.35294646993, 9085.22775564058, 9601.519924003633, 9619.27855410861, 9625.470599117116, 9641.27690423235, 11767.411629418666, 13990.0, 14034.578962631138, 14417.0, 14496.130232186102, 12252.509899603916, 12446.751064978469, 12517.93741031289, 12528.624141275777, 12537.686557835763, 12481.56314528987, 12521.87478125207, 12526.812097818722, 12755.170913890568, 12855.935720321339, 12642.30467324306, 12697.93651031739, 12848.743025139633, 12902.419391127609, 13059.673508162372, 9318.72043838686, 9319.487428191514, 9552.66565670226, 9586.281028922998, 9684.322097453392, 9760.463174525185, 12015.75968480643, 12454.564090256797, 12668.113232073667, 12783.680407989503], "value": 9542.679039316436, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1519.9848001519986, 1520.4602366160016, 1662.2602941690945, 1810.5383127302543, 1824.5712257619466, 7534.962325188367, 8425.915740842589, 8515.361347898901, 9058.0, 9069.0, 8626.353023523245, 8928.062553431877, 8931.240844528224, 8935.687250946217, 8950.104989501064, 2397.4246180916543, 2428.0, 2438.231956933569, 2445.254197469771, 2449.081594402099, 2394.7964423024064, 2398.7721166489155, 2440.036185706645, 2448.1064411489765, 2453.58289090855, 2411.8794060297005, 2426.5874801283735, 2446.779789818916, 2461.2493189577262, 2462.9014839406404, 2349.036894873111, 2368.881555922197, 2374.0147838647026, 2375.726791418983, 2396.532676128156, 2370.1704403458825, 2376.013954209001, 2387.78509934105, 2388.295452841416, 2388.4387169015267, 8925.598348074287, 8934.061923498004, 9034.232090272335, 9045.502497362642, 9061.68284110053, 5195.818146364897, 5340.732963351817, 5341.385740639798, 5341.813036543703, 5347.983883062245, 3326.617438994498, 3393.253484233465, 3464.9854626474876, 3478.4434490481403, 3506.2286297014616, 1139.692283083571, 1147.65570328901, 1165.0388429545574, 1171.689502281896, 1172.0, 12275.0, 12294.0, 12325.445354959049, 12332.445039973223, 12416.317102559356, 4685.998310827225, 4708.411448568929, 4770.475247722748, 4819.397575303087, 4885.755712214375, 10427.791444171075, 10482.895171048192, 10483.266171367932, 10507.527161277761, 10531.473426328654, 5486.862828429242, 5506.174073888948, 5508.091164957737, 5509.944900551023, 5518.779248830002, 4133.132042271097, 4863.635227357962, 5008.0, 5016.272640467112, 5071.619628527875, 4141.8964525887095, 4142.211629177171, 4200.7479551227025, 4207.579242075829, 4221.662267018631, 1293.7735896218123, 1313.9737205255842, 1318.3210646517052, 1329.8869596084442, 1332.600219934016, 890.2077151335317, 976.2580438866371, 1005.4620777883797, 1027.342500799489, 1051.3376572759112, 5765.1928729977835, 5890.587658863924, 5913.970430147908, 5957.076653118774, 6025.397460253939, 461.07094205176594, 464.91399091168245, 476.6901514015848, 486.17835857400877, 1050.9894901051046, 4137.834486620502, 4257.4252475915355, 4301.343982566672, 4324.394584758136, 4347.500037495728, 10772.569097236023, 11007.889921100686, 11083.612073577386, 11090.833637495443, 11130.109591232682, 10119.645812396679, 10613.787724245627, 10682.946585267024, 10985.61550345734, 11036.172287078502, 8307.91997040393, 8409.747707568782, 8457.323414126979, 8485.40602157843, 8526.360522960678, 6006.847028220433, 6010.759569617167, 6090.299615544269, 6174.228221472316, 6274.529410294337, 10285.74285642865, 10316.793664126826, 10346.32748871321, 10431.217658675781, 10435.0, 10346.120579750805, 10348.430836304076, 10353.06822385989, 10449.582016719247, 10467.267291289536, 7708.807279818049, 7946.841063178588, 7970.083440404196, 7992.040955085195, 8172.42793004484, 8751.474911505331, 8830.690925817566, 8862.601182946912, 8862.95568522179, 8894.021657617786, 7880.802611672895, 7925.247101525346, 7983.760487185394, 8022.799430014296, 8256.091829898587, 7491.175970643334, 7696.384289256958, 7857.371410287049, 7920.089189743253, 7953.2842044216295, 7064.222935477196, 7193.064901562763, 7267.018952441353, 7296.489245752747, 7330.6701198445135, 5265.842024739264, 5289.391719952255, 5329.333833270841, 5338.652987555796, 5349.1976203569775, 5280.075986702389, 5282.154855223146, 5318.787248510016, 5350.9732451337495, 5383.865403364947], "value": 4696.581621900816, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.6492515760225, 346.5183395080838, 348.7123123423175, 348.96335884732105, 350.18057744876984, 5625.465580769831, 5755.58265528478, 5821.417858214182, 5902.409759024101, 5909.2022576952095, 5731.914021289674, 5735.627184233022, 5762.366139724627, 5763.596548241625, 5779.306483222009, 4470.0, 4475.731456112644, 4496.415465989425, 4509.6392288616835, 4537.546245375469, 4450.688451808374, 4485.237509623355, 4505.189065968125, 4508.098380323932, 4512.729236245819, 4434.911301773963, 4441.689081764278, 4448.599626033656, 4451.62161216297, 4452.799624016927, 4443.60007599316, 4444.444444444419, 4455.086707225028, 4514.0, 4527.939787396726, 3892.785896775676, 3912.8239229234755, 3919.1965647042575, 3983.8406463741417, 4001.579834117405, 5618.297712785902, 5640.182173584807, 5654.264945557093, 5661.264035675377, 5673.042800233913, 5113.411957624847, 5151.948480515184, 5166.354205724285, 5194.35070616173, 5200.829813292017, 5892.852678683024, 6052.606580572248, 6079.483243924272, 6087.50856040273, 6146.8770624587705, 4332.718373305725, 4334.501532323791, 4339.739615623042, 4339.978300108511, 4349.325854492558, 6181.7527298908435, 6321.8620648283295, 6338.271098823602, 6352.983522636356, 6354.841128971766, 4422.756748378806, 4450.2434586120435, 4452.109578084396, 4470.2177119004045, 4498.167838949739, 4541.614807483749, 4550.840720574764, 4550.908981820345, 4555.863324100283, 4560.931586026212, 5202.76587553561, 5207.323048003811, 5216.60875434344, 5217.869553261123, 5224.138017227115, 5916.674582897896, 5931.139984702194, 6087.391260873877, 6117.663528505975, 6170.413810687977, 1538.7230298546144, 1578.1556867076058, 1579.1472604793282, 1589.4754730938762, 1593.7210988077272, 971.8532132084067, 997.2570435025807, 1002.2460693785874, 1002.3961661341795, 1012.2610494339026, 5134.589232861362, 5144.30551875492, 5190.636655434083, 5228.712420816815, 5257.868553286198, 5424.7558859850615, 5452.6183167177915, 5520.392756796749, 5558.638688485235, 5585.944140558624, 5019.322391477177, 5180.601237665809, 5218.243354713622, 5247.580193584504, 5286.7356632169, 2923.7779287741046, 2928.707129287054, 2930.868110935013, 2943.028800495831, 2943.367176057158, 5592.692401917852, 5627.296587926509, 5639.041362968305, 5659.3208814941645, 5671.489565939085, 5251.0, 5518.310211223597, 5561.663002198729, 5574.414686457944, 5615.742869135891, 5543.695096769636, 5616.887662246814, 5630.324361076697, 5646.407127251661, 5718.571107166979, 5092.7199004053655, 5449.5640348772795, 5471.781128754806, 5500.312460942382, 5548.778048878, 5322.600804939568, 5380.946190538201, 5398.352197736297, 5399.78400863961, 5422.240886276003, 5566.888662226814, 5617.662940223599, 5639.802606908738, 5642.435756424325, 5643.234814940732, 4048.696347773988, 4053.3045524725726, 4106.733062350938, 4449.421575195204, 4457.487388950182, 6093.512518998381, 6243.8126856194385, 6247.468965138014, 6255.906161407492, 6258.43674069336, 6105.572609917263, 6112.083187521907, 6136.7852125175405, 6137.41694539018, 6138.048602466625, 6053.697315134314, 6109.908351374644, 6149.815505534841, 6180.6600636965395, 6187.628742275478, 6062.969685151723, 6078.7872424466705, 6081.939180608138, 6100.145979562776, 6133.172021777182, 6203.410675985774, 6208.689565521616, 6237.313895471585, 6262.561620686691, 6274.278457977209, 5964.731587078679, 5999.610025348338, 6029.125776762257, 6034.758609655564, 6052.485538729257], "value": 4466.387130500208, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.2176935986574, 758.203885919784, 788.4677842456344, 790.5967956342265, 803.6142651527266, 12390.876091239084, 12845.100842940998, 12864.228146311229, 12872.549460768863, 12929.030322725797, 12934.417951192196, 12981.805272920914, 13021.28382938938, 13096.47614095435, 13116.93441532791, 709.9361057504824, 843.7004863273542, 844.5650489997656, 847.9957600212006, 858.2190206911712, 857.3355649371756, 864.0797550608581, 864.360373323739, 866.3285953386113, 867.0072766682146, 909.586138307072, 913.6802119258273, 916.3493919317293, 916.8808054952847, 921.0375157959948, 913.1051569461964, 914.4878867834034, 915.8076803871195, 916.8945571259324, 918.7473444802699, 670.2694063470791, 674.5042393840523, 675.1998881325595, 675.8682056998887, 677.8712044711489, 13140.737185256337, 13171.67070823237, 13180.802287965687, 13255.933720331434, 13268.336583170803, 15496.30266638004, 15522.0, 15637.530874073796, 15669.764953525706, 16145.192740362934, 13120.081594288404, 13260.734785304336, 13337.533186338529, 13363.0, 13579.660508487268, 4026.578799580535, 4036.253293140778, 4051.6150965658217, 4080.326746086892, 4156.293430116857, 84885.57557212237, 86353.0, 87134.12865871387, 88793.0, 90628.54685726529, 11515.19393642437, 11572.36352000648, 12142.939285303693, 12349.135560510858, 12473.75052498945, 24364.634530482057, 24616.876915615307, 24639.26082217536, 24655.506889862103, 24715.382115447257, 8658.350623703247, 8886.333524985652, 9062.410943288665, 9278.11857873501, 9282.164605185566, 4943.233798761198, 5121.180611102206, 5143.0, 5161.27742116104, 5261.289725887033, 3732.64539868712, 3823.483829683013, 3824.4072168813877, 3834.578196398394, 4069.7761623110423, 721.6175427023686, 723.6815801047522, 726.7529040126383, 728.5919884864387, 745.2770812312049, 711.8967749676372, 747.7906186267853, 760.4410758092797, 778.696308439709, 791.4618059719446, 10114.848277275847, 10171.0, 10281.794364112677, 10609.575616975235, 10852.077573406192, 654.3358491131505, 668.9431398331196, 761.7638532055081, 797.5932274540027, 798.2177466083155, 4413.867583972486, 4632.953670463319, 4651.651126165551, 4754.548317909793, 4811.49479304675, 122858.0, 123116.0, 123303.0, 125712.37143814222, 126649.0, 64898.67550662217, 81705.0, 107456.46271768748, 107938.46030769795, 108544.0, 95532.0, 96491.03508964961, 98400.0, 99394.5030274844, 100787.0, 9288.251807318602, 9532.666356677482, 9679.467629280458, 9743.464109474047, 9777.17529441663, 54573.727131365675, 54597.0, 55649.44350556443, 55781.44218557762, 56065.0, 74813.25186748063, 81548.0, 83347.16652833637, 83618.16381836103, 84290.0, 12360.38198090074, 12526.624201273977, 13340.066195366231, 13363.599092027254, 13525.323733813466, 13912.721745565235, 13936.58190254294, 14087.647808804863, 14161.787573186204, 14661.92669036648, 13051.673708157372, 13393.330333483093, 13409.731805364034, 13853.37659805291, 13981.650458738613, 12904.870951290366, 13074.803877941647, 13244.602661920158, 13398.0, 13623.114497557626, 11631.59289424866, 11727.237729547553, 11926.761464770483, 12016.098792590416, 12088.939555302168, 9723.513824308899, 9933.552990115606, 10184.949075254577, 10350.637727679496, 10411.843822342822, 10094.646687366201, 10623.415712135908, 10846.078083362687, 10917.290376125526, 10939.890601093886], "value": 7769.861636896624, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1505.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 111.0, 105.0, 112.0, 111.0, 111.0, 111.0, 111.0, 110.0, 112.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 116.0, 153.0, 175.0, 118.0, 150.0, 156.0, 116.0, 170.0, 118.0], "value": 141.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 165.0, 163.0, 166.0, 162.0, 162.0, 163.0, 162.0, 162.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 166.0, 75.0, 76.0, 76.0, 76.0, 170.0, 76.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 147.0, 91.0, 84.0, 84.0, 140.0, 84.0, 84.0, 144.0], "value": 102.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 119.0, 118.0, 118.0, 117.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0, 148.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 97.0, 96.0, 96.0, 97.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 53.0, 52.0, 55.0, 54.0, 53.0, 58.0, 57.0, 58.0, 65.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 61.0, 60.0, 62.0, 60.0, 60.0, 60.0, 65.0, 61.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 73.0, 74.0, 74.0, 73.0, 73.0, 73.0, 78.0, 73.0], "value": 73.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 125.0, 122.0, 119.0, 119.0, 118.0, 120.0, 117.0, 163.0, 126.0], "value": 124.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 157.0, 155.0, 162.0, 160.0, 153.0, 156.0, 154.0, 151.0, 153.0], "value": 155.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 62.0, 67.0, 63.0, 68.0, 62.0, 60.0, 61.0, 60.0], "value": 63.0, "unit": "score"}]}]} 16:48:08 INFO - Return code: 0 16:48:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:48:08 ERROR - # TBPL SUCCESS # 16:48:08 INFO - Running post-action listener: _resource_record_post_action 16:48:08 INFO - [mozharness: 2016-11-05 23:48:08.965561Z] Finished run-tests step (success) 16:48:08 INFO - Running post-run listener: _resource_record_post_run 16:48:09 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 1744896; Write bytes: 289976320; Read time: 392; Write time: 176656 16:48:09 INFO - TinderboxPrint: CPU usage
13.3% 16:48:09 INFO - TinderboxPrint: I/O read bytes / time
1,744,896 / 392 16:48:09 INFO - TinderboxPrint: I/O write bytes / time
289,976,320 / 176,656 16:48:09 INFO - TinderboxPrint: CPU idle
8,202.0 (86.7%) 16:48:09 INFO - TinderboxPrint: CPU user
1,198.7 (12.7%) 16:48:09 INFO - TinderboxPrint: Swap in / out
0 / 0 16:48:09 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 4096; Write bytes: 70123520; Read time: 216; Write time: 48456 16:48:09 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 8192; Write bytes: 219852800; Read time: 136; Write time: 128200 16:48:09 INFO - Running post-run listener: _upload_blobber_files 16:48:09 INFO - Blob upload gear active. 16:48:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:48:09 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 16:48:09 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'] 16:48:09 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 16:48:09 INFO - (blobuploader) - INFO - Open directory for files ... 16:48:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:48:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:48:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:48:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:48:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:48:13 INFO - (blobuploader) - INFO - Done attempting. 16:48:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:48:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:48:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:48:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:48:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:48:14 INFO - (blobuploader) - INFO - Done attempting. 16:48:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:48:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:48:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:48:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:48:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:48:15 INFO - (blobuploader) - INFO - Done attempting. 16:48:15 INFO - (blobuploader) - INFO - Iteration through files over. 16:48:15 INFO - Return code: 0 16:48:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:48:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:48:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e2de9745ac81654a6168787ea6de0409e3a429c5f93002f273a2ee39b0a8cbd4ad2fbb2bf080218a0137ea3d3f6190f239ad0958657216d007e5beaeae62e297", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/38fbdf05537e5d45e994c5be62c4add7a05aea221b839569da633cfee1c89acb12db081d86ab014f0ded75741f015523c73a99189b13a8b47684aa191c5626be", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3b820d1ea74472fa64fe7bb65763b02340ad7c191170a0bed385ac5625310b784262225eee635122286c71f39fd705a8e0e74818de58638f93e45626f798c7f7"} 16:48:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:48:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:48:15 INFO - Contents: 16:48:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e2de9745ac81654a6168787ea6de0409e3a429c5f93002f273a2ee39b0a8cbd4ad2fbb2bf080218a0137ea3d3f6190f239ad0958657216d007e5beaeae62e297", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/38fbdf05537e5d45e994c5be62c4add7a05aea221b839569da633cfee1c89acb12db081d86ab014f0ded75741f015523c73a99189b13a8b47684aa191c5626be", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3b820d1ea74472fa64fe7bb65763b02340ad7c191170a0bed385ac5625310b784262225eee635122286c71f39fd705a8e0e74818de58638f93e45626f798c7f7"} 16:48:15 INFO - Running post-run listener: copy_logs_to_upload_dir 16:48:15 INFO - Copying logs to upload dir... 16:48:15 INFO - mkdir: /builds/slave/test/build/upload/logs 16:48:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1672.933228 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 52 secs) (at 2016-11-05 16:48:15.202722) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-05 16:48:15.206056) ========= 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=0e2a256762fed810e2f0f810000001b3-1478388020.996873-1638991663 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/e2de9745ac81654a6168787ea6de0409e3a429c5f93002f273a2ee39b0a8cbd4ad2fbb2bf080218a0137ea3d3f6190f239ad0958657216d007e5beaeae62e297", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/38fbdf05537e5d45e994c5be62c4add7a05aea221b839569da633cfee1c89acb12db081d86ab014f0ded75741f015523c73a99189b13a8b47684aa191c5626be", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3b820d1ea74472fa64fe7bb65763b02340ad7c191170a0bed385ac5625310b784262225eee635122286c71f39fd705a8e0e74818de58638f93e45626f798c7f7"} build_url:https://queue.taskcluster.net/v1/task/cPEudMkWRHGTOZCvuHLilg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011356 build_url: 'https://queue.taskcluster.net/v1/task/cPEudMkWRHGTOZCvuHLilg/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/e2de9745ac81654a6168787ea6de0409e3a429c5f93002f273a2ee39b0a8cbd4ad2fbb2bf080218a0137ea3d3f6190f239ad0958657216d007e5beaeae62e297", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/38fbdf05537e5d45e994c5be62c4add7a05aea221b839569da633cfee1c89acb12db081d86ab014f0ded75741f015523c73a99189b13a8b47684aa191c5626be", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3b820d1ea74472fa64fe7bb65763b02340ad7c191170a0bed385ac5625310b784262225eee635122286c71f39fd705a8e0e74818de58638f93e45626f798c7f7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-05 16:48:15.236067) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 16:48:15.236424) ========= 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=0e2a256762fed810e2f0f810000001b3-1478388020.996873-1638991663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004532 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 16:48:15.313343) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-05 16:48:15.313646) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-05 16:48:15.316958) ========= ========= Total master_lag: 0.16 =========