builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-069 starttime: 1468013059.78 results: success (0) buildid: 20160708113726 builduid: 0e18ae00cb88446ba899f020b0a6a925 revision: 23d50da987261085138dab3f05eae49806d9bf1b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 14:24:19.781188) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 14:24:19.781781) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 14:24:19.782111) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 14:24:19.800748) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 14:24:19.801258) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1468010725.232673-603144298 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-08 14:24:20-- 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% 34.5M=0s 2016-07-08 14:24:20 (34.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113498 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 14:24:19.930042) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 14:24:19.930384) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1468010725.232673-603144298 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023024 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 14:24:19.985380) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 14:24:19.985727) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 23d50da987261085138dab3f05eae49806d9bf1b --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 23d50da987261085138dab3f05eae49806d9bf1b --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=05b19d94dfa9f3ce7b6e62cc000001f7-1468010725.232673-603144298 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-08 14:24:20,508 truncating revision to first 12 chars 2016-07-08 14:24:20,508 Setting DEBUG logging. 2016-07-08 14:24:20,508 attempt 1/10 2016-07-08 14:24:20,508 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/23d50da98726?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-08 14:24:20,804 unpacking tar archive at: mozilla-beta-23d50da98726/testing/mozharness/ program finished with exit code 0 elapsedTime=0.702790 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 14:24:20.705633) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 14:24:20.706319) ========= script_repo_revision: 23d50da987261085138dab3f05eae49806d9bf1b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 14:24:20.707225) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 14:24:20.707869) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 14:24:20.719746) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-07-08 14:24:20.720068) ========= /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=05b19d94dfa9f3ce7b6e62cc000001f7-1468010725.232673-603144298 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:24:21 INFO - MultiFileLogger online at 20160708 14:24:21 in /builds/slave/test 14:24:21 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 14:24:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:24:21 INFO - {'append_to_log': False, 14:24:21 INFO - 'base_work_dir': '/builds/slave/test', 14:24:21 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:24:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:24:21 INFO - 'branch': 'Mozilla-Beta', 14:24:21 INFO - 'buildbot_json_path': 'buildprops.json', 14:24:21 INFO - 'config_files': ('talos/linux_config.py',), 14:24:21 INFO - 'default_actions': ('clobber', 14:24:21 INFO - 'read-buildbot-config', 14:24:21 INFO - 'download-and-extract', 14:24:21 INFO - 'populate-webroot', 14:24:21 INFO - 'create-virtualenv', 14:24:21 INFO - 'install', 14:24:21 INFO - 'run-tests'), 14:24:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:24:21 INFO - 'download_minidump_stackwalk': True, 14:24:21 INFO - 'download_symbols': 'ondemand', 14:24:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:24:21 INFO - 'tooltool.py': '/tools/tooltool.py', 14:24:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:24:21 INFO - '/tools/misc-python/virtualenv.py')}, 14:24:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:24:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:24:21 INFO - 'installer_path': 'installer.exe', 14:24:21 INFO - 'log_level': 'info', 14:24:21 INFO - 'log_name': 'talos', 14:24:21 INFO - 'log_to_console': True, 14:24:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:24:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:24:21 INFO - 'opt_config_files': (), 14:24:21 INFO - 'pip_index': False, 14:24:21 INFO - 'sps_profile': False, 14:24:21 INFO - 'sps_profile_interval': 0, 14:24:21 INFO - 'suite': 'dromaeojs', 14:24:21 INFO - 'system_bits': '32', 14:24:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:24:21 INFO - 'title': 'talos-linux64-ix-069', 14:24:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:24:21 INFO - 'use_talos_json': True, 14:24:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:24:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:24:21 INFO - 'work_dir': 'build'} 14:24:21 INFO - ##### 14:24:21 INFO - ##### Running clobber step. 14:24:21 INFO - ##### 14:24:21 INFO - Running pre-action listener: _resource_record_pre_action 14:24:21 INFO - Running main action method: clobber 14:24:21 INFO - rmtree: /builds/slave/test/build 14:24:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:24:21 INFO - Running post-action listener: _resource_record_post_action 14:24:21 INFO - ##### 14:24:21 INFO - ##### Running read-buildbot-config step. 14:24:21 INFO - ##### 14:24:21 INFO - Running pre-action listener: _resource_record_pre_action 14:24:21 INFO - Running main action method: read_buildbot_config 14:24:21 INFO - Using buildbot properties: 14:24:21 INFO - { 14:24:21 INFO - "project": "", 14:24:21 INFO - "product": "firefox", 14:24:21 INFO - "script_repo_revision": "production", 14:24:21 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 14:24:21 INFO - "repository": "", 14:24:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 14:24:21 INFO - "buildid": "20160708113726", 14:24:21 INFO - "pgo_build": "True", 14:24:21 INFO - "basedir": "/builds/slave/test", 14:24:21 INFO - "buildnumber": 162, 14:24:21 INFO - "slavename": "talos-linux64-ix-069", 14:24:21 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:24:21 INFO - "platform": "ubuntu64_hw", 14:24:21 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 14:24:21 INFO - "branch": "mozilla-beta", 14:24:21 INFO - "repo_path": "releases/mozilla-beta", 14:24:21 INFO - "revision": "23d50da987261085138dab3f05eae49806d9bf1b", 14:24:21 INFO - "stage_platform": "linux64-pgo", 14:24:21 INFO - "builduid": "0e18ae00cb88446ba899f020b0a6a925", 14:24:21 INFO - "slavebuilddir": "test" 14:24:21 INFO - } 14:24:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZGcMFbUBSfmwYvtdIkYqkw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 14:24:21 INFO - Running post-action listener: _resource_record_post_action 14:24:21 INFO - ##### 14:24:21 INFO - ##### Running download-and-extract step. 14:24:21 INFO - ##### 14:24:21 INFO - Running pre-action listener: _resource_record_pre_action 14:24:21 INFO - Running main action method: download_and_extract 14:24:21 INFO - mkdir: /builds/slave/test/build/tests 14:24:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:21 INFO - https://queue.taskcluster.net/v1/task/ZGcMFbUBSfmwYvtdIkYqkw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:24:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGcMFbUBSfmwYvtdIkYqkw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 14:24:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGcMFbUBSfmwYvtdIkYqkw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 14:24:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGcMFbUBSfmwYvtdIkYqkw/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 14:24:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGcMFbUBSfmwYvtdIkYqkw/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 14:24:26 INFO - Downloaded 1327 bytes. 14:24:26 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 14:24:26 INFO - Using the following test package requirements: 14:24:26 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 14:24:26 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 14:24:26 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 14:24:26 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 14:24:26 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 14:24:26 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 14:24:26 INFO - u'jsshell-linux-x86_64.zip'], 14:24:26 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 14:24:26 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 14:24:26 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 14:24:26 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 14:24:26 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 14:24:26 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 14:24:26 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 14:24:26 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 14:24:26 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 14:24:26 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 14:24:26 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 14:24:26 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:24:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:26 INFO - https://queue.taskcluster.net/v1/task/ZGcMFbUBSfmwYvtdIkYqkw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:24:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGcMFbUBSfmwYvtdIkYqkw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 14:24:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGcMFbUBSfmwYvtdIkYqkw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 14:24:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGcMFbUBSfmwYvtdIkYqkw/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 14:24:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGcMFbUBSfmwYvtdIkYqkw/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 14:24:30 INFO - Downloaded 24237140 bytes. 14:24:30 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'] 14:24:30 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 14:24:32 INFO - Return code: 0 14:24:32 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 14:24:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:32 INFO - https://queue.taskcluster.net/v1/task/ZGcMFbUBSfmwYvtdIkYqkw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:24:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGcMFbUBSfmwYvtdIkYqkw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 14:24:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGcMFbUBSfmwYvtdIkYqkw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 14:24:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGcMFbUBSfmwYvtdIkYqkw/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 14:24:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGcMFbUBSfmwYvtdIkYqkw/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 14:24:38 INFO - Downloaded 24237140 bytes. 14:24:38 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'] 14:24:38 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 14:24:39 INFO - Return code: 0 14:24:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:39 INFO - https://queue.taskcluster.net/v1/task/ZGcMFbUBSfmwYvtdIkYqkw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:24:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGcMFbUBSfmwYvtdIkYqkw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 14:24:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGcMFbUBSfmwYvtdIkYqkw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 14:24:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGcMFbUBSfmwYvtdIkYqkw/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 14:24:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGcMFbUBSfmwYvtdIkYqkw/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 14:24:41 INFO - Downloaded 10840145 bytes. 14:24:41 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'] 14:24:41 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 14:24:41 INFO - Return code: 0 14:24:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:41 INFO - https://queue.taskcluster.net/v1/task/ZGcMFbUBSfmwYvtdIkYqkw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:24:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGcMFbUBSfmwYvtdIkYqkw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 14:24:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGcMFbUBSfmwYvtdIkYqkw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 14:24:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGcMFbUBSfmwYvtdIkYqkw/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 14:24:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGcMFbUBSfmwYvtdIkYqkw/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 14:24:42 INFO - Downloaded 56038387 bytes. 14:24:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZGcMFbUBSfmwYvtdIkYqkw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 14:24:42 INFO - mkdir: /builds/slave/test/properties 14:24:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:24:42 INFO - Writing to file /builds/slave/test/properties/build_url 14:24:42 INFO - Contents: 14:24:42 INFO - build_url:https://queue.taskcluster.net/v1/task/ZGcMFbUBSfmwYvtdIkYqkw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 14:24:43 INFO - Running post-action listener: _resource_record_post_action 14:24:43 INFO - Running post-action listener: set_extra_try_arguments 14:24:43 INFO - ##### 14:24:43 INFO - ##### Running populate-webroot step. 14:24:43 INFO - ##### 14:24:43 INFO - Running pre-action listener: _resource_record_pre_action 14:24:43 INFO - Running main action method: populate_webroot 14:24:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:24:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:24:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:24:43 INFO - '--tppagecycles', 14:24:43 INFO - '7'], 14:24:43 INFO - 'tests': ['tsvgm']}}, 14:24:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:24:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:24:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:24:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:24:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:24:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:24:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:43 INFO - 'talos_options': ['--disable-e10s'], 14:24:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:24:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:24:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:43 INFO - 'talos_options': ['--disable-e10s'], 14:24:43 INFO - 'tests': ['damp', 'tps']}, 14:24:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:43 INFO - 'tests': ['damp', 'tps']}, 14:24:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:24:43 INFO - 'tests': ['dromaeo_dom']}, 14:24:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:24:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:24:43 INFO - 'tests': ['a11yr', 14:24:43 INFO - 'ts_paint', 14:24:43 INFO - 'tpaint', 14:24:43 INFO - 'sessionrestore', 14:24:43 INFO - 'sessionrestore_no_auto_restore', 14:24:43 INFO - 'tabpaint']}, 14:24:43 INFO - 'other-e10s': {'tests': ['a11yr', 14:24:43 INFO - 'ts_paint', 14:24:43 INFO - 'tpaint', 14:24:43 INFO - 'sessionrestore', 14:24:43 INFO - 'sessionrestore_no_auto_restore', 14:24:43 INFO - 'tabpaint']}, 14:24:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:24:43 INFO - 'ts_paint', 14:24:43 INFO - 'tpaint', 14:24:43 INFO - 'sessionrestore', 14:24:43 INFO - 'sessionrestore_no_auto_restore', 14:24:43 INFO - 'tabpaint']}, 14:24:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:24:43 INFO - 'ts_paint', 14:24:43 INFO - 'tpaint', 14:24:43 INFO - 'sessionrestore', 14:24:43 INFO - 'sessionrestore_no_auto_restore', 14:24:43 INFO - 'tabpaint']}, 14:24:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:24:43 INFO - 'tests': ['a11yr', 14:24:43 INFO - 'ts_paint', 14:24:43 INFO - 'tpaint', 14:24:43 INFO - 'sessionrestore', 14:24:43 INFO - 'sessionrestore_no_auto_restore', 14:24:43 INFO - 'tabpaint']}, 14:24:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:24:43 INFO - 'tests': ['a11yr', 14:24:43 INFO - 'ts_paint', 14:24:43 INFO - 'tpaint', 14:24:43 INFO - 'sessionrestore', 14:24:43 INFO - 'sessionrestore_no_auto_restore', 14:24:43 INFO - 'tabpaint']}, 14:24:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:24:43 INFO - 'tests': ['tsvgx', 14:24:43 INFO - 'tsvgr_opacity', 14:24:43 INFO - 'tart', 14:24:43 INFO - 'tscrollx', 14:24:43 INFO - 'cart']}, 14:24:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:24:43 INFO - 'tsvgr_opacity', 14:24:43 INFO - 'tart', 14:24:43 INFO - 'tscrollx', 14:24:43 INFO - 'cart']}, 14:24:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:43 INFO - 'talos_options': ['--disable-e10s'], 14:24:43 INFO - 'tests': ['tp5o']}, 14:24:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:43 INFO - 'tests': ['tp5o']}, 14:24:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:43 INFO - 'talos_options': ['--disable-e10s', 14:24:43 INFO - '--xperf_path', 14:24:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:24:43 INFO - 'tests': ['tp5n']}, 14:24:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:43 INFO - 'talos_options': ['--xperf_path', 14:24:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:24:43 INFO - 'tests': ['tp5n']}}, 14:24:43 INFO - 'talos.zip': {'path': '', 14:24:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:24:43 INFO - Running post-action listener: _resource_record_post_action 14:24:43 INFO - ##### 14:24:43 INFO - ##### Running create-virtualenv step. 14:24:43 INFO - ##### 14:24:43 INFO - Running pre-action listener: _resource_record_pre_action 14:24:43 INFO - Running main action method: create_virtualenv 14:24:43 INFO - Creating virtualenv /builds/slave/test/build/venv 14:24:43 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 14:24:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:24:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:24:43 INFO - Using real prefix '/usr' 14:24:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:24:44 INFO - Installing distribute.............................................................................................................................................................................................done. 14:24:46 INFO - Installing pip.................done. 14:24:46 INFO - Return code: 0 14:24:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:24:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:46 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 0x7f12204a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17d55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1864410>, '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 0x1865310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18657a0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468010725.232673-603144298', '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 14:24:46 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 14:24:46 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 14:24:46 INFO - Using env: {'DISPLAY': ':0', 14:24:46 INFO - 'HOME': '/home/cltbld', 14:24:46 INFO - 'LANG': 'en_US.UTF-8', 14:24:46 INFO - 'LANGUAGE': 'en_US:en', 14:24:46 INFO - 'LOGNAME': 'cltbld', 14:24:46 INFO - 'MAIL': '/var/mail/cltbld', 14:24:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:46 INFO - 'MOZ_NO_REMOTE': '1', 14:24:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:46 INFO - 'NO_EM_RESTART': '1', 14:24:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:46 INFO - 'PWD': '/builds/slave/test', 14:24:46 INFO - 'SHELL': '/bin/bash', 14:24:46 INFO - 'SHLVL': '1', 14:24:46 INFO - 'TERM': 'linux', 14:24:46 INFO - 'TMOUT': '86400', 14:24:46 INFO - 'USER': 'cltbld', 14:24:46 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468010725.232673-603144298', 14:24:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:46 INFO - '_': '/tools/buildbot/bin/python'} 14:24:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:46 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 14:24:46 INFO - Cleaning up... 14:24:46 INFO - Return code: 0 14:24:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:24:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:46 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 0x7f12204a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17d55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1864410>, '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 0x1865310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18657a0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468010725.232673-603144298', '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 14:24:46 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 14:24:46 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 14:24:46 INFO - Using env: {'DISPLAY': ':0', 14:24:46 INFO - 'HOME': '/home/cltbld', 14:24:46 INFO - 'LANG': 'en_US.UTF-8', 14:24:46 INFO - 'LANGUAGE': 'en_US:en', 14:24:46 INFO - 'LOGNAME': 'cltbld', 14:24:46 INFO - 'MAIL': '/var/mail/cltbld', 14:24:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:46 INFO - 'MOZ_NO_REMOTE': '1', 14:24:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:46 INFO - 'NO_EM_RESTART': '1', 14:24:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:46 INFO - 'PWD': '/builds/slave/test', 14:24:46 INFO - 'SHELL': '/bin/bash', 14:24:46 INFO - 'SHLVL': '1', 14:24:46 INFO - 'TERM': 'linux', 14:24:46 INFO - 'TMOUT': '86400', 14:24:46 INFO - 'USER': 'cltbld', 14:24:46 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468010725.232673-603144298', 14:24:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:46 INFO - '_': '/tools/buildbot/bin/python'} 14:24:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:46 INFO - Downloading/unpacking psutil>=0.7.1 14:24:46 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 14:24:46 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 14:24:46 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 14:24:46 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 14:24:46 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 14:24:46 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 14:24:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:24:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:24:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:24:48 INFO - Installing collected packages: psutil 14:24:48 INFO - Running setup.py install for psutil 14:24:48 INFO - building 'psutil._psutil_linux' extension 14:24:48 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 14:24:48 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 14:24:48 INFO - building 'psutil._psutil_posix' extension 14:24:48 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 14:24:48 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 14:24:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:24:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:24:48 INFO - Successfully installed psutil 14:24:48 INFO - Cleaning up... 14:24:49 INFO - Return code: 0 14:24:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:24:49 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')]} 14:24:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:49 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')]} 14:24:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:49 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 0x7f12204a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17d55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1864410>, '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 0x1865310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18657a0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468010725.232673-603144298', '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 14:24:49 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 14:24:49 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 14:24:49 INFO - Using env: {'DISPLAY': ':0', 14:24:49 INFO - 'HOME': '/home/cltbld', 14:24:49 INFO - 'LANG': 'en_US.UTF-8', 14:24:49 INFO - 'LANGUAGE': 'en_US:en', 14:24:49 INFO - 'LOGNAME': 'cltbld', 14:24:49 INFO - 'MAIL': '/var/mail/cltbld', 14:24:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:49 INFO - 'MOZ_NO_REMOTE': '1', 14:24:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:49 INFO - 'NO_EM_RESTART': '1', 14:24:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:49 INFO - 'PWD': '/builds/slave/test', 14:24:49 INFO - 'SHELL': '/bin/bash', 14:24:49 INFO - 'SHLVL': '1', 14:24:49 INFO - 'TERM': 'linux', 14:24:49 INFO - 'TMOUT': '86400', 14:24:49 INFO - 'USER': 'cltbld', 14:24:49 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468010725.232673-603144298', 14:24:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:49 INFO - '_': '/tools/buildbot/bin/python'} 14:24:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:24:49 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 14:24:49 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 14:24:49 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 14:24:49 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 14:24:49 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 14:24:49 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 14:24:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:24:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:24:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:24:51 INFO - Installing collected packages: mozsystemmonitor 14:24:51 INFO - Running setup.py install for mozsystemmonitor 14:24:51 INFO - Successfully installed mozsystemmonitor 14:24:51 INFO - Cleaning up... 14:24:51 INFO - Return code: 0 14:24:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:24:51 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')]} 14:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:51 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')]} 14:24:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:51 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 0x7f12204a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17d55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1864410>, '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 0x1865310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18657a0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468010725.232673-603144298', '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 14:24:51 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 14:24:51 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 14:24:51 INFO - Using env: {'DISPLAY': ':0', 14:24:51 INFO - 'HOME': '/home/cltbld', 14:24:51 INFO - 'LANG': 'en_US.UTF-8', 14:24:51 INFO - 'LANGUAGE': 'en_US:en', 14:24:51 INFO - 'LOGNAME': 'cltbld', 14:24:51 INFO - 'MAIL': '/var/mail/cltbld', 14:24:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:51 INFO - 'MOZ_NO_REMOTE': '1', 14:24:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:51 INFO - 'NO_EM_RESTART': '1', 14:24:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:51 INFO - 'PWD': '/builds/slave/test', 14:24:51 INFO - 'SHELL': '/bin/bash', 14:24:51 INFO - 'SHLVL': '1', 14:24:51 INFO - 'TERM': 'linux', 14:24:51 INFO - 'TMOUT': '86400', 14:24:51 INFO - 'USER': 'cltbld', 14:24:51 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468010725.232673-603144298', 14:24:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:51 INFO - '_': '/tools/buildbot/bin/python'} 14:24:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:51 INFO - Downloading/unpacking blobuploader==1.2.4 14:24:51 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 14:24:51 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 14:24:51 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 14:24:51 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 14:24:51 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 14:24:51 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 14:24:53 INFO - Downloading blobuploader-1.2.4.tar.gz 14:24:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:24:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:24: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 14:24: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 14:24: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 14:24: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 14:24: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 14:24: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 14:24:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:24:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:24: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 14:24: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 14:24: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 14:24: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 14:24: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 14:24: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 14:24:54 INFO - Downloading docopt-0.6.1.tar.gz 14:24:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:24:54 INFO - Installing collected packages: blobuploader, requests, docopt 14:24:54 INFO - Running setup.py install for blobuploader 14:24:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:24:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:24:54 INFO - Running setup.py install for requests 14:24:54 INFO - Running setup.py install for docopt 14:24:54 INFO - Successfully installed blobuploader requests docopt 14:24:54 INFO - Cleaning up... 14:24:54 INFO - Return code: 0 14:24:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:24:54 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')]} 14:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:54 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')]} 14:24:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:54 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 0x7f12204a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17d55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1864410>, '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 0x1865310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18657a0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468010725.232673-603144298', '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 14:24:54 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 14:24:54 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 14:24:54 INFO - Using env: {'DISPLAY': ':0', 14:24:54 INFO - 'HOME': '/home/cltbld', 14:24:54 INFO - 'LANG': 'en_US.UTF-8', 14:24:54 INFO - 'LANGUAGE': 'en_US:en', 14:24:54 INFO - 'LOGNAME': 'cltbld', 14:24:54 INFO - 'MAIL': '/var/mail/cltbld', 14:24:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:54 INFO - 'MOZ_NO_REMOTE': '1', 14:24:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:54 INFO - 'NO_EM_RESTART': '1', 14:24:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:54 INFO - 'PWD': '/builds/slave/test', 14:24:54 INFO - 'SHELL': '/bin/bash', 14:24:54 INFO - 'SHLVL': '1', 14:24:54 INFO - 'TERM': 'linux', 14:24:54 INFO - 'TMOUT': '86400', 14:24:54 INFO - 'USER': 'cltbld', 14:24:54 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468010725.232673-603144298', 14:24:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:54 INFO - '_': '/tools/buildbot/bin/python'} 14:24:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:24:54 INFO - Running setup.py (path:/tmp/pip-5NzWAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:24:55 INFO - Running setup.py (path:/tmp/pip-vIjRyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:24:55 INFO - Running setup.py (path:/tmp/pip-aqhaBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:24:55 INFO - Running setup.py (path:/tmp/pip-FkpIYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:24:55 INFO - Running setup.py (path:/tmp/pip-WLFqZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:24:55 INFO - Running setup.py (path:/tmp/pip-9XnNFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:24:55 INFO - Running setup.py (path:/tmp/pip-_EUz4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:24:55 INFO - Running setup.py (path:/tmp/pip-EogBos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:24:55 INFO - Running setup.py (path:/tmp/pip-2ig09O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:24:55 INFO - Running setup.py (path:/tmp/pip-9c6oyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:24:55 INFO - Running setup.py (path:/tmp/pip-MAEjRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:24:55 INFO - Running setup.py (path:/tmp/pip-IMP0ey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:24:55 INFO - Running setup.py (path:/tmp/pip-25THhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:24:55 INFO - Running setup.py (path:/tmp/pip-68e4uI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:24:55 INFO - Running setup.py (path:/tmp/pip-PUrW6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:24:56 INFO - Running setup.py (path:/tmp/pip-b7c4kb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:24:56 INFO - Running setup.py (path:/tmp/pip-TAOTtf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:24:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:24:56 INFO - Running setup.py install for manifestparser 14:24:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:24:56 INFO - Running setup.py install for mozcrash 14:24:56 INFO - Running setup.py install for mozdebug 14:24:56 INFO - Running setup.py install for mozdevice 14:24:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:24:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:24:56 INFO - Running setup.py install for mozfile 14:24:56 INFO - Running setup.py install for mozhttpd 14:24:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:24:56 INFO - Running setup.py install for mozinfo 14:24:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:24:56 INFO - Running setup.py install for mozInstall 14:24:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:24:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:24:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:24:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:24:56 INFO - Running setup.py install for mozleak 14:24:57 INFO - Running setup.py install for mozlog 14:24:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:24:57 INFO - Running setup.py install for moznetwork 14:24:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:24:57 INFO - Running setup.py install for mozprocess 14:24:57 INFO - Running setup.py install for mozprofile 14:24:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:24:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:24:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:24:57 INFO - Running setup.py install for mozrunner 14:24:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:24:57 INFO - Running setup.py install for mozscreenshot 14:24:57 INFO - Running setup.py install for moztest 14:24:57 INFO - Running setup.py install for mozversion 14:24:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:24:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:24:57 INFO - Cleaning up... 14:24:57 INFO - Return code: 0 14:24:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:24:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:57 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 0x7f12204a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17d55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1864410>, '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 0x1865310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18657a0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468010725.232673-603144298', '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 14:24:57 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 14:24:57 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 14:24:57 INFO - Using env: {'DISPLAY': ':0', 14:24:57 INFO - 'HOME': '/home/cltbld', 14:24:57 INFO - 'LANG': 'en_US.UTF-8', 14:24:57 INFO - 'LANGUAGE': 'en_US:en', 14:24:57 INFO - 'LOGNAME': 'cltbld', 14:24:57 INFO - 'MAIL': '/var/mail/cltbld', 14:24:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:57 INFO - 'MOZ_NO_REMOTE': '1', 14:24:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:57 INFO - 'NO_EM_RESTART': '1', 14:24:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:57 INFO - 'PWD': '/builds/slave/test', 14:24:57 INFO - 'SHELL': '/bin/bash', 14:24:57 INFO - 'SHLVL': '1', 14:24:57 INFO - 'TERM': 'linux', 14:24:57 INFO - 'TMOUT': '86400', 14:24:57 INFO - 'USER': 'cltbld', 14:24:57 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468010725.232673-603144298', 14:24:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:57 INFO - '_': '/tools/buildbot/bin/python'} 14:24:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:24:58 INFO - Running setup.py (path:/tmp/pip-pfI2Zr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:24:58 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)) 14:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:24:58 INFO - Running setup.py (path:/tmp/pip-fPH1Pz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:24:58 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)) 14:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:24:58 INFO - Running setup.py (path:/tmp/pip-7uy8Ak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:24:58 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)) 14:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:24:58 INFO - Running setup.py (path:/tmp/pip-LLbwAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:24:58 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)) 14:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:24:58 INFO - Running setup.py (path:/tmp/pip-FvDrdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:24:58 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)) 14:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:24:58 INFO - Running setup.py (path:/tmp/pip-enzfYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:24:58 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)) 14:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:24:58 INFO - Running setup.py (path:/tmp/pip-PfpsJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:24:58 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)) 14:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:24:58 INFO - Running setup.py (path:/tmp/pip-JajgGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:24:58 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)) 14:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:24:58 INFO - Running setup.py (path:/tmp/pip-b5ECZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:24:58 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)) 14:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:24:58 INFO - Running setup.py (path:/tmp/pip-LVkl1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:24:58 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)) 14:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:24:58 INFO - Running setup.py (path:/tmp/pip-cHtQGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:24:58 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)) 14:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:24:58 INFO - Running setup.py (path:/tmp/pip-s02sIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:24:59 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)) 14:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:24:59 INFO - Running setup.py (path:/tmp/pip-zDtFSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:24:59 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)) 14:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:24:59 INFO - Running setup.py (path:/tmp/pip-9ocjk5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:24:59 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)) 14:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:24:59 INFO - Running setup.py (path:/tmp/pip-YEbQri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:24:59 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)) 14:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:24:59 INFO - Running setup.py (path:/tmp/pip-LtJtlx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:24:59 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)) 14:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:24:59 INFO - Running setup.py (path:/tmp/pip-_Q9Osy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:24:59 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)) 14:24:59 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)) 14:24:59 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)) 14:24:59 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)) 14:24:59 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)) 14:24:59 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)) 14:24:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:25:01 INFO - Downloading blessings-1.6.tar.gz 14:25:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:25:01 INFO - Installing collected packages: blessings 14:25:01 INFO - Running setup.py install for blessings 14:25:01 INFO - Successfully installed blessings 14:25:01 INFO - Cleaning up... 14:25:01 INFO - Return code: 0 14:25:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:25:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:25:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:25:01 INFO - Reading from file tmpfile_stdout 14:25:01 INFO - Current package versions: 14:25:01 INFO - argparse == 1.2.1 14:25:01 INFO - blessings == 1.6 14:25:01 INFO - blobuploader == 1.2.4 14:25:01 INFO - docopt == 0.6.1 14:25:01 INFO - manifestparser == 1.1 14:25:01 INFO - mozInstall == 1.12 14:25:01 INFO - mozcrash == 0.17 14:25:01 INFO - mozdebug == 0.1 14:25:01 INFO - mozdevice == 0.48 14:25:01 INFO - mozfile == 1.2 14:25:01 INFO - mozhttpd == 0.7 14:25:01 INFO - mozinfo == 0.9 14:25:01 INFO - mozleak == 0.1 14:25:01 INFO - mozlog == 3.1 14:25:01 INFO - moznetwork == 0.27 14:25:01 INFO - mozprocess == 0.22 14:25:01 INFO - mozprofile == 0.28 14:25:01 INFO - mozrunner == 6.11 14:25:01 INFO - mozscreenshot == 0.1 14:25:01 INFO - mozsystemmonitor == 0.0 14:25:01 INFO - moztest == 0.7 14:25:01 INFO - mozversion == 1.4 14:25:01 INFO - psutil == 3.1.1 14:25:01 INFO - requests == 1.2.3 14:25:01 INFO - wsgiref == 0.1.2 14:25:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:25:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:25:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:25:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:25:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:01 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 0x7f12204a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17d55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1864410>, '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 0x1865310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18657a0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468010725.232673-603144298', '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 14:25:01 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 14:25:01 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 14:25:01 INFO - Using env: {'DISPLAY': ':0', 14:25:01 INFO - 'HOME': '/home/cltbld', 14:25:01 INFO - 'LANG': 'en_US.UTF-8', 14:25:01 INFO - 'LANGUAGE': 'en_US:en', 14:25:01 INFO - 'LOGNAME': 'cltbld', 14:25:01 INFO - 'MAIL': '/var/mail/cltbld', 14:25:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:25:01 INFO - 'MOZ_NO_REMOTE': '1', 14:25:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:25:01 INFO - 'NO_EM_RESTART': '1', 14:25:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:25:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:25:01 INFO - 'PWD': '/builds/slave/test', 14:25:01 INFO - 'SHELL': '/bin/bash', 14:25:01 INFO - 'SHLVL': '1', 14:25:01 INFO - 'TERM': 'linux', 14:25:01 INFO - 'TMOUT': '86400', 14:25:01 INFO - 'USER': 'cltbld', 14:25:01 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468010725.232673-603144298', 14:25:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:25:01 INFO - '_': '/tools/buildbot/bin/python'} 14:25:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:25:01 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)) 14:25:01 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)) 14:25:01 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)) 14:25:01 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)) 14:25:01 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)) 14:25:01 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)) 14:25:01 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)) 14:25:01 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)) 14:25:01 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)) 14:25:01 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)) 14:25:01 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)) 14:25:01 INFO - Cleaning up... 14:25:01 INFO - Return code: 0 14:25:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:25:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:25:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:25:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:25:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f12204a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17d55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1864410>, '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 0x1865310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18657a0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468010725.232673-603144298', '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 14:25:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:25:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:25:01 INFO - Using env: {'DISPLAY': ':0', 14:25:01 INFO - 'HOME': '/home/cltbld', 14:25:01 INFO - 'LANG': 'en_US.UTF-8', 14:25:01 INFO - 'LANGUAGE': 'en_US:en', 14:25:02 INFO - 'LOGNAME': 'cltbld', 14:25:02 INFO - 'MAIL': '/var/mail/cltbld', 14:25:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:25:02 INFO - 'MOZ_NO_REMOTE': '1', 14:25:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:25:02 INFO - 'NO_EM_RESTART': '1', 14:25:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:25:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:25:02 INFO - 'PWD': '/builds/slave/test', 14:25:02 INFO - 'SHELL': '/bin/bash', 14:25:02 INFO - 'SHLVL': '1', 14:25:02 INFO - 'TERM': 'linux', 14:25:02 INFO - 'TMOUT': '86400', 14:25:02 INFO - 'USER': 'cltbld', 14:25:02 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468010725.232673-603144298', 14:25:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:25:02 INFO - '_': '/tools/buildbot/bin/python'} 14:25:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:25:02 INFO - Downloading/unpacking jsonschema 14:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:25:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:25:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:25:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:25:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:25:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:25:04 INFO - Downloading/unpacking functools32 (from jsonschema) 14:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:25:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:25:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:25:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:25:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:25:04 INFO - Downloading functools32-3.2.3-2.tar.gz 14:25:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:25:04 INFO - warning: no files found matching '*.txt' 14:25:04 INFO - no previously-included directories found matching 'build' 14:25:04 INFO - no previously-included directories found matching 'dist' 14:25:04 INFO - no previously-included directories found matching '.git*' 14:25:04 INFO - Installing collected packages: jsonschema, functools32 14:25:04 INFO - Running setup.py install for functools32 14:25:04 INFO - warning: no files found matching '*.txt' 14:25:04 INFO - no previously-included directories found matching 'build' 14:25:04 INFO - no previously-included directories found matching 'dist' 14:25:04 INFO - no previously-included directories found matching '.git*' 14:25:04 INFO - Successfully installed jsonschema functools32 14:25:04 INFO - Cleaning up... 14:25:04 INFO - Return code: 0 14:25:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:25:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:25:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:25:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:25:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f12204a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17d55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1864410>, '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 0x1865310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18657a0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468010725.232673-603144298', '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 14:25:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:25:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:25:04 INFO - Using env: {'DISPLAY': ':0', 14:25:04 INFO - 'HOME': '/home/cltbld', 14:25:04 INFO - 'LANG': 'en_US.UTF-8', 14:25:04 INFO - 'LANGUAGE': 'en_US:en', 14:25:04 INFO - 'LOGNAME': 'cltbld', 14:25:04 INFO - 'MAIL': '/var/mail/cltbld', 14:25:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:25:04 INFO - 'MOZ_NO_REMOTE': '1', 14:25:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:25:04 INFO - 'NO_EM_RESTART': '1', 14:25:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:25:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:25:04 INFO - 'PWD': '/builds/slave/test', 14:25:04 INFO - 'SHELL': '/bin/bash', 14:25:04 INFO - 'SHLVL': '1', 14:25:04 INFO - 'TERM': 'linux', 14:25:04 INFO - 'TMOUT': '86400', 14:25:04 INFO - 'USER': 'cltbld', 14:25:04 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468010725.232673-603144298', 14:25:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:25:04 INFO - '_': '/tools/buildbot/bin/python'} 14:25:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:25:04 INFO - Downloading/unpacking flake8 14:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:25:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:25:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:25:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:25:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:25:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:25:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:25: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 14:25: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 14:25: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 14:25: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 14:25: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 14:25: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 14:25:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:25:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:25: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 14:25: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 14:25: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 14:25: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 14:25: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 14:25: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 14:25:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:25:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:25:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:25:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:25:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:25:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:25:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:25:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:25:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:25:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:25:07 INFO - no previously-included directories found matching 'docs/_build' 14:25:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:25:07 INFO - Running setup.py install for pep8 14:25:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:25:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:25:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:25:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:25:07 INFO - no previously-included directories found matching 'docs/_build' 14:25:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:25:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:25:07 INFO - Cleaning up... 14:25:07 INFO - Return code: 0 14:25:07 INFO - Running post-action listener: _resource_record_post_action 14:25:07 INFO - Running post-action listener: _start_resource_monitoring 14:25:07 INFO - Starting resource monitoring. 14:25:07 INFO - ##### 14:25:07 INFO - ##### Running install step. 14:25:07 INFO - ##### 14:25:07 INFO - Running pre-action listener: _resource_record_pre_action 14:25:07 INFO - Running main action method: install 14:25:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:25:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:25:07 INFO - Reading from file tmpfile_stdout 14:25:07 INFO - Detecting whether we're running mozinstall >=1.0... 14:25:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:25:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:25:07 INFO - Reading from file tmpfile_stdout 14:25:07 INFO - Output received: 14:25:07 INFO - Usage: mozinstall [options] installer 14:25:07 INFO - Options: 14:25:07 INFO - -h, --help show this help message and exit 14:25:07 INFO - -d DEST, --destination=DEST 14:25:07 INFO - Directory to install application into. [default: 14:25:07 INFO - "/builds/slave/test"] 14:25:07 INFO - --app=APP Application being installed. [default: firefox] 14:25:07 INFO - mkdir: /builds/slave/test/build/application 14:25:07 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'] 14:25:07 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 14:25:21 INFO - Reading from file tmpfile_stdout 14:25:21 INFO - Output received: 14:25:21 INFO - /builds/slave/test/build/application/firefox/firefox 14:25:21 INFO - Running post-action listener: _resource_record_post_action 14:25:21 INFO - ##### 14:25:21 INFO - ##### Running run-tests step. 14:25:21 INFO - ##### 14:25:21 INFO - Running pre-action listener: _resource_record_pre_action 14:25:21 INFO - Running main action method: run_tests 14:25:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:25:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:25:21 INFO - Python 2.7.3 14:25:21 INFO - Return code: 0 14:25:21 INFO - grabbing minidump binary from tooltool 14:25:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:25:21 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 0x1864410>, '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 0x1865310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18657a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:25:21 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 14:25:21 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 14:25:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:25:21 INFO - Return code: 0 14:25:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:25:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:25:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:25:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:25:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:25:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:25:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:25:22 INFO - Return code: 0 14:25:22 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/ZGcMFbUBSfmwYvtdIkYqkw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 14:25:22 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/ZGcMFbUBSfmwYvtdIkYqkw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --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 14:25:22 INFO - Using env: {'DISPLAY': ':0', 14:25:22 INFO - 'HOME': '/home/cltbld', 14:25:22 INFO - 'LANG': 'en_US.UTF-8', 14:25:22 INFO - 'LANGUAGE': 'en_US:en', 14:25:22 INFO - 'LOGNAME': 'cltbld', 14:25:22 INFO - 'MAIL': '/var/mail/cltbld', 14:25:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:25:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:25:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:25:22 INFO - 'MOZ_NO_REMOTE': '1', 14:25:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:25:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:25:22 INFO - 'NO_EM_RESTART': '1', 14:25:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:25:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:25:22 INFO - 'PWD': '/builds/slave/test', 14:25:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:25:22 INFO - 'SHELL': '/bin/bash', 14:25:22 INFO - 'SHLVL': '1', 14:25:22 INFO - 'TERM': 'linux', 14:25:22 INFO - 'TMOUT': '86400', 14:25:22 INFO - 'USER': 'cltbld', 14:25:22 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468010725.232673-603144298', 14:25:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:25:22 INFO - '_': '/tools/buildbot/bin/python'} 14:25:22 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/ZGcMFbUBSfmwYvtdIkYqkw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 14:25:22 INFO - mozversion application_buildid: 20160708113726 14:25:22 INFO - mozversion application_changeset: 23d50da987261085138dab3f05eae49806d9bf1b 14:25:22 INFO - mozversion application_display_name: Firefox 14:25:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:25:22 INFO - mozversion application_name: Firefox 14:25:22 INFO - mozversion application_remotingname: firefox 14:25:22 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:25:22 INFO - mozversion application_vendor: Mozilla 14:25:22 INFO - mozversion application_version: 48.0 14:25:22 INFO - mozversion platform_buildid: 20160708113726 14:25:22 INFO - mozversion platform_changeset: 23d50da987261085138dab3f05eae49806d9bf1b 14:25:22 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:25:22 INFO - mozversion platform_version: 48.0 14:25:22 INFO - using testdate: 1468013122 14:25:22 INFO - actual date: 1468013122 14:25:22 INFO - starting webserver on 'localhost:39511' 14:25:22 INFO - SUITE-START | Running 2 tests 14:25:22 INFO - TEST-START | dromaeo_css 14:25:22 INFO - operating with platform_type : linux_ 14:25:22 INFO - Initialising browser for dromaeo_css test... 14:25:22 INFO - TEST-INFO | started process 11291 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOrcwX4/profile http://localhost:39511/getInfo.html) 14:25:26 INFO - PROCESS | 11291 | __metrics Screen width/height:1600/1200 14:25:26 INFO - PROCESS | 11291 | colorDepth:24 14:25:26 INFO - PROCESS | 11291 | Browser inner width/height: 1024/697 14:25:26 INFO - PROCESS | 11291 | __metrics 14:25:27 ERROR - PROCESS | 11291 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:25:28 INFO - TEST-INFO | 11291: exit 0 14:25:28 INFO - Browser initialized. 14:25:28 INFO - Running cycle 1/1 for dromaeo_css test... 14:25:28 INFO - TEST-INFO | started process 11381 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOrcwX4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:25:39 INFO - PROCESS | 11381 | RSS: Main: 139722752 14:25:39 INFO - PROCESS | 11381 | 14:26:30 INFO - PROCESS | 11381 | 1468013190783 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] 14:28:38 INFO - PROCESS | 11381 | Cycle 1(1): loaded http://localhost:39511/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39511/tests/dromaeo/cssquery-ext.html) 14:28:39 INFO - PROCESS | 11381 | RSS: Main: 248926208 14:28:39 INFO - PROCESS | 11381 | 14:31:41 INFO - PROCESS | 11381 | Cycle 1(1): loaded http://localhost:39511/tests/dromaeo/cssquery-ext.html (next: http://localhost:39511/tests/dromaeo/cssquery-jquery.html) 14:31:41 INFO - PROCESS | 11381 | RSS: Main: 219373568 14:31:41 INFO - PROCESS | 11381 | 14:34:43 INFO - PROCESS | 11381 | Cycle 1(1): loaded http://localhost:39511/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39511/tests/dromaeo/cssquery-mootools.html) 14:34:44 INFO - PROCESS | 11381 | RSS: Main: 222044160 14:34:44 INFO - PROCESS | 11381 | 14:37:45 INFO - PROCESS | 11381 | Cycle 1(1): loaded http://localhost:39511/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39511/tests/dromaeo/cssquery-prototype.html) 14:37:46 INFO - PROCESS | 11381 | RSS: Main: 221941760 14:37:46 INFO - PROCESS | 11381 | 14:40:49 INFO - PROCESS | 11381 | Cycle 1(1): loaded http://localhost:39511/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39511/tests/dromaeo/cssquery-yui.html) 14:40:49 INFO - PROCESS | 11381 | RSS: Main: 180940800 14:40:49 INFO - PROCESS | 11381 | 14:43:52 INFO - PROCESS | 11381 | Cycle 1(1): loaded http://localhost:39511/tests/dromaeo/cssquery-yui.html (next: http://localhost:39511/tests/dromaeo/cssquery-dojo.html) 14:43:52 INFO - PROCESS | 11381 | RSS: Main: 241524736 14:43:52 INFO - PROCESS | 11381 | 14:43:52 INFO - PROCESS | 11381 | __start_tp_report 14:43:52 INFO - PROCESS | 11381 | _x_x_mozilla_page_load 14:43:52 INFO - PROCESS | 11381 | _x_x_mozilla_page_load_details 14:43:52 INFO - PROCESS | 11381 | |i|pagename|runs| 14:43:52 INFO - PROCESS | 11381 | |0;dojo.html;3298.8020718756875;3361.4621660534303;3371.4942758586208;3404.6254911959663;3407.948880766789;5462.972685136579;5469.288992430983;5479.150731636602;5502.9174562381495;5506.724663766806;5454.10007348787;5489.533389661873;5492.340919089705;5493.697846618445;5541.168824676301;4977.402711674595;4991.201407774757;5070.08738427083;5116.744162791864;5153.793848246066;4992.550670439659;5093.363329583802;5113.411957624883;5119.001794650045;5130.384353877521;5060.974695126519;5081.59347252219;5104.872378190538;5130.948690513103;5145.974270128644;5019.723915184663;5047.671901326439;5057.140286151363;5065.518775716301;5089.134847075988;4758.78585463655;4898.583620392271;4948.529889660476;4955.776990035457;4980.551750342486;5249.632525723201;5300.443453437372;5308.283381743492;5313.203019547061;5320.255164277004;5812.651240925516;5847.0352391855295;5854.151148083504;5858.76564937402;5859.121131830217;5900.262467191601;5906.320773111104;5968.850778730523;6038.33578306386;6041;5479.4520547945285;5489.039418101816;5508.394076651565;5520.972395137998;5531.1426728857095;5682.772689092472;5978.910316345258;5985.371535988658;5988.041913293852;5988.970055149784;5746.597738158289;5795.391483894215;5811.0992796115825;5818.185454036438;5823.737931793079;5888.764449421975;5894.440028197314;5896.262967129109;5900.439458251545;5907.113932910098;5710.971445142831;5844.561657875676;5864.384239654775;5882.676452795137;5886.264216972879;5769.567282453832;5792.594518383673;5803.158542011384;5809.419058094157;5837.620554663933;4444.044530425974;4444.599986001275;4450.132224216247;4451.799669014902;4472.888177795581;3972.920541589152;3977.6817854571564;4013.4983127109113;4053.047533829548;4053.756774593534;5479.53423958968;5496.203050557647;5496.725163741797;5505.587080968943;5544.944550554524;5785.4793068623185;5787.189793428924;5790.826275211751;5791.710414479259;5795.507381872504;5316.255724198615;5474.644148130359;5514.062609356419;5551.583631227674;5555.666660000413;4941.382327209099;4963.751812409365;4966.180580204298;4967.652264341461;4999.475055119233;6035.426634469718;6040.063790112539;6044.455998960027;6047.213862197974;6048.36492168316;5707.743151558273;5770.50950669181;5829.621074630136;5851.765929362778;5864.091065884794;5992.340842507408;5994.430529099728;5999.52003839683;6004.8799024020145;6037.09443583466;5632.7183640816975;5634.52106570946;5649.661020338793;5653.067243904874;5702.201691763239;5759.827205183851;5809.738561764646;5811.883762324815;5816.651000939957;5849.883002340014;5685.090385538294;5716.885662286814;5719.399463056319;5726.8568285791525;5731.369549349485;5573.526250268773;5586.273784408001;5728;5754.223179870663;5754.769809207585;5578.246936663499;5584.050711379156;5593.356763972195;5605.159226116115;5615.915761263503;5660;5676.4323567642905;5704.1443783432815;5708.257926469532;5712.714364281686;5548.722563871709;5614.270144881302;5629.437056294338;5719.942800572107;5771.163181338767 14:43:52 INFO - PROCESS | 11381 | |1;ext.html;656.0651072222086;672.7880717573961;681.4752640466841;724.9565026098435;743.8698227810136;33511.16222094449;34012.65987340126;34036.319273614514;34054.99999999997;34067.82966085166;42713.7864310678;43084.138317233635;43093.138137237234;43131.56868431315;43166;8858.911410885905;9031.864522032141;9035.051319611444;9035.95482022589;9038.909610903906;8832.735017949439;8910.287177025823;8937.776555586097;8945.46327220369;8951.776205594848;8949.776255593597;8990.370674052787;8993.64025438985;9002.144796244347;9009;9093.272538196961;9150.542472876396;9155.908440915606;9159.542022898862;9161.312901532412;8963.865542016874;9077.409968352036;9082.545872706338;9088.409253398508;9097.272218222592;45417;45778.77110614459;45888.3116753249;45901;45933.77033114813;3746.6440688134585;3799.3351163546545;3813.3326667833294;3894.844206231747;3930.6462418382484;34977.47533786995;35038.547301688894;35049.299014019576;35657.108572285644;36774.63225367739;4198.202341555095;4198.4961804583645;4202.201581699498;4203.684723645739;4362.280223763075;322692;322707;322768;322878;323909;41095.383569246485;41891.581084189376;41938.37092443616;66922.33077669259;68224.31775682278;39775;39804.402933956015;39883.202335953116;39911.80044099819;39926.401103983466;15896.205189740467;15918.124503152438;15964.680706385807;15994.040357578582;16009.439669611507;15034.774478382833;15243.466478673194;15262.23688815577;15268.923655381652;15271.083734975937;9737.707868763948;9747.658831940847;9756.707298781048;9776.120149186607;9852.359596626196;3606.9278614427562;3646.21606354635;3662.5421822272215;3702.851885924587;3762.3227818992295;1131.5813149134872;1142.2632402100598;1172.9003034742143;1188.3820413384992;1274.20362273579;34944.475832862525;35165.296694066485;35220.90541479426;35807.4628880567;36166.819165904526;1211.2792888231488;1275.9091226008345;1309.9803502947464;1327.9867201328057;1328.7408955253827;18531.166097525645;18553.25786968506;18556.628867422845;18636.16137273826;18710.71933920992;460892;463653;464403;465122;465494;64187;65974.34025659681;66015;66168.33831661718;66178.33821661818;1414.3281941077905;1428.9071210371292;1483.0879009409352;1496.8278647955406;1500.2348802110785;30299.788008480296;33535.32929341351;33751.49372759362;34111.14722131967;34332;53311;53602;53669.463305366444;53811.19283210677;53874.461255386945;249267;252892;252897;252988;254124;28053.298667533476;28432.431351372445;31221.219469513442;32158.19604509906;32552.18619534436;45505;46501.302480462145;46901.29648055213;47539.52460475351;53171;39193.80403097966;39494.21011579695;42464.575354247296;44151.33772993472;44377.33433998428;43341;43954.56045439505;43985.56014439814;44008.559914400445;45176.096478069594;43997;44555.10889782251;44796;45145.77427112844;45261.54738452574;37036.81481592575;38483.615163848;39054;39633.60366396299;39644.207115858095;29875.55186672158;30207.69792302137;30503.847480762455;31098.844505777328;31440.685593143775 14:43:52 INFO - PROCESS | 11381 | |2;jquery.html;404.4337926902337;409.59450144357083;430.93320535317037;435.39697518936265;440.66729619137544;13191;17966.191521381537;18678.90660546697;18694.439166825;19882.204711811548;16424.589385265375;18677.159527821248;19192.136353864076;19501;19501.317453889118;5562.610617256793;5749.683767392792;5767.250257466523;5780.682062486561;5788.797392091277;5602.943970560304;5684.459976302244;5684.602077854552;5687.6303040302455;5688.175214593882;5507.531859791922;5699;5702.629329093616;5707.71461426927;5816.040353341694;5716.485516303532;5726.026575482137;5752.050911599581;5768.798092066779;5768.884622307531;5195.220716892459;5202.869928251786;5231.843044708665;5235.110031294689;5265.921011184835;23206.3038108857;23395.064197432082;24112.276631701076;24145.637815432783;24154.879225603934;2540.745925407463;2566.1916496303606;2607.3351295419734;2951.4687356275863;3021.4410334088043;14340.211288379134;15149.621259468491;15459.149746763924;15464.304106315243;15474.690506189812;2035.1452389996236;2048.283100914668;2100.2964007057653;2124.8525796070103;2179.553191595719;72853;73432;73844.63077684578;74052.99999999946;74471.62764186144;11289;11310.264832785842;11328.490217940212;11330.943345283385;11551.480183391768;16203.756943645854;16236.269367878238;16408.507744767678;16423.260953257133;16481.25834337458;8256.793580160424;8400.243978041883;8405.663773448994;8426;8682.956585217033;8077.83844323122;8085.838283234302;8118.715844945516;8219.383546234056;8231.34149268057;4693.671442999025;4697.412823397075;4847.224444088929;5037.4458809530925;5135.6918584885025;1944.5527528668486;2038.1847261095681;2050.169681279084;2055.7738648748627;2104.063691657198;460.33711455503965;468.17133673398575;974.5711886769799;1053.1569752932369;1090.1987039525943;11614.361210133524;11656;11732.824007639892;11789.528418863149;12102.81845772314;497.34102314432795;498.67087722103236;506.683322923173;508.9770960306795;1025.1593693171528;10256.282060255711;10452.477376131163;10572.894271057345;10616.840747388795;10835.783284334428;535339;546226;546736;551215;560102;97253;98762.50618747003;98880;99358;99623;1155.393418455301;1166.8658104318113;1169.6958790714475;1205.584073494643;1229.7233122547534;16889.577760555592;16993.320267189174;17039;17119.14404279756;17303.134843257536;37393.439098413;39330.213395731356;39582;39715.40426893541;39825.20349592934;59533;59752;60167;60225.69887150536;60568.69715651393;8316.958415207886;8577.699780507652;8873.822523549621;8960.68637597681;9194.448333100036;12984.415701293276;14229.288535573387;14371.856281437053;14380.496682616476;14420.783688244475;12629.621111366674;12650.810237846625;12706.36468176606;12755.234685918875;12837.486500539873;12319.815202772144;12452.31512266834;12508.687282818002;12785.680357991125;12791.616251512469;12559.93720031394;12857.292848893401;12885.162464439782;12899;13021.739565208833;9074.818503630022;9106.317026223192;9185.402948808307;9619.422834629944;9670.56482458277;12351.135420520477;12373.195742277083;12577.622671319876;12581.433835477243;12664.620061398173 14:43:52 INFO - PROCESS | 11381 | |3;mootools.html;1414.3918115210456;1521.4218596933163;1559.9298031588578;1756.1833747307498;1902.4577995271343;7707.383409327254;8232.382571307153;8426.368022398314;8444.91555084449;8452.619632116553;7818.765437036884;7955.880661790078;7959.124496305401;7961.6019199039965;7967.561784101872;2377.3937645900314;2401.2076014915124;2405.8436201646923;2407.723111842143;2408.722996855358;2292.747797742247;2306.4925716342377;2330.557194133109;2336.2407217654245;2356.39911822485;2364.538914911593;2367.4318163640773;2368.83418160728;2437.390652336916;2446.8654224017673;2350.4123969007746;2371.5968285391523;2378.0725517048363;2383.5232953409386;2395.5568219879206;2251.0658076898067;2311.4683622766856;2322.7677232276806;2323.6630688550235;2324.5002324500147;7426.257374262531;7501.137369202557;8121.837563248702;8165.428420010601;8169.959150204211;5042.344495215599;5097.439281679012;5134.127198376285;5137.460566640486;5142.023015627019;3282.8522716477814;3292.4732042873025;3345.330933813247;3425.777324473926;3459.135216195951;1094.2887123369794;1141.657502749172;1151.0446329546455;1154.4977934598476;1154.5035634677085;12019.759604807943;12059.93970030153;12122.939385303105;12529.874701252962;12557.56048538306;4738.47876733559;4772.737499437564;4785.328954212466;4812.230043193073;4899.510048995143;10555.155587552978;10576.36541807494;10586.735331616617;10591.84112238317;10605.363678179334;5359.866003349947;5369.301990741257;5378.731063446812;5381.085215513293;5402.621816472888;4856.757162141878;4893.290472881412;4900.093482705711;4906.9263961040615;4914;3817.770933743984;3835.9232815343535;3862.304785138702;3911.2568611964207;3918.1575961167914;1234.1916044990546;1243.6704273367566;1248.219862585884;1253.7429826885466;1263.8925691316342;1001.2390583156853;1007.8034783217203;1013.8225810483136;1019.6940917724801;1020.132887046005;5734.053881109654;5747.712614369349;5844.736986835603;5906.616069955439;5910;997.1773287038222;1012.2205901455837;1019.607451131305;1035.3891204189565;1038.2991480750463;3874.903127421837;3954.9209015820097;3980.7213495055066;3991.3214753491975;3996.480457540501;10531.315464494937;10734.731631709114;10885.183611229031;10939.23425360233;10973.067289280341;10258.743531411625;10613.57545698179;10655.041046305869;10786.191035672198;10841.78316433667;8191.713290034821;8203.71287004964;8240.175982401712;8273.089960104384;8417.789555261168;5615;5682.403347648437;5719.771209151588;5751.1373294006235;5791.420857914175;9411.435313880915;9531.52342382892;9665.501847213693;9718.271129665161;9757.170640495353;9711.660091897033;9737.9775123611;9919.702408927744;9959.452230127412;10037.749056273651;7242.637868106679;7301.379382752525;7321.121465424183;7361.190269070291;7373.631318434164;8287.50274983503;8408.747737567883;8482.830343393221;8487.066422693375;8494.150584941457;7697.307242348215;7738.110117336579;7744.380449564134;7822.804429889071;7849.450538462253;7565.092188937363;7598.354139898171;7603.0876294844975;7623.847523049619;7764.961175194087;6705.832354191184;6767.661616919036;6774.762883299061;6784.2876497967;6788.4569234462115;4218.810153543037;4759.3574867393845;4977.178765503651;5048.671836330626;5061.16490779032;4897.608191344612;4989.201727723692;5011;5017.1721665924715;5098.107831129611 14:43:52 INFO - PROCESS | 11381 | |4;prototype.html;335.1086110944887;349.76216173002354;350.07230838278565;352.3323302342063;357.5048557747519;6072.69636518174;6118.663473508961;6157.784477543287;6176.876462470754;6185.969070154643;5801.680907550083;5884.911726324109;6010.759569617221;6072.089186622009;6115.510759139269;4731.172044892147;4763.642361926852;4766.61867050636;4767.094252092109;4768.141734487791;4748.738819364934;4754.072955773626;4773.140834649779;4773.546513081252;4785.90428191436;4545.909081818361;4629.513901040393;4691.9765401172945;4701.153792317382;4737.92893106602;4663.347131401607;4668.696534725232;4675.368825208588;4682.695624784378;4697.624190064804;4105.97947010266;4106.7946602670045;4117.485314335708;4118.052847844982;4124.91750164995;5813.128030795372;5821.417858214145;5824.767009319622;5832.737526811261;5838.620489668158;5395.163749618815;5405;5408.675479471205;5420.268263784378;5423.566114710814;6208.96895515524;6398.872022559569;6400.743970241185;6406.231252249713;6414.967925160391;4511.503734589192;4533.954660453386;4542.682012259143;4545.409096817426;4549.590536851666;6648.434883034948;6716.764913228062;6726.360995705449;6731.158605174353;6735.797926062226;4599.701019433726;4606.539346065367;4606.539346065434;4606.608438282717;4613.261878099488;4638.814447422065;4639.304104384302;4640.95359046412;4645.279981602789;4651.511591282934;5336.893262134736;5362.1420572708175;5366.087765079946;5375.489328513785;5385.569154467712;6295.338989406138;6458.838529036718;6502.967485162544;6504.479641628658;6506.674666266667;1561.7188905996802;1587.8809089318115;1628.6416988262563;1629.7473891546829;1630.6901688679113;1009.7172791618359;1085.159001773616;1094.7208461842179;1102.8676558812833;1102.9062529685066;6153.661548614779;6247.375262473807;6261.123442718023;6291;6294.402031806971;6584.374484423972;6617.272100068989;6625.635590042594;6632.602043877383;6635.469162466991;6256.124142620037;6256.937430625636;6270.184875966186;6272.153259310026;6275.843103922439;3537.327907697529;3576.2668652926086;3579.552555930509;3580.5166302548823;3587.8744243951337;6895.069165662571;6950.860982780316;6961.338672826073;7023.92976070243;7141.678624461912;6869.828254293682;6892.414144797648;6916.23921368649;6916.308369163144;6917.342852429011;7081.929180708127;7083.929160708327;7094.893576596355;7100.112485939258;7102.4318054555515;6701.128853249046;6740.494462915399;6741.426978706865;6768.627725475146;6771.221309549268;6488.513361498001;6650.168728908887;6669.533132680665;6711.362420570038;6741.696623652046;7018.754343598154;7058.61177635235;7082.645867706491;7091.184513780981;7099.467539934422;4643.071385722801;4683.1804434223195;4685.695429797052;4687.273472611751;4688.413948256468;6707.731690732316;6724.29394913527;6731.124953755981;6735.0570920072205;6735.966320168368;6244;6323.557350985387;6436.195475565554;6491.935080649322;6502.6748662567625;6466.32103629131;6484;6498.837529061622;6506.089147519446;6511.055896895018;6391.424771770563;6398.456131228898;6409.2949775525585;6411.5832470889245;6413.422791948747;6422.775202867877;6549.115869357575;6552.477296241077;6556.868862622626;6560.671966401756;6392.360763923571;6403.487720982217;6404.103425520524;6405.071264666691;6408.519361047846 14:43:52 INFO - PROCESS | 11381 | |5;yui.html;822.3791037766485;828.8259465512242;855.6235256487145;901.5402144906096;916.4409710076852;14774.187419691925;15052.623684407881;15763;15930.283137258823;15995.120268385233;14027.08823926444;14151.221682807442;14198.78701819471;14216.715665686706;14221.146731196135;756.9886451703229;888.3248730964449;905.7373361725092;910.3218102513604;910.4810258152822;878.0473186592554;879.5074758135464;880.3793325705394;882.4528792148876;883.4964070479829;771.5756334016269;945.8250223708601;949.5442187749884;950.1401231885155;950.2445555783169;923.5890028937125;936;937.4609599480258;938.2212763406391;938.7183844846553;694.7672529702555;695.1901035293877;695.2526034512869;695.2664938489891;695.5756988237172;14562.854371456362;14685.971981961267;14711.485098021518;14766.114033158045;14786;15127;15467.535973920687;15473.5357939262;15497.535073947687;15540.378384864593;12241.143119981605;12343.19769214998;12343.753124937452;12481.375931203494;12546.74906501874;4069.7558146511305;4070.959290407088;4072.9796351018053;4074.1647962167685;4109.404136400205;52802.47197528014;53591.99999999961;53779;53926.46073539254;53957.460425395635;11049.558017679363;11845.644630661094;11919.702007449883;12055.698607534707;12058.819117713241;20165.49586260326;20368.898155509127;20394.082266298054;20438.28466003683;21025.894870525855;8918.375713700108;9016.323775716848;9050.502222377701;9197.448153110834;9299.67451139207;5034.295198672189;5073.746312684351;5122.897542049138;5195.19474481456;5329.067413202674;3703.092742278159;3744.307303148926;3746.6066063062985;3761.717871159674;3764.322421964073;652.1815122021832;662.0830150241853;697.4281089506555;705.5660768627257;746.7050515046635;780.7345502529167;783.9625926478681;797.5426526009812;815.1237419773767;819.3158712475031;9852.566345144714;9857;9945.20438364929;9996.650117245861;10166.604407919313;716.1012928774355;787.8345547434989;807.5921659561884;810.4003037752021;828.9792755181169;4531.977340113278;4670.159371313128;4729.148753224453;4823.204171311764;4962.305277261186;62771;65912;66213;66288.6685566569;66334.33665663282;56842;57211;57343;57390.7130464345;57727.711361442925;49833.75083124561;50002.499975000515;50468.74765626148;52085.7395713019;52524.212136817216;10144.594216231268;10209.74475638115;10238.283320167815;10259.692209233735;10357.689269321932;39340.409893852186;39398;39494.21011579695;40916.181676366905;40982.180356392106;46443.30335045045;49222.75388623034;50178.247326289405;50218.49781502138;51016;12464.688382790502;12627.305498197687;12647.936760316139;12651.304178270284;12979.870201297867;13590;14363.497277595652;14409.639759006108;14449.277536123362;14450;13358.398872050975;13494.73010539764;13498.865011350154;13814.585562433143;14421.63945901319;13482.056256061982;13490.392932317873;13725.107867988949;13926.791098133333;14090.788638170641;13033.15284506504;13644.65888352799;13980.231087290296;14189.787153192505;14234.71530569362;10386.636467723594;11037.889621103686;11169.441527923735;11261.099112071179;11349.319040857576;10405.47972601382;10997.61508347204;11362.204645674723;11462.656120316404;11690.67956162437 14:43:52 INFO - PROCESS | 11381 | __end_tp_report 14:43:52 INFO - PROCESS | 11381 | __start_cc_report 14:43:52 INFO - PROCESS | 11381 | _x_x_mozilla_cycle_collect,850 14:43:52 INFO - PROCESS | 11381 | __end_cc_report 14:43:52 INFO - PROCESS | 11381 | __startTimestamp1468014232498__endTimestamp 14:43:52 INFO - PROCESS | 11381 | 14:43:52 INFO - PROCESS | 11381 | ------- Summary: start ------- 14:43:52 INFO - PROCESS | 11381 | Number of tests: 6 14:43:52 INFO - PROCESS | 11381 | 14:43:52 INFO - PROCESS | 11381 | [#0] dojo.html Cycles:165 Average:5433.93 Median:5614.27 stddev:582.63 (10.4%) stddev-sans-first:559.82 14:43:52 INFO - PROCESS | 11381 | Values: 3298.8 3361.5 3371.5 3404.6 3407.9 5463.0 5469.3 5479.2 5502.9 5506.7 5454.1 5489.5 5492.3 5493.7 5541.2 4977.4 4991.2 5070.1 5116.7 5153.8 4992.6 5093.4 5113.4 5119.0 5130.4 5061.0 5081.6 5104.9 5130.9 5146.0 5019.7 5047.7 5057.1 5065.5 5089.1 4758.8 4898.6 4948.5 4955.8 4980.6 5249.6 5300.4 5308.3 5313.2 5320.3 5812.7 5847.0 5854.2 5858.8 5859.1 5900.3 5906.3 5968.9 6038.3 6041.0 5479.5 5489.0 5508.4 5521.0 5531.1 5682.8 5978.9 5985.4 5988.0 5989.0 5746.6 5795.4 5811.1 5818.2 5823.7 5888.8 5894.4 5896.3 5900.4 5907.1 5711.0 5844.6 5864.4 5882.7 5886.3 5769.6 5792.6 5803.2 5809.4 5837.6 4444.0 4444.6 4450.1 4451.8 4472.9 3972.9 3977.7 4013.5 4053.0 4053.8 5479.5 5496.2 5496.7 5505.6 5544.9 5785.5 5787.2 5790.8 5791.7 5795.5 5316.3 5474.6 5514.1 5551.6 5555.7 4941.4 4963.8 4966.2 4967.7 4999.5 6035.4 6040.1 6044.5 6047.2 6048.4 5707.7 5770.5 5829.6 5851.8 5864.1 5992.3 5994.4 5999.5 6004.9 6037.1 5632.7 5634.5 5649.7 5653.1 5702.2 5759.8 5809.7 5811.9 5816.7 5849.9 5685.1 5716.9 5719.4 5726.9 5731.4 5573.5 5586.3 5728.0 5754.2 5754.8 5578.2 5584.1 5593.4 5605.2 5615.9 5660.0 5676.4 5704.1 5708.3 5712.7 5548.7 5614.3 5629.4 5719.9 5771.2 14:43:52 INFO - PROCESS | 11381 | 14:43:52 INFO - PROCESS | 11381 | [#1] ext.html Cycles:180 Average:52142.00 Median:39919.10 stddev:94328.33 (236.3%) stddev-sans-first:94513.74 14:43:52 INFO - PROCESS | 11381 | Values: 656.1 672.8 681.5 725.0 743.9 33511.2 34012.7 34036.3 34055.0 34067.8 42713.8 43084.1 43093.1 43131.6 43166.0 8858.9 9031.9 9035.1 9036.0 9038.9 8832.7 8910.3 8937.8 8945.5 8951.8 8949.8 8990.4 8993.6 9002.1 9009.0 9093.3 9150.5 9155.9 9159.5 9161.3 8963.9 9077.4 9082.5 9088.4 9097.3 45417.0 45778.8 45888.3 45901.0 45933.8 3746.6 3799.3 3813.3 3894.8 3930.6 34977.5 35038.5 35049.3 35657.1 36774.6 4198.2 4198.5 4202.2 4203.7 4362.3 322692.0 322707.0 322768.0 322878.0 323909.0 41095.4 41891.6 41938.4 66922.3 68224.3 39775.0 39804.4 39883.2 39911.8 39926.4 15896.2 15918.1 15964.7 15994.0 16009.4 15034.8 15243.5 15262.2 15268.9 15271.1 9737.7 9747.7 9756.7 9776.1 9852.4 3606.9 3646.2 3662.5 3702.9 3762.3 1131.6 1142.3 1172.9 1188.4 1274.2 34944.5 35165.3 35220.9 35807.5 36166.8 1211.3 1275.9 1310.0 1328.0 1328.7 18531.2 18553.3 18556.6 18636.2 18710.7 460892.0 463653.0 464403.0 465122.0 465494.0 64187.0 65974.3 66015.0 66168.3 66178.3 1414.3 1428.9 1483.1 1496.8 1500.2 30299.8 33535.3 33751.5 34111.1 34332.0 53311.0 53602.0 53669.5 53811.2 53874.5 249267.0 252892.0 252897.0 252988.0 254124.0 28053.3 28432.4 31221.2 32158.2 32552.2 45505.0 46501.3 46901.3 47539.5 53171.0 39193.8 39494.2 42464.6 44151.3 44377.3 43341.0 43954.6 43985.6 44008.6 45176.1 43997.0 44555.1 44796.0 45145.8 45261.5 37036.8 38483.6 39054.0 39633.6 39644.2 29875.6 30207.7 30503.8 31098.8 31440.7 14:43:52 INFO - PROCESS | 11381 | 14:43:52 INFO - PROCESS | 11381 | [#2] jquery.html Cycles:180 Average:30675.97 Median:2779.40 stddev:90078.77 (3240.9%) stddev-sans-first:90302.79 14:43:52 INFO - PROCESS | 11381 | Values: 404.4 409.6 430.9 435.4 440.7 13191.0 17966.2 18678.9 18694.4 19882.2 16424.6 18677.2 19192.1 19501.0 19501.3 5562.6 5749.7 5767.3 5780.7 5788.8 5602.9 5684.5 5684.6 5687.6 5688.2 5507.5 5699.0 5702.6 5707.7 5816.0 5716.5 5726.0 5752.1 5768.8 5768.9 5195.2 5202.9 5231.8 5235.1 5265.9 23206.3 23395.1 24112.3 24145.6 24154.9 2540.7 2566.2 2607.3 2951.5 3021.4 14340.2 15149.6 15459.1 15464.3 15474.7 2035.1 2048.3 2100.3 2124.9 2179.6 72853.0 73432.0 73844.6 74053.0 74471.6 11289.0 11310.3 11328.5 11330.9 11551.5 16203.8 16236.3 16408.5 16423.3 16481.3 8256.8 8400.2 8405.7 8426.0 8683.0 8077.8 8085.8 8118.7 8219.4 8231.3 4693.7 4697.4 4847.2 5037.4 5135.7 1944.6 2038.2 2050.2 2055.8 2104.1 460.3 468.2 974.6 1053.2 1090.2 11614.4 11656.0 11732.8 11789.5 12102.8 497.3 498.7 506.7 509.0 1025.2 10256.3 10452.5 10572.9 10616.8 10835.8 535339.0 546226.0 546736.0 551215.0 560102.0 97253.0 98762.5 98880.0 99358.0 99623.0 1155.4 1166.9 1169.7 1205.6 1229.7 16889.6 16993.3 17039.0 17119.1 17303.1 37393.4 39330.2 39582.0 39715.4 39825.2 59533.0 59752.0 60167.0 60225.7 60568.7 8317.0 8577.7 8873.8 8960.7 9194.4 12984.4 14229.3 14371.9 14380.5 14420.8 12629.6 12650.8 12706.4 12755.2 12837.5 12319.8 12452.3 12508.7 12785.7 12791.6 12559.9 12857.3 12885.2 12899.0 13021.7 9074.8 9106.3 9185.4 9619.4 9670.6 12351.1 12373.2 12577.6 12581.4 12664.6 14:43:52 INFO - PROCESS | 11381 | 14:43:52 INFO - PROCESS | 11381 | [#3] mootools.html Cycles:180 Average:5683.54 Median:4834.49 stddev:3190.86 (66.0%) stddev-sans-first:3183.68 14:43:52 INFO - PROCESS | 11381 | Values: 1414.4 1521.4 1559.9 1756.2 1902.5 7707.4 8232.4 8426.4 8444.9 8452.6 7818.8 7955.9 7959.1 7961.6 7967.6 2377.4 2401.2 2405.8 2407.7 2408.7 2292.7 2306.5 2330.6 2336.2 2356.4 2364.5 2367.4 2368.8 2437.4 2446.9 2350.4 2371.6 2378.1 2383.5 2395.6 2251.1 2311.5 2322.8 2323.7 2324.5 7426.3 7501.1 8121.8 8165.4 8170.0 5042.3 5097.4 5134.1 5137.5 5142.0 3282.9 3292.5 3345.3 3425.8 3459.1 1094.3 1141.7 1151.0 1154.5 1154.5 12019.8 12059.9 12122.9 12529.9 12557.6 4738.5 4772.7 4785.3 4812.2 4899.5 10555.2 10576.4 10586.7 10591.8 10605.4 5359.9 5369.3 5378.7 5381.1 5402.6 4856.8 4893.3 4900.1 4906.9 4914.0 3817.8 3835.9 3862.3 3911.3 3918.2 1234.2 1243.7 1248.2 1253.7 1263.9 1001.2 1007.8 1013.8 1019.7 1020.1 5734.1 5747.7 5844.7 5906.6 5910.0 997.2 1012.2 1019.6 1035.4 1038.3 3874.9 3954.9 3980.7 3991.3 3996.5 10531.3 10734.7 10885.2 10939.2 10973.1 10258.7 10613.6 10655.0 10786.2 10841.8 8191.7 8203.7 8240.2 8273.1 8417.8 5615.0 5682.4 5719.8 5751.1 5791.4 9411.4 9531.5 9665.5 9718.3 9757.2 9711.7 9738.0 9919.7 9959.5 10037.7 7242.6 7301.4 7321.1 7361.2 7373.6 8287.5 8408.7 8482.8 8487.1 8494.2 7697.3 7738.1 7744.4 7822.8 7849.5 7565.1 7598.4 7603.1 7623.8 7765.0 6705.8 6767.7 6774.8 6784.3 6788.5 4218.8 4759.4 4977.2 5048.7 5061.2 4897.6 4989.2 5011.0 5017.2 5098.1 14:43:52 INFO - PROCESS | 11381 | 14:43:52 INFO - PROCESS | 11381 | [#4] prototype.html Cycles:180 Average:5440.32 Median:6197.47 stddev:1644.20 (26.5%) stddev-sans-first:1603.54 14:43:52 INFO - PROCESS | 11381 | Values: 335.1 349.8 350.1 352.3 357.5 6072.7 6118.7 6157.8 6176.9 6186.0 5801.7 5884.9 6010.8 6072.1 6115.5 4731.2 4763.6 4766.6 4767.1 4768.1 4748.7 4754.1 4773.1 4773.5 4785.9 4545.9 4629.5 4692.0 4701.2 4737.9 4663.3 4668.7 4675.4 4682.7 4697.6 4106.0 4106.8 4117.5 4118.1 4124.9 5813.1 5821.4 5824.8 5832.7 5838.6 5395.2 5405.0 5408.7 5420.3 5423.6 6209.0 6398.9 6400.7 6406.2 6415.0 4511.5 4534.0 4542.7 4545.4 4549.6 6648.4 6716.8 6726.4 6731.2 6735.8 4599.7 4606.5 4606.5 4606.6 4613.3 4638.8 4639.3 4641.0 4645.3 4651.5 5336.9 5362.1 5366.1 5375.5 5385.6 6295.3 6458.8 6503.0 6504.5 6506.7 1561.7 1587.9 1628.6 1629.7 1630.7 1009.7 1085.2 1094.7 1102.9 1102.9 6153.7 6247.4 6261.1 6291.0 6294.4 6584.4 6617.3 6625.6 6632.6 6635.5 6256.1 6256.9 6270.2 6272.2 6275.8 3537.3 3576.3 3579.6 3580.5 3587.9 6895.1 6950.9 6961.3 7023.9 7141.7 6869.8 6892.4 6916.2 6916.3 6917.3 7081.9 7083.9 7094.9 7100.1 7102.4 6701.1 6740.5 6741.4 6768.6 6771.2 6488.5 6650.2 6669.5 6711.4 6741.7 7018.8 7058.6 7082.6 7091.2 7099.5 4643.1 4683.2 4685.7 4687.3 4688.4 6707.7 6724.3 6731.1 6735.1 6736.0 6244.0 6323.6 6436.2 6491.9 6502.7 6466.3 6484.0 6498.8 6506.1 6511.1 6391.4 6398.5 6409.3 6411.6 6413.4 6422.8 6549.1 6552.5 6556.9 6560.7 6392.4 6403.5 6404.1 6405.1 6408.5 14:43:52 INFO - PROCESS | 11381 | 14:43:52 INFO - PROCESS | 11381 | [#5] yui.html Cycles:180 Average:15727.30 Median:4320.69 stddev:17808.34 (412.2%) stddev-sans-first:17823.12 14:43:52 INFO - PROCESS | 11381 | Values: 822.4 828.8 855.6 901.5 916.4 14774.2 15052.6 15763.0 15930.3 15995.1 14027.1 14151.2 14198.8 14216.7 14221.1 757.0 888.3 905.7 910.3 910.5 878.0 879.5 880.4 882.5 883.5 771.6 945.8 949.5 950.1 950.2 923.6 936.0 937.5 938.2 938.7 694.8 695.2 695.3 695.3 695.6 14562.9 14686.0 14711.5 14766.1 14786.0 15127.0 15467.5 15473.5 15497.5 15540.4 12241.1 12343.2 12343.8 12481.4 12546.7 4069.8 4071.0 4073.0 4074.2 4109.4 52802.5 53592.0 53779.0 53926.5 53957.5 11049.6 11845.6 11919.7 12055.7 12058.8 20165.5 20368.9 20394.1 20438.3 21025.9 8918.4 9016.3 9050.5 9197.4 9299.7 5034.3 5073.7 5122.9 5195.2 5329.1 3703.1 3744.3 3746.6 3761.7 3764.3 652.2 662.1 697.4 705.6 746.7 780.7 784.0 797.5 815.1 819.3 9852.6 9857.0 9945.2 9996.7 10166.6 716.1 787.8 807.6 810.4 829.0 4532.0 4670.2 4729.1 4823.2 4962.3 62771.0 65912.0 66213.0 66288.7 66334.3 56842.0 57211.0 57343.0 57390.7 57727.7 49833.8 50002.5 50468.7 52085.7 52524.2 10144.6 10209.7 10238.3 10259.7 10357.7 39340.4 39398.0 39494.2 40916.2 40982.2 46443.3 49222.8 50178.2 50218.5 51016.0 12464.7 12627.3 12647.9 12651.3 12979.9 13590.0 14363.5 14409.6 14449.3 14450.0 13358.4 13494.7 13498.9 13814.6 14421.6 13482.1 13490.4 13725.1 13926.8 14090.8 13033.2 13644.7 13980.2 14189.8 14234.7 10386.6 11037.9 11169.4 11261.1 11349.3 10405.5 10997.6 11362.2 11462.7 11690.7 14:43:52 INFO - PROCESS | 11381 | -------- Summary: end -------- 14:43:52 INFO - PROCESS | 11381 | 14:43:53 INFO - TEST-INFO | 11381: exit 0 14:43:53 INFO - TEST-OK | dromaeo_css | took 1110732ms 14:43:53 INFO - TEST-START | kraken 14:43:53 INFO - operating with platform_type : linux_ 14:43:53 INFO - Initialising browser for kraken test... 14:43:53 INFO - TEST-INFO | started process 11574 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyFkukh/profile http://localhost:39511/getInfo.html) 14:43:56 INFO - PROCESS | 11574 | __metrics Screen width/height:1600/1200 14:43:56 INFO - PROCESS | 11574 | colorDepth:24 14:43:56 INFO - PROCESS | 11574 | Browser inner width/height: 1024/697 14:43:56 INFO - PROCESS | 11574 | __metrics 14:43:58 ERROR - PROCESS | 11574 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:43:58 INFO - TEST-INFO | 11574: exit 0 14:43:58 INFO - Browser initialized. 14:43:58 INFO - Running cycle 1/1 for kraken test... 14:43:58 INFO - TEST-INFO | started process 11665 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyFkukh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:44:10 INFO - PROCESS | 11665 | RSS: Main: 139468800 14:44:10 INFO - PROCESS | 11665 | 14:44:13 INFO - PROCESS | 11665 | Cycle 1(1): loaded http://localhost:39511/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39511/tests/kraken/driver.html?testName=audio-beat-detection) 14:44:13 INFO - PROCESS | 11665 | RSS: Main: 197619712 14:44:13 INFO - PROCESS | 11665 | 14:44:16 INFO - PROCESS | 11665 | Cycle 1(1): loaded http://localhost:39511/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39511/tests/kraken/driver.html?testName=audio-dft) 14:44:17 INFO - PROCESS | 11665 | RSS: Main: 183951360 14:44:17 INFO - PROCESS | 11665 | 14:44:19 INFO - PROCESS | 11665 | Cycle 1(1): loaded http://localhost:39511/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39511/tests/kraken/driver.html?testName=audio-fft) 14:44:20 INFO - PROCESS | 11665 | RSS: Main: 273625088 14:44:20 INFO - PROCESS | 11665 | 14:44:22 INFO - PROCESS | 11665 | Cycle 1(1): loaded http://localhost:39511/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39511/tests/kraken/driver.html?testName=audio-oscillator) 14:44:23 INFO - PROCESS | 11665 | RSS: Main: 179953664 14:44:23 INFO - PROCESS | 11665 | 14:44:25 INFO - PROCESS | 11665 | Cycle 1(1): loaded http://localhost:39511/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39511/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:44:25 INFO - PROCESS | 11665 | RSS: Main: 177381376 14:44:25 INFO - PROCESS | 11665 | 14:44:28 INFO - PROCESS | 11665 | Cycle 1(1): loaded http://localhost:39511/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39511/tests/kraken/driver.html?testName=imaging-darkroom) 14:44:29 INFO - PROCESS | 11665 | RSS: Main: 212217856 14:44:29 INFO - PROCESS | 11665 | 14:44:32 INFO - PROCESS | 11665 | Cycle 1(1): loaded http://localhost:39511/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39511/tests/kraken/driver.html?testName=imaging-desaturate) 14:44:33 INFO - PROCESS | 11665 | RSS: Main: 212537344 14:44:33 INFO - PROCESS | 11665 | 14:44:36 INFO - PROCESS | 11665 | Cycle 1(1): loaded http://localhost:39511/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39511/tests/kraken/driver.html?testName=json-parse-financial) 14:44:36 INFO - PROCESS | 11665 | RSS: Main: 212271104 14:44:36 INFO - PROCESS | 11665 | 14:44:38 INFO - PROCESS | 11665 | Cycle 1(1): loaded http://localhost:39511/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39511/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:44:38 INFO - PROCESS | 11665 | RSS: Main: 195264512 14:44:38 INFO - PROCESS | 11665 | 14:44:40 INFO - PROCESS | 11665 | Cycle 1(1): loaded http://localhost:39511/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39511/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:44:41 INFO - PROCESS | 11665 | RSS: Main: 197185536 14:44:41 INFO - PROCESS | 11665 | 14:44:42 INFO - PROCESS | 11665 | Cycle 1(1): loaded http://localhost:39511/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39511/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:44:43 INFO - PROCESS | 11665 | RSS: Main: 208879616 14:44:43 INFO - PROCESS | 11665 | 14:44:46 INFO - PROCESS | 11665 | Cycle 1(1): loaded http://localhost:39511/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39511/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:44:46 INFO - PROCESS | 11665 | RSS: Main: 217026560 14:44:46 INFO - PROCESS | 11665 | 14:44:49 INFO - PROCESS | 11665 | Cycle 1(1): loaded http://localhost:39511/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39511/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:44:49 INFO - PROCESS | 11665 | RSS: Main: 211501056 14:44:49 INFO - PROCESS | 11665 | 14:44:51 INFO - PROCESS | 11665 | Cycle 1(1): loaded http://localhost:39511/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39511/tests/kraken/driver.html?testName=ai-astar) 14:44:51 INFO - PROCESS | 11665 | RSS: Main: 273362944 14:44:51 INFO - PROCESS | 11665 | 14:44:51 INFO - PROCESS | 11665 | __start_tp_report 14:44:51 INFO - PROCESS | 11665 | _x_x_mozilla_page_load 14:44:51 INFO - PROCESS | 11665 | _x_x_mozilla_page_load_details 14:44:51 INFO - PROCESS | 11665 | |i|pagename|runs| 14:44:51 INFO - PROCESS | 11665 | |0;ai-astar;110;110;111;110;109;110;104;110;108;108 14:44:51 INFO - PROCESS | 11665 | |1;audio-beat-detection;156;126;160;179;125;156;156;133;188;125 14:44:51 INFO - PROCESS | 11665 | |2;audio-dft;160;160;160;160;160;162;159;162;160;159 14:44:51 INFO - PROCESS | 11665 | |3;audio-fft;74;76;76;179;76;76;77;74;161;75 14:44:51 INFO - PROCESS | 11665 | |4;audio-oscillator;92;93;155;93;93;93;144;92;92;153 14:44:51 INFO - PROCESS | 11665 | |5;imaging-gaussian-blur;116;117;117;116;117;116;116;116;117;117 14:44:51 INFO - PROCESS | 11665 | |6;imaging-darkroom;145;146;146;146;145;146;145;146;146;145 14:44:51 INFO - PROCESS | 11665 | |7;imaging-desaturate;95;95;95;94;95;95;94;94;94;94 14:44:51 INFO - PROCESS | 11665 | |8;json-parse-financial;53;52;53;53;53;55;54;67;51;55 14:44:51 INFO - PROCESS | 11665 | |9;json-stringify-tinderbox;58;58;57;58;57;57;57;58;58;58 14:44:51 INFO - PROCESS | 11665 | |10;stanford-crypto-aes;72;71;72;72;74;74;83;73;74;74 14:44:51 INFO - PROCESS | 11665 | |11;stanford-crypto-ccm;113;112;115;111;116;111;110;110;135;124 14:44:51 INFO - PROCESS | 11665 | |12;stanford-crypto-pbkdf2;161;155;161;156;158;164;153;154;161;157 14:44:51 INFO - PROCESS | 11665 | |13;stanford-crypto-sha256-iterative;68;66;65;65;65;65;65;65;64;65 14:44:51 INFO - PROCESS | 11665 | __end_tp_report 14:44:51 INFO - PROCESS | 11665 | __start_cc_report 14:44:51 INFO - PROCESS | 11665 | _x_x_mozilla_cycle_collect,1596 14:44:51 INFO - PROCESS | 11665 | __end_cc_report 14:44:51 INFO - PROCESS | 11665 | __startTimestamp1468014291833__endTimestamp 14:44:51 INFO - PROCESS | 11665 | 14:44:51 INFO - PROCESS | 11665 | ------- Summary: start ------- 14:44:51 INFO - PROCESS | 11665 | Number of tests: 14 14:44:51 INFO - PROCESS | 11665 | 14:44:51 INFO - PROCESS | 11665 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.00 stddev:2.00 (1.8%) stddev-sans-first:2.09 14:44:51 INFO - PROCESS | 11665 | Values: 110.0 110.0 111.0 110.0 109.0 110.0 104.0 110.0 108.0 108.0 14:44:51 INFO - PROCESS | 11665 | 14:44:51 INFO - PROCESS | 11665 | [#1] audio-beat-detection Cycles:10 Average:150.40 Median:156.00 stddev:22.62 (14.5%) stddev-sans-first:23.90 14:44:51 INFO - PROCESS | 11665 | Values: 156.0 126.0 160.0 179.0 125.0 156.0 156.0 133.0 188.0 125.0 14:44:51 INFO - PROCESS | 11665 | 14:44:51 INFO - PROCESS | 11665 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.00 stddev:1.03 (0.6%) stddev-sans-first:1.09 14:44:51 INFO - PROCESS | 11665 | Values: 160.0 160.0 160.0 160.0 160.0 162.0 159.0 162.0 160.0 159.0 14:44:51 INFO - PROCESS | 11665 | 14:44:51 INFO - PROCESS | 11665 | [#3] audio-fft Cycles:10 Average:94.40 Median:76.00 stddev:40.08 (52.7%) stddev-sans-first:41.83 14:44:51 INFO - PROCESS | 11665 | Values: 74.0 76.0 76.0 179.0 76.0 76.0 77.0 74.0 161.0 75.0 14:44:51 INFO - PROCESS | 11665 | 14:44:51 INFO - PROCESS | 11665 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:92.50 stddev:28.20 (30.5%) stddev-sans-first:29.15 14:44:51 INFO - PROCESS | 11665 | Values: 92.0 93.0 155.0 93.0 93.0 93.0 144.0 92.0 92.0 153.0 14:44:51 INFO - PROCESS | 11665 | 14:44:51 INFO - PROCESS | 11665 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 14:44:51 INFO - PROCESS | 11665 | Values: 116.0 117.0 117.0 116.0 117.0 116.0 116.0 116.0 117.0 117.0 14:44:51 INFO - PROCESS | 11665 | 14:44:51 INFO - PROCESS | 11665 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 14:44:51 INFO - PROCESS | 11665 | Values: 145.0 146.0 146.0 146.0 145.0 146.0 145.0 146.0 146.0 145.0 14:44:51 INFO - PROCESS | 11665 | 14:44:51 INFO - PROCESS | 11665 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 14:44:51 INFO - PROCESS | 11665 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 94.0 94.0 94.0 94.0 14:44:51 INFO - PROCESS | 11665 | 14:44:51 INFO - PROCESS | 11665 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:53.50 stddev:4.53 (8.5%) stddev-sans-first:4.76 14:44:51 INFO - PROCESS | 11665 | Values: 53.0 52.0 53.0 53.0 53.0 55.0 54.0 67.0 51.0 55.0 14:44:51 INFO - PROCESS | 11665 | 14:44:51 INFO - PROCESS | 11665 | [#9] json-stringify-tinderbox Cycles:10 Average:57.60 Median:58.00 stddev:0.52 (0.9%) stddev-sans-first:0.53 14:44:51 INFO - PROCESS | 11665 | Values: 58.0 58.0 57.0 58.0 57.0 57.0 57.0 58.0 58.0 58.0 14:44:51 INFO - PROCESS | 11665 | 14:44:51 INFO - PROCESS | 11665 | [#10] stanford-crypto-aes Cycles:10 Average:73.90 Median:74.00 stddev:3.38 (4.6%) stddev-sans-first:3.52 14:44:51 INFO - PROCESS | 11665 | Values: 72.0 71.0 72.0 72.0 74.0 74.0 83.0 73.0 74.0 74.0 14:44:51 INFO - PROCESS | 11665 | 14:44:51 INFO - PROCESS | 11665 | [#11] stanford-crypto-ccm Cycles:10 Average:115.70 Median:114.00 stddev:7.97 (7.0%) stddev-sans-first:8.40 14:44:51 INFO - PROCESS | 11665 | Values: 113.0 112.0 115.0 111.0 116.0 111.0 110.0 110.0 135.0 124.0 14:44:51 INFO - PROCESS | 11665 | 14:44:51 INFO - PROCESS | 11665 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.00 Median:159.50 stddev:3.62 (2.3%) stddev-sans-first:3.67 14:44:51 INFO - PROCESS | 11665 | Values: 161.0 155.0 161.0 156.0 158.0 164.0 153.0 154.0 161.0 157.0 14:44:51 INFO - PROCESS | 11665 | 14:44:51 INFO - PROCESS | 11665 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.00 stddev:1.06 (1.6%) stddev-sans-first:0.50 14:44:51 INFO - PROCESS | 11665 | Values: 68.0 66.0 65.0 65.0 65.0 65.0 65.0 65.0 64.0 65.0 14:44:51 INFO - PROCESS | 11665 | -------- Summary: end -------- 14:44:51 INFO - PROCESS | 11665 | 14:44:52 INFO - TEST-INFO | 11665: exit 0 14:44:52 INFO - TEST-OK | kraken | took 59590ms 14:44:52 INFO - SUITE-END | took 1170s 14:44:52 INFO - Completed test suite (00:19:30) 14:44:52 INFO - javascript benchmark 14:44:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3298.8020718756875, 3361.4621660534303, 3371.4942758586208, 3404.6254911959663, 3407.948880766789, 5462.972685136579, 5469.288992430983, 5479.150731636602, 5502.9174562381495, 5506.724663766806, 5454.10007348787, 5489.533389661873, 5492.340919089705, 5493.697846618445, 5541.168824676301, 4977.402711674595, 4991.201407774757, 5070.08738427083, 5116.744162791864, 5153.793848246066, 4992.550670439659, 5093.363329583802, 5113.411957624883, 5119.001794650045, 5130.384353877521, 5060.974695126519, 5081.59347252219, 5104.872378190538, 5130.948690513103, 5145.974270128644, 5019.723915184663, 5047.671901326439, 5057.140286151363, 5065.518775716301, 5089.134847075988, 4758.78585463655, 4898.583620392271, 4948.529889660476, 4955.776990035457, 4980.551750342486, 5249.632525723201, 5300.443453437372, 5308.283381743492, 5313.203019547061, 5320.255164277004, 5812.651240925516, 5847.0352391855295, 5854.151148083504, 5858.76564937402, 5859.121131830217, 5900.262467191601, 5906.320773111104, 5968.850778730523, 6038.33578306386, 6041.0, 5479.4520547945285, 5489.039418101816, 5508.394076651565, 5520.972395137998, 5531.1426728857095, 5682.772689092472, 5978.910316345258, 5985.371535988658, 5988.041913293852, 5988.970055149784, 5746.597738158289, 5795.391483894215, 5811.0992796115825, 5818.185454036438, 5823.737931793079, 5888.764449421975, 5894.440028197314, 5896.262967129109, 5900.439458251545, 5907.113932910098, 5710.971445142831, 5844.561657875676, 5864.384239654775, 5882.676452795137, 5886.264216972879, 5769.567282453832, 5792.594518383673, 5803.158542011384, 5809.419058094157, 5837.620554663933, 4444.044530425974, 4444.599986001275, 4450.132224216247, 4451.799669014902, 4472.888177795581, 3972.920541589152, 3977.6817854571564, 4013.4983127109113, 4053.047533829548, 4053.756774593534, 5479.53423958968, 5496.203050557647, 5496.725163741797, 5505.587080968943, 5544.944550554524, 5785.4793068623185, 5787.189793428924, 5790.826275211751, 5791.710414479259, 5795.507381872504, 5316.255724198615, 5474.644148130359, 5514.062609356419, 5551.583631227674, 5555.666660000413, 4941.382327209099, 4963.751812409365, 4966.180580204298, 4967.652264341461, 4999.475055119233, 6035.426634469718, 6040.063790112539, 6044.455998960027, 6047.213862197974, 6048.36492168316, 5707.743151558273, 5770.50950669181, 5829.621074630136, 5851.765929362778, 5864.091065884794, 5992.340842507408, 5994.430529099728, 5999.52003839683, 6004.8799024020145, 6037.09443583466, 5632.7183640816975, 5634.52106570946, 5649.661020338793, 5653.067243904874, 5702.201691763239, 5759.827205183851, 5809.738561764646, 5811.883762324815, 5816.651000939957, 5849.883002340014, 5685.090385538294, 5716.885662286814, 5719.399463056319, 5726.8568285791525, 5731.369549349485, 5573.526250268773, 5586.273784408001, 5728.0, 5754.223179870663, 5754.769809207585, 5578.246936663499, 5584.050711379156, 5593.356763972195, 5605.159226116115, 5615.915761263503, 5660.0, 5676.4323567642905, 5704.1443783432815, 5708.257926469532, 5712.714364281686, 5548.722563871709, 5614.270144881302, 5629.437056294338, 5719.942800572107, 5771.163181338767], "value": 5397.611628280652, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [656.0651072222086, 672.7880717573961, 681.4752640466841, 724.9565026098435, 743.8698227810136, 33511.16222094449, 34012.65987340126, 34036.319273614514, 34054.99999999997, 34067.82966085166, 42713.7864310678, 43084.138317233635, 43093.138137237234, 43131.56868431315, 43166.0, 8858.911410885905, 9031.864522032141, 9035.051319611444, 9035.95482022589, 9038.909610903906, 8832.735017949439, 8910.287177025823, 8937.776555586097, 8945.46327220369, 8951.776205594848, 8949.776255593597, 8990.370674052787, 8993.64025438985, 9002.144796244347, 9009.0, 9093.272538196961, 9150.542472876396, 9155.908440915606, 9159.542022898862, 9161.312901532412, 8963.865542016874, 9077.409968352036, 9082.545872706338, 9088.409253398508, 9097.272218222592, 45417.0, 45778.77110614459, 45888.3116753249, 45901.0, 45933.77033114813, 3746.6440688134585, 3799.3351163546545, 3813.3326667833294, 3894.844206231747, 3930.6462418382484, 34977.47533786995, 35038.547301688894, 35049.299014019576, 35657.108572285644, 36774.63225367739, 4198.202341555095, 4198.4961804583645, 4202.201581699498, 4203.684723645739, 4362.280223763075, 322692.0, 322707.0, 322768.0, 322878.0, 323909.0, 41095.383569246485, 41891.581084189376, 41938.37092443616, 66922.33077669259, 68224.31775682278, 39775.0, 39804.402933956015, 39883.202335953116, 39911.80044099819, 39926.401103983466, 15896.205189740467, 15918.124503152438, 15964.680706385807, 15994.040357578582, 16009.439669611507, 15034.774478382833, 15243.466478673194, 15262.23688815577, 15268.923655381652, 15271.083734975937, 9737.707868763948, 9747.658831940847, 9756.707298781048, 9776.120149186607, 9852.359596626196, 3606.9278614427562, 3646.21606354635, 3662.5421822272215, 3702.851885924587, 3762.3227818992295, 1131.5813149134872, 1142.2632402100598, 1172.9003034742143, 1188.3820413384992, 1274.20362273579, 34944.475832862525, 35165.296694066485, 35220.90541479426, 35807.4628880567, 36166.819165904526, 1211.2792888231488, 1275.9091226008345, 1309.9803502947464, 1327.9867201328057, 1328.7408955253827, 18531.166097525645, 18553.25786968506, 18556.628867422845, 18636.16137273826, 18710.71933920992, 460892.0, 463653.0, 464403.0, 465122.0, 465494.0, 64187.0, 65974.34025659681, 66015.0, 66168.33831661718, 66178.33821661818, 1414.3281941077905, 1428.9071210371292, 1483.0879009409352, 1496.8278647955406, 1500.2348802110785, 30299.788008480296, 33535.32929341351, 33751.49372759362, 34111.14722131967, 34332.0, 53311.0, 53602.0, 53669.463305366444, 53811.19283210677, 53874.461255386945, 249267.0, 252892.0, 252897.0, 252988.0, 254124.0, 28053.298667533476, 28432.431351372445, 31221.219469513442, 32158.19604509906, 32552.18619534436, 45505.0, 46501.302480462145, 46901.29648055213, 47539.52460475351, 53171.0, 39193.80403097966, 39494.21011579695, 42464.575354247296, 44151.33772993472, 44377.33433998428, 43341.0, 43954.56045439505, 43985.56014439814, 44008.559914400445, 45176.096478069594, 43997.0, 44555.10889782251, 44796.0, 45145.77427112844, 45261.54738452574, 37036.81481592575, 38483.615163848, 39054.0, 39633.60366396299, 39644.207115858095, 29875.55186672158, 30207.69792302137, 30503.847480762455, 31098.844505777328, 31440.685593143775], "value": 19493.02871234949, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.4337926902337, 409.59450144357083, 430.93320535317037, 435.39697518936265, 440.66729619137544, 13191.0, 17966.191521381537, 18678.90660546697, 18694.439166825, 19882.204711811548, 16424.589385265375, 18677.159527821248, 19192.136353864076, 19501.0, 19501.317453889118, 5562.610617256793, 5749.683767392792, 5767.250257466523, 5780.682062486561, 5788.797392091277, 5602.943970560304, 5684.459976302244, 5684.602077854552, 5687.6303040302455, 5688.175214593882, 5507.531859791922, 5699.0, 5702.629329093616, 5707.71461426927, 5816.040353341694, 5716.485516303532, 5726.026575482137, 5752.050911599581, 5768.798092066779, 5768.884622307531, 5195.220716892459, 5202.869928251786, 5231.843044708665, 5235.110031294689, 5265.921011184835, 23206.3038108857, 23395.064197432082, 24112.276631701076, 24145.637815432783, 24154.879225603934, 2540.745925407463, 2566.1916496303606, 2607.3351295419734, 2951.4687356275863, 3021.4410334088043, 14340.211288379134, 15149.621259468491, 15459.149746763924, 15464.304106315243, 15474.690506189812, 2035.1452389996236, 2048.283100914668, 2100.2964007057653, 2124.8525796070103, 2179.553191595719, 72853.0, 73432.0, 73844.63077684578, 74052.99999999946, 74471.62764186144, 11289.0, 11310.264832785842, 11328.490217940212, 11330.943345283385, 11551.480183391768, 16203.756943645854, 16236.269367878238, 16408.507744767678, 16423.260953257133, 16481.25834337458, 8256.793580160424, 8400.243978041883, 8405.663773448994, 8426.0, 8682.956585217033, 8077.83844323122, 8085.838283234302, 8118.715844945516, 8219.383546234056, 8231.34149268057, 4693.671442999025, 4697.412823397075, 4847.224444088929, 5037.4458809530925, 5135.6918584885025, 1944.5527528668486, 2038.1847261095681, 2050.169681279084, 2055.7738648748627, 2104.063691657198, 460.33711455503965, 468.17133673398575, 974.5711886769799, 1053.1569752932369, 1090.1987039525943, 11614.361210133524, 11656.0, 11732.824007639892, 11789.528418863149, 12102.81845772314, 497.34102314432795, 498.67087722103236, 506.683322923173, 508.9770960306795, 1025.1593693171528, 10256.282060255711, 10452.477376131163, 10572.894271057345, 10616.840747388795, 10835.783284334428, 535339.0, 546226.0, 546736.0, 551215.0, 560102.0, 97253.0, 98762.50618747003, 98880.0, 99358.0, 99623.0, 1155.393418455301, 1166.8658104318113, 1169.6958790714475, 1205.584073494643, 1229.7233122547534, 16889.577760555592, 16993.320267189174, 17039.0, 17119.14404279756, 17303.134843257536, 37393.439098413, 39330.213395731356, 39582.0, 39715.40426893541, 39825.20349592934, 59533.0, 59752.0, 60167.0, 60225.69887150536, 60568.69715651393, 8316.958415207886, 8577.699780507652, 8873.822523549621, 8960.68637597681, 9194.448333100036, 12984.415701293276, 14229.288535573387, 14371.856281437053, 14380.496682616476, 14420.783688244475, 12629.621111366674, 12650.810237846625, 12706.36468176606, 12755.234685918875, 12837.486500539873, 12319.815202772144, 12452.31512266834, 12508.687282818002, 12785.680357991125, 12791.616251512469, 12559.93720031394, 12857.292848893401, 12885.162464439782, 12899.0, 13021.739565208833, 9074.818503630022, 9106.317026223192, 9185.402948808307, 9619.422834629944, 9670.56482458277, 12351.135420520477, 12373.195742277083, 12577.622671319876, 12581.433835477243, 12664.620061398173], "value": 9290.806660953223, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1414.3918115210456, 1521.4218596933163, 1559.9298031588578, 1756.1833747307498, 1902.4577995271343, 7707.383409327254, 8232.382571307153, 8426.368022398314, 8444.91555084449, 8452.619632116553, 7818.765437036884, 7955.880661790078, 7959.124496305401, 7961.6019199039965, 7967.561784101872, 2377.3937645900314, 2401.2076014915124, 2405.8436201646923, 2407.723111842143, 2408.722996855358, 2292.747797742247, 2306.4925716342377, 2330.557194133109, 2336.2407217654245, 2356.39911822485, 2364.538914911593, 2367.4318163640773, 2368.83418160728, 2437.390652336916, 2446.8654224017673, 2350.4123969007746, 2371.5968285391523, 2378.0725517048363, 2383.5232953409386, 2395.5568219879206, 2251.0658076898067, 2311.4683622766856, 2322.7677232276806, 2323.6630688550235, 2324.5002324500147, 7426.257374262531, 7501.137369202557, 8121.837563248702, 8165.428420010601, 8169.959150204211, 5042.344495215599, 5097.439281679012, 5134.127198376285, 5137.460566640486, 5142.023015627019, 3282.8522716477814, 3292.4732042873025, 3345.330933813247, 3425.777324473926, 3459.135216195951, 1094.2887123369794, 1141.657502749172, 1151.0446329546455, 1154.4977934598476, 1154.5035634677085, 12019.759604807943, 12059.93970030153, 12122.939385303105, 12529.874701252962, 12557.56048538306, 4738.47876733559, 4772.737499437564, 4785.328954212466, 4812.230043193073, 4899.510048995143, 10555.155587552978, 10576.36541807494, 10586.735331616617, 10591.84112238317, 10605.363678179334, 5359.866003349947, 5369.301990741257, 5378.731063446812, 5381.085215513293, 5402.621816472888, 4856.757162141878, 4893.290472881412, 4900.093482705711, 4906.9263961040615, 4914.0, 3817.770933743984, 3835.9232815343535, 3862.304785138702, 3911.2568611964207, 3918.1575961167914, 1234.1916044990546, 1243.6704273367566, 1248.219862585884, 1253.7429826885466, 1263.8925691316342, 1001.2390583156853, 1007.8034783217203, 1013.8225810483136, 1019.6940917724801, 1020.132887046005, 5734.053881109654, 5747.712614369349, 5844.736986835603, 5906.616069955439, 5910.0, 997.1773287038222, 1012.2205901455837, 1019.607451131305, 1035.3891204189565, 1038.2991480750463, 3874.903127421837, 3954.9209015820097, 3980.7213495055066, 3991.3214753491975, 3996.480457540501, 10531.315464494937, 10734.731631709114, 10885.183611229031, 10939.23425360233, 10973.067289280341, 10258.743531411625, 10613.57545698179, 10655.041046305869, 10786.191035672198, 10841.78316433667, 8191.713290034821, 8203.71287004964, 8240.175982401712, 8273.089960104384, 8417.789555261168, 5615.0, 5682.403347648437, 5719.771209151588, 5751.1373294006235, 5791.420857914175, 9411.435313880915, 9531.52342382892, 9665.501847213693, 9718.271129665161, 9757.170640495353, 9711.660091897033, 9737.9775123611, 9919.702408927744, 9959.452230127412, 10037.749056273651, 7242.637868106679, 7301.379382752525, 7321.121465424183, 7361.190269070291, 7373.631318434164, 8287.50274983503, 8408.747737567883, 8482.830343393221, 8487.066422693375, 8494.150584941457, 7697.307242348215, 7738.110117336579, 7744.380449564134, 7822.804429889071, 7849.450538462253, 7565.092188937363, 7598.354139898171, 7603.0876294844975, 7623.847523049619, 7764.961175194087, 6705.832354191184, 6767.661616919036, 6774.762883299061, 6784.2876497967, 6788.4569234462115, 4218.810153543037, 4759.3574867393845, 4977.178765503651, 5048.671836330626, 5061.16490779032, 4897.608191344612, 4989.201727723692, 5011.0, 5017.1721665924715, 5098.107831129611], "value": 4596.150381733809, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.1086110944887, 349.76216173002354, 350.07230838278565, 352.3323302342063, 357.5048557747519, 6072.69636518174, 6118.663473508961, 6157.784477543287, 6176.876462470754, 6185.969070154643, 5801.680907550083, 5884.911726324109, 6010.759569617221, 6072.089186622009, 6115.510759139269, 4731.172044892147, 4763.642361926852, 4766.61867050636, 4767.094252092109, 4768.141734487791, 4748.738819364934, 4754.072955773626, 4773.140834649779, 4773.546513081252, 4785.90428191436, 4545.909081818361, 4629.513901040393, 4691.9765401172945, 4701.153792317382, 4737.92893106602, 4663.347131401607, 4668.696534725232, 4675.368825208588, 4682.695624784378, 4697.624190064804, 4105.97947010266, 4106.7946602670045, 4117.485314335708, 4118.052847844982, 4124.91750164995, 5813.128030795372, 5821.417858214145, 5824.767009319622, 5832.737526811261, 5838.620489668158, 5395.163749618815, 5405.0, 5408.675479471205, 5420.268263784378, 5423.566114710814, 6208.96895515524, 6398.872022559569, 6400.743970241185, 6406.231252249713, 6414.967925160391, 4511.503734589192, 4533.954660453386, 4542.682012259143, 4545.409096817426, 4549.590536851666, 6648.434883034948, 6716.764913228062, 6726.360995705449, 6731.158605174353, 6735.797926062226, 4599.701019433726, 4606.539346065367, 4606.539346065434, 4606.608438282717, 4613.261878099488, 4638.814447422065, 4639.304104384302, 4640.95359046412, 4645.279981602789, 4651.511591282934, 5336.893262134736, 5362.1420572708175, 5366.087765079946, 5375.489328513785, 5385.569154467712, 6295.338989406138, 6458.838529036718, 6502.967485162544, 6504.479641628658, 6506.674666266667, 1561.7188905996802, 1587.8809089318115, 1628.6416988262563, 1629.7473891546829, 1630.6901688679113, 1009.7172791618359, 1085.159001773616, 1094.7208461842179, 1102.8676558812833, 1102.9062529685066, 6153.661548614779, 6247.375262473807, 6261.123442718023, 6291.0, 6294.402031806971, 6584.374484423972, 6617.272100068989, 6625.635590042594, 6632.602043877383, 6635.469162466991, 6256.124142620037, 6256.937430625636, 6270.184875966186, 6272.153259310026, 6275.843103922439, 3537.327907697529, 3576.2668652926086, 3579.552555930509, 3580.5166302548823, 3587.8744243951337, 6895.069165662571, 6950.860982780316, 6961.338672826073, 7023.92976070243, 7141.678624461912, 6869.828254293682, 6892.414144797648, 6916.23921368649, 6916.308369163144, 6917.342852429011, 7081.929180708127, 7083.929160708327, 7094.893576596355, 7100.112485939258, 7102.4318054555515, 6701.128853249046, 6740.494462915399, 6741.426978706865, 6768.627725475146, 6771.221309549268, 6488.513361498001, 6650.168728908887, 6669.533132680665, 6711.362420570038, 6741.696623652046, 7018.754343598154, 7058.61177635235, 7082.645867706491, 7091.184513780981, 7099.467539934422, 4643.071385722801, 4683.1804434223195, 4685.695429797052, 4687.273472611751, 4688.413948256468, 6707.731690732316, 6724.29394913527, 6731.124953755981, 6735.0570920072205, 6735.966320168368, 6244.0, 6323.557350985387, 6436.195475565554, 6491.935080649322, 6502.6748662567625, 6466.32103629131, 6484.0, 6498.837529061622, 6506.089147519446, 6511.055896895018, 6391.424771770563, 6398.456131228898, 6409.2949775525585, 6411.5832470889245, 6413.422791948747, 6422.775202867877, 6549.115869357575, 6552.477296241077, 6556.868862622626, 6560.671966401756, 6392.360763923571, 6403.487720982217, 6404.103425520524, 6405.071264666691, 6408.519361047846], "value": 4903.761663436637, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [822.3791037766485, 828.8259465512242, 855.6235256487145, 901.5402144906096, 916.4409710076852, 14774.187419691925, 15052.623684407881, 15763.0, 15930.283137258823, 15995.120268385233, 14027.08823926444, 14151.221682807442, 14198.78701819471, 14216.715665686706, 14221.146731196135, 756.9886451703229, 888.3248730964449, 905.7373361725092, 910.3218102513604, 910.4810258152822, 878.0473186592554, 879.5074758135464, 880.3793325705394, 882.4528792148876, 883.4964070479829, 771.5756334016269, 945.8250223708601, 949.5442187749884, 950.1401231885155, 950.2445555783169, 923.5890028937125, 936.0, 937.4609599480258, 938.2212763406391, 938.7183844846553, 694.7672529702555, 695.1901035293877, 695.2526034512869, 695.2664938489891, 695.5756988237172, 14562.854371456362, 14685.971981961267, 14711.485098021518, 14766.114033158045, 14786.0, 15127.0, 15467.535973920687, 15473.5357939262, 15497.535073947687, 15540.378384864593, 12241.143119981605, 12343.19769214998, 12343.753124937452, 12481.375931203494, 12546.74906501874, 4069.7558146511305, 4070.959290407088, 4072.9796351018053, 4074.1647962167685, 4109.404136400205, 52802.47197528014, 53591.99999999961, 53779.0, 53926.46073539254, 53957.460425395635, 11049.558017679363, 11845.644630661094, 11919.702007449883, 12055.698607534707, 12058.819117713241, 20165.49586260326, 20368.898155509127, 20394.082266298054, 20438.28466003683, 21025.894870525855, 8918.375713700108, 9016.323775716848, 9050.502222377701, 9197.448153110834, 9299.67451139207, 5034.295198672189, 5073.746312684351, 5122.897542049138, 5195.19474481456, 5329.067413202674, 3703.092742278159, 3744.307303148926, 3746.6066063062985, 3761.717871159674, 3764.322421964073, 652.1815122021832, 662.0830150241853, 697.4281089506555, 705.5660768627257, 746.7050515046635, 780.7345502529167, 783.9625926478681, 797.5426526009812, 815.1237419773767, 819.3158712475031, 9852.566345144714, 9857.0, 9945.20438364929, 9996.650117245861, 10166.604407919313, 716.1012928774355, 787.8345547434989, 807.5921659561884, 810.4003037752021, 828.9792755181169, 4531.977340113278, 4670.159371313128, 4729.148753224453, 4823.204171311764, 4962.305277261186, 62771.0, 65912.0, 66213.0, 66288.6685566569, 66334.33665663282, 56842.0, 57211.0, 57343.0, 57390.7130464345, 57727.711361442925, 49833.75083124561, 50002.499975000515, 50468.74765626148, 52085.7395713019, 52524.212136817216, 10144.594216231268, 10209.74475638115, 10238.283320167815, 10259.692209233735, 10357.689269321932, 39340.409893852186, 39398.0, 39494.21011579695, 40916.181676366905, 40982.180356392106, 46443.30335045045, 49222.75388623034, 50178.247326289405, 50218.49781502138, 51016.0, 12464.688382790502, 12627.305498197687, 12647.936760316139, 12651.304178270284, 12979.870201297867, 13590.0, 14363.497277595652, 14409.639759006108, 14449.277536123362, 14450.0, 13358.398872050975, 13494.73010539764, 13498.865011350154, 13814.585562433143, 14421.63945901319, 13482.056256061982, 13490.392932317873, 13725.107867988949, 13926.791098133333, 14090.788638170641, 13033.15284506504, 13644.65888352799, 13980.231087290296, 14189.787153192505, 14234.71530569362, 10386.636467723594, 11037.889621103686, 11169.441527923735, 11261.099112071179, 11349.319040857576, 10405.47972601382, 10997.61508347204, 11362.204645674723, 11462.656120316404, 11690.67956162437], "value": 7274.887806338769, "unit": "score"}], "name": "dromaeo_css", "value": 7370.3337901425275, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 111.0, 110.0, 109.0, 110.0, 104.0, 110.0, 108.0, 108.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 126.0, 160.0, 179.0, 125.0, 156.0, 156.0, 133.0, 188.0, 125.0], "value": 150.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 160.0, 160.0, 162.0, 159.0, 162.0, 160.0, 159.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 179.0, 76.0, 76.0, 77.0, 74.0, 161.0, 75.0], "value": 94.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 155.0, 93.0, 93.0, 93.0, 144.0, 92.0, 92.0, 153.0], "value": 110.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 53.0, 53.0, 53.0, 55.0, 54.0, 67.0, 51.0, 55.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 57.0, 58.0, 57.0, 57.0, 57.0, 58.0, 58.0, 58.0], "value": 57.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 72.0, 72.0, 74.0, 74.0, 83.0, 73.0, 74.0, 74.0], "value": 73.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 115.0, 111.0, 116.0, 111.0, 110.0, 110.0, 135.0, 124.0], "value": 115.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 155.0, 161.0, 156.0, 158.0, 164.0, 153.0, 154.0, 161.0, 157.0], "value": 158.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 64.0, 65.0], "value": 65.3, "unit": "score"}], "name": "kraken", "value": 1505.7, "alertThreshold": 2.0}]} 14:44:53 INFO - Return code: 0 14:44:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:44:53 ERROR - # TBPL SUCCESS # 14:44:53 INFO - Running post-action listener: _resource_record_post_action 14:44:53 INFO - Running post-run listener: _resource_record_post_run 14:44:54 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 167936; Write bytes: 464150528; Read time: 40; Write time: 660668 14:44:54 INFO - install - Wall time: 14s; CPU: 15.0%; Read bytes: 0; Write bytes: 242171904; Read time: 0; Write time: 447068 14:44:54 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 143360; Write bytes: 221978624; Read time: 24; Write time: 213600 14:44:54 INFO - Running post-run listener: _upload_blobber_files 14:44:54 INFO - Blob upload gear active. 14:44:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:44:54 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 14:44:54 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'] 14:44:54 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 14:44:54 INFO - (blobuploader) - INFO - Open directory for files ... 14:44:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:44:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:44:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:44:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:44:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:44:55 INFO - (blobuploader) - INFO - Done attempting. 14:44:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:44:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:44:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:44:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:44:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:44:56 INFO - (blobuploader) - INFO - Done attempting. 14:44:56 INFO - (blobuploader) - INFO - Iteration through files over. 14:44:56 INFO - Return code: 0 14:44:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:44:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:44:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b37bbc94be42f6b77ce4b9c35c1b53690c817d6b70e3ec0cca8f69f74991634495635d8bf446c8efd6a82783fb9701ff031df25f8c1d2e4f23776ea09932e31d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9308afe286b0f31d53e2d38e85e14d81efdf9abb4dffdae4954226a806a48c8cbb526c524b6732feb3acab37d2aed0e10f0f44b9c96dff78f20eee60f78080d0"} 14:44:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:44:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:44:56 INFO - Contents: 14:44:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b37bbc94be42f6b77ce4b9c35c1b53690c817d6b70e3ec0cca8f69f74991634495635d8bf446c8efd6a82783fb9701ff031df25f8c1d2e4f23776ea09932e31d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9308afe286b0f31d53e2d38e85e14d81efdf9abb4dffdae4954226a806a48c8cbb526c524b6732feb3acab37d2aed0e10f0f44b9c96dff78f20eee60f78080d0"} 14:44:56 INFO - Running post-run listener: copy_logs_to_upload_dir 14:44:56 INFO - Copying logs to upload dir... 14:44:56 INFO - mkdir: /builds/slave/test/build/upload/logs 14:44:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.152510 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-07-08 14:44:55.869160) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 14:44:55.875026) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1468010725.232673-603144298 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/b37bbc94be42f6b77ce4b9c35c1b53690c817d6b70e3ec0cca8f69f74991634495635d8bf446c8efd6a82783fb9701ff031df25f8c1d2e4f23776ea09932e31d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9308afe286b0f31d53e2d38e85e14d81efdf9abb4dffdae4954226a806a48c8cbb526c524b6732feb3acab37d2aed0e10f0f44b9c96dff78f20eee60f78080d0"} build_url:https://queue.taskcluster.net/v1/task/ZGcMFbUBSfmwYvtdIkYqkw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011448 build_url: 'https://queue.taskcluster.net/v1/task/ZGcMFbUBSfmwYvtdIkYqkw/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/b37bbc94be42f6b77ce4b9c35c1b53690c817d6b70e3ec0cca8f69f74991634495635d8bf446c8efd6a82783fb9701ff031df25f8c1d2e4f23776ea09932e31d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9308afe286b0f31d53e2d38e85e14d81efdf9abb4dffdae4954226a806a48c8cbb526c524b6732feb3acab37d2aed0e10f0f44b9c96dff78f20eee60f78080d0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 14:44:55.901701) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 14:44:55.902119) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1468010725.232673-603144298 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004504 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 14:44:55.985363) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 14:44:55.985701) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 14:44:55.986026) ========= ========= Total master_lag: 0.15 =========