builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-001 starttime: 1461949906.68 results: success (0) buildid: 20160429073752 builduid: 1c94cb38644248968b22694c87c7ac9c revision: 57e54fef9cf2ebe21eb7d928ed6d5e1d2d180a79 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 10:11:46.684502) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 10:11:46.684886) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 10:11:46.685159) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 10:11:46.706253) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 10:11:46.706530) ========= 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=8887e36bb8e381bfd44124ac000001a8-1461943084.578579-204733650 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-29 10:11:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.2M=0s 2016-04-29 10:11:47 (38.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.077596 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 10:11:46.797269) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 10:11:46.797566) ========= 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=8887e36bb8e381bfd44124ac000001a8-1461943084.578579-204733650 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017509 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 10:11:46.847554) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 10:11:46.847926) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 57e54fef9cf2ebe21eb7d928ed6d5e1d2d180a79 --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 57e54fef9cf2ebe21eb7d928ed6d5e1d2d180a79 --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=8887e36bb8e381bfd44124ac000001a8-1461943084.578579-204733650 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-29 10:11:47,169 truncating revision to first 12 chars 2016-04-29 10:11:47,169 Setting DEBUG logging. 2016-04-29 10:11:47,169 attempt 1/10 2016-04-29 10:11:47,169 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/57e54fef9cf2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-29 10:11:47,502 unpacking tar archive at: mozilla-inbound-57e54fef9cf2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.596013 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 10:11:47.456800) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 10:11:47.457122) ========= script_repo_revision: 57e54fef9cf2ebe21eb7d928ed6d5e1d2d180a79 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 10:11:47.457625) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 10:11:47.457924) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 10:11:47.465673) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-04-29 10:11:47.465964) ========= /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=8887e36bb8e381bfd44124ac000001a8-1461943084.578579-204733650 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:11:47 INFO - MultiFileLogger online at 20160429 10:11:47 in /builds/slave/test 10:11:47 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 10:11:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:11:47 INFO - {'append_to_log': False, 10:11:47 INFO - 'base_work_dir': '/builds/slave/test', 10:11:47 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 10:11:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:11:47 INFO - 'branch': 'Mozilla-Inbound', 10:11:47 INFO - 'buildbot_json_path': 'buildprops.json', 10:11:47 INFO - 'config_files': ('talos/linux_config.py',), 10:11:47 INFO - 'default_actions': ('clobber', 10:11:47 INFO - 'read-buildbot-config', 10:11:47 INFO - 'download-and-extract', 10:11:47 INFO - 'populate-webroot', 10:11:47 INFO - 'create-virtualenv', 10:11:47 INFO - 'install', 10:11:47 INFO - 'run-tests'), 10:11:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:11:47 INFO - 'download_minidump_stackwalk': True, 10:11:47 INFO - 'download_symbols': 'ondemand', 10:11:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:11:47 INFO - 'tooltool.py': '/tools/tooltool.py', 10:11:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:11:47 INFO - '/tools/misc-python/virtualenv.py')}, 10:11:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:11:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:11:47 INFO - 'installer_path': 'installer.exe', 10:11:47 INFO - 'log_level': 'info', 10:11:47 INFO - 'log_name': 'talos', 10:11:47 INFO - 'log_to_console': True, 10:11:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:11:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:11:47 INFO - 'opt_config_files': (), 10:11:47 INFO - 'pip_index': False, 10:11:47 INFO - 'sps_profile': False, 10:11:47 INFO - 'sps_profile_interval': 0, 10:11:47 INFO - 'suite': 'dromaeojs', 10:11:47 INFO - 'system_bits': '32', 10:11:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:11:47 INFO - 'title': 'talos-linux64-ix-001', 10:11:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:11:47 INFO - 'use_talos_json': True, 10:11:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:11:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:11:47 INFO - 'work_dir': 'build'} 10:11:47 INFO - ##### 10:11:47 INFO - ##### Running clobber step. 10:11:47 INFO - ##### 10:11:47 INFO - Running pre-action listener: _resource_record_pre_action 10:11:47 INFO - Running main action method: clobber 10:11:47 INFO - rmtree: /builds/slave/test/build 10:11:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:11:48 INFO - Running post-action listener: _resource_record_post_action 10:11:48 INFO - ##### 10:11:48 INFO - ##### Running read-buildbot-config step. 10:11:48 INFO - ##### 10:11:48 INFO - Running pre-action listener: _resource_record_pre_action 10:11:48 INFO - Running main action method: read_buildbot_config 10:11:48 INFO - Using buildbot properties: 10:11:48 INFO - { 10:11:48 INFO - "project": "", 10:11:48 INFO - "product": "firefox", 10:11:48 INFO - "script_repo_revision": "production", 10:11:48 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 10:11:48 INFO - "repository": "", 10:11:48 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 10:11:48 INFO - "buildid": "20160429073752", 10:11:48 INFO - "pgo_build": "True", 10:11:48 INFO - "basedir": "/builds/slave/test", 10:11:48 INFO - "buildnumber": 1765, 10:11:48 INFO - "slavename": "talos-linux64-ix-001", 10:11:48 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:11:48 INFO - "platform": "ubuntu64_hw", 10:11:48 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 10:11:48 INFO - "branch": "mozilla-inbound", 10:11:48 INFO - "repo_path": "integration/mozilla-inbound", 10:11:48 INFO - "revision": "57e54fef9cf2ebe21eb7d928ed6d5e1d2d180a79", 10:11:48 INFO - "stage_platform": "linux64-pgo", 10:11:48 INFO - "builduid": "1c94cb38644248968b22694c87c7ac9c", 10:11:48 INFO - "slavebuilddir": "test" 10:11:48 INFO - } 10:11:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/MdnBDEUKSD6hQqW4QTb3Pg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 10:11:48 INFO - Running post-action listener: _resource_record_post_action 10:11:48 INFO - ##### 10:11:48 INFO - ##### Running download-and-extract step. 10:11:48 INFO - ##### 10:11:48 INFO - Running pre-action listener: _resource_record_pre_action 10:11:48 INFO - Running main action method: download_and_extract 10:11:48 INFO - mkdir: /builds/slave/test/build/tests 10:11:48 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')]} 10:11:48 INFO - https://queue.taskcluster.net/v1/task/MdnBDEUKSD6hQqW4QTb3Pg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:11:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdnBDEUKSD6hQqW4QTb3Pg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:11:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdnBDEUKSD6hQqW4QTb3Pg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:11:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdnBDEUKSD6hQqW4QTb3Pg/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 10:11:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdnBDEUKSD6hQqW4QTb3Pg/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 10:11:55 INFO - Downloaded 1361 bytes. 10:11:55 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:11:55 INFO - Using the following test package requirements: 10:11:55 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:11:55 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:11:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:11:55 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:11:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:11:55 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:11:55 INFO - u'jsshell-linux-x86_64.zip'], 10:11:55 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:11:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:11:55 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:11:55 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:11:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:11:55 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:11:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:11:55 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:11:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:11:55 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:11:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:11:55 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:11:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:55 INFO - https://queue.taskcluster.net/v1/task/MdnBDEUKSD6hQqW4QTb3Pg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:11:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdnBDEUKSD6hQqW4QTb3Pg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:11:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdnBDEUKSD6hQqW4QTb3Pg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:11:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdnBDEUKSD6hQqW4QTb3Pg/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 10:11:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdnBDEUKSD6hQqW4QTb3Pg/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 10:12:02 INFO - Downloaded 23877441 bytes. 10:12:02 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'] 10:12:02 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 10:12:03 INFO - Return code: 0 10:12:03 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 10:12:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:03 INFO - https://queue.taskcluster.net/v1/task/MdnBDEUKSD6hQqW4QTb3Pg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:12:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdnBDEUKSD6hQqW4QTb3Pg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:12:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdnBDEUKSD6hQqW4QTb3Pg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:12:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdnBDEUKSD6hQqW4QTb3Pg/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 10:12:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdnBDEUKSD6hQqW4QTb3Pg/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 10:12:04 INFO - Downloaded 23877441 bytes. 10:12:04 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'] 10:12:04 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 10:12:05 INFO - Return code: 0 10:12:05 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')]} 10:12:05 INFO - https://queue.taskcluster.net/v1/task/MdnBDEUKSD6hQqW4QTb3Pg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:12:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdnBDEUKSD6hQqW4QTb3Pg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:12:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdnBDEUKSD6hQqW4QTb3Pg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:12:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdnBDEUKSD6hQqW4QTb3Pg/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 10:12:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdnBDEUKSD6hQqW4QTb3Pg/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 10:12:06 INFO - Downloaded 10840145 bytes. 10:12:06 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'] 10:12:06 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 10:12:07 INFO - Return code: 0 10:12: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')]} 10:12:07 INFO - https://queue.taskcluster.net/v1/task/MdnBDEUKSD6hQqW4QTb3Pg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:12:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdnBDEUKSD6hQqW4QTb3Pg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:12:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdnBDEUKSD6hQqW4QTb3Pg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:12:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdnBDEUKSD6hQqW4QTb3Pg/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 10:12:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdnBDEUKSD6hQqW4QTb3Pg/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 10:12:08 INFO - Downloaded 58606640 bytes. 10:12:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MdnBDEUKSD6hQqW4QTb3Pg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:12:08 INFO - mkdir: /builds/slave/test/properties 10:12:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:12:08 INFO - Writing to file /builds/slave/test/properties/build_url 10:12:08 INFO - Contents: 10:12:08 INFO - build_url:https://queue.taskcluster.net/v1/task/MdnBDEUKSD6hQqW4QTb3Pg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:12:09 INFO - Running post-action listener: _resource_record_post_action 10:12:09 INFO - Running post-action listener: set_extra_try_arguments 10:12:09 INFO - ##### 10:12:09 INFO - ##### Running populate-webroot step. 10:12:09 INFO - ##### 10:12:09 INFO - Running pre-action listener: _resource_record_pre_action 10:12:09 INFO - Running main action method: populate_webroot 10:12:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:12:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:12:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:12:09 INFO - '--tppagecycles', 10:12:09 INFO - '7'], 10:12:09 INFO - 'tests': ['tsvgm']}}, 10:12:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:12:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:12:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:12:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:12:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:12:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:12:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:09 INFO - 'talos_options': ['--disable-e10s'], 10:12:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:12:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:12:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:09 INFO - 'talos_options': ['--disable-e10s'], 10:12:09 INFO - 'tests': ['damp', 'tps']}, 10:12:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:09 INFO - 'tests': ['damp', 'tps']}, 10:12:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:12:09 INFO - 'tests': ['dromaeo_dom']}, 10:12:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:12:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:12:09 INFO - 'tests': ['a11yr', 10:12:09 INFO - 'ts_paint', 10:12:09 INFO - 'tpaint', 10:12:09 INFO - 'sessionrestore', 10:12:09 INFO - 'sessionrestore_no_auto_restore', 10:12:09 INFO - 'tabpaint']}, 10:12:09 INFO - 'other-e10s': {'tests': ['a11yr', 10:12:09 INFO - 'ts_paint', 10:12:09 INFO - 'tpaint', 10:12:09 INFO - 'sessionrestore', 10:12:09 INFO - 'sessionrestore_no_auto_restore', 10:12:09 INFO - 'tabpaint']}, 10:12:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:12:09 INFO - 'ts_paint', 10:12:09 INFO - 'tpaint', 10:12:09 INFO - 'sessionrestore', 10:12:09 INFO - 'sessionrestore_no_auto_restore', 10:12:09 INFO - 'tabpaint']}, 10:12:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:12:09 INFO - 'ts_paint', 10:12:09 INFO - 'tpaint', 10:12:09 INFO - 'sessionrestore', 10:12:09 INFO - 'sessionrestore_no_auto_restore', 10:12:09 INFO - 'tabpaint']}, 10:12:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:12:09 INFO - 'tests': ['a11yr', 10:12:09 INFO - 'ts_paint', 10:12:09 INFO - 'tpaint', 10:12:09 INFO - 'sessionrestore', 10:12:09 INFO - 'sessionrestore_no_auto_restore', 10:12:09 INFO - 'tabpaint']}, 10:12:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:12:09 INFO - 'tests': ['a11yr', 10:12:09 INFO - 'ts_paint', 10:12:09 INFO - 'tpaint', 10:12:09 INFO - 'sessionrestore', 10:12:09 INFO - 'sessionrestore_no_auto_restore', 10:12:09 INFO - 'tabpaint']}, 10:12:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:12:09 INFO - 'tests': ['tsvgx', 10:12:09 INFO - 'tsvgr_opacity', 10:12:09 INFO - 'tart', 10:12:09 INFO - 'tscrollx', 10:12:09 INFO - 'cart']}, 10:12:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:12:09 INFO - 'tsvgr_opacity', 10:12:09 INFO - 'tart', 10:12:09 INFO - 'tscrollx', 10:12:09 INFO - 'cart']}, 10:12:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:09 INFO - 'talos_options': ['--disable-e10s'], 10:12:09 INFO - 'tests': ['tp5o']}, 10:12:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:09 INFO - 'tests': ['tp5o']}, 10:12:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:09 INFO - 'talos_options': ['--disable-e10s', 10:12:09 INFO - '--xperf_path', 10:12:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:12:09 INFO - 'tests': ['tp5n']}, 10:12:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:09 INFO - 'talos_options': ['--xperf_path', 10:12:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:12:09 INFO - 'tests': ['tp5n']}}, 10:12:09 INFO - 'talos.zip': {'path': '', 10:12:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:12:09 INFO - Running post-action listener: _resource_record_post_action 10:12:09 INFO - ##### 10:12:09 INFO - ##### Running create-virtualenv step. 10:12:09 INFO - ##### 10:12:09 INFO - Running pre-action listener: _resource_record_pre_action 10:12:09 INFO - Running main action method: create_virtualenv 10:12:09 INFO - Creating virtualenv /builds/slave/test/build/venv 10:12:09 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 10:12:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:12:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:12:09 INFO - Using real prefix '/usr' 10:12:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:12:10 INFO - Installing distribute.............................................................................................................................................................................................done. 10:12:12 INFO - Installing pip.................done. 10:12:12 INFO - Return code: 0 10:12:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:12:12 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')]} 10:12:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:12 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')]} 10:12:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:12 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 0x7f43ec874f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dda5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e69410>, '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 0x1e6a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a7a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1461943084.578579-204733650', '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 10:12:12 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 10:12:12 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 10:12:12 INFO - Using env: {'DISPLAY': ':0', 10:12:12 INFO - 'HOME': '/home/cltbld', 10:12:12 INFO - 'LANG': 'en_US.UTF-8', 10:12:12 INFO - 'LANGUAGE': 'en_US:en', 10:12:12 INFO - 'LOGNAME': 'cltbld', 10:12:12 INFO - 'MAIL': '/var/mail/cltbld', 10:12:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:12 INFO - 'MOZ_NO_REMOTE': '1', 10:12:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:12 INFO - 'NO_EM_RESTART': '1', 10:12:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:12 INFO - 'PWD': '/builds/slave/test', 10:12:12 INFO - 'SHELL': '/bin/bash', 10:12:12 INFO - 'SHLVL': '1', 10:12:12 INFO - 'TERM': 'linux', 10:12:12 INFO - 'TMOUT': '86400', 10:12:12 INFO - 'USER': 'cltbld', 10:12:12 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461943084.578579-204733650', 10:12:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:12 INFO - '_': '/tools/buildbot/bin/python'} 10:12:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:12 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 10:12:12 INFO - Cleaning up... 10:12:12 INFO - Return code: 0 10:12:12 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:12:12 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')]} 10:12:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:12 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')]} 10:12:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:12 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 0x7f43ec874f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dda5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e69410>, '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 0x1e6a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a7a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1461943084.578579-204733650', '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 10:12:12 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 10:12:12 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 10:12:12 INFO - Using env: {'DISPLAY': ':0', 10:12:12 INFO - 'HOME': '/home/cltbld', 10:12:12 INFO - 'LANG': 'en_US.UTF-8', 10:12:12 INFO - 'LANGUAGE': 'en_US:en', 10:12:12 INFO - 'LOGNAME': 'cltbld', 10:12:12 INFO - 'MAIL': '/var/mail/cltbld', 10:12:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:12 INFO - 'MOZ_NO_REMOTE': '1', 10:12:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:12 INFO - 'NO_EM_RESTART': '1', 10:12:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:12 INFO - 'PWD': '/builds/slave/test', 10:12:12 INFO - 'SHELL': '/bin/bash', 10:12:12 INFO - 'SHLVL': '1', 10:12:12 INFO - 'TERM': 'linux', 10:12:12 INFO - 'TMOUT': '86400', 10:12:12 INFO - 'USER': 'cltbld', 10:12:12 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461943084.578579-204733650', 10:12:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:12 INFO - '_': '/tools/buildbot/bin/python'} 10:12:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:12 INFO - Downloading/unpacking psutil>=0.7.1 10:12:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:12:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:12:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:12:14 INFO - Installing collected packages: psutil 10:12:14 INFO - Running setup.py install for psutil 10:12:14 INFO - building 'psutil._psutil_linux' extension 10:12:14 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 10:12:14 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 10:12:14 INFO - building 'psutil._psutil_posix' extension 10:12:14 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 10:12:14 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 10:12:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:12:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:12:14 INFO - Successfully installed psutil 10:12:14 INFO - Cleaning up... 10:12:14 INFO - Return code: 0 10:12:14 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:12:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:14 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 0x7f43ec874f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dda5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e69410>, '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 0x1e6a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a7a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1461943084.578579-204733650', '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 10:12:14 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 10:12:14 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 10:12:14 INFO - Using env: {'DISPLAY': ':0', 10:12:14 INFO - 'HOME': '/home/cltbld', 10:12:14 INFO - 'LANG': 'en_US.UTF-8', 10:12:14 INFO - 'LANGUAGE': 'en_US:en', 10:12:14 INFO - 'LOGNAME': 'cltbld', 10:12:14 INFO - 'MAIL': '/var/mail/cltbld', 10:12:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:14 INFO - 'MOZ_NO_REMOTE': '1', 10:12:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:14 INFO - 'NO_EM_RESTART': '1', 10:12:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:14 INFO - 'PWD': '/builds/slave/test', 10:12:14 INFO - 'SHELL': '/bin/bash', 10:12:14 INFO - 'SHLVL': '1', 10:12:14 INFO - 'TERM': 'linux', 10:12:14 INFO - 'TMOUT': '86400', 10:12:14 INFO - 'USER': 'cltbld', 10:12:14 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461943084.578579-204733650', 10:12:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:14 INFO - '_': '/tools/buildbot/bin/python'} 10:12:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:15 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:12:15 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 10:12:15 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 10:12:15 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 10:12:15 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 10:12:15 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 10:12:15 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 10:12:17 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:12:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:12:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:12:17 INFO - Installing collected packages: mozsystemmonitor 10:12:17 INFO - Running setup.py install for mozsystemmonitor 10:12:17 INFO - Successfully installed mozsystemmonitor 10:12:17 INFO - Cleaning up... 10:12:17 INFO - Return code: 0 10:12:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:12:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:17 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 0x7f43ec874f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dda5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e69410>, '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 0x1e6a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a7a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1461943084.578579-204733650', '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 10:12:17 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 10:12:17 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 10:12:17 INFO - Using env: {'DISPLAY': ':0', 10:12:17 INFO - 'HOME': '/home/cltbld', 10:12:17 INFO - 'LANG': 'en_US.UTF-8', 10:12:17 INFO - 'LANGUAGE': 'en_US:en', 10:12:17 INFO - 'LOGNAME': 'cltbld', 10:12:17 INFO - 'MAIL': '/var/mail/cltbld', 10:12:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:17 INFO - 'MOZ_NO_REMOTE': '1', 10:12:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:17 INFO - 'NO_EM_RESTART': '1', 10:12:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:17 INFO - 'PWD': '/builds/slave/test', 10:12:17 INFO - 'SHELL': '/bin/bash', 10:12:17 INFO - 'SHLVL': '1', 10:12:17 INFO - 'TERM': 'linux', 10:12:17 INFO - 'TMOUT': '86400', 10:12:17 INFO - 'USER': 'cltbld', 10:12:17 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461943084.578579-204733650', 10:12:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:17 INFO - '_': '/tools/buildbot/bin/python'} 10:12:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:17 INFO - Downloading/unpacking blobuploader==1.2.4 10:12:17 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 10:12:17 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 10:12:17 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 10:12:17 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 10:12:17 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 10:12:17 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 10:12:19 INFO - Downloading blobuploader-1.2.4.tar.gz 10:12:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:12:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:12:19 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 10:12:19 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 10:12:19 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 10:12:19 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 10:12:19 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 10:12:19 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 10:12:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:12:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:12:19 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 10:12:19 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 10:12:19 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 10:12:19 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 10:12:19 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 10:12:19 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 10:12:19 INFO - Downloading docopt-0.6.1.tar.gz 10:12:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:12:20 INFO - Installing collected packages: blobuploader, requests, docopt 10:12:20 INFO - Running setup.py install for blobuploader 10:12:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:12:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:12:20 INFO - Running setup.py install for requests 10:12:20 INFO - Running setup.py install for docopt 10:12:20 INFO - Successfully installed blobuploader requests docopt 10:12:20 INFO - Cleaning up... 10:12:20 INFO - Return code: 0 10:12:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:12:20 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')]} 10:12:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:20 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')]} 10:12:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:20 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 0x7f43ec874f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dda5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e69410>, '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 0x1e6a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a7a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1461943084.578579-204733650', '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 10:12:20 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 10:12:20 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 10:12:20 INFO - Using env: {'DISPLAY': ':0', 10:12:20 INFO - 'HOME': '/home/cltbld', 10:12:20 INFO - 'LANG': 'en_US.UTF-8', 10:12:20 INFO - 'LANGUAGE': 'en_US:en', 10:12:20 INFO - 'LOGNAME': 'cltbld', 10:12:20 INFO - 'MAIL': '/var/mail/cltbld', 10:12:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:20 INFO - 'MOZ_NO_REMOTE': '1', 10:12:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:20 INFO - 'NO_EM_RESTART': '1', 10:12:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:20 INFO - 'PWD': '/builds/slave/test', 10:12:20 INFO - 'SHELL': '/bin/bash', 10:12:20 INFO - 'SHLVL': '1', 10:12:20 INFO - 'TERM': 'linux', 10:12:20 INFO - 'TMOUT': '86400', 10:12:20 INFO - 'USER': 'cltbld', 10:12:20 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461943084.578579-204733650', 10:12:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:20 INFO - '_': '/tools/buildbot/bin/python'} 10:12:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:12:20 INFO - Running setup.py (path:/tmp/pip-B9vePR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:12:20 INFO - Running setup.py (path:/tmp/pip-hmLgvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:12:21 INFO - Running setup.py (path:/tmp/pip-obMFsZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:12:21 INFO - Running setup.py (path:/tmp/pip-EenSIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:12:21 INFO - Running setup.py (path:/tmp/pip-i8bLJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:12:21 INFO - Running setup.py (path:/tmp/pip-8Qn9Yy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:12:21 INFO - Running setup.py (path:/tmp/pip-4AqgYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:12:21 INFO - Running setup.py (path:/tmp/pip-yHUTq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:12:21 INFO - Running setup.py (path:/tmp/pip-7SeA9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:12:21 INFO - Running setup.py (path:/tmp/pip-ofCiPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:12:21 INFO - Running setup.py (path:/tmp/pip-g72wuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:12:21 INFO - Running setup.py (path:/tmp/pip-vYiPTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:12:21 INFO - Running setup.py (path:/tmp/pip-GL5Ozi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:12:21 INFO - Running setup.py (path:/tmp/pip-MKIkNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:12:21 INFO - Running setup.py (path:/tmp/pip-9KOBeD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:12:21 INFO - Running setup.py (path:/tmp/pip-z3ktWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:12:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:12:22 INFO - Running setup.py (path:/tmp/pip-CEJmbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:12:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:12:22 INFO - Running setup.py install for manifestparser 10:12:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:12:22 INFO - Running setup.py install for mozcrash 10:12:22 INFO - Running setup.py install for mozdebug 10:12:22 INFO - Running setup.py install for mozdevice 10:12:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:12:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:12:22 INFO - Running setup.py install for mozfile 10:12:22 INFO - Running setup.py install for mozhttpd 10:12:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:12:22 INFO - Running setup.py install for mozinfo 10:12:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:12:22 INFO - Running setup.py install for mozInstall 10:12:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:12:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:12:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:12:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:12:22 INFO - Running setup.py install for mozleak 10:12:22 INFO - Running setup.py install for mozlog 10:12:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:12:23 INFO - Running setup.py install for moznetwork 10:12:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:12:23 INFO - Running setup.py install for mozprocess 10:12:23 INFO - Running setup.py install for mozprofile 10:12:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:12:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:12:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:12:23 INFO - Running setup.py install for mozrunner 10:12:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:12:23 INFO - Running setup.py install for mozscreenshot 10:12:23 INFO - Running setup.py install for moztest 10:12:23 INFO - Running setup.py install for mozversion 10:12:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:12:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:12:23 INFO - Cleaning up... 10:12:23 INFO - Return code: 0 10:12:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:12:23 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')]} 10:12:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:23 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')]} 10:12:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:23 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 0x7f43ec874f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dda5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e69410>, '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 0x1e6a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a7a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1461943084.578579-204733650', '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 10:12:23 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 10:12:23 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 10:12:23 INFO - Using env: {'DISPLAY': ':0', 10:12:23 INFO - 'HOME': '/home/cltbld', 10:12:23 INFO - 'LANG': 'en_US.UTF-8', 10:12:23 INFO - 'LANGUAGE': 'en_US:en', 10:12:23 INFO - 'LOGNAME': 'cltbld', 10:12:23 INFO - 'MAIL': '/var/mail/cltbld', 10:12:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:23 INFO - 'MOZ_NO_REMOTE': '1', 10:12:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:23 INFO - 'NO_EM_RESTART': '1', 10:12:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:23 INFO - 'PWD': '/builds/slave/test', 10:12:23 INFO - 'SHELL': '/bin/bash', 10:12:23 INFO - 'SHLVL': '1', 10:12:23 INFO - 'TERM': 'linux', 10:12:23 INFO - 'TMOUT': '86400', 10:12:23 INFO - 'USER': 'cltbld', 10:12:23 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461943084.578579-204733650', 10:12:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:23 INFO - '_': '/tools/buildbot/bin/python'} 10:12:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:12:24 INFO - Running setup.py (path:/tmp/pip-uGJUhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:12:24 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)) 10:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:12:24 INFO - Running setup.py (path:/tmp/pip-pVdY6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:12:24 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)) 10:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:12:24 INFO - Running setup.py (path:/tmp/pip-hov5lY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:12:24 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)) 10:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:12:24 INFO - Running setup.py (path:/tmp/pip-hxJmMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:12:24 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)) 10:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:12:24 INFO - Running setup.py (path:/tmp/pip-5PBH2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:12:24 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)) 10:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:12:24 INFO - Running setup.py (path:/tmp/pip-kaOdAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:12:24 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)) 10:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:12:24 INFO - Running setup.py (path:/tmp/pip-xLMUGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:12:24 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)) 10:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:12:24 INFO - Running setup.py (path:/tmp/pip-h6zpUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:12:24 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)) 10:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:12:24 INFO - Running setup.py (path:/tmp/pip-jQ4wLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:12:24 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)) 10:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:12:24 INFO - Running setup.py (path:/tmp/pip-Sc5oFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:12:24 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)) 10:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:12:24 INFO - Running setup.py (path:/tmp/pip-imG47m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:12:24 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)) 10:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:12:24 INFO - Running setup.py (path:/tmp/pip-QbF6zw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:12:24 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)) 10:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:12:24 INFO - Running setup.py (path:/tmp/pip-8t9Q29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:12:25 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)) 10:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:12:25 INFO - Running setup.py (path:/tmp/pip-r8MOMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:12:25 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)) 10:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:12:25 INFO - Running setup.py (path:/tmp/pip-OB5dxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:12:25 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)) 10:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:12:25 INFO - Running setup.py (path:/tmp/pip-qiROfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:12:25 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)) 10:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:12:25 INFO - Running setup.py (path:/tmp/pip-Nlv90Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:12:25 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)) 10:12:25 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)) 10:12:25 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)) 10:12:25 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)) 10:12:25 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)) 10:12:25 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)) 10:12:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:12: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 10:12: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 10:12: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 10:12: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 10:12: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 10:12: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 10:12:27 INFO - Downloading blessings-1.6.tar.gz 10:12:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:12:27 INFO - Installing collected packages: blessings 10:12:27 INFO - Running setup.py install for blessings 10:12:27 INFO - Successfully installed blessings 10:12:27 INFO - Cleaning up... 10:12:27 INFO - Return code: 0 10:12:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:12:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:12:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:12:27 INFO - Reading from file tmpfile_stdout 10:12:27 INFO - Current package versions: 10:12:27 INFO - argparse == 1.2.1 10:12:27 INFO - blessings == 1.6 10:12:27 INFO - blobuploader == 1.2.4 10:12:27 INFO - docopt == 0.6.1 10:12:27 INFO - manifestparser == 1.1 10:12:27 INFO - mozInstall == 1.12 10:12:27 INFO - mozcrash == 0.17 10:12:27 INFO - mozdebug == 0.1 10:12:27 INFO - mozdevice == 0.48 10:12:27 INFO - mozfile == 1.2 10:12:27 INFO - mozhttpd == 0.7 10:12:27 INFO - mozinfo == 0.9 10:12:27 INFO - mozleak == 0.1 10:12:27 INFO - mozlog == 3.1 10:12:27 INFO - moznetwork == 0.27 10:12:27 INFO - mozprocess == 0.22 10:12:27 INFO - mozprofile == 0.28 10:12:27 INFO - mozrunner == 6.11 10:12:27 INFO - mozscreenshot == 0.1 10:12:27 INFO - mozsystemmonitor == 0.0 10:12:27 INFO - moztest == 0.7 10:12:27 INFO - mozversion == 1.4 10:12:27 INFO - psutil == 3.1.1 10:12:27 INFO - requests == 1.2.3 10:12:27 INFO - wsgiref == 0.1.2 10:12:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:12: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')]} 10:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12: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')]} 10:12:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:27 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 0x7f43ec874f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dda5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e69410>, '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 0x1e6a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a7a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1461943084.578579-204733650', '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 10:12:27 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 10:12:27 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 10:12:27 INFO - Using env: {'DISPLAY': ':0', 10:12:27 INFO - 'HOME': '/home/cltbld', 10:12:27 INFO - 'LANG': 'en_US.UTF-8', 10:12:27 INFO - 'LANGUAGE': 'en_US:en', 10:12:27 INFO - 'LOGNAME': 'cltbld', 10:12:27 INFO - 'MAIL': '/var/mail/cltbld', 10:12:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:27 INFO - 'MOZ_NO_REMOTE': '1', 10:12:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:27 INFO - 'NO_EM_RESTART': '1', 10:12:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:27 INFO - 'PWD': '/builds/slave/test', 10:12:27 INFO - 'SHELL': '/bin/bash', 10:12:27 INFO - 'SHLVL': '1', 10:12:27 INFO - 'TERM': 'linux', 10:12:27 INFO - 'TMOUT': '86400', 10:12:27 INFO - 'USER': 'cltbld', 10:12:27 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461943084.578579-204733650', 10:12:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:27 INFO - '_': '/tools/buildbot/bin/python'} 10:12:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:27 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)) 10:12:27 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)) 10:12:27 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)) 10:12:27 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)) 10:12:27 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)) 10:12:27 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)) 10:12:27 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)) 10:12:27 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)) 10:12:27 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)) 10:12:27 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)) 10:12:27 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)) 10:12:27 INFO - Cleaning up... 10:12:27 INFO - Return code: 0 10:12:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:12: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')]} 10:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12: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')]} 10:12:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f43ec874f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dda5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e69410>, '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 0x1e6a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a7a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1461943084.578579-204733650', '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 10:12: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', 'jsonschema'] in /builds/slave/test/build 10:12: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 jsonschema 10:12:27 INFO - Using env: {'DISPLAY': ':0', 10:12:27 INFO - 'HOME': '/home/cltbld', 10:12:27 INFO - 'LANG': 'en_US.UTF-8', 10:12:27 INFO - 'LANGUAGE': 'en_US:en', 10:12:27 INFO - 'LOGNAME': 'cltbld', 10:12:27 INFO - 'MAIL': '/var/mail/cltbld', 10:12:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:27 INFO - 'MOZ_NO_REMOTE': '1', 10:12:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:27 INFO - 'NO_EM_RESTART': '1', 10:12:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:27 INFO - 'PWD': '/builds/slave/test', 10:12:27 INFO - 'SHELL': '/bin/bash', 10:12:27 INFO - 'SHLVL': '1', 10:12:27 INFO - 'TERM': 'linux', 10:12:27 INFO - 'TMOUT': '86400', 10:12:27 INFO - 'USER': 'cltbld', 10:12:27 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461943084.578579-204733650', 10:12:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:27 INFO - '_': '/tools/buildbot/bin/python'} 10:12:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:28 INFO - Downloading/unpacking jsonschema 10:12: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 10:12: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 10:12: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 10:12: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 10:12: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 10:12: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 10:12:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:12:30 INFO - Downloading/unpacking functools32 (from jsonschema) 10:12: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 10:12: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 10:12: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 10:12: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 10:12: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 10:12: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 10:12:30 INFO - Downloading functools32-3.2.3-2.tar.gz 10:12:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:12:30 INFO - warning: no files found matching '*.txt' 10:12:30 INFO - no previously-included directories found matching 'build' 10:12:30 INFO - no previously-included directories found matching 'dist' 10:12:30 INFO - no previously-included directories found matching '.git*' 10:12:30 INFO - Installing collected packages: jsonschema, functools32 10:12:30 INFO - Running setup.py install for functools32 10:12:30 INFO - warning: no files found matching '*.txt' 10:12:30 INFO - no previously-included directories found matching 'build' 10:12:30 INFO - no previously-included directories found matching 'dist' 10:12:30 INFO - no previously-included directories found matching '.git*' 10:12:30 INFO - Successfully installed jsonschema functools32 10:12:30 INFO - Cleaning up... 10:12:30 INFO - Return code: 0 10:12:30 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:12:30 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')]} 10:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:30 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')]} 10:12:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:30 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 0x7f43ec874f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dda5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e69410>, '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 0x1e6a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a7a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1461943084.578579-204733650', '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 10:12:30 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 10:12:30 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 10:12:30 INFO - Using env: {'DISPLAY': ':0', 10:12:30 INFO - 'HOME': '/home/cltbld', 10:12:30 INFO - 'LANG': 'en_US.UTF-8', 10:12:30 INFO - 'LANGUAGE': 'en_US:en', 10:12:30 INFO - 'LOGNAME': 'cltbld', 10:12:30 INFO - 'MAIL': '/var/mail/cltbld', 10:12:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:30 INFO - 'MOZ_NO_REMOTE': '1', 10:12:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:30 INFO - 'NO_EM_RESTART': '1', 10:12:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:30 INFO - 'PWD': '/builds/slave/test', 10:12:30 INFO - 'SHELL': '/bin/bash', 10:12:30 INFO - 'SHLVL': '1', 10:12:30 INFO - 'TERM': 'linux', 10:12:30 INFO - 'TMOUT': '86400', 10:12:30 INFO - 'USER': 'cltbld', 10:12:30 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461943084.578579-204733650', 10:12:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:30 INFO - '_': '/tools/buildbot/bin/python'} 10:12:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:30 INFO - Downloading/unpacking flake8 10:12: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 10:12: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 10:12: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 10:12: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 10:12: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 10:12: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 10:12:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:12:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:12:32 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 10:12:32 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 10:12:32 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 10:12:32 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 10:12:32 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 10:12:32 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 10:12:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:12:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:12:32 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 10:12:32 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 10:12:32 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 10:12:32 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 10:12:32 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 10:12:32 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 10:12:32 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:12:32 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 10:12:32 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 10:12:32 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 10:12:32 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 10:12:32 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 10:12:32 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 10:12:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:12:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:12:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:12:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:12:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:12:33 INFO - no previously-included directories found matching 'docs/_build' 10:12:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:12:33 INFO - Running setup.py install for pep8 10:12:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:12:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:12:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:12:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:12:33 INFO - no previously-included directories found matching 'docs/_build' 10:12:33 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:12:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:12:33 INFO - Cleaning up... 10:12:33 INFO - Return code: 0 10:12:33 INFO - Running post-action listener: _resource_record_post_action 10:12:33 INFO - Running post-action listener: _start_resource_monitoring 10:12:33 INFO - Starting resource monitoring. 10:12:33 INFO - ##### 10:12:33 INFO - ##### Running install step. 10:12:33 INFO - ##### 10:12:33 INFO - Running pre-action listener: _resource_record_pre_action 10:12:33 INFO - Running main action method: install 10:12:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:12:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:12:33 INFO - Reading from file tmpfile_stdout 10:12:33 INFO - Detecting whether we're running mozinstall >=1.0... 10:12:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:12:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:12:33 INFO - Reading from file tmpfile_stdout 10:12:33 INFO - Output received: 10:12:33 INFO - Usage: mozinstall [options] installer 10:12:33 INFO - Options: 10:12:33 INFO - -h, --help show this help message and exit 10:12:33 INFO - -d DEST, --destination=DEST 10:12:33 INFO - Directory to install application into. [default: 10:12:33 INFO - "/builds/slave/test"] 10:12:33 INFO - --app=APP Application being installed. [default: firefox] 10:12:33 INFO - mkdir: /builds/slave/test/build/application 10:12:33 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'] 10:12:33 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 10:12:50 INFO - Reading from file tmpfile_stdout 10:12:50 INFO - Output received: 10:12:50 INFO - /builds/slave/test/build/application/firefox/firefox 10:12:50 INFO - Running post-action listener: _resource_record_post_action 10:12:50 INFO - ##### 10:12:50 INFO - ##### Running run-tests step. 10:12:50 INFO - ##### 10:12:50 INFO - Running pre-action listener: _resource_record_pre_action 10:12:50 INFO - Running main action method: run_tests 10:12:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:12:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:12:50 INFO - Python 2.7.3 10:12:50 INFO - Return code: 0 10:12:50 INFO - grabbing minidump binary from tooltool 10:12:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:50 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 0x1e69410>, '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 0x1e6a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:12:50 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 10:12:50 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 10:12:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:12:50 INFO - Return code: 0 10:12:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:12:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:12:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:12:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:12:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:12:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:12:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:12:51 INFO - Return code: 0 10:12:51 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/MdnBDEUKSD6hQqW4QTb3Pg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 10:12:51 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/MdnBDEUKSD6hQqW4QTb3Pg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 10:12:51 INFO - Using env: {'DISPLAY': ':0', 10:12:51 INFO - 'HOME': '/home/cltbld', 10:12:51 INFO - 'LANG': 'en_US.UTF-8', 10:12:51 INFO - 'LANGUAGE': 'en_US:en', 10:12:51 INFO - 'LOGNAME': 'cltbld', 10:12:51 INFO - 'MAIL': '/var/mail/cltbld', 10:12:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:12:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:12:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:51 INFO - 'MOZ_NO_REMOTE': '1', 10:12:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:12:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:51 INFO - 'NO_EM_RESTART': '1', 10:12:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:51 INFO - 'PWD': '/builds/slave/test', 10:12:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:12:51 INFO - 'SHELL': '/bin/bash', 10:12:51 INFO - 'SHLVL': '1', 10:12:51 INFO - 'TERM': 'linux', 10:12:51 INFO - 'TMOUT': '86400', 10:12:51 INFO - 'USER': 'cltbld', 10:12:51 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461943084.578579-204733650', 10:12:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:51 INFO - '_': '/tools/buildbot/bin/python'} 10:12:51 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/MdnBDEUKSD6hQqW4QTb3Pg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 10:12:51 INFO - mozversion application_buildid: 20160429073752 10:12:51 INFO - mozversion application_changeset: 57e54fef9cf2ebe21eb7d928ed6d5e1d2d180a79 10:12:51 INFO - mozversion application_display_name: Nightly 10:12:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:12:51 INFO - mozversion application_name: Firefox 10:12:51 INFO - mozversion application_remotingname: firefox 10:12:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:12:51 INFO - mozversion application_vendor: Mozilla 10:12:51 INFO - mozversion application_version: 49.0a1 10:12:51 INFO - mozversion platform_buildid: 20160429073752 10:12:51 INFO - mozversion platform_changeset: 57e54fef9cf2ebe21eb7d928ed6d5e1d2d180a79 10:12:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:12:51 INFO - mozversion platform_version: 49.0a1 10:12:51 INFO - using testdate: 1461949971 10:12:51 INFO - actual date: 1461949971 10:12:51 INFO - starting webserver on 'localhost:60788' 10:12:51 INFO - SUITE-START | Running 2 tests 10:12:51 INFO - TEST-START | dromaeo_css 10:12:51 INFO - operating with platform_type : linux_ 10:12:51 INFO - Initialising browser for dromaeo_css test... 10:12:51 INFO - TEST-INFO | started process 11745 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHPe0CD/profile http://localhost:60788/getInfo.html) 10:12:55 INFO - PROCESS | 11745 | __metrics Screen width/height:1600/1200 10:12:55 INFO - PROCESS | 11745 | colorDepth:24 10:12:55 INFO - PROCESS | 11745 | Browser inner width/height: 1024/697 10:12:55 INFO - PROCESS | 11745 | __metrics 10:12:57 ERROR - PROCESS | 11745 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:12:57 INFO - TEST-INFO | 11745: exit 0 10:12:57 INFO - Browser initialized. 10:12:57 INFO - Running cycle 1/1 for dromaeo_css test... 10:12:57 INFO - TEST-INFO | started process 11827 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHPe0CD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:13:09 INFO - PROCESS | 11827 | RSS: Main: 154152960 10:13:09 INFO - PROCESS | 11827 | 10:14:00 INFO - PROCESS | 11827 | 1461950040542 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] 10:16:07 INFO - PROCESS | 11827 | Cycle 1(1): loaded http://localhost:60788/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60788/tests/dromaeo/cssquery-ext.html) 10:16:08 INFO - PROCESS | 11827 | RSS: Main: 243326976 10:16:08 INFO - PROCESS | 11827 | 10:19:11 INFO - PROCESS | 11827 | Cycle 1(1): loaded http://localhost:60788/tests/dromaeo/cssquery-ext.html (next: http://localhost:60788/tests/dromaeo/cssquery-jquery.html) 10:19:11 INFO - PROCESS | 11827 | RSS: Main: 247279616 10:19:11 INFO - PROCESS | 11827 | 10:22:13 INFO - PROCESS | 11827 | Cycle 1(1): loaded http://localhost:60788/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60788/tests/dromaeo/cssquery-mootools.html) 10:22:14 INFO - PROCESS | 11827 | RSS: Main: 246026240 10:22:14 INFO - PROCESS | 11827 | 10:25:16 INFO - PROCESS | 11827 | Cycle 1(1): loaded http://localhost:60788/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60788/tests/dromaeo/cssquery-prototype.html) 10:25:16 INFO - PROCESS | 11827 | RSS: Main: 240644096 10:25:16 INFO - PROCESS | 11827 | 10:28:19 INFO - PROCESS | 11827 | Cycle 1(1): loaded http://localhost:60788/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60788/tests/dromaeo/cssquery-yui.html) 10:28:19 INFO - PROCESS | 11827 | RSS: Main: 226414592 10:28:19 INFO - PROCESS | 11827 | 10:31:22 INFO - PROCESS | 11827 | Cycle 1(1): loaded http://localhost:60788/tests/dromaeo/cssquery-yui.html (next: http://localhost:60788/tests/dromaeo/cssquery-dojo.html) 10:31:22 INFO - PROCESS | 11827 | RSS: Main: 320536576 10:31:22 INFO - PROCESS | 11827 | 10:31:22 INFO - PROCESS | 11827 | __start_tp_report 10:31:22 INFO - PROCESS | 11827 | _x_x_mozilla_page_load 10:31:22 INFO - PROCESS | 11827 | _x_x_mozilla_page_load_details 10:31:22 INFO - PROCESS | 11827 | |i|pagename|runs| 10:31:22 INFO - PROCESS | 11827 | |0;dojo.html;3096.9845150774245;3143.7170654641077;3164.6835316468355;3183.745300375969;3212.309353489;5148.099082660528;5284.3922948860845;5284.867878303045;5305.204219367097;5338.89322213556;5208.218767184924;5227.79088836447;5239.13554263547;5243.947560524393;5364.383095943967;4702.670813043072;4751.738654373999;4774.092922344761;4859.927101093486;4936.531029552187;4835.081334546442;4856.198727210006;4858.5384388483035;4908.28829819676;4908.8036478541;4705.058988202373;4715.104130215265;4739.857804265877;4775.403074615673;4785.473597904228;4663.813447462097;4680.180968330528;4689.648276379251;4697.271922851964;4720.787564559569;4659.161350956826;4676.929846052312;4683.157031734287;4696.788644511005;4744;5161.8193363232485;5204.323437953042;5218.582513398919;5255.421903590602;5256.710880901549;5659.037963546166;5677.801276955328;5693.3452652945025;5700.743466544015;5722.914156287659;5525.668459892379;5603.635763675348;5719.428057194289;5734.483896449298;5739.540836733051;5349.518543331119;5351.7056561889085;5364.168553874156;5371.919421208607;5425.077736784756;5821.155932389865;5824.417558244142;5825.650460972355;5856.795012174553;5863.091220860773;5486.423925487846;5548.0845660465575;5605.32736071674;5606.355269144101;5609.102543593087;5632.943670563324;5637.46444087811;5638.718064096779;5668.03643380618;5680.630759000652;5614.747336369792;5618.0449323615085;5618.550515958714;5619.353774315924;5649.604527683105;5510.366307874646;5619.185218143428;5638.323401191801;5697.800576979786;5723.055695810144;4258.808353624095;4260.68044896634;4261.232978063917;4266.765327906933;4300.204462174508;3834.482344883405;3845;3854.672352849983;3869.28418242626;3876.5348158221195;5220.399654039758;5344.91982620261;5345.625806193529;5432.483914028161;5445.9727701362035;5564.749586268627;5574.414686457944;5581.162825576196;5586.24585680936;5625.6905870176715;5310.495502927216;5311.7078560678765;5314.946850531445;5315.335583052119;5360.571154307646;4747.382840230748;4789.377380940525;4852.053849499384;4871.634627402888;4892.168331383673;5736.62711923732;5779.24869766936;5780.53755699543;5783.94216057834;5784;5503.807366742145;5590.413006634245;5597.944020559742;5601.747921343549;5647.689377084135;5886.882262354643;5951.047832346804;5961.970190149022;5963.373845746134;5978.8206353809455;5551.084071128219;5578.163275508706;5587.972060139836;5588.329400471969;5595.188697638901;5622.634528755618;5645.1532270159805;5657.8019769307875;5658.7736490541565;5687.630304030225;5434.266374039454;5501.312335958005;5548.029094908295;5588.161775733673;5599.860003499945;5423.132298832168;5465.535429488538;5466.398696143341;5467.535259502987;5472.808451704172;5363.463653634605;5384.569234461312;5392.568594512351;5410.97294513525;5446.809361672323;5519.834404967857;5563.443655634566;5583.218349431002;5626.578006649435;5631.0427227372265;5431.837044888502;5438.510534051954;5441.428649991693;5441.83674489766;5448.182772584144 10:31:22 INFO - PROCESS | 11827 | |1;ext.html;644.6776611694153;649.1398896462185;651.7262749645146;656.3174298729322;661.9635920024397;37323.81338093309;39504.40743388851;39515.80242098789;39523.60476395235;39597.20805583886;42032;42719.14561708764;42823.3576496352;42832.357514637304;42854.78572607133;8399.832003359928;8606.526641034741;8606.827863442728;8607.569621518931;8618.396712230146;8457.238848503634;8598.914010859906;8608.87086693697;8809.603567839462;8815.911840881605;8820.382573219877;8890.288776897833;8893.199612034916;8893.42192757472;8896.37725359225;8750.343724220676;8812.339074569401;8819.51492667903;8825.558722063872;8836.293096552261;8734.257588105018;8865.55672216393;8866.911330886673;8875.068117847597;8880.822383552293;40718.1856362874;41350.58649413497;41361.37957930633;41390;41455.37816932749;3339.9499007514905;3908.863189788344;4086.162336720965;4088.8773336799945;4194.3498757692305;31633.84183079093;32140.678593214;32204.67795322064;32282;32545.02364929056;4247.532771395144;4318.373835793793;4323.178596066738;4342.869713908588;4345.326474396474;324808;329582;331124;331204;331274;45173.77413112913;50196.49803501991;57849.13226301609;57852.421475785544;58312;53871.73064134733;54235.18647220295;54318.45681543213;54405;54517.45482545124;15375.692486150214;15754.369825207092;15759.212039397984;15761.133137677538;15762.290696918666;10487.108595769445;11429;11493.195476316745;11671.299722016705;12112.939435302767;16389.754153687703;16614.252358643647;16631;16658.167091645613;16761.580960476087;5939.485431215013;6001.099835024781;6007.249093863267;6095.786647467317;6195.783147589813;1023.6110278094426;1034.3483605328595;1055.873295204565;1068.0921216965517;1113.0261021606095;31776.682233177835;32020.679793202235;32276.19309517281;32346.35307293841;32742.34515309728;1164.7670465906683;1167.6380322100176;1168.760404117154;1203.272020427646;1238.6222202228407;16635.83364166367;17255.56861078458;17416.564585885455;17427.564310892074;17497.67991225842;509604;518685;521919;523035;524749;58445.41554584485;58542;58876;58900.41099588949;58924.7053764737;1346;1391.844768841859;1404.389090745529;1404.5716056602835;1411.4452840358983;30555.2361190972;31106.37787244197;31567.526487103172;31888.202794930312;32224;51818;51998;52280;52337.47662523478;52368.47631523636;320409;413642;417302;420827;421798;36129.63870361368;37337.81331093327;37518.62332390098;38287.80856095702;38914.22171556496;46292;46497;46576;46609.533904661876;47693;38982.4152637705;39138.608613914635;39170.60829391784;39189;39621.2075758489;39213.80393098016;39221.803890980365;39261.41107883327;39482.40776388414;39544;38200.808995954845;39536.04639536023;39602.801985989885;39666;39959.2008159841;31006.53490197694;32428.513572296906;32887.17782055372;32900.34199315953;33296.833515832266;25097.87451062733;25287.241382758548;25375.238742837744;25532.48935021326;25622.231333060037 10:31:22 INFO - PROCESS | 11827 | |2;jquery.html;357.485221281355;370.10065540736;374.24962949286675;377.30575740637227;381.87398158607664;13844.377003034862;17446.82553174468;17920.46238612842;18125.637487250246;18138.3651572195;17901;18360.26558937641;19012.429627111174;19265.903670481664;19342.12960416781;5303.469653034695;5543.77824887004;5565.053940830048;5565.888682226353;5569.721513924308;3985.9202815943663;5485.588580856432;5678.829635110953;6114.877702445949;6134.17188679527;6050.152978583002;6062.514998800108;6065.302490213638;6085.969570152143;6087.726052327655;6854.965725171367;7225.132984041896;7232.385247253989;7233.24050974648;7239.420846332281;4443.311286750527;6758.8310292242595;7094;7100.964495177543;7103.325184107502;23244.3026709199;23797.167099151447;24298;24324.148654797173;24753.5049299013;2385.5467461182493;2434.6591477193206;2543.923682289534;2564.9358766030814;3047.3295874907485;14828.70342593153;15397.153156576383;15407;15883.36466541337;16256.75614865778;1991.71120187572;2117.788221177885;2127.8936053197435;2151.5051538146313;2184.803367696915;87548.56225718894;88260.73125633715;88479;89010.99999999935;89062;14270.02332814926;15729.292181851844;17060.57348566271;17757.200925958103;17857.910710446366;31788.205294867814;31868.362632747678;31994.680053199634;32093.839530802663;32171.678283217338;9233.122853328923;9262;9485.857712134324;9531.475768832643;9585.952070239604;7622.047244094489;7634.122075961335;7736.6518506667335;7739.574323412154;7870.881936770953;8589.656413743505;8870.778230544289;8925.241354484811;9083.772905677279;9095.727128186165;3333.5333053372547;3386.7629265951145;3419.230673098533;3438.7249020078334;3562.966739645474;982.2829334585792;993.5777294649745;1007.9207920792079;1039.8492218628257;1071.3304184884448;17527.29890804379;17798.46604601864;18092.90953545224;18270;18726.344577939708;993.5677980078689;993.9602415903428;1011.9342242754198;1013.4848401639596;1066.4454483668449;10026.899731002743;10176.135028522658;10446.015257101279;10483.161347092215;10533.736656583647;481764;488567;489759;492441;496332;85231.5738421304;87263.56368218118;89290;91731.54134229287;91736;992.0525897767759;998.6404894238068;1025.9025392587691;1027.660871912267;1029.897010298964;13027.47890084386;15591;15981.200939952723;16272;16313.265903034155;36220;38493.230135397695;38601.42097868478;39408.2118357637;39450.80274598609;46099.53900460953;47488.52511474841;48524.514754851996;48985.51014489809;50343;7813.960930195312;7949.364050876032;7969.960150199212;8031.59842007909;8104;8875.334349923653;11697.204146299977;12009.759804804029;12674.239545627292;13335.866641333463;11541.422928853692;11712.824307635221;11797.88202117968;11885.22746021506;11966.64100076999;11305.208635395444;11380.886191137983;11574.363410012531;11721.12091593151;11748;11529.308241505536;11621.302721836717;11660.475278612652;11700;11709.531618735155;7932.484388514728;7993.400494962785;8271.793205169919;8352.87470687928;8551.444156129832;10398.58405663765;11283.887161128283;11360.943195283971;11408.429578521207;11729.120315976164 10:31:22 INFO - PROCESS | 11827 | |3;mootools.html;1343.4357569820675;1482.7924090627312;1495.55133459962;1658.286936617255;1808.0778802810562;7505;7910.406719496046;7911.802204944879;7920;7921.247481489257;7564.6217689115465;7824.765257042298;7832.8041798955055;7845.411594130434;7856.096548896879;1876.0900963032918;1948.7333233398333;1948.9767871867311;2198.065822025637;2225.63277059285;2212.1483228956886;2293.1515339324474;2295.0475552645717;2297.1844995026777;2297.483066310075;2173.89130543473;2208.4147700859285;2216.1135545781735;2225.5993921094196;2228.4985878177363;1903.181631898297;2150.817180539656;2202.0861342542826;2207.4591725027312;2207.768184340637;2210.2043264424956;2229.665550167472;2236.5862315471527;2237.59723249815;2237.7874101960288;7790.922090779133;7830.373570114434;7834.56909869957;7843.019622547182;7847.568383738892;4661.813527458898;4808.855734327975;4816;4835;4857.611391088704;2900.796944213906;3083.722464978163;3085.182426656938;3094.8297843618593;3123.375324935022;1007.8034783217275;1008.6873069348452;1011.3476807459222;1025.7692019295673;1081.3403823667556;11067.391293478855;11089.05743011845;11091.944540277327;11112.277701949428;11129.220954533186;4155.937660935088;4223.704340696183;4236.809343579546;4338.674599405057;4386.035072284092;9315.068493150766;9335.206507446943;9360.62557497706;9368.90631093694;9376.343655944018;4831.251156070744;4831.5651591356245;4842.273658951115;4845.370101886802;4887.560119589183;4043.4137050127565;4404.8458303959205;4434.955650443454;4516.254817955067;4537.410136682211;3727.6645101940953;3750.5686846012513;3805.4101614249835;3813.866514671973;3843.8846834595006;1185.5968970550055;1191.92252503587;1203.4283715235192;1215.775081609905;1222.3155033181447;1008.621766837436;1023.6928921323573;1027.9229057820694;1032.3135115148493;1034.637876743149;5781.017227071408;5830.067189249699;5844.795432159854;5846.532277417881;6007.579469437185;406.3214431898677;408.48495333660395;428.66992415839627;430.34372581812363;433.4040694045687;4135.627793498599;4156.709030367906;4191.517975432804;4208.158368326347;4258.446401967724;9623.278254130968;9796.363236389612;9905.20758339331;9976.750581235527;9986.900130998742;9509;9642.71071867845;9810.705678829647;9865;9883.703488895344;7462.141853686787;7533.924660753322;7542.170361260257;7553.773386798405;7625.885611715828;5594.0769772987005;5646.85882852932;5697.676143020292;5729.54163666914;5817.185594016925;9216.493092879688;9228.676996305097;9311.068893110634;9333.160015598629;9439.480828554495;9219.44683319003;9299.163075323253;9421.246300296098;9453.905460945578;9484.288678349014;7023.262557431396;7046.365827075383;7069.469789765891;7095.361417472246;7234.457415693949;7772.92227077722;7783.104942931409;7791.104023037196;7804.219578042151;7869.84260314779;6947.201071876799;6981.79054628362;7127.144742630918;7232.0959880015;7235.891461627974;6992.930070699432;7013.473989450914;7030;7073.893891591733;7113.715451381887;6657.667116644246;6689.09697190873;6694.397504224448;6708.664566771739;6729.461643068445;4820.734859582616;4831.468538460696;4850.151223535797;4868.48880867518;4903.190973489334;4866.7079975201605;4926.630502712239;4996.450390456974;5027.296178535081;5083.542481176712 10:31:22 INFO - PROCESS | 11827 | |4;prototype.html;293.6256273251603;294.25846865897927;298.5357768669719;303.8268187133334;305.6958326465167;5183.770978479252;5221.06020916235;5234.55506281966;5239.580833533318;5241.659292146012;5151.253068305094;5155.149400348938;5162.741862906849;5172.6637768545015;5185.3777546694355;3739.906502337436;3859.3246181918194;3998.400239964014;4050.8177132029127;4069.837206511736;4000.8599699010542;4021.8994525136814;4039.6970227233073;4047.8785636430953;4060.20825938942;3763.6236376362417;3992.6805855531634;4002.899927501807;4016.15660711251;4017.1764788218493;3887.105965627907;3956.2680904032704;3964.702647301464;3969.920601587952;4004.759714417115;3446.913827154316;3450.4824276358495;3456.9654303456896;3468.9479657805155;3475.982620086909;5021.39743230811;5038.773255203525;5039.118154323016;5052.242163675442;5063.367079115111;4301.139772045603;4529.297958816389;4542.136993971135;4555.362249285103;4570.862874113749;5367.355917289911;5406.729663516809;5410.756515956791;5423.349198096214;5439.918401223985;3789.6589306962505;3801.3347664158937;3809.5238095238096;3813.866514671973;3819.8090095495113;5517.944820551783;5646.491815736604;5648.378678345379;5650.152477128422;5671.865626874642;3783.129880127586;3794.6964242860504;3795.582485926546;3802.3535998880257;3815.847366105325;3830.4637350770913;3844.8654297099465;3857.40210267409;3865.710071744574;3868.883933482;4414;4502.797374118172;4516.503184649686;4531.84138555149;4558.8632341029825;5387.838364849061;5446.945530544723;5467.343918729778;5486.31421072366;5504.944950550524;1389.833220013605;1412.9434822606981;1415.6107070555474;1424.586869807765;1425.4227038049607;855.6149732620346;905.6241659711146;916.5188276155072;944.7401964459691;982.1700662939804;5473.863153421116;5575.494616453535;5630.789380283177;5631.267935168402;5654.264945557051;5927.4665280125;5940.762369505258;5945.4649081582;5947.464728174485;5969.820905372846;5445.346558413015;5589.133684278943;5593.916091258634;5599.348192283286;5612.85967850807;3144.748420126384;3151.779375443697;3157.131788758064;3167.0973772474736;3180.2685382361724;5945.524358051345;6109.694515274218;6117.816465506042;6124.785632502841;6153.353897840751;6052.485538729257;6066.848328791815;6074.331823499411;6095.969520152459;6096.847578810476;6155.47678447337;6164.4280708419965;6169.352218017133;6198.442140207403;6201.7519299228425;5762.423757624204;5869.618474799125;5886.882262354643;5892.882142357214;5915.674637894957;5797.826065218051;5806.216160818235;5840.445157710011;5844.47399734026;5860.150278209721;5979.103134529855;6116.143739876332;6116.541259405473;6147.538934579835;6163.106349579196;4155.210510003089;4174.1443004184675;4176.43618111551;4179.26862799015;4183.49798024239;5979.940200597938;5997.280326360865;5999.400059993965;6000.399960003964;6001.189839371629;5639.351474580311;5802.564807639359;5809.651420914759;5812.360640329476;5828.854278643068;5780.132980053026;5780.624259423124;5800.1299805029585;5807.373935298123;5807.941920580909;5165.199394093921;5265.341832270966;5396.21754845553;5749.683767392834;5752.827415177551;5552.139418390156;5553.888922221452;5558;5566.749496272759;5617.382087970402;5411.701191714039;5414.7021913795115;5456.454354564512;5460.672359658433;5469.863253418696 10:31:22 INFO - PROCESS | 11827 | |5;yui.html;800.7277525641282;810.1169724999753;817.7383237364046;826.9421140520162;836.9455985360951;13572;13825.654358641039;13844.100133491342;13866.098703584259;14006.509772157977;12908.160969536997;13506.527271545498;13524.864751352483;13533.661658458543;13557.440894297135;689.1833177684435;797.2067792546395;823.0493779684474;824.958752062396;826.3678286111129;822.440740296598;823.300194834392;826.2893911236332;826.7437094500724;828.4035494443991;861.9396642235046;865.2645251536206;865.3207232322628;865.5801936061006;866.527742380401;714.7141143542573;841.2975165736617;866.3242670716788;867.4448353054019;868.3964644572025;624.1449214576014;624.753222477119;626.4424662050778;630.8580569371901;631.0187658191556;13863.792043119362;13887.4445022199;13915;13931.094478858842;13995.79006314896;13393.464261429532;13695.178289302574;13708.17750934947;13986;14092.365843536963;10709.839352409721;10834.133269338434;10935.671929842118;11161.107111431065;11181.72045698856;4362.8036738346855;4425.35832304314;4506.211413002711;4576.405067341258;4579.656525760582;49632.53307202333;50142.247866282036;50474.24288635673;51177.48822511802;51737;9934.900650993543;10081.243906706879;10136.746581335525;10161.54273057714;10246.38521688701;17947.73078403825;18077.548061298574;18186.727199091758;18356;18396.448106556825;8411.3270938326;8429.32565394767;8445.788855278668;8561.229489345864;8675.436096653697;4679.181143299909;4813.663043586916;4818.397700287464;4844.733539655353;4913.6069114471475;3276.672332766704;3359.277755282626;3374.9662503375143;3379.3579219948133;3380.0873764084054;594.7264258441165;605.170915845286;644.8806970710434;656.9244536878225;681.7716065118241;700.4641449291296;737.5824568544035;745.7017193122686;757.6742000939539;783.9882401763978;8320.958395208107;8886.644534218689;8893.777655558662;8931.464112153291;9272.814543709088;735.1664541860355;741.9888701669479;754.6868049759398;758.9354904833151;763.4159867701213;4290.528041915387;4588.151192029419;4590.632749380042;4618.722876627413;4647.6281897448125;65519;66588.6670566644;67285;67360;67684.66157669279;57060.71469642625;57494.7125264371;59337.703311483165;60372.39627603668;61267;46640.300395494094;53776.46223537793;54341.45658543443;54388.728056360254;55896;8836.955815220883;8966.462012279284;9060;9115.589798459217;9131.269498440242;33743.83128084344;33981.83009084939;34232.657673422946;34663.30673386468;34972.30055398827;41135.38296925608;44988.32517512306;45215;45881;46194.076118478115;11275.436228188722;11497.655070347902;11632.825507617223;11791.29252244868;11953.521859125538;12046.939765301468;12168.939155304166;12436.19164754288;13320.86679133235;13341.132826366254;12403.635600083802;12491.93754031224;12581.182223155465;12612.684682883002;12905.622987366856;11958.22271552381;12492.25046497213;12503.624891253277;13025.218486890817;13273.800892986807;12183.147179697336;12334.444949977453;12504.124711270124;12731.172473789175;13024.609261722164;10182.490875456346;10302.278840481094;10559.208059395422;10844.67465976022;10860.565577376816;10441.164706823283;10781.657686117329;10846.457677115955;10860.782784344427;10921.126309895031 10:31:22 INFO - PROCESS | 11827 | __end_tp_report 10:31:22 INFO - PROCESS | 11827 | __start_cc_report 10:31:22 INFO - PROCESS | 11827 | _x_x_mozilla_cycle_collect,770 10:31:22 INFO - PROCESS | 11827 | __end_cc_report 10:31:22 INFO - PROCESS | 11827 | __startTimestamp1461951082913__endTimestamp 10:31:22 INFO - PROCESS | 11827 | 10:31:22 INFO - PROCESS | 11827 | ------- Summary: start ------- 10:31:22 INFO - PROCESS | 11827 | Number of tests: 6 10:31:22 INFO - PROCESS | 11827 | 10:31:22 INFO - PROCESS | 11827 | [#0] dojo.html Cycles:165 Average:5240.89 Median:5441.43 stddev:594.19 (10.9%) stddev-sans-first:571.72 10:31:22 INFO - PROCESS | 11827 | Values: 3097.0 3143.7 3164.7 3183.7 3212.3 5148.1 5284.4 5284.9 5305.2 5338.9 5208.2 5227.8 5239.1 5243.9 5364.4 4702.7 4751.7 4774.1 4859.9 4936.5 4835.1 4856.2 4858.5 4908.3 4908.8 4705.1 4715.1 4739.9 4775.4 4785.5 4663.8 4680.2 4689.6 4697.3 4720.8 4659.2 4676.9 4683.2 4696.8 4744.0 5161.8 5204.3 5218.6 5255.4 5256.7 5659.0 5677.8 5693.3 5700.7 5722.9 5525.7 5603.6 5719.4 5734.5 5739.5 5349.5 5351.7 5364.2 5371.9 5425.1 5821.2 5824.4 5825.7 5856.8 5863.1 5486.4 5548.1 5605.3 5606.4 5609.1 5632.9 5637.5 5638.7 5668.0 5680.6 5614.7 5618.0 5618.6 5619.4 5649.6 5510.4 5619.2 5638.3 5697.8 5723.1 4258.8 4260.7 4261.2 4266.8 4300.2 3834.5 3845.0 3854.7 3869.3 3876.5 5220.4 5344.9 5345.6 5432.5 5446.0 5564.7 5574.4 5581.2 5586.2 5625.7 5310.5 5311.7 5314.9 5315.3 5360.6 4747.4 4789.4 4852.1 4871.6 4892.2 5736.6 5779.2 5780.5 5783.9 5784.0 5503.8 5590.4 5597.9 5601.7 5647.7 5886.9 5951.0 5962.0 5963.4 5978.8 5551.1 5578.2 5588.0 5588.3 5595.2 5622.6 5645.2 5657.8 5658.8 5687.6 5434.3 5501.3 5548.0 5588.2 5599.9 5423.1 5465.5 5466.4 5467.5 5472.8 5363.5 5384.6 5392.6 5411.0 5446.8 5519.8 5563.4 5583.2 5626.6 5631.0 5431.8 5438.5 5441.4 5441.8 5448.2 10:31:22 INFO - PROCESS | 11827 | 10:31:22 INFO - PROCESS | 11827 | [#1] ext.html Cycles:180 Average:57484.20 Median:39643.60 stddev:112337.74 (283.4%) stddev-sans-first:112571.82 10:31:22 INFO - PROCESS | 11827 | Values: 644.7 649.1 651.7 656.3 662.0 37323.8 39504.4 39515.8 39523.6 39597.2 42032.0 42719.1 42823.4 42832.4 42854.8 8399.8 8606.5 8606.8 8607.6 8618.4 8457.2 8598.9 8608.9 8809.6 8815.9 8820.4 8890.3 8893.2 8893.4 8896.4 8750.3 8812.3 8819.5 8825.6 8836.3 8734.3 8865.6 8866.9 8875.1 8880.8 40718.2 41350.6 41361.4 41390.0 41455.4 3339.9 3908.9 4086.2 4088.9 4194.3 31633.8 32140.7 32204.7 32282.0 32545.0 4247.5 4318.4 4323.2 4342.9 4345.3 324808.0 329582.0 331124.0 331204.0 331274.0 45173.8 50196.5 57849.1 57852.4 58312.0 53871.7 54235.2 54318.5 54405.0 54517.5 15375.7 15754.4 15759.2 15761.1 15762.3 10487.1 11429.0 11493.2 11671.3 12112.9 16389.8 16614.3 16631.0 16658.2 16761.6 5939.5 6001.1 6007.2 6095.8 6195.8 1023.6 1034.3 1055.9 1068.1 1113.0 31776.7 32020.7 32276.2 32346.4 32742.3 1164.8 1167.6 1168.8 1203.3 1238.6 16635.8 17255.6 17416.6 17427.6 17497.7 509604.0 518685.0 521919.0 523035.0 524749.0 58445.4 58542.0 58876.0 58900.4 58924.7 1346.0 1391.8 1404.4 1404.6 1411.4 30555.2 31106.4 31567.5 31888.2 32224.0 51818.0 51998.0 52280.0 52337.5 52368.5 320409.0 413642.0 417302.0 420827.0 421798.0 36129.6 37337.8 37518.6 38287.8 38914.2 46292.0 46497.0 46576.0 46609.5 47693.0 38982.4 39138.6 39170.6 39189.0 39621.2 39213.8 39221.8 39261.4 39482.4 39544.0 38200.8 39536.0 39602.8 39666.0 39959.2 31006.5 32428.5 32887.2 32900.3 33296.8 25097.9 25287.2 25375.2 25532.5 25622.2 10:31:22 INFO - PROCESS | 11827 | 10:31:22 INFO - PROCESS | 11827 | [#2] jquery.html Cycles:180 Average:29565.26 Median:3428.98 stddev:80623.09 (2351.2%) stddev-sans-first:80819.43 10:31:22 INFO - PROCESS | 11827 | Values: 357.5 370.1 374.2 377.3 381.9 13844.4 17446.8 17920.5 18125.6 18138.4 17901.0 18360.3 19012.4 19265.9 19342.1 5303.5 5543.8 5565.1 5565.9 5569.7 3985.9 5485.6 5678.8 6114.9 6134.2 6050.2 6062.5 6065.3 6086.0 6087.7 6855.0 7225.1 7232.4 7233.2 7239.4 4443.3 6758.8 7094.0 7101.0 7103.3 23244.3 23797.2 24298.0 24324.1 24753.5 2385.5 2434.7 2543.9 2564.9 3047.3 14828.7 15397.2 15407.0 15883.4 16256.8 1991.7 2117.8 2127.9 2151.5 2184.8 87548.6 88260.7 88479.0 89011.0 89062.0 14270.0 15729.3 17060.6 17757.2 17857.9 31788.2 31868.4 31994.7 32093.8 32171.7 9233.1 9262.0 9485.9 9531.5 9586.0 7622.0 7634.1 7736.7 7739.6 7870.9 8589.7 8870.8 8925.2 9083.8 9095.7 3333.5 3386.8 3419.2 3438.7 3563.0 982.3 993.6 1007.9 1039.8 1071.3 17527.3 17798.5 18092.9 18270.0 18726.3 993.6 994.0 1011.9 1013.5 1066.4 10026.9 10176.1 10446.0 10483.2 10533.7 481764.0 488567.0 489759.0 492441.0 496332.0 85231.6 87263.6 89290.0 91731.5 91736.0 992.1 998.6 1025.9 1027.7 1029.9 13027.5 15591.0 15981.2 16272.0 16313.3 36220.0 38493.2 38601.4 39408.2 39450.8 46099.5 47488.5 48524.5 48985.5 50343.0 7814.0 7949.4 7970.0 8031.6 8104.0 8875.3 11697.2 12009.8 12674.2 13335.9 11541.4 11712.8 11797.9 11885.2 11966.6 11305.2 11380.9 11574.4 11721.1 11748.0 11529.3 11621.3 11660.5 11700.0 11709.5 7932.5 7993.4 8271.8 8352.9 8551.4 10398.6 11283.9 11360.9 11408.4 11729.1 10:31:22 INFO - PROCESS | 11827 | 10:31:22 INFO - PROCESS | 11827 | [#3] mootools.html Cycles:180 Average:5342.31 Median:4853.88 stddev:2974.22 (61.3%) stddev-sans-first:2967.38 10:31:22 INFO - PROCESS | 11827 | Values: 1343.4 1482.8 1495.6 1658.3 1808.1 7505.0 7910.4 7911.8 7920.0 7921.2 7564.6 7824.8 7832.8 7845.4 7856.1 1876.1 1948.7 1949.0 2198.1 2225.6 2212.1 2293.2 2295.0 2297.2 2297.5 2173.9 2208.4 2216.1 2225.6 2228.5 1903.2 2150.8 2202.1 2207.5 2207.8 2210.2 2229.7 2236.6 2237.6 2237.8 7790.9 7830.4 7834.6 7843.0 7847.6 4661.8 4808.9 4816.0 4835.0 4857.6 2900.8 3083.7 3085.2 3094.8 3123.4 1007.8 1008.7 1011.3 1025.8 1081.3 11067.4 11089.1 11091.9 11112.3 11129.2 4155.9 4223.7 4236.8 4338.7 4386.0 9315.1 9335.2 9360.6 9368.9 9376.3 4831.3 4831.6 4842.3 4845.4 4887.6 4043.4 4404.8 4435.0 4516.3 4537.4 3727.7 3750.6 3805.4 3813.9 3843.9 1185.6 1191.9 1203.4 1215.8 1222.3 1008.6 1023.7 1027.9 1032.3 1034.6 5781.0 5830.1 5844.8 5846.5 6007.6 406.3 408.5 428.7 430.3 433.4 4135.6 4156.7 4191.5 4208.2 4258.4 9623.3 9796.4 9905.2 9976.8 9986.9 9509.0 9642.7 9810.7 9865.0 9883.7 7462.1 7533.9 7542.2 7553.8 7625.9 5594.1 5646.9 5697.7 5729.5 5817.2 9216.5 9228.7 9311.1 9333.2 9439.5 9219.4 9299.2 9421.2 9453.9 9484.3 7023.3 7046.4 7069.5 7095.4 7234.5 7772.9 7783.1 7791.1 7804.2 7869.8 6947.2 6981.8 7127.1 7232.1 7235.9 6992.9 7013.5 7030.0 7073.9 7113.7 6657.7 6689.1 6694.4 6708.7 6729.5 4820.7 4831.5 4850.2 4868.5 4903.2 4866.7 4926.6 4996.5 5027.3 5083.5 10:31:22 INFO - PROCESS | 11827 | 10:31:22 INFO - PROCESS | 11827 | [#4] prototype.html Cycles:180 Average:4694.77 Median:5408.74 stddev:1452.24 (26.8%) stddev-sans-first:1418.25 10:31:22 INFO - PROCESS | 11827 | Values: 293.6 294.3 298.5 303.8 305.7 5183.8 5221.1 5234.6 5239.6 5241.7 5151.3 5155.1 5162.7 5172.7 5185.4 3739.9 3859.3 3998.4 4050.8 4069.8 4000.9 4021.9 4039.7 4047.9 4060.2 3763.6 3992.7 4002.9 4016.2 4017.2 3887.1 3956.3 3964.7 3969.9 4004.8 3446.9 3450.5 3457.0 3468.9 3476.0 5021.4 5038.8 5039.1 5052.2 5063.4 4301.1 4529.3 4542.1 4555.4 4570.9 5367.4 5406.7 5410.8 5423.3 5439.9 3789.7 3801.3 3809.5 3813.9 3819.8 5517.9 5646.5 5648.4 5650.2 5671.9 3783.1 3794.7 3795.6 3802.4 3815.8 3830.5 3844.9 3857.4 3865.7 3868.9 4414.0 4502.8 4516.5 4531.8 4558.9 5387.8 5446.9 5467.3 5486.3 5504.9 1389.8 1412.9 1415.6 1424.6 1425.4 855.6 905.6 916.5 944.7 982.2 5473.9 5575.5 5630.8 5631.3 5654.3 5927.5 5940.8 5945.5 5947.5 5969.8 5445.3 5589.1 5593.9 5599.3 5612.9 3144.7 3151.8 3157.1 3167.1 3180.3 5945.5 6109.7 6117.8 6124.8 6153.4 6052.5 6066.8 6074.3 6096.0 6096.8 6155.5 6164.4 6169.4 6198.4 6201.8 5762.4 5869.6 5886.9 5892.9 5915.7 5797.8 5806.2 5840.4 5844.5 5860.2 5979.1 6116.1 6116.5 6147.5 6163.1 4155.2 4174.1 4176.4 4179.3 4183.5 5979.9 5997.3 5999.4 6000.4 6001.2 5639.4 5802.6 5809.7 5812.4 5828.9 5780.1 5780.6 5800.1 5807.4 5807.9 5165.2 5265.3 5396.2 5749.7 5752.8 5552.1 5553.9 5558.0 5566.7 5617.4 5411.7 5414.7 5456.5 5460.7 5469.9 10:31:22 INFO - PROCESS | 11827 | 10:31:22 INFO - PROCESS | 11827 | [#5] yui.html Cycles:180 Average:14909.25 Median:4604.68 stddev:17649.72 (383.3%) stddev-sans-first:17667.43 10:31:22 INFO - PROCESS | 11827 | Values: 800.7 810.1 817.7 826.9 836.9 13572.0 13825.7 13844.1 13866.1 14006.5 12908.2 13506.5 13524.9 13533.7 13557.4 689.2 797.2 823.0 825.0 826.4 822.4 823.3 826.3 826.7 828.4 861.9 865.3 865.3 865.6 866.5 714.7 841.3 866.3 867.4 868.4 624.1 624.8 626.4 630.9 631.0 13863.8 13887.4 13915.0 13931.1 13995.8 13393.5 13695.2 13708.2 13986.0 14092.4 10709.8 10834.1 10935.7 11161.1 11181.7 4362.8 4425.4 4506.2 4576.4 4579.7 49632.5 50142.2 50474.2 51177.5 51737.0 9934.9 10081.2 10136.7 10161.5 10246.4 17947.7 18077.5 18186.7 18356.0 18396.4 8411.3 8429.3 8445.8 8561.2 8675.4 4679.2 4813.7 4818.4 4844.7 4913.6 3276.7 3359.3 3375.0 3379.4 3380.1 594.7 605.2 644.9 656.9 681.8 700.5 737.6 745.7 757.7 784.0 8321.0 8886.6 8893.8 8931.5 9272.8 735.2 742.0 754.7 758.9 763.4 4290.5 4588.2 4590.6 4618.7 4647.6 65519.0 66588.7 67285.0 67360.0 67684.7 57060.7 57494.7 59337.7 60372.4 61267.0 46640.3 53776.5 54341.5 54388.7 55896.0 8837.0 8966.5 9060.0 9115.6 9131.3 33743.8 33981.8 34232.7 34663.3 34972.3 41135.4 44988.3 45215.0 45881.0 46194.1 11275.4 11497.7 11632.8 11791.3 11953.5 12046.9 12168.9 12436.2 13320.9 13341.1 12403.6 12491.9 12581.2 12612.7 12905.6 11958.2 12492.3 12503.6 13025.2 13273.8 12183.1 12334.4 12504.1 12731.2 13024.6 10182.5 10302.3 10559.2 10844.7 10860.6 10441.2 10781.7 10846.5 10860.8 10921.1 10:31:22 INFO - PROCESS | 11827 | -------- Summary: end -------- 10:31:22 INFO - PROCESS | 11827 | 10:31:23 INFO - TEST-INFO | 11827: exit 0 10:31:23 INFO - TEST-OK | dromaeo_css | took 1112051ms 10:31:23 INFO - TEST-START | kraken 10:31:23 INFO - operating with platform_type : linux_ 10:31:23 INFO - Initialising browser for kraken test... 10:31:23 INFO - TEST-INFO | started process 12010 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5q1yo2/profile http://localhost:60788/getInfo.html) 10:31:27 INFO - PROCESS | 12010 | __metrics Screen width/height:1600/1200 10:31:27 INFO - PROCESS | 12010 | colorDepth:24 10:31:27 INFO - PROCESS | 12010 | Browser inner width/height: 1024/697 10:31:27 INFO - PROCESS | 12010 | __metrics 10:31:28 ERROR - PROCESS | 12010 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:31:29 INFO - TEST-INFO | 12010: exit 0 10:31:29 INFO - Browser initialized. 10:31:29 INFO - Running cycle 1/1 for kraken test... 10:31:29 INFO - TEST-INFO | started process 12092 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5q1yo2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:31:41 INFO - PROCESS | 12092 | RSS: Main: 154550272 10:31:41 INFO - PROCESS | 12092 | 10:31:44 INFO - PROCESS | 12092 | Cycle 1(1): loaded http://localhost:60788/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60788/tests/kraken/driver.html?testName=audio-beat-detection) 10:31:44 INFO - PROCESS | 12092 | RSS: Main: 209829888 10:31:44 INFO - PROCESS | 12092 | 10:31:47 INFO - PROCESS | 12092 | Cycle 1(1): loaded http://localhost:60788/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60788/tests/kraken/driver.html?testName=audio-dft) 10:31:48 INFO - PROCESS | 12092 | RSS: Main: 196100096 10:31:48 INFO - PROCESS | 12092 | 10:31:51 INFO - PROCESS | 12092 | Cycle 1(1): loaded http://localhost:60788/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60788/tests/kraken/driver.html?testName=audio-fft) 10:31:51 INFO - PROCESS | 12092 | RSS: Main: 266305536 10:31:51 INFO - PROCESS | 12092 | 10:31:54 INFO - PROCESS | 12092 | Cycle 1(1): loaded http://localhost:60788/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60788/tests/kraken/driver.html?testName=audio-oscillator) 10:31:54 INFO - PROCESS | 12092 | RSS: Main: 174129152 10:31:54 INFO - PROCESS | 12092 | 10:31:56 INFO - PROCESS | 12092 | Cycle 1(1): loaded http://localhost:60788/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60788/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:31:57 INFO - PROCESS | 12092 | RSS: Main: 178077696 10:31:57 INFO - PROCESS | 12092 | 10:32:00 INFO - PROCESS | 12092 | Cycle 1(1): loaded http://localhost:60788/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60788/tests/kraken/driver.html?testName=imaging-darkroom) 10:32:01 INFO - PROCESS | 12092 | RSS: Main: 214487040 10:32:01 INFO - PROCESS | 12092 | 10:32:04 INFO - PROCESS | 12092 | Cycle 1(1): loaded http://localhost:60788/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60788/tests/kraken/driver.html?testName=imaging-desaturate) 10:32:05 INFO - PROCESS | 12092 | RSS: Main: 214503424 10:32:05 INFO - PROCESS | 12092 | 10:32:07 INFO - PROCESS | 12092 | Cycle 1(1): loaded http://localhost:60788/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60788/tests/kraken/driver.html?testName=json-parse-financial) 10:32:08 INFO - PROCESS | 12092 | RSS: Main: 215408640 10:32:08 INFO - PROCESS | 12092 | 10:32:09 INFO - PROCESS | 12092 | Cycle 1(1): loaded http://localhost:60788/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60788/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:32:10 INFO - PROCESS | 12092 | RSS: Main: 201527296 10:32:10 INFO - PROCESS | 12092 | 10:32:12 INFO - PROCESS | 12092 | Cycle 1(1): loaded http://localhost:60788/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60788/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:32:12 INFO - PROCESS | 12092 | RSS: Main: 201695232 10:32:12 INFO - PROCESS | 12092 | 10:32:14 INFO - PROCESS | 12092 | Cycle 1(1): loaded http://localhost:60788/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60788/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:32:15 INFO - PROCESS | 12092 | RSS: Main: 215724032 10:32:15 INFO - PROCESS | 12092 | 10:32:18 INFO - PROCESS | 12092 | Cycle 1(1): loaded http://localhost:60788/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60788/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:32:18 INFO - PROCESS | 12092 | RSS: Main: 222879744 10:32:18 INFO - PROCESS | 12092 | 10:32:21 INFO - PROCESS | 12092 | Cycle 1(1): loaded http://localhost:60788/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60788/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:32:22 INFO - PROCESS | 12092 | RSS: Main: 221102080 10:32:22 INFO - PROCESS | 12092 | 10:32:23 INFO - PROCESS | 12092 | Cycle 1(1): loaded http://localhost:60788/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60788/tests/kraken/driver.html?testName=ai-astar) 10:32:24 INFO - PROCESS | 12092 | RSS: Main: 284958720 10:32:24 INFO - PROCESS | 12092 | 10:32:24 INFO - PROCESS | 12092 | __start_tp_report 10:32:24 INFO - PROCESS | 12092 | _x_x_mozilla_page_load 10:32:24 INFO - PROCESS | 12092 | _x_x_mozilla_page_load_details 10:32:24 INFO - PROCESS | 12092 | |i|pagename|runs| 10:32:24 INFO - PROCESS | 12092 | |0;ai-astar;110;114;106;112;114;113;100;113;110;111 10:32:24 INFO - PROCESS | 12092 | |1;audio-beat-detection;154;129;156;192;130;164;166;130;181;128 10:32:24 INFO - PROCESS | 12092 | |2;audio-dft;160;163;162;164;162;160;163;162;161;162 10:32:24 INFO - PROCESS | 12092 | |3;audio-fft;78;78;105;128;79;78;78;117;108;78 10:32:24 INFO - PROCESS | 12092 | |4;audio-oscillator;92;93;154;92;92;93;149;92;100;160 10:32:24 INFO - PROCESS | 12092 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;118;116;117 10:32:24 INFO - PROCESS | 12092 | |6;imaging-darkroom;145;145;150;145;145;145;146;145;146;146 10:32:24 INFO - PROCESS | 12092 | |7;imaging-desaturate;95;95;95;95;94;95;95;95;95;95 10:32:24 INFO - PROCESS | 12092 | |8;json-parse-financial;57;57;59;55;55;58;58;74;54;53 10:32:24 INFO - PROCESS | 12092 | |9;json-stringify-tinderbox;63;64;62;63;62;63;63;64;64;63 10:32:24 INFO - PROCESS | 12092 | |10;stanford-crypto-aes;78;77;78;77;77;86;79;81;88;79 10:32:24 INFO - PROCESS | 12092 | |11;stanford-crypto-ccm;123;124;120;122;121;121;126;123;163;125 10:32:24 INFO - PROCESS | 12092 | |12;stanford-crypto-pbkdf2;171;168;166;170;173;174;166;167;166;169 10:32:24 INFO - PROCESS | 12092 | |13;stanford-crypto-sha256-iterative;72;70;68;68;67;70;69;67;65;69 10:32:24 INFO - PROCESS | 12092 | __end_tp_report 10:32:24 INFO - PROCESS | 12092 | __start_cc_report 10:32:24 INFO - PROCESS | 12092 | _x_x_mozilla_cycle_collect,1628 10:32:24 INFO - PROCESS | 12092 | __end_cc_report 10:32:24 INFO - PROCESS | 12092 | __startTimestamp1461951144147__endTimestamp 10:32:24 INFO - PROCESS | 12092 | 10:32:24 INFO - PROCESS | 12092 | ------- Summary: start ------- 10:32:24 INFO - PROCESS | 12092 | Number of tests: 14 10:32:24 INFO - PROCESS | 12092 | 10:32:24 INFO - PROCESS | 12092 | [#0] ai-astar Cycles:10 Average:110.30 Median:112.50 stddev:4.35 (3.9%) stddev-sans-first:4.61 10:32:24 INFO - PROCESS | 12092 | Values: 110.0 114.0 106.0 112.0 114.0 113.0 100.0 113.0 110.0 111.0 10:32:24 INFO - PROCESS | 12092 | 10:32:24 INFO - PROCESS | 12092 | [#1] audio-beat-detection Cycles:10 Average:153.00 Median:160.00 stddev:23.25 (14.5%) stddev-sans-first:24.65 10:32:24 INFO - PROCESS | 12092 | Values: 154.0 129.0 156.0 192.0 130.0 164.0 166.0 130.0 181.0 128.0 10:32:24 INFO - PROCESS | 12092 | 10:32:24 INFO - PROCESS | 12092 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.29 (0.8%) stddev-sans-first:1.17 10:32:24 INFO - PROCESS | 12092 | Values: 160.0 163.0 162.0 164.0 162.0 160.0 163.0 162.0 161.0 162.0 10:32:24 INFO - PROCESS | 12092 | 10:32:24 INFO - PROCESS | 12092 | [#3] audio-fft Cycles:10 Average:92.70 Median:78.00 stddev:19.69 (25.2%) stddev-sans-first:20.16 10:32:24 INFO - PROCESS | 12092 | Values: 78.0 78.0 105.0 128.0 79.0 78.0 78.0 117.0 108.0 78.0 10:32:24 INFO - PROCESS | 12092 | 10:32:24 INFO - PROCESS | 12092 | [#4] audio-oscillator Cycles:10 Average:111.70 Median:92.00 stddev:29.63 (32.2%) stddev-sans-first:30.56 10:32:24 INFO - PROCESS | 12092 | Values: 92.0 93.0 154.0 92.0 92.0 93.0 149.0 92.0 100.0 160.0 10:32:24 INFO - PROCESS | 12092 | 10:32:24 INFO - PROCESS | 12092 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 10:32:24 INFO - PROCESS | 12092 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 116.0 117.0 10:32:24 INFO - PROCESS | 12092 | 10:32:24 INFO - PROCESS | 12092 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:145.50 stddev:1.55 (1.1%) stddev-sans-first:1.62 10:32:24 INFO - PROCESS | 12092 | Values: 145.0 145.0 150.0 145.0 145.0 145.0 146.0 145.0 146.0 146.0 10:32:24 INFO - PROCESS | 12092 | 10:32:24 INFO - PROCESS | 12092 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 10:32:24 INFO - PROCESS | 12092 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 10:32:24 INFO - PROCESS | 12092 | 10:32:24 INFO - PROCESS | 12092 | [#8] json-parse-financial Cycles:10 Average:58.00 Median:57.50 stddev:5.94 (10.3%) stddev-sans-first:6.29 10:32:24 INFO - PROCESS | 12092 | Values: 57.0 57.0 59.0 55.0 55.0 58.0 58.0 74.0 54.0 53.0 10:32:24 INFO - PROCESS | 12092 | 10:32:24 INFO - PROCESS | 12092 | [#9] json-stringify-tinderbox Cycles:10 Average:63.10 Median:63.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 10:32:24 INFO - PROCESS | 12092 | Values: 63.0 64.0 62.0 63.0 62.0 63.0 63.0 64.0 64.0 63.0 10:32:24 INFO - PROCESS | 12092 | 10:32:24 INFO - PROCESS | 12092 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:79.00 stddev:3.92 (5.0%) stddev-sans-first:4.09 10:32:24 INFO - PROCESS | 12092 | Values: 78.0 77.0 78.0 77.0 77.0 86.0 79.0 81.0 88.0 79.0 10:32:24 INFO - PROCESS | 12092 | 10:32:24 INFO - PROCESS | 12092 | [#11] stanford-crypto-ccm Cycles:10 Average:126.80 Median:123.50 stddev:12.86 (10.4%) stddev-sans-first:13.56 10:32:24 INFO - PROCESS | 12092 | Values: 123.0 124.0 120.0 122.0 121.0 121.0 126.0 123.0 163.0 125.0 10:32:24 INFO - PROCESS | 12092 | 10:32:24 INFO - PROCESS | 12092 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.00 Median:169.50 stddev:2.94 (1.7%) stddev-sans-first:3.03 10:32:24 INFO - PROCESS | 12092 | Values: 171.0 168.0 166.0 170.0 173.0 174.0 166.0 167.0 166.0 169.0 10:32:24 INFO - PROCESS | 12092 | 10:32:24 INFO - PROCESS | 12092 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:1.96 (2.8%) stddev-sans-first:1.62 10:32:24 INFO - PROCESS | 12092 | Values: 72.0 70.0 68.0 68.0 67.0 70.0 69.0 67.0 65.0 69.0 10:32:24 INFO - PROCESS | 12092 | -------- Summary: end -------- 10:32:24 INFO - PROCESS | 12092 | 10:32:25 INFO - TEST-INFO | 12092: exit 0 10:32:25 INFO - TEST-OK | kraken | took 61396ms 10:32:25 INFO - SUITE-END | took 1173s 10:32:25 INFO - Completed test suite (00:19:33) 10:32:25 INFO - javascript benchmark 10:32:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3096.9845150774245, 3143.7170654641077, 3164.6835316468355, 3183.745300375969, 3212.309353489, 5148.099082660528, 5284.3922948860845, 5284.867878303045, 5305.204219367097, 5338.89322213556, 5208.218767184924, 5227.79088836447, 5239.13554263547, 5243.947560524393, 5364.383095943967, 4702.670813043072, 4751.738654373999, 4774.092922344761, 4859.927101093486, 4936.531029552187, 4835.081334546442, 4856.198727210006, 4858.5384388483035, 4908.28829819676, 4908.8036478541, 4705.058988202373, 4715.104130215265, 4739.857804265877, 4775.403074615673, 4785.473597904228, 4663.813447462097, 4680.180968330528, 4689.648276379251, 4697.271922851964, 4720.787564559569, 4659.161350956826, 4676.929846052312, 4683.157031734287, 4696.788644511005, 4744.0, 5161.8193363232485, 5204.323437953042, 5218.582513398919, 5255.421903590602, 5256.710880901549, 5659.037963546166, 5677.801276955328, 5693.3452652945025, 5700.743466544015, 5722.914156287659, 5525.668459892379, 5603.635763675348, 5719.428057194289, 5734.483896449298, 5739.540836733051, 5349.518543331119, 5351.7056561889085, 5364.168553874156, 5371.919421208607, 5425.077736784756, 5821.155932389865, 5824.417558244142, 5825.650460972355, 5856.795012174553, 5863.091220860773, 5486.423925487846, 5548.0845660465575, 5605.32736071674, 5606.355269144101, 5609.102543593087, 5632.943670563324, 5637.46444087811, 5638.718064096779, 5668.03643380618, 5680.630759000652, 5614.747336369792, 5618.0449323615085, 5618.550515958714, 5619.353774315924, 5649.604527683105, 5510.366307874646, 5619.185218143428, 5638.323401191801, 5697.800576979786, 5723.055695810144, 4258.808353624095, 4260.68044896634, 4261.232978063917, 4266.765327906933, 4300.204462174508, 3834.482344883405, 3845.0, 3854.672352849983, 3869.28418242626, 3876.5348158221195, 5220.399654039758, 5344.91982620261, 5345.625806193529, 5432.483914028161, 5445.9727701362035, 5564.749586268627, 5574.414686457944, 5581.162825576196, 5586.24585680936, 5625.6905870176715, 5310.495502927216, 5311.7078560678765, 5314.946850531445, 5315.335583052119, 5360.571154307646, 4747.382840230748, 4789.377380940525, 4852.053849499384, 4871.634627402888, 4892.168331383673, 5736.62711923732, 5779.24869766936, 5780.53755699543, 5783.94216057834, 5784.0, 5503.807366742145, 5590.413006634245, 5597.944020559742, 5601.747921343549, 5647.689377084135, 5886.882262354643, 5951.047832346804, 5961.970190149022, 5963.373845746134, 5978.8206353809455, 5551.084071128219, 5578.163275508706, 5587.972060139836, 5588.329400471969, 5595.188697638901, 5622.634528755618, 5645.1532270159805, 5657.8019769307875, 5658.7736490541565, 5687.630304030225, 5434.266374039454, 5501.312335958005, 5548.029094908295, 5588.161775733673, 5599.860003499945, 5423.132298832168, 5465.535429488538, 5466.398696143341, 5467.535259502987, 5472.808451704172, 5363.463653634605, 5384.569234461312, 5392.568594512351, 5410.97294513525, 5446.809361672323, 5519.834404967857, 5563.443655634566, 5583.218349431002, 5626.578006649435, 5631.0427227372265, 5431.837044888502, 5438.510534051954, 5441.428649991693, 5441.83674489766, 5448.182772584144], "value": 5201.572626386802, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [644.6776611694153, 649.1398896462185, 651.7262749645146, 656.3174298729322, 661.9635920024397, 37323.81338093309, 39504.40743388851, 39515.80242098789, 39523.60476395235, 39597.20805583886, 42032.0, 42719.14561708764, 42823.3576496352, 42832.357514637304, 42854.78572607133, 8399.832003359928, 8606.526641034741, 8606.827863442728, 8607.569621518931, 8618.396712230146, 8457.238848503634, 8598.914010859906, 8608.87086693697, 8809.603567839462, 8815.911840881605, 8820.382573219877, 8890.288776897833, 8893.199612034916, 8893.42192757472, 8896.37725359225, 8750.343724220676, 8812.339074569401, 8819.51492667903, 8825.558722063872, 8836.293096552261, 8734.257588105018, 8865.55672216393, 8866.911330886673, 8875.068117847597, 8880.822383552293, 40718.1856362874, 41350.58649413497, 41361.37957930633, 41390.0, 41455.37816932749, 3339.9499007514905, 3908.863189788344, 4086.162336720965, 4088.8773336799945, 4194.3498757692305, 31633.84183079093, 32140.678593214, 32204.67795322064, 32282.0, 32545.02364929056, 4247.532771395144, 4318.373835793793, 4323.178596066738, 4342.869713908588, 4345.326474396474, 324808.0, 329582.0, 331124.0, 331204.0, 331274.0, 45173.77413112913, 50196.49803501991, 57849.13226301609, 57852.421475785544, 58312.0, 53871.73064134733, 54235.18647220295, 54318.45681543213, 54405.0, 54517.45482545124, 15375.692486150214, 15754.369825207092, 15759.212039397984, 15761.133137677538, 15762.290696918666, 10487.108595769445, 11429.0, 11493.195476316745, 11671.299722016705, 12112.939435302767, 16389.754153687703, 16614.252358643647, 16631.0, 16658.167091645613, 16761.580960476087, 5939.485431215013, 6001.099835024781, 6007.249093863267, 6095.786647467317, 6195.783147589813, 1023.6110278094426, 1034.3483605328595, 1055.873295204565, 1068.0921216965517, 1113.0261021606095, 31776.682233177835, 32020.679793202235, 32276.19309517281, 32346.35307293841, 32742.34515309728, 1164.7670465906683, 1167.6380322100176, 1168.760404117154, 1203.272020427646, 1238.6222202228407, 16635.83364166367, 17255.56861078458, 17416.564585885455, 17427.564310892074, 17497.67991225842, 509604.0, 518685.0, 521919.0, 523035.0, 524749.0, 58445.41554584485, 58542.0, 58876.0, 58900.41099588949, 58924.7053764737, 1346.0, 1391.844768841859, 1404.389090745529, 1404.5716056602835, 1411.4452840358983, 30555.2361190972, 31106.37787244197, 31567.526487103172, 31888.202794930312, 32224.0, 51818.0, 51998.0, 52280.0, 52337.47662523478, 52368.47631523636, 320409.0, 413642.0, 417302.0, 420827.0, 421798.0, 36129.63870361368, 37337.81331093327, 37518.62332390098, 38287.80856095702, 38914.22171556496, 46292.0, 46497.0, 46576.0, 46609.533904661876, 47693.0, 38982.4152637705, 39138.608613914635, 39170.60829391784, 39189.0, 39621.2075758489, 39213.80393098016, 39221.803890980365, 39261.41107883327, 39482.40776388414, 39544.0, 38200.808995954845, 39536.04639536023, 39602.801985989885, 39666.0, 39959.2008159841, 31006.53490197694, 32428.513572296906, 32887.17782055372, 32900.34199315953, 33296.833515832266, 25097.87451062733, 25287.241382758548, 25375.238742837744, 25532.48935021326, 25622.231333060037], "value": 19667.09385380278, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.485221281355, 370.10065540736, 374.24962949286675, 377.30575740637227, 381.87398158607664, 13844.377003034862, 17446.82553174468, 17920.46238612842, 18125.637487250246, 18138.3651572195, 17901.0, 18360.26558937641, 19012.429627111174, 19265.903670481664, 19342.12960416781, 5303.469653034695, 5543.77824887004, 5565.053940830048, 5565.888682226353, 5569.721513924308, 3985.9202815943663, 5485.588580856432, 5678.829635110953, 6114.877702445949, 6134.17188679527, 6050.152978583002, 6062.514998800108, 6065.302490213638, 6085.969570152143, 6087.726052327655, 6854.965725171367, 7225.132984041896, 7232.385247253989, 7233.24050974648, 7239.420846332281, 4443.311286750527, 6758.8310292242595, 7094.0, 7100.964495177543, 7103.325184107502, 23244.3026709199, 23797.167099151447, 24298.0, 24324.148654797173, 24753.5049299013, 2385.5467461182493, 2434.6591477193206, 2543.923682289534, 2564.9358766030814, 3047.3295874907485, 14828.70342593153, 15397.153156576383, 15407.0, 15883.36466541337, 16256.75614865778, 1991.71120187572, 2117.788221177885, 2127.8936053197435, 2151.5051538146313, 2184.803367696915, 87548.56225718894, 88260.73125633715, 88479.0, 89010.99999999935, 89062.0, 14270.02332814926, 15729.292181851844, 17060.57348566271, 17757.200925958103, 17857.910710446366, 31788.205294867814, 31868.362632747678, 31994.680053199634, 32093.839530802663, 32171.678283217338, 9233.122853328923, 9262.0, 9485.857712134324, 9531.475768832643, 9585.952070239604, 7622.047244094489, 7634.122075961335, 7736.6518506667335, 7739.574323412154, 7870.881936770953, 8589.656413743505, 8870.778230544289, 8925.241354484811, 9083.772905677279, 9095.727128186165, 3333.5333053372547, 3386.7629265951145, 3419.230673098533, 3438.7249020078334, 3562.966739645474, 982.2829334585792, 993.5777294649745, 1007.9207920792079, 1039.8492218628257, 1071.3304184884448, 17527.29890804379, 17798.46604601864, 18092.90953545224, 18270.0, 18726.344577939708, 993.5677980078689, 993.9602415903428, 1011.9342242754198, 1013.4848401639596, 1066.4454483668449, 10026.899731002743, 10176.135028522658, 10446.015257101279, 10483.161347092215, 10533.736656583647, 481764.0, 488567.0, 489759.0, 492441.0, 496332.0, 85231.5738421304, 87263.56368218118, 89290.0, 91731.54134229287, 91736.0, 992.0525897767759, 998.6404894238068, 1025.9025392587691, 1027.660871912267, 1029.897010298964, 13027.47890084386, 15591.0, 15981.200939952723, 16272.0, 16313.265903034155, 36220.0, 38493.230135397695, 38601.42097868478, 39408.2118357637, 39450.80274598609, 46099.53900460953, 47488.52511474841, 48524.514754851996, 48985.51014489809, 50343.0, 7813.960930195312, 7949.364050876032, 7969.960150199212, 8031.59842007909, 8104.0, 8875.334349923653, 11697.204146299977, 12009.759804804029, 12674.239545627292, 13335.866641333463, 11541.422928853692, 11712.824307635221, 11797.88202117968, 11885.22746021506, 11966.64100076999, 11305.208635395444, 11380.886191137983, 11574.363410012531, 11721.12091593151, 11748.0, 11529.308241505536, 11621.302721836717, 11660.475278612652, 11700.0, 11709.531618735155, 7932.484388514728, 7993.400494962785, 8271.793205169919, 8352.87470687928, 8551.444156129832, 10398.58405663765, 11283.887161128283, 11360.943195283971, 11408.429578521207, 11729.120315976164], "value": 9914.542859233166, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1343.4357569820675, 1482.7924090627312, 1495.55133459962, 1658.286936617255, 1808.0778802810562, 7505.0, 7910.406719496046, 7911.802204944879, 7920.0, 7921.247481489257, 7564.6217689115465, 7824.765257042298, 7832.8041798955055, 7845.411594130434, 7856.096548896879, 1876.0900963032918, 1948.7333233398333, 1948.9767871867311, 2198.065822025637, 2225.63277059285, 2212.1483228956886, 2293.1515339324474, 2295.0475552645717, 2297.1844995026777, 2297.483066310075, 2173.89130543473, 2208.4147700859285, 2216.1135545781735, 2225.5993921094196, 2228.4985878177363, 1903.181631898297, 2150.817180539656, 2202.0861342542826, 2207.4591725027312, 2207.768184340637, 2210.2043264424956, 2229.665550167472, 2236.5862315471527, 2237.59723249815, 2237.7874101960288, 7790.922090779133, 7830.373570114434, 7834.56909869957, 7843.019622547182, 7847.568383738892, 4661.813527458898, 4808.855734327975, 4816.0, 4835.0, 4857.611391088704, 2900.796944213906, 3083.722464978163, 3085.182426656938, 3094.8297843618593, 3123.375324935022, 1007.8034783217275, 1008.6873069348452, 1011.3476807459222, 1025.7692019295673, 1081.3403823667556, 11067.391293478855, 11089.05743011845, 11091.944540277327, 11112.277701949428, 11129.220954533186, 4155.937660935088, 4223.704340696183, 4236.809343579546, 4338.674599405057, 4386.035072284092, 9315.068493150766, 9335.206507446943, 9360.62557497706, 9368.90631093694, 9376.343655944018, 4831.251156070744, 4831.5651591356245, 4842.273658951115, 4845.370101886802, 4887.560119589183, 4043.4137050127565, 4404.8458303959205, 4434.955650443454, 4516.254817955067, 4537.410136682211, 3727.6645101940953, 3750.5686846012513, 3805.4101614249835, 3813.866514671973, 3843.8846834595006, 1185.5968970550055, 1191.92252503587, 1203.4283715235192, 1215.775081609905, 1222.3155033181447, 1008.621766837436, 1023.6928921323573, 1027.9229057820694, 1032.3135115148493, 1034.637876743149, 5781.017227071408, 5830.067189249699, 5844.795432159854, 5846.532277417881, 6007.579469437185, 406.3214431898677, 408.48495333660395, 428.66992415839627, 430.34372581812363, 433.4040694045687, 4135.627793498599, 4156.709030367906, 4191.517975432804, 4208.158368326347, 4258.446401967724, 9623.278254130968, 9796.363236389612, 9905.20758339331, 9976.750581235527, 9986.900130998742, 9509.0, 9642.71071867845, 9810.705678829647, 9865.0, 9883.703488895344, 7462.141853686787, 7533.924660753322, 7542.170361260257, 7553.773386798405, 7625.885611715828, 5594.0769772987005, 5646.85882852932, 5697.676143020292, 5729.54163666914, 5817.185594016925, 9216.493092879688, 9228.676996305097, 9311.068893110634, 9333.160015598629, 9439.480828554495, 9219.44683319003, 9299.163075323253, 9421.246300296098, 9453.905460945578, 9484.288678349014, 7023.262557431396, 7046.365827075383, 7069.469789765891, 7095.361417472246, 7234.457415693949, 7772.92227077722, 7783.104942931409, 7791.104023037196, 7804.219578042151, 7869.84260314779, 6947.201071876799, 6981.79054628362, 7127.144742630918, 7232.0959880015, 7235.891461627974, 6992.930070699432, 7013.473989450914, 7030.0, 7073.893891591733, 7113.715451381887, 6657.667116644246, 6689.09697190873, 6694.397504224448, 6708.664566771739, 6729.461643068445, 4820.734859582616, 4831.468538460696, 4850.151223535797, 4868.48880867518, 4903.190973489334, 4866.7079975201605, 4926.630502712239, 4996.450390456974, 5027.296178535081, 5083.542481176712], "value": 4246.076404295323, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.6256273251603, 294.25846865897927, 298.5357768669719, 303.8268187133334, 305.6958326465167, 5183.770978479252, 5221.06020916235, 5234.55506281966, 5239.580833533318, 5241.659292146012, 5151.253068305094, 5155.149400348938, 5162.741862906849, 5172.6637768545015, 5185.3777546694355, 3739.906502337436, 3859.3246181918194, 3998.400239964014, 4050.8177132029127, 4069.837206511736, 4000.8599699010542, 4021.8994525136814, 4039.6970227233073, 4047.8785636430953, 4060.20825938942, 3763.6236376362417, 3992.6805855531634, 4002.899927501807, 4016.15660711251, 4017.1764788218493, 3887.105965627907, 3956.2680904032704, 3964.702647301464, 3969.920601587952, 4004.759714417115, 3446.913827154316, 3450.4824276358495, 3456.9654303456896, 3468.9479657805155, 3475.982620086909, 5021.39743230811, 5038.773255203525, 5039.118154323016, 5052.242163675442, 5063.367079115111, 4301.139772045603, 4529.297958816389, 4542.136993971135, 4555.362249285103, 4570.862874113749, 5367.355917289911, 5406.729663516809, 5410.756515956791, 5423.349198096214, 5439.918401223985, 3789.6589306962505, 3801.3347664158937, 3809.5238095238096, 3813.866514671973, 3819.8090095495113, 5517.944820551783, 5646.491815736604, 5648.378678345379, 5650.152477128422, 5671.865626874642, 3783.129880127586, 3794.6964242860504, 3795.582485926546, 3802.3535998880257, 3815.847366105325, 3830.4637350770913, 3844.8654297099465, 3857.40210267409, 3865.710071744574, 3868.883933482, 4414.0, 4502.797374118172, 4516.503184649686, 4531.84138555149, 4558.8632341029825, 5387.838364849061, 5446.945530544723, 5467.343918729778, 5486.31421072366, 5504.944950550524, 1389.833220013605, 1412.9434822606981, 1415.6107070555474, 1424.586869807765, 1425.4227038049607, 855.6149732620346, 905.6241659711146, 916.5188276155072, 944.7401964459691, 982.1700662939804, 5473.863153421116, 5575.494616453535, 5630.789380283177, 5631.267935168402, 5654.264945557051, 5927.4665280125, 5940.762369505258, 5945.4649081582, 5947.464728174485, 5969.820905372846, 5445.346558413015, 5589.133684278943, 5593.916091258634, 5599.348192283286, 5612.85967850807, 3144.748420126384, 3151.779375443697, 3157.131788758064, 3167.0973772474736, 3180.2685382361724, 5945.524358051345, 6109.694515274218, 6117.816465506042, 6124.785632502841, 6153.353897840751, 6052.485538729257, 6066.848328791815, 6074.331823499411, 6095.969520152459, 6096.847578810476, 6155.47678447337, 6164.4280708419965, 6169.352218017133, 6198.442140207403, 6201.7519299228425, 5762.423757624204, 5869.618474799125, 5886.882262354643, 5892.882142357214, 5915.674637894957, 5797.826065218051, 5806.216160818235, 5840.445157710011, 5844.47399734026, 5860.150278209721, 5979.103134529855, 6116.143739876332, 6116.541259405473, 6147.538934579835, 6163.106349579196, 4155.210510003089, 4174.1443004184675, 4176.43618111551, 4179.26862799015, 4183.49798024239, 5979.940200597938, 5997.280326360865, 5999.400059993965, 6000.399960003964, 6001.189839371629, 5639.351474580311, 5802.564807639359, 5809.651420914759, 5812.360640329476, 5828.854278643068, 5780.132980053026, 5780.624259423124, 5800.1299805029585, 5807.373935298123, 5807.941920580909, 5165.199394093921, 5265.341832270966, 5396.21754845553, 5749.683767392834, 5752.827415177551, 5552.139418390156, 5553.888922221452, 5558.0, 5566.749496272759, 5617.382087970402, 5411.701191714039, 5414.7021913795115, 5456.454354564512, 5460.672359658433, 5469.863253418696], "value": 4223.2868478451865, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [800.7277525641282, 810.1169724999753, 817.7383237364046, 826.9421140520162, 836.9455985360951, 13572.0, 13825.654358641039, 13844.100133491342, 13866.098703584259, 14006.509772157977, 12908.160969536997, 13506.527271545498, 13524.864751352483, 13533.661658458543, 13557.440894297135, 689.1833177684435, 797.2067792546395, 823.0493779684474, 824.958752062396, 826.3678286111129, 822.440740296598, 823.300194834392, 826.2893911236332, 826.7437094500724, 828.4035494443991, 861.9396642235046, 865.2645251536206, 865.3207232322628, 865.5801936061006, 866.527742380401, 714.7141143542573, 841.2975165736617, 866.3242670716788, 867.4448353054019, 868.3964644572025, 624.1449214576014, 624.753222477119, 626.4424662050778, 630.8580569371901, 631.0187658191556, 13863.792043119362, 13887.4445022199, 13915.0, 13931.094478858842, 13995.79006314896, 13393.464261429532, 13695.178289302574, 13708.17750934947, 13986.0, 14092.365843536963, 10709.839352409721, 10834.133269338434, 10935.671929842118, 11161.107111431065, 11181.72045698856, 4362.8036738346855, 4425.35832304314, 4506.211413002711, 4576.405067341258, 4579.656525760582, 49632.53307202333, 50142.247866282036, 50474.24288635673, 51177.48822511802, 51737.0, 9934.900650993543, 10081.243906706879, 10136.746581335525, 10161.54273057714, 10246.38521688701, 17947.73078403825, 18077.548061298574, 18186.727199091758, 18356.0, 18396.448106556825, 8411.3270938326, 8429.32565394767, 8445.788855278668, 8561.229489345864, 8675.436096653697, 4679.181143299909, 4813.663043586916, 4818.397700287464, 4844.733539655353, 4913.6069114471475, 3276.672332766704, 3359.277755282626, 3374.9662503375143, 3379.3579219948133, 3380.0873764084054, 594.7264258441165, 605.170915845286, 644.8806970710434, 656.9244536878225, 681.7716065118241, 700.4641449291296, 737.5824568544035, 745.7017193122686, 757.6742000939539, 783.9882401763978, 8320.958395208107, 8886.644534218689, 8893.777655558662, 8931.464112153291, 9272.814543709088, 735.1664541860355, 741.9888701669479, 754.6868049759398, 758.9354904833151, 763.4159867701213, 4290.528041915387, 4588.151192029419, 4590.632749380042, 4618.722876627413, 4647.6281897448125, 65519.0, 66588.6670566644, 67285.0, 67360.0, 67684.66157669279, 57060.71469642625, 57494.7125264371, 59337.703311483165, 60372.39627603668, 61267.0, 46640.300395494094, 53776.46223537793, 54341.45658543443, 54388.728056360254, 55896.0, 8836.955815220883, 8966.462012279284, 9060.0, 9115.589798459217, 9131.269498440242, 33743.83128084344, 33981.83009084939, 34232.657673422946, 34663.30673386468, 34972.30055398827, 41135.38296925608, 44988.32517512306, 45215.0, 45881.0, 46194.076118478115, 11275.436228188722, 11497.655070347902, 11632.825507617223, 11791.29252244868, 11953.521859125538, 12046.939765301468, 12168.939155304166, 12436.19164754288, 13320.86679133235, 13341.132826366254, 12403.635600083802, 12491.93754031224, 12581.182223155465, 12612.684682883002, 12905.622987366856, 11958.22271552381, 12492.25046497213, 12503.624891253277, 13025.218486890817, 13273.800892986807, 12183.147179697336, 12334.444949977453, 12504.124711270124, 12731.172473789175, 13024.609261722164, 10182.490875456346, 10302.278840481094, 10559.208059395422, 10844.67465976022, 10860.565577376816, 10441.164706823283, 10781.657686117329, 10846.457677115955, 10860.782784344427, 10921.126309895031], "value": 6761.160719938314, "unit": "score"}], "name": "dromaeo_css", "value": 7051.952850346964, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 114.0, 106.0, 112.0, 114.0, 113.0, 100.0, 113.0, 110.0, 111.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 129.0, 156.0, 192.0, 130.0, 164.0, 166.0, 130.0, 181.0, 128.0], "value": 153.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 163.0, 162.0, 164.0, 162.0, 160.0, 163.0, 162.0, 161.0, 162.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 105.0, 128.0, 79.0, 78.0, 78.0, 117.0, 108.0, 78.0], "value": 92.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 154.0, 92.0, 92.0, 93.0, 149.0, 92.0, 100.0, 160.0], "value": 111.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 116.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 150.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 59.0, 55.0, 55.0, 58.0, 58.0, 74.0, 54.0, 53.0], "value": 58.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 62.0, 63.0, 62.0, 63.0, 63.0, 64.0, 64.0, 63.0], "value": 63.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 78.0, 77.0, 77.0, 86.0, 79.0, 81.0, 88.0, 79.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 124.0, 120.0, 122.0, 121.0, 121.0, 126.0, 123.0, 163.0, 125.0], "value": 126.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 168.0, 166.0, 170.0, 173.0, 174.0, 166.0, 167.0, 166.0, 169.0], "value": 169.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 70.0, 68.0, 68.0, 67.0, 70.0, 69.0, 67.0, 65.0, 69.0], "value": 68.5, "unit": "score"}], "name": "kraken", "value": 1552.7, "alertThreshold": 2.0}]} 10:32:25 INFO - Return code: 0 10:32:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:32:25 ERROR - # TBPL SUCCESS # 10:32:25 INFO - Running post-action listener: _resource_record_post_action 10:32:25 INFO - Running post-run listener: _resource_record_post_run 10:32:26 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 535908352; Read time: 0; Write time: 470164 10:32:26 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244944896; Read time: 0; Write time: 287136 10:32:26 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 290963456; Read time: 0; Write time: 183028 10:32:26 INFO - Running post-run listener: _upload_blobber_files 10:32:26 INFO - Blob upload gear active. 10:32:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:32:26 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 10:32:26 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'] 10:32:26 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 10:32:26 INFO - (blobuploader) - INFO - Open directory for files ... 10:32:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:32:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:32:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:32:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:32:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:32:28 INFO - (blobuploader) - INFO - Done attempting. 10:32:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:32:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:32:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:32:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:32:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:32:29 INFO - (blobuploader) - INFO - Done attempting. 10:32:29 INFO - (blobuploader) - INFO - Iteration through files over. 10:32:29 INFO - Return code: 0 10:32:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:32:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:32:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fb7b36f81cad05f67dfd92452196ab28fadc8f1be357d69f53c0cf1338094c119b4f46975aa21e99c1e31a023ab0221decdd28499c72f0f00182d406a57c2217", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8b9b306a286c15c0a812fb292ea6822ce7de14cb0ea2f930cce2b32e5257d435b3ab478519aa8e0c3594a57941bf1bb76c34d5b6ddb0945c18f31fe82c33dd14"} 10:32:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:32:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:32:29 INFO - Contents: 10:32:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fb7b36f81cad05f67dfd92452196ab28fadc8f1be357d69f53c0cf1338094c119b4f46975aa21e99c1e31a023ab0221decdd28499c72f0f00182d406a57c2217", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8b9b306a286c15c0a812fb292ea6822ce7de14cb0ea2f930cce2b32e5257d435b3ab478519aa8e0c3594a57941bf1bb76c34d5b6ddb0945c18f31fe82c33dd14"} 10:32:29 INFO - Running post-run listener: copy_logs_to_upload_dir 10:32:29 INFO - Copying logs to upload dir... 10:32:29 INFO - mkdir: /builds/slave/test/build/upload/logs 10:32:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.652334 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-04-29 10:32:29.131848) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 10:32:29.135059) ========= 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=8887e36bb8e381bfd44124ac000001a8-1461943084.578579-204733650 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/fb7b36f81cad05f67dfd92452196ab28fadc8f1be357d69f53c0cf1338094c119b4f46975aa21e99c1e31a023ab0221decdd28499c72f0f00182d406a57c2217", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8b9b306a286c15c0a812fb292ea6822ce7de14cb0ea2f930cce2b32e5257d435b3ab478519aa8e0c3594a57941bf1bb76c34d5b6ddb0945c18f31fe82c33dd14"} build_url:https://queue.taskcluster.net/v1/task/MdnBDEUKSD6hQqW4QTb3Pg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011194 build_url: 'https://queue.taskcluster.net/v1/task/MdnBDEUKSD6hQqW4QTb3Pg/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/fb7b36f81cad05f67dfd92452196ab28fadc8f1be357d69f53c0cf1338094c119b4f46975aa21e99c1e31a023ab0221decdd28499c72f0f00182d406a57c2217", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8b9b306a286c15c0a812fb292ea6822ce7de14cb0ea2f930cce2b32e5257d435b3ab478519aa8e0c3594a57941bf1bb76c34d5b6ddb0945c18f31fe82c33dd14"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 10:32:29.159103) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 10:32:29.159400) ========= 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=8887e36bb8e381bfd44124ac000001a8-1461943084.578579-204733650 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004440 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 10:32:29.243618) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 10:32:29.243930) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 10:32:29.244205) ========= ========= Total master_lag: 0.16 =========