builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-028 starttime: 1473245352.65 results: success (0) buildid: 20160907004009 builduid: 4e2b6e876f594fbe91551200ebdb17c0 revision: 3a0fd1bb116a3b79b6f33462a04144818b550ee9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-07 03:49:12.655020) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-07 03:49:12.655730) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-07 03:49:12.656363) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-07 03:49:12.717363) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 03:49:12.717632) ========= 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=836cfdc75598d54cb747368e000001a9-1473245343.304993-160625666 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-07 03:49:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 17.4M=0.001s 2016-09-07 03:49:13 (17.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.079109 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 03:49:12.814828) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 03:49:12.815144) ========= 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=836cfdc75598d54cb747368e000001a9-1473245343.304993-160625666 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023781 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 03:49:12.868899) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 03:49:12.869237) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3a0fd1bb116a3b79b6f33462a04144818b550ee9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3a0fd1bb116a3b79b6f33462a04144818b550ee9 --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=836cfdc75598d54cb747368e000001a9-1473245343.304993-160625666 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-07 03:49:13,656 truncating revision to first 12 chars 2016-09-07 03:49:13,656 Setting DEBUG logging. 2016-09-07 03:49:13,657 attempt 1/10 2016-09-07 03:49:13,657 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/3a0fd1bb116a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-07 03:49:14,115 unpacking tar archive at: mozilla-aurora-3a0fd1bb116a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.794880 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 03:49:13.678945) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-07 03:49:13.679257) ========= script_repo_revision: 3a0fd1bb116a3b79b6f33462a04144818b550ee9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-07 03:49:13.679671) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-07 03:49:13.679973) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-07 03:49:13.691850) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 3 secs) (at 2016-09-07 03:49:13.692144) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=836cfdc75598d54cb747368e000001a9-1473245343.304993-160625666 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:49:14 INFO - MultiFileLogger online at 20160907 03:49:14 in /builds/slave/test 03:49:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:49:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:49:14 INFO - {'append_to_log': False, 03:49:14 INFO - 'base_work_dir': '/builds/slave/test', 03:49:14 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:49:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:49:14 INFO - 'branch': 'Mozilla-Aurora', 03:49:14 INFO - 'buildbot_json_path': 'buildprops.json', 03:49:14 INFO - 'config_files': ('talos/linux_config.py',), 03:49:14 INFO - 'default_actions': ('clobber', 03:49:14 INFO - 'read-buildbot-config', 03:49:14 INFO - 'download-and-extract', 03:49:14 INFO - 'populate-webroot', 03:49:14 INFO - 'create-virtualenv', 03:49:14 INFO - 'install', 03:49:14 INFO - 'run-tests'), 03:49:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:49:14 INFO - 'download_minidump_stackwalk': True, 03:49:14 INFO - 'download_symbols': 'ondemand', 03:49:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:49:14 INFO - 'tooltool.py': '/tools/tooltool.py', 03:49:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:49:14 INFO - '/tools/misc-python/virtualenv.py')}, 03:49:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:49:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:49:14 INFO - 'installer_path': 'installer.exe', 03:49:14 INFO - 'log_level': 'info', 03:49:14 INFO - 'log_name': 'talos', 03:49:14 INFO - 'log_to_console': True, 03:49:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:49:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:49:14 INFO - 'opt_config_files': (), 03:49:14 INFO - 'pip_index': False, 03:49:14 INFO - 'sps_profile': False, 03:49:14 INFO - 'sps_profile_interval': 0, 03:49:14 INFO - 'suite': 'dromaeojs-e10s', 03:49:14 INFO - 'system_bits': '32', 03:49:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:49:14 INFO - 'title': 'talos-linux64-ix-028', 03:49:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:49:14 INFO - 'use_talos_json': True, 03:49:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:49:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:49:14 INFO - 'work_dir': 'build'} 03:49:14 INFO - [mozharness: 2016-09-07 10:49:14.557460Z] Running clobber step. 03:49:14 INFO - Running pre-action listener: _resource_record_pre_action 03:49:14 INFO - Running main action method: clobber 03:49:14 INFO - rmtree: /builds/slave/test/build 03:49:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:49:15 INFO - Running post-action listener: _resource_record_post_action 03:49:15 INFO - [mozharness: 2016-09-07 10:49:15.527570Z] Finished clobber step (success) 03:49:15 INFO - [mozharness: 2016-09-07 10:49:15.527670Z] Running read-buildbot-config step. 03:49:15 INFO - Running pre-action listener: _resource_record_pre_action 03:49:15 INFO - Running main action method: read_buildbot_config 03:49:15 INFO - Using buildbot properties: 03:49:15 INFO - { 03:49:15 INFO - "project": "", 03:49:15 INFO - "product": "firefox", 03:49:15 INFO - "script_repo_revision": "production", 03:49:15 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:49:15 INFO - "repository": "", 03:49:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:49:15 INFO - "buildid": "20160907004009", 03:49:15 INFO - "stage_platform": "linux64-pgo", 03:49:15 INFO - "basedir": "/builds/slave/test", 03:49:15 INFO - "nightly_build": "True", 03:49:15 INFO - "buildnumber": 545, 03:49:15 INFO - "slavename": "talos-linux64-ix-028", 03:49:15 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:49:15 INFO - "platform": "ubuntu64_hw", 03:49:15 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:49:15 INFO - "branch": "mozilla-aurora", 03:49:15 INFO - "repo_path": "releases/mozilla-aurora", 03:49:15 INFO - "revision": "3a0fd1bb116a3b79b6f33462a04144818b550ee9", 03:49:15 INFO - "pgo_build": "True", 03:49:15 INFO - "builduid": "4e2b6e876f594fbe91551200ebdb17c0", 03:49:15 INFO - "slavebuilddir": "test" 03:49:15 INFO - } 03:49:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 03:49:15 INFO - Running post-action listener: _resource_record_post_action 03:49:15 INFO - [mozharness: 2016-09-07 10:49:15.530190Z] Finished read-buildbot-config step (success) 03:49:15 INFO - [mozharness: 2016-09-07 10:49:15.530279Z] Running download-and-extract step. 03:49:15 INFO - Running pre-action listener: _resource_record_pre_action 03:49:15 INFO - Running main action method: download_and_extract 03:49:15 INFO - mkdir: /builds/slave/test/build/tests 03:49: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')]} 03:49:15 INFO - https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:49:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:49:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:49:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:49:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:49:15 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:49:15 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:49:15 INFO - retry: Failed, sleeping 30 seconds before retrying 03:49:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #2 03:49:45 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:49:45 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:49:45 INFO - retry: Failed, sleeping 60 seconds before retrying 03:50:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #3 03:50:45 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:50:45 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:50:45 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json! 03:50:45 INFO - Caught exception: HTTP Error 404: Not Found 03:50:45 INFO - Caught exception: HTTP Error 404: Not Found 03:50:45 INFO - Caught exception: HTTP Error 404: Not Found 03:50:45 INFO - trying https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:50:45 INFO - Downloading https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:50:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:50:46 INFO - Downloaded 1361 bytes. 03:50:46 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:50:46 INFO - Using the following test package requirements: 03:50:46 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 03:50:46 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:50:46 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:50:46 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:50:46 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:50:46 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:50:46 INFO - u'jsshell-linux-x86_64.zip'], 03:50:46 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:50:46 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:50:46 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 03:50:46 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:50:46 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:50:46 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:50:46 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:50:46 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:50:46 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:50:46 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:50:46 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:50:46 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:50:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:46 INFO - https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:50:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:50:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:50:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:50:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:50:46 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:50:46 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:50:46 INFO - retry: Failed, sleeping 30 seconds before retrying 03:51:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 03:51:16 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:51:16 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:51:16 INFO - retry: Failed, sleeping 60 seconds before retrying 03:52:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 03:52:16 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:52:16 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:52:16 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 03:52:16 INFO - Caught exception: HTTP Error 404: Not Found 03:52:16 INFO - Caught exception: HTTP Error 404: Not Found 03:52:16 INFO - Caught exception: HTTP Error 404: Not Found 03:52:16 INFO - trying https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:52:16 INFO - Downloading https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:52:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:52:17 INFO - Downloaded 21768581 bytes. 03:52:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:52:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:52:18 INFO - Return code: 0 03:52:18 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:52:18 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')]} 03:52:18 INFO - https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:52:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:52:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:52:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:52:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:52:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:52:18 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:52:18 INFO - retry: Failed, sleeping 30 seconds before retrying 03:52:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 03:52:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:52:48 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:52:48 INFO - retry: Failed, sleeping 60 seconds before retrying 03:53:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 03:53:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:53:48 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:53:48 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 03:53:48 INFO - Caught exception: HTTP Error 404: Not Found 03:53:48 INFO - Caught exception: HTTP Error 404: Not Found 03:53:48 INFO - Caught exception: HTTP Error 404: Not Found 03:53:48 INFO - trying https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:53:48 INFO - Downloading https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:53:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:53:49 INFO - Downloaded 21768581 bytes. 03:53:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:53:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:53:50 INFO - Return code: 0 03:53:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:53:50 INFO - https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:53:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:53:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:53:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:53:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:53:50 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:53:50 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:53:50 INFO - retry: Failed, sleeping 30 seconds before retrying 03:54:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 03:54:20 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:54:20 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:54:20 INFO - retry: Failed, sleeping 60 seconds before retrying 03:55:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 03:55:20 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:55:20 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:55:20 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip! 03:55:20 INFO - Caught exception: HTTP Error 404: Not Found 03:55:20 INFO - Caught exception: HTTP Error 404: Not Found 03:55:20 INFO - Caught exception: HTTP Error 404: Not Found 03:55:20 INFO - trying https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:55:20 INFO - Downloading https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:55:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:55:21 INFO - Downloaded 14413740 bytes. 03:55:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:55:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:55:21 INFO - Return code: 0 03:55:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:55:21 INFO - https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:55:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:55:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:55:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:55:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:55:21 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:55:21 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:55:21 INFO - retry: Failed, sleeping 30 seconds before retrying 03:55:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #2 03:55:51 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:55:51 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:55:51 INFO - retry: Failed, sleeping 60 seconds before retrying 03:56:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #3 03:56:51 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:56:51 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:56:51 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2! 03:56:51 INFO - Caught exception: HTTP Error 404: Not Found 03:56:51 INFO - Caught exception: HTTP Error 404: Not Found 03:56:51 INFO - Caught exception: HTTP Error 404: Not Found 03:56:51 INFO - trying https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:56:51 INFO - Downloading https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:56:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:56:53 INFO - Downloaded 63871392 bytes. 03:56:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:56:53 INFO - mkdir: /builds/slave/test/properties 03:56:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:56:53 INFO - Writing to file /builds/slave/test/properties/build_url 03:56:53 INFO - Contents: 03:56:53 INFO - build_url:https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:56:53 INFO - Running post-action listener: _resource_record_post_action 03:56:53 INFO - Running post-action listener: set_extra_try_arguments 03:56:53 INFO - [mozharness: 2016-09-07 10:56:53.810347Z] Finished download-and-extract step (success) 03:56:53 INFO - [mozharness: 2016-09-07 10:56:53.810582Z] Running populate-webroot step. 03:56:53 INFO - Running pre-action listener: _resource_record_pre_action 03:56:53 INFO - Running main action method: populate_webroot 03:56:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:56:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:56:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:56:53 INFO - '--tppagecycles', 03:56:53 INFO - '7'], 03:56:53 INFO - 'tests': ['tsvgm']}}, 03:56:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:56:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:56:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:56:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:56:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:56:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:56:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:56:53 INFO - 'talos_options': ['--disable-e10s'], 03:56:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:56:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:56:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:56:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:56:53 INFO - 'talos_options': ['--disable-e10s'], 03:56:53 INFO - 'tests': ['damp', 'tps']}, 03:56:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:56:53 INFO - 'tests': ['damp', 'tps']}, 03:56:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:56:53 INFO - 'tests': ['dromaeo_dom']}, 03:56:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:56:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:56:53 INFO - 'tests': ['basic_compositor_video']}, 03:56:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:56:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:56:53 INFO - 'tests': ['a11yr', 03:56:53 INFO - 'ts_paint', 03:56:53 INFO - 'tpaint', 03:56:53 INFO - 'sessionrestore', 03:56:53 INFO - 'sessionrestore_no_auto_restore', 03:56:53 INFO - 'tabpaint']}, 03:56:53 INFO - 'other-e10s': {'tests': ['a11yr', 03:56:53 INFO - 'ts_paint', 03:56:53 INFO - 'tpaint', 03:56:53 INFO - 'sessionrestore', 03:56:53 INFO - 'sessionrestore_no_auto_restore', 03:56:53 INFO - 'tabpaint']}, 03:56:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:56:53 INFO - 'ts_paint', 03:56:53 INFO - 'tpaint', 03:56:53 INFO - 'sessionrestore', 03:56:53 INFO - 'sessionrestore_no_auto_restore', 03:56:53 INFO - 'tabpaint']}, 03:56:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:56:53 INFO - 'ts_paint', 03:56:53 INFO - 'tpaint', 03:56:53 INFO - 'sessionrestore', 03:56:53 INFO - 'sessionrestore_no_auto_restore', 03:56:53 INFO - 'tabpaint']}, 03:56:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:56:53 INFO - 'tests': ['a11yr', 03:56:53 INFO - 'ts_paint', 03:56:53 INFO - 'tpaint', 03:56:53 INFO - 'sessionrestore', 03:56:53 INFO - 'sessionrestore_no_auto_restore', 03:56:53 INFO - 'tabpaint']}, 03:56:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:56:53 INFO - 'tests': ['a11yr', 03:56:53 INFO - 'ts_paint', 03:56:53 INFO - 'tpaint', 03:56:53 INFO - 'sessionrestore', 03:56:53 INFO - 'sessionrestore_no_auto_restore', 03:56:53 INFO - 'tabpaint']}, 03:56:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:56:53 INFO - 'tests': ['tsvgx', 03:56:53 INFO - 'tsvgr_opacity', 03:56:53 INFO - 'tart', 03:56:53 INFO - 'tscrollx', 03:56:53 INFO - 'cart']}, 03:56:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:56:53 INFO - 'tsvgr_opacity', 03:56:53 INFO - 'tart', 03:56:53 INFO - 'tscrollx', 03:56:53 INFO - 'cart']}, 03:56:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:56:53 INFO - 'talos_options': ['--disable-e10s'], 03:56:53 INFO - 'tests': ['tp5o']}, 03:56:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:56:53 INFO - 'tests': ['tp5o']}, 03:56:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:56:53 INFO - 'talos_options': ['--disable-e10s', 03:56:53 INFO - '--xperf_path', 03:56:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:56:53 INFO - 'tests': ['tp5n']}, 03:56:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:56:53 INFO - 'talos_options': ['--xperf_path', 03:56:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:56:53 INFO - 'tests': ['tp5n']}}, 03:56:53 INFO - 'talos.zip': {'path': '', 03:56:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:56:53 INFO - Running post-action listener: _resource_record_post_action 03:56:53 INFO - [mozharness: 2016-09-07 10:56:53.827927Z] Finished populate-webroot step (success) 03:56:53 INFO - [mozharness: 2016-09-07 10:56:53.828015Z] Running create-virtualenv step. 03:56:53 INFO - Running pre-action listener: _resource_record_pre_action 03:56:53 INFO - Running main action method: create_virtualenv 03:56:53 INFO - Creating virtualenv /builds/slave/test/build/venv 03:56:53 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 03:56:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:56:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:56:53 INFO - Using real prefix '/usr' 03:56:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:56:54 INFO - Installing distribute.............................................................................................................................................................................................done. 03:56:56 INFO - Installing pip.................done. 03:56:56 INFO - Return code: 0 03:56:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:56:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:56 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 0x115b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1419570>, '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 0x141a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141a900>, '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': '836cfdc75598d54cb747368e000001a9-1473245343.304993-160625666', '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 03:56:56 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 03:56:56 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 03:56:56 INFO - Using env: {'DISPLAY': ':0', 03:56:56 INFO - 'HOME': '/home/cltbld', 03:56:56 INFO - 'LANG': 'en_US.UTF-8', 03:56:56 INFO - 'LANGUAGE': 'en_US:en', 03:56:56 INFO - 'LOGNAME': 'cltbld', 03:56:56 INFO - 'MAIL': '/var/mail/cltbld', 03:56:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:56 INFO - 'MOZ_NO_REMOTE': '1', 03:56:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:56 INFO - 'NO_EM_RESTART': '1', 03:56:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:56 INFO - 'PWD': '/builds/slave/test', 03:56:56 INFO - 'SHELL': '/bin/bash', 03:56:56 INFO - 'SHLVL': '1', 03:56:56 INFO - 'TERM': 'linux', 03:56:56 INFO - 'TMOUT': '86400', 03:56:56 INFO - 'USER': 'cltbld', 03:56:56 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1473245343.304993-160625666', 03:56:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:56 INFO - '_': '/tools/buildbot/bin/python'} 03:56:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:56 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 03:56:56 INFO - Cleaning up... 03:56:56 INFO - Return code: 0 03:56:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:56:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:56 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 0x115b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1419570>, '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 0x141a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141a900>, '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': '836cfdc75598d54cb747368e000001a9-1473245343.304993-160625666', '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 03:56:56 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 03:56:56 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 03:56:56 INFO - Using env: {'DISPLAY': ':0', 03:56:56 INFO - 'HOME': '/home/cltbld', 03:56:56 INFO - 'LANG': 'en_US.UTF-8', 03:56:56 INFO - 'LANGUAGE': 'en_US:en', 03:56:56 INFO - 'LOGNAME': 'cltbld', 03:56:56 INFO - 'MAIL': '/var/mail/cltbld', 03:56:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:56 INFO - 'MOZ_NO_REMOTE': '1', 03:56:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:56 INFO - 'NO_EM_RESTART': '1', 03:56:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:56 INFO - 'PWD': '/builds/slave/test', 03:56:56 INFO - 'SHELL': '/bin/bash', 03:56:56 INFO - 'SHLVL': '1', 03:56:56 INFO - 'TERM': 'linux', 03:56:56 INFO - 'TMOUT': '86400', 03:56:56 INFO - 'USER': 'cltbld', 03:56:56 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1473245343.304993-160625666', 03:56:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:56 INFO - '_': '/tools/buildbot/bin/python'} 03:56:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:56 INFO - Downloading/unpacking psutil>=3.1.1 03:56:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:56:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:56:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:56:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:56:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:56:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:56:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:56:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:56:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:56:58 INFO - Installing collected packages: psutil 03:56:58 INFO - Running setup.py install for psutil 03:56:58 INFO - building 'psutil._psutil_linux' extension 03:56:58 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 03:56:59 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 03:56:59 INFO - building 'psutil._psutil_posix' extension 03:56:59 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 03:56:59 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 03:56:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:56:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:56:59 INFO - Successfully installed psutil 03:56:59 INFO - Cleaning up... 03:56:59 INFO - Return code: 0 03:56:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:56:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:59 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 0x115b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1419570>, '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 0x141a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141a900>, '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': '836cfdc75598d54cb747368e000001a9-1473245343.304993-160625666', '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 03:56:59 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 03:56:59 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 03:56:59 INFO - Using env: {'DISPLAY': ':0', 03:56:59 INFO - 'HOME': '/home/cltbld', 03:56:59 INFO - 'LANG': 'en_US.UTF-8', 03:56:59 INFO - 'LANGUAGE': 'en_US:en', 03:56:59 INFO - 'LOGNAME': 'cltbld', 03:56:59 INFO - 'MAIL': '/var/mail/cltbld', 03:56:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:59 INFO - 'MOZ_NO_REMOTE': '1', 03:56:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:59 INFO - 'NO_EM_RESTART': '1', 03:56:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:59 INFO - 'PWD': '/builds/slave/test', 03:56:59 INFO - 'SHELL': '/bin/bash', 03:56:59 INFO - 'SHLVL': '1', 03:56:59 INFO - 'TERM': 'linux', 03:56:59 INFO - 'TMOUT': '86400', 03:56:59 INFO - 'USER': 'cltbld', 03:56:59 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1473245343.304993-160625666', 03:56:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:59 INFO - '_': '/tools/buildbot/bin/python'} 03:56:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:56:59 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 03:56:59 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 03:56:59 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 03:56:59 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 03:56:59 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 03:56:59 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 03:57:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:57:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:57:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:57:01 INFO - Installing collected packages: mozsystemmonitor 03:57:01 INFO - Running setup.py install for mozsystemmonitor 03:57:01 INFO - Successfully installed mozsystemmonitor 03:57:01 INFO - Cleaning up... 03:57:01 INFO - Return code: 0 03:57:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:57:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x115b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1419570>, '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 0x141a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141a900>, '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': '836cfdc75598d54cb747368e000001a9-1473245343.304993-160625666', '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 03:57:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:57:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:57:01 INFO - Using env: {'DISPLAY': ':0', 03:57:01 INFO - 'HOME': '/home/cltbld', 03:57:01 INFO - 'LANG': 'en_US.UTF-8', 03:57:01 INFO - 'LANGUAGE': 'en_US:en', 03:57:01 INFO - 'LOGNAME': 'cltbld', 03:57:01 INFO - 'MAIL': '/var/mail/cltbld', 03:57:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:01 INFO - 'MOZ_NO_REMOTE': '1', 03:57:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:01 INFO - 'NO_EM_RESTART': '1', 03:57:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:01 INFO - 'PWD': '/builds/slave/test', 03:57:01 INFO - 'SHELL': '/bin/bash', 03:57:01 INFO - 'SHLVL': '1', 03:57:01 INFO - 'TERM': 'linux', 03:57:01 INFO - 'TMOUT': '86400', 03:57:01 INFO - 'USER': 'cltbld', 03:57:01 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1473245343.304993-160625666', 03:57:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:01 INFO - '_': '/tools/buildbot/bin/python'} 03:57:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:01 INFO - Downloading/unpacking jsonschema==2.5.1 03:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:57:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:03 INFO - Downloading functools32-3.2.3-2.tar.gz 03:57:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:57:04 INFO - warning: no files found matching '*.txt' 03:57:04 INFO - no previously-included directories found matching 'build' 03:57:04 INFO - no previously-included directories found matching 'dist' 03:57:04 INFO - no previously-included directories found matching '.git*' 03:57:04 INFO - Installing collected packages: jsonschema, functools32 03:57:04 INFO - Running setup.py install for functools32 03:57:04 INFO - warning: no files found matching '*.txt' 03:57:04 INFO - no previously-included directories found matching 'build' 03:57:04 INFO - no previously-included directories found matching 'dist' 03:57:04 INFO - no previously-included directories found matching '.git*' 03:57:04 INFO - Successfully installed jsonschema functools32 03:57:04 INFO - Cleaning up... 03:57:04 INFO - Return code: 0 03:57:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:57: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')]} 03:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57: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')]} 03:57:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57: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', '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 0x115b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1419570>, '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 0x141a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141a900>, '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': '836cfdc75598d54cb747368e000001a9-1473245343.304993-160625666', '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 03:57: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:57: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 functools32==3.2.3-2 03:57:04 INFO - Using env: {'DISPLAY': ':0', 03:57:04 INFO - 'HOME': '/home/cltbld', 03:57:04 INFO - 'LANG': 'en_US.UTF-8', 03:57:04 INFO - 'LANGUAGE': 'en_US:en', 03:57:04 INFO - 'LOGNAME': 'cltbld', 03:57:04 INFO - 'MAIL': '/var/mail/cltbld', 03:57:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:04 INFO - 'MOZ_NO_REMOTE': '1', 03:57:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:04 INFO - 'NO_EM_RESTART': '1', 03:57:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:04 INFO - 'PWD': '/builds/slave/test', 03:57:04 INFO - 'SHELL': '/bin/bash', 03:57:04 INFO - 'SHLVL': '1', 03:57:04 INFO - 'TERM': 'linux', 03:57:04 INFO - 'TMOUT': '86400', 03:57:04 INFO - 'USER': 'cltbld', 03:57:04 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1473245343.304993-160625666', 03:57:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:04 INFO - '_': '/tools/buildbot/bin/python'} 03:57:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:57:04 INFO - Cleaning up... 03:57:04 INFO - Return code: 0 03:57:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:57: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')]} 03:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57: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')]} 03:57:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57: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', '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 0x115b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1419570>, '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 0x141a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141a900>, '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': '836cfdc75598d54cb747368e000001a9-1473245343.304993-160625666', '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 03:57: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:57: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 blobuploader==1.2.4 03:57:04 INFO - Using env: {'DISPLAY': ':0', 03:57:04 INFO - 'HOME': '/home/cltbld', 03:57:04 INFO - 'LANG': 'en_US.UTF-8', 03:57:04 INFO - 'LANGUAGE': 'en_US:en', 03:57:04 INFO - 'LOGNAME': 'cltbld', 03:57:04 INFO - 'MAIL': '/var/mail/cltbld', 03:57:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:04 INFO - 'MOZ_NO_REMOTE': '1', 03:57:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:04 INFO - 'NO_EM_RESTART': '1', 03:57:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:04 INFO - 'PWD': '/builds/slave/test', 03:57:04 INFO - 'SHELL': '/bin/bash', 03:57:04 INFO - 'SHLVL': '1', 03:57:04 INFO - 'TERM': 'linux', 03:57:04 INFO - 'TMOUT': '86400', 03:57:04 INFO - 'USER': 'cltbld', 03:57:04 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1473245343.304993-160625666', 03:57:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:04 INFO - '_': '/tools/buildbot/bin/python'} 03:57:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:04 INFO - Downloading/unpacking blobuploader==1.2.4 03:57: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 03:57: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 03:57: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 03:57: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 03:57: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 03:57: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 03:57:06 INFO - Downloading blobuploader-1.2.4.tar.gz 03:57:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:57:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:57:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:07 INFO - Downloading docopt-0.6.1.tar.gz 03:57:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:57:07 INFO - Installing collected packages: blobuploader, requests, docopt 03:57:07 INFO - Running setup.py install for blobuploader 03:57:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:57:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:57:07 INFO - Running setup.py install for requests 03:57:07 INFO - Running setup.py install for docopt 03:57:07 INFO - Successfully installed blobuploader requests docopt 03:57:07 INFO - Cleaning up... 03:57:07 INFO - Return code: 0 03:57:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:57: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')]} 03:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57: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')]} 03:57:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:07 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 0x115b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1419570>, '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 0x141a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141a900>, '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': '836cfdc75598d54cb747368e000001a9-1473245343.304993-160625666', '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 03:57:07 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 03:57:07 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 03:57:07 INFO - Using env: {'DISPLAY': ':0', 03:57:07 INFO - 'HOME': '/home/cltbld', 03:57:07 INFO - 'LANG': 'en_US.UTF-8', 03:57:07 INFO - 'LANGUAGE': 'en_US:en', 03:57:07 INFO - 'LOGNAME': 'cltbld', 03:57:07 INFO - 'MAIL': '/var/mail/cltbld', 03:57:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:07 INFO - 'MOZ_NO_REMOTE': '1', 03:57:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:07 INFO - 'NO_EM_RESTART': '1', 03:57:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:07 INFO - 'PWD': '/builds/slave/test', 03:57:07 INFO - 'SHELL': '/bin/bash', 03:57:07 INFO - 'SHLVL': '1', 03:57:07 INFO - 'TERM': 'linux', 03:57:07 INFO - 'TMOUT': '86400', 03:57:07 INFO - 'USER': 'cltbld', 03:57:07 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1473245343.304993-160625666', 03:57:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:07 INFO - '_': '/tools/buildbot/bin/python'} 03:57:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:57:08 INFO - Running setup.py (path:/tmp/pip-m6hoch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:57:08 INFO - Running setup.py (path:/tmp/pip-JsCTX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:57:08 INFO - Running setup.py (path:/tmp/pip-nu6va8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:57:08 INFO - Running setup.py (path:/tmp/pip-BfubTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:57:08 INFO - Running setup.py (path:/tmp/pip-v_Lr5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:57:08 INFO - Running setup.py (path:/tmp/pip-IcjaKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:57:08 INFO - Running setup.py (path:/tmp/pip-xp1iFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:57:08 INFO - Running setup.py (path:/tmp/pip-ww9x4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:57:08 INFO - Running setup.py (path:/tmp/pip-2JqBt7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:57:08 INFO - Running setup.py (path:/tmp/pip-hHoTt3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:57:08 INFO - Running setup.py (path:/tmp/pip-kL8oKY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:57:08 INFO - Running setup.py (path:/tmp/pip-ghtDFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:57:08 INFO - Running setup.py (path:/tmp/pip-KLo3zS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:57:09 INFO - Running setup.py (path:/tmp/pip-6xgz3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:57:09 INFO - Running setup.py (path:/tmp/pip-vSAKk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:57:09 INFO - Running setup.py (path:/tmp/pip-oDksO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:57:09 INFO - Running setup.py (path:/tmp/pip-N4_FO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:57:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:57:09 INFO - Running setup.py install for manifestparser 03:57:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:57:09 INFO - Running setup.py install for mozcrash 03:57:09 INFO - Running setup.py install for mozdebug 03:57:09 INFO - Running setup.py install for mozdevice 03:57:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:57:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:57:09 INFO - Running setup.py install for mozfile 03:57:09 INFO - Running setup.py install for mozhttpd 03:57:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:57:09 INFO - Running setup.py install for mozinfo 03:57:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:57:10 INFO - Running setup.py install for mozInstall 03:57:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:57:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:57:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:57:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:57:10 INFO - Running setup.py install for mozleak 03:57:10 INFO - Running setup.py install for mozlog 03:57:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:57:10 INFO - Running setup.py install for moznetwork 03:57:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:57:10 INFO - Running setup.py install for mozprocess 03:57:10 INFO - Running setup.py install for mozprofile 03:57:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:57:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:57:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:57:10 INFO - Running setup.py install for mozrunner 03:57:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:57:10 INFO - Running setup.py install for mozscreenshot 03:57:10 INFO - Running setup.py install for moztest 03:57:11 INFO - Running setup.py install for mozversion 03:57:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:57:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:57:11 INFO - Cleaning up... 03:57:11 INFO - Return code: 0 03:57:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:57:11 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')]} 03:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:11 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')]} 03:57:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:11 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 0x115b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1419570>, '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 0x141a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141a900>, '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': '836cfdc75598d54cb747368e000001a9-1473245343.304993-160625666', '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 03:57:11 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 03:57:11 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 03:57:11 INFO - Using env: {'DISPLAY': ':0', 03:57:11 INFO - 'HOME': '/home/cltbld', 03:57:11 INFO - 'LANG': 'en_US.UTF-8', 03:57:11 INFO - 'LANGUAGE': 'en_US:en', 03:57:11 INFO - 'LOGNAME': 'cltbld', 03:57:11 INFO - 'MAIL': '/var/mail/cltbld', 03:57:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:11 INFO - 'MOZ_NO_REMOTE': '1', 03:57:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:11 INFO - 'NO_EM_RESTART': '1', 03:57:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:11 INFO - 'PWD': '/builds/slave/test', 03:57:11 INFO - 'SHELL': '/bin/bash', 03:57:11 INFO - 'SHLVL': '1', 03:57:11 INFO - 'TERM': 'linux', 03:57:11 INFO - 'TMOUT': '86400', 03:57:11 INFO - 'USER': 'cltbld', 03:57:11 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1473245343.304993-160625666', 03:57:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:11 INFO - '_': '/tools/buildbot/bin/python'} 03:57:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:57:11 INFO - Running setup.py (path:/tmp/pip-JLAk5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:57:11 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)) 03:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:57:11 INFO - Running setup.py (path:/tmp/pip-Oe42sW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:57:11 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)) 03:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:57:11 INFO - Running setup.py (path:/tmp/pip-SEnL6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:57:11 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)) 03:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:57:11 INFO - Running setup.py (path:/tmp/pip-z2a3od-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:57:11 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)) 03:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:57:11 INFO - Running setup.py (path:/tmp/pip-CVyGcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:57:11 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)) 03:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:57:11 INFO - Running setup.py (path:/tmp/pip-fFtvvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:57:11 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)) 03:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:57:11 INFO - Running setup.py (path:/tmp/pip-dhSp7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:57:11 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)) 03:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:57:11 INFO - Running setup.py (path:/tmp/pip-hz3r4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:57:11 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)) 03:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:57:11 INFO - Running setup.py (path:/tmp/pip-fZbsQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:57:11 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)) 03:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:57:12 INFO - Running setup.py (path:/tmp/pip-vkX05D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:57:12 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)) 03:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:57:12 INFO - Running setup.py (path:/tmp/pip-AoeaUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:57:12 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)) 03:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:57:12 INFO - Running setup.py (path:/tmp/pip-9U2Ef3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:57:12 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)) 03:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:57:12 INFO - Running setup.py (path:/tmp/pip-oJghSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:57:12 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)) 03:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:57:12 INFO - Running setup.py (path:/tmp/pip-nC6NPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:57:12 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)) 03:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:57:12 INFO - Running setup.py (path:/tmp/pip-vqmhTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:57:12 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)) 03:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:57:12 INFO - Running setup.py (path:/tmp/pip-cRlnvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:57:12 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)) 03:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:57:12 INFO - Running setup.py (path:/tmp/pip-pnl7t9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:57:12 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)) 03:57:12 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)) 03:57:12 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)) 03:57:12 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)) 03:57:12 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)) 03:57:12 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)) 03:57:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:57: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 03:57: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 03:57: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 03:57: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 03:57: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 03:57: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 03:57:14 INFO - Downloading blessings-1.6.tar.gz 03:57:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:57:14 INFO - Installing collected packages: blessings 03:57:14 INFO - Running setup.py install for blessings 03:57:14 INFO - Successfully installed blessings 03:57:14 INFO - Cleaning up... 03:57:14 INFO - Return code: 0 03:57:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:57:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:57:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:57:14 INFO - Reading from file tmpfile_stdout 03:57:14 INFO - Current package versions: 03:57:14 INFO - argparse == 1.2.1 03:57:14 INFO - blessings == 1.6 03:57:14 INFO - blobuploader == 1.2.4 03:57:14 INFO - docopt == 0.6.1 03:57:14 INFO - functools32 == 3.2.3-2 03:57:14 INFO - jsonschema == 2.5.1 03:57:14 INFO - manifestparser == 1.1 03:57:14 INFO - mozInstall == 1.12 03:57:14 INFO - mozcrash == 0.17 03:57:14 INFO - mozdebug == 0.1 03:57:14 INFO - mozdevice == 0.48 03:57:14 INFO - mozfile == 1.2 03:57:14 INFO - mozhttpd == 0.7 03:57:14 INFO - mozinfo == 0.9 03:57:14 INFO - mozleak == 0.1 03:57:14 INFO - mozlog == 3.3 03:57:14 INFO - moznetwork == 0.27 03:57:14 INFO - mozprocess == 0.23 03:57:14 INFO - mozprofile == 0.28 03:57:14 INFO - mozrunner == 6.12 03:57:14 INFO - mozscreenshot == 0.1 03:57:14 INFO - mozsystemmonitor == 0.3 03:57:14 INFO - moztest == 0.7 03:57:14 INFO - mozversion == 1.4 03:57:14 INFO - psutil == 3.1.1 03:57:14 INFO - requests == 1.2.3 03:57:14 INFO - wsgiref == 0.1.2 03:57:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:57:14 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')]} 03:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:14 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')]} 03:57:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:14 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 0x115b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1419570>, '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 0x141a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141a900>, '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': '836cfdc75598d54cb747368e000001a9-1473245343.304993-160625666', '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 03:57:14 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 03:57:14 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 03:57:14 INFO - Using env: {'DISPLAY': ':0', 03:57:14 INFO - 'HOME': '/home/cltbld', 03:57:14 INFO - 'LANG': 'en_US.UTF-8', 03:57:14 INFO - 'LANGUAGE': 'en_US:en', 03:57:14 INFO - 'LOGNAME': 'cltbld', 03:57:14 INFO - 'MAIL': '/var/mail/cltbld', 03:57:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:14 INFO - 'MOZ_NO_REMOTE': '1', 03:57:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:14 INFO - 'NO_EM_RESTART': '1', 03:57:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:14 INFO - 'PWD': '/builds/slave/test', 03:57:14 INFO - 'SHELL': '/bin/bash', 03:57:14 INFO - 'SHLVL': '1', 03:57:14 INFO - 'TERM': 'linux', 03:57:14 INFO - 'TMOUT': '86400', 03:57:14 INFO - 'USER': 'cltbld', 03:57:14 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1473245343.304993-160625666', 03:57:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:14 INFO - '_': '/tools/buildbot/bin/python'} 03:57:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:15 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)) 03:57:15 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)) 03:57:15 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)) 03:57:15 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)) 03:57:15 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)) 03:57:15 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)) 03:57:15 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)) 03:57:15 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)) 03:57:15 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)) 03:57:15 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)) 03:57:15 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)) 03:57:15 INFO - Cleaning up... 03:57:15 INFO - Return code: 0 03:57:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:57: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')]} 03:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57: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')]} 03:57:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:15 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 0x115b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1419570>, '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 0x141a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141a900>, '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': '836cfdc75598d54cb747368e000001a9-1473245343.304993-160625666', '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 03:57:15 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 03:57:15 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 03:57:15 INFO - Using env: {'DISPLAY': ':0', 03:57:15 INFO - 'HOME': '/home/cltbld', 03:57:15 INFO - 'LANG': 'en_US.UTF-8', 03:57:15 INFO - 'LANGUAGE': 'en_US:en', 03:57:15 INFO - 'LOGNAME': 'cltbld', 03:57:15 INFO - 'MAIL': '/var/mail/cltbld', 03:57:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:15 INFO - 'MOZ_NO_REMOTE': '1', 03:57:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:15 INFO - 'NO_EM_RESTART': '1', 03:57:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:15 INFO - 'PWD': '/builds/slave/test', 03:57:15 INFO - 'SHELL': '/bin/bash', 03:57:15 INFO - 'SHLVL': '1', 03:57:15 INFO - 'TERM': 'linux', 03:57:15 INFO - 'TMOUT': '86400', 03:57:15 INFO - 'USER': 'cltbld', 03:57:15 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1473245343.304993-160625666', 03:57:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:15 INFO - '_': '/tools/buildbot/bin/python'} 03:57:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:57:15 INFO - Cleaning up... 03:57:15 INFO - Return code: 0 03:57:15 INFO - Running post-action listener: _resource_record_post_action 03:57:15 INFO - Running post-action listener: _start_resource_monitoring 03:57:15 INFO - Starting resource monitoring. 03:57:15 INFO - [mozharness: 2016-09-07 10:57:15.431880Z] Finished create-virtualenv step (success) 03:57:15 INFO - [mozharness: 2016-09-07 10:57:15.432316Z] Running install step. 03:57:15 INFO - Running pre-action listener: _resource_record_pre_action 03:57:15 INFO - Running main action method: install 03:57:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:57:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:57:15 INFO - Reading from file tmpfile_stdout 03:57:15 INFO - Detecting whether we're running mozinstall >=1.0... 03:57:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:57:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:57:15 INFO - Reading from file tmpfile_stdout 03:57:15 INFO - Output received: 03:57:15 INFO - Usage: mozinstall [options] installer 03:57:15 INFO - Options: 03:57:15 INFO - -h, --help show this help message and exit 03:57:15 INFO - -d DEST, --destination=DEST 03:57:15 INFO - Directory to install application into. [default: 03:57:15 INFO - "/builds/slave/test"] 03:57:15 INFO - --app=APP Application being installed. [default: firefox] 03:57:15 INFO - mkdir: /builds/slave/test/build/application 03:57:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:57:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:57:32 INFO - Reading from file tmpfile_stdout 03:57:32 INFO - Output received: 03:57:32 INFO - /builds/slave/test/build/application/firefox/firefox 03:57:32 INFO - Running post-action listener: _resource_record_post_action 03:57:32 INFO - [mozharness: 2016-09-07 10:57:32.613945Z] Finished install step (success) 03:57:32 INFO - [mozharness: 2016-09-07 10:57:32.614222Z] Running run-tests step. 03:57:32 INFO - Running pre-action listener: _resource_record_pre_action 03:57:32 INFO - Running main action method: run_tests 03:57:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:57:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:57:32 INFO - Python 2.7.3 03:57:32 INFO - Return code: 0 03:57:32 INFO - grabbing minidump binary from tooltool 03:57:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:32 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 0x1419570>, '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 0x141a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141a900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:57:32 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 03:57:32 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 03:57:32 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 03:57:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:57:32 INFO - Return code: 0 03:57:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:57:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:57:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:57:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:57:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:57:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 03:57:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --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 03:57:32 INFO - Using env: {'DISPLAY': ':0', 03:57:32 INFO - 'HOME': '/home/cltbld', 03:57:32 INFO - 'LANG': 'en_US.UTF-8', 03:57:32 INFO - 'LANGUAGE': 'en_US:en', 03:57:32 INFO - 'LOGNAME': 'cltbld', 03:57:32 INFO - 'MAIL': '/var/mail/cltbld', 03:57:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:57:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:57:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:32 INFO - 'MOZ_NO_REMOTE': '1', 03:57:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:57:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:32 INFO - 'NO_EM_RESTART': '1', 03:57:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:32 INFO - 'PWD': '/builds/slave/test', 03:57:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:57:32 INFO - 'SHELL': '/bin/bash', 03:57:32 INFO - 'SHLVL': '1', 03:57:32 INFO - 'TERM': 'linux', 03:57:32 INFO - 'TMOUT': '86400', 03:57:32 INFO - 'USER': 'cltbld', 03:57:32 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1473245343.304993-160625666', 03:57:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:32 INFO - '_': '/tools/buildbot/bin/python'} 03:57:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 03:57:32 INFO - mozversion application_buildid: 20160907004009 03:57:32 INFO - mozversion application_changeset: 3a0fd1bb116a3b79b6f33462a04144818b550ee9 03:57:32 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:57:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:57:32 INFO - mozversion application_name: Firefox 03:57:32 INFO - mozversion application_remotingname: firefox-dev 03:57:32 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:57:32 INFO - mozversion application_vendor: Mozilla 03:57:32 INFO - mozversion application_version: 50.0a2 03:57:32 INFO - mozversion platform_buildid: 20160907004009 03:57:32 INFO - mozversion platform_changeset: 3a0fd1bb116a3b79b6f33462a04144818b550ee9 03:57:32 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:57:32 INFO - mozversion platform_version: 50.0a2 03:57:32 INFO - using testdate: 1473245852 03:57:32 INFO - actual date: 1473245852 03:57:32 INFO - starting webserver on 'localhost:39551' 03:57:32 INFO - SUITE-START | Running 2 tests 03:57:32 INFO - TEST-START | dromaeo_css 03:57:32 INFO - operating with platform_type : linux_ 03:57:32 INFO - Initialising browser for dromaeo_css test... 03:57:32 INFO - TEST-INFO | started process 8112 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoekthl/profile http://localhost:39551/getInfo.html) 03:57:37 INFO - PROCESS | 8112 | __metrics Screen width/height:1600/1200 03:57:37 INFO - PROCESS | 8112 | colorDepth:24 03:57:37 INFO - PROCESS | 8112 | Browser inner width/height: 1024/697 03:57:37 INFO - PROCESS | 8112 | __metrics 03:57:38 ERROR - PROCESS | 8112 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 03:57:39 INFO - TEST-INFO | 8112: exit 0 03:57:39 INFO - Browser initialized. 03:57:39 INFO - Running cycle 1/1 for dromaeo_css test... 03:57:39 INFO - TEST-INFO | started process 8236 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoekthl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:57:50 INFO - PROCESS | 8236 | RSS: Main: 152801280 03:57:50 INFO - PROCESS | 8236 | 03:58:40 INFO - PROCESS | 8236 | 1473245920506 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:00:48 INFO - PROCESS | 8236 | Cycle 1(1): loaded http://localhost:39551/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39551/tests/dromaeo/cssquery-ext.html) 04:00:50 INFO - PROCESS | 8236 | RSS: Main: 157876224 04:00:50 INFO - PROCESS | 8236 | 04:03:52 INFO - PROCESS | 8236 | Cycle 1(1): loaded http://localhost:39551/tests/dromaeo/cssquery-ext.html (next: http://localhost:39551/tests/dromaeo/cssquery-jquery.html) 04:03:52 INFO - PROCESS | 8236 | RSS: Main: 154423296 04:03:52 INFO - PROCESS | 8236 | 04:06:54 INFO - PROCESS | 8236 | Cycle 1(1): loaded http://localhost:39551/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39551/tests/dromaeo/cssquery-mootools.html) 04:06:55 INFO - PROCESS | 8236 | RSS: Main: 154398720 04:06:55 INFO - PROCESS | 8236 | 04:09:56 INFO - PROCESS | 8236 | Cycle 1(1): loaded http://localhost:39551/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39551/tests/dromaeo/cssquery-prototype.html) 04:09:57 INFO - PROCESS | 8236 | RSS: Main: 153243648 04:09:57 INFO - PROCESS | 8236 | 04:12:59 INFO - PROCESS | 8236 | Cycle 1(1): loaded http://localhost:39551/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39551/tests/dromaeo/cssquery-yui.html) 04:13:00 INFO - PROCESS | 8236 | RSS: Main: 155574272 04:13:00 INFO - PROCESS | 8236 | 04:16:02 INFO - PROCESS | 8236 | Cycle 1(1): loaded http://localhost:39551/tests/dromaeo/cssquery-yui.html (next: http://localhost:39551/tests/dromaeo/cssquery-dojo.html) 04:16:03 INFO - PROCESS | 8236 | RSS: Main: 155385856 04:16:03 INFO - PROCESS | 8236 | 04:16:03 INFO - PROCESS | 8236 | __start_tp_report 04:16:03 INFO - PROCESS | 8236 | _x_x_mozilla_page_load 04:16:03 INFO - PROCESS | 8236 | _x_x_mozilla_page_load_details 04:16:03 INFO - PROCESS | 8236 | |i|pagename|runs| 04:16:03 INFO - PROCESS | 8236 | |0;dojo.html;3259.983700081499;3285.080177550285;3299.5875515560556;3301.29022260214;3310.619278782941;5662.915056274154;5678.801241956532;5684.175794509799;5702.686352250625;5712.628679135853;5639.295088113986;5655.442302508767;5664.40523745006;5689.089745640698;5708.942910570893;5168.664036837612;5187.273781670569;5195.220716892459;5239.607029472805;5241.764120614563;4996.125678006352;5010.448850626428;5186.766595503212;5203.531682148606;5282.498162674539;5129.974350128244;5145.794168233266;5146.562542183919;5151.922721159186;5214.530692237698;5239.502247286502;5239.580833533346;5240.3973543042275;5245.160774276116;5274.630775845692;5043.747812609355;5069;5088.287639730441;5146.536811686929;5146.588272938194;5613.775448982035;5637;5666.150077488369;5720.399358067385;5744.281964754406;6045.486133678599;6069.2110025696375;6083.513318934519;6099.969500152471;6130.846728831771;5883.205767221413;6131.662758548278;6131.68252131274;6184.412480814315;6189.288231853349;5813.302403711539;5817.796377126865;5826.329972053226;5828.154917536934;5864.354920958691;6328.145700330489;6343.619382837044;6344.904826427607;6350.809475715736;6354.459870911024;5744.913826292609;5933.317668468095;5960.403959604005;6068.271807383054;6095.817125486243;6066.120412540157;6107.059952181356;6122.571420000557;6140;6143.723532441051;6061.3029501607;6086.239220097488;6092.421219984094;6093.878122437615;6113.113598528189;5864.67744274069;6033.276006879202;6046.546509011841;6053.4854537363935;6084.604500707528;4695.7886895089805;4696.319033740088;4706.835260765857;4713.481517033124;4733.597644200281;4180.937285940713;4184.351425529047;4191.077962848169;4204.222218889515;4211.115665710174;5732.168835518826;5801.3328467225965;5890.764369425175;5967.254093238345;5982.4316689914385;6191.25704915413;6207.131001659771;6219.440250377488;6220.937790622036;6222.315545290015;5974.790882319098;5976.133460648181;5978.641281523122;6009.939900601025;6012.759489620366;5130.281760553526;5262.894742105136;5320.361556613154;5343.732813359316;5374.946250537523;6361.61830290184;6384.52116091295;6398.648074355955;6409.487241020801;6415.67921603918;6105.358937311518;6126.877462450726;6132;6138.140660307471;6145.600535965327;6114.6636934969;6341.4292713656;6345.1434056401795;6396.999999999814;6402.839929001812;6140.596275277906;6179.3202747698615;6179.969100154471;6180.938190618036;6193.84515387119;6290.0879372491645;6291.559590828781;6291.653959032297;6303.558750887577;6304.968475157778;5811.593188476766;5954.940450595612;5965.194698715618;5990.430909063632;6131.570790044832;5993.700314984146;5997.880042399215;6020.30766461845;6030.246219222598;6056.545759068;5937.732802023833;5942.821715348547;5968.940310596839;5978.043513037893;6006.339302676614;5792.797252096157;5978.701064946822;6000.189974353407;6020.397960203944;6048.092786082123;5924.052151655715;5944.286685597756;5945.048792193228;5959.135925290722;5969.224000880032 04:16:03 INFO - PROCESS | 8236 | |1;ext.html;578.1587789765891;649.2403887451682;651.5308977536172;657.6382989355853;664.8337915521116;42253;46971;46997;47198.292025619645;47306.2904056439;45880.3117953231;46439;46485;46608.067838643205;46642;9089.545522723854;9149.085091490831;9221.40060896043;9221.907780922173;9244.260459163252;9108.72673819783;9208.26333893287;9221.216196623294;9226.446413215228;9267.95366023169;9277.118673725985;9291.674791382304;9294.907050929505;9301.395409298408;9326.673566425177;9158.86261706075;9167.908320916838;9214.170724634749;9226.538673066354;9240.815183696322;9102.590383432695;9122.361434699573;9162.541872906328;9181.678641247525;9199.080091990814;43630.78184609057;43641;44100.3384949226;44110.55889441129;44293.778531107135;3441.776284541497;3729.310077635646;3879.1465877506903;4381.583749543788;4561.201789686792;32328.83835580807;35038;35638;36023.63976360229;36271.27457450863;4525.633002552874;4565.383673204108;4625.259958406672;4711.95288047122;4748.311494833264;360320;361545;361746;362275;362433;64961.35038649647;65262;65365;65410.345896541374;65495.345046549875;41401.1719765603;41566.584334156876;41910;42099.7895010523;42358.36462453066;19418.12618432174;19774;19813.900930495256;19837.504062398268;19898.104585293695;14807.555773326818;15065.472708455152;15140.091594504365;15145.167015814235;15172.848271517365;20282.797172028386;20559.38321850347;20691.896540517202;20792.58414831695;20795.896020519802;7381.335679788737;7457.7389791357045;7557.659905304275;7633.770986870402;7707.267809558083;1005.939643621385;1156.2657712352548;1159.8724140344555;1187.1037366788191;1194.9940250298694;33092.83453582717;33756.32487350288;33797;34579.308413832085;34850.128746781535;1166.7258194324327;1176.9352685602373;1185.300672603151;1224.6938265433641;1271.0149634033698;16901.23944422504;16986.915065424593;17070;17911.462656120337;17943.910280448516;550927;556593;562272;562272;562295;43362.34956475655;43470;43648.3452748209;43774.7811260948;43876.341854872204;1487.0557196180287;1514.4699355225582;1516.2115699836024;1532.0501289200768;1562.5000000000118;32609.510857337635;33545.83227083849;33619.327613448084;33881;34136.31727365489;56966;58640;60243.39756602553;60325;66241;518291;520087;523096;524654;524910;47402.76298618485;47666.28500572425;48501;48846.26730599115;48914.26628600645;51761.68289707738;52140.47859521508;52343.73828130835;52502;53181;44488.33267500925;44993.32510012287;45624.08751824879;45933;46173.53826461827;45370.319445207686;45496.77251613853;45626;45771.542284576724;46000;37575.81212094031;44117.55882441263;44521.55478445304;45253.321200181366;45795.77102114468;38026.42960355652;38860.805695971336;39310.60689393069;39849.80075099606;39878;29906.700932990392;29990.850045750503;30221.848890755406;30279;30704 04:16:03 INFO - PROCESS | 8236 | |2;jquery.html;408.11439176985937;416.69581205719845;420.52690722936694;434.2032370599949;442.02974471036066;18729.34447294345;19677.21291148354;20341.49146271344;20418.08118634663;20501.282455114073;16270;17008.914955425236;19705.507362315948;19738.802611973875;19883.005849707493;5688.317401911776;5776.075827867542;5983.6409815411;6002.2197114375285;6033.09503574463;5761.884762304751;5775.682337471438;5869.060950247961;5870.471657550819;5870.911936320958;5722.656640601556;5724.39893811148;5838.970805145968;5860.062390017598;5866.384029676865;5666.320041594994;5838.824835254949;5864.882702345951;5868.589198756089;5873.060310350324;5768.42315768424;5773.220615216934;5796.2464879565805;5801.274840644919;5827.533797296206;13889.861101389059;14468.276586170754;14482.855171448256;14501.70996580073;17176;2281.3156053184143;2503.949921001588;2711.783057355407;2852.044565070683;3065.6321241450946;10712.46437678113;10723.62467313648;10891.891081089167;10932.836007459895;10983.340999539972;1993.2326054468988;2018.3743039657606;2032.4918770307422;2051.0872661665417;2095.748510178773;58459.70770146122;74582.62708686422;77668;79272.60363698202;83726;11105.500252488657;11111.944440277746;11365.715857103472;11832.940835295769;11955.820662690066;16280.75578866318;16548.75176872324;16627.334906603843;16981.235844387033;17059.829401705825;8764.561771911507;8957.820843583091;8976.326775491863;9188.40275382098;9342.112499312554;8756.649734010569;8882.134751702086;8885.911140888638;8913.420627659181;9305.162535371848;4700.459447163552;4758.762061896891;4782.904341913142;4789.664723469394;4880.219164933665;1945.2121890634317;1955.3742802303127;2022.029425875588;2025.4025062606565;2073.9481512962298;919.1589695428742;984.9064338887795;1045.4563626913962;1057.460695045517;1059.4014381874217;19364;19447.22211111568;19836.10737516815;20125;20155.899220504096;1034.1261633919326;1037.6679462571904;1044.498640652491;1060.226034994443;1084.2789544952675;10538.841917371246;11051.72370690739;11056.778864422666;11096.389698566656;11130.721731956604;528543;528776;533569;556826;560058;91243;95785.52107239419;97252;98448;98994.5050274744;1030.1038096855784;1041.375174895057;1090.0625462102585;1098.747288123736;1114.9665510034713;16953.576160596083;17364.1070958708;17561.56096097608;17615.735763963294;17918.193681284112;41590.77200695874;42812;42951.35572966345;42959.355609666505;44174.11651767011;59862;60512.394876050676;62287;62644.37355626568;63443.365566345594;8674.522901240493;8848.867266990872;9158.084191581054;9166.724998250063;9248.21390181842;12055.21641093326;13484.932575337061;13757.724845503235;14067.296635168404;14208.644783880072;11812.881871181178;12121.939390302992;12150.149489535648;12300.323482208565;12316.938415307866;11835.28988260707;11938.22401543897;12084.939575302067;12289.815652765394;12538;11569.074474042225;11596.072314214674;11818.290902545874;12017.278963262232;12239.571614993432;7978.4813987092975;8264.752057438287;8324.0427350853;8350;9002.819943601222;9212.723618291462;11806.055515558563;12162.695932601755;12307.69230769238;12355.876441235472 04:16:03 INFO - PROCESS | 8236 | |3;mootools.html;1531.8085239345082;1563.8592526672596;1715.759793628892;1805.6930321845277;1838.2003828334666;8254.711085112021;9182.40314379565;9245.722628321144;9835.065668761474;9859.852102218463;9288.628454861815;9512.429254244751;9549.856752148724;9570.090841370076;9574.186194173486;2310.849794763343;2360.1621424394352;2362.645603159531;2362.8936697848553;2365.1012615206196;2505.6116301973225;2526.873656317186;2570.485902819434;2571.562834318161;2573.9485210295784;2500.6999160100722;2501.737317581655;2505.0856437400307;2506.8495890246554;2518.6851643544555;2445.3397582652674;2450.2281781238853;2452.901883924641;2467.2968204061845;2474.2329877737957;2415.45652228249;2415.806735461159;2423.0307876849224;2423.7091549014053;2467.383154211447;9585.616575336979;9612.18296444803;9637.90362096377;9642.228621710246;9643.951780241125;5566.66600003997;5610.579206559524;5694.572907031948;5695.572832037572;5723.885522289573;3415.0704851758924;3497.7901325920525;3513.7189024878203;3560.590532088791;3609.8917032488803;1193.9761204775855;1229.692576855786;1237.6534570320325;1239.0830785218964;1271.8918891894107;13369.398377072957;13386.330683465787;13387.799183012165;13396.799048014287;13453.932730336384;4662.126509618619;4818.831340903052;4836.322914791932;4919.852404427873;4963.007398520311;11231.494582743797;11261.887381126084;11274.774504510027;11303.547858085749;11412.771744565229;5697.515711164598;5702.201691763156;5704.4295570443455;5758;5763.971180144073;4389.714668546534;5103;5191.844244672666;5217.895642087137;5295.841124766263;4156.314208155681;4202.2646036943415;4277.721948073366;4296.484421869333;4344;1294.288141522178;1295.88343020941;1304.3804193008245;1309.0378571749757;1320.2474589483902;921.6912334367928;1062.2882668612049;1070.5289672544056;1073.849661047454;1092.983605245922;6247.125402443661;6490.578112422678;6498.675066246668;6524.412802847766;6524.445422139076;442.8759947214785;447.6620151785381;448.78827166650177;454.2096751652102;459.4463671276104;4284.635805956528;4340.891477713082;4370.7159034662645;4411.2721400968485;4420;11708.941455292668;11854.644360669194;11980;11993.940030299793;11995.580154694544;11918.284902905853;11948.402579870972;11956.342401167845;11956.641300760992;11981.400929953641;8484.109168537338;8756.824863502694;8848.247898928534;8856.335774816915;9005.729828105168;6510.934890651222;6518.57629254097;6659.367360100783;6706.295838936841;6791.966040169767;10995.285306455055;11019.228653994143;11034.448277585929;11042.116630669689;11136.610218642309;10598.364098154136;10721.195910306915;10822.51298691545;10872.293300935415;10957.945210273898;6722.159730033746;8163.7142700005215;8373.413861029669;8386.11945745688;8560;9390.483523406005;9398.2951278653;9419.811603768023;9470.763230919281;9497.905020949702;8470.237678608955;8528.317734581342;8575.571221439028;8639.308855291687;8734.65061397537;8384.782328632757;8425.410221284696;8426.157384261525;8457.196566326189;8499.150084991452;7371.815704607213;7392.519486233377;7408.62956852166;7416.703331866881;7452.06849143857;5539.25220095282;5589.189567512769;5675.035244008611;5721.1990321354215;5792.478676919098;5509.917351239655;5575.080111781511;5650.0677388232125;5781.277340332458;5853.736581853912 04:16:03 INFO - PROCESS | 8236 | |4;prototype.html;351.6202501298597;351.7414700195356;352.3463974327622;353.73823370705685;360.5979333043657;5822.767089316433;5862.941370586293;5872.73572689229;5877.3241077276125;5936.417658318629;5678.858028549288;5723.942760572393;5737.770489180428;5743.164028396541;5783.884322313551;4463.575960283768;4479.619232365253;4486.618637415807;4526.411566496351;4559.589636932676;4501.414816073906;4502.594766471017;4535.25168347224;4546.727196368229;4554.565311926733;4493.146302202587;4525.411696479453;4535.727856328631;4545.204589196894;4553.704009239405;4393.2531469650075;4496.460424749019;4508.233600287959;4529.388532548097;4535.818567257323;4012.839486420569;4017.4375587417785;4029.005642207097;4033.1127152026506;4036.9596304037173;5657.434256574351;5720.942790572082;5722.799702010409;5724.198612194296;5737.282839645044;5077.957658779576;5152.793888244466;5216.165413533817;5218.582513398919;5221.556167725748;6086.6348019119;6105.450509454126;6114.2357205349335;6114.419130182626;6131.754729810802;4313.161286455026;4454.866354009385;4458.9554104459185;4474.463064432256;4475.641948644101;6047.274327080734;6203.720832562501;6312.715927783215;6315.905261421082;6334.429901308904;4422.270325396338;4436.511983681857;4443.844465443694;4463.709858859163;4465.531119232499;4499.235130027903;4539.704919180309;4543.7728113594185;4557.6581756368405;4559.9772001140445;4973.55238028572;5136.948630513722;5180.7150606717;5189.4032186299055;5194.740262986836;6004.609700369462;6092.664903430354;6093.66484843329;6094.116353128771;6182.536309776785;1530.8545688159606;1559.6100974756312;1560.680060587577;1562.7655851622349;1582.8575428211516;941.5574679900436;980.2060331131806;984.4044353166374;995.8406654935176;1007.7302598725659;5234.0840352938085;5260.894782104337;5316.840494785162;5370.174140792149;5384.542313903284;5547.861303467445;5548.472895074961;5555.722213889289;5612.35457922336;5647.463490968352;4950.653454258168;5093.363329583802;5187.688738675692;5298.443663415363;5302.946970530323;2958.8816447342297;2968.723448916943;2981.3602518614675;2983.4928062229474;3006.7143621355935;5524.8784436793085;5792.565557583198;5842.357340692521;5845.240118784531;5868.207791948118;5559.360673522516;5614.494695477427;5617.595601099725;5635.746391412396;5670.752434464412;5676.403977582295;5724.169995350734;5751.01589951466;5766.452187042224;5807.709614519257;5281.445448227881;5496.076373269484;5523.861903452445;5588.804391846266;5601.747921343631;5491.258680078138;5506.449355064461;5527;5563.388027316911;5578.497935185853;6249.593776404519;6284.842878928063;6452.032195170762;6471.255805582418;6479.41685248311;4362.8691139265875;4370.694051416371;4376.54046325144;4388.169630588189;4390.407295015132;6084.326810127073;6215.471684906834;6217.668374359615;6265.655388953652;6322.33615470369;6106.664133472524;6110.908336375047;6122.969385153046;6141.6007959482495;6142.232220972379;5827.125931110368;6068.543549547989;6087.908681369694;6138.570300078952;6152.938470615416;6039.607425517327;6044.395560443921;6050.304215015153;6067.878642427038;6078.45293923549;6124.908126378197;6142.600730952474;6150.600210986271;6166;6215.44061034491;5747.189635264878;5965.9105113422465;6006.429389208019;6016.217891674054;6016.8796624068145 04:16:03 INFO - PROCESS | 8236 | |5;yui.html;801.6312496251724;814.3200427642917;820.4666966471792;879.2789912271936;894.0478390514106;15320.923395383035;15487.380504779796;15503.379864805409;15880.444184453532;16658.167091645413;14444.061136026177;14519.20144392058;14566.27168641569;14616;14643;722.6025685872776;833.5790425834975;850.6044689219527;851.3870013590205;851.6167724523989;855.1064137975799;859.3898332184157;862.9697960571381;866.6056944090424;870.4820631724114;899.9370044096916;901.1709227510673;903.453410686535;904.8552231642939;906.3836591118037;893.9150780675825;894.7315805258429;898.6809682562695;899.8020435504178;900.7297810656777;667.813012356541;668.7024274197984;669.5647828911198;669.8626781509779;672.1027428383114;14432.783508247385;14474;14509.129452232793;14515.782263266059;14575;14284;16645.42176502975;16751.832481675272;17000.659986800318;17351.91324043384;13775.931120344434;14118.364673589713;14245.430182792676;14277.78583321251;14586.927065364605;4131.669466442678;4133.318002529579;4165.146145040259;4291.828326866922;4785;83418.58290708569;86061;86401.99999999937;86972.56513717455;87033.56483217607;12102.81845772314;12200.450979705935;12468.501259949682;12536.937315313366;12713.555025574246;22710.886445567998;22766;22831.31506054821;22847.314580562608;22890.198843040413;8886.333524985652;9051.230645395084;9148.359614826899;9150.86273705895;9334.159925606727;4981.950180498221;5033.144365457881;5126.769295381717;5208.062548741187;5239.711815850165;3603.4955106285142;3767.1900541383734;3778.3954567269107;3792.0140763401164;3796.2976849282973;652.3704625036768;659.8878190707592;661.2626920983165;664.3887623386496;667.0427935911982;685.674304705271;737.9040724705754;773.3426587400777;775.8711075385413;826.0912995704676;9164.266858651292;9960.348138357507;10148.492575371201;10242.436665983443;10405.53175107122;735.577043200162;769.955846604153;772.1699173388517;779.9376049915993;784.7042421828344;5089.3638295213095;5124.92312615311;5245.527902488794;5269.077911365495;5359.490848369399;79103;89909;131299.68700313065;132801;135165;115287;115567;116819;118990;119862;55460;61948;99716;101787.4910625457;102956.97043029623;9489.667861625087;9593.232541396532;9629.518524073908;9663.082007209305;9723.756906077122;44030;49368.25947610717;58288;61239.38760612515;61342.69328653328;51525;55817.720911396806;74624;79293.2070679309;83120.58439707763;14025.29873506341;14048.690640642855;14126.316521255403;14414.351354188877;14460.13239205651;15634.609134771721;15975.760363594323;16099.517014489584;16402;16416.343346266494;13735.175889446666;13740.793888091886;13754.170638703416;13855.099418537762;14082.366293516612;14683.55949321522;15067.397304107713;15067.849321506645;15247.923760381127;15339.386424542894;14473;14636.853631463975;14652.12087274767;14693.779593305895;14832.406703731729;11244.718882028015;11374;11378.829317560077;11532.135089868125;11623;12467.376631168225;12538.811917821058;12564.937175314066;12716.745665086832;13004.154729942524 04:16:03 INFO - PROCESS | 8236 | __end_tp_report 04:16:03 INFO - PROCESS | 8236 | __start_cc_report 04:16:03 INFO - PROCESS | 8236 | _x_x_mozilla_cycle_collect,330 04:16:03 INFO - PROCESS | 8236 | __end_cc_report 04:16:03 INFO - PROCESS | 8236 | __startTimestamp1473246963175__endTimestamp 04:16:03 INFO - PROCESS | 8236 | 04:16:03 INFO - PROCESS | 8236 | ------- Summary: start ------- 04:16:03 INFO - PROCESS | 8236 | Number of tests: 6 04:16:03 INFO - PROCESS | 8236 | 04:16:03 INFO - PROCESS | 8236 | [#0] dojo.html Cycles:165 Average:5702.33 Median:5965.19 stddev:662.06 (11.1%) stddev-sans-first:635.76 04:16:03 INFO - PROCESS | 8236 | Values: 3260.0 3285.1 3299.6 3301.3 3310.6 5662.9 5678.8 5684.2 5702.7 5712.6 5639.3 5655.4 5664.4 5689.1 5708.9 5168.7 5187.3 5195.2 5239.6 5241.8 4996.1 5010.4 5186.8 5203.5 5282.5 5130.0 5145.8 5146.6 5151.9 5214.5 5239.5 5239.6 5240.4 5245.2 5274.6 5043.7 5069.0 5088.3 5146.5 5146.6 5613.8 5637.0 5666.2 5720.4 5744.3 6045.5 6069.2 6083.5 6100.0 6130.8 5883.2 6131.7 6131.7 6184.4 6189.3 5813.3 5817.8 5826.3 5828.2 5864.4 6328.1 6343.6 6344.9 6350.8 6354.5 5744.9 5933.3 5960.4 6068.3 6095.8 6066.1 6107.1 6122.6 6140.0 6143.7 6061.3 6086.2 6092.4 6093.9 6113.1 5864.7 6033.3 6046.5 6053.5 6084.6 4695.8 4696.3 4706.8 4713.5 4733.6 4180.9 4184.4 4191.1 4204.2 4211.1 5732.2 5801.3 5890.8 5967.3 5982.4 6191.3 6207.1 6219.4 6220.9 6222.3 5974.8 5976.1 5978.6 6009.9 6012.8 5130.3 5262.9 5320.4 5343.7 5374.9 6361.6 6384.5 6398.6 6409.5 6415.7 6105.4 6126.9 6132.0 6138.1 6145.6 6114.7 6341.4 6345.1 6397.0 6402.8 6140.6 6179.3 6180.0 6180.9 6193.8 6290.1 6291.6 6291.7 6303.6 6305.0 5811.6 5954.9 5965.2 5990.4 6131.6 5993.7 5997.9 6020.3 6030.2 6056.5 5937.7 5942.8 5968.9 5978.0 6006.3 5792.8 5978.7 6000.2 6020.4 6048.1 5924.1 5944.3 5945.0 5959.1 5969.2 04:16:03 INFO - PROCESS | 8236 | 04:16:03 INFO - PROCESS | 8236 | [#1] ext.html Cycles:180 Average:64925.17 Median:24889.48 stddev:129554.32 (520.5%) stddev-sans-first:129827.67 04:16:03 INFO - PROCESS | 8236 | Values: 578.2 649.2 651.5 657.6 664.8 42253.0 46971.0 46997.0 47198.3 47306.3 45880.3 46439.0 46485.0 46608.1 46642.0 9089.5 9149.1 9221.4 9221.9 9244.3 9108.7 9208.3 9221.2 9226.4 9268.0 9277.1 9291.7 9294.9 9301.4 9326.7 9158.9 9167.9 9214.2 9226.5 9240.8 9102.6 9122.4 9162.5 9181.7 9199.1 43630.8 43641.0 44100.3 44110.6 44293.8 3441.8 3729.3 3879.1 4381.6 4561.2 32328.8 35038.0 35638.0 36023.6 36271.3 4525.6 4565.4 4625.3 4712.0 4748.3 360320.0 361545.0 361746.0 362275.0 362433.0 64961.4 65262.0 65365.0 65410.3 65495.3 41401.2 41566.6 41910.0 42099.8 42358.4 19418.1 19774.0 19813.9 19837.5 19898.1 14807.6 15065.5 15140.1 15145.2 15172.8 20282.8 20559.4 20691.9 20792.6 20795.9 7381.3 7457.7 7557.7 7633.8 7707.3 1005.9 1156.3 1159.9 1187.1 1195.0 33092.8 33756.3 33797.0 34579.3 34850.1 1166.7 1176.9 1185.3 1224.7 1271.0 16901.2 16986.9 17070.0 17911.5 17943.9 550927.0 556593.0 562272.0 562272.0 562295.0 43362.3 43470.0 43648.3 43774.8 43876.3 1487.1 1514.5 1516.2 1532.1 1562.5 32609.5 33545.8 33619.3 33881.0 34136.3 56966.0 58640.0 60243.4 60325.0 66241.0 518291.0 520087.0 523096.0 524654.0 524910.0 47402.8 47666.3 48501.0 48846.3 48914.3 51761.7 52140.5 52343.7 52502.0 53181.0 44488.3 44993.3 45624.1 45933.0 46173.5 45370.3 45496.8 45626.0 45771.5 46000.0 37575.8 44117.6 44521.6 45253.3 45795.8 38026.4 38860.8 39310.6 39849.8 39878.0 29906.7 29990.9 30221.8 30279.0 30704.0 04:16:03 INFO - PROCESS | 8236 | 04:16:03 INFO - PROCESS | 8236 | [#2] jquery.html Cycles:180 Average:30520.47 Median:2084.85 stddev:89089.26 (4273.2%) stddev-sans-first:89310.48 04:16:03 INFO - PROCESS | 8236 | Values: 408.1 416.7 420.5 434.2 442.0 18729.3 19677.2 20341.5 20418.1 20501.3 16270.0 17008.9 19705.5 19738.8 19883.0 5688.3 5776.1 5983.6 6002.2 6033.1 5761.9 5775.7 5869.1 5870.5 5870.9 5722.7 5724.4 5839.0 5860.1 5866.4 5666.3 5838.8 5864.9 5868.6 5873.1 5768.4 5773.2 5796.2 5801.3 5827.5 13889.9 14468.3 14482.9 14501.7 17176.0 2281.3 2503.9 2711.8 2852.0 3065.6 10712.5 10723.6 10891.9 10932.8 10983.3 1993.2 2018.4 2032.5 2051.1 2095.7 58459.7 74582.6 77668.0 79272.6 83726.0 11105.5 11111.9 11365.7 11832.9 11955.8 16280.8 16548.8 16627.3 16981.2 17059.8 8764.6 8957.8 8976.3 9188.4 9342.1 8756.6 8882.1 8885.9 8913.4 9305.2 4700.5 4758.8 4782.9 4789.7 4880.2 1945.2 1955.4 2022.0 2025.4 2073.9 919.2 984.9 1045.5 1057.5 1059.4 19364.0 19447.2 19836.1 20125.0 20155.9 1034.1 1037.7 1044.5 1060.2 1084.3 10538.8 11051.7 11056.8 11096.4 11130.7 528543.0 528776.0 533569.0 556826.0 560058.0 91243.0 95785.5 97252.0 98448.0 98994.5 1030.1 1041.4 1090.1 1098.7 1115.0 16953.6 17364.1 17561.6 17615.7 17918.2 41590.8 42812.0 42951.4 42959.4 44174.1 59862.0 60512.4 62287.0 62644.4 63443.4 8674.5 8848.9 9158.1 9166.7 9248.2 12055.2 13484.9 13757.7 14067.3 14208.6 11812.9 12121.9 12150.1 12300.3 12316.9 11835.3 11938.2 12084.9 12289.8 12538.0 11569.1 11596.1 11818.3 12017.3 12239.6 7978.5 8264.8 8324.0 8350.0 9002.8 9212.7 11806.1 12162.7 12307.7 12355.9 04:16:03 INFO - PROCESS | 8236 | 04:16:03 INFO - PROCESS | 8236 | [#3] mootools.html Cycles:180 Average:6259.81 Median:2433.83 stddev:3628.21 (149.1%) stddev-sans-first:3620.99 04:16:03 INFO - PROCESS | 8236 | Values: 1531.8 1563.9 1715.8 1805.7 1838.2 8254.7 9182.4 9245.7 9835.1 9859.9 9288.6 9512.4 9549.9 9570.1 9574.2 2310.8 2360.2 2362.6 2362.9 2365.1 2505.6 2526.9 2570.5 2571.6 2573.9 2500.7 2501.7 2505.1 2506.8 2518.7 2445.3 2450.2 2452.9 2467.3 2474.2 2415.5 2415.8 2423.0 2423.7 2467.4 9585.6 9612.2 9637.9 9642.2 9644.0 5566.7 5610.6 5694.6 5695.6 5723.9 3415.1 3497.8 3513.7 3560.6 3609.9 1194.0 1229.7 1237.7 1239.1 1271.9 13369.4 13386.3 13387.8 13396.8 13453.9 4662.1 4818.8 4836.3 4919.9 4963.0 11231.5 11261.9 11274.8 11303.5 11412.8 5697.5 5702.2 5704.4 5758.0 5764.0 4389.7 5103.0 5191.8 5217.9 5295.8 4156.3 4202.3 4277.7 4296.5 4344.0 1294.3 1295.9 1304.4 1309.0 1320.2 921.7 1062.3 1070.5 1073.8 1093.0 6247.1 6490.6 6498.7 6524.4 6524.4 442.9 447.7 448.8 454.2 459.4 4284.6 4340.9 4370.7 4411.3 4420.0 11708.9 11854.6 11980.0 11993.9 11995.6 11918.3 11948.4 11956.3 11956.6 11981.4 8484.1 8756.8 8848.2 8856.3 9005.7 6510.9 6518.6 6659.4 6706.3 6792.0 10995.3 11019.2 11034.4 11042.1 11136.6 10598.4 10721.2 10822.5 10872.3 10957.9 6722.2 8163.7 8373.4 8386.1 8560.0 9390.5 9398.3 9419.8 9470.8 9497.9 8470.2 8528.3 8575.6 8639.3 8734.7 8384.8 8425.4 8426.2 8457.2 8499.2 7371.8 7392.5 7408.6 7416.7 7452.1 5539.3 5589.2 5675.0 5721.2 5792.5 5509.9 5575.1 5650.1 5781.3 5853.7 04:16:03 INFO - PROCESS | 8236 | 04:16:03 INFO - PROCESS | 8236 | [#4] prototype.html Cycles:180 Average:4972.87 Median:5557.54 stddev:1441.70 (25.9%) stddev-sans-first:1403.40 04:16:03 INFO - PROCESS | 8236 | Values: 351.6 351.7 352.3 353.7 360.6 5822.8 5862.9 5872.7 5877.3 5936.4 5678.9 5723.9 5737.8 5743.2 5783.9 4463.6 4479.6 4486.6 4526.4 4559.6 4501.4 4502.6 4535.3 4546.7 4554.6 4493.1 4525.4 4535.7 4545.2 4553.7 4393.3 4496.5 4508.2 4529.4 4535.8 4012.8 4017.4 4029.0 4033.1 4037.0 5657.4 5720.9 5722.8 5724.2 5737.3 5078.0 5152.8 5216.2 5218.6 5221.6 6086.6 6105.5 6114.2 6114.4 6131.8 4313.2 4454.9 4459.0 4474.5 4475.6 6047.3 6203.7 6312.7 6315.9 6334.4 4422.3 4436.5 4443.8 4463.7 4465.5 4499.2 4539.7 4543.8 4557.7 4560.0 4973.6 5136.9 5180.7 5189.4 5194.7 6004.6 6092.7 6093.7 6094.1 6182.5 1530.9 1559.6 1560.7 1562.8 1582.9 941.6 980.2 984.4 995.8 1007.7 5234.1 5260.9 5316.8 5370.2 5384.5 5547.9 5548.5 5555.7 5612.4 5647.5 4950.7 5093.4 5187.7 5298.4 5302.9 2958.9 2968.7 2981.4 2983.5 3006.7 5524.9 5792.6 5842.4 5845.2 5868.2 5559.4 5614.5 5617.6 5635.7 5670.8 5676.4 5724.2 5751.0 5766.5 5807.7 5281.4 5496.1 5523.9 5588.8 5601.7 5491.3 5506.4 5527.0 5563.4 5578.5 6249.6 6284.8 6452.0 6471.3 6479.4 4362.9 4370.7 4376.5 4388.2 4390.4 6084.3 6215.5 6217.7 6265.7 6322.3 6106.7 6110.9 6123.0 6141.6 6142.2 5827.1 6068.5 6087.9 6138.6 6152.9 6039.6 6044.4 6050.3 6067.9 6078.5 6124.9 6142.6 6150.6 6166.0 6215.4 5747.2 5965.9 6006.4 6016.2 6016.9 04:16:03 INFO - PROCESS | 8236 | 04:16:03 INFO - PROCESS | 8236 | [#5] yui.html Cycles:180 Average:21887.86 Median:4228.49 stddev:31933.56 (755.2%) stddev-sans-first:31983.89 04:16:03 INFO - PROCESS | 8236 | Values: 801.6 814.3 820.5 879.3 894.0 15320.9 15487.4 15503.4 15880.4 16658.2 14444.1 14519.2 14566.3 14616.0 14643.0 722.6 833.6 850.6 851.4 851.6 855.1 859.4 863.0 866.6 870.5 899.9 901.2 903.5 904.9 906.4 893.9 894.7 898.7 899.8 900.7 667.8 668.7 669.6 669.9 672.1 14432.8 14474.0 14509.1 14515.8 14575.0 14284.0 16645.4 16751.8 17000.7 17351.9 13775.9 14118.4 14245.4 14277.8 14586.9 4131.7 4133.3 4165.1 4291.8 4785.0 83418.6 86061.0 86402.0 86972.6 87033.6 12102.8 12200.5 12468.5 12536.9 12713.6 22710.9 22766.0 22831.3 22847.3 22890.2 8886.3 9051.2 9148.4 9150.9 9334.2 4982.0 5033.1 5126.8 5208.1 5239.7 3603.5 3767.2 3778.4 3792.0 3796.3 652.4 659.9 661.3 664.4 667.0 685.7 737.9 773.3 775.9 826.1 9164.3 9960.3 10148.5 10242.4 10405.5 735.6 770.0 772.2 779.9 784.7 5089.4 5124.9 5245.5 5269.1 5359.5 79103.0 89909.0 131299.7 132801.0 135165.0 115287.0 115567.0 116819.0 118990.0 119862.0 55460.0 61948.0 99716.0 101787.5 102957.0 9489.7 9593.2 9629.5 9663.1 9723.8 44030.0 49368.3 58288.0 61239.4 61342.7 51525.0 55817.7 74624.0 79293.2 83120.6 14025.3 14048.7 14126.3 14414.4 14460.1 15634.6 15975.8 16099.5 16402.0 16416.3 13735.2 13740.8 13754.2 13855.1 14082.4 14683.6 15067.4 15067.8 15247.9 15339.4 14473.0 14636.9 14652.1 14693.8 14832.4 11244.7 11374.0 11378.8 11532.1 11623.0 12467.4 12538.8 12564.9 12716.7 13004.2 04:16:03 INFO - PROCESS | 8236 | -------- Summary: end -------- 04:16:03 INFO - PROCESS | 8236 | 04:16:03 INFO - TEST-INFO | 8236: exit 0 04:16:03 INFO - TEST-OK | dromaeo_css | took 1110981ms 04:16:03 INFO - TEST-START | kraken 04:16:03 INFO - operating with platform_type : linux_ 04:16:03 INFO - Initialising browser for kraken test... 04:16:03 INFO - TEST-INFO | started process 8498 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPLyZ1Q/profile http://localhost:39551/getInfo.html) 04:16:08 INFO - PROCESS | 8498 | __metrics Screen width/height:1600/1200 04:16:08 INFO - PROCESS | 8498 | colorDepth:24 04:16:08 INFO - PROCESS | 8498 | Browser inner width/height: 1024/697 04:16:08 INFO - PROCESS | 8498 | __metrics 04:16:09 ERROR - PROCESS | 8498 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 04:16:09 INFO - TEST-INFO | 8498: exit 0 04:16:09 INFO - Browser initialized. 04:16:09 INFO - Running cycle 1/1 for kraken test... 04:16:09 INFO - TEST-INFO | started process 8623 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPLyZ1Q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:16:21 INFO - PROCESS | 8623 | RSS: Main: 152711168 04:16:21 INFO - PROCESS | 8623 | 04:16:24 INFO - PROCESS | 8623 | Cycle 1(1): loaded http://localhost:39551/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39551/tests/kraken/driver.html?testName=audio-beat-detection) 04:16:25 INFO - PROCESS | 8623 | RSS: Main: 157855744 04:16:25 INFO - PROCESS | 8623 | 04:16:27 INFO - PROCESS | 8623 | Cycle 1(1): loaded http://localhost:39551/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39551/tests/kraken/driver.html?testName=audio-dft) 04:16:28 INFO - PROCESS | 8623 | RSS: Main: 156626944 04:16:28 INFO - PROCESS | 8623 | 04:16:31 INFO - PROCESS | 8623 | Cycle 1(1): loaded http://localhost:39551/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39551/tests/kraken/driver.html?testName=audio-fft) 04:16:31 INFO - PROCESS | 8623 | RSS: Main: 157569024 04:16:31 INFO - PROCESS | 8623 | 04:16:33 INFO - PROCESS | 8623 | Cycle 1(1): loaded http://localhost:39551/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39551/tests/kraken/driver.html?testName=audio-oscillator) 04:16:34 INFO - PROCESS | 8623 | RSS: Main: 157077504 04:16:34 INFO - PROCESS | 8623 | 04:16:36 INFO - PROCESS | 8623 | Cycle 1(1): loaded http://localhost:39551/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39551/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:16:37 INFO - PROCESS | 8623 | RSS: Main: 157085696 04:16:37 INFO - PROCESS | 8623 | 04:16:40 INFO - PROCESS | 8623 | Cycle 1(1): loaded http://localhost:39551/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39551/tests/kraken/driver.html?testName=imaging-darkroom) 04:16:41 INFO - PROCESS | 8623 | RSS: Main: 156397568 04:16:41 INFO - PROCESS | 8623 | 04:16:44 INFO - PROCESS | 8623 | Cycle 1(1): loaded http://localhost:39551/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39551/tests/kraken/driver.html?testName=imaging-desaturate) 04:16:45 INFO - PROCESS | 8623 | RSS: Main: 156966912 04:16:45 INFO - PROCESS | 8623 | 04:16:47 INFO - PROCESS | 8623 | Cycle 1(1): loaded http://localhost:39551/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39551/tests/kraken/driver.html?testName=json-parse-financial) 04:16:48 INFO - PROCESS | 8623 | RSS: Main: 157409280 04:16:48 INFO - PROCESS | 8623 | 04:16:50 INFO - PROCESS | 8623 | Cycle 1(1): loaded http://localhost:39551/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39551/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:16:50 INFO - PROCESS | 8623 | RSS: Main: 156909568 04:16:50 INFO - PROCESS | 8623 | 04:16:52 INFO - PROCESS | 8623 | Cycle 1(1): loaded http://localhost:39551/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39551/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:16:53 INFO - PROCESS | 8623 | RSS: Main: 157171712 04:16:53 INFO - PROCESS | 8623 | 04:16:55 INFO - PROCESS | 8623 | Cycle 1(1): loaded http://localhost:39551/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39551/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:16:55 INFO - PROCESS | 8623 | RSS: Main: 157466624 04:16:55 INFO - PROCESS | 8623 | 04:16:58 INFO - PROCESS | 8623 | Cycle 1(1): loaded http://localhost:39551/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39551/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:16:58 INFO - PROCESS | 8623 | RSS: Main: 157495296 04:16:58 INFO - PROCESS | 8623 | 04:17:01 INFO - PROCESS | 8623 | Cycle 1(1): loaded http://localhost:39551/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39551/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:17:02 INFO - PROCESS | 8623 | RSS: Main: 157462528 04:17:02 INFO - PROCESS | 8623 | 04:17:03 INFO - PROCESS | 8623 | Cycle 1(1): loaded http://localhost:39551/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39551/tests/kraken/driver.html?testName=ai-astar) 04:17:04 INFO - PROCESS | 8623 | RSS: Main: 158543872 04:17:04 INFO - PROCESS | 8623 | 04:17:04 INFO - PROCESS | 8623 | __start_tp_report 04:17:04 INFO - PROCESS | 8623 | _x_x_mozilla_page_load 04:17:04 INFO - PROCESS | 8623 | _x_x_mozilla_page_load_details 04:17:04 INFO - PROCESS | 8623 | |i|pagename|runs| 04:17:04 INFO - PROCESS | 8623 | |0;ai-astar;102;111;107;114;112;113;112;113;111;113 04:17:04 INFO - PROCESS | 8623 | |1;audio-beat-detection;145;117;150;170;117;147;148;117;179;117 04:17:04 INFO - PROCESS | 8623 | |2;audio-dft;167;168;164;165;163;168;163;164;162;162 04:17:04 INFO - PROCESS | 8623 | |3;audio-fft;75;76;76;184;76;76;75;77;173;77 04:17:04 INFO - PROCESS | 8623 | |4;audio-oscillator;83;84;151;84;83;84;147;84;84;152 04:17:04 INFO - PROCESS | 8623 | |5;imaging-gaussian-blur;117;117;118;117;118;118;117;117;118;118 04:17:04 INFO - PROCESS | 8623 | |6;imaging-darkroom;146;147;146;146;146;146;147;146;146;148 04:17:04 INFO - PROCESS | 8623 | |7;imaging-desaturate;95;95;97;95;96;96;96;95;95;95 04:17:04 INFO - PROCESS | 8623 | |8;json-parse-financial;53;52;51;55;51;52;54;51;50;51 04:17:04 INFO - PROCESS | 8623 | |9;json-stringify-tinderbox;62;61;60;61;61;59;59;61;60;61 04:17:04 INFO - PROCESS | 8623 | |10;stanford-crypto-aes;72;72;75;73;82;73;82;74;73;80 04:17:04 INFO - PROCESS | 8623 | |11;stanford-crypto-ccm;120;125;122;119;122;119;129;144;153;130 04:17:04 INFO - PROCESS | 8623 | |12;stanford-crypto-pbkdf2;156;151;158;149;153;154;151;151;150;153 04:17:04 INFO - PROCESS | 8623 | |13;stanford-crypto-sha256-iterative;62;63;63;62;63;60;61;61;64;61 04:17:04 INFO - PROCESS | 8623 | __end_tp_report 04:17:04 INFO - PROCESS | 8623 | __start_cc_report 04:17:04 INFO - PROCESS | 8623 | _x_x_mozilla_cycle_collect,859 04:17:04 INFO - PROCESS | 8623 | __end_cc_report 04:17:04 INFO - PROCESS | 8623 | __startTimestamp1473247024076__endTimestamp 04:17:04 INFO - PROCESS | 8623 | 04:17:04 INFO - PROCESS | 8623 | ------- Summary: start ------- 04:17:04 INFO - PROCESS | 8623 | Number of tests: 14 04:17:04 INFO - PROCESS | 8623 | 04:17:04 INFO - PROCESS | 8623 | [#0] ai-astar Cycles:10 Average:110.80 Median:112.50 stddev:3.65 (3.2%) stddev-sans-first:2.05 04:17:04 INFO - PROCESS | 8623 | Values: 102.0 111.0 107.0 114.0 112.0 113.0 112.0 113.0 111.0 113.0 04:17:04 INFO - PROCESS | 8623 | 04:17:04 INFO - PROCESS | 8623 | [#1] audio-beat-detection Cycles:10 Average:140.70 Median:147.50 stddev:23.02 (15.6%) stddev-sans-first:24.37 04:17:04 INFO - PROCESS | 8623 | Values: 145.0 117.0 150.0 170.0 117.0 147.0 148.0 117.0 179.0 117.0 04:17:04 INFO - PROCESS | 8623 | 04:17:04 INFO - PROCESS | 8623 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.50 stddev:2.32 (1.4%) stddev-sans-first:2.29 04:17:04 INFO - PROCESS | 8623 | Values: 167.0 168.0 164.0 165.0 163.0 168.0 163.0 164.0 162.0 162.0 04:17:04 INFO - PROCESS | 8623 | 04:17:04 INFO - PROCESS | 8623 | [#3] audio-fft Cycles:10 Average:96.50 Median:76.00 stddev:43.30 (57.0%) stddev-sans-first:45.22 04:17:04 INFO - PROCESS | 8623 | Values: 75.0 76.0 76.0 184.0 76.0 76.0 75.0 77.0 173.0 77.0 04:17:04 INFO - PROCESS | 8623 | 04:17:04 INFO - PROCESS | 8623 | [#4] audio-oscillator Cycles:10 Average:103.60 Median:84.00 stddev:32.05 (38.1%) stddev-sans-first:33.11 04:17:04 INFO - PROCESS | 8623 | Values: 83.0 84.0 151.0 84.0 83.0 84.0 147.0 84.0 84.0 152.0 04:17:04 INFO - PROCESS | 8623 | 04:17:04 INFO - PROCESS | 8623 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 04:17:04 INFO - PROCESS | 8623 | Values: 117.0 117.0 118.0 117.0 118.0 118.0 117.0 117.0 118.0 118.0 04:17:04 INFO - PROCESS | 8623 | 04:17:04 INFO - PROCESS | 8623 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 04:17:04 INFO - PROCESS | 8623 | Values: 146.0 147.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 148.0 04:17:04 INFO - PROCESS | 8623 | 04:17:04 INFO - PROCESS | 8623 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 04:17:04 INFO - PROCESS | 8623 | Values: 95.0 95.0 97.0 95.0 96.0 96.0 96.0 95.0 95.0 95.0 04:17:04 INFO - PROCESS | 8623 | 04:17:04 INFO - PROCESS | 8623 | [#8] json-parse-financial Cycles:10 Average:52.00 Median:52.00 stddev:1.56 (3.0%) stddev-sans-first:1.62 04:17:04 INFO - PROCESS | 8623 | Values: 53.0 52.0 51.0 55.0 51.0 52.0 54.0 51.0 50.0 51.0 04:17:04 INFO - PROCESS | 8623 | 04:17:04 INFO - PROCESS | 8623 | [#9] json-stringify-tinderbox Cycles:10 Average:60.50 Median:61.00 stddev:0.97 (1.6%) stddev-sans-first:0.87 04:17:04 INFO - PROCESS | 8623 | Values: 62.0 61.0 60.0 61.0 61.0 59.0 59.0 61.0 60.0 61.0 04:17:04 INFO - PROCESS | 8623 | 04:17:04 INFO - PROCESS | 8623 | [#10] stanford-crypto-aes Cycles:10 Average:75.60 Median:74.50 stddev:4.09 (5.5%) stddev-sans-first:4.12 04:17:04 INFO - PROCESS | 8623 | Values: 72.0 72.0 75.0 73.0 82.0 73.0 82.0 74.0 73.0 80.0 04:17:04 INFO - PROCESS | 8623 | 04:17:04 INFO - PROCESS | 8623 | [#11] stanford-crypto-ccm Cycles:10 Average:128.30 Median:127.00 stddev:11.51 (9.1%) stddev-sans-first:11.81 04:17:04 INFO - PROCESS | 8623 | Values: 120.0 125.0 122.0 119.0 122.0 119.0 129.0 144.0 153.0 130.0 04:17:04 INFO - PROCESS | 8623 | 04:17:04 INFO - PROCESS | 8623 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.60 Median:153.00 stddev:2.80 (1.8%) stddev-sans-first:2.68 04:17:04 INFO - PROCESS | 8623 | Values: 156.0 151.0 158.0 149.0 153.0 154.0 151.0 151.0 150.0 153.0 04:17:04 INFO - PROCESS | 8623 | 04:17:04 INFO - PROCESS | 8623 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.00 Median:62.50 stddev:1.25 (2.0%) stddev-sans-first:1.32 04:17:04 INFO - PROCESS | 8623 | Values: 62.0 63.0 63.0 62.0 63.0 60.0 61.0 61.0 64.0 61.0 04:17:04 INFO - PROCESS | 8623 | -------- Summary: end -------- 04:17:04 INFO - PROCESS | 8623 | 04:17:05 INFO - TEST-INFO | 8623: exit 0 04:17:05 INFO - TEST-OK | kraken | took 61206ms 04:17:05 INFO - SUITE-END | took 1172s 04:17:05 INFO - Completed test suite (00:19:32) 04:17:05 INFO - javascript benchmark 04:17:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7674.097023229686, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3259.983700081499, 3285.080177550285, 3299.5875515560556, 3301.29022260214, 3310.619278782941, 5662.915056274154, 5678.801241956532, 5684.175794509799, 5702.686352250625, 5712.628679135853, 5639.295088113986, 5655.442302508767, 5664.40523745006, 5689.089745640698, 5708.942910570893, 5168.664036837612, 5187.273781670569, 5195.220716892459, 5239.607029472805, 5241.764120614563, 4996.125678006352, 5010.448850626428, 5186.766595503212, 5203.531682148606, 5282.498162674539, 5129.974350128244, 5145.794168233266, 5146.562542183919, 5151.922721159186, 5214.530692237698, 5239.502247286502, 5239.580833533346, 5240.3973543042275, 5245.160774276116, 5274.630775845692, 5043.747812609355, 5069.0, 5088.287639730441, 5146.536811686929, 5146.588272938194, 5613.775448982035, 5637.0, 5666.150077488369, 5720.399358067385, 5744.281964754406, 6045.486133678599, 6069.2110025696375, 6083.513318934519, 6099.969500152471, 6130.846728831771, 5883.205767221413, 6131.662758548278, 6131.68252131274, 6184.412480814315, 6189.288231853349, 5813.302403711539, 5817.796377126865, 5826.329972053226, 5828.154917536934, 5864.354920958691, 6328.145700330489, 6343.619382837044, 6344.904826427607, 6350.809475715736, 6354.459870911024, 5744.913826292609, 5933.317668468095, 5960.403959604005, 6068.271807383054, 6095.817125486243, 6066.120412540157, 6107.059952181356, 6122.571420000557, 6140.0, 6143.723532441051, 6061.3029501607, 6086.239220097488, 6092.421219984094, 6093.878122437615, 6113.113598528189, 5864.67744274069, 6033.276006879202, 6046.546509011841, 6053.4854537363935, 6084.604500707528, 4695.7886895089805, 4696.319033740088, 4706.835260765857, 4713.481517033124, 4733.597644200281, 4180.937285940713, 4184.351425529047, 4191.077962848169, 4204.222218889515, 4211.115665710174, 5732.168835518826, 5801.3328467225965, 5890.764369425175, 5967.254093238345, 5982.4316689914385, 6191.25704915413, 6207.131001659771, 6219.440250377488, 6220.937790622036, 6222.315545290015, 5974.790882319098, 5976.133460648181, 5978.641281523122, 6009.939900601025, 6012.759489620366, 5130.281760553526, 5262.894742105136, 5320.361556613154, 5343.732813359316, 5374.946250537523, 6361.61830290184, 6384.52116091295, 6398.648074355955, 6409.487241020801, 6415.67921603918, 6105.358937311518, 6126.877462450726, 6132.0, 6138.140660307471, 6145.600535965327, 6114.6636934969, 6341.4292713656, 6345.1434056401795, 6396.999999999814, 6402.839929001812, 6140.596275277906, 6179.3202747698615, 6179.969100154471, 6180.938190618036, 6193.84515387119, 6290.0879372491645, 6291.559590828781, 6291.653959032297, 6303.558750887577, 6304.968475157778, 5811.593188476766, 5954.940450595612, 5965.194698715618, 5990.430909063632, 6131.570790044832, 5993.700314984146, 5997.880042399215, 6020.30766461845, 6030.246219222598, 6056.545759068, 5937.732802023833, 5942.821715348547, 5968.940310596839, 5978.043513037893, 6006.339302676614, 5792.797252096157, 5978.701064946822, 6000.189974353407, 6020.397960203944, 6048.092786082123, 5924.052151655715, 5944.286685597756, 5945.048792193228, 5959.135925290722, 5969.224000880032], "value": 5656.694545341325, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.1587789765891, 649.2403887451682, 651.5308977536172, 657.6382989355853, 664.8337915521116, 42253.0, 46971.0, 46997.0, 47198.292025619645, 47306.2904056439, 45880.3117953231, 46439.0, 46485.0, 46608.067838643205, 46642.0, 9089.545522723854, 9149.085091490831, 9221.40060896043, 9221.907780922173, 9244.260459163252, 9108.72673819783, 9208.26333893287, 9221.216196623294, 9226.446413215228, 9267.95366023169, 9277.118673725985, 9291.674791382304, 9294.907050929505, 9301.395409298408, 9326.673566425177, 9158.86261706075, 9167.908320916838, 9214.170724634749, 9226.538673066354, 9240.815183696322, 9102.590383432695, 9122.361434699573, 9162.541872906328, 9181.678641247525, 9199.080091990814, 43630.78184609057, 43641.0, 44100.3384949226, 44110.55889441129, 44293.778531107135, 3441.776284541497, 3729.310077635646, 3879.1465877506903, 4381.583749543788, 4561.201789686792, 32328.83835580807, 35038.0, 35638.0, 36023.63976360229, 36271.27457450863, 4525.633002552874, 4565.383673204108, 4625.259958406672, 4711.95288047122, 4748.311494833264, 360320.0, 361545.0, 361746.0, 362275.0, 362433.0, 64961.35038649647, 65262.0, 65365.0, 65410.345896541374, 65495.345046549875, 41401.1719765603, 41566.584334156876, 41910.0, 42099.7895010523, 42358.36462453066, 19418.12618432174, 19774.0, 19813.900930495256, 19837.504062398268, 19898.104585293695, 14807.555773326818, 15065.472708455152, 15140.091594504365, 15145.167015814235, 15172.848271517365, 20282.797172028386, 20559.38321850347, 20691.896540517202, 20792.58414831695, 20795.896020519802, 7381.335679788737, 7457.7389791357045, 7557.659905304275, 7633.770986870402, 7707.267809558083, 1005.939643621385, 1156.2657712352548, 1159.8724140344555, 1187.1037366788191, 1194.9940250298694, 33092.83453582717, 33756.32487350288, 33797.0, 34579.308413832085, 34850.128746781535, 1166.7258194324327, 1176.9352685602373, 1185.300672603151, 1224.6938265433641, 1271.0149634033698, 16901.23944422504, 16986.915065424593, 17070.0, 17911.462656120337, 17943.910280448516, 550927.0, 556593.0, 562272.0, 562272.0, 562295.0, 43362.34956475655, 43470.0, 43648.3452748209, 43774.7811260948, 43876.341854872204, 1487.0557196180287, 1514.4699355225582, 1516.2115699836024, 1532.0501289200768, 1562.5000000000118, 32609.510857337635, 33545.83227083849, 33619.327613448084, 33881.0, 34136.31727365489, 56966.0, 58640.0, 60243.39756602553, 60325.0, 66241.0, 518291.0, 520087.0, 523096.0, 524654.0, 524910.0, 47402.76298618485, 47666.28500572425, 48501.0, 48846.26730599115, 48914.26628600645, 51761.68289707738, 52140.47859521508, 52343.73828130835, 52502.0, 53181.0, 44488.33267500925, 44993.32510012287, 45624.08751824879, 45933.0, 46173.53826461827, 45370.319445207686, 45496.77251613853, 45626.0, 45771.542284576724, 46000.0, 37575.81212094031, 44117.55882441263, 44521.55478445304, 45253.321200181366, 45795.77102114468, 38026.42960355652, 38860.805695971336, 39310.60689393069, 39849.80075099606, 39878.0, 29906.700932990392, 29990.850045750503, 30221.848890755406, 30279.0, 30704.0], "value": 21561.05473956525, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.11439176985937, 416.69581205719845, 420.52690722936694, 434.2032370599949, 442.02974471036066, 18729.34447294345, 19677.21291148354, 20341.49146271344, 20418.08118634663, 20501.282455114073, 16270.0, 17008.914955425236, 19705.507362315948, 19738.802611973875, 19883.005849707493, 5688.317401911776, 5776.075827867542, 5983.6409815411, 6002.2197114375285, 6033.09503574463, 5761.884762304751, 5775.682337471438, 5869.060950247961, 5870.471657550819, 5870.911936320958, 5722.656640601556, 5724.39893811148, 5838.970805145968, 5860.062390017598, 5866.384029676865, 5666.320041594994, 5838.824835254949, 5864.882702345951, 5868.589198756089, 5873.060310350324, 5768.42315768424, 5773.220615216934, 5796.2464879565805, 5801.274840644919, 5827.533797296206, 13889.861101389059, 14468.276586170754, 14482.855171448256, 14501.70996580073, 17176.0, 2281.3156053184143, 2503.949921001588, 2711.783057355407, 2852.044565070683, 3065.6321241450946, 10712.46437678113, 10723.62467313648, 10891.891081089167, 10932.836007459895, 10983.340999539972, 1993.2326054468988, 2018.3743039657606, 2032.4918770307422, 2051.0872661665417, 2095.748510178773, 58459.70770146122, 74582.62708686422, 77668.0, 79272.60363698202, 83726.0, 11105.500252488657, 11111.944440277746, 11365.715857103472, 11832.940835295769, 11955.820662690066, 16280.75578866318, 16548.75176872324, 16627.334906603843, 16981.235844387033, 17059.829401705825, 8764.561771911507, 8957.820843583091, 8976.326775491863, 9188.40275382098, 9342.112499312554, 8756.649734010569, 8882.134751702086, 8885.911140888638, 8913.420627659181, 9305.162535371848, 4700.459447163552, 4758.762061896891, 4782.904341913142, 4789.664723469394, 4880.219164933665, 1945.2121890634317, 1955.3742802303127, 2022.029425875588, 2025.4025062606565, 2073.9481512962298, 919.1589695428742, 984.9064338887795, 1045.4563626913962, 1057.460695045517, 1059.4014381874217, 19364.0, 19447.22211111568, 19836.10737516815, 20125.0, 20155.899220504096, 1034.1261633919326, 1037.6679462571904, 1044.498640652491, 1060.226034994443, 1084.2789544952675, 10538.841917371246, 11051.72370690739, 11056.778864422666, 11096.389698566656, 11130.721731956604, 528543.0, 528776.0, 533569.0, 556826.0, 560058.0, 91243.0, 95785.52107239419, 97252.0, 98448.0, 98994.5050274744, 1030.1038096855784, 1041.375174895057, 1090.0625462102585, 1098.747288123736, 1114.9665510034713, 16953.576160596083, 17364.1070958708, 17561.56096097608, 17615.735763963294, 17918.193681284112, 41590.77200695874, 42812.0, 42951.35572966345, 42959.355609666505, 44174.11651767011, 59862.0, 60512.394876050676, 62287.0, 62644.37355626568, 63443.365566345594, 8674.522901240493, 8848.867266990872, 9158.084191581054, 9166.724998250063, 9248.21390181842, 12055.21641093326, 13484.932575337061, 13757.724845503235, 14067.296635168404, 14208.644783880072, 11812.881871181178, 12121.939390302992, 12150.149489535648, 12300.323482208565, 12316.938415307866, 11835.28988260707, 11938.22401543897, 12084.939575302067, 12289.815652765394, 12538.0, 11569.074474042225, 11596.072314214674, 11818.290902545874, 12017.278963262232, 12239.571614993432, 7978.4813987092975, 8264.752057438287, 8324.0427350853, 8350.0, 9002.819943601222, 9212.723618291462, 11806.055515558563, 12162.695932601755, 12307.69230769238, 12355.876441235472], "value": 9447.491820438876, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1531.8085239345082, 1563.8592526672596, 1715.759793628892, 1805.6930321845277, 1838.2003828334666, 8254.711085112021, 9182.40314379565, 9245.722628321144, 9835.065668761474, 9859.852102218463, 9288.628454861815, 9512.429254244751, 9549.856752148724, 9570.090841370076, 9574.186194173486, 2310.849794763343, 2360.1621424394352, 2362.645603159531, 2362.8936697848553, 2365.1012615206196, 2505.6116301973225, 2526.873656317186, 2570.485902819434, 2571.562834318161, 2573.9485210295784, 2500.6999160100722, 2501.737317581655, 2505.0856437400307, 2506.8495890246554, 2518.6851643544555, 2445.3397582652674, 2450.2281781238853, 2452.901883924641, 2467.2968204061845, 2474.2329877737957, 2415.45652228249, 2415.806735461159, 2423.0307876849224, 2423.7091549014053, 2467.383154211447, 9585.616575336979, 9612.18296444803, 9637.90362096377, 9642.228621710246, 9643.951780241125, 5566.66600003997, 5610.579206559524, 5694.572907031948, 5695.572832037572, 5723.885522289573, 3415.0704851758924, 3497.7901325920525, 3513.7189024878203, 3560.590532088791, 3609.8917032488803, 1193.9761204775855, 1229.692576855786, 1237.6534570320325, 1239.0830785218964, 1271.8918891894107, 13369.398377072957, 13386.330683465787, 13387.799183012165, 13396.799048014287, 13453.932730336384, 4662.126509618619, 4818.831340903052, 4836.322914791932, 4919.852404427873, 4963.007398520311, 11231.494582743797, 11261.887381126084, 11274.774504510027, 11303.547858085749, 11412.771744565229, 5697.515711164598, 5702.201691763156, 5704.4295570443455, 5758.0, 5763.971180144073, 4389.714668546534, 5103.0, 5191.844244672666, 5217.895642087137, 5295.841124766263, 4156.314208155681, 4202.2646036943415, 4277.721948073366, 4296.484421869333, 4344.0, 1294.288141522178, 1295.88343020941, 1304.3804193008245, 1309.0378571749757, 1320.2474589483902, 921.6912334367928, 1062.2882668612049, 1070.5289672544056, 1073.849661047454, 1092.983605245922, 6247.125402443661, 6490.578112422678, 6498.675066246668, 6524.412802847766, 6524.445422139076, 442.8759947214785, 447.6620151785381, 448.78827166650177, 454.2096751652102, 459.4463671276104, 4284.635805956528, 4340.891477713082, 4370.7159034662645, 4411.2721400968485, 4420.0, 11708.941455292668, 11854.644360669194, 11980.0, 11993.940030299793, 11995.580154694544, 11918.284902905853, 11948.402579870972, 11956.342401167845, 11956.641300760992, 11981.400929953641, 8484.109168537338, 8756.824863502694, 8848.247898928534, 8856.335774816915, 9005.729828105168, 6510.934890651222, 6518.57629254097, 6659.367360100783, 6706.295838936841, 6791.966040169767, 10995.285306455055, 11019.228653994143, 11034.448277585929, 11042.116630669689, 11136.610218642309, 10598.364098154136, 10721.195910306915, 10822.51298691545, 10872.293300935415, 10957.945210273898, 6722.159730033746, 8163.7142700005215, 8373.413861029669, 8386.11945745688, 8560.0, 9390.483523406005, 9398.2951278653, 9419.811603768023, 9470.763230919281, 9497.905020949702, 8470.237678608955, 8528.317734581342, 8575.571221439028, 8639.308855291687, 8734.65061397537, 8384.782328632757, 8425.410221284696, 8426.157384261525, 8457.196566326189, 8499.150084991452, 7371.815704607213, 7392.519486233377, 7408.62956852166, 7416.703331866881, 7452.06849143857, 5539.25220095282, 5589.189567512769, 5675.035244008611, 5721.1990321354215, 5792.478676919098, 5509.917351239655, 5575.080111781511, 5650.0677388232125, 5781.277340332458, 5853.736581853912], "value": 4887.378266862376, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.6202501298597, 351.7414700195356, 352.3463974327622, 353.73823370705685, 360.5979333043657, 5822.767089316433, 5862.941370586293, 5872.73572689229, 5877.3241077276125, 5936.417658318629, 5678.858028549288, 5723.942760572393, 5737.770489180428, 5743.164028396541, 5783.884322313551, 4463.575960283768, 4479.619232365253, 4486.618637415807, 4526.411566496351, 4559.589636932676, 4501.414816073906, 4502.594766471017, 4535.25168347224, 4546.727196368229, 4554.565311926733, 4493.146302202587, 4525.411696479453, 4535.727856328631, 4545.204589196894, 4553.704009239405, 4393.2531469650075, 4496.460424749019, 4508.233600287959, 4529.388532548097, 4535.818567257323, 4012.839486420569, 4017.4375587417785, 4029.005642207097, 4033.1127152026506, 4036.9596304037173, 5657.434256574351, 5720.942790572082, 5722.799702010409, 5724.198612194296, 5737.282839645044, 5077.957658779576, 5152.793888244466, 5216.165413533817, 5218.582513398919, 5221.556167725748, 6086.6348019119, 6105.450509454126, 6114.2357205349335, 6114.419130182626, 6131.754729810802, 4313.161286455026, 4454.866354009385, 4458.9554104459185, 4474.463064432256, 4475.641948644101, 6047.274327080734, 6203.720832562501, 6312.715927783215, 6315.905261421082, 6334.429901308904, 4422.270325396338, 4436.511983681857, 4443.844465443694, 4463.709858859163, 4465.531119232499, 4499.235130027903, 4539.704919180309, 4543.7728113594185, 4557.6581756368405, 4559.9772001140445, 4973.55238028572, 5136.948630513722, 5180.7150606717, 5189.4032186299055, 5194.740262986836, 6004.609700369462, 6092.664903430354, 6093.66484843329, 6094.116353128771, 6182.536309776785, 1530.8545688159606, 1559.6100974756312, 1560.680060587577, 1562.7655851622349, 1582.8575428211516, 941.5574679900436, 980.2060331131806, 984.4044353166374, 995.8406654935176, 1007.7302598725659, 5234.0840352938085, 5260.894782104337, 5316.840494785162, 5370.174140792149, 5384.542313903284, 5547.861303467445, 5548.472895074961, 5555.722213889289, 5612.35457922336, 5647.463490968352, 4950.653454258168, 5093.363329583802, 5187.688738675692, 5298.443663415363, 5302.946970530323, 2958.8816447342297, 2968.723448916943, 2981.3602518614675, 2983.4928062229474, 3006.7143621355935, 5524.8784436793085, 5792.565557583198, 5842.357340692521, 5845.240118784531, 5868.207791948118, 5559.360673522516, 5614.494695477427, 5617.595601099725, 5635.746391412396, 5670.752434464412, 5676.403977582295, 5724.169995350734, 5751.01589951466, 5766.452187042224, 5807.709614519257, 5281.445448227881, 5496.076373269484, 5523.861903452445, 5588.804391846266, 5601.747921343631, 5491.258680078138, 5506.449355064461, 5527.0, 5563.388027316911, 5578.497935185853, 6249.593776404519, 6284.842878928063, 6452.032195170762, 6471.255805582418, 6479.41685248311, 4362.8691139265875, 4370.694051416371, 4376.54046325144, 4388.169630588189, 4390.407295015132, 6084.326810127073, 6215.471684906834, 6217.668374359615, 6265.655388953652, 6322.33615470369, 6106.664133472524, 6110.908336375047, 6122.969385153046, 6141.6007959482495, 6142.232220972379, 5827.125931110368, 6068.543549547989, 6087.908681369694, 6138.570300078952, 6152.938470615416, 6039.607425517327, 6044.395560443921, 6050.304215015153, 6067.878642427038, 6078.45293923549, 6124.908126378197, 6142.600730952474, 6150.600210986271, 6166.0, 6215.44061034491, 5747.189635264878, 5965.9105113422465, 6006.429389208019, 6016.217891674054, 6016.8796624068145], "value": 4511.270693222137, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [801.6312496251724, 814.3200427642917, 820.4666966471792, 879.2789912271936, 894.0478390514106, 15320.923395383035, 15487.380504779796, 15503.379864805409, 15880.444184453532, 16658.167091645413, 14444.061136026177, 14519.20144392058, 14566.27168641569, 14616.0, 14643.0, 722.6025685872776, 833.5790425834975, 850.6044689219527, 851.3870013590205, 851.6167724523989, 855.1064137975799, 859.3898332184157, 862.9697960571381, 866.6056944090424, 870.4820631724114, 899.9370044096916, 901.1709227510673, 903.453410686535, 904.8552231642939, 906.3836591118037, 893.9150780675825, 894.7315805258429, 898.6809682562695, 899.8020435504178, 900.7297810656777, 667.813012356541, 668.7024274197984, 669.5647828911198, 669.8626781509779, 672.1027428383114, 14432.783508247385, 14474.0, 14509.129452232793, 14515.782263266059, 14575.0, 14284.0, 16645.42176502975, 16751.832481675272, 17000.659986800318, 17351.91324043384, 13775.931120344434, 14118.364673589713, 14245.430182792676, 14277.78583321251, 14586.927065364605, 4131.669466442678, 4133.318002529579, 4165.146145040259, 4291.828326866922, 4785.0, 83418.58290708569, 86061.0, 86401.99999999937, 86972.56513717455, 87033.56483217607, 12102.81845772314, 12200.450979705935, 12468.501259949682, 12536.937315313366, 12713.555025574246, 22710.886445567998, 22766.0, 22831.31506054821, 22847.314580562608, 22890.198843040413, 8886.333524985652, 9051.230645395084, 9148.359614826899, 9150.86273705895, 9334.159925606727, 4981.950180498221, 5033.144365457881, 5126.769295381717, 5208.062548741187, 5239.711815850165, 3603.4955106285142, 3767.1900541383734, 3778.3954567269107, 3792.0140763401164, 3796.2976849282973, 652.3704625036768, 659.8878190707592, 661.2626920983165, 664.3887623386496, 667.0427935911982, 685.674304705271, 737.9040724705754, 773.3426587400777, 775.8711075385413, 826.0912995704676, 9164.266858651292, 9960.348138357507, 10148.492575371201, 10242.436665983443, 10405.53175107122, 735.577043200162, 769.955846604153, 772.1699173388517, 779.9376049915993, 784.7042421828344, 5089.3638295213095, 5124.92312615311, 5245.527902488794, 5269.077911365495, 5359.490848369399, 79103.0, 89909.0, 131299.68700313065, 132801.0, 135165.0, 115287.0, 115567.0, 116819.0, 118990.0, 119862.0, 55460.0, 61948.0, 99716.0, 101787.4910625457, 102956.97043029623, 9489.667861625087, 9593.232541396532, 9629.518524073908, 9663.082007209305, 9723.756906077122, 44030.0, 49368.25947610717, 58288.0, 61239.38760612515, 61342.69328653328, 51525.0, 55817.720911396806, 74624.0, 79293.2070679309, 83120.58439707763, 14025.29873506341, 14048.690640642855, 14126.316521255403, 14414.351354188877, 14460.13239205651, 15634.609134771721, 15975.760363594323, 16099.517014489584, 16402.0, 16416.343346266494, 13735.175889446666, 13740.793888091886, 13754.170638703416, 13855.099418537762, 14082.366293516612, 14683.55949321522, 15067.397304107713, 15067.849321506645, 15247.923760381127, 15339.386424542894, 14473.0, 14636.853631463975, 14652.12087274767, 14693.779593305895, 14832.406703731729, 11244.718882028015, 11374.0, 11378.829317560077, 11532.135089868125, 11623.0, 12467.376631168225, 12538.811917821058, 12564.937175314066, 12716.745665086832, 13004.154729942524], "value": 8038.909557064683, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1506.5999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 107.0, 114.0, 112.0, 113.0, 112.0, 113.0, 111.0, 113.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 117.0, 150.0, 170.0, 117.0, 147.0, 148.0, 117.0, 179.0, 117.0], "value": 140.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 168.0, 164.0, 165.0, 163.0, 168.0, 163.0, 164.0, 162.0, 162.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 184.0, 76.0, 76.0, 75.0, 77.0, 173.0, 77.0], "value": 96.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 151.0, 84.0, 83.0, 84.0, 147.0, 84.0, 84.0, 152.0], "value": 103.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 117.0, 117.0, 118.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 148.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 51.0, 55.0, 51.0, 52.0, 54.0, 51.0, 50.0, 51.0], "value": 52.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 60.0, 61.0, 61.0, 59.0, 59.0, 61.0, 60.0, 61.0], "value": 60.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 75.0, 73.0, 82.0, 73.0, 82.0, 74.0, 73.0, 80.0], "value": 75.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 125.0, 122.0, 119.0, 122.0, 119.0, 129.0, 144.0, 153.0, 130.0], "value": 128.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 151.0, 158.0, 149.0, 153.0, 154.0, 151.0, 151.0, 150.0, 153.0], "value": 152.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 62.0, 63.0, 60.0, 61.0, 61.0, 64.0, 61.0], "value": 62.0, "unit": "score"}]}]} 04:17:05 INFO - Return code: 0 04:17:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:17:05 ERROR - # TBPL SUCCESS # 04:17:05 INFO - Running post-action listener: _resource_record_post_action 04:17:05 INFO - [mozharness: 2016-09-07 11:17:05.398106Z] Finished run-tests step (success) 04:17:05 INFO - Running post-run listener: _resource_record_post_run 04:17:05 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 270336; Write bytes: 327000064; Read time: 264; Write time: 253436 04:17:05 INFO - TinderboxPrint: CPU usage
13.3% 04:17:05 INFO - TinderboxPrint: I/O read bytes / time
270,336 / 264 04:17:05 INFO - TinderboxPrint: I/O write bytes / time
327,000,064 / 253,436 04:17:05 INFO - TinderboxPrint: CPU idle
8,221.5 (86.7%) 04:17:05 INFO - TinderboxPrint: CPU user
1,206.8 (12.7%) 04:17:05 INFO - TinderboxPrint: Swap in / out
0 / 0 04:17:05 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 79609856; Read time: 0; Write time: 105160 04:17:05 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 266240; Write bytes: 247013376; Read time: 244; Write time: 148204 04:17:06 INFO - Running post-run listener: _upload_blobber_files 04:17:06 INFO - Blob upload gear active. 04:17:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:17:06 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 04:17:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:17:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:17:06 INFO - (blobuploader) - INFO - Open directory for files ... 04:17:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:17:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:17:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:17:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:17:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:17:07 INFO - (blobuploader) - INFO - Done attempting. 04:17:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:17:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:17:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:17:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:17:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:17:16 INFO - (blobuploader) - INFO - Done attempting. 04:17:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:17:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:17:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:17:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:17:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:17:17 INFO - (blobuploader) - INFO - Done attempting. 04:17:17 INFO - (blobuploader) - INFO - Iteration through files over. 04:17:17 INFO - Return code: 0 04:17:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:17:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:17:17 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4bbcccb5c8bcf67913873fc7f4ea17eb4ddeec381d358cb767289d2ea84c31e813ebe6f7d567ccd7aff1d13c145966c7225cf090b522bb9390efb1cb62934523", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1f4d50580d1bf42434789eee9aa9d6e82a6c1f48200b6f06e1c34f73515cbdc2a6b3b2381e2b02aee5ad287e5bea8e76a0f8170665024cf44c65a9ba962ba803", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d2f43f294104e882f28d31f56c4026cff10021745ef1c64192fe9f4fff411bf3ee5dccc35b017d36d4469a28ff427345f8ed73764d590afb31c9dee436ffc51a"} 04:17:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:17:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:17:17 INFO - Contents: 04:17:17 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4bbcccb5c8bcf67913873fc7f4ea17eb4ddeec381d358cb767289d2ea84c31e813ebe6f7d567ccd7aff1d13c145966c7225cf090b522bb9390efb1cb62934523", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1f4d50580d1bf42434789eee9aa9d6e82a6c1f48200b6f06e1c34f73515cbdc2a6b3b2381e2b02aee5ad287e5bea8e76a0f8170665024cf44c65a9ba962ba803", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d2f43f294104e882f28d31f56c4026cff10021745ef1c64192fe9f4fff411bf3ee5dccc35b017d36d4469a28ff427345f8ed73764d590afb31c9dee436ffc51a"} 04:17:17 INFO - Running post-run listener: copy_logs_to_upload_dir 04:17:17 INFO - Copying logs to upload dir... 04:17:17 INFO - mkdir: /builds/slave/test/build/upload/logs 04:17:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1683.343972 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 3 secs) (at 2016-09-07 04:17:17.038117) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-07 04:17:17.041340) ========= 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=836cfdc75598d54cb747368e000001a9-1473245343.304993-160625666 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4bbcccb5c8bcf67913873fc7f4ea17eb4ddeec381d358cb767289d2ea84c31e813ebe6f7d567ccd7aff1d13c145966c7225cf090b522bb9390efb1cb62934523", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1f4d50580d1bf42434789eee9aa9d6e82a6c1f48200b6f06e1c34f73515cbdc2a6b3b2381e2b02aee5ad287e5bea8e76a0f8170665024cf44c65a9ba962ba803", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d2f43f294104e882f28d31f56c4026cff10021745ef1c64192fe9f4fff411bf3ee5dccc35b017d36d4469a28ff427345f8ed73764d590afb31c9dee436ffc51a"} build_url:https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011389 build_url: 'https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4bbcccb5c8bcf67913873fc7f4ea17eb4ddeec381d358cb767289d2ea84c31e813ebe6f7d567ccd7aff1d13c145966c7225cf090b522bb9390efb1cb62934523", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1f4d50580d1bf42434789eee9aa9d6e82a6c1f48200b6f06e1c34f73515cbdc2a6b3b2381e2b02aee5ad287e5bea8e76a0f8170665024cf44c65a9ba962ba803", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d2f43f294104e882f28d31f56c4026cff10021745ef1c64192fe9f4fff411bf3ee5dccc35b017d36d4469a28ff427345f8ed73764d590afb31c9dee436ffc51a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-07 04:17:17.066097) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 04:17:17.066381) ========= 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=836cfdc75598d54cb747368e000001a9-1473245343.304993-160625666 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004564 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 04:17:17.151439) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-07 04:17:17.151719) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-07 04:17:17.151995) ========= ========= Total master_lag: 0.16 =========