builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-058 starttime: 1474122008.43 results: success (0) buildid: 20160917004009 builduid: 39c0864104644d618a468a713b19f1a0 revision: b9499912b32324acd84792bf02b533b40e98e496 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-17 07:20:08.430682) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-17 07:20:08.431197) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-17 07:20:08.431483) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-17 07:20:08.445845) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-17 07:20:08.446136) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1474122008.673593-1028930911 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-17 07:20:09-- 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% 46.3M=0s 2016-09-17 07:20:09 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.252584 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-17 07:20:08.714470) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-17 07:20:08.715010) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1474122008.673593-1028930911 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019182 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-17 07:20:08.764785) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-17 07:20:08.765232) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b9499912b32324acd84792bf02b533b40e98e496 --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 b9499912b32324acd84792bf02b533b40e98e496 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1474122008.673593-1028930911 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-17 07:20:09,718 truncating revision to first 12 chars 2016-09-17 07:20:09,718 Setting DEBUG logging. 2016-09-17 07:20:09,719 attempt 1/10 2016-09-17 07:20:09,719 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b9499912b323?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-17 07:20:10,017 unpacking tar archive at: mozilla-aurora-b9499912b323/testing/mozharness/ program finished with exit code 0 elapsedTime=0.626943 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-17 07:20:09.407860) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-17 07:20:09.408212) ========= script_repo_revision: b9499912b32324acd84792bf02b533b40e98e496 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-17 07:20:09.408650) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-17 07:20:09.408925) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-17 07:20:09.535767) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 56 secs) (at 2016-09-17 07:20:09.536178) ========= /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=0e2a256762fed810e2f0f810000001b3-1474122008.673593-1028930911 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:20:10 INFO - MultiFileLogger online at 20160917 07:20:10 in /builds/slave/test 07:20:10 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 07:20:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:20:10 INFO - {'append_to_log': False, 07:20:10 INFO - 'base_work_dir': '/builds/slave/test', 07:20:10 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:20:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:20:10 INFO - 'branch': 'Mozilla-Aurora', 07:20:10 INFO - 'buildbot_json_path': 'buildprops.json', 07:20:10 INFO - 'config_files': ('talos/linux_config.py',), 07:20:10 INFO - 'default_actions': ('clobber', 07:20:10 INFO - 'read-buildbot-config', 07:20:10 INFO - 'download-and-extract', 07:20:10 INFO - 'populate-webroot', 07:20:10 INFO - 'create-virtualenv', 07:20:10 INFO - 'install', 07:20:10 INFO - 'run-tests'), 07:20:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:20:10 INFO - 'download_minidump_stackwalk': True, 07:20:10 INFO - 'download_symbols': 'ondemand', 07:20:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:20:10 INFO - 'tooltool.py': '/tools/tooltool.py', 07:20:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:20:10 INFO - '/tools/misc-python/virtualenv.py')}, 07:20:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:20:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:20:10 INFO - 'installer_path': 'installer.exe', 07:20:10 INFO - 'log_level': 'info', 07:20:10 INFO - 'log_name': 'talos', 07:20:10 INFO - 'log_to_console': True, 07:20:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:20:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:20:10 INFO - 'opt_config_files': (), 07:20:10 INFO - 'pip_index': False, 07:20:10 INFO - 'sps_profile': False, 07:20:10 INFO - 'sps_profile_interval': 0, 07:20:10 INFO - 'suite': 'dromaeojs-e10s', 07:20:10 INFO - 'system_bits': '32', 07:20:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:20:10 INFO - 'title': 'talos-linux64-ix-058', 07:20:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:20:10 INFO - 'use_talos_json': True, 07:20:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:20:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:20:10 INFO - 'work_dir': 'build'} 07:20:10 INFO - [mozharness: 2016-09-17 14:20:10.583679Z] Running clobber step. 07:20:10 INFO - Running pre-action listener: _resource_record_pre_action 07:20:10 INFO - Running main action method: clobber 07:20:10 INFO - rmtree: /builds/slave/test/build 07:20:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:20:11 INFO - Running post-action listener: _resource_record_post_action 07:20:11 INFO - [mozharness: 2016-09-17 14:20:11.582237Z] Finished clobber step (success) 07:20:11 INFO - [mozharness: 2016-09-17 14:20:11.582338Z] Running read-buildbot-config step. 07:20:11 INFO - Running pre-action listener: _resource_record_pre_action 07:20:11 INFO - Running main action method: read_buildbot_config 07:20:11 INFO - Using buildbot properties: 07:20:11 INFO - { 07:20:11 INFO - "project": "", 07:20:11 INFO - "product": "firefox", 07:20:11 INFO - "script_repo_revision": "production", 07:20:11 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 07:20:11 INFO - "repository": "", 07:20:11 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 07:20:11 INFO - "buildid": "20160917004009", 07:20:11 INFO - "stage_platform": "linux64-pgo", 07:20:11 INFO - "basedir": "/builds/slave/test", 07:20:11 INFO - "nightly_build": "True", 07:20:11 INFO - "buildnumber": 509, 07:20:11 INFO - "slavename": "talos-linux64-ix-058", 07:20:11 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:20:11 INFO - "platform": "ubuntu64_hw", 07:20:11 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 07:20:11 INFO - "branch": "mozilla-aurora", 07:20:11 INFO - "repo_path": "releases/mozilla-aurora", 07:20:11 INFO - "revision": "b9499912b32324acd84792bf02b533b40e98e496", 07:20:11 INFO - "pgo_build": "True", 07:20:11 INFO - "builduid": "39c0864104644d618a468a713b19f1a0", 07:20:11 INFO - "slavebuilddir": "test" 07:20:11 INFO - } 07:20:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 07:20:11 INFO - Running post-action listener: _resource_record_post_action 07:20:11 INFO - [mozharness: 2016-09-17 14:20:11.585180Z] Finished read-buildbot-config step (success) 07:20:11 INFO - [mozharness: 2016-09-17 14:20:11.585269Z] Running download-and-extract step. 07:20:11 INFO - Running pre-action listener: _resource_record_pre_action 07:20:11 INFO - Running main action method: download_and_extract 07:20:11 INFO - mkdir: /builds/slave/test/build/tests 07:20: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')]} 07:20:11 INFO - https://queue.taskcluster.net/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:20:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 07:20:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 07:20:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:20:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:20:11 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 07:20:11 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 07:20:11 INFO - retry: Failed, sleeping 30 seconds before retrying 07:20:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:20:41 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 07:20:41 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 07:20:41 INFO - retry: Failed, sleeping 60 seconds before retrying 07:21:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:21:41 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 07:21:41 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 07:21:41 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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! 07:21:41 INFO - Caught exception: HTTP Error 404: Not Found 07:21:41 INFO - Caught exception: HTTP Error 404: Not Found 07:21:41 INFO - Caught exception: HTTP Error 404: Not Found 07:21:41 INFO - trying https://queue.taskcluster.net/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 07:21:41 INFO - Downloading https://queue.taskcluster.net/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:21:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:21:42 INFO - Downloaded 1361 bytes. 07:21:42 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 07:21:42 INFO - Using the following test package requirements: 07:21:42 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 07:21:42 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 07:21:42 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 07:21:42 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 07:21:42 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 07:21:42 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 07:21:42 INFO - u'jsshell-linux-x86_64.zip'], 07:21:42 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 07:21:42 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 07:21:42 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 07:21:42 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 07:21:42 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 07:21:42 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 07:21:42 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 07:21:42 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 07:21:42 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 07:21:42 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 07:21:42 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 07:21:42 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:21:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:21:42 INFO - https://queue.taskcluster.net/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:21:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 07:21:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 07:21:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:21:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:21:42 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 07:21:42 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 07:21:42 INFO - retry: Failed, sleeping 30 seconds before retrying 07:22:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:22:12 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 07:22:12 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 07:22:12 INFO - retry: Failed, sleeping 60 seconds before retrying 07:23:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:23:12 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 07:23:12 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 07:23:12 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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! 07:23:12 INFO - Caught exception: HTTP Error 404: Not Found 07:23:12 INFO - Caught exception: HTTP Error 404: Not Found 07:23:12 INFO - Caught exception: HTTP Error 404: Not Found 07:23:12 INFO - trying https://queue.taskcluster.net/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 07:23:12 INFO - Downloading https://queue.taskcluster.net/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:23:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:23:13 INFO - Downloaded 21771059 bytes. 07:23:13 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'] 07:23:13 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 07:23:14 INFO - Return code: 0 07:23:14 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 07:23: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')]} 07:23:14 INFO - https://queue.taskcluster.net/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:23:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 07:23:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 07:23:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:23:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:23:14 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 07:23:14 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 07:23:14 INFO - retry: Failed, sleeping 30 seconds before retrying 07:23:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:23:44 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 07:23:44 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 07:23:44 INFO - retry: Failed, sleeping 60 seconds before retrying 07:24:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:24:44 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 07:24:44 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 07:24:44 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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! 07:24:44 INFO - Caught exception: HTTP Error 404: Not Found 07:24:44 INFO - Caught exception: HTTP Error 404: Not Found 07:24:44 INFO - Caught exception: HTTP Error 404: Not Found 07:24:44 INFO - trying https://queue.taskcluster.net/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 07:24:44 INFO - Downloading https://queue.taskcluster.net/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:24:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:24:45 INFO - Downloaded 21771059 bytes. 07:24:45 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'] 07:24:45 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 07:24:46 INFO - Return code: 0 07:24: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')]} 07:24:46 INFO - https://queue.taskcluster.net/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:24:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 07:24:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 07:24:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:24:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:24:46 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 07:24:46 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 07:24:46 INFO - retry: Failed, sleeping 30 seconds before retrying 07:25:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:25:16 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 07:25:16 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 07:25:16 INFO - retry: Failed, sleeping 60 seconds before retrying 07:26:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:26:16 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 07:26:16 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 07:26:16 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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! 07:26:16 INFO - Caught exception: HTTP Error 404: Not Found 07:26:16 INFO - Caught exception: HTTP Error 404: Not Found 07:26:16 INFO - Caught exception: HTTP Error 404: Not Found 07:26:16 INFO - trying https://queue.taskcluster.net/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 07:26:16 INFO - Downloading https://queue.taskcluster.net/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:26:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:26:17 INFO - Downloaded 14413740 bytes. 07:26:17 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'] 07:26:17 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 07:26:17 INFO - Return code: 0 07:26:17 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')]} 07:26:17 INFO - https://queue.taskcluster.net/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:26:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 07:26:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 07:26:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:26:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:26:17 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 07:26:17 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 07:26:17 INFO - retry: Failed, sleeping 30 seconds before retrying 07:26:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:26:47 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 07:26:47 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 07:26:47 INFO - retry: Failed, sleeping 60 seconds before retrying 07:27:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:27:47 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 07:27:47 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 07:27:47 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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! 07:27:47 INFO - Caught exception: HTTP Error 404: Not Found 07:27:47 INFO - Caught exception: HTTP Error 404: Not Found 07:27:47 INFO - Caught exception: HTTP Error 404: Not Found 07:27:47 INFO - trying https://queue.taskcluster.net/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 07:27:47 INFO - Downloading https://queue.taskcluster.net/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:27:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:27:49 INFO - Downloaded 63891050 bytes. 07:27:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 07:27:49 INFO - mkdir: /builds/slave/test/properties 07:27:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:27:49 INFO - Writing to file /builds/slave/test/properties/build_url 07:27:49 INFO - Contents: 07:27:49 INFO - build_url:https://queue.taskcluster.net/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 07:27:49 INFO - Running post-action listener: _resource_record_post_action 07:27:49 INFO - Running post-action listener: set_extra_try_arguments 07:27:49 INFO - [mozharness: 2016-09-17 14:27:49.813478Z] Finished download-and-extract step (success) 07:27:49 INFO - [mozharness: 2016-09-17 14:27:49.813710Z] Running populate-webroot step. 07:27:49 INFO - Running pre-action listener: _resource_record_pre_action 07:27:49 INFO - Running main action method: populate_webroot 07:27:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:27:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:27:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:27:49 INFO - '--tppagecycles', 07:27:49 INFO - '7'], 07:27:49 INFO - 'tests': ['tsvgm']}}, 07:27:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:27:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:27:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:27:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:27:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:27:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:27:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:49 INFO - 'talos_options': ['--disable-e10s'], 07:27:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:27:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:27:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:49 INFO - 'talos_options': ['--disable-e10s'], 07:27:49 INFO - 'tests': ['damp', 'tps']}, 07:27:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:49 INFO - 'tests': ['damp', 'tps']}, 07:27:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:27:49 INFO - 'tests': ['dromaeo_dom']}, 07:27:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:27:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:27:49 INFO - 'tests': ['basic_compositor_video']}, 07:27:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:27:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:27:49 INFO - 'tests': ['a11yr', 07:27:49 INFO - 'ts_paint', 07:27:49 INFO - 'tpaint', 07:27:49 INFO - 'sessionrestore', 07:27:49 INFO - 'sessionrestore_no_auto_restore', 07:27:49 INFO - 'tabpaint']}, 07:27:49 INFO - 'other-e10s': {'tests': ['a11yr', 07:27:49 INFO - 'ts_paint', 07:27:49 INFO - 'tpaint', 07:27:49 INFO - 'sessionrestore', 07:27:49 INFO - 'sessionrestore_no_auto_restore', 07:27:49 INFO - 'tabpaint']}, 07:27:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:27:49 INFO - 'ts_paint', 07:27:49 INFO - 'tpaint', 07:27:49 INFO - 'sessionrestore', 07:27:49 INFO - 'sessionrestore_no_auto_restore', 07:27:49 INFO - 'tabpaint']}, 07:27:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:27:49 INFO - 'ts_paint', 07:27:49 INFO - 'tpaint', 07:27:49 INFO - 'sessionrestore', 07:27:49 INFO - 'sessionrestore_no_auto_restore', 07:27:49 INFO - 'tabpaint']}, 07:27:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:27:49 INFO - 'tests': ['a11yr', 07:27:49 INFO - 'ts_paint', 07:27:49 INFO - 'tpaint', 07:27:49 INFO - 'sessionrestore', 07:27:49 INFO - 'sessionrestore_no_auto_restore', 07:27:49 INFO - 'tabpaint']}, 07:27:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:27:49 INFO - 'tests': ['a11yr', 07:27:49 INFO - 'ts_paint', 07:27:49 INFO - 'tpaint', 07:27:49 INFO - 'sessionrestore', 07:27:49 INFO - 'sessionrestore_no_auto_restore', 07:27:49 INFO - 'tabpaint']}, 07:27:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:27:49 INFO - 'tests': ['tsvgx', 07:27:49 INFO - 'tsvgr_opacity', 07:27:49 INFO - 'tart', 07:27:49 INFO - 'tscrollx', 07:27:49 INFO - 'cart']}, 07:27:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:27:49 INFO - 'tsvgr_opacity', 07:27:49 INFO - 'tart', 07:27:49 INFO - 'tscrollx', 07:27:49 INFO - 'cart']}, 07:27:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:49 INFO - 'talos_options': ['--disable-e10s'], 07:27:49 INFO - 'tests': ['tp5o']}, 07:27:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:49 INFO - 'tests': ['tp5o']}, 07:27:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:49 INFO - 'talos_options': ['--disable-e10s', 07:27:49 INFO - '--xperf_path', 07:27:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:27:49 INFO - 'tests': ['tp5n']}, 07:27:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:49 INFO - 'talos_options': ['--xperf_path', 07:27:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:27:49 INFO - 'tests': ['tp5n']}}, 07:27:49 INFO - 'talos.zip': {'path': '', 07:27:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:27:49 INFO - Running post-action listener: _resource_record_post_action 07:27:49 INFO - [mozharness: 2016-09-17 14:27:49.832625Z] Finished populate-webroot step (success) 07:27:49 INFO - [mozharness: 2016-09-17 14:27:49.832714Z] Running create-virtualenv step. 07:27:49 INFO - Running pre-action listener: _resource_record_pre_action 07:27:49 INFO - Running main action method: create_virtualenv 07:27:49 INFO - Creating virtualenv /builds/slave/test/build/venv 07:27:49 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 07:27:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:27:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:27:49 INFO - Using real prefix '/usr' 07:27:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:27:50 INFO - Installing distribute.............................................................................................................................................................................................done. 07:27:52 INFO - Installing pip.................done. 07:27:52 INFO - Return code: 0 07:27:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:27:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e6400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1375570>, '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 0x1376470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1376900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474122008.673593-1028930911', '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 07:27:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:27:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:27:52 INFO - Using env: {'DISPLAY': ':0', 07:27:52 INFO - 'HOME': '/home/cltbld', 07:27:52 INFO - 'LANG': 'en_US.UTF-8', 07:27:52 INFO - 'LANGUAGE': 'en_US:en', 07:27:52 INFO - 'LOGNAME': 'cltbld', 07:27:52 INFO - 'MAIL': '/var/mail/cltbld', 07:27:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:52 INFO - 'MOZ_NO_REMOTE': '1', 07:27:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:52 INFO - 'NO_EM_RESTART': '1', 07:27:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:52 INFO - 'PWD': '/builds/slave/test', 07:27:52 INFO - 'SHELL': '/bin/bash', 07:27:52 INFO - 'SHLVL': '1', 07:27:52 INFO - 'TERM': 'linux', 07:27:52 INFO - 'TMOUT': '86400', 07:27:52 INFO - 'USER': 'cltbld', 07:27:52 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474122008.673593-1028930911', 07:27:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:52 INFO - '_': '/tools/buildbot/bin/python'} 07:27:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:52 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 07:27:52 INFO - Cleaning up... 07:27:52 INFO - Return code: 0 07:27:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:27:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e6400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1375570>, '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 0x1376470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1376900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474122008.673593-1028930911', '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 07:27:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:27:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:27:52 INFO - Using env: {'DISPLAY': ':0', 07:27:52 INFO - 'HOME': '/home/cltbld', 07:27:52 INFO - 'LANG': 'en_US.UTF-8', 07:27:52 INFO - 'LANGUAGE': 'en_US:en', 07:27:52 INFO - 'LOGNAME': 'cltbld', 07:27:52 INFO - 'MAIL': '/var/mail/cltbld', 07:27:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:52 INFO - 'MOZ_NO_REMOTE': '1', 07:27:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:52 INFO - 'NO_EM_RESTART': '1', 07:27:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:52 INFO - 'PWD': '/builds/slave/test', 07:27:52 INFO - 'SHELL': '/bin/bash', 07:27:52 INFO - 'SHLVL': '1', 07:27:52 INFO - 'TERM': 'linux', 07:27:52 INFO - 'TMOUT': '86400', 07:27:52 INFO - 'USER': 'cltbld', 07:27:52 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474122008.673593-1028930911', 07:27:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:52 INFO - '_': '/tools/buildbot/bin/python'} 07:27:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:52 INFO - Downloading/unpacking psutil>=3.1.1 07:27:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:27:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:27:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:27:54 INFO - Installing collected packages: psutil 07:27:54 INFO - Running setup.py install for psutil 07:27:54 INFO - building 'psutil._psutil_linux' extension 07:27:54 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 07:27:55 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 07:27:55 INFO - building 'psutil._psutil_posix' extension 07:27:55 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 07:27:55 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 07:27:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:27:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:27:55 INFO - Successfully installed psutil 07:27:55 INFO - Cleaning up... 07:27:55 INFO - Return code: 0 07:27:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:27:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e6400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1375570>, '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 0x1376470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1376900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474122008.673593-1028930911', '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 07:27:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:27:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:27:55 INFO - Using env: {'DISPLAY': ':0', 07:27:55 INFO - 'HOME': '/home/cltbld', 07:27:55 INFO - 'LANG': 'en_US.UTF-8', 07:27:55 INFO - 'LANGUAGE': 'en_US:en', 07:27:55 INFO - 'LOGNAME': 'cltbld', 07:27:55 INFO - 'MAIL': '/var/mail/cltbld', 07:27:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:55 INFO - 'MOZ_NO_REMOTE': '1', 07:27:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:55 INFO - 'NO_EM_RESTART': '1', 07:27:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:55 INFO - 'PWD': '/builds/slave/test', 07:27:55 INFO - 'SHELL': '/bin/bash', 07:27:55 INFO - 'SHLVL': '1', 07:27:55 INFO - 'TERM': 'linux', 07:27:55 INFO - 'TMOUT': '86400', 07:27:55 INFO - 'USER': 'cltbld', 07:27:55 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474122008.673593-1028930911', 07:27:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:55 INFO - '_': '/tools/buildbot/bin/python'} 07:27:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:27:55 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 07:27:55 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 07:27:55 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 07:27:55 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 07:27:55 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 07:27:55 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 07:27:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:27:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:27:57 INFO - Installing collected packages: mozsystemmonitor 07:27:57 INFO - Running setup.py install for mozsystemmonitor 07:27:57 INFO - Successfully installed mozsystemmonitor 07:27:57 INFO - Cleaning up... 07:27:57 INFO - Return code: 0 07:27:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:27:57 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')]} 07:27:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:57 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')]} 07:27:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:57 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 0x10b7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e6400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1375570>, '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 0x1376470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1376900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474122008.673593-1028930911', '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 07:27:57 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 07:27:57 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 07:27:57 INFO - Using env: {'DISPLAY': ':0', 07:27:57 INFO - 'HOME': '/home/cltbld', 07:27:57 INFO - 'LANG': 'en_US.UTF-8', 07:27:57 INFO - 'LANGUAGE': 'en_US:en', 07:27:57 INFO - 'LOGNAME': 'cltbld', 07:27:57 INFO - 'MAIL': '/var/mail/cltbld', 07:27:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:57 INFO - 'MOZ_NO_REMOTE': '1', 07:27:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:57 INFO - 'NO_EM_RESTART': '1', 07:27:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:57 INFO - 'PWD': '/builds/slave/test', 07:27:57 INFO - 'SHELL': '/bin/bash', 07:27:57 INFO - 'SHLVL': '1', 07:27:57 INFO - 'TERM': 'linux', 07:27:57 INFO - 'TMOUT': '86400', 07:27:57 INFO - 'USER': 'cltbld', 07:27:57 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474122008.673593-1028930911', 07:27:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:57 INFO - '_': '/tools/buildbot/bin/python'} 07:27:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:57 INFO - Downloading/unpacking jsonschema==2.5.1 07:27:57 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 07:27:57 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 07:27:57 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 07:27:57 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 07:27:57 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 07:27:57 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 07:27:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:27:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:27: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 07:27: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 07:27: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 07:27: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 07:27: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 07:27: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 07:28:00 INFO - Downloading functools32-3.2.3-2.tar.gz 07:28:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:28:00 INFO - warning: no files found matching '*.txt' 07:28:00 INFO - no previously-included directories found matching 'build' 07:28:00 INFO - no previously-included directories found matching 'dist' 07:28:00 INFO - no previously-included directories found matching '.git*' 07:28:00 INFO - Installing collected packages: jsonschema, functools32 07:28:00 INFO - Running setup.py install for functools32 07:28:00 INFO - warning: no files found matching '*.txt' 07:28:00 INFO - no previously-included directories found matching 'build' 07:28:00 INFO - no previously-included directories found matching 'dist' 07:28:00 INFO - no previously-included directories found matching '.git*' 07:28:00 INFO - Successfully installed jsonschema functools32 07:28:00 INFO - Cleaning up... 07:28:00 INFO - Return code: 0 07:28:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:28:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e6400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1375570>, '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 0x1376470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1376900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474122008.673593-1028930911', '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 07:28:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:28:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:28:00 INFO - Using env: {'DISPLAY': ':0', 07:28:00 INFO - 'HOME': '/home/cltbld', 07:28:00 INFO - 'LANG': 'en_US.UTF-8', 07:28:00 INFO - 'LANGUAGE': 'en_US:en', 07:28:00 INFO - 'LOGNAME': 'cltbld', 07:28:00 INFO - 'MAIL': '/var/mail/cltbld', 07:28:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:00 INFO - 'MOZ_NO_REMOTE': '1', 07:28:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:00 INFO - 'NO_EM_RESTART': '1', 07:28:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:00 INFO - 'PWD': '/builds/slave/test', 07:28:00 INFO - 'SHELL': '/bin/bash', 07:28:00 INFO - 'SHLVL': '1', 07:28:00 INFO - 'TERM': 'linux', 07:28:00 INFO - 'TMOUT': '86400', 07:28:00 INFO - 'USER': 'cltbld', 07:28:00 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474122008.673593-1028930911', 07:28:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:00 INFO - '_': '/tools/buildbot/bin/python'} 07:28:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:28:00 INFO - Cleaning up... 07:28:00 INFO - Return code: 0 07:28:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:28:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e6400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1375570>, '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 0x1376470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1376900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474122008.673593-1028930911', '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 07:28:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:28:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:28:00 INFO - Using env: {'DISPLAY': ':0', 07:28:00 INFO - 'HOME': '/home/cltbld', 07:28:00 INFO - 'LANG': 'en_US.UTF-8', 07:28:00 INFO - 'LANGUAGE': 'en_US:en', 07:28:00 INFO - 'LOGNAME': 'cltbld', 07:28:00 INFO - 'MAIL': '/var/mail/cltbld', 07:28:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:00 INFO - 'MOZ_NO_REMOTE': '1', 07:28:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:00 INFO - 'NO_EM_RESTART': '1', 07:28:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:00 INFO - 'PWD': '/builds/slave/test', 07:28:00 INFO - 'SHELL': '/bin/bash', 07:28:00 INFO - 'SHLVL': '1', 07:28:00 INFO - 'TERM': 'linux', 07:28:00 INFO - 'TMOUT': '86400', 07:28:00 INFO - 'USER': 'cltbld', 07:28:00 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474122008.673593-1028930911', 07:28:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:00 INFO - '_': '/tools/buildbot/bin/python'} 07:28:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:00 INFO - Downloading/unpacking blobuploader==1.2.4 07:28:00 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 07:28:00 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 07:28:00 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 07:28:00 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 07:28:00 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 07:28:00 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 07:28:02 INFO - Downloading blobuploader-1.2.4.tar.gz 07:28:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:28:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:28:02 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 07:28:02 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 07:28:02 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 07:28:02 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 07:28:02 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 07:28:02 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 07:28:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:28:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:28: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 07:28: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 07:28: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 07:28: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 07:28: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 07:28: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 07:28:03 INFO - Downloading docopt-0.6.1.tar.gz 07:28:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:28:03 INFO - Installing collected packages: blobuploader, requests, docopt 07:28:03 INFO - Running setup.py install for blobuploader 07:28:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:28:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:28:03 INFO - Running setup.py install for requests 07:28:03 INFO - Running setup.py install for docopt 07:28:03 INFO - Successfully installed blobuploader requests docopt 07:28:03 INFO - Cleaning up... 07:28:04 INFO - Return code: 0 07:28:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:28:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:04 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 0x10b7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e6400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1375570>, '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 0x1376470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1376900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474122008.673593-1028930911', '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 07:28:04 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 07:28:04 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 07:28:04 INFO - Using env: {'DISPLAY': ':0', 07:28:04 INFO - 'HOME': '/home/cltbld', 07:28:04 INFO - 'LANG': 'en_US.UTF-8', 07:28:04 INFO - 'LANGUAGE': 'en_US:en', 07:28:04 INFO - 'LOGNAME': 'cltbld', 07:28:04 INFO - 'MAIL': '/var/mail/cltbld', 07:28:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:04 INFO - 'MOZ_NO_REMOTE': '1', 07:28:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:04 INFO - 'NO_EM_RESTART': '1', 07:28:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:04 INFO - 'PWD': '/builds/slave/test', 07:28:04 INFO - 'SHELL': '/bin/bash', 07:28:04 INFO - 'SHLVL': '1', 07:28:04 INFO - 'TERM': 'linux', 07:28:04 INFO - 'TMOUT': '86400', 07:28:04 INFO - 'USER': 'cltbld', 07:28:04 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474122008.673593-1028930911', 07:28:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:04 INFO - '_': '/tools/buildbot/bin/python'} 07:28:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:28:04 INFO - Running setup.py (path:/tmp/pip-DIePLB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:28:04 INFO - Running setup.py (path:/tmp/pip-bmW223-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:28:04 INFO - Running setup.py (path:/tmp/pip-zuF_sL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:28:04 INFO - Running setup.py (path:/tmp/pip-EXsaB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:28:04 INFO - Running setup.py (path:/tmp/pip-mgWIBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:28:04 INFO - Running setup.py (path:/tmp/pip-A2fb9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:28:04 INFO - Running setup.py (path:/tmp/pip-Yvyq1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:28:04 INFO - Running setup.py (path:/tmp/pip-PK62pe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:28:04 INFO - Running setup.py (path:/tmp/pip-Dj7qXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:28:04 INFO - Running setup.py (path:/tmp/pip-y_gqtz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:28:04 INFO - Running setup.py (path:/tmp/pip-Ef1ySU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:28:05 INFO - Running setup.py (path:/tmp/pip-EAUusB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:28:05 INFO - Running setup.py (path:/tmp/pip-8jRIy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:28:05 INFO - Running setup.py (path:/tmp/pip-kMfqli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:28:05 INFO - Running setup.py (path:/tmp/pip-B6X5EA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:28:05 INFO - Running setup.py (path:/tmp/pip-LomwZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:28:05 INFO - Running setup.py (path:/tmp/pip-VTpPMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:28:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:28:05 INFO - Running setup.py install for manifestparser 07:28:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:28:05 INFO - Running setup.py install for mozcrash 07:28:05 INFO - Running setup.py install for mozdebug 07:28:05 INFO - Running setup.py install for mozdevice 07:28:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:28:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:28:05 INFO - Running setup.py install for mozfile 07:28:06 INFO - Running setup.py install for mozhttpd 07:28:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:28:06 INFO - Running setup.py install for mozinfo 07:28:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:28:06 INFO - Running setup.py install for mozInstall 07:28:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:28:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:28:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:28:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:28:06 INFO - Running setup.py install for mozleak 07:28:06 INFO - Running setup.py install for mozlog 07:28:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:28:06 INFO - Running setup.py install for moznetwork 07:28:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:28:06 INFO - Running setup.py install for mozprocess 07:28:06 INFO - Running setup.py install for mozprofile 07:28:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:28:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:28:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:28:06 INFO - Running setup.py install for mozrunner 07:28:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:28:06 INFO - Running setup.py install for mozscreenshot 07:28:07 INFO - Running setup.py install for moztest 07:28:07 INFO - Running setup.py install for mozversion 07:28:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:28:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:28:07 INFO - Cleaning up... 07:28:07 INFO - Return code: 0 07:28:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:28:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:07 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 0x10b7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e6400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1375570>, '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 0x1376470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1376900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474122008.673593-1028930911', '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 07:28:07 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 07:28:07 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 07:28:07 INFO - Using env: {'DISPLAY': ':0', 07:28:07 INFO - 'HOME': '/home/cltbld', 07:28:07 INFO - 'LANG': 'en_US.UTF-8', 07:28:07 INFO - 'LANGUAGE': 'en_US:en', 07:28:07 INFO - 'LOGNAME': 'cltbld', 07:28:07 INFO - 'MAIL': '/var/mail/cltbld', 07:28:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:07 INFO - 'MOZ_NO_REMOTE': '1', 07:28:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:07 INFO - 'NO_EM_RESTART': '1', 07:28:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:07 INFO - 'PWD': '/builds/slave/test', 07:28:07 INFO - 'SHELL': '/bin/bash', 07:28:07 INFO - 'SHLVL': '1', 07:28:07 INFO - 'TERM': 'linux', 07:28:07 INFO - 'TMOUT': '86400', 07:28:07 INFO - 'USER': 'cltbld', 07:28:07 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474122008.673593-1028930911', 07:28:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:07 INFO - '_': '/tools/buildbot/bin/python'} 07:28:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:28:07 INFO - Running setup.py (path:/tmp/pip-Isxwk5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:28:07 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)) 07:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:28:07 INFO - Running setup.py (path:/tmp/pip-ZIq_nU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:28:07 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)) 07:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:28:07 INFO - Running setup.py (path:/tmp/pip-RjsV_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:28:07 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)) 07:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:28:07 INFO - Running setup.py (path:/tmp/pip-vxs0Tc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:28:07 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)) 07:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:28:07 INFO - Running setup.py (path:/tmp/pip-fUJsd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:28:07 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)) 07:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:28:07 INFO - Running setup.py (path:/tmp/pip-DFySOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:28:07 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)) 07:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:28:07 INFO - Running setup.py (path:/tmp/pip-vDMaqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:28:08 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)) 07:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:28:08 INFO - Running setup.py (path:/tmp/pip-DWbMu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:28:08 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)) 07:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:28:08 INFO - Running setup.py (path:/tmp/pip-tzO1oH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:28:08 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)) 07:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:28:08 INFO - Running setup.py (path:/tmp/pip-Eq_V8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:28:08 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)) 07:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:28:08 INFO - Running setup.py (path:/tmp/pip-P4P4TJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:28:08 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)) 07:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:28:08 INFO - Running setup.py (path:/tmp/pip-3fz8cO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:28:08 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)) 07:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:28:08 INFO - Running setup.py (path:/tmp/pip-cd9v3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:28:08 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)) 07:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:28:08 INFO - Running setup.py (path:/tmp/pip-y7VD3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:28:08 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)) 07:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:28:08 INFO - Running setup.py (path:/tmp/pip-tKPvYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:28:08 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)) 07:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:28:08 INFO - Running setup.py (path:/tmp/pip-leoNlm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:28:08 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)) 07:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:28:08 INFO - Running setup.py (path:/tmp/pip-5XBRzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:28:08 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)) 07:28:08 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)) 07:28:08 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)) 07:28:08 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)) 07:28:08 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)) 07:28:08 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)) 07:28:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:28:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:10 INFO - Downloading blessings-1.6.tar.gz 07:28:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:28:10 INFO - Installing collected packages: blessings 07:28:10 INFO - Running setup.py install for blessings 07:28:10 INFO - Successfully installed blessings 07:28:10 INFO - Cleaning up... 07:28:10 INFO - Return code: 0 07:28:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:28:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:28:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:28:11 INFO - Reading from file tmpfile_stdout 07:28:11 INFO - Current package versions: 07:28:11 INFO - argparse == 1.2.1 07:28:11 INFO - blessings == 1.6 07:28:11 INFO - blobuploader == 1.2.4 07:28:11 INFO - docopt == 0.6.1 07:28:11 INFO - functools32 == 3.2.3-2 07:28:11 INFO - jsonschema == 2.5.1 07:28:11 INFO - manifestparser == 1.1 07:28:11 INFO - mozInstall == 1.12 07:28:11 INFO - mozcrash == 0.17 07:28:11 INFO - mozdebug == 0.1 07:28:11 INFO - mozdevice == 0.48 07:28:11 INFO - mozfile == 1.2 07:28:11 INFO - mozhttpd == 0.7 07:28:11 INFO - mozinfo == 0.9 07:28:11 INFO - mozleak == 0.1 07:28:11 INFO - mozlog == 3.3 07:28:11 INFO - moznetwork == 0.27 07:28:11 INFO - mozprocess == 0.23 07:28:11 INFO - mozprofile == 0.28 07:28:11 INFO - mozrunner == 6.12 07:28:11 INFO - mozscreenshot == 0.1 07:28:11 INFO - mozsystemmonitor == 0.3 07:28:11 INFO - moztest == 0.7 07:28:11 INFO - mozversion == 1.4 07:28:11 INFO - psutil == 3.1.1 07:28:11 INFO - requests == 1.2.3 07:28:11 INFO - wsgiref == 0.1.2 07:28:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:28: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')]} 07:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28: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')]} 07:28:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:11 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 0x10b7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e6400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1375570>, '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 0x1376470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1376900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474122008.673593-1028930911', '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 07:28:11 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 07:28:11 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 07:28:11 INFO - Using env: {'DISPLAY': ':0', 07:28:11 INFO - 'HOME': '/home/cltbld', 07:28:11 INFO - 'LANG': 'en_US.UTF-8', 07:28:11 INFO - 'LANGUAGE': 'en_US:en', 07:28:11 INFO - 'LOGNAME': 'cltbld', 07:28:11 INFO - 'MAIL': '/var/mail/cltbld', 07:28:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:11 INFO - 'MOZ_NO_REMOTE': '1', 07:28:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:11 INFO - 'NO_EM_RESTART': '1', 07:28:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:11 INFO - 'PWD': '/builds/slave/test', 07:28:11 INFO - 'SHELL': '/bin/bash', 07:28:11 INFO - 'SHLVL': '1', 07:28:11 INFO - 'TERM': 'linux', 07:28:11 INFO - 'TMOUT': '86400', 07:28:11 INFO - 'USER': 'cltbld', 07:28:11 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474122008.673593-1028930911', 07:28:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:11 INFO - '_': '/tools/buildbot/bin/python'} 07:28:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:11 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)) 07:28:11 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)) 07:28:11 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)) 07:28:11 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)) 07:28:11 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)) 07:28:11 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)) 07:28:11 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)) 07:28:11 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)) 07:28:11 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)) 07:28:11 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)) 07:28:11 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)) 07:28:11 INFO - Cleaning up... 07:28:11 INFO - Return code: 0 07:28:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:28: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')]} 07:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28: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')]} 07:28:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:11 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 0x10b7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e6400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1375570>, '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 0x1376470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1376900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474122008.673593-1028930911', '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 07:28:11 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 07:28:11 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 07:28:11 INFO - Using env: {'DISPLAY': ':0', 07:28:11 INFO - 'HOME': '/home/cltbld', 07:28:11 INFO - 'LANG': 'en_US.UTF-8', 07:28:11 INFO - 'LANGUAGE': 'en_US:en', 07:28:11 INFO - 'LOGNAME': 'cltbld', 07:28:11 INFO - 'MAIL': '/var/mail/cltbld', 07:28:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:11 INFO - 'MOZ_NO_REMOTE': '1', 07:28:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:11 INFO - 'NO_EM_RESTART': '1', 07:28:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:11 INFO - 'PWD': '/builds/slave/test', 07:28:11 INFO - 'SHELL': '/bin/bash', 07:28:11 INFO - 'SHLVL': '1', 07:28:11 INFO - 'TERM': 'linux', 07:28:11 INFO - 'TMOUT': '86400', 07:28:11 INFO - 'USER': 'cltbld', 07:28:11 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474122008.673593-1028930911', 07:28:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:11 INFO - '_': '/tools/buildbot/bin/python'} 07:28:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:28:11 INFO - Cleaning up... 07:28:11 INFO - Return code: 0 07:28:11 INFO - Running post-action listener: _resource_record_post_action 07:28:11 INFO - Running post-action listener: _start_resource_monitoring 07:28:11 INFO - Starting resource monitoring. 07:28:11 INFO - [mozharness: 2016-09-17 14:28:11.593937Z] Finished create-virtualenv step (success) 07:28:11 INFO - [mozharness: 2016-09-17 14:28:11.594362Z] Running install step. 07:28:11 INFO - Running pre-action listener: _resource_record_pre_action 07:28:11 INFO - Running main action method: install 07:28:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:28:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:28:11 INFO - Reading from file tmpfile_stdout 07:28:11 INFO - Detecting whether we're running mozinstall >=1.0... 07:28:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:28:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:28:11 INFO - Reading from file tmpfile_stdout 07:28:11 INFO - Output received: 07:28:11 INFO - Usage: mozinstall [options] installer 07:28:11 INFO - Options: 07:28:11 INFO - -h, --help show this help message and exit 07:28:11 INFO - -d DEST, --destination=DEST 07:28:11 INFO - Directory to install application into. [default: 07:28:11 INFO - "/builds/slave/test"] 07:28:11 INFO - --app=APP Application being installed. [default: firefox] 07:28:11 INFO - mkdir: /builds/slave/test/build/application 07:28:11 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'] 07:28:11 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 07:28:28 INFO - Reading from file tmpfile_stdout 07:28:28 INFO - Output received: 07:28:28 INFO - /builds/slave/test/build/application/firefox/firefox 07:28:28 INFO - Running post-action listener: _resource_record_post_action 07:28:28 INFO - [mozharness: 2016-09-17 14:28:28.383794Z] Finished install step (success) 07:28:28 INFO - [mozharness: 2016-09-17 14:28:28.384078Z] Running run-tests step. 07:28:28 INFO - Running pre-action listener: _resource_record_pre_action 07:28:28 INFO - Running main action method: run_tests 07:28:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:28:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:28:28 INFO - Python 2.7.3 07:28:28 INFO - Return code: 0 07:28:28 INFO - grabbing minidump binary from tooltool 07:28:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:28 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 0x1375570>, '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 0x1376470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1376900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:28:28 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 07:28:28 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 07:28:28 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 07:28:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:28:28 INFO - Return code: 0 07:28:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:28:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:28:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:28:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:28:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:28:28 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/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:28:28 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/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:28:28 INFO - Using env: {'DISPLAY': ':0', 07:28:28 INFO - 'HOME': '/home/cltbld', 07:28:28 INFO - 'LANG': 'en_US.UTF-8', 07:28:28 INFO - 'LANGUAGE': 'en_US:en', 07:28:28 INFO - 'LOGNAME': 'cltbld', 07:28:28 INFO - 'MAIL': '/var/mail/cltbld', 07:28:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:28:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:28:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:28 INFO - 'MOZ_NO_REMOTE': '1', 07:28:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:28:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:28 INFO - 'NO_EM_RESTART': '1', 07:28:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:28 INFO - 'PWD': '/builds/slave/test', 07:28:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:28:28 INFO - 'SHELL': '/bin/bash', 07:28:28 INFO - 'SHLVL': '1', 07:28:28 INFO - 'TERM': 'linux', 07:28:28 INFO - 'TMOUT': '86400', 07:28:28 INFO - 'USER': 'cltbld', 07:28:28 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474122008.673593-1028930911', 07:28:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:28 INFO - '_': '/tools/buildbot/bin/python'} 07:28:28 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/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:28:28 INFO - mozversion application_buildid: 20160917004009 07:28:28 INFO - mozversion application_changeset: b9499912b32324acd84792bf02b533b40e98e496 07:28:28 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:28:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:28:28 INFO - mozversion application_name: Firefox 07:28:28 INFO - mozversion application_remotingname: firefox-dev 07:28:28 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:28:28 INFO - mozversion application_vendor: Mozilla 07:28:28 INFO - mozversion application_version: 50.0a2 07:28:28 INFO - mozversion platform_buildid: 20160917004009 07:28:28 INFO - mozversion platform_changeset: b9499912b32324acd84792bf02b533b40e98e496 07:28:28 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:28:28 INFO - mozversion platform_version: 50.0a2 07:28:28 INFO - using testdate: 1474122508 07:28:28 INFO - actual date: 1474122508 07:28:28 INFO - starting webserver on 'localhost:45877' 07:28:28 INFO - SUITE-START | Running 2 tests 07:28:28 INFO - TEST-START | dromaeo_css 07:28:28 INFO - operating with platform_type : linux_ 07:28:28 INFO - Initialising browser for dromaeo_css test... 07:28:28 INFO - TEST-INFO | started process 16972 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbVdEBb/profile http://localhost:45877/getInfo.html) 07:28:32 INFO - PROCESS | 16972 | __metrics Screen width/height:1600/1200 07:28:32 INFO - PROCESS | 16972 | colorDepth:24 07:28:32 INFO - PROCESS | 16972 | Browser inner width/height: 1024/697 07:28:32 INFO - PROCESS | 16972 | __metrics 07:28:33 ERROR - PROCESS | 16972 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 07:28:34 INFO - TEST-INFO | 16972: exit 0 07:28:34 INFO - Browser initialized. 07:28:34 INFO - Running cycle 1/1 for dromaeo_css test... 07:28:34 INFO - TEST-INFO | started process 17098 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbVdEBb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:28:46 INFO - PROCESS | 17098 | RSS: Main: 153546752 07:28:46 INFO - PROCESS | 17098 | 07:29:35 INFO - PROCESS | 17098 | 1474122575923 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] 07:31:44 INFO - PROCESS | 17098 | Cycle 1(1): loaded http://localhost:45877/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45877/tests/dromaeo/cssquery-ext.html) 07:31:45 INFO - PROCESS | 17098 | RSS: Main: 160608256 07:31:45 INFO - PROCESS | 17098 | 07:34:47 INFO - PROCESS | 17098 | Cycle 1(1): loaded http://localhost:45877/tests/dromaeo/cssquery-ext.html (next: http://localhost:45877/tests/dromaeo/cssquery-jquery.html) 07:34:48 INFO - PROCESS | 17098 | RSS: Main: 155299840 07:34:48 INFO - PROCESS | 17098 | 07:37:50 INFO - PROCESS | 17098 | Cycle 1(1): loaded http://localhost:45877/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45877/tests/dromaeo/cssquery-mootools.html) 07:37:50 INFO - PROCESS | 17098 | RSS: Main: 156647424 07:37:50 INFO - PROCESS | 17098 | 07:40:52 INFO - PROCESS | 17098 | Cycle 1(1): loaded http://localhost:45877/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45877/tests/dromaeo/cssquery-prototype.html) 07:40:53 INFO - PROCESS | 17098 | RSS: Main: 154836992 07:40:53 INFO - PROCESS | 17098 | 07:43:55 INFO - PROCESS | 17098 | Cycle 1(1): loaded http://localhost:45877/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45877/tests/dromaeo/cssquery-yui.html) 07:43:56 INFO - PROCESS | 17098 | RSS: Main: 157184000 07:43:56 INFO - PROCESS | 17098 | 07:46:58 INFO - PROCESS | 17098 | Cycle 1(1): loaded http://localhost:45877/tests/dromaeo/cssquery-yui.html (next: http://localhost:45877/tests/dromaeo/cssquery-dojo.html) 07:46:58 INFO - PROCESS | 17098 | RSS: Main: 158289920 07:46:58 INFO - PROCESS | 17098 | 07:46:58 INFO - PROCESS | 17098 | __start_tp_report 07:46:58 INFO - PROCESS | 17098 | _x_x_mozilla_page_load 07:46:58 INFO - PROCESS | 17098 | _x_x_mozilla_page_load_details 07:46:58 INFO - PROCESS | 17098 | |i|pagename|runs| 07:46:58 INFO - PROCESS | 17098 | |0;dojo.html;3252.4796032634777;3285.737141028718;3313.9834300828493;3322.6677332266777;3334.2497937963963;5676.8580785480335;5717.651051596613;5803.883922321551;5848.619839710426;5851.034579294412;5762.049261871796;5785.82642520725;5851.268591426072;5853.473187413132;5860.003799354109;5274.208868669702;5362.43694412087;5371.248025276445;5384.973075134619;5410.972945135269;5195.610329225305;5206;5331.866703332409;5350.438203988583;5367.865803354908;5309.495597918191;5332.173513105475;5342.465753424665;5355.0628639988045;5417.322834645669;5399.325084364455;5419.403865574784;5423.213634023084;5424.83725488234;5467.343918729778;5111.974440127813;5196.376434827807;5196.792128314863;5276.657017293864;5287.894242115136;5718.885622287573;5745.683987380692;5790.36306006339;5795.710214489301;5876.500497457721;6206.875862482725;6251.343608921089;6257.155284036642;6271.153394291758;6278.37216278373;6122.032243765652;6184.165137706442;6224.782132625382;6357.745690172387;6363.87272254557;5890.293164820207;5901.527877769811;5907.202527658797;5928.081147422156;5944.791932282349;6427.903581446282;6465.579737317059;6475.255345635218;6476.4495017924;6491.480681545465;5997.910031349533;6074.969625151846;6124.081387791778;6127.264728232641;6218.533609979269;6302.684865756785;6316.115743795872;6339.714712837841;6343.492520598341;6353.047042943595;6269.96865015672;6273.96863015682;6282.748690052438;6287.811365659038;6299.937000630027;6035.426634469718;6122.245686735527;6151.446369826737;6287.371262873768;6299.149614802035;4773.331733557305;4792.041591681677;4795.040991801654;4816.735079570657;4828.324034635154;4221.282381995068;4242.024334403043;4252.170826688766;4258.829646814154;4296.613304802583;5789.218455508452;5873.353931067579;5898.616589921641;5927.792527261525;5984.251968503937;6198.411150940653;6233.594816336924;6234.625922444668;6244.406781355855;6270.435660790459;5946.345901950782;5974.4622983930785;5981.730822113015;6014.488768454643;6066.423689749467;4987.152184128707;5006.324146240284;5053.191489361684;5185.429602743695;5211.895762084737;6407.487401007908;6408.2630497492455;6422.646754428458;6429.1320671709655;6432.0351947207355;6101;6172.105044768394;6191.876162476635;6194.752209911553;6197.938020619917;6131.254333328352;6297.590656607306;6306.747730090745;6356.713947872265;6408.102865598913;6119.593952096689;6122.367660829284;6127.342242870382;6130.065561664973;6131.682521312607;6217.160683307696;6219.968900155471;6227.595206311757;6234;6235.563510554218;5942.7920022799;6001.7299221536005;6038.124471951454;6051.394860513913;6052.697365131814;6100.786472473442;6109.070667812992;6117.188044311343;6128.417800308964;6129.141920131275;6072.787452439144;6076.574639775174;6090.390960903874;6133.907991380043;6141.170941922784;5981;6119.8470038247615;6121.392004143408;6137.693115344304;6148.969255153875;6043.848903777441;6052.878942421039;6089;6112.266528016667;6119.479844213113 07:46:58 INFO - PROCESS | 17098 | |1;ext.html;579.1631093070512;621.1521273461725;651.5308977536175;660.7918505670714;689.6758523493962;40271.59728402715;44610.553894461045;44808.775956120175;44815.103697926024;45071.32393014107;44414.77792611033;45015;45136.548634513645;45184.77407612957;45315.54684453154;8995.95502022489;9088.045755195708;9143.451392916413;9148;9179.082091790835;9073.500957447337;9179.632814687438;9188.448693078437;9190.21883139934;9195.540222988857;9230.26157907369;9260.073992600754;9262.722118336427;9273.443593384385;9316.161545460907;9081.81836363269;9105.817883642323;9118.270538356915;9121.543922803834;9156.130167634064;9093.40892841963;9189;9219.35464517484;9230.815383692288;9241.399309044891;42942.78528607368;43561;43574;43603;43778.34332485015;3374;3882.398228274622;4049.493813273341;4096.078382363974;4230.492340919079;33274.667253327396;33725.15687107817;35824.462633060524;36182.276354472764;37365.25269494622;4788.736619485927;4822.059698358821;4850.854474365775;4854.587360074398;4903.583195428393;380117;381284;383229;384645;384803;66964;67381.2940288279;67400;67500.66249668818;67663.3233667667;39796.80101599474;40028;40193.79903100466;42556.57443425588;70372.64813676;19414.514637133903;19758.60482790336;19784.604307914047;19804.40586782399;19848.50378740543;15141;15162.545123646309;15263.236838158047;15307.693846123015;15309.08145511273;20854.478638033866;20929;21180.682289765668;21197.894010530155;21216.78783212148;7475.43934204926;7577.507462014952;7592.8861067084035;7647.808804779925;7868.881966770503;1014.2342531388754;1137.1244142010605;1150.3328069719544;1229.1088960503564;1240.1319076646384;33677.494837577455;34155;34681.47977780335;34710.13224669403;35080.12299692528;1069.2835800014009;1115.6151127860876;1147.4836323654388;1152.1301417429786;1182.586094866807;17562.736558951627;17849.37527186542;18346;18424.631507369777;18524.16641251147;418401;552104;552746;554567;560286;66398.33601663921;66602.66698666573;66663;66803;66866;1463.3707505772406;1499.14548707238;1528.0373364780116;1529.755239161751;1530.3496014194145;33968.15079623029;34754.478682819274;35197.296054079285;35357.292854143285;35452;53016.20475692945;53615.463845361046;53740.73129634327;53946;53990.73004635109;445040;450284;451525;452780;453215;30629.540556891217;31119.222019449695;31422.214444639067;31466.685333146375;31530.36939261156;52137.217941731666;52292;52596.21105683341;52657;52709.47290527046;43800.56199438092;43896.78051609721;44026.77986610046;45223;45424.31863521984;41853.162936741704;44670.3299450502;46526;46642.300365495226;47156.52843471521;45635.54364456313;46226.53773462222;46441.53558464507;46789;47432.28851567298;38636.22727545377;39148.608513915635;39785;39801;40540.39189412102;30167.547486788153;30917.845410772803;31213.2832694204;31378.843105784326;31499 07:46:58 INFO - PROCESS | 17098 | |2;jquery.html;415.715235063981;417.780665150796;428.7950858088771;433.11212015368494;435.2991683389742;19575.902120489394;21103.577928441442;21313.893430532844;21866.23468178614;21914.561708765814;20212;20635;20781.27265545706;20906;21099.57800843982;5870.970645146779;6057.848553786146;6061.66660833654;6125.326214116443;6126.877462450749;5823.388544202861;6038.2150320458495;6044.304904935922;6073.544484163684;6149.0468977308365;6055.6063855849225;6086.208792856923;6087.908681369783;6133.417325354084;6136.723847426854;6567.704453299589;6610.107635469199;6644.800655980304;6654;6669.299723529008;5749.396313387076;5840.386759390288;5894.115882617599;5986.431289027535;6001.459868611846;14664.12015279076;14751.70496590073;14871.256437178097;19708.70436943447;24132.517349653084;2405.518896220763;2448.5714999875127;2466.48203877186;2515.6855393075866;2546.2743118211406;10284;10454.268201225917;10895.237333386665;11169.888301117047;11268.154888383322;2030.2995466564012;2037.1749441476227;2058.3516192399347;2096.3920463065692;2107.968380474294;86444.56777716134;86699;88128.11871881328;88476.5576172115;90199.54900225457;9039.63841446348;9498.857517137249;9514;9872.703818885446;11233.213675042833;14523.491677791226;14534.709305813825;14539.927300363643;14542.927285363505;14569.927150364181;8608.397412181212;8616.48301101936;8640.351973602004;8693.782870398149;8754.781130471662;8828.42615230008;8853.601587928559;8940.8658870117;8968.730938071869;9187.586558604879;4255.702100852973;4456.554344565518;4476.641868650565;4495.730256184639;4606.470255920545;2119.4065661614463;2186.180182431588;2192.40804982657;2207.7902599253043;2232.8883555822144;1017.6489111256604;1069.1767339148967;1104.2380757277454;1106.0211712634216;1108.983365249522;20455.386338409873;20856.165753369998;21009.68485472719;21263.68104478434;21269.46826329323;1087.152021423291;1091.1598069486452;1097.5664612478186;1160.9477573509212;1168.485866218861;11538.134639901873;11647.317475950225;11769.529218831321;11778.76442471163;11785;405428;409434;412438;543931;548285;95547.52226238964;102325.48837255915;107426.46286768516;107463;107782;1070.817960946641;1099.0493223361893;1110.7500812317326;1146.1117633833678;1153.8038533449167;19405.902970485058;19627.411177664122;19658.41024769259;19722.50693732668;19806.50483737918;44665.77667111644;45817.77091114523;46141.53858461372;46754.29868551906;47204;60721.69639151776;65606;66224.33775662375;67705.66147169232;68805;8845.159709827556;8911.955440222757;8939.955300223457;9002.009778924445;9067.637294508146;8270.586470676562;11473.082153427873;12662.303573303558;12741.235525868478;14407.135571865303;12749;12828.743425131632;12855.357232138544;12884.48462061507;13056.543020994219;11366.943165284121;11518.654440366803;11897.583584574499;11898.76202475963;12574.30841303737;12387.19483233587;12782.744345113231;13040.739185216433;13216.405261763435;13631.863681363457;8944.105589441004;8961.865572016295;9048.140426659456;9078.910530736353;9327.766805829637;9216.493092879688;12680.809787853004;12983.35083245815;13148.539801107298;13175.802362964372 07:46:58 INFO - PROCESS | 17098 | |3;mootools.html;1596.425286896717;1610.0098439459732;1804.5669039430531;1848.4547058617707;1886.0758228468055;8264.338852891755;8879.51162686052;9022.052684468135;9673.806523869518;9744.317897747153;9415.529223538813;9492.050794920522;9515.048495150482;9515.476648784314;9533.952330238357;2515.899364025441;2518.3074654469983;2535.835170713907;2541.301142185895;2545.2364290712803;2452.4236804350962;2533.1260715053277;2534.277730846709;2534.569123249052;2535.0873685473216;2482.2181012980946;2488.377905523619;2496.0889275414434;2514.208024472285;2517.647529345893;2412.589859723851;2424.527217192648;2445.303088619735;2463.3472129885504;2471.233917485585;2438.207582535683;2441.353041444001;2457.213691618683;2457.619069044301;2484.7266800651914;9333.579988900516;9503.762405939839;9528.904710952871;9533;9535.094166054283;5449.3188351456065;5520.696361700105;5575.0522411190195;5581.3302403711405;5581.832545023656;3541.6812486876047;3556.2354093869944;3607.4047782115917;3665.651763082503;3706.258748250361;1186.35936594239;1195.4321697193764;1201.4113084588575;1202.3387137074662;1208.6313674329326;12553.932915702177;12709.046821488426;12723.10938234324;12760.553380631633;12769.61691149267;4952.455229924705;4967.155583550805;5044.873878153002;5094.719790411563;5110.48895110486;11087.279326843729;11095.50070246841;11100.222984391015;11111.888881111085;11142.164337674545;5599.412061733541;5618.185363122406;5622.269105016322;5661.745221465044;5688;4467.30756732707;4998.725070121178;5116.923246151311;5134.2812006319145;5179.352580927384;4295.140971805589;4337.436133302714;4375.518692943773;4379;4532.88667783308;1405.3324670781296;1418.581518452059;1430.206235539265;1448.739226939161;1463.824341079056;933.4585940154694;995.915347195482;1005.9949700251598;1011.1506334678758;1023.6877752285476;6011.729472173763;6101.206843110367;6223.626582405071;6289.7169627366875;6324.462420694201;473.7962676049332;474.8527956333548;479.0419161676647;488.02151685869603;488.7116601205306;4031.8588849390717;4118.5263694674895;4151.6886233532605;4156.085661154541;4181.184668989518;11509.884901150881;11639.76720465586;11661.591844285578;11771.529138834521;11860.110491713156;11466.770664586662;11509.827352589718;11549.076073914066;11605.76788464226;11742.88257117435;8565;8612;8711.782205444915;8719;8724.956375218084;6167.938320616737;6173.197484327009;6239.032949892774;6271.811845644455;6289.905651415141;10624.84062739075;10656.520456579628;10758.784824303313;10774.299670521392;10777.515011824644;10629;10786.029257366874;10788.352698838095;10842.457877106272;10912.945435272773;7495.7001719930595;7971.3224375926375;8131.227533384319;8263.297619702393;8392.496450213006;9378.390404623678;9388.906110938804;9406.96523382441;9468.431894086378;9475.952620236854;8120.593970301579;8201.42590018693;8219.219174178443;8239.670413183645;8412.327013838756;7997.320227780704;8008.079070906921;8068.59657017135;8079.555624440713;8221.958890205511;7005.579665220103;7196.532225405332;7205.243449437943;7275.454340924346;7335.743248986473;5356.7589458473685;5363.410024897336;5481.095619222783;5578.49793518569;5622.493975542057;5483.616146869681;5520.503154716095;5552.611317207757;5569.693666848362;5610.831675049755 07:46:58 INFO - PROCESS | 17098 | |4;prototype.html;322.511395236217;323.25651002693803;326.1731510620577;336.1009300122174;340.7614669731189;5775.711214439277;5830.154627578999;5839.299284085905;5850.941490585093;5858.88282234355;5725.88345272672;5729.627574207673;5731.484166425021;5785.652860828353;5792.942070579293;4240.89397765056;4412.404325416076;4461.4869290031575;4518.819247230123;4539.9546004540025;4448.177087238855;4492.865214043584;4516.774161291923;4527.547245275479;4536.228841097005;4507.954920450803;4516.728996260218;4528.50186479487;4533.977330113345;4535.410396648431;4345.78271086446;4451.5993560579545;4468.173387923244;4470.173017991649;4485.641148708096;3945.2504024235304;3950.881473555798;3967.6708302718625;3984.9601503984877;3995.4018392642884;5645.068563686987;5650.660960342392;5652.660840349592;5671.376148623648;5706.4864162225185;5080.822171223989;5093.006863661588;5098.847034588968;5159.380874295071;5206.114960456732;6009.399060094;6041.365656606037;6051.515878729691;6079.331273559905;6081.17904082952;4297;4360.454943132108;4371.890702732426;4377.146456440995;4394.308191346355;6228.128062071313;6249.156363890862;6270.216222972129;6299.212598425197;6345.936540634627;4454.22051141049;4455.576720211575;4492.842750503717;4501.2670122003265;4503;4403.603675669141;4464.263396539534;4539.114872599877;4542;4543.704659197141;5115.2071428928575;5140.691558506502;5161.716105614228;5203.297554830049;5204.71374074422;6082.1789058477425;6087.604305720114;6116.602420842631;6117.418845209698;6163.660998645028;1530.6862093270852;1544.3436539470904;1554.2772610736063;1564.7105285522214;1580.217792192872;998.236349192868;1008.6772232885406;1012.9617142428922;1029.9494515594051;1034.9896501035043;5797.8550536236935;5847.152162936435;5862.713541718733;5866.658672582258;5907.9704601476715;6154.661493617805;6195.876082478325;6246.718897649616;6255.748850229972;6273.247210334698;5675.858103547444;5838.591298609056;5886.264216972879;5898.616589921641;5903.35063143054;3298.191942973987;3346.916327091842;3359.8656053758064;3360.613529444145;3364.360771453416;6315.336889626615;6396.680165991682;6419.582727122815;6422.614643121427;6481.4166724994975;6310.5898116622275;6356.332585078592;6362.2503811452225;6370.8088757337355;6379.330170332141;6165.167702360213;6298.913532369106;6333.303336632966;6397.45621622158;6427.453666438311;6143.385661433999;6163.938360616516;6167.101462312706;6177.876442471215;6184.330230837559;6118.326984031664;6119.632822030692;6133.38666133401;6136.846578835565;6141.232345956755;6140.956037473729;6372.458341041063;6382.712777924911;6385.457236134795;6389;4266.87199384019;4266.957330426656;4277.529471758042;4286.121345124305;4296.849610263625;6021.036634138517;6205.906911396242;6257.342978987323;6259.655718935503;6280.937190628035;5982.641041537521;6018.187544681412;6024.5481588881885;6027.378090530633;6052.818415447544;6029.45734883845;6048.879022419615;6050.515958723204;6061.848453788514;6066;5806.593538452268;5946.970265148647;5991.191189189403;6150.846228844136;6172.4692875920655;6150.078712611474;6199.194104766351;6227.719752611234;6244.438000579969;6261.279952805486;5892.882142357214;5955.166276721176;5979.820605381846;6030.396960303934;6062.636241825505 07:46:58 INFO - PROCESS | 17098 | |5;yui.html;890.9999999999999;905.4160066756942;935.3732998890747;939.2861425316758;943.7121677888243;16465;17454.301827926898;17920.37278695246;17950.461486155436;18037.819621803777;16441.753373699376;16739.330426782915;16786.580335491588;16818.15909204541;16828.32686692531;744.7653988993477;860.6299291304737;874.4622057434664;890.0565400675273;892.9062448442918;887.769180013198;889.4263200235844;892.2683399612321;894.6823877523483;900.4012331799378;951.8096380723848;952.3286083311249;953.3993584042043;956.0821611253206;960.1982344742148;942.7690215897114;943.6178347769164;945.4374647084974;949.1410273702311;949.9762505937372;694.8888177891564;697.5082566790401;698;700.9264027277164;702.6978399288304;16821.831781682147;17121.486355409357;17216.91391543047;17302.394416195373;17328.306867725274;16565.66868662632;17442;17493.912530437265;17917;18030.729539056792;13208.603741887759;13275.668108297274;13342.599722008355;13561.389737461739;13588.32058397086;4116.300228961084;4122.525909520414;4145.54399016108;4214.136102099063;4263.147370525876;68813.65593172052;83940;84443;85166;86524.13475865223;12808.80786788199;12874.678133046562;12978.610641680765;13222.140560863512;13303.933480332536;23033.769662303497;23054.538909221723;23409.41476463102;23634.527309453715;23827;9091.727248182566;9188.770280742901;9281.071892810665;9289.256859451227;9324.90675093254;5225.451327610546;5268.868278292996;5298.788048478018;5356.678599284055;5453.3455985281225;3802.6007269236884;3936.4882565266903;3944.7041471889147;3948.269570129535;3952.4268980997595;652.9379708927644;676.9289224631441;694.2120693013466;695.6591270277528;716.8100453379755;837.3175861672718;853.5774791478258;858.356232825381;874.7157173918501;882.6513527156866;10985.450727463754;11323.207375483636;11406.714832129263;11492.310461372344;11582.024476044262;691.1050190003957;722.7325889420842;789.3093543149744;845.0788640381891;855.1491266190056;5033.723145226974;5300.814471493556;5324.653897496651;5345.305110335631;5380.461953804666;112555.437222815;113889;117689;119229;120601.39699301623;61767.691161544804;71287.28712712806;101792.49103754581;106194;106322.46838765757;88671;91656.99999999866;91771.54114229386;91838.54080729553;93834.53082734543;10662.626808061681;11129.276597021168;11156.386398748147;11603.419829008348;11670.591529296435;55855.44144558503;56327;57186.7140664294;57186.7140664294;57767.71116144393;72328;80187;80520;82964.58517707614;83325;13799.51701690436;13863.37614807316;14097;14299.928500357431;14622.488212912496;15414.46049388266;15584.376624934876;15796.842031579537;16054.43809466663;16494;15507.612309692347;15610.219489025276;15807.209639517749;16319.918400407922;16818.327266909677;15069.321880515185;15127.16800575979;15926.681466370375;16462.42381516641;16551.91724041372;13371.866281337063;13400.262985535888;14001.369938352595;14023;15213.6196595086;12575.748485030432;12986.675333116369;13064.477420903437;13305.733885322434;13420.463181473022;11433.428328583705;11454.370009649549;11556.248843825124;12394.628795842715;13414.932925335701 07:46:58 INFO - PROCESS | 17098 | __end_tp_report 07:46:58 INFO - PROCESS | 17098 | __start_cc_report 07:46:58 INFO - PROCESS | 17098 | _x_x_mozilla_cycle_collect,318 07:46:58 INFO - PROCESS | 17098 | __end_cc_report 07:46:58 INFO - PROCESS | 17098 | __startTimestamp1474123618952__endTimestamp 07:46:58 INFO - PROCESS | 17098 | 07:46:58 INFO - PROCESS | 17098 | ------- Summary: start ------- 07:46:58 INFO - PROCESS | 17098 | Number of tests: 6 07:46:58 INFO - PROCESS | 17098 | 07:46:58 INFO - PROCESS | 17098 | [#0] dojo.html Cycles:165 Average:5789.64 Median:6052.70 stddev:669.06 (11.1%) stddev-sans-first:640.83 07:46:58 INFO - PROCESS | 17098 | Values: 3252.5 3285.7 3314.0 3322.7 3334.2 5676.9 5717.7 5803.9 5848.6 5851.0 5762.0 5785.8 5851.3 5853.5 5860.0 5274.2 5362.4 5371.2 5385.0 5411.0 5195.6 5206.0 5331.9 5350.4 5367.9 5309.5 5332.2 5342.5 5355.1 5417.3 5399.3 5419.4 5423.2 5424.8 5467.3 5112.0 5196.4 5196.8 5276.7 5287.9 5718.9 5745.7 5790.4 5795.7 5876.5 6206.9 6251.3 6257.2 6271.2 6278.4 6122.0 6184.2 6224.8 6357.7 6363.9 5890.3 5901.5 5907.2 5928.1 5944.8 6427.9 6465.6 6475.3 6476.4 6491.5 5997.9 6075.0 6124.1 6127.3 6218.5 6302.7 6316.1 6339.7 6343.5 6353.0 6270.0 6274.0 6282.7 6287.8 6299.9 6035.4 6122.2 6151.4 6287.4 6299.1 4773.3 4792.0 4795.0 4816.7 4828.3 4221.3 4242.0 4252.2 4258.8 4296.6 5789.2 5873.4 5898.6 5927.8 5984.3 6198.4 6233.6 6234.6 6244.4 6270.4 5946.3 5974.5 5981.7 6014.5 6066.4 4987.2 5006.3 5053.2 5185.4 5211.9 6407.5 6408.3 6422.6 6429.1 6432.0 6101.0 6172.1 6191.9 6194.8 6197.9 6131.3 6297.6 6306.7 6356.7 6408.1 6119.6 6122.4 6127.3 6130.1 6131.7 6217.2 6220.0 6227.6 6234.0 6235.6 5942.8 6001.7 6038.1 6051.4 6052.7 6100.8 6109.1 6117.2 6128.4 6129.1 6072.8 6076.6 6090.4 6133.9 6141.2 5981.0 6119.8 6121.4 6137.7 6149.0 6043.8 6052.9 6089.0 6112.3 6119.5 07:46:58 INFO - PROCESS | 17098 | 07:46:58 INFO - PROCESS | 17098 | [#1] ext.html Cycles:180 Average:62887.74 Median:244727.39 stddev:121286.89 (49.6%) stddev-sans-first:121536.91 07:46:58 INFO - PROCESS | 17098 | Values: 579.2 621.2 651.5 660.8 689.7 40271.6 44610.6 44808.8 44815.1 45071.3 44414.8 45015.0 45136.5 45184.8 45315.5 8996.0 9088.0 9143.5 9148.0 9179.1 9073.5 9179.6 9188.4 9190.2 9195.5 9230.3 9260.1 9262.7 9273.4 9316.2 9081.8 9105.8 9118.3 9121.5 9156.1 9093.4 9189.0 9219.4 9230.8 9241.4 42942.8 43561.0 43574.0 43603.0 43778.3 3374.0 3882.4 4049.5 4096.1 4230.5 33274.7 33725.2 35824.5 36182.3 37365.3 4788.7 4822.1 4850.9 4854.6 4903.6 380117.0 381284.0 383229.0 384645.0 384803.0 66964.0 67381.3 67400.0 67500.7 67663.3 39796.8 40028.0 40193.8 42556.6 70372.6 19414.5 19758.6 19784.6 19804.4 19848.5 15141.0 15162.5 15263.2 15307.7 15309.1 20854.5 20929.0 21180.7 21197.9 21216.8 7475.4 7577.5 7592.9 7647.8 7868.9 1014.2 1137.1 1150.3 1229.1 1240.1 33677.5 34155.0 34681.5 34710.1 35080.1 1069.3 1115.6 1147.5 1152.1 1182.6 17562.7 17849.4 18346.0 18424.6 18524.2 418401.0 552104.0 552746.0 554567.0 560286.0 66398.3 66602.7 66663.0 66803.0 66866.0 1463.4 1499.1 1528.0 1529.8 1530.3 33968.2 34754.5 35197.3 35357.3 35452.0 53016.2 53615.5 53740.7 53946.0 53990.7 445040.0 450284.0 451525.0 452780.0 453215.0 30629.5 31119.2 31422.2 31466.7 31530.4 52137.2 52292.0 52596.2 52657.0 52709.5 43800.6 43896.8 44026.8 45223.0 45424.3 41853.2 44670.3 46526.0 46642.3 47156.5 45635.5 46226.5 46441.5 46789.0 47432.3 38636.2 39148.6 39785.0 39801.0 40540.4 30167.5 30917.8 31213.3 31378.8 31499.0 07:46:58 INFO - PROCESS | 17098 | 07:46:58 INFO - PROCESS | 17098 | [#2] jquery.html Cycles:180 Average:29391.94 Median:2220.34 stddev:77963.05 (3511.3%) stddev-sans-first:78151.40 07:46:58 INFO - PROCESS | 17098 | Values: 415.7 417.8 428.8 433.1 435.3 19575.9 21103.6 21313.9 21866.2 21914.6 20212.0 20635.0 20781.3 20906.0 21099.6 5871.0 6057.8 6061.7 6125.3 6126.9 5823.4 6038.2 6044.3 6073.5 6149.0 6055.6 6086.2 6087.9 6133.4 6136.7 6567.7 6610.1 6644.8 6654.0 6669.3 5749.4 5840.4 5894.1 5986.4 6001.5 14664.1 14751.7 14871.3 19708.7 24132.5 2405.5 2448.6 2466.5 2515.7 2546.3 10284.0 10454.3 10895.2 11169.9 11268.2 2030.3 2037.2 2058.4 2096.4 2108.0 86444.6 86699.0 88128.1 88476.6 90199.5 9039.6 9498.9 9514.0 9872.7 11233.2 14523.5 14534.7 14539.9 14542.9 14569.9 8608.4 8616.5 8640.4 8693.8 8754.8 8828.4 8853.6 8940.9 8968.7 9187.6 4255.7 4456.6 4476.6 4495.7 4606.5 2119.4 2186.2 2192.4 2207.8 2232.9 1017.6 1069.2 1104.2 1106.0 1109.0 20455.4 20856.2 21009.7 21263.7 21269.5 1087.2 1091.2 1097.6 1160.9 1168.5 11538.1 11647.3 11769.5 11778.8 11785.0 405428.0 409434.0 412438.0 543931.0 548285.0 95547.5 102325.5 107426.5 107463.0 107782.0 1070.8 1099.0 1110.8 1146.1 1153.8 19405.9 19627.4 19658.4 19722.5 19806.5 44665.8 45817.8 46141.5 46754.3 47204.0 60721.7 65606.0 66224.3 67705.7 68805.0 8845.2 8912.0 8940.0 9002.0 9067.6 8270.6 11473.1 12662.3 12741.2 14407.1 12749.0 12828.7 12855.4 12884.5 13056.5 11366.9 11518.7 11897.6 11898.8 12574.3 12387.2 12782.7 13040.7 13216.4 13631.9 8944.1 8961.9 9048.1 9078.9 9327.8 9216.5 12680.8 12983.4 13148.5 13175.8 07:46:58 INFO - PROCESS | 17098 | 07:46:58 INFO - PROCESS | 17098 | [#3] mootools.html Cycles:180 Average:6150.33 Median:476.95 stddev:3510.45 (736.0%) stddev-sans-first:3503.62 07:46:58 INFO - PROCESS | 17098 | Values: 1596.4 1610.0 1804.6 1848.5 1886.1 8264.3 8879.5 9022.1 9673.8 9744.3 9415.5 9492.1 9515.0 9515.5 9534.0 2515.9 2518.3 2535.8 2541.3 2545.2 2452.4 2533.1 2534.3 2534.6 2535.1 2482.2 2488.4 2496.1 2514.2 2517.6 2412.6 2424.5 2445.3 2463.3 2471.2 2438.2 2441.4 2457.2 2457.6 2484.7 9333.6 9503.8 9528.9 9533.0 9535.1 5449.3 5520.7 5575.1 5581.3 5581.8 3541.7 3556.2 3607.4 3665.7 3706.3 1186.4 1195.4 1201.4 1202.3 1208.6 12553.9 12709.0 12723.1 12760.6 12769.6 4952.5 4967.2 5044.9 5094.7 5110.5 11087.3 11095.5 11100.2 11111.9 11142.2 5599.4 5618.2 5622.3 5661.7 5688.0 4467.3 4998.7 5116.9 5134.3 5179.4 4295.1 4337.4 4375.5 4379.0 4532.9 1405.3 1418.6 1430.2 1448.7 1463.8 933.5 995.9 1006.0 1011.2 1023.7 6011.7 6101.2 6223.6 6289.7 6324.5 473.8 474.9 479.0 488.0 488.7 4031.9 4118.5 4151.7 4156.1 4181.2 11509.9 11639.8 11661.6 11771.5 11860.1 11466.8 11509.8 11549.1 11605.8 11742.9 8565.0 8612.0 8711.8 8719.0 8725.0 6167.9 6173.2 6239.0 6271.8 6289.9 10624.8 10656.5 10758.8 10774.3 10777.5 10629.0 10786.0 10788.4 10842.5 10912.9 7495.7 7971.3 8131.2 8263.3 8392.5 9378.4 9388.9 9407.0 9468.4 9476.0 8120.6 8201.4 8219.2 8239.7 8412.3 7997.3 8008.1 8068.6 8079.6 8222.0 7005.6 7196.5 7205.2 7275.5 7335.7 5356.8 5363.4 5481.1 5578.5 5622.5 5483.6 5520.5 5552.6 5569.7 5610.8 07:46:58 INFO - PROCESS | 17098 | 07:46:58 INFO - PROCESS | 17098 | [#4] prototype.html Cycles:180 Average:5107.30 Median:5843.23 stddev:1507.06 (25.8%) stddev-sans-first:1467.87 07:46:58 INFO - PROCESS | 17098 | Values: 322.5 323.3 326.2 336.1 340.8 5775.7 5830.2 5839.3 5850.9 5858.9 5725.9 5729.6 5731.5 5785.7 5792.9 4240.9 4412.4 4461.5 4518.8 4540.0 4448.2 4492.9 4516.8 4527.5 4536.2 4508.0 4516.7 4528.5 4534.0 4535.4 4345.8 4451.6 4468.2 4470.2 4485.6 3945.3 3950.9 3967.7 3985.0 3995.4 5645.1 5650.7 5652.7 5671.4 5706.5 5080.8 5093.0 5098.8 5159.4 5206.1 6009.4 6041.4 6051.5 6079.3 6081.2 4297.0 4360.5 4371.9 4377.1 4394.3 6228.1 6249.2 6270.2 6299.2 6345.9 4454.2 4455.6 4492.8 4501.3 4503.0 4403.6 4464.3 4539.1 4542.0 4543.7 5115.2 5140.7 5161.7 5203.3 5204.7 6082.2 6087.6 6116.6 6117.4 6163.7 1530.7 1544.3 1554.3 1564.7 1580.2 998.2 1008.7 1013.0 1029.9 1035.0 5797.9 5847.2 5862.7 5866.7 5908.0 6154.7 6195.9 6246.7 6255.7 6273.2 5675.9 5838.6 5886.3 5898.6 5903.4 3298.2 3346.9 3359.9 3360.6 3364.4 6315.3 6396.7 6419.6 6422.6 6481.4 6310.6 6356.3 6362.3 6370.8 6379.3 6165.2 6298.9 6333.3 6397.5 6427.5 6143.4 6163.9 6167.1 6177.9 6184.3 6118.3 6119.6 6133.4 6136.8 6141.2 6141.0 6372.5 6382.7 6385.5 6389.0 4266.9 4267.0 4277.5 4286.1 4296.8 6021.0 6205.9 6257.3 6259.7 6280.9 5982.6 6018.2 6024.5 6027.4 6052.8 6029.5 6048.9 6050.5 6061.8 6066.0 5806.6 5947.0 5991.2 6150.8 6172.5 6150.1 6199.2 6227.7 6244.4 6261.3 5892.9 5955.2 5979.8 6030.4 6062.6 07:46:58 INFO - PROCESS | 17098 | 07:46:58 INFO - PROCESS | 17098 | [#5] yui.html Cycles:180 Average:22060.53 Median:3946.49 stddev:30469.62 (772.1%) stddev-sans-first:30513.63 07:46:58 INFO - PROCESS | 17098 | Values: 891.0 905.4 935.4 939.3 943.7 16465.0 17454.3 17920.4 17950.5 18037.8 16441.8 16739.3 16786.6 16818.2 16828.3 744.8 860.6 874.5 890.1 892.9 887.8 889.4 892.3 894.7 900.4 951.8 952.3 953.4 956.1 960.2 942.8 943.6 945.4 949.1 950.0 694.9 697.5 698.0 700.9 702.7 16821.8 17121.5 17216.9 17302.4 17328.3 16565.7 17442.0 17493.9 17917.0 18030.7 13208.6 13275.7 13342.6 13561.4 13588.3 4116.3 4122.5 4145.5 4214.1 4263.1 68813.7 83940.0 84443.0 85166.0 86524.1 12808.8 12874.7 12978.6 13222.1 13303.9 23033.8 23054.5 23409.4 23634.5 23827.0 9091.7 9188.8 9281.1 9289.3 9324.9 5225.5 5268.9 5298.8 5356.7 5453.3 3802.6 3936.5 3944.7 3948.3 3952.4 652.9 676.9 694.2 695.7 716.8 837.3 853.6 858.4 874.7 882.7 10985.5 11323.2 11406.7 11492.3 11582.0 691.1 722.7 789.3 845.1 855.1 5033.7 5300.8 5324.7 5345.3 5380.5 112555.4 113889.0 117689.0 119229.0 120601.4 61767.7 71287.3 101792.5 106194.0 106322.5 88671.0 91657.0 91771.5 91838.5 93834.5 10662.6 11129.3 11156.4 11603.4 11670.6 55855.4 56327.0 57186.7 57186.7 57767.7 72328.0 80187.0 80520.0 82964.6 83325.0 13799.5 13863.4 14097.0 14299.9 14622.5 15414.5 15584.4 15796.8 16054.4 16494.0 15507.6 15610.2 15807.2 16319.9 16818.3 15069.3 15127.2 15926.7 16462.4 16551.9 13371.9 13400.3 14001.4 14023.0 15213.6 12575.7 12986.7 13064.5 13305.7 13420.5 11433.4 11454.4 11556.2 12394.6 13414.9 07:46:58 INFO - PROCESS | 17098 | -------- Summary: end -------- 07:46:58 INFO - PROCESS | 17098 | 07:46:59 INFO - TEST-INFO | 17098: exit 0 07:46:59 INFO - TEST-OK | dromaeo_css | took 1111073ms 07:46:59 INFO - TEST-START | kraken 07:46:59 INFO - operating with platform_type : linux_ 07:46:59 INFO - Initialising browser for kraken test... 07:46:59 INFO - TEST-INFO | started process 17390 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9uulS1/profile http://localhost:45877/getInfo.html) 07:47:04 INFO - PROCESS | 17390 | __metrics Screen width/height:1600/1200 07:47:04 INFO - PROCESS | 17390 | colorDepth:24 07:47:04 INFO - PROCESS | 17390 | Browser inner width/height: 1024/697 07:47:04 INFO - PROCESS | 17390 | __metrics 07:47:04 ERROR - PROCESS | 17390 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 07:47:05 INFO - TEST-INFO | 17390: exit 0 07:47:05 INFO - Browser initialized. 07:47:05 INFO - Running cycle 1/1 for kraken test... 07:47:05 INFO - TEST-INFO | started process 17516 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9uulS1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:47:17 INFO - PROCESS | 17516 | RSS: Main: 153141248 07:47:17 INFO - PROCESS | 17516 | 07:47:19 INFO - PROCESS | 17516 | Cycle 1(1): loaded http://localhost:45877/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45877/tests/kraken/driver.html?testName=audio-beat-detection) 07:47:20 INFO - PROCESS | 17516 | RSS: Main: 158396416 07:47:20 INFO - PROCESS | 17516 | 07:47:23 INFO - PROCESS | 17516 | Cycle 1(1): loaded http://localhost:45877/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45877/tests/kraken/driver.html?testName=audio-dft) 07:47:24 INFO - PROCESS | 17516 | RSS: Main: 156975104 07:47:24 INFO - PROCESS | 17516 | 07:47:26 INFO - PROCESS | 17516 | Cycle 1(1): loaded http://localhost:45877/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45877/tests/kraken/driver.html?testName=audio-fft) 07:47:27 INFO - PROCESS | 17516 | RSS: Main: 157827072 07:47:27 INFO - PROCESS | 17516 | 07:47:29 INFO - PROCESS | 17516 | Cycle 1(1): loaded http://localhost:45877/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45877/tests/kraken/driver.html?testName=audio-oscillator) 07:47:30 INFO - PROCESS | 17516 | RSS: Main: 157315072 07:47:30 INFO - PROCESS | 17516 | 07:47:32 INFO - PROCESS | 17516 | Cycle 1(1): loaded http://localhost:45877/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45877/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:47:33 INFO - PROCESS | 17516 | RSS: Main: 157495296 07:47:33 INFO - PROCESS | 17516 | 07:47:36 INFO - PROCESS | 17516 | Cycle 1(1): loaded http://localhost:45877/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45877/tests/kraken/driver.html?testName=imaging-darkroom) 07:47:36 INFO - PROCESS | 17516 | RSS: Main: 157843456 07:47:36 INFO - PROCESS | 17516 | 07:47:40 INFO - PROCESS | 17516 | Cycle 1(1): loaded http://localhost:45877/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45877/tests/kraken/driver.html?testName=imaging-desaturate) 07:47:40 INFO - PROCESS | 17516 | RSS: Main: 158117888 07:47:40 INFO - PROCESS | 17516 | 07:47:43 INFO - PROCESS | 17516 | Cycle 1(1): loaded http://localhost:45877/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45877/tests/kraken/driver.html?testName=json-parse-financial) 07:47:44 INFO - PROCESS | 17516 | RSS: Main: 158453760 07:47:44 INFO - PROCESS | 17516 | 07:47:45 INFO - PROCESS | 17516 | Cycle 1(1): loaded http://localhost:45877/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45877/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:47:46 INFO - PROCESS | 17516 | RSS: Main: 158199808 07:47:46 INFO - PROCESS | 17516 | 07:47:48 INFO - PROCESS | 17516 | Cycle 1(1): loaded http://localhost:45877/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45877/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:47:48 INFO - PROCESS | 17516 | RSS: Main: 158445568 07:47:48 INFO - PROCESS | 17516 | 07:47:50 INFO - PROCESS | 17516 | Cycle 1(1): loaded http://localhost:45877/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45877/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:47:51 INFO - PROCESS | 17516 | RSS: Main: 158273536 07:47:51 INFO - PROCESS | 17516 | 07:47:54 INFO - PROCESS | 17516 | Cycle 1(1): loaded http://localhost:45877/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45877/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:47:54 INFO - PROCESS | 17516 | RSS: Main: 157913088 07:47:54 INFO - PROCESS | 17516 | 07:47:57 INFO - PROCESS | 17516 | Cycle 1(1): loaded http://localhost:45877/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45877/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:47:58 INFO - PROCESS | 17516 | RSS: Main: 158400512 07:47:58 INFO - PROCESS | 17516 | 07:47:59 INFO - PROCESS | 17516 | Cycle 1(1): loaded http://localhost:45877/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45877/tests/kraken/driver.html?testName=ai-astar) 07:47:59 INFO - PROCESS | 17516 | RSS: Main: 160497664 07:47:59 INFO - PROCESS | 17516 | 07:47:59 INFO - PROCESS | 17516 | __start_tp_report 07:47:59 INFO - PROCESS | 17516 | _x_x_mozilla_page_load 07:47:59 INFO - PROCESS | 17516 | _x_x_mozilla_page_load_details 07:47:59 INFO - PROCESS | 17516 | |i|pagename|runs| 07:47:59 INFO - PROCESS | 17516 | |0;ai-astar;101;113;113;109;112;113;110;112;112;122 07:47:59 INFO - PROCESS | 17516 | |1;audio-beat-detection;149;117;147;177;118;150;150;119;191;117 07:47:59 INFO - PROCESS | 17516 | |2;audio-dft;162;163;161;163;163;165;163;165;163;163 07:47:59 INFO - PROCESS | 17516 | |3;audio-fft;75;76;76;185;76;78;75;76;173;75 07:47:59 INFO - PROCESS | 17516 | |4;audio-oscillator;84;85;149;84;84;85;143;84;85;154 07:47:59 INFO - PROCESS | 17516 | |5;imaging-gaussian-blur;118;121;117;118;118;118;117;118;118;117 07:47:59 INFO - PROCESS | 17516 | |6;imaging-darkroom;148;148;148;149;148;148;148;148;148;148 07:47:59 INFO - PROCESS | 17516 | |7;imaging-desaturate;95;97;95;95;96;96;95;96;100;96 07:47:59 INFO - PROCESS | 17516 | |8;json-parse-financial;53;52;51;51;51;54;51;52;51;54 07:47:59 INFO - PROCESS | 17516 | |9;json-stringify-tinderbox;61;61;60;65;62;59;62;61;61;61 07:47:59 INFO - PROCESS | 17516 | |10;stanford-crypto-aes;72;79;72;79;72;73;72;73;73;78 07:47:59 INFO - PROCESS | 17516 | |11;stanford-crypto-ccm;127;121;123;126;132;125;118;117;153;118 07:47:59 INFO - PROCESS | 17516 | |12;stanford-crypto-pbkdf2;152;152;158;154;151;150;154;157;152;153 07:47:59 INFO - PROCESS | 17516 | |13;stanford-crypto-sha256-iterative;63;62;63;62;65;63;61;62;61;65 07:47:59 INFO - PROCESS | 17516 | __end_tp_report 07:47:59 INFO - PROCESS | 17516 | __start_cc_report 07:47:59 INFO - PROCESS | 17516 | _x_x_mozilla_cycle_collect,890 07:47:59 INFO - PROCESS | 17516 | __end_cc_report 07:47:59 INFO - PROCESS | 17516 | __startTimestamp1474123679925__endTimestamp 07:47:59 INFO - PROCESS | 17516 | 07:47:59 INFO - PROCESS | 17516 | ------- Summary: start ------- 07:47:59 INFO - PROCESS | 17516 | Number of tests: 14 07:47:59 INFO - PROCESS | 17516 | 07:47:59 INFO - PROCESS | 17516 | [#0] ai-astar Cycles:10 Average:111.70 Median:112.50 stddev:5.12 (4.6%) stddev-sans-first:3.69 07:47:59 INFO - PROCESS | 17516 | Values: 101.0 113.0 113.0 109.0 112.0 113.0 110.0 112.0 112.0 122.0 07:47:59 INFO - PROCESS | 17516 | 07:47:59 INFO - PROCESS | 17516 | [#1] audio-beat-detection Cycles:10 Average:143.50 Median:149.50 stddev:26.16 (17.5%) stddev-sans-first:27.67 07:47:59 INFO - PROCESS | 17516 | Values: 149.0 117.0 147.0 177.0 118.0 150.0 150.0 119.0 191.0 117.0 07:47:59 INFO - PROCESS | 17516 | 07:47:59 INFO - PROCESS | 17516 | [#2] audio-dft Cycles:10 Average:163.10 Median:163.00 stddev:1.20 (0.7%) stddev-sans-first:1.20 07:47:59 INFO - PROCESS | 17516 | Values: 162.0 163.0 161.0 163.0 163.0 165.0 163.0 165.0 163.0 163.0 07:47:59 INFO - PROCESS | 17516 | 07:47:59 INFO - PROCESS | 17516 | [#3] audio-fft Cycles:10 Average:96.50 Median:76.00 stddev:43.58 (57.3%) stddev-sans-first:45.53 07:47:59 INFO - PROCESS | 17516 | Values: 75.0 76.0 76.0 185.0 76.0 78.0 75.0 76.0 173.0 75.0 07:47:59 INFO - PROCESS | 17516 | 07:47:59 INFO - PROCESS | 17516 | [#4] audio-oscillator Cycles:10 Average:103.70 Median:84.00 stddev:31.14 (37.1%) stddev-sans-first:32.20 07:47:59 INFO - PROCESS | 17516 | Values: 84.0 85.0 149.0 84.0 84.0 85.0 143.0 84.0 85.0 154.0 07:47:59 INFO - PROCESS | 17516 | 07:47:59 INFO - PROCESS | 17516 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:1.15 (1.0%) stddev-sans-first:1.22 07:47:59 INFO - PROCESS | 17516 | Values: 118.0 121.0 117.0 118.0 118.0 118.0 117.0 118.0 118.0 117.0 07:47:59 INFO - PROCESS | 17516 | 07:47:59 INFO - PROCESS | 17516 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 07:47:59 INFO - PROCESS | 17516 | Values: 148.0 148.0 148.0 149.0 148.0 148.0 148.0 148.0 148.0 148.0 07:47:59 INFO - PROCESS | 17516 | 07:47:59 INFO - PROCESS | 17516 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:1.52 (1.6%) stddev-sans-first:1.56 07:47:59 INFO - PROCESS | 17516 | Values: 95.0 97.0 95.0 95.0 96.0 96.0 95.0 96.0 100.0 96.0 07:47:59 INFO - PROCESS | 17516 | 07:47:59 INFO - PROCESS | 17516 | [#8] json-parse-financial Cycles:10 Average:52.00 Median:52.00 stddev:1.25 (2.4%) stddev-sans-first:1.27 07:47:59 INFO - PROCESS | 17516 | Values: 53.0 52.0 51.0 51.0 51.0 54.0 51.0 52.0 51.0 54.0 07:47:59 INFO - PROCESS | 17516 | 07:47:59 INFO - PROCESS | 17516 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:61.00 stddev:1.57 (2.6%) stddev-sans-first:1.66 07:47:59 INFO - PROCESS | 17516 | Values: 61.0 61.0 60.0 65.0 62.0 59.0 62.0 61.0 61.0 61.0 07:47:59 INFO - PROCESS | 17516 | 07:47:59 INFO - PROCESS | 17516 | [#10] stanford-crypto-aes Cycles:10 Average:74.30 Median:73.00 stddev:3.06 (4.2%) stddev-sans-first:3.13 07:47:59 INFO - PROCESS | 17516 | Values: 72.0 79.0 72.0 79.0 72.0 73.0 72.0 73.0 73.0 78.0 07:47:59 INFO - PROCESS | 17516 | 07:47:59 INFO - PROCESS | 17516 | [#11] stanford-crypto-ccm Cycles:10 Average:126.00 Median:125.50 stddev:10.59 (8.4%) stddev-sans-first:11.23 07:47:59 INFO - PROCESS | 17516 | Values: 127.0 121.0 123.0 126.0 132.0 125.0 118.0 117.0 153.0 118.0 07:47:59 INFO - PROCESS | 17516 | 07:47:59 INFO - PROCESS | 17516 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.30 Median:153.50 stddev:2.54 (1.7%) stddev-sans-first:2.65 07:47:59 INFO - PROCESS | 17516 | Values: 152.0 152.0 158.0 154.0 151.0 150.0 154.0 157.0 152.0 153.0 07:47:59 INFO - PROCESS | 17516 | 07:47:59 INFO - PROCESS | 17516 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:1.42 (2.3%) stddev-sans-first:1.50 07:47:59 INFO - PROCESS | 17516 | Values: 63.0 62.0 63.0 62.0 65.0 63.0 61.0 62.0 61.0 65.0 07:47:59 INFO - PROCESS | 17516 | -------- Summary: end -------- 07:47:59 INFO - PROCESS | 17516 | 07:48:00 INFO - TEST-INFO | 17516: exit 0 07:48:00 INFO - TEST-OK | kraken | took 61188ms 07:48:00 INFO - SUITE-END | took 1172s 07:48:01 INFO - Completed test suite (00:19:32) 07:48:01 INFO - javascript benchmark 07:48:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7799.792763815829, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3252.4796032634777, 3285.737141028718, 3313.9834300828493, 3322.6677332266777, 3334.2497937963963, 5676.8580785480335, 5717.651051596613, 5803.883922321551, 5848.619839710426, 5851.034579294412, 5762.049261871796, 5785.82642520725, 5851.268591426072, 5853.473187413132, 5860.003799354109, 5274.208868669702, 5362.43694412087, 5371.248025276445, 5384.973075134619, 5410.972945135269, 5195.610329225305, 5206.0, 5331.866703332409, 5350.438203988583, 5367.865803354908, 5309.495597918191, 5332.173513105475, 5342.465753424665, 5355.0628639988045, 5417.322834645669, 5399.325084364455, 5419.403865574784, 5423.213634023084, 5424.83725488234, 5467.343918729778, 5111.974440127813, 5196.376434827807, 5196.792128314863, 5276.657017293864, 5287.894242115136, 5718.885622287573, 5745.683987380692, 5790.36306006339, 5795.710214489301, 5876.500497457721, 6206.875862482725, 6251.343608921089, 6257.155284036642, 6271.153394291758, 6278.37216278373, 6122.032243765652, 6184.165137706442, 6224.782132625382, 6357.745690172387, 6363.87272254557, 5890.293164820207, 5901.527877769811, 5907.202527658797, 5928.081147422156, 5944.791932282349, 6427.903581446282, 6465.579737317059, 6475.255345635218, 6476.4495017924, 6491.480681545465, 5997.910031349533, 6074.969625151846, 6124.081387791778, 6127.264728232641, 6218.533609979269, 6302.684865756785, 6316.115743795872, 6339.714712837841, 6343.492520598341, 6353.047042943595, 6269.96865015672, 6273.96863015682, 6282.748690052438, 6287.811365659038, 6299.937000630027, 6035.426634469718, 6122.245686735527, 6151.446369826737, 6287.371262873768, 6299.149614802035, 4773.331733557305, 4792.041591681677, 4795.040991801654, 4816.735079570657, 4828.324034635154, 4221.282381995068, 4242.024334403043, 4252.170826688766, 4258.829646814154, 4296.613304802583, 5789.218455508452, 5873.353931067579, 5898.616589921641, 5927.792527261525, 5984.251968503937, 6198.411150940653, 6233.594816336924, 6234.625922444668, 6244.406781355855, 6270.435660790459, 5946.345901950782, 5974.4622983930785, 5981.730822113015, 6014.488768454643, 6066.423689749467, 4987.152184128707, 5006.324146240284, 5053.191489361684, 5185.429602743695, 5211.895762084737, 6407.487401007908, 6408.2630497492455, 6422.646754428458, 6429.1320671709655, 6432.0351947207355, 6101.0, 6172.105044768394, 6191.876162476635, 6194.752209911553, 6197.938020619917, 6131.254333328352, 6297.590656607306, 6306.747730090745, 6356.713947872265, 6408.102865598913, 6119.593952096689, 6122.367660829284, 6127.342242870382, 6130.065561664973, 6131.682521312607, 6217.160683307696, 6219.968900155471, 6227.595206311757, 6234.0, 6235.563510554218, 5942.7920022799, 6001.7299221536005, 6038.124471951454, 6051.394860513913, 6052.697365131814, 6100.786472473442, 6109.070667812992, 6117.188044311343, 6128.417800308964, 6129.141920131275, 6072.787452439144, 6076.574639775174, 6090.390960903874, 6133.907991380043, 6141.170941922784, 5981.0, 6119.8470038247615, 6121.392004143408, 6137.693115344304, 6148.969255153875, 6043.848903777441, 6052.878942421039, 6089.0, 6112.266528016667, 6119.479844213113], "value": 5743.179517700954, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.1631093070512, 621.1521273461725, 651.5308977536175, 660.7918505670714, 689.6758523493962, 40271.59728402715, 44610.553894461045, 44808.775956120175, 44815.103697926024, 45071.32393014107, 44414.77792611033, 45015.0, 45136.548634513645, 45184.77407612957, 45315.54684453154, 8995.95502022489, 9088.045755195708, 9143.451392916413, 9148.0, 9179.082091790835, 9073.500957447337, 9179.632814687438, 9188.448693078437, 9190.21883139934, 9195.540222988857, 9230.26157907369, 9260.073992600754, 9262.722118336427, 9273.443593384385, 9316.161545460907, 9081.81836363269, 9105.817883642323, 9118.270538356915, 9121.543922803834, 9156.130167634064, 9093.40892841963, 9189.0, 9219.35464517484, 9230.815383692288, 9241.399309044891, 42942.78528607368, 43561.0, 43574.0, 43603.0, 43778.34332485015, 3374.0, 3882.398228274622, 4049.493813273341, 4096.078382363974, 4230.492340919079, 33274.667253327396, 33725.15687107817, 35824.462633060524, 36182.276354472764, 37365.25269494622, 4788.736619485927, 4822.059698358821, 4850.854474365775, 4854.587360074398, 4903.583195428393, 380117.0, 381284.0, 383229.0, 384645.0, 384803.0, 66964.0, 67381.2940288279, 67400.0, 67500.66249668818, 67663.3233667667, 39796.80101599474, 40028.0, 40193.79903100466, 42556.57443425588, 70372.64813676, 19414.514637133903, 19758.60482790336, 19784.604307914047, 19804.40586782399, 19848.50378740543, 15141.0, 15162.545123646309, 15263.236838158047, 15307.693846123015, 15309.08145511273, 20854.478638033866, 20929.0, 21180.682289765668, 21197.894010530155, 21216.78783212148, 7475.43934204926, 7577.507462014952, 7592.8861067084035, 7647.808804779925, 7868.881966770503, 1014.2342531388754, 1137.1244142010605, 1150.3328069719544, 1229.1088960503564, 1240.1319076646384, 33677.494837577455, 34155.0, 34681.47977780335, 34710.13224669403, 35080.12299692528, 1069.2835800014009, 1115.6151127860876, 1147.4836323654388, 1152.1301417429786, 1182.586094866807, 17562.736558951627, 17849.37527186542, 18346.0, 18424.631507369777, 18524.16641251147, 418401.0, 552104.0, 552746.0, 554567.0, 560286.0, 66398.33601663921, 66602.66698666573, 66663.0, 66803.0, 66866.0, 1463.3707505772406, 1499.14548707238, 1528.0373364780116, 1529.755239161751, 1530.3496014194145, 33968.15079623029, 34754.478682819274, 35197.296054079285, 35357.292854143285, 35452.0, 53016.20475692945, 53615.463845361046, 53740.73129634327, 53946.0, 53990.73004635109, 445040.0, 450284.0, 451525.0, 452780.0, 453215.0, 30629.540556891217, 31119.222019449695, 31422.214444639067, 31466.685333146375, 31530.36939261156, 52137.217941731666, 52292.0, 52596.21105683341, 52657.0, 52709.47290527046, 43800.56199438092, 43896.78051609721, 44026.77986610046, 45223.0, 45424.31863521984, 41853.162936741704, 44670.3299450502, 46526.0, 46642.300365495226, 47156.52843471521, 45635.54364456313, 46226.53773462222, 46441.53558464507, 46789.0, 47432.28851567298, 38636.22727545377, 39148.608513915635, 39785.0, 39801.0, 40540.39189412102, 30167.547486788153, 30917.845410772803, 31213.2832694204, 31378.843105784326, 31499.0], "value": 21525.856161994252, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.715235063981, 417.780665150796, 428.7950858088771, 433.11212015368494, 435.2991683389742, 19575.902120489394, 21103.577928441442, 21313.893430532844, 21866.23468178614, 21914.561708765814, 20212.0, 20635.0, 20781.27265545706, 20906.0, 21099.57800843982, 5870.970645146779, 6057.848553786146, 6061.66660833654, 6125.326214116443, 6126.877462450749, 5823.388544202861, 6038.2150320458495, 6044.304904935922, 6073.544484163684, 6149.0468977308365, 6055.6063855849225, 6086.208792856923, 6087.908681369783, 6133.417325354084, 6136.723847426854, 6567.704453299589, 6610.107635469199, 6644.800655980304, 6654.0, 6669.299723529008, 5749.396313387076, 5840.386759390288, 5894.115882617599, 5986.431289027535, 6001.459868611846, 14664.12015279076, 14751.70496590073, 14871.256437178097, 19708.70436943447, 24132.517349653084, 2405.518896220763, 2448.5714999875127, 2466.48203877186, 2515.6855393075866, 2546.2743118211406, 10284.0, 10454.268201225917, 10895.237333386665, 11169.888301117047, 11268.154888383322, 2030.2995466564012, 2037.1749441476227, 2058.3516192399347, 2096.3920463065692, 2107.968380474294, 86444.56777716134, 86699.0, 88128.11871881328, 88476.5576172115, 90199.54900225457, 9039.63841446348, 9498.857517137249, 9514.0, 9872.703818885446, 11233.213675042833, 14523.491677791226, 14534.709305813825, 14539.927300363643, 14542.927285363505, 14569.927150364181, 8608.397412181212, 8616.48301101936, 8640.351973602004, 8693.782870398149, 8754.781130471662, 8828.42615230008, 8853.601587928559, 8940.8658870117, 8968.730938071869, 9187.586558604879, 4255.702100852973, 4456.554344565518, 4476.641868650565, 4495.730256184639, 4606.470255920545, 2119.4065661614463, 2186.180182431588, 2192.40804982657, 2207.7902599253043, 2232.8883555822144, 1017.6489111256604, 1069.1767339148967, 1104.2380757277454, 1106.0211712634216, 1108.983365249522, 20455.386338409873, 20856.165753369998, 21009.68485472719, 21263.68104478434, 21269.46826329323, 1087.152021423291, 1091.1598069486452, 1097.5664612478186, 1160.9477573509212, 1168.485866218861, 11538.134639901873, 11647.317475950225, 11769.529218831321, 11778.76442471163, 11785.0, 405428.0, 409434.0, 412438.0, 543931.0, 548285.0, 95547.52226238964, 102325.48837255915, 107426.46286768516, 107463.0, 107782.0, 1070.817960946641, 1099.0493223361893, 1110.7500812317326, 1146.1117633833678, 1153.8038533449167, 19405.902970485058, 19627.411177664122, 19658.41024769259, 19722.50693732668, 19806.50483737918, 44665.77667111644, 45817.77091114523, 46141.53858461372, 46754.29868551906, 47204.0, 60721.69639151776, 65606.0, 66224.33775662375, 67705.66147169232, 68805.0, 8845.159709827556, 8911.955440222757, 8939.955300223457, 9002.009778924445, 9067.637294508146, 8270.586470676562, 11473.082153427873, 12662.303573303558, 12741.235525868478, 14407.135571865303, 12749.0, 12828.743425131632, 12855.357232138544, 12884.48462061507, 13056.543020994219, 11366.943165284121, 11518.654440366803, 11897.583584574499, 11898.76202475963, 12574.30841303737, 12387.19483233587, 12782.744345113231, 13040.739185216433, 13216.405261763435, 13631.863681363457, 8944.105589441004, 8961.865572016295, 9048.140426659456, 9078.910530736353, 9327.766805829637, 9216.493092879688, 12680.809787853004, 12983.35083245815, 13148.539801107298, 13175.802362964372], "value": 9705.214870517588, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1596.425286896717, 1610.0098439459732, 1804.5669039430531, 1848.4547058617707, 1886.0758228468055, 8264.338852891755, 8879.51162686052, 9022.052684468135, 9673.806523869518, 9744.317897747153, 9415.529223538813, 9492.050794920522, 9515.048495150482, 9515.476648784314, 9533.952330238357, 2515.899364025441, 2518.3074654469983, 2535.835170713907, 2541.301142185895, 2545.2364290712803, 2452.4236804350962, 2533.1260715053277, 2534.277730846709, 2534.569123249052, 2535.0873685473216, 2482.2181012980946, 2488.377905523619, 2496.0889275414434, 2514.208024472285, 2517.647529345893, 2412.589859723851, 2424.527217192648, 2445.303088619735, 2463.3472129885504, 2471.233917485585, 2438.207582535683, 2441.353041444001, 2457.213691618683, 2457.619069044301, 2484.7266800651914, 9333.579988900516, 9503.762405939839, 9528.904710952871, 9533.0, 9535.094166054283, 5449.3188351456065, 5520.696361700105, 5575.0522411190195, 5581.3302403711405, 5581.832545023656, 3541.6812486876047, 3556.2354093869944, 3607.4047782115917, 3665.651763082503, 3706.258748250361, 1186.35936594239, 1195.4321697193764, 1201.4113084588575, 1202.3387137074662, 1208.6313674329326, 12553.932915702177, 12709.046821488426, 12723.10938234324, 12760.553380631633, 12769.61691149267, 4952.455229924705, 4967.155583550805, 5044.873878153002, 5094.719790411563, 5110.48895110486, 11087.279326843729, 11095.50070246841, 11100.222984391015, 11111.888881111085, 11142.164337674545, 5599.412061733541, 5618.185363122406, 5622.269105016322, 5661.745221465044, 5688.0, 4467.30756732707, 4998.725070121178, 5116.923246151311, 5134.2812006319145, 5179.352580927384, 4295.140971805589, 4337.436133302714, 4375.518692943773, 4379.0, 4532.88667783308, 1405.3324670781296, 1418.581518452059, 1430.206235539265, 1448.739226939161, 1463.824341079056, 933.4585940154694, 995.915347195482, 1005.9949700251598, 1011.1506334678758, 1023.6877752285476, 6011.729472173763, 6101.206843110367, 6223.626582405071, 6289.7169627366875, 6324.462420694201, 473.7962676049332, 474.8527956333548, 479.0419161676647, 488.02151685869603, 488.7116601205306, 4031.8588849390717, 4118.5263694674895, 4151.6886233532605, 4156.085661154541, 4181.184668989518, 11509.884901150881, 11639.76720465586, 11661.591844285578, 11771.529138834521, 11860.110491713156, 11466.770664586662, 11509.827352589718, 11549.076073914066, 11605.76788464226, 11742.88257117435, 8565.0, 8612.0, 8711.782205444915, 8719.0, 8724.956375218084, 6167.938320616737, 6173.197484327009, 6239.032949892774, 6271.811845644455, 6289.905651415141, 10624.84062739075, 10656.520456579628, 10758.784824303313, 10774.299670521392, 10777.515011824644, 10629.0, 10786.029257366874, 10788.352698838095, 10842.457877106272, 10912.945435272773, 7495.7001719930595, 7971.3224375926375, 8131.227533384319, 8263.297619702393, 8392.496450213006, 9378.390404623678, 9388.906110938804, 9406.96523382441, 9468.431894086378, 9475.952620236854, 8120.593970301579, 8201.42590018693, 8219.219174178443, 8239.670413183645, 8412.327013838756, 7997.320227780704, 8008.079070906921, 8068.59657017135, 8079.555624440713, 8221.958890205511, 7005.579665220103, 7196.532225405332, 7205.243449437943, 7275.454340924346, 7335.743248986473, 5356.7589458473685, 5363.410024897336, 5481.095619222783, 5578.49793518569, 5622.493975542057, 5483.616146869681, 5520.503154716095, 5552.611317207757, 5569.693666848362, 5610.831675049755], "value": 4846.3331383276945, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.511395236217, 323.25651002693803, 326.1731510620577, 336.1009300122174, 340.7614669731189, 5775.711214439277, 5830.154627578999, 5839.299284085905, 5850.941490585093, 5858.88282234355, 5725.88345272672, 5729.627574207673, 5731.484166425021, 5785.652860828353, 5792.942070579293, 4240.89397765056, 4412.404325416076, 4461.4869290031575, 4518.819247230123, 4539.9546004540025, 4448.177087238855, 4492.865214043584, 4516.774161291923, 4527.547245275479, 4536.228841097005, 4507.954920450803, 4516.728996260218, 4528.50186479487, 4533.977330113345, 4535.410396648431, 4345.78271086446, 4451.5993560579545, 4468.173387923244, 4470.173017991649, 4485.641148708096, 3945.2504024235304, 3950.881473555798, 3967.6708302718625, 3984.9601503984877, 3995.4018392642884, 5645.068563686987, 5650.660960342392, 5652.660840349592, 5671.376148623648, 5706.4864162225185, 5080.822171223989, 5093.006863661588, 5098.847034588968, 5159.380874295071, 5206.114960456732, 6009.399060094, 6041.365656606037, 6051.515878729691, 6079.331273559905, 6081.17904082952, 4297.0, 4360.454943132108, 4371.890702732426, 4377.146456440995, 4394.308191346355, 6228.128062071313, 6249.156363890862, 6270.216222972129, 6299.212598425197, 6345.936540634627, 4454.22051141049, 4455.576720211575, 4492.842750503717, 4501.2670122003265, 4503.0, 4403.603675669141, 4464.263396539534, 4539.114872599877, 4542.0, 4543.704659197141, 5115.2071428928575, 5140.691558506502, 5161.716105614228, 5203.297554830049, 5204.71374074422, 6082.1789058477425, 6087.604305720114, 6116.602420842631, 6117.418845209698, 6163.660998645028, 1530.6862093270852, 1544.3436539470904, 1554.2772610736063, 1564.7105285522214, 1580.217792192872, 998.236349192868, 1008.6772232885406, 1012.9617142428922, 1029.9494515594051, 1034.9896501035043, 5797.8550536236935, 5847.152162936435, 5862.713541718733, 5866.658672582258, 5907.9704601476715, 6154.661493617805, 6195.876082478325, 6246.718897649616, 6255.748850229972, 6273.247210334698, 5675.858103547444, 5838.591298609056, 5886.264216972879, 5898.616589921641, 5903.35063143054, 3298.191942973987, 3346.916327091842, 3359.8656053758064, 3360.613529444145, 3364.360771453416, 6315.336889626615, 6396.680165991682, 6419.582727122815, 6422.614643121427, 6481.4166724994975, 6310.5898116622275, 6356.332585078592, 6362.2503811452225, 6370.8088757337355, 6379.330170332141, 6165.167702360213, 6298.913532369106, 6333.303336632966, 6397.45621622158, 6427.453666438311, 6143.385661433999, 6163.938360616516, 6167.101462312706, 6177.876442471215, 6184.330230837559, 6118.326984031664, 6119.632822030692, 6133.38666133401, 6136.846578835565, 6141.232345956755, 6140.956037473729, 6372.458341041063, 6382.712777924911, 6385.457236134795, 6389.0, 4266.87199384019, 4266.957330426656, 4277.529471758042, 4286.121345124305, 4296.849610263625, 6021.036634138517, 6205.906911396242, 6257.342978987323, 6259.655718935503, 6280.937190628035, 5982.641041537521, 6018.187544681412, 6024.5481588881885, 6027.378090530633, 6052.818415447544, 6029.45734883845, 6048.879022419615, 6050.515958723204, 6061.848453788514, 6066.0, 5806.593538452268, 5946.970265148647, 5991.191189189403, 6150.846228844136, 6172.4692875920655, 6150.078712611474, 6199.194104766351, 6227.719752611234, 6244.438000579969, 6261.279952805486, 5892.882142357214, 5955.166276721176, 5979.820605381846, 6030.396960303934, 6062.636241825505], "value": 4615.2812517158745, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [890.9999999999999, 905.4160066756942, 935.3732998890747, 939.2861425316758, 943.7121677888243, 16465.0, 17454.301827926898, 17920.37278695246, 17950.461486155436, 18037.819621803777, 16441.753373699376, 16739.330426782915, 16786.580335491588, 16818.15909204541, 16828.32686692531, 744.7653988993477, 860.6299291304737, 874.4622057434664, 890.0565400675273, 892.9062448442918, 887.769180013198, 889.4263200235844, 892.2683399612321, 894.6823877523483, 900.4012331799378, 951.8096380723848, 952.3286083311249, 953.3993584042043, 956.0821611253206, 960.1982344742148, 942.7690215897114, 943.6178347769164, 945.4374647084974, 949.1410273702311, 949.9762505937372, 694.8888177891564, 697.5082566790401, 698.0, 700.9264027277164, 702.6978399288304, 16821.831781682147, 17121.486355409357, 17216.91391543047, 17302.394416195373, 17328.306867725274, 16565.66868662632, 17442.0, 17493.912530437265, 17917.0, 18030.729539056792, 13208.603741887759, 13275.668108297274, 13342.599722008355, 13561.389737461739, 13588.32058397086, 4116.300228961084, 4122.525909520414, 4145.54399016108, 4214.136102099063, 4263.147370525876, 68813.65593172052, 83940.0, 84443.0, 85166.0, 86524.13475865223, 12808.80786788199, 12874.678133046562, 12978.610641680765, 13222.140560863512, 13303.933480332536, 23033.769662303497, 23054.538909221723, 23409.41476463102, 23634.527309453715, 23827.0, 9091.727248182566, 9188.770280742901, 9281.071892810665, 9289.256859451227, 9324.90675093254, 5225.451327610546, 5268.868278292996, 5298.788048478018, 5356.678599284055, 5453.3455985281225, 3802.6007269236884, 3936.4882565266903, 3944.7041471889147, 3948.269570129535, 3952.4268980997595, 652.9379708927644, 676.9289224631441, 694.2120693013466, 695.6591270277528, 716.8100453379755, 837.3175861672718, 853.5774791478258, 858.356232825381, 874.7157173918501, 882.6513527156866, 10985.450727463754, 11323.207375483636, 11406.714832129263, 11492.310461372344, 11582.024476044262, 691.1050190003957, 722.7325889420842, 789.3093543149744, 845.0788640381891, 855.1491266190056, 5033.723145226974, 5300.814471493556, 5324.653897496651, 5345.305110335631, 5380.461953804666, 112555.437222815, 113889.0, 117689.0, 119229.0, 120601.39699301623, 61767.691161544804, 71287.28712712806, 101792.49103754581, 106194.0, 106322.46838765757, 88671.0, 91656.99999999866, 91771.54114229386, 91838.54080729553, 93834.53082734543, 10662.626808061681, 11129.276597021168, 11156.386398748147, 11603.419829008348, 11670.591529296435, 55855.44144558503, 56327.0, 57186.7140664294, 57186.7140664294, 57767.71116144393, 72328.0, 80187.0, 80520.0, 82964.58517707614, 83325.0, 13799.51701690436, 13863.37614807316, 14097.0, 14299.928500357431, 14622.488212912496, 15414.46049388266, 15584.376624934876, 15796.842031579537, 16054.43809466663, 16494.0, 15507.612309692347, 15610.219489025276, 15807.209639517749, 16319.918400407922, 16818.327266909677, 15069.321880515185, 15127.16800575979, 15926.681466370375, 16462.42381516641, 16551.91724041372, 13371.866281337063, 13400.262985535888, 14001.369938352595, 14023.0, 15213.6196595086, 12575.748485030432, 12986.675333116369, 13064.477420903437, 13305.733885322434, 13420.463181473022, 11433.428328583705, 11454.370009649549, 11556.248843825124, 12394.628795842715, 13414.932925335701], "value": 8389.325321626064, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1510.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 113.0, 113.0, 109.0, 112.0, 113.0, 110.0, 112.0, 112.0, 122.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 117.0, 147.0, 177.0, 118.0, 150.0, 150.0, 119.0, 191.0, 117.0], "value": 143.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 161.0, 163.0, 163.0, 165.0, 163.0, 165.0, 163.0, 163.0], "value": 163.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 185.0, 76.0, 78.0, 75.0, 76.0, 173.0, 75.0], "value": 96.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 149.0, 84.0, 84.0, 85.0, 143.0, 84.0, 85.0, 154.0], "value": 103.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 121.0, 117.0, 118.0, 118.0, 118.0, 117.0, 118.0, 118.0, 117.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 149.0, 148.0, 148.0, 148.0, 148.0, 148.0, 148.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 100.0, 96.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 51.0, 51.0, 51.0, 54.0, 51.0, 52.0, 51.0, 54.0], "value": 52.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 65.0, 62.0, 59.0, 62.0, 61.0, 61.0, 61.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 79.0, 72.0, 79.0, 72.0, 73.0, 72.0, 73.0, 73.0, 78.0], "value": 74.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 121.0, 123.0, 126.0, 132.0, 125.0, 118.0, 117.0, 153.0, 118.0], "value": 126.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 152.0, 158.0, 154.0, 151.0, 150.0, 154.0, 157.0, 152.0, 153.0], "value": 153.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 62.0, 65.0, 63.0, 61.0, 62.0, 61.0, 65.0], "value": 62.7, "unit": "score"}]}]} 07:48:01 INFO - Return code: 0 07:48:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:48:01 ERROR - # TBPL SUCCESS # 07:48:01 INFO - Running post-action listener: _resource_record_post_action 07:48:01 INFO - [mozharness: 2016-09-17 14:48:01.235616Z] Finished run-tests step (success) 07:48:01 INFO - Running post-run listener: _resource_record_post_run 07:48:01 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 2478080; Write bytes: 328933376; Read time: 1228; Write time: 174972 07:48:01 INFO - TinderboxPrint: CPU usage
13.2% 07:48:01 INFO - TinderboxPrint: I/O read bytes / time
2,478,080 / 1,228 07:48:01 INFO - TinderboxPrint: I/O write bytes / time
328,933,376 / 174,972 07:48:01 INFO - TinderboxPrint: CPU idle
8,230.5 (86.8%) 07:48:01 INFO - TinderboxPrint: CPU user
1,199.6 (12.6%) 07:48:01 INFO - TinderboxPrint: Swap in / out
0 / 0 07:48:01 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 77189120; Read time: 0; Write time: 38248 07:48:01 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 2478080; Write bytes: 249323520; Read time: 1228; Write time: 136488 07:48:01 INFO - Running post-run listener: _upload_blobber_files 07:48:01 INFO - Blob upload gear active. 07:48:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:48:01 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 07:48:01 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'] 07:48:01 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 07:48:02 INFO - (blobuploader) - INFO - Open directory for files ... 07:48:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:48:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:48:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:48:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:48:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:48:05 INFO - (blobuploader) - INFO - Done attempting. 07:48:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:48:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:48:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:48:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:48:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:48:06 INFO - (blobuploader) - INFO - Done attempting. 07:48:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:48:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:48:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:48:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:48:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:48:07 INFO - (blobuploader) - INFO - Done attempting. 07:48:07 INFO - (blobuploader) - INFO - Iteration through files over. 07:48:07 INFO - Return code: 0 07:48:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:48:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:48:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a7276dcd4272667e567df94f5ca7c89378ad0191603b0a32b9ae634a74c86abeb5ffc78699fe2ffc4f8d1506791eb8b48f023a0133a17200ea2fcc3bfffd65bf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fc1762db9d10b03c29821a7e2ab95bc24713d65a0977d3552d090731ba7cb7f478b7472d77ffaa549274cbdb2f1072c47918adfcdac6b09bcb05cbd268e866b2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e76188ac3d7f9702f369c0b1b5b35ab32b69666735878fa3267c42c5b58c3bcf7b11c0c5c81f57ccd5227ed6324ac5b59af8f696973e0beb64bc0ad3ba80043c"} 07:48:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:48:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:48:07 INFO - Contents: 07:48:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a7276dcd4272667e567df94f5ca7c89378ad0191603b0a32b9ae634a74c86abeb5ffc78699fe2ffc4f8d1506791eb8b48f023a0133a17200ea2fcc3bfffd65bf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fc1762db9d10b03c29821a7e2ab95bc24713d65a0977d3552d090731ba7cb7f478b7472d77ffaa549274cbdb2f1072c47918adfcdac6b09bcb05cbd268e866b2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e76188ac3d7f9702f369c0b1b5b35ab32b69666735878fa3267c42c5b58c3bcf7b11c0c5c81f57ccd5227ed6324ac5b59af8f696973e0beb64bc0ad3ba80043c"} 07:48:07 INFO - Running post-run listener: copy_logs_to_upload_dir 07:48:07 INFO - Copying logs to upload dir... 07:48:07 INFO - mkdir: /builds/slave/test/build/upload/logs 07:48:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1676.796326 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 56 secs) (at 2016-09-17 07:48:06.356119) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-17 07:48:06.363367) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1474122008.673593-1028930911 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/a7276dcd4272667e567df94f5ca7c89378ad0191603b0a32b9ae634a74c86abeb5ffc78699fe2ffc4f8d1506791eb8b48f023a0133a17200ea2fcc3bfffd65bf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fc1762db9d10b03c29821a7e2ab95bc24713d65a0977d3552d090731ba7cb7f478b7472d77ffaa549274cbdb2f1072c47918adfcdac6b09bcb05cbd268e866b2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e76188ac3d7f9702f369c0b1b5b35ab32b69666735878fa3267c42c5b58c3bcf7b11c0c5c81f57ccd5227ed6324ac5b59af8f696973e0beb64bc0ad3ba80043c"} build_url:https://queue.taskcluster.net/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011235 build_url: 'https://queue.taskcluster.net/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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/a7276dcd4272667e567df94f5ca7c89378ad0191603b0a32b9ae634a74c86abeb5ffc78699fe2ffc4f8d1506791eb8b48f023a0133a17200ea2fcc3bfffd65bf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fc1762db9d10b03c29821a7e2ab95bc24713d65a0977d3552d090731ba7cb7f478b7472d77ffaa549274cbdb2f1072c47918adfcdac6b09bcb05cbd268e866b2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e76188ac3d7f9702f369c0b1b5b35ab32b69666735878fa3267c42c5b58c3bcf7b11c0c5c81f57ccd5227ed6324ac5b59af8f696973e0beb64bc0ad3ba80043c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-17 07:48:06.388789) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-17 07:48:06.389129) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1474122008.673593-1028930911 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004510 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-17 07:48:06.473641) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-17 07:48:06.476961) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-17 07:48:06.477271) ========= ========= Total master_lag: 0.18 =========