builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-020 starttime: 1461744521.51 results: success (0) buildid: 20160426223217 builduid: 81eae3bfbe2e49159d1da282ef8fa3a9 revision: 048c047097a97068fa5e4f2592c53e59449ab8fd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 01:08:41.505683) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 01:08:41.506152) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 01:08:41.506511) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 01:08:41.564892) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 01:08:41.565153) ========= 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=af724c981e2a0f424dbabf99000001e7-1461739840.556753-192799357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-27 01:08:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 229M=0s 2016-04-27 01:08:42 (229 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116423 ========= master_lag: 0.54 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 01:08:42.223940) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 01:08:42.224236) ========= 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=af724c981e2a0f424dbabf99000001e7-1461739840.556753-192799357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015335 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 01:08:42.269440) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-27 01:08:42.269773) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 048c047097a97068fa5e4f2592c53e59449ab8fd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 048c047097a97068fa5e4f2592c53e59449ab8fd --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=af724c981e2a0f424dbabf99000001e7-1461739840.556753-192799357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-27 01:08:43,710 truncating revision to first 12 chars 2016-04-27 01:08:43,710 Setting DEBUG logging. 2016-04-27 01:08:43,710 attempt 1/10 2016-04-27 01:08:43,710 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/048c047097a9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-27 01:08:44,926 unpacking tar archive at: mozilla-inbound-048c047097a9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.484525 ========= master_lag: 0.43 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-27 01:08:44.186589) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 01:08:44.186894) ========= script_repo_revision: 048c047097a97068fa5e4f2592c53e59449ab8fd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 01:08:44.187251) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 01:08:44.187510) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 01:08:44.203367) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-04-27 01:08:44.203649) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=af724c981e2a0f424dbabf99000001e7-1461739840.556753-192799357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:08:45 INFO - MultiFileLogger online at 20160427 01:08:45 in /builds/slave/test 01:08:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 01:08:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:08:45 INFO - {'append_to_log': False, 01:08:45 INFO - 'base_work_dir': '/builds/slave/test', 01:08:45 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 01:08:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:08:45 INFO - 'branch': 'Mozilla-Inbound', 01:08:45 INFO - 'buildbot_json_path': 'buildprops.json', 01:08:45 INFO - 'config_files': ('talos/linux_config.py',), 01:08:45 INFO - 'default_actions': ('clobber', 01:08:45 INFO - 'read-buildbot-config', 01:08:45 INFO - 'download-and-extract', 01:08:45 INFO - 'populate-webroot', 01:08:45 INFO - 'create-virtualenv', 01:08:45 INFO - 'install', 01:08:45 INFO - 'run-tests'), 01:08:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:08:45 INFO - 'download_minidump_stackwalk': True, 01:08:45 INFO - 'download_symbols': 'ondemand', 01:08:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:08:45 INFO - 'tooltool.py': '/tools/tooltool.py', 01:08:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:08:45 INFO - '/tools/misc-python/virtualenv.py')}, 01:08:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:08:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:08:45 INFO - 'installer_path': 'installer.exe', 01:08:45 INFO - 'log_level': 'info', 01:08:45 INFO - 'log_name': 'talos', 01:08:45 INFO - 'log_to_console': True, 01:08:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:08:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:08:45 INFO - 'opt_config_files': (), 01:08:45 INFO - 'pip_index': False, 01:08:45 INFO - 'sps_profile': False, 01:08:45 INFO - 'sps_profile_interval': 0, 01:08:45 INFO - 'suite': 'dromaeojs', 01:08:45 INFO - 'system_bits': '32', 01:08:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:08:45 INFO - 'title': 'talos-linux64-ix-020', 01:08:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:08:45 INFO - 'use_talos_json': True, 01:08:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:08:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:08:45 INFO - 'work_dir': 'build'} 01:08:45 INFO - ##### 01:08:45 INFO - ##### Running clobber step. 01:08:45 INFO - ##### 01:08:45 INFO - Running pre-action listener: _resource_record_pre_action 01:08:45 INFO - Running main action method: clobber 01:08:45 INFO - rmtree: /builds/slave/test/build 01:08:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:08:46 INFO - Running post-action listener: _resource_record_post_action 01:08:46 INFO - ##### 01:08:46 INFO - ##### Running read-buildbot-config step. 01:08:46 INFO - ##### 01:08:46 INFO - Running pre-action listener: _resource_record_pre_action 01:08:46 INFO - Running main action method: read_buildbot_config 01:08:46 INFO - Using buildbot properties: 01:08:46 INFO - { 01:08:46 INFO - "project": "", 01:08:46 INFO - "product": "firefox", 01:08:46 INFO - "script_repo_revision": "production", 01:08:46 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 01:08:46 INFO - "repository": "", 01:08:46 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 01:08:46 INFO - "buildid": "20160426223217", 01:08:46 INFO - "pgo_build": "True", 01:08:46 INFO - "basedir": "/builds/slave/test", 01:08:46 INFO - "buildnumber": 1755, 01:08:46 INFO - "slavename": "talos-linux64-ix-020", 01:08:46 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:08:46 INFO - "platform": "ubuntu64_hw", 01:08:46 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 01:08:46 INFO - "branch": "mozilla-inbound", 01:08:46 INFO - "repo_path": "integration/mozilla-inbound", 01:08:46 INFO - "revision": "048c047097a97068fa5e4f2592c53e59449ab8fd", 01:08:46 INFO - "stage_platform": "linux64-pgo", 01:08:46 INFO - "builduid": "81eae3bfbe2e49159d1da282ef8fa3a9", 01:08:46 INFO - "slavebuilddir": "test" 01:08:46 INFO - } 01:08:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/JWfdUPohQT-NGY-7s2g9gQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 01:08:46 INFO - Running post-action listener: _resource_record_post_action 01:08:46 INFO - ##### 01:08:46 INFO - ##### Running download-and-extract step. 01:08:46 INFO - ##### 01:08:46 INFO - Running pre-action listener: _resource_record_pre_action 01:08:46 INFO - Running main action method: download_and_extract 01:08:46 INFO - mkdir: /builds/slave/test/build/tests 01:08: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')]} 01:08:46 INFO - https://queue.taskcluster.net/v1/task/JWfdUPohQT-NGY-7s2g9gQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:08:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWfdUPohQT-NGY-7s2g9gQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:08:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWfdUPohQT-NGY-7s2g9gQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:08:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWfdUPohQT-NGY-7s2g9gQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:08:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWfdUPohQT-NGY-7s2g9gQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:08:56 INFO - Downloaded 1361 bytes. 01:08:56 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:08:56 INFO - Using the following test package requirements: 01:08:56 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:08:56 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:08:56 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:08:56 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:08:56 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:08:56 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:08:56 INFO - u'jsshell-linux-x86_64.zip'], 01:08:56 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:08:56 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:08:56 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:08:56 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:08:56 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:08:56 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:08:56 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:08:56 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:08:56 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:08:56 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:08:56 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:08:56 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:08:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:08:56 INFO - https://queue.taskcluster.net/v1/task/JWfdUPohQT-NGY-7s2g9gQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:08:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWfdUPohQT-NGY-7s2g9gQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:08:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWfdUPohQT-NGY-7s2g9gQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:08:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWfdUPohQT-NGY-7s2g9gQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:08:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWfdUPohQT-NGY-7s2g9gQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:09:06 INFO - Downloaded 23865939 bytes. 01:09:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:09:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:09:07 INFO - Return code: 0 01:09:07 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:09:07 INFO - https://queue.taskcluster.net/v1/task/JWfdUPohQT-NGY-7s2g9gQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:09:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWfdUPohQT-NGY-7s2g9gQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:09:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWfdUPohQT-NGY-7s2g9gQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:09:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWfdUPohQT-NGY-7s2g9gQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:09:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWfdUPohQT-NGY-7s2g9gQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:09:13 INFO - Downloaded 23865939 bytes. 01:09:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:09:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:09:15 INFO - Return code: 0 01:09:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:09:15 INFO - https://queue.taskcluster.net/v1/task/JWfdUPohQT-NGY-7s2g9gQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:09:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWfdUPohQT-NGY-7s2g9gQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:09:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWfdUPohQT-NGY-7s2g9gQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:09:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWfdUPohQT-NGY-7s2g9gQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:09:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWfdUPohQT-NGY-7s2g9gQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:09:16 INFO - Downloaded 10840145 bytes. 01:09:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:09:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 01:09:16 INFO - Return code: 0 01:09:16 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')]} 01:09:16 INFO - https://queue.taskcluster.net/v1/task/JWfdUPohQT-NGY-7s2g9gQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:09:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWfdUPohQT-NGY-7s2g9gQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:09:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWfdUPohQT-NGY-7s2g9gQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:09:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWfdUPohQT-NGY-7s2g9gQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:09:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWfdUPohQT-NGY-7s2g9gQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:09:19 INFO - Downloaded 58362294 bytes. 01:09:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JWfdUPohQT-NGY-7s2g9gQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:09:19 INFO - mkdir: /builds/slave/test/properties 01:09:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:09:19 INFO - Writing to file /builds/slave/test/properties/build_url 01:09:19 INFO - Contents: 01:09:19 INFO - build_url:https://queue.taskcluster.net/v1/task/JWfdUPohQT-NGY-7s2g9gQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:09:19 INFO - Running post-action listener: _resource_record_post_action 01:09:19 INFO - Running post-action listener: set_extra_try_arguments 01:09:19 INFO - ##### 01:09:19 INFO - ##### Running populate-webroot step. 01:09:19 INFO - ##### 01:09:19 INFO - Running pre-action listener: _resource_record_pre_action 01:09:19 INFO - Running main action method: populate_webroot 01:09:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:09:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:09:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:09:19 INFO - '--tppagecycles', 01:09:19 INFO - '7'], 01:09:19 INFO - 'tests': ['tsvgm']}}, 01:09:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:09:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:09:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:09:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:09:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:09:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:09:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:09:19 INFO - 'talos_options': ['--disable-e10s'], 01:09:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:09:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:09:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:09:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:09:19 INFO - 'talos_options': ['--disable-e10s'], 01:09:19 INFO - 'tests': ['damp', 'tps']}, 01:09:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:09:19 INFO - 'tests': ['damp', 'tps']}, 01:09:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:09:19 INFO - 'tests': ['dromaeo_dom']}, 01:09:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:09:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:09:19 INFO - 'tests': ['a11yr', 01:09:19 INFO - 'ts_paint', 01:09:19 INFO - 'tpaint', 01:09:19 INFO - 'sessionrestore', 01:09:19 INFO - 'sessionrestore_no_auto_restore', 01:09:19 INFO - 'tabpaint']}, 01:09:19 INFO - 'other-e10s': {'tests': ['a11yr', 01:09:19 INFO - 'ts_paint', 01:09:19 INFO - 'tpaint', 01:09:19 INFO - 'sessionrestore', 01:09:19 INFO - 'sessionrestore_no_auto_restore', 01:09:19 INFO - 'tabpaint']}, 01:09:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:09:19 INFO - 'ts_paint', 01:09:19 INFO - 'tpaint', 01:09:19 INFO - 'sessionrestore', 01:09:19 INFO - 'sessionrestore_no_auto_restore', 01:09:19 INFO - 'tabpaint']}, 01:09:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:09:19 INFO - 'ts_paint', 01:09:19 INFO - 'tpaint', 01:09:19 INFO - 'sessionrestore', 01:09:19 INFO - 'sessionrestore_no_auto_restore', 01:09:19 INFO - 'tabpaint']}, 01:09:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:09:19 INFO - 'tests': ['a11yr', 01:09:19 INFO - 'ts_paint', 01:09:19 INFO - 'tpaint', 01:09:19 INFO - 'sessionrestore', 01:09:19 INFO - 'sessionrestore_no_auto_restore', 01:09:19 INFO - 'tabpaint']}, 01:09:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:09:19 INFO - 'tests': ['a11yr', 01:09:19 INFO - 'ts_paint', 01:09:19 INFO - 'tpaint', 01:09:19 INFO - 'sessionrestore', 01:09:19 INFO - 'sessionrestore_no_auto_restore', 01:09:19 INFO - 'tabpaint']}, 01:09:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:09:19 INFO - 'tests': ['tsvgx', 01:09:19 INFO - 'tsvgr_opacity', 01:09:19 INFO - 'tart', 01:09:19 INFO - 'tscrollx', 01:09:19 INFO - 'cart']}, 01:09:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:09:19 INFO - 'tsvgr_opacity', 01:09:19 INFO - 'tart', 01:09:19 INFO - 'tscrollx', 01:09:19 INFO - 'cart']}, 01:09:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:09:19 INFO - 'talos_options': ['--disable-e10s'], 01:09:19 INFO - 'tests': ['tp5o']}, 01:09:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:09:19 INFO - 'tests': ['tp5o']}, 01:09:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:09:19 INFO - 'talos_options': ['--disable-e10s', 01:09:19 INFO - '--xperf_path', 01:09:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:09:19 INFO - 'tests': ['tp5n']}, 01:09:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:09:19 INFO - 'talos_options': ['--xperf_path', 01:09:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:09:19 INFO - 'tests': ['tp5n']}}, 01:09:19 INFO - 'talos.zip': {'path': '', 01:09:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:09:19 INFO - Running post-action listener: _resource_record_post_action 01:09:19 INFO - ##### 01:09:19 INFO - ##### Running create-virtualenv step. 01:09:19 INFO - ##### 01:09:19 INFO - Running pre-action listener: _resource_record_pre_action 01:09:19 INFO - Running main action method: create_virtualenv 01:09:19 INFO - Creating virtualenv /builds/slave/test/build/venv 01:09:19 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 01:09:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:09:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:09:20 INFO - Using real prefix '/usr' 01:09:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:09:20 INFO - Installing distribute.............................................................................................................................................................................................done. 01:09:22 INFO - Installing pip.................done. 01:09:22 INFO - Return code: 0 01:09:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:09:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:22 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 0x7fc9f6411f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ec5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7b410>, '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 0x2a7c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7c7a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461739840.556753-192799357', '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 01:09:22 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 01:09:22 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 01:09:22 INFO - Using env: {'DISPLAY': ':0', 01:09:22 INFO - 'HOME': '/home/cltbld', 01:09:22 INFO - 'LANG': 'en_US.UTF-8', 01:09:22 INFO - 'LANGUAGE': 'en_US:en', 01:09:22 INFO - 'LOGNAME': 'cltbld', 01:09:22 INFO - 'MAIL': '/var/mail/cltbld', 01:09:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:22 INFO - 'MOZ_NO_REMOTE': '1', 01:09:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:22 INFO - 'NO_EM_RESTART': '1', 01:09:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:22 INFO - 'PWD': '/builds/slave/test', 01:09:22 INFO - 'SHELL': '/bin/bash', 01:09:22 INFO - 'SHLVL': '1', 01:09:22 INFO - 'TERM': 'linux', 01:09:22 INFO - 'TMOUT': '86400', 01:09:22 INFO - 'USER': 'cltbld', 01:09:22 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461739840.556753-192799357', 01:09:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:22 INFO - '_': '/tools/buildbot/bin/python'} 01:09:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:22 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 01:09:22 INFO - Cleaning up... 01:09:22 INFO - Return code: 0 01:09:22 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:09:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:22 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 0x7fc9f6411f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ec5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7b410>, '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 0x2a7c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7c7a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461739840.556753-192799357', '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 01:09:22 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 01:09:22 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 01:09:22 INFO - Using env: {'DISPLAY': ':0', 01:09:22 INFO - 'HOME': '/home/cltbld', 01:09:22 INFO - 'LANG': 'en_US.UTF-8', 01:09:22 INFO - 'LANGUAGE': 'en_US:en', 01:09:22 INFO - 'LOGNAME': 'cltbld', 01:09:22 INFO - 'MAIL': '/var/mail/cltbld', 01:09:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:22 INFO - 'MOZ_NO_REMOTE': '1', 01:09:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:22 INFO - 'NO_EM_RESTART': '1', 01:09:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:22 INFO - 'PWD': '/builds/slave/test', 01:09:22 INFO - 'SHELL': '/bin/bash', 01:09:22 INFO - 'SHLVL': '1', 01:09:22 INFO - 'TERM': 'linux', 01:09:22 INFO - 'TMOUT': '86400', 01:09:22 INFO - 'USER': 'cltbld', 01:09:22 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461739840.556753-192799357', 01:09:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:22 INFO - '_': '/tools/buildbot/bin/python'} 01:09:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:23 INFO - Downloading/unpacking psutil>=0.7.1 01:09:23 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 01:09:23 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 01:09:23 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 01:09:23 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 01:09:23 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 01:09:23 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 01:09:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:09:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:09:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:09:25 INFO - Installing collected packages: psutil 01:09:25 INFO - Running setup.py install for psutil 01:09:25 INFO - building 'psutil._psutil_linux' extension 01:09:25 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 01:09:25 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 01:09:25 INFO - building 'psutil._psutil_posix' extension 01:09:25 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 01:09:25 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 01:09:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:09:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:09:25 INFO - Successfully installed psutil 01:09:25 INFO - Cleaning up... 01:09:25 INFO - Return code: 0 01:09:25 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:09:25 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')]} 01:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:25 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')]} 01:09:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:25 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 0x7fc9f6411f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ec5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7b410>, '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 0x2a7c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7c7a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461739840.556753-192799357', '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 01:09:25 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 01:09:25 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 01:09:25 INFO - Using env: {'DISPLAY': ':0', 01:09:25 INFO - 'HOME': '/home/cltbld', 01:09:25 INFO - 'LANG': 'en_US.UTF-8', 01:09:25 INFO - 'LANGUAGE': 'en_US:en', 01:09:25 INFO - 'LOGNAME': 'cltbld', 01:09:25 INFO - 'MAIL': '/var/mail/cltbld', 01:09:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:25 INFO - 'MOZ_NO_REMOTE': '1', 01:09:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:25 INFO - 'NO_EM_RESTART': '1', 01:09:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:25 INFO - 'PWD': '/builds/slave/test', 01:09:25 INFO - 'SHELL': '/bin/bash', 01:09:25 INFO - 'SHLVL': '1', 01:09:25 INFO - 'TERM': 'linux', 01:09:25 INFO - 'TMOUT': '86400', 01:09:25 INFO - 'USER': 'cltbld', 01:09:25 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461739840.556753-192799357', 01:09:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:25 INFO - '_': '/tools/buildbot/bin/python'} 01:09:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:25 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:09:25 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 01:09:25 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 01:09:25 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 01:09:25 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 01:09:25 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 01:09:25 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 01:09:27 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:09:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:09:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:09:27 INFO - Installing collected packages: mozsystemmonitor 01:09:27 INFO - Running setup.py install for mozsystemmonitor 01:09:27 INFO - Successfully installed mozsystemmonitor 01:09:27 INFO - Cleaning up... 01:09:27 INFO - Return code: 0 01:09:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:09:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:27 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 0x7fc9f6411f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ec5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7b410>, '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 0x2a7c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7c7a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461739840.556753-192799357', '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 01:09:27 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 01:09:27 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 01:09:27 INFO - Using env: {'DISPLAY': ':0', 01:09:27 INFO - 'HOME': '/home/cltbld', 01:09:27 INFO - 'LANG': 'en_US.UTF-8', 01:09:27 INFO - 'LANGUAGE': 'en_US:en', 01:09:27 INFO - 'LOGNAME': 'cltbld', 01:09:27 INFO - 'MAIL': '/var/mail/cltbld', 01:09:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:27 INFO - 'MOZ_NO_REMOTE': '1', 01:09:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:27 INFO - 'NO_EM_RESTART': '1', 01:09:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:27 INFO - 'PWD': '/builds/slave/test', 01:09:27 INFO - 'SHELL': '/bin/bash', 01:09:27 INFO - 'SHLVL': '1', 01:09:27 INFO - 'TERM': 'linux', 01:09:27 INFO - 'TMOUT': '86400', 01:09:27 INFO - 'USER': 'cltbld', 01:09:27 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461739840.556753-192799357', 01:09:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:27 INFO - '_': '/tools/buildbot/bin/python'} 01:09:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:28 INFO - Downloading/unpacking blobuploader==1.2.4 01:09:28 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 01:09:28 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 01:09:28 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 01:09:28 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 01:09:28 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 01:09:28 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 01:09:30 INFO - Downloading blobuploader-1.2.4.tar.gz 01:09:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:09:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:09:30 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 01:09:30 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 01:09:30 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 01:09:30 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 01:09:30 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 01:09:30 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 01:09:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:09:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:09:30 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 01:09:30 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 01:09:30 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 01:09:30 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 01:09:30 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 01:09:30 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 01:09:30 INFO - Downloading docopt-0.6.1.tar.gz 01:09:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:09:30 INFO - Installing collected packages: blobuploader, requests, docopt 01:09:30 INFO - Running setup.py install for blobuploader 01:09:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:09:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:09:30 INFO - Running setup.py install for requests 01:09:31 INFO - Running setup.py install for docopt 01:09:31 INFO - Successfully installed blobuploader requests docopt 01:09:31 INFO - Cleaning up... 01:09:31 INFO - Return code: 0 01:09:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:09:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:09:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:31 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 0x7fc9f6411f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ec5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7b410>, '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 0x2a7c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7c7a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461739840.556753-192799357', '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 01:09:31 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 01:09:31 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 01:09:31 INFO - Using env: {'DISPLAY': ':0', 01:09:31 INFO - 'HOME': '/home/cltbld', 01:09:31 INFO - 'LANG': 'en_US.UTF-8', 01:09:31 INFO - 'LANGUAGE': 'en_US:en', 01:09:31 INFO - 'LOGNAME': 'cltbld', 01:09:31 INFO - 'MAIL': '/var/mail/cltbld', 01:09:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:31 INFO - 'MOZ_NO_REMOTE': '1', 01:09:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:31 INFO - 'NO_EM_RESTART': '1', 01:09:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:31 INFO - 'PWD': '/builds/slave/test', 01:09:31 INFO - 'SHELL': '/bin/bash', 01:09:31 INFO - 'SHLVL': '1', 01:09:31 INFO - 'TERM': 'linux', 01:09:31 INFO - 'TMOUT': '86400', 01:09:31 INFO - 'USER': 'cltbld', 01:09:31 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461739840.556753-192799357', 01:09:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:31 INFO - '_': '/tools/buildbot/bin/python'} 01:09:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:09:31 INFO - Running setup.py (path:/tmp/pip-WNftJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:09:31 INFO - Running setup.py (path:/tmp/pip-YKtns0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:09:31 INFO - Running setup.py (path:/tmp/pip-sJxx1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:09:31 INFO - Running setup.py (path:/tmp/pip-kYukm4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:09:31 INFO - Running setup.py (path:/tmp/pip-28JgeT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:09:31 INFO - Running setup.py (path:/tmp/pip-k8raSZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:09:32 INFO - Running setup.py (path:/tmp/pip-BwUFjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:09:32 INFO - Running setup.py (path:/tmp/pip-q3wf6g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:09:32 INFO - Running setup.py (path:/tmp/pip-TnJg4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:09:32 INFO - Running setup.py (path:/tmp/pip-5HTbxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:09:32 INFO - Running setup.py (path:/tmp/pip-_egqmf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:09:32 INFO - Running setup.py (path:/tmp/pip-WIoLXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:09:32 INFO - Running setup.py (path:/tmp/pip-XE8SOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:09:32 INFO - Running setup.py (path:/tmp/pip-ORmNED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:09:32 INFO - Running setup.py (path:/tmp/pip-EcJCgY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:09:32 INFO - Running setup.py (path:/tmp/pip-Mmmtj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:09:32 INFO - Running setup.py (path:/tmp/pip-jvvhj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:09:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:09:32 INFO - Running setup.py install for manifestparser 01:09:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:09:32 INFO - Running setup.py install for mozcrash 01:09:33 INFO - Running setup.py install for mozdebug 01:09:33 INFO - Running setup.py install for mozdevice 01:09:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:09:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:09:33 INFO - Running setup.py install for mozfile 01:09:33 INFO - Running setup.py install for mozhttpd 01:09:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:09:33 INFO - Running setup.py install for mozinfo 01:09:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:09:33 INFO - Running setup.py install for mozInstall 01:09:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:09:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:09:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:09:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:09:33 INFO - Running setup.py install for mozleak 01:09:33 INFO - Running setup.py install for mozlog 01:09:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:09:33 INFO - Running setup.py install for moznetwork 01:09:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:09:33 INFO - Running setup.py install for mozprocess 01:09:34 INFO - Running setup.py install for mozprofile 01:09:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:09:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:09:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:09:34 INFO - Running setup.py install for mozrunner 01:09:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:09:34 INFO - Running setup.py install for mozscreenshot 01:09:34 INFO - Running setup.py install for moztest 01:09:34 INFO - Running setup.py install for mozversion 01:09:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:09:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:09:34 INFO - Cleaning up... 01:09:34 INFO - Return code: 0 01:09:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:09:34 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')]} 01:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:34 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')]} 01:09:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:34 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 0x7fc9f6411f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ec5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7b410>, '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 0x2a7c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7c7a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461739840.556753-192799357', '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 01:09:34 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 01:09:34 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 01:09:34 INFO - Using env: {'DISPLAY': ':0', 01:09:34 INFO - 'HOME': '/home/cltbld', 01:09:34 INFO - 'LANG': 'en_US.UTF-8', 01:09:34 INFO - 'LANGUAGE': 'en_US:en', 01:09:34 INFO - 'LOGNAME': 'cltbld', 01:09:34 INFO - 'MAIL': '/var/mail/cltbld', 01:09:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:34 INFO - 'MOZ_NO_REMOTE': '1', 01:09:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:34 INFO - 'NO_EM_RESTART': '1', 01:09:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:34 INFO - 'PWD': '/builds/slave/test', 01:09:34 INFO - 'SHELL': '/bin/bash', 01:09:34 INFO - 'SHLVL': '1', 01:09:34 INFO - 'TERM': 'linux', 01:09:34 INFO - 'TMOUT': '86400', 01:09:34 INFO - 'USER': 'cltbld', 01:09:34 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461739840.556753-192799357', 01:09:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:34 INFO - '_': '/tools/buildbot/bin/python'} 01:09:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:09:34 INFO - Running setup.py (path:/tmp/pip-zQ2zwn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:09:34 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)) 01:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:09:34 INFO - Running setup.py (path:/tmp/pip-LH_TMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:09:34 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)) 01:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:09:34 INFO - Running setup.py (path:/tmp/pip-eFjM0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:09:35 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)) 01:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:09:35 INFO - Running setup.py (path:/tmp/pip-uHufOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:09:35 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)) 01:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:09:35 INFO - Running setup.py (path:/tmp/pip-XeDrUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:09:35 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)) 01:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:09:35 INFO - Running setup.py (path:/tmp/pip-S3B5WX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:09:35 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)) 01:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:09:35 INFO - Running setup.py (path:/tmp/pip-1yktAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:09:35 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)) 01:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:09:35 INFO - Running setup.py (path:/tmp/pip-USHl3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:09:35 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)) 01:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:09:35 INFO - Running setup.py (path:/tmp/pip-YYPG2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:09:35 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)) 01:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:09:35 INFO - Running setup.py (path:/tmp/pip-U5m9v7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:09:35 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)) 01:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:09:35 INFO - Running setup.py (path:/tmp/pip-NXs0Mk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:09:35 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)) 01:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:09:35 INFO - Running setup.py (path:/tmp/pip-CUHzyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:09:35 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)) 01:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:09:35 INFO - Running setup.py (path:/tmp/pip-qwamKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:09:35 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)) 01:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:09:35 INFO - Running setup.py (path:/tmp/pip-_m_AzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:09:35 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)) 01:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:09:35 INFO - Running setup.py (path:/tmp/pip-uFd05o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:09:35 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)) 01:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:09:35 INFO - Running setup.py (path:/tmp/pip-kpJpMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:09:36 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)) 01:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:09:36 INFO - Running setup.py (path:/tmp/pip-9YJf3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:09:36 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)) 01:09:36 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)) 01:09:36 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)) 01:09:36 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)) 01:09:36 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)) 01:09:36 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)) 01:09:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:09:36 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 01:09:36 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 01:09:36 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 01:09:36 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 01:09:36 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 01:09:36 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 01:09:37 INFO - Downloading blessings-1.6.tar.gz 01:09:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:09:38 INFO - Installing collected packages: blessings 01:09:38 INFO - Running setup.py install for blessings 01:09:38 INFO - Successfully installed blessings 01:09:38 INFO - Cleaning up... 01:09:38 INFO - Return code: 0 01:09:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:09:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:09:38 INFO - Reading from file tmpfile_stdout 01:09:38 INFO - Current package versions: 01:09:38 INFO - argparse == 1.2.1 01:09:38 INFO - blessings == 1.6 01:09:38 INFO - blobuploader == 1.2.4 01:09:38 INFO - docopt == 0.6.1 01:09:38 INFO - manifestparser == 1.1 01:09:38 INFO - mozInstall == 1.12 01:09:38 INFO - mozcrash == 0.17 01:09:38 INFO - mozdebug == 0.1 01:09:38 INFO - mozdevice == 0.48 01:09:38 INFO - mozfile == 1.2 01:09:38 INFO - mozhttpd == 0.7 01:09:38 INFO - mozinfo == 0.9 01:09:38 INFO - mozleak == 0.1 01:09:38 INFO - mozlog == 3.1 01:09:38 INFO - moznetwork == 0.27 01:09:38 INFO - mozprocess == 0.22 01:09:38 INFO - mozprofile == 0.28 01:09:38 INFO - mozrunner == 6.11 01:09:38 INFO - mozscreenshot == 0.1 01:09:38 INFO - mozsystemmonitor == 0.0 01:09:38 INFO - moztest == 0.7 01:09:38 INFO - mozversion == 1.4 01:09:38 INFO - psutil == 3.1.1 01:09:38 INFO - requests == 1.2.3 01:09:38 INFO - wsgiref == 0.1.2 01:09:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:09:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:38 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 0x7fc9f6411f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ec5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7b410>, '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 0x2a7c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7c7a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461739840.556753-192799357', '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 01:09:38 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 01:09:38 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 01:09:38 INFO - Using env: {'DISPLAY': ':0', 01:09:38 INFO - 'HOME': '/home/cltbld', 01:09:38 INFO - 'LANG': 'en_US.UTF-8', 01:09:38 INFO - 'LANGUAGE': 'en_US:en', 01:09:38 INFO - 'LOGNAME': 'cltbld', 01:09:38 INFO - 'MAIL': '/var/mail/cltbld', 01:09:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:38 INFO - 'MOZ_NO_REMOTE': '1', 01:09:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:38 INFO - 'NO_EM_RESTART': '1', 01:09:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:38 INFO - 'PWD': '/builds/slave/test', 01:09:38 INFO - 'SHELL': '/bin/bash', 01:09:38 INFO - 'SHLVL': '1', 01:09:38 INFO - 'TERM': 'linux', 01:09:38 INFO - 'TMOUT': '86400', 01:09:38 INFO - 'USER': 'cltbld', 01:09:38 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461739840.556753-192799357', 01:09:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:38 INFO - '_': '/tools/buildbot/bin/python'} 01:09:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:38 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)) 01:09:38 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)) 01:09:38 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)) 01:09:38 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)) 01:09:38 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)) 01:09:38 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)) 01:09:38 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)) 01:09:38 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)) 01:09:38 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)) 01:09:38 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)) 01:09:38 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)) 01:09:38 INFO - Cleaning up... 01:09:38 INFO - Return code: 0 01:09:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:09:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:38 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 0x7fc9f6411f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ec5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7b410>, '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 0x2a7c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7c7a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461739840.556753-192799357', '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 01:09:38 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 01:09:38 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 01:09:38 INFO - Using env: {'DISPLAY': ':0', 01:09:38 INFO - 'HOME': '/home/cltbld', 01:09:38 INFO - 'LANG': 'en_US.UTF-8', 01:09:38 INFO - 'LANGUAGE': 'en_US:en', 01:09:38 INFO - 'LOGNAME': 'cltbld', 01:09:38 INFO - 'MAIL': '/var/mail/cltbld', 01:09:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:38 INFO - 'MOZ_NO_REMOTE': '1', 01:09:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:38 INFO - 'NO_EM_RESTART': '1', 01:09:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:38 INFO - 'PWD': '/builds/slave/test', 01:09:38 INFO - 'SHELL': '/bin/bash', 01:09:38 INFO - 'SHLVL': '1', 01:09:38 INFO - 'TERM': 'linux', 01:09:38 INFO - 'TMOUT': '86400', 01:09:38 INFO - 'USER': 'cltbld', 01:09:38 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461739840.556753-192799357', 01:09:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:38 INFO - '_': '/tools/buildbot/bin/python'} 01:09:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:38 INFO - Downloading/unpacking jsonschema 01:09:38 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 01:09:38 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 01:09:38 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 01:09:38 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 01:09:38 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 01:09:38 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 01:09:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:09:40 INFO - Downloading/unpacking functools32 (from jsonschema) 01:09:40 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 01:09:40 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 01:09:40 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 01:09:40 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 01:09:40 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 01:09:40 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 01:09:40 INFO - Downloading functools32-3.2.3-2.tar.gz 01:09:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:09:40 INFO - warning: no files found matching '*.txt' 01:09:40 INFO - no previously-included directories found matching 'build' 01:09:40 INFO - no previously-included directories found matching 'dist' 01:09:40 INFO - no previously-included directories found matching '.git*' 01:09:40 INFO - Installing collected packages: jsonschema, functools32 01:09:41 INFO - Running setup.py install for functools32 01:09:41 INFO - warning: no files found matching '*.txt' 01:09:41 INFO - no previously-included directories found matching 'build' 01:09:41 INFO - no previously-included directories found matching 'dist' 01:09:41 INFO - no previously-included directories found matching '.git*' 01:09:41 INFO - Successfully installed jsonschema functools32 01:09:41 INFO - Cleaning up... 01:09:41 INFO - Return code: 0 01:09:41 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:09: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')]} 01:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09: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')]} 01:09:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:41 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 0x7fc9f6411f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ec5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7b410>, '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 0x2a7c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7c7a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461739840.556753-192799357', '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 01:09:41 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 01:09:41 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 01:09:41 INFO - Using env: {'DISPLAY': ':0', 01:09:41 INFO - 'HOME': '/home/cltbld', 01:09:41 INFO - 'LANG': 'en_US.UTF-8', 01:09:41 INFO - 'LANGUAGE': 'en_US:en', 01:09:41 INFO - 'LOGNAME': 'cltbld', 01:09:41 INFO - 'MAIL': '/var/mail/cltbld', 01:09:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:41 INFO - 'MOZ_NO_REMOTE': '1', 01:09:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:41 INFO - 'NO_EM_RESTART': '1', 01:09:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:41 INFO - 'PWD': '/builds/slave/test', 01:09:41 INFO - 'SHELL': '/bin/bash', 01:09:41 INFO - 'SHLVL': '1', 01:09:41 INFO - 'TERM': 'linux', 01:09:41 INFO - 'TMOUT': '86400', 01:09:41 INFO - 'USER': 'cltbld', 01:09:41 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461739840.556753-192799357', 01:09:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:41 INFO - '_': '/tools/buildbot/bin/python'} 01:09:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:41 INFO - Downloading/unpacking flake8 01:09:41 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 01:09:41 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 01:09:41 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 01:09:41 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 01:09:41 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 01:09:41 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 01:09:43 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:09:43 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:09:43 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 01:09:43 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 01:09:43 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 01:09:43 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 01:09:43 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 01:09:43 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 01:09:43 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:09:43 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:09:43 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 01:09:43 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 01:09:43 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 01:09:43 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 01:09:43 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 01:09:43 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 01:09:43 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:09:43 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 01:09:43 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 01:09:43 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 01:09:43 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 01:09:43 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 01:09:43 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 01:09:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:09:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:09:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:09:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:09:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:09:43 INFO - no previously-included directories found matching 'docs/_build' 01:09:44 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:09:44 INFO - Running setup.py install for pep8 01:09:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:09:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:09:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:09:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:09:44 INFO - no previously-included directories found matching 'docs/_build' 01:09:44 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:09:44 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:09:44 INFO - Cleaning up... 01:09:44 INFO - Return code: 0 01:09:44 INFO - Running post-action listener: _resource_record_post_action 01:09:44 INFO - Running post-action listener: _start_resource_monitoring 01:09:44 INFO - Starting resource monitoring. 01:09:44 INFO - ##### 01:09:44 INFO - ##### Running install step. 01:09:44 INFO - ##### 01:09:44 INFO - Running pre-action listener: _resource_record_pre_action 01:09:44 INFO - Running main action method: install 01:09:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:09:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:09:44 INFO - Reading from file tmpfile_stdout 01:09:44 INFO - Detecting whether we're running mozinstall >=1.0... 01:09:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:09:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:09:44 INFO - Reading from file tmpfile_stdout 01:09:44 INFO - Output received: 01:09:44 INFO - Usage: mozinstall [options] installer 01:09:44 INFO - Options: 01:09:44 INFO - -h, --help show this help message and exit 01:09:44 INFO - -d DEST, --destination=DEST 01:09:44 INFO - Directory to install application into. [default: 01:09:44 INFO - "/builds/slave/test"] 01:09:44 INFO - --app=APP Application being installed. [default: firefox] 01:09:44 INFO - mkdir: /builds/slave/test/build/application 01:09:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:09:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:10:01 INFO - Reading from file tmpfile_stdout 01:10:01 INFO - Output received: 01:10:01 INFO - /builds/slave/test/build/application/firefox/firefox 01:10:01 INFO - Running post-action listener: _resource_record_post_action 01:10:01 INFO - ##### 01:10:01 INFO - ##### Running run-tests step. 01:10:01 INFO - ##### 01:10:01 INFO - Running pre-action listener: _resource_record_pre_action 01:10:01 INFO - Running main action method: run_tests 01:10:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:10:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:10:01 INFO - Python 2.7.3 01:10:01 INFO - Return code: 0 01:10:01 INFO - grabbing minidump binary from tooltool 01:10: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')]} 01:10:01 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 0x2a7b410>, '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 0x2a7c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7c7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:10:01 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 01:10:01 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 01:10:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:10:01 INFO - Return code: 0 01:10:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:10:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:10:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:10:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:10:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:10:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:10:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:10:02 INFO - Return code: 0 01:10:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JWfdUPohQT-NGY-7s2g9gQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 01:10:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JWfdUPohQT-NGY-7s2g9gQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 01:10:02 INFO - Using env: {'DISPLAY': ':0', 01:10:02 INFO - 'HOME': '/home/cltbld', 01:10:02 INFO - 'LANG': 'en_US.UTF-8', 01:10:02 INFO - 'LANGUAGE': 'en_US:en', 01:10:02 INFO - 'LOGNAME': 'cltbld', 01:10:02 INFO - 'MAIL': '/var/mail/cltbld', 01:10:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:10:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:10:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:02 INFO - 'MOZ_NO_REMOTE': '1', 01:10:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:10:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:10:02 INFO - 'NO_EM_RESTART': '1', 01:10:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:10:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:10:02 INFO - 'PWD': '/builds/slave/test', 01:10:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:10:02 INFO - 'SHELL': '/bin/bash', 01:10:02 INFO - 'SHLVL': '1', 01:10:02 INFO - 'TERM': 'linux', 01:10:02 INFO - 'TMOUT': '86400', 01:10:02 INFO - 'USER': 'cltbld', 01:10:02 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461739840.556753-192799357', 01:10:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:02 INFO - '_': '/tools/buildbot/bin/python'} 01:10:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JWfdUPohQT-NGY-7s2g9gQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 01:10:02 INFO - mozversion application_buildid: 20160426223217 01:10:02 INFO - mozversion application_changeset: 048c047097a97068fa5e4f2592c53e59449ab8fd 01:10:02 INFO - mozversion application_display_name: Nightly 01:10:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:10:02 INFO - mozversion application_name: Firefox 01:10:02 INFO - mozversion application_remotingname: firefox 01:10:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:10:02 INFO - mozversion application_vendor: Mozilla 01:10:02 INFO - mozversion application_version: 49.0a1 01:10:02 INFO - mozversion platform_buildid: 20160426223217 01:10:02 INFO - mozversion platform_changeset: 048c047097a97068fa5e4f2592c53e59449ab8fd 01:10:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:10:02 INFO - mozversion platform_version: 49.0a1 01:10:02 INFO - using testdate: 1461744602 01:10:02 INFO - actual date: 1461744602 01:10:02 INFO - starting webserver on 'localhost:59571' 01:10:02 INFO - SUITE-START | Running 2 tests 01:10:02 INFO - TEST-START | dromaeo_css 01:10:02 INFO - operating with platform_type : linux_ 01:10:02 INFO - Initialising browser for dromaeo_css test... 01:10:02 INFO - TEST-INFO | started process 27002 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjDHBdS/profile http://localhost:59571/getInfo.html) 01:10:06 INFO - PROCESS | 27002 | __metrics Screen width/height:1600/1200 01:10:06 INFO - PROCESS | 27002 | colorDepth:24 01:10:06 INFO - PROCESS | 27002 | Browser inner width/height: 1024/697 01:10:06 INFO - PROCESS | 27002 | __metrics 01:10:08 ERROR - PROCESS | 27002 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:10:09 INFO - TEST-INFO | 27002: exit 0 01:10:09 INFO - Browser initialized. 01:10:09 INFO - Running cycle 1/1 for dromaeo_css test... 01:10:09 INFO - TEST-INFO | started process 27083 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjDHBdS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:10:21 INFO - PROCESS | 27083 | RSS: Main: 154472448 01:10:21 INFO - PROCESS | 27083 | 01:11:12 INFO - PROCESS | 27083 | 1461744672162 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] 01:13:19 INFO - PROCESS | 27083 | Cycle 1(1): loaded http://localhost:59571/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59571/tests/dromaeo/cssquery-ext.html) 01:13:20 INFO - PROCESS | 27083 | RSS: Main: 252100608 01:13:20 INFO - PROCESS | 27083 | 01:16:23 INFO - PROCESS | 27083 | Cycle 1(1): loaded http://localhost:59571/tests/dromaeo/cssquery-ext.html (next: http://localhost:59571/tests/dromaeo/cssquery-jquery.html) 01:16:23 INFO - PROCESS | 27083 | RSS: Main: 236654592 01:16:23 INFO - PROCESS | 27083 | 01:19:25 INFO - PROCESS | 27083 | Cycle 1(1): loaded http://localhost:59571/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59571/tests/dromaeo/cssquery-mootools.html) 01:19:26 INFO - PROCESS | 27083 | RSS: Main: 236314624 01:19:26 INFO - PROCESS | 27083 | 01:22:28 INFO - PROCESS | 27083 | Cycle 1(1): loaded http://localhost:59571/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59571/tests/dromaeo/cssquery-prototype.html) 01:22:28 INFO - PROCESS | 27083 | RSS: Main: 230735872 01:22:28 INFO - PROCESS | 27083 | 01:25:31 INFO - PROCESS | 27083 | Cycle 1(1): loaded http://localhost:59571/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59571/tests/dromaeo/cssquery-yui.html) 01:25:31 INFO - PROCESS | 27083 | RSS: Main: 226668544 01:25:31 INFO - PROCESS | 27083 | 01:28:34 INFO - PROCESS | 27083 | Cycle 1(1): loaded http://localhost:59571/tests/dromaeo/cssquery-yui.html (next: http://localhost:59571/tests/dromaeo/cssquery-dojo.html) 01:28:34 INFO - PROCESS | 27083 | RSS: Main: 269328384 01:28:34 INFO - PROCESS | 27083 | 01:28:34 INFO - PROCESS | 27083 | __start_tp_report 01:28:34 INFO - PROCESS | 27083 | _x_x_mozilla_page_load 01:28:34 INFO - PROCESS | 27083 | _x_x_mozilla_page_load_details 01:28:34 INFO - PROCESS | 27083 | |i|pagename|runs| 01:28:34 INFO - PROCESS | 27083 | |0;dojo.html;3080.7535397168226;3102.9844850775744;3139.9999999999986;3142.465780817259;3176.1106890070773;5126.692398456086;5171.79312827487;5171.948280517194;5199.22011698245;5215.713135777531;5197.402298735647;5208.166693329059;5255.02781985333;5292.444293349201;5345.358556973159;4701.435827700672;4720.103180395731;4730.219513780239;4741.8424616799275;4935.728534930578;4867.829625963092;4889.511048895118;4893.3638626978445;4909.950900491003;4940.456549779521;4620.607248383892;4705.976470117627;4754.191787396151;4759.428868535781;4834.516548345155;4673.462551806551;4673.649476289292;4680.3447517347595;4688.413948256468;4704.553067458586;4625.074985003012;4656.4877863434995;4659.673822832403;4673.929891051637;4699.859004229878;5135.12702840518;5149.742512874342;5160.200168973815;5192;5204.479552044765;5470.8085217017615;5472.288602481652;5482.451754824486;5487.149491828773;5494.615376923617;5494.450554944514;5511.200875872976;5513.761926170115;5518.33779946409;5528.502434780889;5230.738463076831;5259.579233661298;5260.500252476008;5264.868378290574;5296.761645725913;5727.828165155052;5736.282964629421;5750.367459579443;5750.827475175752;5752.050911599539;5360.973195133999;5489.835304940858;5507.834764957058;5521.171824226318;5586.050371436865;5551.444855514497;5554.1113421853115;5556.083246264402;5560.944390556043;5599.8600034998635;5459.563234941195;5464.699441530674;5469.1249400096585;5488.17677348401;5524;5343.839684809462;5425.945740542623;5485.780568777204;5490.286262785812;5514;4193.6645068394455;4196.769177695256;4202.138561594866;4203.600657937491;4233.830646774095;3772;3778.3387907116144;3803.486529318562;3804.904877378088;3809.3333666608232;5098.337216161875;5173.896522069537;5270.683758974474;5330.120530112566;5333.333333333333;5614;5620.718964051863;5630.8029218977135;5643.209950606918;5645.1532270159805;5255.08036093682;5291.603129765206;5304.469553044664;5320.228566857784;5360.356757189163;4629.1436084324505;4681.368015317957;4714.269288260325;4747.359106520645;4748.169070412664;5805.01314776489;5831.212786273799;5836.153757705194;5840.065589505659;5841.182234487175;5495.258140151029;5603.971980140073;5604.327480702342;5609.5792815539;5661.094224923992;5817.79637712695;5837.09525023622;5854.677992710442;5875.764969401347;5895.20414744004;5519.199716041232;5520.806771762969;5525.9447405527035;5529.087700529368;5530.087535556588;5477.041517734301;5544.279243698294;5610.7755689773585;5618;5618.747156377891;5514.862128446661;5539.667619942817;5541.168824676331;5542.806001789918;5590.301212348457;5509.256250406304;5523.613347065828;5531;5532.612717109763;5533.280673512418;5115.87210319745;5316.441773613715;5386.5152136307925;5414.160805075219;5419.105847535113;5467.39858615544;5476.424975377688;5494.972525137348;5497.175423686479;5544.972275138599;5323.095073837534;5347.97326013383;5376.677399356051;5396.109641909041;5439.673619582838 01:28:34 INFO - PROCESS | 27083 | |1;ext.html;596.0790578556131;624.8375422390177;635.7329921432997;649.0880313160012;649.8115546491516;29684.257893552644;30451.84774076129;36863;37432;37452.25095498088;38391.616083839224;39257.41113883287;39417.40873886894;39424.60575394245;39477.40783888237;7644.808879777995;8487.236148746611;8694.043655197924;8700.956495217515;8702.651893924236;9787;10077.294589378746;10079.143272821819;10090.293679442442;10097;10306.123979461754;10505.68482945513;10508.422036787973;10512.894871051307;10516.474176291193;7611.048618922635;9883.308168428213;10152.847707284396;10271.897281027206;10435.530401131968;10060.144887684555;10197.592096316139;10199.54102065409;10212.234082443772;10213.387196768217;38210.61789382126;38900.22199556021;38966.610333896584;39059.60940390588;39095.218095638214;3578.5347904772475;3645.2345007548447;3726.981365093184;4010.7393019453643;4063.8374465021366;29161.85419072891;29644.555331670043;30189.69810301891;30311.848440757876;30637;3901.551321598024;4008.238434697398;4045.7167998240134;4064.9187016259807;4154.169166166779;187940;190421;190466;190700;190889;32192.195195119843;54803.72598136984;55205.447945520835;55256;55326;33572.66427335695;33637.495437568454;33719.83140084333;33725;33811;14440.638984025483;14730.189839558927;14745.852541474662;14750.336234869243;14750.63123421923;11760.70598235051;11801.586944456903;11859.051275897908;11867.643970680894;11885.108616853771;8073.434859559775;8158.877616835753;8178.754637360888;8200.753977380688;8240.21717936795;2930.2088436122554;3181.8568164432654;3195.344954284366;3208.98395508021;3250.756193285513;1010.5553556435145;1102.3055475050828;1118.848955391028;1141.3437273567731;1180.6103985684704;26664.73335266661;28391.716082838906;28471.71528284732;28638.28404289868;29234.415311694072;1040.8750949885912;1073.2165519171049;1115.9218854680257;1148.6726283009302;1161.7386088130104;15880.126593037263;16047.358105675643;16293.918530407273;16389.426370077228;16517.174141292886;353920;360234;360573;360751;361009;52799;54225.72887135618;54419;54473;54493;1349.811026456297;1361.5642994241946;1384.7715127004133;1388.1116085704955;1465.9633509162143;29358;30157;30623;30749.692503074682;30805.383892322476;47384.52615473939;47704.7614761924;47751.28373074337;47928.5207147938;47978.76010619925;289100;293492;295081;295091;295413;22877.88561057184;23338.183163589194;25150.496990060463;27022.459550809268;27368.58947115755;39617.2076558473;43617.563824362616;43812.33764946184;44180.7790961056;45070;36903;36928;37008;37373.2525349486;37587.248255035294;34484.48273275853;35316.293674126886;35593.64406356007;35596.28807423889;37432.438513421774;35411.645883540834;36109.63890361063;36122.27755444929;36368.27263454663;36513.087172820895;31079.533806992462;31331.686683132877;31922.36155276835;31943.361132777678;33318.83340583282;26388.868055659597;26697.466050679268;26866.865665671547;26873.731262687124;26884.462310753283 01:28:34 INFO - PROCESS | 27083 | |2;jquery.html;385.9247446747882;397.3840547151915;401.6024136105257;404.106923698626;408.6812286416594;13810.654733631663;14300.356483958221;16973.915130424346;17570.736438953427;17581.20884560193;12885.355732213398;16561.83438165618;16857.157142142903;16886.74669879953;16997;5433.891322173564;5520.365158006841;5579.497845193931;5584;5617.241672374238;4009.1981603679237;4192.790360481979;5468.6171967962255;5619.775208991636;5653.604247702662;4185.91628167438;5826.854328641797;6093.299270583895;6101.420365065312;6101.938980610182;6016.90974635383;6078.574499785017;6081.422264884829;6093.482054025391;6116;5203.19350500673;5342.786288548454;5389.407165211824;5411.18832175173;5425.511703946664;12128.757424851541;19114.904425477922;21019;21027.5794484111;21082.894585527127;2093.152273329304;2259.243153543565;2321.3500219938446;2643.127767836609;2655.309619498925;9291.76770580734;9492.430454172772;10112.94943525285;11820.468078936468;13847.099938503965;1841.7513635659147;1888.5845114074882;1901.610169915178;1989.7711763147133;2029.2390353617393;65675.34324656788;68202.31797682059;68229.3177068228;68907.65546172287;69411.3058869415;10025.498725063717;10115.089641932262;10385.273030887765;10540;10683.73290667724;14357.928210358881;14558.781618275734;14559.78160327596;14578.854211457961;14596.635084122981;7203.639818009078;7602.315791578784;7808.102068262109;7941;8235.341172706288;7707.884381734279;7887.526748395;7946.682132714626;8049.27556519916;8085.838283234302;4555.886102847456;4647.419072615923;4653.464851542049;4666.183417901853;4666.510016448292;1780.5606319342326;1789.8210178981997;1828.826261505155;1830.9176087076114;1880.3734769424623;970.5542034074093;1010.1111022300475;1061.1881910338598;1065.7655315830505;1105.8728246251624;17611.38360157414;17689.823101768816;17911.820881791016;18118.45644630663;18382.356617518322;979.715882394112;986.6694657289888;988.4267125067587;994.3039872089566;1011.9544620492095;7843.5293882366095;10162;10199.38803671782;10261.076503114606;10303.845442318372;459080;462711;462921;475938;481181;76553.61723191348;76622.6168869152;76626;76791.61604191943;77043;980.2256217588168;990.841465365538;994.6966175316453;1001.2540657210279;1029.1920842138884;15647;15679.764803528184;15763.684726305639;16041.919790400972;16312.836871631132;34651.826740866134;34941;35106.64893351034;35371.93884183479;36074.63925360713;35970.8201458991;41484.377734334616;42680.146397071265;45724.31413528866;50347;7963.641636126273;8157.102718701057;8208.425410221227;8322.58773902697;8432.83134337322;9025.774355641162;11797.705057373634;12650.557230496888;12681.175723577939;12708.110432269652;11270.830429848724;11274;11279.09767218637;11403.942980285046;11588.536458541565;10869.891301086887;10888.94555527249;10916.945415272872;11029.669109926715;11252.381119038531;10791.244612877337;10807.513661885077;11111.166662500507;11306.393029394796;11434.71413214643;8194.83610327802;8417;8489.915100848912;8552.957235213784;8591.570421479026;11371.943140284577;11385.544578216779;11434.828477572677;11598.304101753922;11742.70643233926 01:28:34 INFO - PROCESS | 27083 | |3;mootools.html;1300.174389262819;1469.2580246975278;1484.621421537508;1614.2897125264883;1750.5361079313975;7626.389888808896;7923;7990.2409271119295;8000.759977200679;8007.279344858962;7602.087749470057;7758.456908016441;7778.6888524458955;7780.766577002685;7792.883106753403;1974.8025197480208;2044.9795502044938;2227.766084561122;2237.2617036377997;2276.2602154299834;2253.8196944244423;2258.2434884313775;2259.7288325400973;2261.6607508873717;2264.739554951177;2266.7506574276817;2275.2377953385635;2302.113686230805;2302.804261637763;2304.9423764405856;1898.810118988097;2141.336185782397;2205.71325727656;2217.102073660162;2218.833587480929;2207.1061220205843;2214.867107973527;2232.821374290053;2238.865668059905;2240.6190947538958;8188.959055204686;8266.917330826675;8268.958655206745;8282.958585207096;8289.129641387688;4888.266759985995;5060.2662613920775;5071.18860982241;5076.086304465195;5084.44071152173;3105.223694076481;3118.781685282031;3184.68153184682;3252.1869532616847;3265.738740900746;975.7267964969819;995.4127065031666;1007.3754272351116;2072.1814883121083;2114.7356580427445;10421.947890260575;10475.214358923111;10485.790284194274;10492.685219443429;10496.475176241234;4136.338185890303;4429.870383052301;4579.267317229294;4610.631149508032;4616.0767846430845;8650.221480066699;8655.48067115975;8705.738827835175;8709.216170544682;8739.12608739121;4886.364772579542;4891.584215341664;4894.143524883131;4905.681130726492;4906.435759887588;4110.157417729359;4460.397846290774;4559.772011399483;4563.178627846953;4568.70303430276;3560.91097722559;3649.835757390924;3688.0964163780045;3702.426123950792;3702.7593206441493;1150.3902931446346;1152.2913408253864;1166.1894982986912;1169.8128299472044;1175.13040350142;938.1462868789368;945.9905400945902;956.1967946924617;969.1277849935115;987.1362557761959;5282.97358513205;5450.700211488406;5554.527865131509;5640.294963129609;5698.373178950312;860.1699360117392;915.624593916491;945.8155659646441;972.5817898303798;978.1685567267765;3736.532933383327;3779.9244015119543;3858.112634094174;3895.5520115187114;3947.4276229946495;9647.421154730739;9764.218862490983;9879.654212102541;9923.851142232872;10030.147437467896;9746.707598772047;9953.900460995443;10105.292629515863;10238.590456381662;10294.382337059651;7266.818329541804;7772.22277772207;7819.687212511436;7886.64510097047;7897.24976127267;5539.861503462445;5573.3869274380595;5609.775608975595;5612.85967850807;5798.362180160263;8801.295896328407;9236.861447078165;9423.246140308896;9430.151286384258;9437.19783818383;9243.352965292364;9324.860127098234;9380.827396575429;9479.715608531755;9637.807243854942;6232.594881332699;6702.19573651165;6884.724611015503;6940.13248343957;7006.789796306119;7916.168802275678;7950.24472675095;7996.200379961957;8017.078036025931;8050.597470126353;7107.111611048619;7177.1746249182015;7201.783946481614;7266.455015873937;7480.588567628833;6861.519693621399;6963.651817409211;7275.345218930322;7317.853642927218;7444.404447644284;6473.676316184266;6511.446527045254;6517.511186661114;6530.869382612226;6537.378948999837;4758.785854636619;4823.421189457287;4830.686005409637;4867.5132486751045;4909.779059942382;4856.441509226484;4919.286703428054;4952.5542701157065;4960.8759781005765;5034.748262586929 01:28:34 INFO - PROCESS | 27083 | |4;prototype.html;323.94492936200845;331.3737037000069;332.154666374078;335.53193295352975;336.9747268954829;5326.440723724011;5362.731863406829;5404.540614047801;5408.701911541227;5415.323084614423;5264.447233040533;5282.31329927109;5297.867553311159;5307.628466007381;5341.798095428537;3982.462367580383;3998.4202290667836;4018;4042.636162745367;4102.323116685743;3921.6274453926976;4184.205001049806;4208.642265407444;4210.757826441207;4212.756177743136;4124.989377602492;4176.415301857743;4177.16456708658;4189.664826813862;4196.454460920091;3917.5298964124486;4038.697097717683;4142.378643203529;4182.393552934823;4191.392248124035;3657.0674478008204;3663.1757854482794;3673.1000904778234;3679.3193259247123;3698.2973235085515;5037.622178336639;5060.316857224301;5077.619178561623;5111.386633603955;5119.488051194888;4380.408644832939;4724.527547245282;4741.762911854394;4745.311929770199;4746.430428348585;5524.613277070606;5537.307836520435;5549.5837812163845;5564.527015203713;5590.468905454016;3853.7880416577077;3872.206197729459;3875.4380614810975;3885.436611691317;3896.0649444133487;5235.712035838065;5469.316335458067;5704.543636509069;5781.768729250825;5825.7378417971295;3968.861089861841;4071.2671719090254;4079.836806527765;4094.28350038742;4099.241640296555;4119.835206591702;4138.668371960541;4150.335946248586;4162.167566486714;4168.562300958356;4726.550977657117;4733.077049975291;4738.73936933465;4753.857384278477;4754.453237877619;5463.836084917459;5582.106862901997;5589.469000445032;5608.719564021782;5640.407757185437;1535.063611197169;1542.2597153366446;1542.4293011585785;1548.5509202331423;1554.35494269879;1020.505055048301;1050.795094956476;1052.7210289273348;1055.9524821383056;1069.385103565453;5757.050086735725;5775;5785.074388097884;5813.970930145407;5823.679697616587;6186.226721659793;6189.938100619026;6200.627962322275;6201.875962480815;6206.224221972254;5257.5005374489365;5540.869408784105;5547.972260138754;5556.611037227355;5797.449242321973;3325.833708314575;3327.251368442081;3334.7832390894514;3343.13078599561;3351.8826841060445;6384.201974753156;6485.221773387129;6523.739050438025;6532.216134063943;6542.280349161589;6345.904811427832;6356.586821856565;6374.235091788923;6374.394432528902;6407.423331900151;5661.915071273934;5725.1698503716725;5952.851178720567;6433.163688720437;6475.514336424787;5742.712864356849;5754.4533269339345;5755.65466072037;5769.480746732646;5771.874484475487;5465.638632241223;5625.240592519957;5675.687837168995;5726.112452569859;5742.16738572913;5928.940710593011;5945.554083443672;5946.43508866657;5951.642901425928;6012.729427175875;4031.4759081320412;4048.595140485928;4057.2696914555663;4080.3267460868624;4110.835566577303;5511.145772405283;5741.224934633771;5741.650712082574;5753.597248192586;5806.361300256884;5607.243022192115;5629.211910332475;5632.408597097409;5633.6619802811965;5640.60515763909;5553.305836770403;5570.164475328733;5615.747291371817;5616.775328986795;5684.237886255274;5322.121849894724;5418.965379387556;5424.349078110652;5441.537469314994;5496.148097044965;5598.580106492111;5598.944010560005;5630.18362337467;5631.408702086386;5635.380108188014;5299.390570084335;5490.478404551562;5501.889962200654;5512.586556008396;5556.222128902038 01:28:34 INFO - PROCESS | 27083 | |5;yui.html;724.9275072492751;742.5804420502419;748.947573669843;751.2374939436471;803.3171803966629;13265.469381224751;13461.125026873246;13530.594082177526;13597.999999999987;13631.454741810328;12816.487340506368;12928.806067908989;12984.675383115427;12985.09104362695;13005.219686818797;664.4684252597926;765.1430397954272;801.2068052627915;801.6793282686914;803.2529747334976;791.9049714034295;796.2594786848229;797.9985118676053;798.1978111997435;798.5448294472153;705.0552259971637;841.5329492131895;842.9620667069966;845.5729856422498;850.9872351914727;720.0890873045602;725.1733024352243;820.9138040505751;849.3375167369462;850.9234168924764;625.0780099353462;625.3184029407922;625.8654389306275;626.6553395632384;627.1282916745727;12699.555515557004;12720.491180352774;12758.872411275861;12773.808392874114;12784.849363557232;13155.40800663963;14010.92994535031;14252.714945701027;14270.215138167398;14455.13269203851;11427.486712224772;11662.300261984308;11703.648890533212;11850.762984740342;11856.703582410422;3825.2731980923536;3874.8643797467234;3899.3760998240145;3984.860529881469;3985.860494882665;54820.72589637026;55464.72267638636;56446;56887.715561422345;57107.71446142743;10829.729256768644;10898.94550527258;10941;11102.888971110186;11169.106471482262;19750.209991600463;19757.308494202633;19764.209431622574;19766.50583735418;19777;8376.162383761575;8393.958030209931;8482.915170848213;8671.739847804576;8780.209781119729;4925.236588328815;4983.551480366785;5008.273800298936;5028.069807085701;5039.899202016012;3290.1610089427045;3359.5800524934384;3362.0586235854;3369.5619569456303;3377.67912048355;531.9281896943941;580.4398755201252;587.4595372257534;598.8592680720027;600.534585696089;628.6416742456847;734.4711807498593;740.5667684404683;741.6440108747723;760.7451503746196;8705.347098967603;8763.912360876437;8896.955515222511;9014.86477702835;9161.267098632094;695.8156088636515;735.2427697802257;739.4971419434836;766.3141488367991;778.7897267737792;4215.367694845798;4305.9569404306185;4345.239583072949;4353.9129217415475;4533.229351010336;63451.682741585995;66217.33782662208;66284.33715662878;66718.33281667122;66833.6658316715;55851.162232566545;56809.431905680416;57023.71488142616;57215;59173.40826591679;50769.49230507648;51030;52882.73558632259;53556;53824.19263710969;8769.649214031368;8960.103989601248;8967.730968070968;9046.23107035883;9125.269978401844;32485.350292993535;33429.997100087036;33479.49780753339;34059.65940340565;34288.65711342855;46120.53879461296;46190.53809461863;46742.76628616835;46930.530694692614;47324.2901356473;11969.10231732641;12158.574449894211;12165.391730413621;12171.208871423683;12361.93819030899;13339.933300333436;13642.522511712043;13735.175889446666;13758.793618095537;14048.086874353134;12419;12569;12959;13041.478340866259;13270.1374410663;12633.305168215837;12840;12899.226046436868;13188.472461101448;13197;12543.56097536582;12547.24716517012;13216.207027578375;13347.66630834237;13475.865241347854;10974.341539507655;11014.44927753625;11291.266067705574;11365.659030229106;11608.361540115036;10571;10693.198010149114;10768.300060496043;10882;10960.252554127555 01:28:34 INFO - PROCESS | 27083 | __end_tp_report 01:28:34 INFO - PROCESS | 27083 | __start_cc_report 01:28:34 INFO - PROCESS | 27083 | _x_x_mozilla_cycle_collect,782 01:28:34 INFO - PROCESS | 27083 | __end_cc_report 01:28:34 INFO - PROCESS | 27083 | __startTimestamp1461745714551__endTimestamp 01:28:34 INFO - PROCESS | 27083 | 01:28:34 INFO - PROCESS | 27083 | ------- Summary: start ------- 01:28:34 INFO - PROCESS | 27083 | Number of tests: 6 01:28:34 INFO - PROCESS | 27083 | 01:28:34 INFO - PROCESS | 27083 | [#0] dojo.html Cycles:165 Average:5182.14 Median:5386.52 stddev:585.39 (10.9%) stddev-sans-first:563.50 01:28:34 INFO - PROCESS | 27083 | Values: 3080.8 3103.0 3140.0 3142.5 3176.1 5126.7 5171.8 5171.9 5199.2 5215.7 5197.4 5208.2 5255.0 5292.4 5345.4 4701.4 4720.1 4730.2 4741.8 4935.7 4867.8 4889.5 4893.4 4910.0 4940.5 4620.6 4706.0 4754.2 4759.4 4834.5 4673.5 4673.6 4680.3 4688.4 4704.6 4625.1 4656.5 4659.7 4673.9 4699.9 5135.1 5149.7 5160.2 5192.0 5204.5 5470.8 5472.3 5482.5 5487.1 5494.6 5494.5 5511.2 5513.8 5518.3 5528.5 5230.7 5259.6 5260.5 5264.9 5296.8 5727.8 5736.3 5750.4 5750.8 5752.1 5361.0 5489.8 5507.8 5521.2 5586.1 5551.4 5554.1 5556.1 5560.9 5599.9 5459.6 5464.7 5469.1 5488.2 5524.0 5343.8 5425.9 5485.8 5490.3 5514.0 4193.7 4196.8 4202.1 4203.6 4233.8 3772.0 3778.3 3803.5 3804.9 3809.3 5098.3 5173.9 5270.7 5330.1 5333.3 5614.0 5620.7 5630.8 5643.2 5645.2 5255.1 5291.6 5304.5 5320.2 5360.4 4629.1 4681.4 4714.3 4747.4 4748.2 5805.0 5831.2 5836.2 5840.1 5841.2 5495.3 5604.0 5604.3 5609.6 5661.1 5817.8 5837.1 5854.7 5875.8 5895.2 5519.2 5520.8 5525.9 5529.1 5530.1 5477.0 5544.3 5610.8 5618.0 5618.7 5514.9 5539.7 5541.2 5542.8 5590.3 5509.3 5523.6 5531.0 5532.6 5533.3 5115.9 5316.4 5386.5 5414.2 5419.1 5467.4 5476.4 5495.0 5497.2 5545.0 5323.1 5348.0 5376.7 5396.1 5439.7 01:28:34 INFO - PROCESS | 27083 | 01:28:34 INFO - PROCESS | 27083 | [#1] ext.html Cycles:180 Average:43918.92 Median:3202.16 stddev:76091.65 (2376.3%) stddev-sans-first:76235.58 01:28:34 INFO - PROCESS | 27083 | Values: 596.1 624.8 635.7 649.1 649.8 29684.3 30451.8 36863.0 37432.0 37452.3 38391.6 39257.4 39417.4 39424.6 39477.4 7644.8 8487.2 8694.0 8701.0 8702.7 9787.0 10077.3 10079.1 10090.3 10097.0 10306.1 10505.7 10508.4 10512.9 10516.5 7611.0 9883.3 10152.8 10271.9 10435.5 10060.1 10197.6 10199.5 10212.2 10213.4 38210.6 38900.2 38966.6 39059.6 39095.2 3578.5 3645.2 3727.0 4010.7 4063.8 29161.9 29644.6 30189.7 30311.8 30637.0 3901.6 4008.2 4045.7 4064.9 4154.2 187940.0 190421.0 190466.0 190700.0 190889.0 32192.2 54803.7 55205.4 55256.0 55326.0 33572.7 33637.5 33719.8 33725.0 33811.0 14440.6 14730.2 14745.9 14750.3 14750.6 11760.7 11801.6 11859.1 11867.6 11885.1 8073.4 8158.9 8178.8 8200.8 8240.2 2930.2 3181.9 3195.3 3209.0 3250.8 1010.6 1102.3 1118.8 1141.3 1180.6 26664.7 28391.7 28471.7 28638.3 29234.4 1040.9 1073.2 1115.9 1148.7 1161.7 15880.1 16047.4 16293.9 16389.4 16517.2 353920.0 360234.0 360573.0 360751.0 361009.0 52799.0 54225.7 54419.0 54473.0 54493.0 1349.8 1361.6 1384.8 1388.1 1466.0 29358.0 30157.0 30623.0 30749.7 30805.4 47384.5 47704.8 47751.3 47928.5 47978.8 289100.0 293492.0 295081.0 295091.0 295413.0 22877.9 23338.2 25150.5 27022.5 27368.6 39617.2 43617.6 43812.3 44180.8 45070.0 36903.0 36928.0 37008.0 37373.3 37587.2 34484.5 35316.3 35593.6 35596.3 37432.4 35411.6 36109.6 36122.3 36368.3 36513.1 31079.5 31331.7 31922.4 31943.4 33318.8 26388.9 26697.5 26866.9 26873.7 26884.5 01:28:34 INFO - PROCESS | 27083 | 01:28:34 INFO - PROCESS | 27083 | [#2] jquery.html Cycles:180 Average:26469.99 Median:35239.29 stddev:76766.80 (217.8%) stddev-sans-first:76957.17 01:28:34 INFO - PROCESS | 27083 | Values: 385.9 397.4 401.6 404.1 408.7 13810.7 14300.4 16973.9 17570.7 17581.2 12885.4 16561.8 16857.2 16886.7 16997.0 5433.9 5520.4 5579.5 5584.0 5617.2 4009.2 4192.8 5468.6 5619.8 5653.6 4185.9 5826.9 6093.3 6101.4 6101.9 6016.9 6078.6 6081.4 6093.5 6116.0 5203.2 5342.8 5389.4 5411.2 5425.5 12128.8 19114.9 21019.0 21027.6 21082.9 2093.2 2259.2 2321.4 2643.1 2655.3 9291.8 9492.4 10112.9 11820.5 13847.1 1841.8 1888.6 1901.6 1989.8 2029.2 65675.3 68202.3 68229.3 68907.7 69411.3 10025.5 10115.1 10385.3 10540.0 10683.7 14357.9 14558.8 14559.8 14578.9 14596.6 7203.6 7602.3 7808.1 7941.0 8235.3 7707.9 7887.5 7946.7 8049.3 8085.8 4555.9 4647.4 4653.5 4666.2 4666.5 1780.6 1789.8 1828.8 1830.9 1880.4 970.6 1010.1 1061.2 1065.8 1105.9 17611.4 17689.8 17911.8 18118.5 18382.4 979.7 986.7 988.4 994.3 1012.0 7843.5 10162.0 10199.4 10261.1 10303.8 459080.0 462711.0 462921.0 475938.0 481181.0 76553.6 76622.6 76626.0 76791.6 77043.0 980.2 990.8 994.7 1001.3 1029.2 15647.0 15679.8 15763.7 16041.9 16312.8 34651.8 34941.0 35106.6 35371.9 36074.6 35970.8 41484.4 42680.1 45724.3 50347.0 7963.6 8157.1 8208.4 8322.6 8432.8 9025.8 11797.7 12650.6 12681.2 12708.1 11270.8 11274.0 11279.1 11403.9 11588.5 10869.9 10888.9 10916.9 11029.7 11252.4 10791.2 10807.5 11111.2 11306.4 11434.7 8194.8 8417.0 8489.9 8553.0 8591.6 11371.9 11385.5 11434.8 11598.3 11742.7 01:28:34 INFO - PROCESS | 27083 | 01:28:34 INFO - PROCESS | 27083 | [#3] mootools.html Cycles:180 Average:5351.06 Median:5080.26 stddev:2913.65 (57.4%) stddev-sans-first:2905.91 01:28:34 INFO - PROCESS | 27083 | Values: 1300.2 1469.3 1484.6 1614.3 1750.5 7626.4 7923.0 7990.2 8000.8 8007.3 7602.1 7758.5 7778.7 7780.8 7792.9 1974.8 2045.0 2227.8 2237.3 2276.3 2253.8 2258.2 2259.7 2261.7 2264.7 2266.8 2275.2 2302.1 2302.8 2304.9 1898.8 2141.3 2205.7 2217.1 2218.8 2207.1 2214.9 2232.8 2238.9 2240.6 8189.0 8266.9 8269.0 8283.0 8289.1 4888.3 5060.3 5071.2 5076.1 5084.4 3105.2 3118.8 3184.7 3252.2 3265.7 975.7 995.4 1007.4 2072.2 2114.7 10421.9 10475.2 10485.8 10492.7 10496.5 4136.3 4429.9 4579.3 4610.6 4616.1 8650.2 8655.5 8705.7 8709.2 8739.1 4886.4 4891.6 4894.1 4905.7 4906.4 4110.2 4460.4 4559.8 4563.2 4568.7 3560.9 3649.8 3688.1 3702.4 3702.8 1150.4 1152.3 1166.2 1169.8 1175.1 938.1 946.0 956.2 969.1 987.1 5283.0 5450.7 5554.5 5640.3 5698.4 860.2 915.6 945.8 972.6 978.2 3736.5 3779.9 3858.1 3895.6 3947.4 9647.4 9764.2 9879.7 9923.9 10030.1 9746.7 9953.9 10105.3 10238.6 10294.4 7266.8 7772.2 7819.7 7886.6 7897.2 5539.9 5573.4 5609.8 5612.9 5798.4 8801.3 9236.9 9423.2 9430.2 9437.2 9243.4 9324.9 9380.8 9479.7 9637.8 6232.6 6702.2 6884.7 6940.1 7006.8 7916.2 7950.2 7996.2 8017.1 8050.6 7107.1 7177.2 7201.8 7266.5 7480.6 6861.5 6963.7 7275.3 7317.9 7444.4 6473.7 6511.4 6517.5 6530.9 6537.4 4758.8 4823.4 4830.7 4867.5 4909.8 4856.4 4919.3 4952.6 4960.9 5034.7 01:28:34 INFO - PROCESS | 27083 | 01:28:34 INFO - PROCESS | 27083 | [#4] prototype.html Cycles:180 Average:4769.59 Median:5383.64 stddev:1419.20 (26.4%) stddev-sans-first:1383.40 01:28:34 INFO - PROCESS | 27083 | Values: 323.9 331.4 332.2 335.5 337.0 5326.4 5362.7 5404.5 5408.7 5415.3 5264.4 5282.3 5297.9 5307.6 5341.8 3982.5 3998.4 4018.0 4042.6 4102.3 3921.6 4184.2 4208.6 4210.8 4212.8 4125.0 4176.4 4177.2 4189.7 4196.5 3917.5 4038.7 4142.4 4182.4 4191.4 3657.1 3663.2 3673.1 3679.3 3698.3 5037.6 5060.3 5077.6 5111.4 5119.5 4380.4 4724.5 4741.8 4745.3 4746.4 5524.6 5537.3 5549.6 5564.5 5590.5 3853.8 3872.2 3875.4 3885.4 3896.1 5235.7 5469.3 5704.5 5781.8 5825.7 3968.9 4071.3 4079.8 4094.3 4099.2 4119.8 4138.7 4150.3 4162.2 4168.6 4726.6 4733.1 4738.7 4753.9 4754.5 5463.8 5582.1 5589.5 5608.7 5640.4 1535.1 1542.3 1542.4 1548.6 1554.4 1020.5 1050.8 1052.7 1056.0 1069.4 5757.1 5775.0 5785.1 5814.0 5823.7 6186.2 6189.9 6200.6 6201.9 6206.2 5257.5 5540.9 5548.0 5556.6 5797.4 3325.8 3327.3 3334.8 3343.1 3351.9 6384.2 6485.2 6523.7 6532.2 6542.3 6345.9 6356.6 6374.2 6374.4 6407.4 5661.9 5725.2 5952.9 6433.2 6475.5 5742.7 5754.5 5755.7 5769.5 5771.9 5465.6 5625.2 5675.7 5726.1 5742.2 5928.9 5945.6 5946.4 5951.6 6012.7 4031.5 4048.6 4057.3 4080.3 4110.8 5511.1 5741.2 5741.7 5753.6 5806.4 5607.2 5629.2 5632.4 5633.7 5640.6 5553.3 5570.2 5615.7 5616.8 5684.2 5322.1 5419.0 5424.3 5441.5 5496.1 5598.6 5598.9 5630.2 5631.4 5635.4 5299.4 5490.5 5501.9 5512.6 5556.2 01:28:34 INFO - PROCESS | 27083 | 01:28:34 INFO - PROCESS | 27083 | [#5] yui.html Cycles:180 Average:15108.72 Median:46155.54 stddev:17808.62 (38.6%) stddev-sans-first:17825.82 01:28:34 INFO - PROCESS | 27083 | Values: 724.9 742.6 748.9 751.2 803.3 13265.5 13461.1 13530.6 13598.0 13631.5 12816.5 12928.8 12984.7 12985.1 13005.2 664.5 765.1 801.2 801.7 803.3 791.9 796.3 798.0 798.2 798.5 705.1 841.5 843.0 845.6 851.0 720.1 725.2 820.9 849.3 850.9 625.1 625.3 625.9 626.7 627.1 12699.6 12720.5 12758.9 12773.8 12784.8 13155.4 14010.9 14252.7 14270.2 14455.1 11427.5 11662.3 11703.6 11850.8 11856.7 3825.3 3874.9 3899.4 3984.9 3985.9 54820.7 55464.7 56446.0 56887.7 57107.7 10829.7 10898.9 10941.0 11102.9 11169.1 19750.2 19757.3 19764.2 19766.5 19777.0 8376.2 8394.0 8482.9 8671.7 8780.2 4925.2 4983.6 5008.3 5028.1 5039.9 3290.2 3359.6 3362.1 3369.6 3377.7 531.9 580.4 587.5 598.9 600.5 628.6 734.5 740.6 741.6 760.7 8705.3 8763.9 8897.0 9014.9 9161.3 695.8 735.2 739.5 766.3 778.8 4215.4 4306.0 4345.2 4353.9 4533.2 63451.7 66217.3 66284.3 66718.3 66833.7 55851.2 56809.4 57023.7 57215.0 59173.4 50769.5 51030.0 52882.7 53556.0 53824.2 8769.6 8960.1 8967.7 9046.2 9125.3 32485.4 33430.0 33479.5 34059.7 34288.7 46120.5 46190.5 46742.8 46930.5 47324.3 11969.1 12158.6 12165.4 12171.2 12361.9 13339.9 13642.5 13735.2 13758.8 14048.1 12419.0 12569.0 12959.0 13041.5 13270.1 12633.3 12840.0 12899.2 13188.5 13197.0 12543.6 12547.2 13216.2 13347.7 13475.9 10974.3 11014.4 11291.3 11365.7 11608.4 10571.0 10693.2 10768.3 10882.0 10960.3 01:28:34 INFO - PROCESS | 27083 | -------- Summary: end -------- 01:28:34 INFO - PROCESS | 27083 | 01:28:35 INFO - TEST-INFO | 27083: exit 0 01:28:35 INFO - TEST-OK | dromaeo_css | took 1112969ms 01:28:35 INFO - TEST-START | kraken 01:28:35 INFO - operating with platform_type : linux_ 01:28:35 INFO - Initialising browser for kraken test... 01:28:35 INFO - TEST-INFO | started process 27263 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJQjPJ1/profile http://localhost:59571/getInfo.html) 01:28:39 INFO - PROCESS | 27263 | __metrics Screen width/height:1600/1200 01:28:39 INFO - PROCESS | 27263 | colorDepth:24 01:28:39 INFO - PROCESS | 27263 | Browser inner width/height: 1024/697 01:28:39 INFO - PROCESS | 27263 | __metrics 01:28:40 ERROR - PROCESS | 27263 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:28:41 INFO - TEST-INFO | 27263: exit 0 01:28:41 INFO - Browser initialized. 01:28:41 INFO - Running cycle 1/1 for kraken test... 01:28:41 INFO - TEST-INFO | started process 27347 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJQjPJ1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:28:53 INFO - PROCESS | 27347 | RSS: Main: 154017792 01:28:53 INFO - PROCESS | 27347 | 01:28:56 INFO - PROCESS | 27347 | Cycle 1(1): loaded http://localhost:59571/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59571/tests/kraken/driver.html?testName=audio-beat-detection) 01:28:56 INFO - PROCESS | 27347 | RSS: Main: 209199104 01:28:56 INFO - PROCESS | 27347 | 01:28:59 INFO - PROCESS | 27347 | Cycle 1(1): loaded http://localhost:59571/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59571/tests/kraken/driver.html?testName=audio-dft) 01:29:00 INFO - PROCESS | 27347 | RSS: Main: 194949120 01:29:00 INFO - PROCESS | 27347 | 01:29:03 INFO - PROCESS | 27347 | Cycle 1(1): loaded http://localhost:59571/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59571/tests/kraken/driver.html?testName=audio-fft) 01:29:04 INFO - PROCESS | 27347 | RSS: Main: 265478144 01:29:04 INFO - PROCESS | 27347 | 01:29:06 INFO - PROCESS | 27347 | Cycle 1(1): loaded http://localhost:59571/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59571/tests/kraken/driver.html?testName=audio-oscillator) 01:29:06 INFO - PROCESS | 27347 | RSS: Main: 173776896 01:29:06 INFO - PROCESS | 27347 | 01:29:08 INFO - PROCESS | 27347 | Cycle 1(1): loaded http://localhost:59571/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59571/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:29:09 INFO - PROCESS | 27347 | RSS: Main: 178241536 01:29:09 INFO - PROCESS | 27347 | 01:29:12 INFO - PROCESS | 27347 | Cycle 1(1): loaded http://localhost:59571/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59571/tests/kraken/driver.html?testName=imaging-darkroom) 01:29:13 INFO - PROCESS | 27347 | RSS: Main: 214245376 01:29:13 INFO - PROCESS | 27347 | 01:29:16 INFO - PROCESS | 27347 | Cycle 1(1): loaded http://localhost:59571/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59571/tests/kraken/driver.html?testName=imaging-desaturate) 01:29:16 INFO - PROCESS | 27347 | RSS: Main: 214683648 01:29:16 INFO - PROCESS | 27347 | 01:29:19 INFO - PROCESS | 27347 | Cycle 1(1): loaded http://localhost:59571/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59571/tests/kraken/driver.html?testName=json-parse-financial) 01:29:20 INFO - PROCESS | 27347 | RSS: Main: 214315008 01:29:20 INFO - PROCESS | 27347 | 01:29:21 INFO - PROCESS | 27347 | Cycle 1(1): loaded http://localhost:59571/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59571/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:29:22 INFO - PROCESS | 27347 | RSS: Main: 200790016 01:29:22 INFO - PROCESS | 27347 | 01:29:24 INFO - PROCESS | 27347 | Cycle 1(1): loaded http://localhost:59571/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59571/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:29:24 INFO - PROCESS | 27347 | RSS: Main: 204353536 01:29:24 INFO - PROCESS | 27347 | 01:29:26 INFO - PROCESS | 27347 | Cycle 1(1): loaded http://localhost:59571/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59571/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:29:27 INFO - PROCESS | 27347 | RSS: Main: 215605248 01:29:27 INFO - PROCESS | 27347 | 01:29:30 INFO - PROCESS | 27347 | Cycle 1(1): loaded http://localhost:59571/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59571/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:29:30 INFO - PROCESS | 27347 | RSS: Main: 223367168 01:29:30 INFO - PROCESS | 27347 | 01:29:33 INFO - PROCESS | 27347 | Cycle 1(1): loaded http://localhost:59571/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59571/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:29:34 INFO - PROCESS | 27347 | RSS: Main: 220049408 01:29:34 INFO - PROCESS | 27347 | 01:29:36 INFO - PROCESS | 27347 | Cycle 1(1): loaded http://localhost:59571/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59571/tests/kraken/driver.html?testName=ai-astar) 01:29:36 INFO - PROCESS | 27347 | RSS: Main: 284254208 01:29:36 INFO - PROCESS | 27347 | 01:29:36 INFO - PROCESS | 27347 | __start_tp_report 01:29:36 INFO - PROCESS | 27347 | _x_x_mozilla_page_load 01:29:36 INFO - PROCESS | 27347 | _x_x_mozilla_page_load_details 01:29:36 INFO - PROCESS | 27347 | |i|pagename|runs| 01:29:36 INFO - PROCESS | 27347 | |0;ai-astar;110;111;106;111;114;113;100;112;111;112 01:29:36 INFO - PROCESS | 27347 | |1;audio-beat-detection;155;128;155;188;126;153;153;136;195;132 01:29:36 INFO - PROCESS | 27347 | |2;audio-dft;161;161;161;161;161;160;161;164;161;160 01:29:36 INFO - PROCESS | 27347 | |3;audio-fft;74;76;100;112;77;77;73;112;105;77 01:29:36 INFO - PROCESS | 27347 | |4;audio-oscillator;92;92;146;93;93;94;154;93;93;145 01:29:36 INFO - PROCESS | 27347 | |5;imaging-gaussian-blur;117;116;116;118;118;116;117;117;116;117 01:29:36 INFO - PROCESS | 27347 | |6;imaging-darkroom;145;146;145;146;145;146;145;147;146;147 01:29:36 INFO - PROCESS | 27347 | |7;imaging-desaturate;94;94;95;95;96;95;94;94;95;94 01:29:36 INFO - PROCESS | 27347 | |8;json-parse-financial;57;58;58;58;56;58;59;73;55;56 01:29:36 INFO - PROCESS | 27347 | |9;json-stringify-tinderbox;61;61;60;61;61;60;61;61;61;61 01:29:36 INFO - PROCESS | 27347 | |10;stanford-crypto-aes;76;76;74;77;77;77;77;77;78;79 01:29:36 INFO - PROCESS | 27347 | |11;stanford-crypto-ccm;134;136;127;126;127;134;127;135;158;128 01:29:36 INFO - PROCESS | 27347 | |12;stanford-crypto-pbkdf2;206;200;204;203;212;202;209;208;206;208 01:29:36 INFO - PROCESS | 27347 | |13;stanford-crypto-sha256-iterative;73;71;70;70;71;69;71;68;70;69 01:29:36 INFO - PROCESS | 27347 | __end_tp_report 01:29:36 INFO - PROCESS | 27347 | __start_cc_report 01:29:36 INFO - PROCESS | 27347 | _x_x_mozilla_cycle_collect,1647 01:29:36 INFO - PROCESS | 27347 | __end_cc_report 01:29:36 INFO - PROCESS | 27347 | __startTimestamp1461745776457__endTimestamp 01:29:36 INFO - PROCESS | 27347 | 01:29:36 INFO - PROCESS | 27347 | ------- Summary: start ------- 01:29:36 INFO - PROCESS | 27347 | Number of tests: 14 01:29:36 INFO - PROCESS | 27347 | 01:29:36 INFO - PROCESS | 27347 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.50 stddev:4.11 (3.7%) stddev-sans-first:4.36 01:29:36 INFO - PROCESS | 27347 | Values: 110.0 111.0 106.0 111.0 114.0 113.0 100.0 112.0 111.0 112.0 01:29:36 INFO - PROCESS | 27347 | 01:29:36 INFO - PROCESS | 27347 | [#1] audio-beat-detection Cycles:10 Average:152.10 Median:154.00 stddev:23.74 (15.4%) stddev-sans-first:25.16 01:29:36 INFO - PROCESS | 27347 | Values: 155.0 128.0 155.0 188.0 126.0 153.0 153.0 136.0 195.0 132.0 01:29:36 INFO - PROCESS | 27347 | 01:29:36 INFO - PROCESS | 27347 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:1.10 (0.7%) stddev-sans-first:1.17 01:29:36 INFO - PROCESS | 27347 | Values: 161.0 161.0 161.0 161.0 161.0 160.0 161.0 164.0 161.0 160.0 01:29:36 INFO - PROCESS | 27347 | 01:29:36 INFO - PROCESS | 27347 | [#3] audio-fft Cycles:10 Average:88.30 Median:75.00 stddev:16.71 (22.3%) stddev-sans-first:16.90 01:29:36 INFO - PROCESS | 27347 | Values: 74.0 76.0 100.0 112.0 77.0 77.0 73.0 112.0 105.0 77.0 01:29:36 INFO - PROCESS | 27347 | 01:29:36 INFO - PROCESS | 27347 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:93.00 stddev:26.90 (28.9%) stddev-sans-first:27.78 01:29:36 INFO - PROCESS | 27347 | Values: 92.0 92.0 146.0 93.0 93.0 94.0 154.0 93.0 93.0 145.0 01:29:36 INFO - PROCESS | 27347 | 01:29:36 INFO - PROCESS | 27347 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 01:29:36 INFO - PROCESS | 27347 | Values: 117.0 116.0 116.0 118.0 118.0 116.0 117.0 117.0 116.0 117.0 01:29:36 INFO - PROCESS | 27347 | 01:29:36 INFO - PROCESS | 27347 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 01:29:36 INFO - PROCESS | 27347 | Values: 145.0 146.0 145.0 146.0 145.0 146.0 145.0 147.0 146.0 147.0 01:29:36 INFO - PROCESS | 27347 | 01:29:36 INFO - PROCESS | 27347 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 01:29:36 INFO - PROCESS | 27347 | Values: 94.0 94.0 95.0 95.0 96.0 95.0 94.0 94.0 95.0 94.0 01:29:36 INFO - PROCESS | 27347 | 01:29:36 INFO - PROCESS | 27347 | [#8] json-parse-financial Cycles:10 Average:58.80 Median:58.00 stddev:5.14 (8.9%) stddev-sans-first:5.41 01:29:36 INFO - PROCESS | 27347 | Values: 57.0 58.0 58.0 58.0 56.0 58.0 59.0 73.0 55.0 56.0 01:29:36 INFO - PROCESS | 27347 | 01:29:36 INFO - PROCESS | 27347 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 01:29:36 INFO - PROCESS | 27347 | Values: 61.0 61.0 60.0 61.0 61.0 60.0 61.0 61.0 61.0 61.0 01:29:36 INFO - PROCESS | 27347 | 01:29:36 INFO - PROCESS | 27347 | [#10] stanford-crypto-aes Cycles:10 Average:76.80 Median:77.00 stddev:1.32 (1.7%) stddev-sans-first:1.36 01:29:36 INFO - PROCESS | 27347 | Values: 76.0 76.0 74.0 77.0 77.0 77.0 77.0 77.0 78.0 79.0 01:29:36 INFO - PROCESS | 27347 | 01:29:36 INFO - PROCESS | 27347 | [#11] stanford-crypto-ccm Cycles:10 Average:133.20 Median:134.00 stddev:9.55 (7.1%) stddev-sans-first:10.13 01:29:36 INFO - PROCESS | 27347 | Values: 134.0 136.0 127.0 126.0 127.0 134.0 127.0 135.0 158.0 128.0 01:29:36 INFO - PROCESS | 27347 | 01:29:36 INFO - PROCESS | 27347 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:205.80 Median:207.00 stddev:3.61 (1.7%) stddev-sans-first:3.83 01:29:36 INFO - PROCESS | 27347 | Values: 206.0 200.0 204.0 203.0 212.0 202.0 209.0 208.0 206.0 208.0 01:29:36 INFO - PROCESS | 27347 | 01:29:36 INFO - PROCESS | 27347 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:70.50 stddev:1.40 (2.0%) stddev-sans-first:1.05 01:29:36 INFO - PROCESS | 27347 | Values: 73.0 71.0 70.0 70.0 71.0 69.0 71.0 68.0 70.0 69.0 01:29:36 INFO - PROCESS | 27347 | -------- Summary: end -------- 01:29:36 INFO - PROCESS | 27347 | 01:29:37 INFO - TEST-INFO | 27347: exit 0 01:29:37 INFO - TEST-OK | kraken | took 62156ms 01:29:37 INFO - SUITE-END | took 1175s 01:29:37 INFO - Completed test suite (00:19:35) 01:29:37 INFO - javascript benchmark 01:29:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3080.7535397168226, 3102.9844850775744, 3139.9999999999986, 3142.465780817259, 3176.1106890070773, 5126.692398456086, 5171.79312827487, 5171.948280517194, 5199.22011698245, 5215.713135777531, 5197.402298735647, 5208.166693329059, 5255.02781985333, 5292.444293349201, 5345.358556973159, 4701.435827700672, 4720.103180395731, 4730.219513780239, 4741.8424616799275, 4935.728534930578, 4867.829625963092, 4889.511048895118, 4893.3638626978445, 4909.950900491003, 4940.456549779521, 4620.607248383892, 4705.976470117627, 4754.191787396151, 4759.428868535781, 4834.516548345155, 4673.462551806551, 4673.649476289292, 4680.3447517347595, 4688.413948256468, 4704.553067458586, 4625.074985003012, 4656.4877863434995, 4659.673822832403, 4673.929891051637, 4699.859004229878, 5135.12702840518, 5149.742512874342, 5160.200168973815, 5192.0, 5204.479552044765, 5470.8085217017615, 5472.288602481652, 5482.451754824486, 5487.149491828773, 5494.615376923617, 5494.450554944514, 5511.200875872976, 5513.761926170115, 5518.33779946409, 5528.502434780889, 5230.738463076831, 5259.579233661298, 5260.500252476008, 5264.868378290574, 5296.761645725913, 5727.828165155052, 5736.282964629421, 5750.367459579443, 5750.827475175752, 5752.050911599539, 5360.973195133999, 5489.835304940858, 5507.834764957058, 5521.171824226318, 5586.050371436865, 5551.444855514497, 5554.1113421853115, 5556.083246264402, 5560.944390556043, 5599.8600034998635, 5459.563234941195, 5464.699441530674, 5469.1249400096585, 5488.17677348401, 5524.0, 5343.839684809462, 5425.945740542623, 5485.780568777204, 5490.286262785812, 5514.0, 4193.6645068394455, 4196.769177695256, 4202.138561594866, 4203.600657937491, 4233.830646774095, 3772.0, 3778.3387907116144, 3803.486529318562, 3804.904877378088, 3809.3333666608232, 5098.337216161875, 5173.896522069537, 5270.683758974474, 5330.120530112566, 5333.333333333333, 5614.0, 5620.718964051863, 5630.8029218977135, 5643.209950606918, 5645.1532270159805, 5255.08036093682, 5291.603129765206, 5304.469553044664, 5320.228566857784, 5360.356757189163, 4629.1436084324505, 4681.368015317957, 4714.269288260325, 4747.359106520645, 4748.169070412664, 5805.01314776489, 5831.212786273799, 5836.153757705194, 5840.065589505659, 5841.182234487175, 5495.258140151029, 5603.971980140073, 5604.327480702342, 5609.5792815539, 5661.094224923992, 5817.79637712695, 5837.09525023622, 5854.677992710442, 5875.764969401347, 5895.20414744004, 5519.199716041232, 5520.806771762969, 5525.9447405527035, 5529.087700529368, 5530.087535556588, 5477.041517734301, 5544.279243698294, 5610.7755689773585, 5618.0, 5618.747156377891, 5514.862128446661, 5539.667619942817, 5541.168824676331, 5542.806001789918, 5590.301212348457, 5509.256250406304, 5523.613347065828, 5531.0, 5532.612717109763, 5533.280673512418, 5115.87210319745, 5316.441773613715, 5386.5152136307925, 5414.160805075219, 5419.105847535113, 5467.39858615544, 5476.424975377688, 5494.972525137348, 5497.175423686479, 5544.972275138599, 5323.095073837534, 5347.97326013383, 5376.677399356051, 5396.109641909041, 5439.673619582838], "value": 5143.507391746933, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.0790578556131, 624.8375422390177, 635.7329921432997, 649.0880313160012, 649.8115546491516, 29684.257893552644, 30451.84774076129, 36863.0, 37432.0, 37452.25095498088, 38391.616083839224, 39257.41113883287, 39417.40873886894, 39424.60575394245, 39477.40783888237, 7644.808879777995, 8487.236148746611, 8694.043655197924, 8700.956495217515, 8702.651893924236, 9787.0, 10077.294589378746, 10079.143272821819, 10090.293679442442, 10097.0, 10306.123979461754, 10505.68482945513, 10508.422036787973, 10512.894871051307, 10516.474176291193, 7611.048618922635, 9883.308168428213, 10152.847707284396, 10271.897281027206, 10435.530401131968, 10060.144887684555, 10197.592096316139, 10199.54102065409, 10212.234082443772, 10213.387196768217, 38210.61789382126, 38900.22199556021, 38966.610333896584, 39059.60940390588, 39095.218095638214, 3578.5347904772475, 3645.2345007548447, 3726.981365093184, 4010.7393019453643, 4063.8374465021366, 29161.85419072891, 29644.555331670043, 30189.69810301891, 30311.848440757876, 30637.0, 3901.551321598024, 4008.238434697398, 4045.7167998240134, 4064.9187016259807, 4154.169166166779, 187940.0, 190421.0, 190466.0, 190700.0, 190889.0, 32192.195195119843, 54803.72598136984, 55205.447945520835, 55256.0, 55326.0, 33572.66427335695, 33637.495437568454, 33719.83140084333, 33725.0, 33811.0, 14440.638984025483, 14730.189839558927, 14745.852541474662, 14750.336234869243, 14750.63123421923, 11760.70598235051, 11801.586944456903, 11859.051275897908, 11867.643970680894, 11885.108616853771, 8073.434859559775, 8158.877616835753, 8178.754637360888, 8200.753977380688, 8240.21717936795, 2930.2088436122554, 3181.8568164432654, 3195.344954284366, 3208.98395508021, 3250.756193285513, 1010.5553556435145, 1102.3055475050828, 1118.848955391028, 1141.3437273567731, 1180.6103985684704, 26664.73335266661, 28391.716082838906, 28471.71528284732, 28638.28404289868, 29234.415311694072, 1040.8750949885912, 1073.2165519171049, 1115.9218854680257, 1148.6726283009302, 1161.7386088130104, 15880.126593037263, 16047.358105675643, 16293.918530407273, 16389.426370077228, 16517.174141292886, 353920.0, 360234.0, 360573.0, 360751.0, 361009.0, 52799.0, 54225.72887135618, 54419.0, 54473.0, 54493.0, 1349.811026456297, 1361.5642994241946, 1384.7715127004133, 1388.1116085704955, 1465.9633509162143, 29358.0, 30157.0, 30623.0, 30749.692503074682, 30805.383892322476, 47384.52615473939, 47704.7614761924, 47751.28373074337, 47928.5207147938, 47978.76010619925, 289100.0, 293492.0, 295081.0, 295091.0, 295413.0, 22877.88561057184, 23338.183163589194, 25150.496990060463, 27022.459550809268, 27368.58947115755, 39617.2076558473, 43617.563824362616, 43812.33764946184, 44180.7790961056, 45070.0, 36903.0, 36928.0, 37008.0, 37373.2525349486, 37587.248255035294, 34484.48273275853, 35316.293674126886, 35593.64406356007, 35596.28807423889, 37432.438513421774, 35411.645883540834, 36109.63890361063, 36122.27755444929, 36368.27263454663, 36513.087172820895, 31079.533806992462, 31331.686683132877, 31922.36155276835, 31943.361132777678, 33318.83340583282, 26388.868055659597, 26697.466050679268, 26866.865665671547, 26873.731262687124, 26884.462310753283], "value": 17496.453938718732, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.9247446747882, 397.3840547151915, 401.6024136105257, 404.106923698626, 408.6812286416594, 13810.654733631663, 14300.356483958221, 16973.915130424346, 17570.736438953427, 17581.20884560193, 12885.355732213398, 16561.83438165618, 16857.157142142903, 16886.74669879953, 16997.0, 5433.891322173564, 5520.365158006841, 5579.497845193931, 5584.0, 5617.241672374238, 4009.1981603679237, 4192.790360481979, 5468.6171967962255, 5619.775208991636, 5653.604247702662, 4185.91628167438, 5826.854328641797, 6093.299270583895, 6101.420365065312, 6101.938980610182, 6016.90974635383, 6078.574499785017, 6081.422264884829, 6093.482054025391, 6116.0, 5203.19350500673, 5342.786288548454, 5389.407165211824, 5411.18832175173, 5425.511703946664, 12128.757424851541, 19114.904425477922, 21019.0, 21027.5794484111, 21082.894585527127, 2093.152273329304, 2259.243153543565, 2321.3500219938446, 2643.127767836609, 2655.309619498925, 9291.76770580734, 9492.430454172772, 10112.94943525285, 11820.468078936468, 13847.099938503965, 1841.7513635659147, 1888.5845114074882, 1901.610169915178, 1989.7711763147133, 2029.2390353617393, 65675.34324656788, 68202.31797682059, 68229.3177068228, 68907.65546172287, 69411.3058869415, 10025.498725063717, 10115.089641932262, 10385.273030887765, 10540.0, 10683.73290667724, 14357.928210358881, 14558.781618275734, 14559.78160327596, 14578.854211457961, 14596.635084122981, 7203.639818009078, 7602.315791578784, 7808.102068262109, 7941.0, 8235.341172706288, 7707.884381734279, 7887.526748395, 7946.682132714626, 8049.27556519916, 8085.838283234302, 4555.886102847456, 4647.419072615923, 4653.464851542049, 4666.183417901853, 4666.510016448292, 1780.5606319342326, 1789.8210178981997, 1828.826261505155, 1830.9176087076114, 1880.3734769424623, 970.5542034074093, 1010.1111022300475, 1061.1881910338598, 1065.7655315830505, 1105.8728246251624, 17611.38360157414, 17689.823101768816, 17911.820881791016, 18118.45644630663, 18382.356617518322, 979.715882394112, 986.6694657289888, 988.4267125067587, 994.3039872089566, 1011.9544620492095, 7843.5293882366095, 10162.0, 10199.38803671782, 10261.076503114606, 10303.845442318372, 459080.0, 462711.0, 462921.0, 475938.0, 481181.0, 76553.61723191348, 76622.6168869152, 76626.0, 76791.61604191943, 77043.0, 980.2256217588168, 990.841465365538, 994.6966175316453, 1001.2540657210279, 1029.1920842138884, 15647.0, 15679.764803528184, 15763.684726305639, 16041.919790400972, 16312.836871631132, 34651.826740866134, 34941.0, 35106.64893351034, 35371.93884183479, 36074.63925360713, 35970.8201458991, 41484.377734334616, 42680.146397071265, 45724.31413528866, 50347.0, 7963.641636126273, 8157.102718701057, 8208.425410221227, 8322.58773902697, 8432.83134337322, 9025.774355641162, 11797.705057373634, 12650.557230496888, 12681.175723577939, 12708.110432269652, 11270.830429848724, 11274.0, 11279.09767218637, 11403.942980285046, 11588.536458541565, 10869.891301086887, 10888.94555527249, 10916.945415272872, 11029.669109926715, 11252.381119038531, 10791.244612877337, 10807.513661885077, 11111.166662500507, 11306.393029394796, 11434.71413214643, 8194.83610327802, 8417.0, 8489.915100848912, 8552.957235213784, 8591.570421479026, 11371.943140284577, 11385.544578216779, 11434.828477572677, 11598.304101753922, 11742.70643233926], "value": 8653.481797350627, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1300.174389262819, 1469.2580246975278, 1484.621421537508, 1614.2897125264883, 1750.5361079313975, 7626.389888808896, 7923.0, 7990.2409271119295, 8000.759977200679, 8007.279344858962, 7602.087749470057, 7758.456908016441, 7778.6888524458955, 7780.766577002685, 7792.883106753403, 1974.8025197480208, 2044.9795502044938, 2227.766084561122, 2237.2617036377997, 2276.2602154299834, 2253.8196944244423, 2258.2434884313775, 2259.7288325400973, 2261.6607508873717, 2264.739554951177, 2266.7506574276817, 2275.2377953385635, 2302.113686230805, 2302.804261637763, 2304.9423764405856, 1898.810118988097, 2141.336185782397, 2205.71325727656, 2217.102073660162, 2218.833587480929, 2207.1061220205843, 2214.867107973527, 2232.821374290053, 2238.865668059905, 2240.6190947538958, 8188.959055204686, 8266.917330826675, 8268.958655206745, 8282.958585207096, 8289.129641387688, 4888.266759985995, 5060.2662613920775, 5071.18860982241, 5076.086304465195, 5084.44071152173, 3105.223694076481, 3118.781685282031, 3184.68153184682, 3252.1869532616847, 3265.738740900746, 975.7267964969819, 995.4127065031666, 1007.3754272351116, 2072.1814883121083, 2114.7356580427445, 10421.947890260575, 10475.214358923111, 10485.790284194274, 10492.685219443429, 10496.475176241234, 4136.338185890303, 4429.870383052301, 4579.267317229294, 4610.631149508032, 4616.0767846430845, 8650.221480066699, 8655.48067115975, 8705.738827835175, 8709.216170544682, 8739.12608739121, 4886.364772579542, 4891.584215341664, 4894.143524883131, 4905.681130726492, 4906.435759887588, 4110.157417729359, 4460.397846290774, 4559.772011399483, 4563.178627846953, 4568.70303430276, 3560.91097722559, 3649.835757390924, 3688.0964163780045, 3702.426123950792, 3702.7593206441493, 1150.3902931446346, 1152.2913408253864, 1166.1894982986912, 1169.8128299472044, 1175.13040350142, 938.1462868789368, 945.9905400945902, 956.1967946924617, 969.1277849935115, 987.1362557761959, 5282.97358513205, 5450.700211488406, 5554.527865131509, 5640.294963129609, 5698.373178950312, 860.1699360117392, 915.624593916491, 945.8155659646441, 972.5817898303798, 978.1685567267765, 3736.532933383327, 3779.9244015119543, 3858.112634094174, 3895.5520115187114, 3947.4276229946495, 9647.421154730739, 9764.218862490983, 9879.654212102541, 9923.851142232872, 10030.147437467896, 9746.707598772047, 9953.900460995443, 10105.292629515863, 10238.590456381662, 10294.382337059651, 7266.818329541804, 7772.22277772207, 7819.687212511436, 7886.64510097047, 7897.24976127267, 5539.861503462445, 5573.3869274380595, 5609.775608975595, 5612.85967850807, 5798.362180160263, 8801.295896328407, 9236.861447078165, 9423.246140308896, 9430.151286384258, 9437.19783818383, 9243.352965292364, 9324.860127098234, 9380.827396575429, 9479.715608531755, 9637.807243854942, 6232.594881332699, 6702.19573651165, 6884.724611015503, 6940.13248343957, 7006.789796306119, 7916.168802275678, 7950.24472675095, 7996.200379961957, 8017.078036025931, 8050.597470126353, 7107.111611048619, 7177.1746249182015, 7201.783946481614, 7266.455015873937, 7480.588567628833, 6861.519693621399, 6963.651817409211, 7275.345218930322, 7317.853642927218, 7444.404447644284, 6473.676316184266, 6511.446527045254, 6517.511186661114, 6530.869382612226, 6537.378948999837, 4758.785854636619, 4823.421189457287, 4830.686005409637, 4867.5132486751045, 4909.779059942382, 4856.441509226484, 4919.286703428054, 4952.5542701157065, 4960.8759781005765, 5034.748262586929], "value": 4367.001189993628, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.94492936200845, 331.3737037000069, 332.154666374078, 335.53193295352975, 336.9747268954829, 5326.440723724011, 5362.731863406829, 5404.540614047801, 5408.701911541227, 5415.323084614423, 5264.447233040533, 5282.31329927109, 5297.867553311159, 5307.628466007381, 5341.798095428537, 3982.462367580383, 3998.4202290667836, 4018.0, 4042.636162745367, 4102.323116685743, 3921.6274453926976, 4184.205001049806, 4208.642265407444, 4210.757826441207, 4212.756177743136, 4124.989377602492, 4176.415301857743, 4177.16456708658, 4189.664826813862, 4196.454460920091, 3917.5298964124486, 4038.697097717683, 4142.378643203529, 4182.393552934823, 4191.392248124035, 3657.0674478008204, 3663.1757854482794, 3673.1000904778234, 3679.3193259247123, 3698.2973235085515, 5037.622178336639, 5060.316857224301, 5077.619178561623, 5111.386633603955, 5119.488051194888, 4380.408644832939, 4724.527547245282, 4741.762911854394, 4745.311929770199, 4746.430428348585, 5524.613277070606, 5537.307836520435, 5549.5837812163845, 5564.527015203713, 5590.468905454016, 3853.7880416577077, 3872.206197729459, 3875.4380614810975, 3885.436611691317, 3896.0649444133487, 5235.712035838065, 5469.316335458067, 5704.543636509069, 5781.768729250825, 5825.7378417971295, 3968.861089861841, 4071.2671719090254, 4079.836806527765, 4094.28350038742, 4099.241640296555, 4119.835206591702, 4138.668371960541, 4150.335946248586, 4162.167566486714, 4168.562300958356, 4726.550977657117, 4733.077049975291, 4738.73936933465, 4753.857384278477, 4754.453237877619, 5463.836084917459, 5582.106862901997, 5589.469000445032, 5608.719564021782, 5640.407757185437, 1535.063611197169, 1542.2597153366446, 1542.4293011585785, 1548.5509202331423, 1554.35494269879, 1020.505055048301, 1050.795094956476, 1052.7210289273348, 1055.9524821383056, 1069.385103565453, 5757.050086735725, 5775.0, 5785.074388097884, 5813.970930145407, 5823.679697616587, 6186.226721659793, 6189.938100619026, 6200.627962322275, 6201.875962480815, 6206.224221972254, 5257.5005374489365, 5540.869408784105, 5547.972260138754, 5556.611037227355, 5797.449242321973, 3325.833708314575, 3327.251368442081, 3334.7832390894514, 3343.13078599561, 3351.8826841060445, 6384.201974753156, 6485.221773387129, 6523.739050438025, 6532.216134063943, 6542.280349161589, 6345.904811427832, 6356.586821856565, 6374.235091788923, 6374.394432528902, 6407.423331900151, 5661.915071273934, 5725.1698503716725, 5952.851178720567, 6433.163688720437, 6475.514336424787, 5742.712864356849, 5754.4533269339345, 5755.65466072037, 5769.480746732646, 5771.874484475487, 5465.638632241223, 5625.240592519957, 5675.687837168995, 5726.112452569859, 5742.16738572913, 5928.940710593011, 5945.554083443672, 5946.43508866657, 5951.642901425928, 6012.729427175875, 4031.4759081320412, 4048.595140485928, 4057.2696914555663, 4080.3267460868624, 4110.835566577303, 5511.145772405283, 5741.224934633771, 5741.650712082574, 5753.597248192586, 5806.361300256884, 5607.243022192115, 5629.211910332475, 5632.408597097409, 5633.6619802811965, 5640.60515763909, 5553.305836770403, 5570.164475328733, 5615.747291371817, 5616.775328986795, 5684.237886255274, 5322.121849894724, 5418.965379387556, 5424.349078110652, 5441.537469314994, 5496.148097044965, 5598.580106492111, 5598.944010560005, 5630.18362337467, 5631.408702086386, 5635.380108188014, 5299.390570084335, 5490.478404551562, 5501.889962200654, 5512.586556008396, 5556.222128902038], "value": 4328.4965351954215, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [724.9275072492751, 742.5804420502419, 748.947573669843, 751.2374939436471, 803.3171803966629, 13265.469381224751, 13461.125026873246, 13530.594082177526, 13597.999999999987, 13631.454741810328, 12816.487340506368, 12928.806067908989, 12984.675383115427, 12985.09104362695, 13005.219686818797, 664.4684252597926, 765.1430397954272, 801.2068052627915, 801.6793282686914, 803.2529747334976, 791.9049714034295, 796.2594786848229, 797.9985118676053, 798.1978111997435, 798.5448294472153, 705.0552259971637, 841.5329492131895, 842.9620667069966, 845.5729856422498, 850.9872351914727, 720.0890873045602, 725.1733024352243, 820.9138040505751, 849.3375167369462, 850.9234168924764, 625.0780099353462, 625.3184029407922, 625.8654389306275, 626.6553395632384, 627.1282916745727, 12699.555515557004, 12720.491180352774, 12758.872411275861, 12773.808392874114, 12784.849363557232, 13155.40800663963, 14010.92994535031, 14252.714945701027, 14270.215138167398, 14455.13269203851, 11427.486712224772, 11662.300261984308, 11703.648890533212, 11850.762984740342, 11856.703582410422, 3825.2731980923536, 3874.8643797467234, 3899.3760998240145, 3984.860529881469, 3985.860494882665, 54820.72589637026, 55464.72267638636, 56446.0, 56887.715561422345, 57107.71446142743, 10829.729256768644, 10898.94550527258, 10941.0, 11102.888971110186, 11169.106471482262, 19750.209991600463, 19757.308494202633, 19764.209431622574, 19766.50583735418, 19777.0, 8376.162383761575, 8393.958030209931, 8482.915170848213, 8671.739847804576, 8780.209781119729, 4925.236588328815, 4983.551480366785, 5008.273800298936, 5028.069807085701, 5039.899202016012, 3290.1610089427045, 3359.5800524934384, 3362.0586235854, 3369.5619569456303, 3377.67912048355, 531.9281896943941, 580.4398755201252, 587.4595372257534, 598.8592680720027, 600.534585696089, 628.6416742456847, 734.4711807498593, 740.5667684404683, 741.6440108747723, 760.7451503746196, 8705.347098967603, 8763.912360876437, 8896.955515222511, 9014.86477702835, 9161.267098632094, 695.8156088636515, 735.2427697802257, 739.4971419434836, 766.3141488367991, 778.7897267737792, 4215.367694845798, 4305.9569404306185, 4345.239583072949, 4353.9129217415475, 4533.229351010336, 63451.682741585995, 66217.33782662208, 66284.33715662878, 66718.33281667122, 66833.6658316715, 55851.162232566545, 56809.431905680416, 57023.71488142616, 57215.0, 59173.40826591679, 50769.49230507648, 51030.0, 52882.73558632259, 53556.0, 53824.19263710969, 8769.649214031368, 8960.103989601248, 8967.730968070968, 9046.23107035883, 9125.269978401844, 32485.350292993535, 33429.997100087036, 33479.49780753339, 34059.65940340565, 34288.65711342855, 46120.53879461296, 46190.53809461863, 46742.76628616835, 46930.530694692614, 47324.2901356473, 11969.10231732641, 12158.574449894211, 12165.391730413621, 12171.208871423683, 12361.93819030899, 13339.933300333436, 13642.522511712043, 13735.175889446666, 13758.793618095537, 14048.086874353134, 12419.0, 12569.0, 12959.0, 13041.478340866259, 13270.1374410663, 12633.305168215837, 12840.0, 12899.226046436868, 13188.472461101448, 13197.0, 12543.56097536582, 12547.24716517012, 13216.207027578375, 13347.66630834237, 13475.865241347854, 10974.341539507655, 11014.44927753625, 11291.266067705574, 11365.659030229106, 11608.361540115036, 10571.0, 10693.198010149114, 10768.300060496043, 10882.0, 10960.252554127555], "value": 6743.234725041806, "unit": "score"}], "name": "dromaeo_css", "value": 6804.636632317352, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 106.0, 111.0, 114.0, 113.0, 100.0, 112.0, 111.0, 112.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 128.0, 155.0, 188.0, 126.0, 153.0, 153.0, 136.0, 195.0, 132.0], "value": 152.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 161.0, 160.0, 161.0, 164.0, 161.0, 160.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 100.0, 112.0, 77.0, 77.0, 73.0, 112.0, 105.0, 77.0], "value": 88.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 146.0, 93.0, 93.0, 94.0, 154.0, 93.0, 93.0, 145.0], "value": 109.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 118.0, 118.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 147.0, 146.0, 147.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 96.0, 95.0, 94.0, 94.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 58.0, 58.0, 56.0, 58.0, 59.0, 73.0, 55.0, 56.0], "value": 58.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 61.0, 61.0, 60.0, 61.0, 61.0, 61.0, 61.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 74.0, 77.0, 77.0, 77.0, 77.0, 77.0, 78.0, 79.0], "value": 76.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 136.0, 127.0, 126.0, 127.0, 134.0, 127.0, 135.0, 158.0, 128.0], "value": 133.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [206.0, 200.0, 204.0, 203.0, 212.0, 202.0, 209.0, 208.0, 206.0, 208.0], "value": 205.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 71.0, 70.0, 70.0, 71.0, 69.0, 71.0, 68.0, 70.0, 69.0], "value": 70.2, "unit": "score"}], "name": "kraken", "value": 1583.8, "alertThreshold": 2.0}]} 01:29:37 INFO - Return code: 0 01:29:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:29:37 ERROR - # TBPL SUCCESS # 01:29:37 INFO - Running post-action listener: _resource_record_post_action 01:29:37 INFO - Running post-run listener: _resource_record_post_run 01:29:38 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 534769664; Read time: 0; Write time: 1374264 01:29:38 INFO - install - Wall time: 17s; CPU: 21.0%; Read bytes: 0; Write bytes: 250875904; Read time: 0; Write time: 893236 01:29:38 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 283893760; Read time: 0; Write time: 481028 01:29:38 INFO - Running post-run listener: _upload_blobber_files 01:29:38 INFO - Blob upload gear active. 01:29:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:29:38 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 01:29:38 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-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:29:38 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-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:29:39 INFO - (blobuploader) - INFO - Open directory for files ... 01:29:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:29:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:29:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:29:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:29:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:29:40 INFO - (blobuploader) - INFO - Done attempting. 01:29:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:29:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:29:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:29:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:29:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:29:40 INFO - (blobuploader) - INFO - Done attempting. 01:29:40 INFO - (blobuploader) - INFO - Iteration through files over. 01:29:40 INFO - Return code: 0 01:29:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:29:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:29:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/692f716bd3836c3588cc5289afec64c8ab8d5d7afb4931770db402a055b9c76df879a8af6e06c5e5f971a456aa51f4915a49f18c8628dac96138563da3e6f7c8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/990f3a13e0ff7d3b14f5d4c7990aecbc5cd5de8e90b5b246ded983d7fff3ee66e77e18830e6f4beb052d02b217c718368df5f8cbfe5c9d94bacd2126e6809bec"} 01:29:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:29:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:29:40 INFO - Contents: 01:29:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/692f716bd3836c3588cc5289afec64c8ab8d5d7afb4931770db402a055b9c76df879a8af6e06c5e5f971a456aa51f4915a49f18c8628dac96138563da3e6f7c8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/990f3a13e0ff7d3b14f5d4c7990aecbc5cd5de8e90b5b246ded983d7fff3ee66e77e18830e6f4beb052d02b217c718368df5f8cbfe5c9d94bacd2126e6809bec"} 01:29:40 INFO - Running post-run listener: copy_logs_to_upload_dir 01:29:40 INFO - Copying logs to upload dir... 01:29:40 INFO - mkdir: /builds/slave/test/build/upload/logs 01:29:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.699732 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-04-27 01:29:39.915508) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 01:29:39.919108) ========= 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=af724c981e2a0f424dbabf99000001e7-1461739840.556753-192799357 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-Inbound/sha512/692f716bd3836c3588cc5289afec64c8ab8d5d7afb4931770db402a055b9c76df879a8af6e06c5e5f971a456aa51f4915a49f18c8628dac96138563da3e6f7c8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/990f3a13e0ff7d3b14f5d4c7990aecbc5cd5de8e90b5b246ded983d7fff3ee66e77e18830e6f4beb052d02b217c718368df5f8cbfe5c9d94bacd2126e6809bec"} build_url:https://queue.taskcluster.net/v1/task/JWfdUPohQT-NGY-7s2g9gQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011267 build_url: 'https://queue.taskcluster.net/v1/task/JWfdUPohQT-NGY-7s2g9gQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/692f716bd3836c3588cc5289afec64c8ab8d5d7afb4931770db402a055b9c76df879a8af6e06c5e5f971a456aa51f4915a49f18c8628dac96138563da3e6f7c8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/990f3a13e0ff7d3b14f5d4c7990aecbc5cd5de8e90b5b246ded983d7fff3ee66e77e18830e6f4beb052d02b217c718368df5f8cbfe5c9d94bacd2126e6809bec"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 01:29:39.943651) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 01:29:39.943985) ========= 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=af724c981e2a0f424dbabf99000001e7-1461739840.556753-192799357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004469 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 01:29:40.027492) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 01:29:40.027872) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 01:29:40.028197) ========= ========= Total master_lag: 1.11 =========