builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-060 starttime: 1466705485.6 results: success (0) buildid: 20160623083527 builduid: 1aadf1fea30f4f37b775e5900b844b27 revision: f403cf3a053abd6036932519b3b7214dbcb76c30 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 11:11:25.598183) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 11:11:25.598733) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 11:11:25.599116) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 11:11:25.615643) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 11:11:25.616313) ========= 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=337fe3f4b1febe37b85fccc40000019e-1466703634.225124-831287079 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-23 11:11:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.5M=0s 2016-06-23 11:11:25 (37.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.080459 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 11:11:25.713282) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 11:11:25.713667) ========= 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=337fe3f4b1febe37b85fccc40000019e-1466703634.225124-831287079 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016352 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 11:11:25.763324) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 11:11:25.763709) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f403cf3a053abd6036932519b3b7214dbcb76c30 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f403cf3a053abd6036932519b3b7214dbcb76c30 --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=337fe3f4b1febe37b85fccc40000019e-1466703634.225124-831287079 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-23 11:11:25,865 truncating revision to first 12 chars 2016-06-23 11:11:25,865 Setting DEBUG logging. 2016-06-23 11:11:25,865 attempt 1/10 2016-06-23 11:11:25,865 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/f403cf3a053a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-23 11:11:26,296 unpacking tar archive at: mozilla-beta-f403cf3a053a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.819251 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 11:11:26.596982) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 11:11:26.597320) ========= script_repo_revision: f403cf3a053abd6036932519b3b7214dbcb76c30 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 11:11:26.597843) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 11:11:26.598160) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 11:11:26.647301) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-23 11:11:26.647749) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1466703634.225124-831287079 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:11:26 INFO - MultiFileLogger online at 20160623 11:11:26 in /builds/slave/test 11:11:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 11:11:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:11:26 INFO - {'append_to_log': False, 11:11:26 INFO - 'base_work_dir': '/builds/slave/test', 11:11:26 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:11:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:11:26 INFO - 'branch': 'Mozilla-Beta', 11:11:26 INFO - 'buildbot_json_path': 'buildprops.json', 11:11:26 INFO - 'config_files': ('talos/linux_config.py',), 11:11:26 INFO - 'default_actions': ('clobber', 11:11:26 INFO - 'read-buildbot-config', 11:11:26 INFO - 'download-and-extract', 11:11:26 INFO - 'populate-webroot', 11:11:26 INFO - 'create-virtualenv', 11:11:26 INFO - 'install', 11:11:26 INFO - 'run-tests'), 11:11:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:11:26 INFO - 'download_minidump_stackwalk': True, 11:11:26 INFO - 'download_symbols': 'ondemand', 11:11:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:11:26 INFO - 'tooltool.py': '/tools/tooltool.py', 11:11:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:11:26 INFO - '/tools/misc-python/virtualenv.py')}, 11:11:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:11:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:11:26 INFO - 'installer_path': 'installer.exe', 11:11:26 INFO - 'log_level': 'info', 11:11:26 INFO - 'log_name': 'talos', 11:11:26 INFO - 'log_to_console': True, 11:11:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:11:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:11:26 INFO - 'opt_config_files': (), 11:11:26 INFO - 'pip_index': False, 11:11:26 INFO - 'sps_profile': False, 11:11:26 INFO - 'sps_profile_interval': 0, 11:11:26 INFO - 'suite': 'dromaeojs', 11:11:26 INFO - 'system_bits': '32', 11:11:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:11:26 INFO - 'title': 'talos-linux64-ix-060', 11:11:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:11:26 INFO - 'use_talos_json': True, 11:11:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:11:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:11:26 INFO - 'work_dir': 'build'} 11:11:26 INFO - ##### 11:11:26 INFO - ##### Running clobber step. 11:11:26 INFO - ##### 11:11:26 INFO - Running pre-action listener: _resource_record_pre_action 11:11:26 INFO - Running main action method: clobber 11:11:26 INFO - rmtree: /builds/slave/test/build 11:11:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:11:27 INFO - Running post-action listener: _resource_record_post_action 11:11:27 INFO - ##### 11:11:27 INFO - ##### Running read-buildbot-config step. 11:11:27 INFO - ##### 11:11:27 INFO - Running pre-action listener: _resource_record_pre_action 11:11:27 INFO - Running main action method: read_buildbot_config 11:11:27 INFO - Using buildbot properties: 11:11:27 INFO - { 11:11:27 INFO - "project": "", 11:11:27 INFO - "product": "firefox", 11:11:27 INFO - "script_repo_revision": "production", 11:11:27 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 11:11:27 INFO - "repository": "", 11:11:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 11:11:27 INFO - "buildid": "20160623083527", 11:11:27 INFO - "pgo_build": "True", 11:11:27 INFO - "basedir": "/builds/slave/test", 11:11:27 INFO - "buildnumber": 69, 11:11:27 INFO - "slavename": "talos-linux64-ix-060", 11:11:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:11:27 INFO - "platform": "ubuntu64_hw", 11:11:27 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 11:11:27 INFO - "branch": "mozilla-beta", 11:11:27 INFO - "repo_path": "releases/mozilla-beta", 11:11:27 INFO - "revision": "f403cf3a053abd6036932519b3b7214dbcb76c30", 11:11:27 INFO - "stage_platform": "linux64-pgo", 11:11:27 INFO - "builduid": "1aadf1fea30f4f37b775e5900b844b27", 11:11:27 INFO - "slavebuilddir": "test" 11:11:27 INFO - } 11:11:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/Lr1jcZkkSF6iQBPU8eW-xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 11:11:27 INFO - Running post-action listener: _resource_record_post_action 11:11:27 INFO - ##### 11:11:27 INFO - ##### Running download-and-extract step. 11:11:27 INFO - ##### 11:11:27 INFO - Running pre-action listener: _resource_record_pre_action 11:11:27 INFO - Running main action method: download_and_extract 11:11:27 INFO - mkdir: /builds/slave/test/build/tests 11:11:27 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')]} 11:11:27 INFO - https://queue.taskcluster.net/v1/task/Lr1jcZkkSF6iQBPU8eW-xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:11:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lr1jcZkkSF6iQBPU8eW-xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 11:11:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lr1jcZkkSF6iQBPU8eW-xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 11:11:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lr1jcZkkSF6iQBPU8eW-xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 11:11:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lr1jcZkkSF6iQBPU8eW-xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:11:28 INFO - Downloaded 1327 bytes. 11:11:28 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 11:11:28 INFO - Using the following test package requirements: 11:11:28 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 11:11:28 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 11:11:28 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 11:11:28 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 11:11:28 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 11:11:28 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 11:11:28 INFO - u'jsshell-linux-x86_64.zip'], 11:11:28 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 11:11:28 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 11:11:28 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 11:11:28 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 11:11:28 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 11:11:28 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 11:11:28 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 11:11:28 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 11:11:28 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 11:11:28 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 11:11:28 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 11:11:28 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:11: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')]} 11:11:28 INFO - https://queue.taskcluster.net/v1/task/Lr1jcZkkSF6iQBPU8eW-xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:11:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lr1jcZkkSF6iQBPU8eW-xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 11:11:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lr1jcZkkSF6iQBPU8eW-xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 11:11:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lr1jcZkkSF6iQBPU8eW-xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 11:11:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lr1jcZkkSF6iQBPU8eW-xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:11:29 INFO - Downloaded 24185520 bytes. 11:11:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:11:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:11:31 INFO - Return code: 0 11:11:31 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:11:31 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')]} 11:11:31 INFO - https://queue.taskcluster.net/v1/task/Lr1jcZkkSF6iQBPU8eW-xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:11:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lr1jcZkkSF6iQBPU8eW-xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 11:11:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lr1jcZkkSF6iQBPU8eW-xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 11:11:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lr1jcZkkSF6iQBPU8eW-xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 11:11:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lr1jcZkkSF6iQBPU8eW-xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:11:36 INFO - Downloaded 24185520 bytes. 11:11:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:11:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:11:37 INFO - Return code: 0 11:11:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:37 INFO - https://queue.taskcluster.net/v1/task/Lr1jcZkkSF6iQBPU8eW-xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:11:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lr1jcZkkSF6iQBPU8eW-xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 11:11:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lr1jcZkkSF6iQBPU8eW-xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 11:11:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lr1jcZkkSF6iQBPU8eW-xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 11:11:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lr1jcZkkSF6iQBPU8eW-xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:11:38 INFO - Downloaded 10840145 bytes. 11:11:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:11:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:11:38 INFO - Return code: 0 11:11:38 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')]} 11:11:38 INFO - https://queue.taskcluster.net/v1/task/Lr1jcZkkSF6iQBPU8eW-xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:11:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lr1jcZkkSF6iQBPU8eW-xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 11:11:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lr1jcZkkSF6iQBPU8eW-xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 11:11:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lr1jcZkkSF6iQBPU8eW-xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 11:11:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lr1jcZkkSF6iQBPU8eW-xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:11:44 INFO - Downloaded 56013362 bytes. 11:11:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Lr1jcZkkSF6iQBPU8eW-xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 11:11:44 INFO - mkdir: /builds/slave/test/properties 11:11:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:11:44 INFO - Writing to file /builds/slave/test/properties/build_url 11:11:44 INFO - Contents: 11:11:44 INFO - build_url:https://queue.taskcluster.net/v1/task/Lr1jcZkkSF6iQBPU8eW-xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 11:11:44 INFO - Running post-action listener: _resource_record_post_action 11:11:44 INFO - Running post-action listener: set_extra_try_arguments 11:11:44 INFO - ##### 11:11:44 INFO - ##### Running populate-webroot step. 11:11:44 INFO - ##### 11:11:44 INFO - Running pre-action listener: _resource_record_pre_action 11:11:44 INFO - Running main action method: populate_webroot 11:11:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:11:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:11:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:11:45 INFO - '--tppagecycles', 11:11:45 INFO - '7'], 11:11:45 INFO - 'tests': ['tsvgm']}}, 11:11:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:11:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:11:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:11:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:11:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:11:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:11:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:45 INFO - 'talos_options': ['--disable-e10s'], 11:11:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:11:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:11:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:45 INFO - 'talos_options': ['--disable-e10s'], 11:11:45 INFO - 'tests': ['damp', 'tps']}, 11:11:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:45 INFO - 'tests': ['damp', 'tps']}, 11:11:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:11:45 INFO - 'tests': ['dromaeo_dom']}, 11:11:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:11:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:11:45 INFO - 'tests': ['a11yr', 11:11:45 INFO - 'ts_paint', 11:11:45 INFO - 'tpaint', 11:11:45 INFO - 'sessionrestore', 11:11:45 INFO - 'sessionrestore_no_auto_restore', 11:11:45 INFO - 'tabpaint']}, 11:11:45 INFO - 'other-e10s': {'tests': ['a11yr', 11:11:45 INFO - 'ts_paint', 11:11:45 INFO - 'tpaint', 11:11:45 INFO - 'sessionrestore', 11:11:45 INFO - 'sessionrestore_no_auto_restore', 11:11:45 INFO - 'tabpaint']}, 11:11:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:11:45 INFO - 'ts_paint', 11:11:45 INFO - 'tpaint', 11:11:45 INFO - 'sessionrestore', 11:11:45 INFO - 'sessionrestore_no_auto_restore', 11:11:45 INFO - 'tabpaint']}, 11:11:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:11:45 INFO - 'ts_paint', 11:11:45 INFO - 'tpaint', 11:11:45 INFO - 'sessionrestore', 11:11:45 INFO - 'sessionrestore_no_auto_restore', 11:11:45 INFO - 'tabpaint']}, 11:11:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:11:45 INFO - 'tests': ['a11yr', 11:11:45 INFO - 'ts_paint', 11:11:45 INFO - 'tpaint', 11:11:45 INFO - 'sessionrestore', 11:11:45 INFO - 'sessionrestore_no_auto_restore', 11:11:45 INFO - 'tabpaint']}, 11:11:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:11:45 INFO - 'tests': ['a11yr', 11:11:45 INFO - 'ts_paint', 11:11:45 INFO - 'tpaint', 11:11:45 INFO - 'sessionrestore', 11:11:45 INFO - 'sessionrestore_no_auto_restore', 11:11:45 INFO - 'tabpaint']}, 11:11:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:11:45 INFO - 'tests': ['tsvgx', 11:11:45 INFO - 'tsvgr_opacity', 11:11:45 INFO - 'tart', 11:11:45 INFO - 'tscrollx', 11:11:45 INFO - 'cart']}, 11:11:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:11:45 INFO - 'tsvgr_opacity', 11:11:45 INFO - 'tart', 11:11:45 INFO - 'tscrollx', 11:11:45 INFO - 'cart']}, 11:11:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:45 INFO - 'talos_options': ['--disable-e10s'], 11:11:45 INFO - 'tests': ['tp5o']}, 11:11:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:45 INFO - 'tests': ['tp5o']}, 11:11:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:45 INFO - 'talos_options': ['--disable-e10s', 11:11:45 INFO - '--xperf_path', 11:11:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:11:45 INFO - 'tests': ['tp5n']}, 11:11:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:45 INFO - 'talos_options': ['--xperf_path', 11:11:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:11:45 INFO - 'tests': ['tp5n']}}, 11:11:45 INFO - 'talos.zip': {'path': '', 11:11:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:11:45 INFO - Running post-action listener: _resource_record_post_action 11:11:45 INFO - ##### 11:11:45 INFO - ##### Running create-virtualenv step. 11:11:45 INFO - ##### 11:11:45 INFO - Running pre-action listener: _resource_record_pre_action 11:11:45 INFO - Running main action method: create_virtualenv 11:11:45 INFO - Creating virtualenv /builds/slave/test/build/venv 11:11:45 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 11:11:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:11:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:11:45 INFO - Using real prefix '/usr' 11:11:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:11:45 INFO - Installing distribute.............................................................................................................................................................................................done. 11:11:47 INFO - Installing pip.................done. 11:11:47 INFO - Return code: 0 11:11:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:11:47 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')]} 11:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:47 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')]} 11:11:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:47 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 0x7fb30f681f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19215a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b0410>, '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 0x19b1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b17a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466703634.225124-831287079', '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 11:11:47 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 11:11:47 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 11:11:47 INFO - Using env: {'DISPLAY': ':0', 11:11:47 INFO - 'HOME': '/home/cltbld', 11:11:47 INFO - 'LANG': 'en_US.UTF-8', 11:11:47 INFO - 'LANGUAGE': 'en_US:en', 11:11:47 INFO - 'LOGNAME': 'cltbld', 11:11:47 INFO - 'MAIL': '/var/mail/cltbld', 11:11:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:47 INFO - 'MOZ_NO_REMOTE': '1', 11:11:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:47 INFO - 'NO_EM_RESTART': '1', 11:11:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:47 INFO - 'PWD': '/builds/slave/test', 11:11:47 INFO - 'SHELL': '/bin/bash', 11:11:47 INFO - 'SHLVL': '1', 11:11:47 INFO - 'TERM': 'linux', 11:11:47 INFO - 'TMOUT': '86400', 11:11:47 INFO - 'USER': 'cltbld', 11:11:47 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466703634.225124-831287079', 11:11:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:47 INFO - '_': '/tools/buildbot/bin/python'} 11:11:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:47 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 11:11:47 INFO - Cleaning up... 11:11:47 INFO - Return code: 0 11:11:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:11:47 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')]} 11:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:47 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')]} 11:11:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:47 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb30f681f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19215a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b0410>, '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 0x19b1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b17a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466703634.225124-831287079', '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 11:11:47 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>=0.7.1'] in /builds/slave/test/build 11:11:47 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>=0.7.1 11:11:47 INFO - Using env: {'DISPLAY': ':0', 11:11:47 INFO - 'HOME': '/home/cltbld', 11:11:47 INFO - 'LANG': 'en_US.UTF-8', 11:11:47 INFO - 'LANGUAGE': 'en_US:en', 11:11:47 INFO - 'LOGNAME': 'cltbld', 11:11:47 INFO - 'MAIL': '/var/mail/cltbld', 11:11:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:47 INFO - 'MOZ_NO_REMOTE': '1', 11:11:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:47 INFO - 'NO_EM_RESTART': '1', 11:11:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:47 INFO - 'PWD': '/builds/slave/test', 11:11:47 INFO - 'SHELL': '/bin/bash', 11:11:47 INFO - 'SHLVL': '1', 11:11:47 INFO - 'TERM': 'linux', 11:11:47 INFO - 'TMOUT': '86400', 11:11:47 INFO - 'USER': 'cltbld', 11:11:47 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466703634.225124-831287079', 11:11:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:47 INFO - '_': '/tools/buildbot/bin/python'} 11:11:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:47 INFO - Downloading/unpacking psutil>=0.7.1 11:11:47 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 11:11:47 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 11:11:47 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 11:11:47 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 11:11:47 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 11:11:47 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 11:11:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:11:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:11:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:11:50 INFO - Installing collected packages: psutil 11:11:50 INFO - Running setup.py install for psutil 11:11:50 INFO - building 'psutil._psutil_linux' extension 11:11:50 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 11:11:50 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 11:11:50 INFO - building 'psutil._psutil_posix' extension 11:11:50 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 11:11:50 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 11:11:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:11:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:11:50 INFO - Successfully installed psutil 11:11:50 INFO - Cleaning up... 11:11:50 INFO - Return code: 0 11:11:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:50 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb30f681f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19215a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b0410>, '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 0x19b1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b17a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466703634.225124-831287079', '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 11:11:50 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.0.0'] in /builds/slave/test/build 11:11:50 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.0.0 11:11:50 INFO - Using env: {'DISPLAY': ':0', 11:11:50 INFO - 'HOME': '/home/cltbld', 11:11:50 INFO - 'LANG': 'en_US.UTF-8', 11:11:50 INFO - 'LANGUAGE': 'en_US:en', 11:11:50 INFO - 'LOGNAME': 'cltbld', 11:11:50 INFO - 'MAIL': '/var/mail/cltbld', 11:11:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:50 INFO - 'MOZ_NO_REMOTE': '1', 11:11:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:50 INFO - 'NO_EM_RESTART': '1', 11:11:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:50 INFO - 'PWD': '/builds/slave/test', 11:11:50 INFO - 'SHELL': '/bin/bash', 11:11:50 INFO - 'SHLVL': '1', 11:11:50 INFO - 'TERM': 'linux', 11:11:50 INFO - 'TMOUT': '86400', 11:11:50 INFO - 'USER': 'cltbld', 11:11:50 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466703634.225124-831287079', 11:11:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:50 INFO - '_': '/tools/buildbot/bin/python'} 11:11:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:11:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:11:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:11:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:11:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:11:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:11:52 INFO - Installing collected packages: mozsystemmonitor 11:11:52 INFO - Running setup.py install for mozsystemmonitor 11:11:52 INFO - Successfully installed mozsystemmonitor 11:11:52 INFO - Cleaning up... 11:11:52 INFO - Return code: 0 11:11:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:11: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')]} 11:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11: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')]} 11:11:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11: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', '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 0x7fb30f681f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19215a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b0410>, '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 0x19b1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b17a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466703634.225124-831287079', '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 11:11: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:11: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 blobuploader==1.2.4 11:11:52 INFO - Using env: {'DISPLAY': ':0', 11:11:52 INFO - 'HOME': '/home/cltbld', 11:11:52 INFO - 'LANG': 'en_US.UTF-8', 11:11:52 INFO - 'LANGUAGE': 'en_US:en', 11:11:52 INFO - 'LOGNAME': 'cltbld', 11:11:52 INFO - 'MAIL': '/var/mail/cltbld', 11:11:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:52 INFO - 'MOZ_NO_REMOTE': '1', 11:11:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:52 INFO - 'NO_EM_RESTART': '1', 11:11:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:52 INFO - 'PWD': '/builds/slave/test', 11:11:52 INFO - 'SHELL': '/bin/bash', 11:11:52 INFO - 'SHLVL': '1', 11:11:52 INFO - 'TERM': 'linux', 11:11:52 INFO - 'TMOUT': '86400', 11:11:52 INFO - 'USER': 'cltbld', 11:11:52 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466703634.225124-831287079', 11:11:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:52 INFO - '_': '/tools/buildbot/bin/python'} 11:11:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:53 INFO - Downloading/unpacking blobuploader==1.2.4 11:11:53 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 11:11:53 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 11:11:53 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 11:11:53 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 11:11:53 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 11:11:53 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 11:11:54 INFO - Downloading blobuploader-1.2.4.tar.gz 11:11:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:11:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:11: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 11:11: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 11:11: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 11:11: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 11:11: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 11:11: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 11:11:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:11:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:11: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 11:11: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 11:11: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 11:11: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 11:11: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 11:11: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 11:11:55 INFO - Downloading docopt-0.6.1.tar.gz 11:11:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:11:55 INFO - Installing collected packages: blobuploader, requests, docopt 11:11:55 INFO - Running setup.py install for blobuploader 11:11:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:11:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:11:55 INFO - Running setup.py install for requests 11:11:56 INFO - Running setup.py install for docopt 11:11:56 INFO - Successfully installed blobuploader requests docopt 11:11:56 INFO - Cleaning up... 11:11:56 INFO - Return code: 0 11:11:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:11:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:56 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 0x7fb30f681f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19215a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b0410>, '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 0x19b1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b17a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466703634.225124-831287079', '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 11:11:56 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 11:11:56 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 11:11:56 INFO - Using env: {'DISPLAY': ':0', 11:11:56 INFO - 'HOME': '/home/cltbld', 11:11:56 INFO - 'LANG': 'en_US.UTF-8', 11:11:56 INFO - 'LANGUAGE': 'en_US:en', 11:11:56 INFO - 'LOGNAME': 'cltbld', 11:11:56 INFO - 'MAIL': '/var/mail/cltbld', 11:11:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:56 INFO - 'MOZ_NO_REMOTE': '1', 11:11:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:56 INFO - 'NO_EM_RESTART': '1', 11:11:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:56 INFO - 'PWD': '/builds/slave/test', 11:11:56 INFO - 'SHELL': '/bin/bash', 11:11:56 INFO - 'SHLVL': '1', 11:11:56 INFO - 'TERM': 'linux', 11:11:56 INFO - 'TMOUT': '86400', 11:11:56 INFO - 'USER': 'cltbld', 11:11:56 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466703634.225124-831287079', 11:11:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:56 INFO - '_': '/tools/buildbot/bin/python'} 11:11:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:11:56 INFO - Running setup.py (path:/tmp/pip-E1FZ_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:11:56 INFO - Running setup.py (path:/tmp/pip-SmJNyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:11:56 INFO - Running setup.py (path:/tmp/pip-8d3brE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:11:56 INFO - Running setup.py (path:/tmp/pip-pjtzIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:11:56 INFO - Running setup.py (path:/tmp/pip-3V0uNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:11:56 INFO - Running setup.py (path:/tmp/pip-uHiESD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:11:57 INFO - Running setup.py (path:/tmp/pip-5h5BPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:11:57 INFO - Running setup.py (path:/tmp/pip-Fg5sbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:11:57 INFO - Running setup.py (path:/tmp/pip-5KeEZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:11:57 INFO - Running setup.py (path:/tmp/pip-LMQTiX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:11:57 INFO - Running setup.py (path:/tmp/pip-zJ6VW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:11:57 INFO - Running setup.py (path:/tmp/pip-_GcAq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:11:57 INFO - Running setup.py (path:/tmp/pip-3EBtXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:11:57 INFO - Running setup.py (path:/tmp/pip-17Y_Fh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:11:57 INFO - Running setup.py (path:/tmp/pip-qGB7ir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:11:57 INFO - Running setup.py (path:/tmp/pip-5w7uKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:11:57 INFO - Running setup.py (path:/tmp/pip-QRXLgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:11:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:11:57 INFO - Running setup.py install for manifestparser 11:11:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:11:57 INFO - Running setup.py install for mozcrash 11:11:58 INFO - Running setup.py install for mozdebug 11:11:58 INFO - Running setup.py install for mozdevice 11:11:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:11:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:11:58 INFO - Running setup.py install for mozfile 11:11:58 INFO - Running setup.py install for mozhttpd 11:11:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:11:58 INFO - Running setup.py install for mozinfo 11:11:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:11:58 INFO - Running setup.py install for mozInstall 11:11:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:11:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:11:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:11:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:11:58 INFO - Running setup.py install for mozleak 11:11:58 INFO - Running setup.py install for mozlog 11:11:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:11:58 INFO - Running setup.py install for moznetwork 11:11:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:11:58 INFO - Running setup.py install for mozprocess 11:11:59 INFO - Running setup.py install for mozprofile 11:11:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:11:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:11:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:11:59 INFO - Running setup.py install for mozrunner 11:11:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:11:59 INFO - Running setup.py install for mozscreenshot 11:11:59 INFO - Running setup.py install for moztest 11:11:59 INFO - Running setup.py install for mozversion 11:11:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:11:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:11:59 INFO - Cleaning up... 11:11:59 INFO - Return code: 0 11:11:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:11:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:59 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 0x7fb30f681f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19215a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b0410>, '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 0x19b1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b17a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466703634.225124-831287079', '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 11:11:59 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 11:11:59 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 11:11:59 INFO - Using env: {'DISPLAY': ':0', 11:11:59 INFO - 'HOME': '/home/cltbld', 11:11:59 INFO - 'LANG': 'en_US.UTF-8', 11:11:59 INFO - 'LANGUAGE': 'en_US:en', 11:11:59 INFO - 'LOGNAME': 'cltbld', 11:11:59 INFO - 'MAIL': '/var/mail/cltbld', 11:11:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:59 INFO - 'MOZ_NO_REMOTE': '1', 11:11:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:59 INFO - 'NO_EM_RESTART': '1', 11:11:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:59 INFO - 'PWD': '/builds/slave/test', 11:11:59 INFO - 'SHELL': '/bin/bash', 11:11:59 INFO - 'SHLVL': '1', 11:11:59 INFO - 'TERM': 'linux', 11:11:59 INFO - 'TMOUT': '86400', 11:11:59 INFO - 'USER': 'cltbld', 11:11:59 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466703634.225124-831287079', 11:11:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:59 INFO - '_': '/tools/buildbot/bin/python'} 11:11:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:11:59 INFO - Running setup.py (path:/tmp/pip-lB1iqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:11:59 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)) 11:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:11:59 INFO - Running setup.py (path:/tmp/pip-dH4_Xt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:11:59 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)) 11:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:11:59 INFO - Running setup.py (path:/tmp/pip-EDNU58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:12:00 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)) 11:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:12:00 INFO - Running setup.py (path:/tmp/pip-511uG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:12:00 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)) 11:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:12:00 INFO - Running setup.py (path:/tmp/pip-TGmUe5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:12:00 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)) 11:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:12:00 INFO - Running setup.py (path:/tmp/pip-AFQ72L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:12:00 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)) 11:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:12:00 INFO - Running setup.py (path:/tmp/pip-bw39qs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:12:00 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)) 11:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:12:00 INFO - Running setup.py (path:/tmp/pip-IAEDn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:12:00 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)) 11:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:12:00 INFO - Running setup.py (path:/tmp/pip-2Ly2cl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:12:00 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)) 11:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:12:00 INFO - Running setup.py (path:/tmp/pip-dQHg0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:12:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 11:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:12:00 INFO - Running setup.py (path:/tmp/pip-ddzTB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:12:00 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)) 11:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:12:00 INFO - Running setup.py (path:/tmp/pip-5ZFXRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:12:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 11:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:12:00 INFO - Running setup.py (path:/tmp/pip-jCdSFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:12:00 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)) 11:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:12:00 INFO - Running setup.py (path:/tmp/pip-u6GZ2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:12:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 11:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:00 INFO - Running setup.py (path:/tmp/pip-O6kyKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:00 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)) 11:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:12:00 INFO - Running setup.py (path:/tmp/pip-i6wJaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:12:01 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)) 11:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:12:01 INFO - Running setup.py (path:/tmp/pip-PRZ8Mb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:12:01 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)) 11:12:01 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)) 11:12:01 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)) 11:12:01 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)) 11:12:01 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)) 11:12:01 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)) 11:12:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:02 INFO - Downloading blessings-1.6.tar.gz 11:12:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:12:03 INFO - Installing collected packages: blessings 11:12:03 INFO - Running setup.py install for blessings 11:12:03 INFO - Successfully installed blessings 11:12:03 INFO - Cleaning up... 11:12:03 INFO - Return code: 0 11:12:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:12:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:12:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:12:03 INFO - Reading from file tmpfile_stdout 11:12:03 INFO - Current package versions: 11:12:03 INFO - argparse == 1.2.1 11:12:03 INFO - blessings == 1.6 11:12:03 INFO - blobuploader == 1.2.4 11:12:03 INFO - docopt == 0.6.1 11:12:03 INFO - manifestparser == 1.1 11:12:03 INFO - mozInstall == 1.12 11:12:03 INFO - mozcrash == 0.17 11:12:03 INFO - mozdebug == 0.1 11:12:03 INFO - mozdevice == 0.48 11:12:03 INFO - mozfile == 1.2 11:12:03 INFO - mozhttpd == 0.7 11:12:03 INFO - mozinfo == 0.9 11:12:03 INFO - mozleak == 0.1 11:12:03 INFO - mozlog == 3.1 11:12:03 INFO - moznetwork == 0.27 11:12:03 INFO - mozprocess == 0.22 11:12:03 INFO - mozprofile == 0.28 11:12:03 INFO - mozrunner == 6.11 11:12:03 INFO - mozscreenshot == 0.1 11:12:03 INFO - mozsystemmonitor == 0.0 11:12:03 INFO - moztest == 0.7 11:12:03 INFO - mozversion == 1.4 11:12:03 INFO - psutil == 3.1.1 11:12:03 INFO - requests == 1.2.3 11:12:03 INFO - wsgiref == 0.1.2 11:12:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:12:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:03 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 0x7fb30f681f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19215a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b0410>, '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 0x19b1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b17a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466703634.225124-831287079', '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 11:12:03 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 11:12:03 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 11:12:03 INFO - Using env: {'DISPLAY': ':0', 11:12:03 INFO - 'HOME': '/home/cltbld', 11:12:03 INFO - 'LANG': 'en_US.UTF-8', 11:12:03 INFO - 'LANGUAGE': 'en_US:en', 11:12:03 INFO - 'LOGNAME': 'cltbld', 11:12:03 INFO - 'MAIL': '/var/mail/cltbld', 11:12:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:03 INFO - 'MOZ_NO_REMOTE': '1', 11:12:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:03 INFO - 'NO_EM_RESTART': '1', 11:12:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:03 INFO - 'PWD': '/builds/slave/test', 11:12:03 INFO - 'SHELL': '/bin/bash', 11:12:03 INFO - 'SHLVL': '1', 11:12:03 INFO - 'TERM': 'linux', 11:12:03 INFO - 'TMOUT': '86400', 11:12:03 INFO - 'USER': 'cltbld', 11:12:03 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466703634.225124-831287079', 11:12:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:03 INFO - '_': '/tools/buildbot/bin/python'} 11:12:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:03 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)) 11:12:03 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)) 11:12:03 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)) 11:12:03 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)) 11:12:03 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)) 11:12:03 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)) 11:12:03 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)) 11:12:03 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)) 11:12:03 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)) 11:12:03 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)) 11:12:03 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)) 11:12:03 INFO - Cleaning up... 11:12:03 INFO - Return code: 0 11:12:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:12:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb30f681f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19215a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b0410>, '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 0x19b1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b17a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466703634.225124-831287079', '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 11:12:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:12:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:12:03 INFO - Using env: {'DISPLAY': ':0', 11:12:03 INFO - 'HOME': '/home/cltbld', 11:12:03 INFO - 'LANG': 'en_US.UTF-8', 11:12:03 INFO - 'LANGUAGE': 'en_US:en', 11:12:03 INFO - 'LOGNAME': 'cltbld', 11:12:03 INFO - 'MAIL': '/var/mail/cltbld', 11:12:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:03 INFO - 'MOZ_NO_REMOTE': '1', 11:12:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:03 INFO - 'NO_EM_RESTART': '1', 11:12:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:03 INFO - 'PWD': '/builds/slave/test', 11:12:03 INFO - 'SHELL': '/bin/bash', 11:12:03 INFO - 'SHLVL': '1', 11:12:03 INFO - 'TERM': 'linux', 11:12:03 INFO - 'TMOUT': '86400', 11:12:03 INFO - 'USER': 'cltbld', 11:12:03 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466703634.225124-831287079', 11:12:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:03 INFO - '_': '/tools/buildbot/bin/python'} 11:12:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:03 INFO - Downloading/unpacking jsonschema 11:12: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 11:12: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 11:12: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 11:12: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 11:12: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 11:12: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 11:12:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:12:05 INFO - Downloading/unpacking functools32 (from jsonschema) 11:12:05 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 11:12:05 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 11:12:05 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 11:12:05 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 11:12:05 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 11:12:05 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 11:12:05 INFO - Downloading functools32-3.2.3-2.tar.gz 11:12:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:12:06 INFO - warning: no files found matching '*.txt' 11:12:06 INFO - no previously-included directories found matching 'build' 11:12:06 INFO - no previously-included directories found matching 'dist' 11:12:06 INFO - no previously-included directories found matching '.git*' 11:12:06 INFO - Installing collected packages: jsonschema, functools32 11:12:06 INFO - Running setup.py install for functools32 11:12:06 INFO - warning: no files found matching '*.txt' 11:12:06 INFO - no previously-included directories found matching 'build' 11:12:06 INFO - no previously-included directories found matching 'dist' 11:12:06 INFO - no previously-included directories found matching '.git*' 11:12:06 INFO - Successfully installed jsonschema functools32 11:12:06 INFO - Cleaning up... 11:12:06 INFO - Return code: 0 11:12:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:12:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb30f681f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19215a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b0410>, '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 0x19b1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b17a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466703634.225124-831287079', '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 11:12:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 11:12:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:12:06 INFO - Using env: {'DISPLAY': ':0', 11:12:06 INFO - 'HOME': '/home/cltbld', 11:12:06 INFO - 'LANG': 'en_US.UTF-8', 11:12:06 INFO - 'LANGUAGE': 'en_US:en', 11:12:06 INFO - 'LOGNAME': 'cltbld', 11:12:06 INFO - 'MAIL': '/var/mail/cltbld', 11:12:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:06 INFO - 'MOZ_NO_REMOTE': '1', 11:12:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:06 INFO - 'NO_EM_RESTART': '1', 11:12:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:06 INFO - 'PWD': '/builds/slave/test', 11:12:06 INFO - 'SHELL': '/bin/bash', 11:12:06 INFO - 'SHLVL': '1', 11:12:06 INFO - 'TERM': 'linux', 11:12:06 INFO - 'TMOUT': '86400', 11:12:06 INFO - 'USER': 'cltbld', 11:12:06 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466703634.225124-831287079', 11:12:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:06 INFO - '_': '/tools/buildbot/bin/python'} 11:12:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:06 INFO - Downloading/unpacking flake8 11:12:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:12:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:12: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 11:12: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 11:12: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 11:12: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 11:12: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 11:12: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 11:12:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:12:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:12: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 11:12: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 11:12: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 11:12: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 11:12: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 11:12: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 11:12:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:12: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 11:12: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 11:12: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 11:12: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 11:12: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 11:12: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 11:12:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:12:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:12:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:12:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:12:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:12:09 INFO - no previously-included directories found matching 'docs/_build' 11:12:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:12:09 INFO - Running setup.py install for pep8 11:12:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:12:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:12:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:12:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:12:09 INFO - no previously-included directories found matching 'docs/_build' 11:12:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:12:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:12:09 INFO - Cleaning up... 11:12:09 INFO - Return code: 0 11:12:09 INFO - Running post-action listener: _resource_record_post_action 11:12:09 INFO - Running post-action listener: _start_resource_monitoring 11:12:09 INFO - Starting resource monitoring. 11:12:09 INFO - ##### 11:12:09 INFO - ##### Running install step. 11:12:09 INFO - ##### 11:12:09 INFO - Running pre-action listener: _resource_record_pre_action 11:12:09 INFO - Running main action method: install 11:12:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:12:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:12:09 INFO - Reading from file tmpfile_stdout 11:12:09 INFO - Detecting whether we're running mozinstall >=1.0... 11:12:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:12:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:12:09 INFO - Reading from file tmpfile_stdout 11:12:09 INFO - Output received: 11:12:09 INFO - Usage: mozinstall [options] installer 11:12:09 INFO - Options: 11:12:09 INFO - -h, --help show this help message and exit 11:12:09 INFO - -d DEST, --destination=DEST 11:12:09 INFO - Directory to install application into. [default: 11:12:09 INFO - "/builds/slave/test"] 11:12:09 INFO - --app=APP Application being installed. [default: firefox] 11:12:09 INFO - mkdir: /builds/slave/test/build/application 11:12:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:12:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:12:22 INFO - Reading from file tmpfile_stdout 11:12:22 INFO - Output received: 11:12:22 INFO - /builds/slave/test/build/application/firefox/firefox 11:12:22 INFO - Running post-action listener: _resource_record_post_action 11:12:22 INFO - ##### 11:12:22 INFO - ##### Running run-tests step. 11:12:22 INFO - ##### 11:12:22 INFO - Running pre-action listener: _resource_record_pre_action 11:12:22 INFO - Running main action method: run_tests 11:12:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:12:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:12:22 INFO - Python 2.7.3 11:12:22 INFO - Return code: 0 11:12:22 INFO - grabbing minidump binary from tooltool 11:12:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:22 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b0410>, '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 0x19b1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b17a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:12:22 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 11:12:22 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 11:12:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:12:22 INFO - Return code: 0 11:12:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:12:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:12:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:12:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:12:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:12:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:12:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:12:23 INFO - Return code: 0 11:12:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Lr1jcZkkSF6iQBPU8eW-xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:12:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Lr1jcZkkSF6iQBPU8eW-xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:12:23 INFO - Using env: {'DISPLAY': ':0', 11:12:23 INFO - 'HOME': '/home/cltbld', 11:12:23 INFO - 'LANG': 'en_US.UTF-8', 11:12:23 INFO - 'LANGUAGE': 'en_US:en', 11:12:23 INFO - 'LOGNAME': 'cltbld', 11:12:23 INFO - 'MAIL': '/var/mail/cltbld', 11:12:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:12:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:12:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:23 INFO - 'MOZ_NO_REMOTE': '1', 11:12:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:12:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:23 INFO - 'NO_EM_RESTART': '1', 11:12:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:23 INFO - 'PWD': '/builds/slave/test', 11:12:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:12:23 INFO - 'SHELL': '/bin/bash', 11:12:23 INFO - 'SHLVL': '1', 11:12:23 INFO - 'TERM': 'linux', 11:12:23 INFO - 'TMOUT': '86400', 11:12:23 INFO - 'USER': 'cltbld', 11:12:23 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466703634.225124-831287079', 11:12:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:23 INFO - '_': '/tools/buildbot/bin/python'} 11:12:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Lr1jcZkkSF6iQBPU8eW-xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:12:24 INFO - mozversion application_buildid: 20160623083527 11:12:24 INFO - mozversion application_changeset: f403cf3a053abd6036932519b3b7214dbcb76c30 11:12:24 INFO - mozversion application_display_name: Firefox 11:12:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:12:24 INFO - mozversion application_name: Firefox 11:12:24 INFO - mozversion application_remotingname: firefox 11:12:24 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:12:24 INFO - mozversion application_vendor: Mozilla 11:12:24 INFO - mozversion application_version: 48.0 11:12:24 INFO - mozversion platform_buildid: 20160623083527 11:12:24 INFO - mozversion platform_changeset: f403cf3a053abd6036932519b3b7214dbcb76c30 11:12:24 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:12:24 INFO - mozversion platform_version: 48.0 11:12:24 INFO - using testdate: 1466705544 11:12:24 INFO - actual date: 1466705544 11:12:24 INFO - starting webserver on 'localhost:55391' 11:12:24 INFO - SUITE-START | Running 2 tests 11:12:24 INFO - TEST-START | dromaeo_css 11:12:24 INFO - operating with platform_type : linux_ 11:12:24 INFO - Initialising browser for dromaeo_css test... 11:12:24 INFO - TEST-INFO | started process 29407 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbmmM7Q/profile http://localhost:55391/getInfo.html) 11:12:27 INFO - PROCESS | 29407 | __metrics Screen width/height:1600/1200 11:12:27 INFO - PROCESS | 29407 | colorDepth:24 11:12:27 INFO - PROCESS | 29407 | Browser inner width/height: 1024/697 11:12:27 INFO - PROCESS | 29407 | __metrics 11:12:28 ERROR - PROCESS | 29407 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:12:29 INFO - TEST-INFO | 29407: exit 0 11:12:29 INFO - Browser initialized. 11:12:29 INFO - Running cycle 1/1 for dromaeo_css test... 11:12:29 INFO - TEST-INFO | started process 29495 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbmmM7Q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:12:41 INFO - PROCESS | 29495 | RSS: Main: 140005376 11:12:41 INFO - PROCESS | 29495 | 11:13:32 INFO - PROCESS | 29495 | 1466705612968 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] 11:15:39 INFO - PROCESS | 29495 | Cycle 1(1): loaded http://localhost:55391/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55391/tests/dromaeo/cssquery-ext.html) 11:15:41 INFO - PROCESS | 29495 | RSS: Main: 300929024 11:15:41 INFO - PROCESS | 29495 | 11:18:43 INFO - PROCESS | 29495 | Cycle 1(1): loaded http://localhost:55391/tests/dromaeo/cssquery-ext.html (next: http://localhost:55391/tests/dromaeo/cssquery-jquery.html) 11:18:44 INFO - PROCESS | 29495 | RSS: Main: 224325632 11:18:44 INFO - PROCESS | 29495 | 11:21:45 INFO - PROCESS | 29495 | Cycle 1(1): loaded http://localhost:55391/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55391/tests/dromaeo/cssquery-mootools.html) 11:21:46 INFO - PROCESS | 29495 | RSS: Main: 222957568 11:21:46 INFO - PROCESS | 29495 | 11:24:48 INFO - PROCESS | 29495 | Cycle 1(1): loaded http://localhost:55391/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55391/tests/dromaeo/cssquery-prototype.html) 11:24:48 INFO - PROCESS | 29495 | RSS: Main: 223342592 11:24:48 INFO - PROCESS | 29495 | 11:27:51 INFO - PROCESS | 29495 | Cycle 1(1): loaded http://localhost:55391/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55391/tests/dromaeo/cssquery-yui.html) 11:27:51 INFO - PROCESS | 29495 | RSS: Main: 211312640 11:27:51 INFO - PROCESS | 29495 | 11:30:54 INFO - PROCESS | 29495 | Cycle 1(1): loaded http://localhost:55391/tests/dromaeo/cssquery-yui.html (next: http://localhost:55391/tests/dromaeo/cssquery-dojo.html) 11:30:54 INFO - PROCESS | 29495 | RSS: Main: 250277888 11:30:54 INFO - PROCESS | 29495 | 11:30:54 INFO - PROCESS | 29495 | __start_tp_report 11:30:54 INFO - PROCESS | 29495 | _x_x_mozilla_page_load 11:30:54 INFO - PROCESS | 29495 | _x_x_mozilla_page_load_details 11:30:54 INFO - PROCESS | 29495 | |i|pagename|runs| 11:30:54 INFO - PROCESS | 29495 | |0;dojo.html;3305.091099947515;3366.1584603849024;3372.2075312301613;3392.7116195123413;3422.418188907887;5532.3637781655125;5549.223108764776;5556.805511807088;5557.888842223153;5561.777528898844;5542.612017158801;5560.082586373243;5560.332760068787;5574.693391863446;5607.915881261774;4958.454569997315;4972.87567810804;5025.7487125643665;5090.236464530313;5118.846434606968;4981.975090124544;5018.824341148061;5044.268581055745;5049.141645920203;5120.692758434506;5070.442251352367;5074.314967479399;5082.517160869711;5085.567726743213;5106.7701953412;5011.173156429185;5021.6735912165595;5076.999999999982;5085.389753229636;5090.949090509103;4906;4926.753662316905;4984.651074424792;4994.076095922266;5021.14640511114;5419.376771671269;5420.810271640474;5422.91865622016;5458.1266997280245;5462.016836969344;5758.107493338539;5924.318703349127;5925.674087925162;5925.8814823703715;5930;5871.442212989759;5885.705714714247;5901.439363260526;5903.940960590382;5935.287765468128;5511.58663100269;5512.448755124496;5521.503064724194;5524.06090964537;5549.944500554983;5843.503302219274;5889.646621202742;5936.643801371932;5975.43233392827;5999.280086389661;5820.185174075633;5821.301443826768;5824.184614154022;5831.271091113611;5853.414658534112;5871.706414679249;5886.852828679232;5890.764369425261;5892.027815410409;5906.025505791582;5745.540356771448;5842.328132264759;5880.235569375954;5891.351951285355;5932.3474417814;5872.677002764889;5883.264591926009;5887.823365298962;5890.587658863838;5897.52819774417;4460.553944605514;4503.054358584668;4523.321501774694;4528.207563676409;4533.5013148553635;3954.2882281189086;3972.7020473464604;4040.515138183378;4040.8181631826637;4055.6958228133008;5641.2384328116;5641.633293835969;5641.8589535261945;5649.971750141305;5658.122990936411;5963.850903727442;5973.581849270597;5974.193483879708;5990.64056156632;5994.400559944058;5483.588730845203;5608.46719561641;5616.97191514048;5731.799387021434;5747.683877386784;4970.130227210224;4976.303317535548;4984.451710311862;4992.276119962585;5011.57401620859;6104.450599445982;6151.41092201476;6156.261248650101;6166.568340216231;6186.969065154645;5745.080787074048;5852.502537284208;5949;5962.16529685853;5985.581009329305;6086.452219300284;6118.449339559461;6126.23422072241;6136;6138.815835524942;5785.074388097884;5827.825165245049;5828.6502809831545;5836.328822185503;5851.765929362949;5777.971110144423;5778.046622307273;5852.18069470266;5857.121431785266;5861.6189947653265;5699.829005129853;5746.16680581305;5759.481646651821;5760.798372057126;5762.164486149569;5773.336066352424;5773.364929857628;5803.332616749128;5811.56413268998;5830.475257226701;5605.80379686709;5627.774889004394;5632.718364081861;5691.430856914276;5692.48767610917;5718.771249149988;5748.626339287933;5752.712364381848;5787.681677507778;5801.680907550125;5671.971640141938;5709.0865461525955;5718.056520674042;5741.339745929272;5743.1385292206505 11:30:54 INFO - PROCESS | 29495 | |1;ext.html;632.2255237334266;665.4576520136092;681.6114814555699;684.2507454337501;747.1109379837994;34558.481622775646;40745.18509629809;41291.793541032326;41404.37893431594;41456.58543414565;44633.107337853224;45085.77457112718;45102.32346514805;45105.77447112768;45114.32328515075;8108.513489190638;8801.867971980426;8987.37088403812;8988.50563219026;10385.584576616926;10461.529231184615;10574.206934479946;10633.149348052137;10639.255252132354;10640.78718425631;10669.893301066968;10701.946490267577;10743.409112498848;10747.677569672884;10753.03222709956;10546.525406356694;10638.840417393745;10644.733881652943;10651.094656954168;10653.414062226575;10559.577616895314;10919.290246133976;11001.61494347702;11002.394868282241;11007.834882476769;44766.10467790626;44974.77512612416;45183.77408112971;45228;45378.31932521015;3685.8894233173046;3694.3350196964534;3700.9259814803554;3758.1356288053626;3781.357169281201;30515.847420762977;30918.69081309203;31292.687073129204;31489.48501821186;31663.683363166303;4085.2850751118435;4143.751374917484;4154.127633197032;4159.9792001040105;4200.789960501963;290662;292061;292389;293115;294060.52969735226;40343.79828100841;40996;41062;64948.35051649518;65172.348276516626;38082.809585951894;38227.80886095552;38291.234175316895;38383;38415.03962400906;17486.21312040961;17552.56118597045;17578.384756533458;17644.382446614305;17660.735088973677;13694.52069177574;15086.396544138332;15527.068375897255;15541;15544.222788860738;9364.110409511086;9388.577514011886;9398.436093834254;9440.90559094414;9461.479618620904;3527.470879368115;3569.964300357015;3570.839312230956;3587.3722098632634;3600.189957259648;1107.9889201107885;1155.8324043013715;1175.8765329640435;1191.4042978510745;1270.39021269791;33851.4922276166;33956;34116.82941585326;34198.65801342005;35273.294534109176;1203.8194270859442;1243.4093805442524;1258.4337048328289;1277.904157188196;1311.4167771932534;18049.27802887896;18068.277268909358;18160.1827917744;18246.726299105525;18301.084945752926;511048;517339;518994;523730;527138;62525;62784.37215627877;62822;62868.685656571426;63101.26740494481;1364.6929440875922;1421.9878871397063;1504.4433559583024;1506.9698606028037;1520.954371368883;30114.32668751415;30457;33032.66967330392;33054.17364565905;33899.4915076279;50308;50471;50868.74565627148;50976.74511627418;51038.489615103375;316822;317546;317667;318194;319291;28195.295117622223;31387.372252555277;31746.841265793522;31852.04443866688;31949.20126996844;47624;49519;50338.74830625823;50854.23718644297;51116;41814.372784408864;42017.78991105025;42238.57761422346;42408.36387454129;43504;40589;40836.38745418881;40981.590184097775;42140.78929605455;42675.7866210667;42672.57327426686;43078.78460607677;43455.782721086194;43667.78166109149;43695.56304436915;35283.29433411266;35980.640193598774;36682;37259.44110838285;37460.62539374681;28346;28637.42725145444;28841.134765956216;29211.561826572193;29297.41405171842 11:30:54 INFO - PROCESS | 29495 | |2;jquery.html;421.1934146110198;427.29709627662476;429.76148237728046;430.75877508595187;437.9781010949454;18720.81279187208;19401.223951041975;19402.02989850509;19791;20612.587748245027;12768.297743624096;13124.934375328134;15432.459863904765;20309.695354569692;20372.388828335137;5300.946990530103;5360.410354860962;5516.475934786209;5558.6942718150485;5948.672822994734;5877.764889404419;5919.704014799243;5967.403259674042;5972.343042265347;5975.551833612475;5536.2249285100115;5575.135853942646;5923;5926.288845338566;5934.406559344053;5406.648567843077;5486.177073438977;5491.395946445888;5532.30846144232;5543.390227075019;5380.892382152335;5394.379646340682;5397.028534863723;5399.811006614749;6945.062416573748;25272.115475958253;25861.612075818877;25865.612015819777;26560;26587.601185982225;2603.388203772112;2654.561997270448;2746.436980419029;2829.1795379339965;3248.3990461764647;15548.92225538865;15774.132422716746;15957.521274361789;16013.599660008476;16880.15599220034;2178.967315490269;2187.9453013674624;2210.182232573958;2310.653401989698;2369.07606033647;93972;97076.99999999929;98994.50502747513;100028;100455.49316760254;17753.644927101384;18535.53661158482;18773.7183942241;18867.528311792314;18996.62006759857;34541.481877771854;34583.4812477813;34672.82663586716;35045.64954350475;35109;8698.391112622056;9111.407758495676;9179.816403672023;9263.768405789775;9280;9087.273018158532;9117.544122793966;9131.178193962574;9186.63253469867;9227;4904.632152588499;5057.772400241998;5082.974585127125;5085.516875896784;5085.847424577269;1962.931297404584;1985.9404217873487;1991.6116357310186;2068.1520576563535;2111.968320475194;489.1562055454313;492.66252616957496;993.339429279521;1047.5809676129609;1079.4602698650674;11636.825447618292;11776.58781942645;12046.397680115959;12113.152079354537;12401.751964960651;490.92636104584597;497.2466712929914;499.787590274132;502.6632156455184;504.4073213973566;6712.160979877515;6727.29363416844;6738.528303018742;6745.56153850008;6797.592144471348;502524;503450;506864;519111;527970;94588;98961.50519247357;99299.50350248347;99342.5032874831;99872.5006374978;505.5576370675659;512.1242675025748;512.6155383462403;515.7421289355323;519.0371860199276;9902.257330700082;12012.399380031138;12028.578999734968;12059.523095680383;12228.44971976281;40057.1988560233;40858;41277;42096.789516052224;42228.78885605675;53908.460915391915;56981.43018569927;57107.42892571187;57404.79478346722;57483.137752932904;8651.307895368482;8715.91284087151;8946.105389461001;9046.728598142066;9091.590878410356;9545.236381089635;12812.359382031047;13618.046736728335;13758;13786.793198101836;11369.943150284196;11820.349880756641;12262.141650084408;12478.812817807922;12964.870351296366;11959.103067269816;12262.589802172864;12321.876781232073;12650.367481626066;12661.177023493443;12333.321667308384;12918.741625167257;12957.41691623898;12963.935180324039;13173.538926137922;9039.90960090417;9258.490783006999;9339.953300233456;9376.624935002796;9458.716238512856;9580.856287155837;12089.093318001362;12538.811917821058;12578.685532861751;12634.494620215088 11:30:54 INFO - PROCESS | 29495 | |3;mootools.html;1384.1279993604028;1523.9161846098466;1551.8215405228395;1749.8425141737248;1888.7355770192175;8085.676572937083;8294.336453083753;8305.58472076396;8315.043769966456;8324.042735085466;8218.917810821906;8378.036525799535;8381.622826972785;8386.748397548068;8391.580420978957;2368.159303447277;2378.4648454097864;2390.486045500217;2390.569697454466;2396.7363590005084;2361.102780943239;2417.9274621761288;2423.45472268739;2428.368624157714;2431.902723891051;2302.838801283911;2325.5813953488364;2328.5459335429596;2366.2073205476186;2380.5238952209543;2354.976450235493;2356.5404746074523;2388.5700573896693;2390.880455977203;2400.9639855402183;2368.1593034472685;2438.5610590093775;2451.1298489036312;2452.1662634704285;2456.349067497115;7180.31786980236;7720.652570634335;8590.441621294596;8644.740657780276;8655.134486551358;5063.873403164914;5201.869953251161;5238.292830467876;5241.109011468059;5242.68543887368;3273.5908011498564;3279.3277378137423;3283.753718471124;3313.685199906005;3344.0803778960735;1070.5717712914818;2186.3902676786315;2186.6610675345346;2198.8240940724704;2223.49971256466;11576.131790115774;11699.883001169965;11819.172657914036;11826.349550774705;11848.34834084125;4367.978160109179;4445.088756804847;4449.777511124431;4464.263396539534;4509.571590698878;9586.856197157049;9593.904060959441;9597.90402095984;9598.568064436977;9615.278854085831;5236.738163091906;5257.132573125392;5258.447862974409;5264.52619264268;5271.130263506555;4851.272309153655;4893.290472881412;4908.288298196813;4909.239067944474;4910.140725373046;3598.334308152948;3917.8236979335998;3951.7628942263555;3954.307996100671;3955.802209889494;1175.835383046374;1176.129664048598;1177.040711819864;1189.0665827325508;1192.7495226002463;1055.7888422315568;1075.6611667324767;1077.8706555213425;1096.8957948994832;1099.741560733227;5745.798897038667;6060.696965151725;6062.575619706578;6108.297545782292;6191.597546159485;467.35971718744855;469.27965572845517;470.5365215262963;1111.0611533254548;1117.1118960426481;4090.590940905945;4123.8969025773995;4131.338985762323;4136.958630413657;4159.396887451303;9878.65424710146;10184.185265178769;10190.031946965026;10297.227707921937;10304.690859274233;10036.648717295006;10127;10158.746031349276;10161.69514914539;10177.694669159937;7989.121196668362;8175.591220438954;8252.917470825216;8261.545614991233;8282.58587070644;5803.7388317524965;5829.242198514166;5884.6469211847425;5951.523878089656;6058.697065146813;9281.39670921388;9490.28822838276;9584.712458626253;9598.32811703174;9616.615335386787;9451.669191578261;9643.614255429704;9659.855102173613;9721.513924303898;9743.464109473764;7230.313120253568;7322.743703970335;7361.963190184015;7365.742199023009;7471.6637751302405;8122.75631731049;8217.342612591097;8221.958890205511;8228.094909560063;8337.708180213906;7550.584717840571;7647.579383133981;7701.653425595974;7717.2282771722375;7764.301212890867;7258;7279.890801638086;7344.779656610311;7380;7412;6700.4639628830555;6856.554323968926;6869.381755642016;6871.415929646036;6873.278305778022;4489.640828733628;5268.446813084724;5332.626716129834;5386.245925570345;5533.5849811263515;5230.398504172069;5279.551238144647;5293.973530132479;5364.678119312854;5443.510084092451 11:30:54 INFO - PROCESS | 29495 | |4;prototype.html;350.1421517282657;354.9183687751817;356.630887031922;359.9982000089999;360.22012343276805;6263.874722505547;6300.21247344082;6437.83905402364;6454;6459.4832413406875;6255.874882502359;6273.3412991635905;6302.275238347592;6330.208723909512;6340.4610608098255;4530.433695788027;4773.949731059161;4777.999999999991;4778.25936979767;4797.544233297831;4625.953740462603;4637.0725854829;4678.415198100238;4698.365720627723;4801.423829140508;4745.477997420281;4770.570648641621;4778.498257682928;4782.091402633506;4783.402074740658;4738.431388233417;4757.310190022427;4758.881027974294;4762;4766.261229509431;3936.8425262989444;4061;4123.969007748063;4127.29835927893;4173.707840451169;5938.168656388066;5951.9107213391835;5953.7320820562745;5990.1314309425325;6031.065184896304;5555.638883472561;5559.305086864142;5562.249096371978;5562.276904002494;5567.693776842272;6553.737850485975;6561.114249576294;6567.8029659109825;6580.670966451658;6583.868322633569;4619.122366750306;4621.075784843045;4622.306654001893;4626.005408837116;4627.699199552052;6614.966925165391;6855.903055511094;6941.548799328028;6947.444204463682;6960.860782784366;4679.508651591602;4706.505816889177;4721.3390125382475;4731.858044258678;4732.290156476556;4781.904361912742;4782.306565547976;4782.665213435026;4787.688800227974;4791.137595232892;5521.171824226398;5534.363548191929;5535.142052981794;5537.446255374511;5541.861453463615;6623.867522649616;6625.933740662628;6635.568688035262;6642.734290628321;6649.335066493312;1622.4078211452734;1658.8009438867173;1672.966540669204;1676.893250454694;1682.0328311220853;1061.8725752909545;1091.579741799397;1092.8032954068185;1093.676651251978;1104.9005589496983;6222.595531290452;6345.365463453618;6355.237371515448;6357.650329231937;6360.6501642409185;6744.527883048139;6931.306869313129;6972.477064220204;6980.895286570705;6995.685194166274;6506.60960342381;6515.7067931943175;6518.706658200393;6518.934810651927;6539.673016349164;3709.684676802448;3749.9812500937865;3751.268502642013;3761.454589084622;3761.567419746709;7090.113735783028;7220.169680486706;7230.927690723025;7233.8553228935125;7243.9637801811705;7005.614691192033;7068.823279418056;7069.222385537587;7070.151581810215;7070.186928503185;7169.964150179216;7198.316159964795;7199.1361036675935;7219.205887352387;7222.422206223595;6931.4108300795;6934.791956241321;6948.235694073547;6961.164660240804;6967.965160174167;6764.3573860483175;6808.421284190899;6809.795706128824;6810.965945170441;6813.965930170318;6944.159797653525;7223.530470519399;7235.457340699363;7247.420206383582;7249.565026098451;4502.57225563571;4568.337591049346;4578.40480737502;4588.793504292382;4589.7705114744795;6936.410405115622;6936.895946560907;6949.027136201037;6950.721971121098;6950.8609827804175;6737;6743.629100399525;6746;6746.763863264762;6747.224069231905;6610.474197636425;6655.567388119756;6733.93266067333;6735.124433823572;6740.460763138839;6575.769848055295;6600.867982640416;6606.141201643755;6608.4382827458285;6610.867782644224;6750.1562304711915;6751.831204219934;6763;6766.391024807791;6771.221309549464;6582.308857569887;6588.275289718223;6594.208694956636;6663.400293973566;6679.131712877295 11:30:54 INFO - PROCESS | 29495 | |5;yui.html;769.7652216074102;778.9337906277963;798.3453568074182;872.5680788009934;896.2158111652302;14592.270386480686;14613.269336533158;14642.194679292634;15139.167345795991;15337.616559586002;14174.362153703083;14291.071080379768;14353.497627583036;14374.209418482005;14431.783523247133;769.2499812682646;852.4970267542149;886.2555453419127;908.5230254116609;913.0914739833875;904.5522466379118;907.3104440625107;909.4725059465494;915.0346384564315;915.1351972386097;946.1815529566944;946.981060378792;947.1002547579792;957.0620791624212;958.7746879483316;798.1738900238255;930.1442672741094;963.7397902566267;963.802420503795;966.0243154414022;691.0187533702154;692.2523674431602;695.1172011545309;695.4853408477741;697.0137255783061;13800.723985520333;13834.584962451143;13881;13891.235982020984;13928.86071139296;14766.926165369212;15073.170975596338;15358.846411535853;15406.691866162613;15543.455979040793;12059.397030148546;12149.574764883188;12331.198472099284;12334.444949977273;12492.188007779465;4060.776657283848;4064.7561146331313;4122.361034039729;4161.52142503613;4200.243956087903;55101.44898551043;55967.44032559663;56091.71954140244;56208.43791562073;56325.71837140788;11915.106367022508;11946.522139114339;12090.637280881587;12148;12408.875911240772;19226.134823932956;19233.61532769365;19238.519037024187;19325.03374831253;19330.613387732446;8406.747797566082;8491.95754021226;8646.048934617187;8786.560671966376;8868;4689.390379250675;4721.480637129913;4890.388701412324;4981.178105612606;5038.521340472723;3366.107981384935;3391.9491207631904;3418.0942050356675;3421.709154721827;3428.160100775276;585.5696063393402;596.7881402102278;605.7274226598048;655.3904868472366;655.95408321418;704.1057856522189;730.6346826586706;832.1595188859175;833.9874901876477;845.9280961118251;9709.141685730374;10133.847992280122;10167.898321016843;10303.536340864679;10318.535665895053;677.2110491277705;713.6039498078512;735.7057177129084;769.4882902869641;772.8724760414581;4683.601893838993;4731.787069581877;4746.28805679144;4808.543188397167;4832;63364.366356336766;63635.04547431792;64084;64350.35649643537;64423.67788161029;54982.17526737102;56759.71620141873;56790.716046419504;56825.43174568201;57046.7147664259;48994.26508602374;49352.25971610429;49910.25134622984;50344.49655503471;50538.494615054115;9309.115634014757;9502.097300756417;9544.761380965254;9566.856497152687;9568.09103135201;35046.47430288497;35122.12194695153;36700.26599468049;40220.59779402168;40732.79633601813;46373.536264636925;47068.29397559108;47625.28562071641;49146.75426622844;50569;12415.813762793747;12582.87417125817;12767.93616031914;12866.935665321613;12996.935015324863;13068.673283167996;13953.651158721113;14040;14218.928905355408;14457.638559036108;13569.52506662262;13615.659608509866;13649.658758530719;13725.176489410667;13777.655558611115;13062.281574513492;13433.798493022417;13448.798268026183;13624.318784060955;14168.291585420893;13386.799198011842;13403.865961340261;13467.865321347053;13584.660383490493;13717.657058573615;10964.396958167059;11016.283941543774;11152.776944461228;11508.539658413905;11980.341081240267;11301.660950171508;11424.371659558805;11462.885371146182;11558;11574 11:30:54 INFO - PROCESS | 29495 | __end_tp_report 11:30:54 INFO - PROCESS | 29495 | __start_cc_report 11:30:54 INFO - PROCESS | 29495 | _x_x_mozilla_cycle_collect,1272 11:30:54 INFO - PROCESS | 29495 | __end_cc_report 11:30:54 INFO - PROCESS | 29495 | __startTimestamp1466706654354__endTimestamp 11:30:54 INFO - PROCESS | 29495 | 11:30:54 INFO - PROCESS | 29495 | ------- Summary: start ------- 11:30:54 INFO - PROCESS | 29495 | Number of tests: 6 11:30:54 INFO - PROCESS | 29495 | 11:30:54 INFO - PROCESS | 29495 | [#0] dojo.html Cycles:165 Average:5487.66 Median:5718.77 stddev:602.37 (10.5%) stddev-sans-first:579.38 11:30:54 INFO - PROCESS | 29495 | Values: 3305.1 3366.2 3372.2 3392.7 3422.4 5532.4 5549.2 5556.8 5557.9 5561.8 5542.6 5560.1 5560.3 5574.7 5607.9 4958.5 4972.9 5025.7 5090.2 5118.8 4982.0 5018.8 5044.3 5049.1 5120.7 5070.4 5074.3 5082.5 5085.6 5106.8 5011.2 5021.7 5077.0 5085.4 5090.9 4906.0 4926.8 4984.7 4994.1 5021.1 5419.4 5420.8 5422.9 5458.1 5462.0 5758.1 5924.3 5925.7 5925.9 5930.0 5871.4 5885.7 5901.4 5903.9 5935.3 5511.6 5512.4 5521.5 5524.1 5549.9 5843.5 5889.6 5936.6 5975.4 5999.3 5820.2 5821.3 5824.2 5831.3 5853.4 5871.7 5886.9 5890.8 5892.0 5906.0 5745.5 5842.3 5880.2 5891.4 5932.3 5872.7 5883.3 5887.8 5890.6 5897.5 4460.6 4503.1 4523.3 4528.2 4533.5 3954.3 3972.7 4040.5 4040.8 4055.7 5641.2 5641.6 5641.9 5650.0 5658.1 5963.9 5973.6 5974.2 5990.6 5994.4 5483.6 5608.5 5617.0 5731.8 5747.7 4970.1 4976.3 4984.5 4992.3 5011.6 6104.5 6151.4 6156.3 6166.6 6187.0 5745.1 5852.5 5949.0 5962.2 5985.6 6086.5 6118.4 6126.2 6136.0 6138.8 5785.1 5827.8 5828.7 5836.3 5851.8 5778.0 5778.0 5852.2 5857.1 5861.6 5699.8 5746.2 5759.5 5760.8 5762.2 5773.3 5773.4 5803.3 5811.6 5830.5 5605.8 5627.8 5632.7 5691.4 5692.5 5718.8 5748.6 5752.7 5787.7 5801.7 5672.0 5709.1 5718.1 5741.3 5743.1 11:30:54 INFO - PROCESS | 29495 | 11:30:54 INFO - PROCESS | 29495 | [#1] ext.html Cycles:180 Average:54487.60 Median:3579.11 stddev:103279.03 (2885.6%) stddev-sans-first:103489.60 11:30:54 INFO - PROCESS | 29495 | Values: 632.2 665.5 681.6 684.3 747.1 34558.5 40745.2 41291.8 41404.4 41456.6 44633.1 45085.8 45102.3 45105.8 45114.3 8108.5 8801.9 8987.4 8988.5 10385.6 10461.5 10574.2 10633.1 10639.3 10640.8 10669.9 10701.9 10743.4 10747.7 10753.0 10546.5 10638.8 10644.7 10651.1 10653.4 10559.6 10919.3 11001.6 11002.4 11007.8 44766.1 44974.8 45183.8 45228.0 45378.3 3685.9 3694.3 3700.9 3758.1 3781.4 30515.8 30918.7 31292.7 31489.5 31663.7 4085.3 4143.8 4154.1 4160.0 4200.8 290662.0 292061.0 292389.0 293115.0 294060.5 40343.8 40996.0 41062.0 64948.4 65172.3 38082.8 38227.8 38291.2 38383.0 38415.0 17486.2 17552.6 17578.4 17644.4 17660.7 13694.5 15086.4 15527.1 15541.0 15544.2 9364.1 9388.6 9398.4 9440.9 9461.5 3527.5 3570.0 3570.8 3587.4 3600.2 1108.0 1155.8 1175.9 1191.4 1270.4 33851.5 33956.0 34116.8 34198.7 35273.3 1203.8 1243.4 1258.4 1277.9 1311.4 18049.3 18068.3 18160.2 18246.7 18301.1 511048.0 517339.0 518994.0 523730.0 527138.0 62525.0 62784.4 62822.0 62868.7 63101.3 1364.7 1422.0 1504.4 1507.0 1521.0 30114.3 30457.0 33032.7 33054.2 33899.5 50308.0 50471.0 50868.7 50976.7 51038.5 316822.0 317546.0 317667.0 318194.0 319291.0 28195.3 31387.4 31746.8 31852.0 31949.2 47624.0 49519.0 50338.7 50854.2 51116.0 41814.4 42017.8 42238.6 42408.4 43504.0 40589.0 40836.4 40981.6 42140.8 42675.8 42672.6 43078.8 43455.8 43667.8 43695.6 35283.3 35980.6 36682.0 37259.4 37460.6 28346.0 28637.4 28841.1 29211.6 29297.4 11:30:54 INFO - PROCESS | 29495 | 11:30:54 INFO - PROCESS | 29495 | [#2] jquery.html Cycles:180 Average:30819.34 Median:463.57 stddev:84736.69 (18279.3%) stddev-sans-first:84943.66 11:30:54 INFO - PROCESS | 29495 | Values: 421.2 427.3 429.8 430.8 438.0 18720.8 19401.2 19402.0 19791.0 20612.6 12768.3 13124.9 15432.5 20309.7 20372.4 5300.9 5360.4 5516.5 5558.7 5948.7 5877.8 5919.7 5967.4 5972.3 5975.6 5536.2 5575.1 5923.0 5926.3 5934.4 5406.6 5486.2 5491.4 5532.3 5543.4 5380.9 5394.4 5397.0 5399.8 6945.1 25272.1 25861.6 25865.6 26560.0 26587.6 2603.4 2654.6 2746.4 2829.2 3248.4 15548.9 15774.1 15957.5 16013.6 16880.2 2179.0 2187.9 2210.2 2310.7 2369.1 93972.0 97077.0 98994.5 100028.0 100455.5 17753.6 18535.5 18773.7 18867.5 18996.6 34541.5 34583.5 34672.8 35045.6 35109.0 8698.4 9111.4 9179.8 9263.8 9280.0 9087.3 9117.5 9131.2 9186.6 9227.0 4904.6 5057.8 5083.0 5085.5 5085.8 1962.9 1985.9 1991.6 2068.2 2112.0 489.2 492.7 993.3 1047.6 1079.5 11636.8 11776.6 12046.4 12113.2 12401.8 490.9 497.2 499.8 502.7 504.4 6712.2 6727.3 6738.5 6745.6 6797.6 502524.0 503450.0 506864.0 519111.0 527970.0 94588.0 98961.5 99299.5 99342.5 99872.5 505.6 512.1 512.6 515.7 519.0 9902.3 12012.4 12028.6 12059.5 12228.4 40057.2 40858.0 41277.0 42096.8 42228.8 53908.5 56981.4 57107.4 57404.8 57483.1 8651.3 8715.9 8946.1 9046.7 9091.6 9545.2 12812.4 13618.0 13758.0 13786.8 11369.9 11820.3 12262.1 12478.8 12964.9 11959.1 12262.6 12321.9 12650.4 12661.2 12333.3 12918.7 12957.4 12963.9 13173.5 9039.9 9258.5 9340.0 9376.6 9458.7 9580.9 12089.1 12538.8 12578.7 12634.5 11:30:54 INFO - PROCESS | 29495 | 11:30:54 INFO - PROCESS | 29495 | [#3] mootools.html Cycles:180 Average:5647.21 Median:5132.87 stddev:3044.85 (59.3%) stddev-sans-first:3036.53 11:30:54 INFO - PROCESS | 29495 | Values: 1384.1 1523.9 1551.8 1749.8 1888.7 8085.7 8294.3 8305.6 8315.0 8324.0 8218.9 8378.0 8381.6 8386.7 8391.6 2368.2 2378.5 2390.5 2390.6 2396.7 2361.1 2417.9 2423.5 2428.4 2431.9 2302.8 2325.6 2328.5 2366.2 2380.5 2355.0 2356.5 2388.6 2390.9 2401.0 2368.2 2438.6 2451.1 2452.2 2456.3 7180.3 7720.7 8590.4 8644.7 8655.1 5063.9 5201.9 5238.3 5241.1 5242.7 3273.6 3279.3 3283.8 3313.7 3344.1 1070.6 2186.4 2186.7 2198.8 2223.5 11576.1 11699.9 11819.2 11826.3 11848.3 4368.0 4445.1 4449.8 4464.3 4509.6 9586.9 9593.9 9597.9 9598.6 9615.3 5236.7 5257.1 5258.4 5264.5 5271.1 4851.3 4893.3 4908.3 4909.2 4910.1 3598.3 3917.8 3951.8 3954.3 3955.8 1175.8 1176.1 1177.0 1189.1 1192.7 1055.8 1075.7 1077.9 1096.9 1099.7 5745.8 6060.7 6062.6 6108.3 6191.6 467.4 469.3 470.5 1111.1 1117.1 4090.6 4123.9 4131.3 4137.0 4159.4 9878.7 10184.2 10190.0 10297.2 10304.7 10036.6 10127.0 10158.7 10161.7 10177.7 7989.1 8175.6 8252.9 8261.5 8282.6 5803.7 5829.2 5884.6 5951.5 6058.7 9281.4 9490.3 9584.7 9598.3 9616.6 9451.7 9643.6 9659.9 9721.5 9743.5 7230.3 7322.7 7362.0 7365.7 7471.7 8122.8 8217.3 8222.0 8228.1 8337.7 7550.6 7647.6 7701.7 7717.2 7764.3 7258.0 7279.9 7344.8 7380.0 7412.0 6700.5 6856.6 6869.4 6871.4 6873.3 4489.6 5268.4 5332.6 5386.2 5533.6 5230.4 5279.6 5294.0 5364.7 5443.5 11:30:54 INFO - PROCESS | 29495 | 11:30:54 INFO - PROCESS | 29495 | [#4] prototype.html Cycles:180 Average:5581.37 Median:6359.15 stddev:1707.07 (26.8%) stddev-sans-first:1666.09 11:30:54 INFO - PROCESS | 29495 | Values: 350.1 354.9 356.6 360.0 360.2 6263.9 6300.2 6437.8 6454.0 6459.5 6255.9 6273.3 6302.3 6330.2 6340.5 4530.4 4773.9 4778.0 4778.3 4797.5 4626.0 4637.1 4678.4 4698.4 4801.4 4745.5 4770.6 4778.5 4782.1 4783.4 4738.4 4757.3 4758.9 4762.0 4766.3 3936.8 4061.0 4124.0 4127.3 4173.7 5938.2 5951.9 5953.7 5990.1 6031.1 5555.6 5559.3 5562.2 5562.3 5567.7 6553.7 6561.1 6567.8 6580.7 6583.9 4619.1 4621.1 4622.3 4626.0 4627.7 6615.0 6855.9 6941.5 6947.4 6960.9 4679.5 4706.5 4721.3 4731.9 4732.3 4781.9 4782.3 4782.7 4787.7 4791.1 5521.2 5534.4 5535.1 5537.4 5541.9 6623.9 6625.9 6635.6 6642.7 6649.3 1622.4 1658.8 1673.0 1676.9 1682.0 1061.9 1091.6 1092.8 1093.7 1104.9 6222.6 6345.4 6355.2 6357.7 6360.7 6744.5 6931.3 6972.5 6980.9 6995.7 6506.6 6515.7 6518.7 6518.9 6539.7 3709.7 3750.0 3751.3 3761.5 3761.6 7090.1 7220.2 7230.9 7233.9 7244.0 7005.6 7068.8 7069.2 7070.2 7070.2 7170.0 7198.3 7199.1 7219.2 7222.4 6931.4 6934.8 6948.2 6961.2 6968.0 6764.4 6808.4 6809.8 6811.0 6814.0 6944.2 7223.5 7235.5 7247.4 7249.6 4502.6 4568.3 4578.4 4588.8 4589.8 6936.4 6936.9 6949.0 6950.7 6950.9 6737.0 6743.6 6746.0 6746.8 6747.2 6610.5 6655.6 6733.9 6735.1 6740.5 6575.8 6600.9 6606.1 6608.4 6610.9 6750.2 6751.8 6763.0 6766.4 6771.2 6582.3 6588.3 6594.2 6663.4 6679.1 11:30:54 INFO - PROCESS | 29495 | 11:30:54 INFO - PROCESS | 29495 | [#5] yui.html Cycles:180 Average:15466.44 Median:4686.50 stddev:17576.52 (375.0%) stddev-sans-first:17591.18 11:30:54 INFO - PROCESS | 29495 | Values: 769.8 778.9 798.3 872.6 896.2 14592.3 14613.3 14642.2 15139.2 15337.6 14174.4 14291.1 14353.5 14374.2 14431.8 769.2 852.5 886.3 908.5 913.1 904.6 907.3 909.5 915.0 915.1 946.2 947.0 947.1 957.1 958.8 798.2 930.1 963.7 963.8 966.0 691.0 692.3 695.1 695.5 697.0 13800.7 13834.6 13881.0 13891.2 13928.9 14766.9 15073.2 15358.8 15406.7 15543.5 12059.4 12149.6 12331.2 12334.4 12492.2 4060.8 4064.8 4122.4 4161.5 4200.2 55101.4 55967.4 56091.7 56208.4 56325.7 11915.1 11946.5 12090.6 12148.0 12408.9 19226.1 19233.6 19238.5 19325.0 19330.6 8406.7 8492.0 8646.0 8786.6 8868.0 4689.4 4721.5 4890.4 4981.2 5038.5 3366.1 3391.9 3418.1 3421.7 3428.2 585.6 596.8 605.7 655.4 656.0 704.1 730.6 832.2 834.0 845.9 9709.1 10133.8 10167.9 10303.5 10318.5 677.2 713.6 735.7 769.5 772.9 4683.6 4731.8 4746.3 4808.5 4832.0 63364.4 63635.0 64084.0 64350.4 64423.7 54982.2 56759.7 56790.7 56825.4 57046.7 48994.3 49352.3 49910.3 50344.5 50538.5 9309.1 9502.1 9544.8 9566.9 9568.1 35046.5 35122.1 36700.3 40220.6 40732.8 46373.5 47068.3 47625.3 49146.8 50569.0 12415.8 12582.9 12767.9 12866.9 12996.9 13068.7 13953.7 14040.0 14218.9 14457.6 13569.5 13615.7 13649.7 13725.2 13777.7 13062.3 13433.8 13448.8 13624.3 14168.3 13386.8 13403.9 13467.9 13584.7 13717.7 10964.4 11016.3 11152.8 11508.5 11980.3 11301.7 11424.4 11462.9 11558.0 11574.0 11:30:54 INFO - PROCESS | 29495 | -------- Summary: end -------- 11:30:54 INFO - PROCESS | 29495 | 11:30:55 INFO - TEST-INFO | 29495: exit 0 11:30:55 INFO - TEST-OK | dromaeo_css | took 1110931ms 11:30:55 INFO - TEST-START | kraken 11:30:55 INFO - operating with platform_type : linux_ 11:30:55 INFO - Initialising browser for kraken test... 11:30:55 INFO - TEST-INFO | started process 29691 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnlNz9f/profile http://localhost:55391/getInfo.html) 11:30:58 INFO - PROCESS | 29691 | __metrics Screen width/height:1600/1200 11:30:58 INFO - PROCESS | 29691 | colorDepth:24 11:30:58 INFO - PROCESS | 29691 | Browser inner width/height: 1024/697 11:30:58 INFO - PROCESS | 29691 | __metrics 11:30:59 ERROR - PROCESS | 29691 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:31:00 INFO - TEST-INFO | 29691: exit 0 11:31:00 INFO - Browser initialized. 11:31:00 INFO - Running cycle 1/1 for kraken test... 11:31:00 INFO - TEST-INFO | started process 29786 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnlNz9f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:31:12 INFO - PROCESS | 29786 | RSS: Main: 139317248 11:31:12 INFO - PROCESS | 29786 | 11:31:14 INFO - PROCESS | 29786 | Cycle 1(1): loaded http://localhost:55391/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55391/tests/kraken/driver.html?testName=audio-beat-detection) 11:31:15 INFO - PROCESS | 29786 | RSS: Main: 197754880 11:31:15 INFO - PROCESS | 29786 | 11:31:18 INFO - PROCESS | 29786 | Cycle 1(1): loaded http://localhost:55391/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55391/tests/kraken/driver.html?testName=audio-dft) 11:31:18 INFO - PROCESS | 29786 | RSS: Main: 185069568 11:31:18 INFO - PROCESS | 29786 | 11:31:21 INFO - PROCESS | 29786 | Cycle 1(1): loaded http://localhost:55391/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55391/tests/kraken/driver.html?testName=audio-fft) 11:31:22 INFO - PROCESS | 29786 | RSS: Main: 274427904 11:31:22 INFO - PROCESS | 29786 | 11:31:24 INFO - PROCESS | 29786 | Cycle 1(1): loaded http://localhost:55391/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55391/tests/kraken/driver.html?testName=audio-oscillator) 11:31:24 INFO - PROCESS | 29786 | RSS: Main: 181645312 11:31:24 INFO - PROCESS | 29786 | 11:31:26 INFO - PROCESS | 29786 | Cycle 1(1): loaded http://localhost:55391/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55391/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:31:27 INFO - PROCESS | 29786 | RSS: Main: 178950144 11:31:27 INFO - PROCESS | 29786 | 11:31:30 INFO - PROCESS | 29786 | Cycle 1(1): loaded http://localhost:55391/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55391/tests/kraken/driver.html?testName=imaging-darkroom) 11:31:31 INFO - PROCESS | 29786 | RSS: Main: 214290432 11:31:31 INFO - PROCESS | 29786 | 11:31:34 INFO - PROCESS | 29786 | Cycle 1(1): loaded http://localhost:55391/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55391/tests/kraken/driver.html?testName=imaging-desaturate) 11:31:34 INFO - PROCESS | 29786 | RSS: Main: 213970944 11:31:34 INFO - PROCESS | 29786 | 11:31:37 INFO - PROCESS | 29786 | Cycle 1(1): loaded http://localhost:55391/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55391/tests/kraken/driver.html?testName=json-parse-financial) 11:31:38 INFO - PROCESS | 29786 | RSS: Main: 213905408 11:31:38 INFO - PROCESS | 29786 | 11:31:39 INFO - PROCESS | 29786 | Cycle 1(1): loaded http://localhost:55391/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55391/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:31:40 INFO - PROCESS | 29786 | RSS: Main: 196386816 11:31:40 INFO - PROCESS | 29786 | 11:31:42 INFO - PROCESS | 29786 | Cycle 1(1): loaded http://localhost:55391/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55391/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:31:42 INFO - PROCESS | 29786 | RSS: Main: 199221248 11:31:42 INFO - PROCESS | 29786 | 11:31:44 INFO - PROCESS | 29786 | Cycle 1(1): loaded http://localhost:55391/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55391/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:31:45 INFO - PROCESS | 29786 | RSS: Main: 210333696 11:31:45 INFO - PROCESS | 29786 | 11:31:47 INFO - PROCESS | 29786 | Cycle 1(1): loaded http://localhost:55391/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55391/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:31:48 INFO - PROCESS | 29786 | RSS: Main: 217485312 11:31:48 INFO - PROCESS | 29786 | 11:31:50 INFO - PROCESS | 29786 | Cycle 1(1): loaded http://localhost:55391/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55391/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:31:51 INFO - PROCESS | 29786 | RSS: Main: 212480000 11:31:51 INFO - PROCESS | 29786 | 11:31:53 INFO - PROCESS | 29786 | Cycle 1(1): loaded http://localhost:55391/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55391/tests/kraken/driver.html?testName=ai-astar) 11:31:53 INFO - PROCESS | 29786 | RSS: Main: 274567168 11:31:53 INFO - PROCESS | 29786 | 11:31:53 INFO - PROCESS | 29786 | __start_tp_report 11:31:53 INFO - PROCESS | 29786 | _x_x_mozilla_page_load 11:31:53 INFO - PROCESS | 29786 | _x_x_mozilla_page_load_details 11:31:53 INFO - PROCESS | 29786 | |i|pagename|runs| 11:31:53 INFO - PROCESS | 29786 | |0;ai-astar;110;110;110;111;111;111;105;108;110;108 11:31:53 INFO - PROCESS | 29786 | |1;audio-beat-detection;162;125;160;180;129;160;161;127;180;126 11:31:53 INFO - PROCESS | 29786 | |2;audio-dft;161;161;161;162;161;162;160;161;161;160 11:31:53 INFO - PROCESS | 29786 | |3;audio-fft;76;74;75;170;76;76;76;80;159;77 11:31:53 INFO - PROCESS | 29786 | |4;audio-oscillator;94;93;151;92;92;93;140;92;93;147 11:31:53 INFO - PROCESS | 29786 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 11:31:53 INFO - PROCESS | 29786 | |6;imaging-darkroom;145;146;145;150;145;145;146;145;145;146 11:31:53 INFO - PROCESS | 29786 | |7;imaging-desaturate;94;94;95;94;95;94;94;94;97;96 11:31:53 INFO - PROCESS | 29786 | |8;json-parse-financial;55;56;55;55;53;54;54;76;52;52 11:31:53 INFO - PROCESS | 29786 | |9;json-stringify-tinderbox;59;59;61;59;60;60;59;60;58;65 11:31:53 INFO - PROCESS | 29786 | |10;stanford-crypto-aes;73;72;72;71;74;74;74;74;74;74 11:31:53 INFO - PROCESS | 29786 | |11;stanford-crypto-ccm;113;117;113;113;113;108;112;112;135;119 11:31:53 INFO - PROCESS | 29786 | |12;stanford-crypto-pbkdf2;159;155;156;155;155;158;155;157;157;153 11:31:53 INFO - PROCESS | 29786 | |13;stanford-crypto-sha256-iterative;70;67;66;66;65;66;66;66;66;65 11:31:53 INFO - PROCESS | 29786 | __end_tp_report 11:31:53 INFO - PROCESS | 29786 | __start_cc_report 11:31:53 INFO - PROCESS | 29786 | _x_x_mozilla_cycle_collect,1571 11:31:53 INFO - PROCESS | 29786 | __end_cc_report 11:31:53 INFO - PROCESS | 29786 | __startTimestamp1466706713434__endTimestamp 11:31:53 INFO - PROCESS | 29786 | 11:31:53 INFO - PROCESS | 29786 | ------- Summary: start ------- 11:31:53 INFO - PROCESS | 29786 | Number of tests: 14 11:31:53 INFO - PROCESS | 29786 | 11:31:53 INFO - PROCESS | 29786 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:1.90 (1.7%) stddev-sans-first:2.00 11:31:53 INFO - PROCESS | 29786 | Values: 110.0 110.0 110.0 111.0 111.0 111.0 105.0 108.0 110.0 108.0 11:31:53 INFO - PROCESS | 29786 | 11:31:53 INFO - PROCESS | 29786 | [#1] audio-beat-detection Cycles:10 Average:151.00 Median:160.50 stddev:22.18 (13.8%) stddev-sans-first:23.16 11:31:53 INFO - PROCESS | 29786 | Values: 162.0 125.0 160.0 180.0 129.0 160.0 161.0 127.0 180.0 126.0 11:31:53 INFO - PROCESS | 29786 | 11:31:53 INFO - PROCESS | 29786 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 11:31:53 INFO - PROCESS | 29786 | Values: 161.0 161.0 161.0 162.0 161.0 162.0 160.0 161.0 161.0 160.0 11:31:53 INFO - PROCESS | 29786 | 11:31:53 INFO - PROCESS | 29786 | [#3] audio-fft Cycles:10 Average:93.90 Median:76.00 stddev:37.33 (49.1%) stddev-sans-first:39.03 11:31:53 INFO - PROCESS | 29786 | Values: 76.0 74.0 75.0 170.0 76.0 76.0 76.0 80.0 159.0 77.0 11:31:53 INFO - PROCESS | 29786 | 11:31:53 INFO - PROCESS | 29786 | [#4] audio-oscillator Cycles:10 Average:108.70 Median:92.50 stddev:25.88 (28.0%) stddev-sans-first:26.90 11:31:53 INFO - PROCESS | 29786 | Values: 94.0 93.0 151.0 92.0 92.0 93.0 140.0 92.0 93.0 147.0 11:31:53 INFO - PROCESS | 29786 | 11:31:53 INFO - PROCESS | 29786 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 11:31:53 INFO - PROCESS | 29786 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 11:31:53 INFO - PROCESS | 29786 | 11:31:53 INFO - PROCESS | 29786 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:145.50 stddev:1.55 (1.1%) stddev-sans-first:1.62 11:31:53 INFO - PROCESS | 29786 | Values: 145.0 146.0 145.0 150.0 145.0 145.0 146.0 145.0 145.0 146.0 11:31:53 INFO - PROCESS | 29786 | 11:31:53 INFO - PROCESS | 29786 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:94.50 stddev:1.06 (1.1%) stddev-sans-first:1.09 11:31:53 INFO - PROCESS | 29786 | Values: 94.0 94.0 95.0 94.0 95.0 94.0 94.0 94.0 97.0 96.0 11:31:53 INFO - PROCESS | 29786 | 11:31:53 INFO - PROCESS | 29786 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:55.00 stddev:7.08 (12.9%) stddev-sans-first:7.50 11:31:53 INFO - PROCESS | 29786 | Values: 55.0 56.0 55.0 55.0 53.0 54.0 54.0 76.0 52.0 52.0 11:31:53 INFO - PROCESS | 29786 | 11:31:53 INFO - PROCESS | 29786 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:60.00 stddev:1.94 (3.2%) stddev-sans-first:2.03 11:31:53 INFO - PROCESS | 29786 | Values: 59.0 59.0 61.0 59.0 60.0 60.0 59.0 60.0 58.0 65.0 11:31:53 INFO - PROCESS | 29786 | 11:31:53 INFO - PROCESS | 29786 | [#10] stanford-crypto-aes Cycles:10 Average:73.20 Median:74.00 stddev:1.14 (1.5%) stddev-sans-first:1.20 11:31:53 INFO - PROCESS | 29786 | Values: 73.0 72.0 72.0 71.0 74.0 74.0 74.0 74.0 74.0 74.0 11:31:53 INFO - PROCESS | 29786 | 11:31:53 INFO - PROCESS | 29786 | [#11] stanford-crypto-ccm Cycles:10 Average:115.50 Median:113.00 stddev:7.46 (6.6%) stddev-sans-first:7.85 11:31:53 INFO - PROCESS | 29786 | Values: 113.0 117.0 113.0 113.0 113.0 108.0 112.0 112.0 135.0 119.0 11:31:53 INFO - PROCESS | 29786 | 11:31:53 INFO - PROCESS | 29786 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.00 Median:156.50 stddev:1.76 (1.1%) stddev-sans-first:1.50 11:31:53 INFO - PROCESS | 29786 | Values: 159.0 155.0 156.0 155.0 155.0 158.0 155.0 157.0 157.0 153.0 11:31:53 INFO - PROCESS | 29786 | 11:31:53 INFO - PROCESS | 29786 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.00 stddev:1.42 (2.1%) stddev-sans-first:0.60 11:31:53 INFO - PROCESS | 29786 | Values: 70.0 67.0 66.0 66.0 65.0 66.0 66.0 66.0 66.0 65.0 11:31:53 INFO - PROCESS | 29786 | -------- Summary: end -------- 11:31:53 INFO - PROCESS | 29786 | 11:31:54 INFO - TEST-INFO | 29786: exit 0 11:31:54 INFO - TEST-OK | kraken | took 59336ms 11:31:54 INFO - SUITE-END | took 1170s 11:31:54 INFO - Completed test suite (00:19:30) 11:31:54 INFO - javascript benchmark 11:31:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3305.091099947515, 3366.1584603849024, 3372.2075312301613, 3392.7116195123413, 3422.418188907887, 5532.3637781655125, 5549.223108764776, 5556.805511807088, 5557.888842223153, 5561.777528898844, 5542.612017158801, 5560.082586373243, 5560.332760068787, 5574.693391863446, 5607.915881261774, 4958.454569997315, 4972.87567810804, 5025.7487125643665, 5090.236464530313, 5118.846434606968, 4981.975090124544, 5018.824341148061, 5044.268581055745, 5049.141645920203, 5120.692758434506, 5070.442251352367, 5074.314967479399, 5082.517160869711, 5085.567726743213, 5106.7701953412, 5011.173156429185, 5021.6735912165595, 5076.999999999982, 5085.389753229636, 5090.949090509103, 4906.0, 4926.753662316905, 4984.651074424792, 4994.076095922266, 5021.14640511114, 5419.376771671269, 5420.810271640474, 5422.91865622016, 5458.1266997280245, 5462.016836969344, 5758.107493338539, 5924.318703349127, 5925.674087925162, 5925.8814823703715, 5930.0, 5871.442212989759, 5885.705714714247, 5901.439363260526, 5903.940960590382, 5935.287765468128, 5511.58663100269, 5512.448755124496, 5521.503064724194, 5524.06090964537, 5549.944500554983, 5843.503302219274, 5889.646621202742, 5936.643801371932, 5975.43233392827, 5999.280086389661, 5820.185174075633, 5821.301443826768, 5824.184614154022, 5831.271091113611, 5853.414658534112, 5871.706414679249, 5886.852828679232, 5890.764369425261, 5892.027815410409, 5906.025505791582, 5745.540356771448, 5842.328132264759, 5880.235569375954, 5891.351951285355, 5932.3474417814, 5872.677002764889, 5883.264591926009, 5887.823365298962, 5890.587658863838, 5897.52819774417, 4460.553944605514, 4503.054358584668, 4523.321501774694, 4528.207563676409, 4533.5013148553635, 3954.2882281189086, 3972.7020473464604, 4040.515138183378, 4040.8181631826637, 4055.6958228133008, 5641.2384328116, 5641.633293835969, 5641.8589535261945, 5649.971750141305, 5658.122990936411, 5963.850903727442, 5973.581849270597, 5974.193483879708, 5990.64056156632, 5994.400559944058, 5483.588730845203, 5608.46719561641, 5616.97191514048, 5731.799387021434, 5747.683877386784, 4970.130227210224, 4976.303317535548, 4984.451710311862, 4992.276119962585, 5011.57401620859, 6104.450599445982, 6151.41092201476, 6156.261248650101, 6166.568340216231, 6186.969065154645, 5745.080787074048, 5852.502537284208, 5949.0, 5962.16529685853, 5985.581009329305, 6086.452219300284, 6118.449339559461, 6126.23422072241, 6136.0, 6138.815835524942, 5785.074388097884, 5827.825165245049, 5828.6502809831545, 5836.328822185503, 5851.765929362949, 5777.971110144423, 5778.046622307273, 5852.18069470266, 5857.121431785266, 5861.6189947653265, 5699.829005129853, 5746.16680581305, 5759.481646651821, 5760.798372057126, 5762.164486149569, 5773.336066352424, 5773.364929857628, 5803.332616749128, 5811.56413268998, 5830.475257226701, 5605.80379686709, 5627.774889004394, 5632.718364081861, 5691.430856914276, 5692.48767610917, 5718.771249149988, 5748.626339287933, 5752.712364381848, 5787.681677507778, 5801.680907550125, 5671.971640141938, 5709.0865461525955, 5718.056520674042, 5741.339745929272, 5743.1385292206505], "value": 5449.064778494421, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [632.2255237334266, 665.4576520136092, 681.6114814555699, 684.2507454337501, 747.1109379837994, 34558.481622775646, 40745.18509629809, 41291.793541032326, 41404.37893431594, 41456.58543414565, 44633.107337853224, 45085.77457112718, 45102.32346514805, 45105.77447112768, 45114.32328515075, 8108.513489190638, 8801.867971980426, 8987.37088403812, 8988.50563219026, 10385.584576616926, 10461.529231184615, 10574.206934479946, 10633.149348052137, 10639.255252132354, 10640.78718425631, 10669.893301066968, 10701.946490267577, 10743.409112498848, 10747.677569672884, 10753.03222709956, 10546.525406356694, 10638.840417393745, 10644.733881652943, 10651.094656954168, 10653.414062226575, 10559.577616895314, 10919.290246133976, 11001.61494347702, 11002.394868282241, 11007.834882476769, 44766.10467790626, 44974.77512612416, 45183.77408112971, 45228.0, 45378.31932521015, 3685.8894233173046, 3694.3350196964534, 3700.9259814803554, 3758.1356288053626, 3781.357169281201, 30515.847420762977, 30918.69081309203, 31292.687073129204, 31489.48501821186, 31663.683363166303, 4085.2850751118435, 4143.751374917484, 4154.127633197032, 4159.9792001040105, 4200.789960501963, 290662.0, 292061.0, 292389.0, 293115.0, 294060.52969735226, 40343.79828100841, 40996.0, 41062.0, 64948.35051649518, 65172.348276516626, 38082.809585951894, 38227.80886095552, 38291.234175316895, 38383.0, 38415.03962400906, 17486.21312040961, 17552.56118597045, 17578.384756533458, 17644.382446614305, 17660.735088973677, 13694.52069177574, 15086.396544138332, 15527.068375897255, 15541.0, 15544.222788860738, 9364.110409511086, 9388.577514011886, 9398.436093834254, 9440.90559094414, 9461.479618620904, 3527.470879368115, 3569.964300357015, 3570.839312230956, 3587.3722098632634, 3600.189957259648, 1107.9889201107885, 1155.8324043013715, 1175.8765329640435, 1191.4042978510745, 1270.39021269791, 33851.4922276166, 33956.0, 34116.82941585326, 34198.65801342005, 35273.294534109176, 1203.8194270859442, 1243.4093805442524, 1258.4337048328289, 1277.904157188196, 1311.4167771932534, 18049.27802887896, 18068.277268909358, 18160.1827917744, 18246.726299105525, 18301.084945752926, 511048.0, 517339.0, 518994.0, 523730.0, 527138.0, 62525.0, 62784.37215627877, 62822.0, 62868.685656571426, 63101.26740494481, 1364.6929440875922, 1421.9878871397063, 1504.4433559583024, 1506.9698606028037, 1520.954371368883, 30114.32668751415, 30457.0, 33032.66967330392, 33054.17364565905, 33899.4915076279, 50308.0, 50471.0, 50868.74565627148, 50976.74511627418, 51038.489615103375, 316822.0, 317546.0, 317667.0, 318194.0, 319291.0, 28195.295117622223, 31387.372252555277, 31746.841265793522, 31852.04443866688, 31949.20126996844, 47624.0, 49519.0, 50338.74830625823, 50854.23718644297, 51116.0, 41814.372784408864, 42017.78991105025, 42238.57761422346, 42408.36387454129, 43504.0, 40589.0, 40836.38745418881, 40981.590184097775, 42140.78929605455, 42675.7866210667, 42672.57327426686, 43078.78460607677, 43455.782721086194, 43667.78166109149, 43695.56304436915, 35283.29433411266, 35980.640193598774, 36682.0, 37259.44110838285, 37460.62539374681, 28346.0, 28637.42725145444, 28841.134765956216, 29211.561826572193, 29297.41405171842], "value": 19773.445410094526, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.1934146110198, 427.29709627662476, 429.76148237728046, 430.75877508595187, 437.9781010949454, 18720.81279187208, 19401.223951041975, 19402.02989850509, 19791.0, 20612.587748245027, 12768.297743624096, 13124.934375328134, 15432.459863904765, 20309.695354569692, 20372.388828335137, 5300.946990530103, 5360.410354860962, 5516.475934786209, 5558.6942718150485, 5948.672822994734, 5877.764889404419, 5919.704014799243, 5967.403259674042, 5972.343042265347, 5975.551833612475, 5536.2249285100115, 5575.135853942646, 5923.0, 5926.288845338566, 5934.406559344053, 5406.648567843077, 5486.177073438977, 5491.395946445888, 5532.30846144232, 5543.390227075019, 5380.892382152335, 5394.379646340682, 5397.028534863723, 5399.811006614749, 6945.062416573748, 25272.115475958253, 25861.612075818877, 25865.612015819777, 26560.0, 26587.601185982225, 2603.388203772112, 2654.561997270448, 2746.436980419029, 2829.1795379339965, 3248.3990461764647, 15548.92225538865, 15774.132422716746, 15957.521274361789, 16013.599660008476, 16880.15599220034, 2178.967315490269, 2187.9453013674624, 2210.182232573958, 2310.653401989698, 2369.07606033647, 93972.0, 97076.99999999929, 98994.50502747513, 100028.0, 100455.49316760254, 17753.644927101384, 18535.53661158482, 18773.7183942241, 18867.528311792314, 18996.62006759857, 34541.481877771854, 34583.4812477813, 34672.82663586716, 35045.64954350475, 35109.0, 8698.391112622056, 9111.407758495676, 9179.816403672023, 9263.768405789775, 9280.0, 9087.273018158532, 9117.544122793966, 9131.178193962574, 9186.63253469867, 9227.0, 4904.632152588499, 5057.772400241998, 5082.974585127125, 5085.516875896784, 5085.847424577269, 1962.931297404584, 1985.9404217873487, 1991.6116357310186, 2068.1520576563535, 2111.968320475194, 489.1562055454313, 492.66252616957496, 993.339429279521, 1047.5809676129609, 1079.4602698650674, 11636.825447618292, 11776.58781942645, 12046.397680115959, 12113.152079354537, 12401.751964960651, 490.92636104584597, 497.2466712929914, 499.787590274132, 502.6632156455184, 504.4073213973566, 6712.160979877515, 6727.29363416844, 6738.528303018742, 6745.56153850008, 6797.592144471348, 502524.0, 503450.0, 506864.0, 519111.0, 527970.0, 94588.0, 98961.50519247357, 99299.50350248347, 99342.5032874831, 99872.5006374978, 505.5576370675659, 512.1242675025748, 512.6155383462403, 515.7421289355323, 519.0371860199276, 9902.257330700082, 12012.399380031138, 12028.578999734968, 12059.523095680383, 12228.44971976281, 40057.1988560233, 40858.0, 41277.0, 42096.789516052224, 42228.78885605675, 53908.460915391915, 56981.43018569927, 57107.42892571187, 57404.79478346722, 57483.137752932904, 8651.307895368482, 8715.91284087151, 8946.105389461001, 9046.728598142066, 9091.590878410356, 9545.236381089635, 12812.359382031047, 13618.046736728335, 13758.0, 13786.793198101836, 11369.943150284196, 11820.349880756641, 12262.141650084408, 12478.812817807922, 12964.870351296366, 11959.103067269816, 12262.589802172864, 12321.876781232073, 12650.367481626066, 12661.177023493443, 12333.321667308384, 12918.741625167257, 12957.41691623898, 12963.935180324039, 13173.538926137922, 9039.90960090417, 9258.490783006999, 9339.953300233456, 9376.624935002796, 9458.716238512856, 9580.856287155837, 12089.093318001362, 12538.811917821058, 12578.685532861751, 12634.494620215088], "value": 9275.194482227074, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1384.1279993604028, 1523.9161846098466, 1551.8215405228395, 1749.8425141737248, 1888.7355770192175, 8085.676572937083, 8294.336453083753, 8305.58472076396, 8315.043769966456, 8324.042735085466, 8218.917810821906, 8378.036525799535, 8381.622826972785, 8386.748397548068, 8391.580420978957, 2368.159303447277, 2378.4648454097864, 2390.486045500217, 2390.569697454466, 2396.7363590005084, 2361.102780943239, 2417.9274621761288, 2423.45472268739, 2428.368624157714, 2431.902723891051, 2302.838801283911, 2325.5813953488364, 2328.5459335429596, 2366.2073205476186, 2380.5238952209543, 2354.976450235493, 2356.5404746074523, 2388.5700573896693, 2390.880455977203, 2400.9639855402183, 2368.1593034472685, 2438.5610590093775, 2451.1298489036312, 2452.1662634704285, 2456.349067497115, 7180.31786980236, 7720.652570634335, 8590.441621294596, 8644.740657780276, 8655.134486551358, 5063.873403164914, 5201.869953251161, 5238.292830467876, 5241.109011468059, 5242.68543887368, 3273.5908011498564, 3279.3277378137423, 3283.753718471124, 3313.685199906005, 3344.0803778960735, 1070.5717712914818, 2186.3902676786315, 2186.6610675345346, 2198.8240940724704, 2223.49971256466, 11576.131790115774, 11699.883001169965, 11819.172657914036, 11826.349550774705, 11848.34834084125, 4367.978160109179, 4445.088756804847, 4449.777511124431, 4464.263396539534, 4509.571590698878, 9586.856197157049, 9593.904060959441, 9597.90402095984, 9598.568064436977, 9615.278854085831, 5236.738163091906, 5257.132573125392, 5258.447862974409, 5264.52619264268, 5271.130263506555, 4851.272309153655, 4893.290472881412, 4908.288298196813, 4909.239067944474, 4910.140725373046, 3598.334308152948, 3917.8236979335998, 3951.7628942263555, 3954.307996100671, 3955.802209889494, 1175.835383046374, 1176.129664048598, 1177.040711819864, 1189.0665827325508, 1192.7495226002463, 1055.7888422315568, 1075.6611667324767, 1077.8706555213425, 1096.8957948994832, 1099.741560733227, 5745.798897038667, 6060.696965151725, 6062.575619706578, 6108.297545782292, 6191.597546159485, 467.35971718744855, 469.27965572845517, 470.5365215262963, 1111.0611533254548, 1117.1118960426481, 4090.590940905945, 4123.8969025773995, 4131.338985762323, 4136.958630413657, 4159.396887451303, 9878.65424710146, 10184.185265178769, 10190.031946965026, 10297.227707921937, 10304.690859274233, 10036.648717295006, 10127.0, 10158.746031349276, 10161.69514914539, 10177.694669159937, 7989.121196668362, 8175.591220438954, 8252.917470825216, 8261.545614991233, 8282.58587070644, 5803.7388317524965, 5829.242198514166, 5884.6469211847425, 5951.523878089656, 6058.697065146813, 9281.39670921388, 9490.28822838276, 9584.712458626253, 9598.32811703174, 9616.615335386787, 9451.669191578261, 9643.614255429704, 9659.855102173613, 9721.513924303898, 9743.464109473764, 7230.313120253568, 7322.743703970335, 7361.963190184015, 7365.742199023009, 7471.6637751302405, 8122.75631731049, 8217.342612591097, 8221.958890205511, 8228.094909560063, 8337.708180213906, 7550.584717840571, 7647.579383133981, 7701.653425595974, 7717.2282771722375, 7764.301212890867, 7258.0, 7279.890801638086, 7344.779656610311, 7380.0, 7412.0, 6700.4639628830555, 6856.554323968926, 6869.381755642016, 6871.415929646036, 6873.278305778022, 4489.640828733628, 5268.446813084724, 5332.626716129834, 5386.245925570345, 5533.5849811263515, 5230.398504172069, 5279.551238144647, 5293.973530132479, 5364.678119312854, 5443.510084092451], "value": 4616.5747321159715, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.1421517282657, 354.9183687751817, 356.630887031922, 359.9982000089999, 360.22012343276805, 6263.874722505547, 6300.21247344082, 6437.83905402364, 6454.0, 6459.4832413406875, 6255.874882502359, 6273.3412991635905, 6302.275238347592, 6330.208723909512, 6340.4610608098255, 4530.433695788027, 4773.949731059161, 4777.999999999991, 4778.25936979767, 4797.544233297831, 4625.953740462603, 4637.0725854829, 4678.415198100238, 4698.365720627723, 4801.423829140508, 4745.477997420281, 4770.570648641621, 4778.498257682928, 4782.091402633506, 4783.402074740658, 4738.431388233417, 4757.310190022427, 4758.881027974294, 4762.0, 4766.261229509431, 3936.8425262989444, 4061.0, 4123.969007748063, 4127.29835927893, 4173.707840451169, 5938.168656388066, 5951.9107213391835, 5953.7320820562745, 5990.1314309425325, 6031.065184896304, 5555.638883472561, 5559.305086864142, 5562.249096371978, 5562.276904002494, 5567.693776842272, 6553.737850485975, 6561.114249576294, 6567.8029659109825, 6580.670966451658, 6583.868322633569, 4619.122366750306, 4621.075784843045, 4622.306654001893, 4626.005408837116, 4627.699199552052, 6614.966925165391, 6855.903055511094, 6941.548799328028, 6947.444204463682, 6960.860782784366, 4679.508651591602, 4706.505816889177, 4721.3390125382475, 4731.858044258678, 4732.290156476556, 4781.904361912742, 4782.306565547976, 4782.665213435026, 4787.688800227974, 4791.137595232892, 5521.171824226398, 5534.363548191929, 5535.142052981794, 5537.446255374511, 5541.861453463615, 6623.867522649616, 6625.933740662628, 6635.568688035262, 6642.734290628321, 6649.335066493312, 1622.4078211452734, 1658.8009438867173, 1672.966540669204, 1676.893250454694, 1682.0328311220853, 1061.8725752909545, 1091.579741799397, 1092.8032954068185, 1093.676651251978, 1104.9005589496983, 6222.595531290452, 6345.365463453618, 6355.237371515448, 6357.650329231937, 6360.6501642409185, 6744.527883048139, 6931.306869313129, 6972.477064220204, 6980.895286570705, 6995.685194166274, 6506.60960342381, 6515.7067931943175, 6518.706658200393, 6518.934810651927, 6539.673016349164, 3709.684676802448, 3749.9812500937865, 3751.268502642013, 3761.454589084622, 3761.567419746709, 7090.113735783028, 7220.169680486706, 7230.927690723025, 7233.8553228935125, 7243.9637801811705, 7005.614691192033, 7068.823279418056, 7069.222385537587, 7070.151581810215, 7070.186928503185, 7169.964150179216, 7198.316159964795, 7199.1361036675935, 7219.205887352387, 7222.422206223595, 6931.4108300795, 6934.791956241321, 6948.235694073547, 6961.164660240804, 6967.965160174167, 6764.3573860483175, 6808.421284190899, 6809.795706128824, 6810.965945170441, 6813.965930170318, 6944.159797653525, 7223.530470519399, 7235.457340699363, 7247.420206383582, 7249.565026098451, 4502.57225563571, 4568.337591049346, 4578.40480737502, 4588.793504292382, 4589.7705114744795, 6936.410405115622, 6936.895946560907, 6949.027136201037, 6950.721971121098, 6950.8609827804175, 6737.0, 6743.629100399525, 6746.0, 6746.763863264762, 6747.224069231905, 6610.474197636425, 6655.567388119756, 6733.93266067333, 6735.124433823572, 6740.460763138839, 6575.769848055295, 6600.867982640416, 6606.141201643755, 6608.4382827458285, 6610.867782644224, 6750.1562304711915, 6751.831204219934, 6763.0, 6766.391024807791, 6771.221309549464, 6582.308857569887, 6588.275289718223, 6594.208694956636, 6663.400293973566, 6679.131712877295], "value": 5023.872571833939, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [769.7652216074102, 778.9337906277963, 798.3453568074182, 872.5680788009934, 896.2158111652302, 14592.270386480686, 14613.269336533158, 14642.194679292634, 15139.167345795991, 15337.616559586002, 14174.362153703083, 14291.071080379768, 14353.497627583036, 14374.209418482005, 14431.783523247133, 769.2499812682646, 852.4970267542149, 886.2555453419127, 908.5230254116609, 913.0914739833875, 904.5522466379118, 907.3104440625107, 909.4725059465494, 915.0346384564315, 915.1351972386097, 946.1815529566944, 946.981060378792, 947.1002547579792, 957.0620791624212, 958.7746879483316, 798.1738900238255, 930.1442672741094, 963.7397902566267, 963.802420503795, 966.0243154414022, 691.0187533702154, 692.2523674431602, 695.1172011545309, 695.4853408477741, 697.0137255783061, 13800.723985520333, 13834.584962451143, 13881.0, 13891.235982020984, 13928.86071139296, 14766.926165369212, 15073.170975596338, 15358.846411535853, 15406.691866162613, 15543.455979040793, 12059.397030148546, 12149.574764883188, 12331.198472099284, 12334.444949977273, 12492.188007779465, 4060.776657283848, 4064.7561146331313, 4122.361034039729, 4161.52142503613, 4200.243956087903, 55101.44898551043, 55967.44032559663, 56091.71954140244, 56208.43791562073, 56325.71837140788, 11915.106367022508, 11946.522139114339, 12090.637280881587, 12148.0, 12408.875911240772, 19226.134823932956, 19233.61532769365, 19238.519037024187, 19325.03374831253, 19330.613387732446, 8406.747797566082, 8491.95754021226, 8646.048934617187, 8786.560671966376, 8868.0, 4689.390379250675, 4721.480637129913, 4890.388701412324, 4981.178105612606, 5038.521340472723, 3366.107981384935, 3391.9491207631904, 3418.0942050356675, 3421.709154721827, 3428.160100775276, 585.5696063393402, 596.7881402102278, 605.7274226598048, 655.3904868472366, 655.95408321418, 704.1057856522189, 730.6346826586706, 832.1595188859175, 833.9874901876477, 845.9280961118251, 9709.141685730374, 10133.847992280122, 10167.898321016843, 10303.536340864679, 10318.535665895053, 677.2110491277705, 713.6039498078512, 735.7057177129084, 769.4882902869641, 772.8724760414581, 4683.601893838993, 4731.787069581877, 4746.28805679144, 4808.543188397167, 4832.0, 63364.366356336766, 63635.04547431792, 64084.0, 64350.35649643537, 64423.67788161029, 54982.17526737102, 56759.71620141873, 56790.716046419504, 56825.43174568201, 57046.7147664259, 48994.26508602374, 49352.25971610429, 49910.25134622984, 50344.49655503471, 50538.494615054115, 9309.115634014757, 9502.097300756417, 9544.761380965254, 9566.856497152687, 9568.09103135201, 35046.47430288497, 35122.12194695153, 36700.26599468049, 40220.59779402168, 40732.79633601813, 46373.536264636925, 47068.29397559108, 47625.28562071641, 49146.75426622844, 50569.0, 12415.813762793747, 12582.87417125817, 12767.93616031914, 12866.935665321613, 12996.935015324863, 13068.673283167996, 13953.651158721113, 14040.0, 14218.928905355408, 14457.638559036108, 13569.52506662262, 13615.659608509866, 13649.658758530719, 13725.176489410667, 13777.655558611115, 13062.281574513492, 13433.798493022417, 13448.798268026183, 13624.318784060955, 14168.291585420893, 13386.799198011842, 13403.865961340261, 13467.865321347053, 13584.660383490493, 13717.657058573615, 10964.396958167059, 11016.283941543774, 11152.776944461228, 11508.539658413905, 11980.341081240267, 11301.660950171508, 11424.371659558805, 11462.885371146182, 11558.0, 11574.0], "value": 7133.628859491022, "unit": "score"}], "name": "dromaeo_css", "value": 7408.650080023347, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 110.0, 111.0, 111.0, 111.0, 105.0, 108.0, 110.0, 108.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 125.0, 160.0, 180.0, 129.0, 160.0, 161.0, 127.0, 180.0, 126.0], "value": 151.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 162.0, 161.0, 162.0, 160.0, 161.0, 161.0, 160.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 170.0, 76.0, 76.0, 76.0, 80.0, 159.0, 77.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 151.0, 92.0, 92.0, 93.0, 140.0, 92.0, 93.0, 147.0], "value": 108.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 150.0, 145.0, 145.0, 146.0, 145.0, 145.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 97.0, 96.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 55.0, 53.0, 54.0, 54.0, 76.0, 52.0, 52.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 61.0, 59.0, 60.0, 60.0, 59.0, 60.0, 58.0, 65.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 72.0, 71.0, 74.0, 74.0, 74.0, 74.0, 74.0, 74.0], "value": 73.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 117.0, 113.0, 113.0, 113.0, 108.0, 112.0, 112.0, 135.0, 119.0], "value": 115.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 155.0, 156.0, 155.0, 155.0, 158.0, 155.0, 157.0, 157.0, 153.0], "value": 156.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 66.0, 66.0, 65.0, 66.0, 66.0, 66.0, 66.0, 65.0], "value": 66.3, "unit": "score"}], "name": "kraken", "value": 1508.7, "alertThreshold": 2.0}]} 11:31:54 INFO - Return code: 0 11:31:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:31:54 ERROR - # TBPL SUCCESS # 11:31:54 INFO - Running post-action listener: _resource_record_post_action 11:31:54 INFO - Running post-run listener: _resource_record_post_run 11:31:55 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 464814080; Read time: 20; Write time: 341668 11:31:55 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 241913856; Read time: 0; Write time: 237268 11:31:55 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 222363648; Read time: 20; Write time: 104400 11:31:55 INFO - Running post-run listener: _upload_blobber_files 11:31:55 INFO - Blob upload gear active. 11:31:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:31:55 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 11:31:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:31:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:31:56 INFO - (blobuploader) - INFO - Open directory for files ... 11:31:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:31:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:31:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:31:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:31:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:31:57 INFO - (blobuploader) - INFO - Done attempting. 11:31:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:31:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:31:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:31:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:31:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:31:58 INFO - (blobuploader) - INFO - Done attempting. 11:31:58 INFO - (blobuploader) - INFO - Iteration through files over. 11:31:58 INFO - Return code: 0 11:31:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:31:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:31:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9ae36bb59a4ce5b2c6bc73d7ca515ab683a7a9af0c770f880a974bc89905f1f50c31183b5a07872c89834f1c4c540229e1fb539ed2604fba104b7978d7b59410", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3dfebb5612bfb1cf3e071881ab8b032cbd90e1b2a2109e78de56d82f7875719ddee6d8e35cc9f09c763a3732e1fb6404d4a1ee4eee3eee72675d766af620555f"} 11:31:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:31:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:31:58 INFO - Contents: 11:31:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9ae36bb59a4ce5b2c6bc73d7ca515ab683a7a9af0c770f880a974bc89905f1f50c31183b5a07872c89834f1c4c540229e1fb539ed2604fba104b7978d7b59410", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3dfebb5612bfb1cf3e071881ab8b032cbd90e1b2a2109e78de56d82f7875719ddee6d8e35cc9f09c763a3732e1fb6404d4a1ee4eee3eee72675d766af620555f"} 11:31:58 INFO - Running post-run listener: copy_logs_to_upload_dir 11:31:58 INFO - Copying logs to upload dir... 11:31:58 INFO - mkdir: /builds/slave/test/build/upload/logs 11:31:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.565474 ========= master_lag: 8.53 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-23 11:32:06.745602) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 11:32:06.748987) ========= 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=337fe3f4b1febe37b85fccc40000019e-1466703634.225124-831287079 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9ae36bb59a4ce5b2c6bc73d7ca515ab683a7a9af0c770f880a974bc89905f1f50c31183b5a07872c89834f1c4c540229e1fb539ed2604fba104b7978d7b59410", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3dfebb5612bfb1cf3e071881ab8b032cbd90e1b2a2109e78de56d82f7875719ddee6d8e35cc9f09c763a3732e1fb6404d4a1ee4eee3eee72675d766af620555f"} build_url:https://queue.taskcluster.net/v1/task/Lr1jcZkkSF6iQBPU8eW-xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011372 build_url: 'https://queue.taskcluster.net/v1/task/Lr1jcZkkSF6iQBPU8eW-xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9ae36bb59a4ce5b2c6bc73d7ca515ab683a7a9af0c770f880a974bc89905f1f50c31183b5a07872c89834f1c4c540229e1fb539ed2604fba104b7978d7b59410", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3dfebb5612bfb1cf3e071881ab8b032cbd90e1b2a2109e78de56d82f7875719ddee6d8e35cc9f09c763a3732e1fb6404d4a1ee4eee3eee72675d766af620555f"}' ========= master_lag: 0.05 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 11:32:06.807045) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-06-23 11:32:06.807382) ========= 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=337fe3f4b1febe37b85fccc40000019e-1466703634.225124-831287079 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004562 ========= master_lag: 1.21 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-06-23 11:32:08.024038) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 11:32:08.024374) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 11:32:08.028176) ========= ========= Total master_lag: 9.85 =========