builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-040 starttime: 1461765460.89 results: success (0) buildid: 20160427043016 builduid: 0b1a265df1434ee19a83ac7285e3a2d5 revision: bc40974a002f891b186432370547a370984e35a7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 06:57:40.892076) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 06:57:40.892568) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 06:57:40.892891) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 06:57:41.007002) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 06:57:41.007266) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1461756990.560480-593053154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-27 06:57:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2016-04-27 06:57:42 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085799 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 06:57:41.107360) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 06:57:41.107689) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1461756990.560480-593053154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019168 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 06:57:41.160820) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 06:57:41.161164) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev bc40974a002f891b186432370547a370984e35a7 --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 bc40974a002f891b186432370547a370984e35a7 --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=9e0dfe3369c33a1556e63f89000001d8-1461756990.560480-593053154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-27 06:57:42,138 truncating revision to first 12 chars 2016-04-27 06:57:42,138 Setting DEBUG logging. 2016-04-27 06:57:42,138 attempt 1/10 2016-04-27 06:57:42,138 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/bc40974a002f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-27 06:57:42,393 unpacking tar archive at: mozilla-inbound-bc40974a002f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.585889 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 06:57:41.767644) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 06:57:41.767923) ========= script_repo_revision: bc40974a002f891b186432370547a370984e35a7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 06:57:41.768293) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 06:57:41.768562) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 06:57:41.784709) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-04-27 06:57:41.785013) ========= /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=9e0dfe3369c33a1556e63f89000001d8-1461756990.560480-593053154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:57:42 INFO - MultiFileLogger online at 20160427 06:57:42 in /builds/slave/test 06:57:42 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 06:57:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:57:42 INFO - {'append_to_log': False, 06:57:42 INFO - 'base_work_dir': '/builds/slave/test', 06:57:42 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 06:57:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:57:42 INFO - 'branch': 'Mozilla-Inbound', 06:57:42 INFO - 'buildbot_json_path': 'buildprops.json', 06:57:42 INFO - 'config_files': ('talos/linux_config.py',), 06:57:42 INFO - 'default_actions': ('clobber', 06:57:42 INFO - 'read-buildbot-config', 06:57:42 INFO - 'download-and-extract', 06:57:42 INFO - 'populate-webroot', 06:57:42 INFO - 'create-virtualenv', 06:57:42 INFO - 'install', 06:57:42 INFO - 'run-tests'), 06:57:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:57:42 INFO - 'download_minidump_stackwalk': True, 06:57:42 INFO - 'download_symbols': 'ondemand', 06:57:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:57:42 INFO - 'tooltool.py': '/tools/tooltool.py', 06:57:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:57:42 INFO - '/tools/misc-python/virtualenv.py')}, 06:57:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:57:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:57:42 INFO - 'installer_path': 'installer.exe', 06:57:42 INFO - 'log_level': 'info', 06:57:42 INFO - 'log_name': 'talos', 06:57:42 INFO - 'log_to_console': True, 06:57:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:57:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:57:42 INFO - 'opt_config_files': (), 06:57:42 INFO - 'pip_index': False, 06:57:42 INFO - 'sps_profile': False, 06:57:42 INFO - 'sps_profile_interval': 0, 06:57:42 INFO - 'suite': 'dromaeojs', 06:57:42 INFO - 'system_bits': '32', 06:57:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:57:42 INFO - 'title': 'talos-linux64-ix-040', 06:57:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:57:42 INFO - 'use_talos_json': True, 06:57:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:57:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:57:42 INFO - 'work_dir': 'build'} 06:57:42 INFO - ##### 06:57:42 INFO - ##### Running clobber step. 06:57:42 INFO - ##### 06:57:42 INFO - Running pre-action listener: _resource_record_pre_action 06:57:42 INFO - Running main action method: clobber 06:57:42 INFO - rmtree: /builds/slave/test/build 06:57:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:57:43 INFO - Running post-action listener: _resource_record_post_action 06:57:43 INFO - ##### 06:57:43 INFO - ##### Running read-buildbot-config step. 06:57:43 INFO - ##### 06:57:43 INFO - Running pre-action listener: _resource_record_pre_action 06:57:43 INFO - Running main action method: read_buildbot_config 06:57:43 INFO - Using buildbot properties: 06:57:43 INFO - { 06:57:43 INFO - "project": "", 06:57:43 INFO - "product": "firefox", 06:57:43 INFO - "script_repo_revision": "production", 06:57:43 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 06:57:43 INFO - "repository": "", 06:57:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 06:57:43 INFO - "buildid": "20160427043016", 06:57:43 INFO - "pgo_build": "True", 06:57:43 INFO - "basedir": "/builds/slave/test", 06:57:43 INFO - "buildnumber": 1756, 06:57:43 INFO - "slavename": "talos-linux64-ix-040", 06:57:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:57:43 INFO - "platform": "ubuntu64_hw", 06:57:43 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 06:57:43 INFO - "branch": "mozilla-inbound", 06:57:43 INFO - "repo_path": "integration/mozilla-inbound", 06:57:43 INFO - "revision": "bc40974a002f891b186432370547a370984e35a7", 06:57:43 INFO - "stage_platform": "linux64-pgo", 06:57:43 INFO - "builduid": "0b1a265df1434ee19a83ac7285e3a2d5", 06:57:43 INFO - "slavebuilddir": "test" 06:57:43 INFO - } 06:57:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/LQOl2fRST_mWU8CEcbfq9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 06:57:43 INFO - Running post-action listener: _resource_record_post_action 06:57:43 INFO - ##### 06:57:43 INFO - ##### Running download-and-extract step. 06:57:43 INFO - ##### 06:57:43 INFO - Running pre-action listener: _resource_record_pre_action 06:57:43 INFO - Running main action method: download_and_extract 06:57:43 INFO - mkdir: /builds/slave/test/build/tests 06:57:43 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')]} 06:57:43 INFO - https://queue.taskcluster.net/v1/task/LQOl2fRST_mWU8CEcbfq9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:57:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQOl2fRST_mWU8CEcbfq9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:57:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQOl2fRST_mWU8CEcbfq9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:57:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQOl2fRST_mWU8CEcbfq9Q/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 06:57:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQOl2fRST_mWU8CEcbfq9Q/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 06:57:52 INFO - Downloaded 1361 bytes. 06:57:52 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:57:52 INFO - Using the following test package requirements: 06:57:52 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 06:57:52 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:57:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:57:52 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:57:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:57:52 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:57:52 INFO - u'jsshell-linux-x86_64.zip'], 06:57:52 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:57:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:57:52 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 06:57:52 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:57:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:57:52 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:57:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:57:52 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:57:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:57:52 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:57:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:57:52 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:57:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:52 INFO - https://queue.taskcluster.net/v1/task/LQOl2fRST_mWU8CEcbfq9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:57:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQOl2fRST_mWU8CEcbfq9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:57:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQOl2fRST_mWU8CEcbfq9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:57:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQOl2fRST_mWU8CEcbfq9Q/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 06:57:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQOl2fRST_mWU8CEcbfq9Q/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 06:57:56 INFO - Downloaded 23865969 bytes. 06:57:56 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'] 06:57:56 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 06:57:57 INFO - Return code: 0 06:57:57 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 06:57:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:57 INFO - https://queue.taskcluster.net/v1/task/LQOl2fRST_mWU8CEcbfq9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:57:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQOl2fRST_mWU8CEcbfq9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:57:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQOl2fRST_mWU8CEcbfq9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:57:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQOl2fRST_mWU8CEcbfq9Q/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 06:57:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQOl2fRST_mWU8CEcbfq9Q/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 06:57:59 INFO - Downloaded 23865969 bytes. 06:57:59 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'] 06:57:59 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 06:58:00 INFO - Return code: 0 06:58:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:00 INFO - https://queue.taskcluster.net/v1/task/LQOl2fRST_mWU8CEcbfq9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:58:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQOl2fRST_mWU8CEcbfq9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:58:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQOl2fRST_mWU8CEcbfq9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:58:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQOl2fRST_mWU8CEcbfq9Q/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 06:58:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQOl2fRST_mWU8CEcbfq9Q/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 06:58:01 INFO - Downloaded 10840145 bytes. 06:58:01 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'] 06:58:01 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 06:58:02 INFO - Return code: 0 06:58:02 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')]} 06:58:02 INFO - https://queue.taskcluster.net/v1/task/LQOl2fRST_mWU8CEcbfq9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:58:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQOl2fRST_mWU8CEcbfq9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:58:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQOl2fRST_mWU8CEcbfq9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:58:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQOl2fRST_mWU8CEcbfq9Q/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 06:58:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQOl2fRST_mWU8CEcbfq9Q/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 06:58:04 INFO - Downloaded 58376033 bytes. 06:58:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LQOl2fRST_mWU8CEcbfq9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:58:04 INFO - mkdir: /builds/slave/test/properties 06:58:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:58:04 INFO - Writing to file /builds/slave/test/properties/build_url 06:58:04 INFO - Contents: 06:58:04 INFO - build_url:https://queue.taskcluster.net/v1/task/LQOl2fRST_mWU8CEcbfq9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:58:05 INFO - Running post-action listener: _resource_record_post_action 06:58:05 INFO - Running post-action listener: set_extra_try_arguments 06:58:05 INFO - ##### 06:58:05 INFO - ##### Running populate-webroot step. 06:58:05 INFO - ##### 06:58:05 INFO - Running pre-action listener: _resource_record_pre_action 06:58:05 INFO - Running main action method: populate_webroot 06:58:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:58:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:58:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:58:05 INFO - '--tppagecycles', 06:58:05 INFO - '7'], 06:58:05 INFO - 'tests': ['tsvgm']}}, 06:58:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:58:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:58:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:58:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:58:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:58:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:58:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:05 INFO - 'talos_options': ['--disable-e10s'], 06:58:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:58:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:58:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:05 INFO - 'talos_options': ['--disable-e10s'], 06:58:05 INFO - 'tests': ['damp', 'tps']}, 06:58:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:05 INFO - 'tests': ['damp', 'tps']}, 06:58:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:58:05 INFO - 'tests': ['dromaeo_dom']}, 06:58:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:58:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:58:05 INFO - 'tests': ['a11yr', 06:58:05 INFO - 'ts_paint', 06:58:05 INFO - 'tpaint', 06:58:05 INFO - 'sessionrestore', 06:58:05 INFO - 'sessionrestore_no_auto_restore', 06:58:05 INFO - 'tabpaint']}, 06:58:05 INFO - 'other-e10s': {'tests': ['a11yr', 06:58:05 INFO - 'ts_paint', 06:58:05 INFO - 'tpaint', 06:58:05 INFO - 'sessionrestore', 06:58:05 INFO - 'sessionrestore_no_auto_restore', 06:58:05 INFO - 'tabpaint']}, 06:58:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:58:05 INFO - 'ts_paint', 06:58:05 INFO - 'tpaint', 06:58:05 INFO - 'sessionrestore', 06:58:05 INFO - 'sessionrestore_no_auto_restore', 06:58:05 INFO - 'tabpaint']}, 06:58:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:58:05 INFO - 'ts_paint', 06:58:05 INFO - 'tpaint', 06:58:05 INFO - 'sessionrestore', 06:58:05 INFO - 'sessionrestore_no_auto_restore', 06:58:05 INFO - 'tabpaint']}, 06:58:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:58:05 INFO - 'tests': ['a11yr', 06:58:05 INFO - 'ts_paint', 06:58:05 INFO - 'tpaint', 06:58:05 INFO - 'sessionrestore', 06:58:05 INFO - 'sessionrestore_no_auto_restore', 06:58:05 INFO - 'tabpaint']}, 06:58:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:58:05 INFO - 'tests': ['a11yr', 06:58:05 INFO - 'ts_paint', 06:58:05 INFO - 'tpaint', 06:58:05 INFO - 'sessionrestore', 06:58:05 INFO - 'sessionrestore_no_auto_restore', 06:58:05 INFO - 'tabpaint']}, 06:58:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:58:05 INFO - 'tests': ['tsvgx', 06:58:05 INFO - 'tsvgr_opacity', 06:58:05 INFO - 'tart', 06:58:05 INFO - 'tscrollx', 06:58:05 INFO - 'cart']}, 06:58:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:58:05 INFO - 'tsvgr_opacity', 06:58:05 INFO - 'tart', 06:58:05 INFO - 'tscrollx', 06:58:05 INFO - 'cart']}, 06:58:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:05 INFO - 'talos_options': ['--disable-e10s'], 06:58:05 INFO - 'tests': ['tp5o']}, 06:58:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:05 INFO - 'tests': ['tp5o']}, 06:58:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:05 INFO - 'talos_options': ['--disable-e10s', 06:58:05 INFO - '--xperf_path', 06:58:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:58:05 INFO - 'tests': ['tp5n']}, 06:58:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:05 INFO - 'talos_options': ['--xperf_path', 06:58:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:58:05 INFO - 'tests': ['tp5n']}}, 06:58:05 INFO - 'talos.zip': {'path': '', 06:58:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:58:05 INFO - Running post-action listener: _resource_record_post_action 06:58:05 INFO - ##### 06:58:05 INFO - ##### Running create-virtualenv step. 06:58:05 INFO - ##### 06:58:05 INFO - Running pre-action listener: _resource_record_pre_action 06:58:05 INFO - Running main action method: create_virtualenv 06:58:05 INFO - Creating virtualenv /builds/slave/test/build/venv 06:58:05 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 06:58:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:58:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:58:05 INFO - Using real prefix '/usr' 06:58:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:58:05 INFO - Installing distribute.............................................................................................................................................................................................done. 06:58:07 INFO - Installing pip.................done. 06:58:07 INFO - Return code: 0 06:58:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:58: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')]} 06:58:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58: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')]} 06:58:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:07 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 0x7ffe0a9b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ed85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f67410>, '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 0x1f68310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f687a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461756990.560480-593053154', '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 06:58:07 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 06:58:07 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 06:58:07 INFO - Using env: {'DISPLAY': ':0', 06:58:07 INFO - 'HOME': '/home/cltbld', 06:58:07 INFO - 'LANG': 'en_US.UTF-8', 06:58:07 INFO - 'LANGUAGE': 'en_US:en', 06:58:07 INFO - 'LOGNAME': 'cltbld', 06:58:07 INFO - 'MAIL': '/var/mail/cltbld', 06:58:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:07 INFO - 'MOZ_NO_REMOTE': '1', 06:58:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:07 INFO - 'NO_EM_RESTART': '1', 06:58:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:07 INFO - 'PWD': '/builds/slave/test', 06:58:07 INFO - 'SHELL': '/bin/bash', 06:58:07 INFO - 'SHLVL': '1', 06:58:07 INFO - 'TERM': 'linux', 06:58:07 INFO - 'TMOUT': '86400', 06:58:07 INFO - 'USER': 'cltbld', 06:58:07 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461756990.560480-593053154', 06:58:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:07 INFO - '_': '/tools/buildbot/bin/python'} 06:58:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:07 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 06:58:07 INFO - Cleaning up... 06:58:07 INFO - Return code: 0 06:58:07 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:58: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')]} 06:58:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58: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')]} 06:58:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:07 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 0x7ffe0a9b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ed85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f67410>, '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 0x1f68310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f687a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461756990.560480-593053154', '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 06:58:07 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 06:58:07 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 06:58:07 INFO - Using env: {'DISPLAY': ':0', 06:58:07 INFO - 'HOME': '/home/cltbld', 06:58:07 INFO - 'LANG': 'en_US.UTF-8', 06:58:07 INFO - 'LANGUAGE': 'en_US:en', 06:58:07 INFO - 'LOGNAME': 'cltbld', 06:58:07 INFO - 'MAIL': '/var/mail/cltbld', 06:58:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:07 INFO - 'MOZ_NO_REMOTE': '1', 06:58:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:07 INFO - 'NO_EM_RESTART': '1', 06:58:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:07 INFO - 'PWD': '/builds/slave/test', 06:58:07 INFO - 'SHELL': '/bin/bash', 06:58:07 INFO - 'SHLVL': '1', 06:58:07 INFO - 'TERM': 'linux', 06:58:07 INFO - 'TMOUT': '86400', 06:58:07 INFO - 'USER': 'cltbld', 06:58:07 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461756990.560480-593053154', 06:58:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:07 INFO - '_': '/tools/buildbot/bin/python'} 06:58:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:08 INFO - Downloading/unpacking psutil>=0.7.1 06:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:58:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:58:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:58:10 INFO - Installing collected packages: psutil 06:58:10 INFO - Running setup.py install for psutil 06:58:10 INFO - building 'psutil._psutil_linux' extension 06:58:10 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 06:58:10 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 06:58:10 INFO - building 'psutil._psutil_posix' extension 06:58:10 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 06:58:10 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 06:58:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:58:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:58:10 INFO - Successfully installed psutil 06:58:10 INFO - Cleaning up... 06:58:10 INFO - Return code: 0 06:58:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:58:10 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')]} 06:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:10 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')]} 06:58:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:10 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 0x7ffe0a9b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ed85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f67410>, '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 0x1f68310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f687a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461756990.560480-593053154', '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 06:58:10 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 06:58:10 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 06:58:10 INFO - Using env: {'DISPLAY': ':0', 06:58:10 INFO - 'HOME': '/home/cltbld', 06:58:10 INFO - 'LANG': 'en_US.UTF-8', 06:58:10 INFO - 'LANGUAGE': 'en_US:en', 06:58:10 INFO - 'LOGNAME': 'cltbld', 06:58:10 INFO - 'MAIL': '/var/mail/cltbld', 06:58:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:10 INFO - 'MOZ_NO_REMOTE': '1', 06:58:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:10 INFO - 'NO_EM_RESTART': '1', 06:58:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:10 INFO - 'PWD': '/builds/slave/test', 06:58:10 INFO - 'SHELL': '/bin/bash', 06:58:10 INFO - 'SHLVL': '1', 06:58:10 INFO - 'TERM': 'linux', 06:58:10 INFO - 'TMOUT': '86400', 06:58:10 INFO - 'USER': 'cltbld', 06:58:10 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461756990.560480-593053154', 06:58:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:10 INFO - '_': '/tools/buildbot/bin/python'} 06:58:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:58:10 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 06:58:10 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 06:58:10 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 06:58:10 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 06:58:10 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 06:58:10 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 06:58:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:58:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:58:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:58:12 INFO - Installing collected packages: mozsystemmonitor 06:58:12 INFO - Running setup.py install for mozsystemmonitor 06:58:12 INFO - Successfully installed mozsystemmonitor 06:58:12 INFO - Cleaning up... 06:58:12 INFO - Return code: 0 06:58:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:58: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')]} 06:58:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58: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')]} 06:58:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58: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', '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 0x7ffe0a9b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ed85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f67410>, '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 0x1f68310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f687a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461756990.560480-593053154', '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 06:58: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:58: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 blobuploader==1.2.4 06:58:12 INFO - Using env: {'DISPLAY': ':0', 06:58:12 INFO - 'HOME': '/home/cltbld', 06:58:12 INFO - 'LANG': 'en_US.UTF-8', 06:58:12 INFO - 'LANGUAGE': 'en_US:en', 06:58:12 INFO - 'LOGNAME': 'cltbld', 06:58:12 INFO - 'MAIL': '/var/mail/cltbld', 06:58:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:12 INFO - 'MOZ_NO_REMOTE': '1', 06:58:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:12 INFO - 'NO_EM_RESTART': '1', 06:58:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:12 INFO - 'PWD': '/builds/slave/test', 06:58:12 INFO - 'SHELL': '/bin/bash', 06:58:12 INFO - 'SHLVL': '1', 06:58:12 INFO - 'TERM': 'linux', 06:58:12 INFO - 'TMOUT': '86400', 06:58:12 INFO - 'USER': 'cltbld', 06:58:12 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461756990.560480-593053154', 06:58:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:12 INFO - '_': '/tools/buildbot/bin/python'} 06:58:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:13 INFO - Downloading/unpacking blobuploader==1.2.4 06:58:13 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 06:58:13 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 06:58:13 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 06:58:13 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 06:58:13 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 06:58:13 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 06:58:15 INFO - Downloading blobuploader-1.2.4.tar.gz 06:58:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:58:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:58: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 06:58: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 06:58: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 06:58: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 06:58: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 06:58: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 06:58:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:58:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:58: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 06:58: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 06:58: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 06:58: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 06:58: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 06:58: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 06:58:15 INFO - Downloading docopt-0.6.1.tar.gz 06:58:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:58:15 INFO - Installing collected packages: blobuploader, requests, docopt 06:58:15 INFO - Running setup.py install for blobuploader 06:58:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:58:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:58:15 INFO - Running setup.py install for requests 06:58:16 INFO - Running setup.py install for docopt 06:58:16 INFO - Successfully installed blobuploader requests docopt 06:58:16 INFO - Cleaning up... 06:58:16 INFO - Return code: 0 06:58:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:16 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 0x7ffe0a9b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ed85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f67410>, '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 0x1f68310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f687a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461756990.560480-593053154', '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 06:58:16 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 06:58:16 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 06:58:16 INFO - Using env: {'DISPLAY': ':0', 06:58:16 INFO - 'HOME': '/home/cltbld', 06:58:16 INFO - 'LANG': 'en_US.UTF-8', 06:58:16 INFO - 'LANGUAGE': 'en_US:en', 06:58:16 INFO - 'LOGNAME': 'cltbld', 06:58:16 INFO - 'MAIL': '/var/mail/cltbld', 06:58:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:16 INFO - 'MOZ_NO_REMOTE': '1', 06:58:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:16 INFO - 'NO_EM_RESTART': '1', 06:58:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:16 INFO - 'PWD': '/builds/slave/test', 06:58:16 INFO - 'SHELL': '/bin/bash', 06:58:16 INFO - 'SHLVL': '1', 06:58:16 INFO - 'TERM': 'linux', 06:58:16 INFO - 'TMOUT': '86400', 06:58:16 INFO - 'USER': 'cltbld', 06:58:16 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461756990.560480-593053154', 06:58:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:16 INFO - '_': '/tools/buildbot/bin/python'} 06:58:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:58:16 INFO - Running setup.py (path:/tmp/pip-CuXERB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:58:16 INFO - Running setup.py (path:/tmp/pip-VYXISW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:58:16 INFO - Running setup.py (path:/tmp/pip-i3SE16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:58:16 INFO - Running setup.py (path:/tmp/pip-t5vtkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:58:16 INFO - Running setup.py (path:/tmp/pip-P7bQjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:58:17 INFO - Running setup.py (path:/tmp/pip-jFrqrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:58:17 INFO - Running setup.py (path:/tmp/pip-eNqwTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:58:17 INFO - Running setup.py (path:/tmp/pip-8Y2Pkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:58:17 INFO - Running setup.py (path:/tmp/pip-1khDOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:58:17 INFO - Running setup.py (path:/tmp/pip-p6P7S0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:58:17 INFO - Running setup.py (path:/tmp/pip-f3j3wt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:58:17 INFO - Running setup.py (path:/tmp/pip-54jxcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:58:17 INFO - Running setup.py (path:/tmp/pip-mBzsBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:58:17 INFO - Running setup.py (path:/tmp/pip-Kn3mjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:58:17 INFO - Running setup.py (path:/tmp/pip-oz0XaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:58:17 INFO - Running setup.py (path:/tmp/pip-3tDWxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:58:17 INFO - Running setup.py (path:/tmp/pip-kVjrO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:58:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:58:17 INFO - Running setup.py install for manifestparser 06:58:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:58:17 INFO - Running setup.py install for mozcrash 06:58:18 INFO - Running setup.py install for mozdebug 06:58:18 INFO - Running setup.py install for mozdevice 06:58:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:58:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:58:18 INFO - Running setup.py install for mozfile 06:58:18 INFO - Running setup.py install for mozhttpd 06:58:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:58:18 INFO - Running setup.py install for mozinfo 06:58:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:58:18 INFO - Running setup.py install for mozInstall 06:58:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:58:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:58:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:58:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:58:18 INFO - Running setup.py install for mozleak 06:58:18 INFO - Running setup.py install for mozlog 06:58:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:58:18 INFO - Running setup.py install for moznetwork 06:58:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:58:19 INFO - Running setup.py install for mozprocess 06:58:19 INFO - Running setup.py install for mozprofile 06:58:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:58:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:58:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:58:19 INFO - Running setup.py install for mozrunner 06:58:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:58:19 INFO - Running setup.py install for mozscreenshot 06:58:19 INFO - Running setup.py install for moztest 06:58:19 INFO - Running setup.py install for mozversion 06:58:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:58:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:58:19 INFO - Cleaning up... 06:58:19 INFO - Return code: 0 06:58:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:58:19 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')]} 06:58:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:19 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')]} 06:58:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:19 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 0x7ffe0a9b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ed85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f67410>, '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 0x1f68310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f687a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461756990.560480-593053154', '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 06:58:19 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 06:58:19 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 06:58:19 INFO - Using env: {'DISPLAY': ':0', 06:58:19 INFO - 'HOME': '/home/cltbld', 06:58:19 INFO - 'LANG': 'en_US.UTF-8', 06:58:19 INFO - 'LANGUAGE': 'en_US:en', 06:58:19 INFO - 'LOGNAME': 'cltbld', 06:58:19 INFO - 'MAIL': '/var/mail/cltbld', 06:58:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:19 INFO - 'MOZ_NO_REMOTE': '1', 06:58:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:19 INFO - 'NO_EM_RESTART': '1', 06:58:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:19 INFO - 'PWD': '/builds/slave/test', 06:58:19 INFO - 'SHELL': '/bin/bash', 06:58:19 INFO - 'SHLVL': '1', 06:58:19 INFO - 'TERM': 'linux', 06:58:19 INFO - 'TMOUT': '86400', 06:58:19 INFO - 'USER': 'cltbld', 06:58:19 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461756990.560480-593053154', 06:58:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:19 INFO - '_': '/tools/buildbot/bin/python'} 06:58:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:58:19 INFO - Running setup.py (path:/tmp/pip-ihRcFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:58:19 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)) 06:58:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:58:19 INFO - Running setup.py (path:/tmp/pip-_OVHme-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:58:20 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)) 06:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:58:20 INFO - Running setup.py (path:/tmp/pip-Bm8JLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:58:20 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)) 06:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:58:20 INFO - Running setup.py (path:/tmp/pip-5_LyIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:58:20 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)) 06:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:58:20 INFO - Running setup.py (path:/tmp/pip-pFxYMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:58:20 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)) 06:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:58:20 INFO - Running setup.py (path:/tmp/pip-1_4ziO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:58:20 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)) 06:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:58:20 INFO - Running setup.py (path:/tmp/pip-EGHNNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:58:20 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)) 06:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:58:20 INFO - Running setup.py (path:/tmp/pip-wE0VQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:58:20 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)) 06:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:58:20 INFO - Running setup.py (path:/tmp/pip-b6ycGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:58:20 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)) 06:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:58:20 INFO - Running setup.py (path:/tmp/pip-YMBGq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:58:20 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)) 06:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:58:20 INFO - Running setup.py (path:/tmp/pip-qzD1gB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:58:20 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)) 06:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:58:20 INFO - Running setup.py (path:/tmp/pip-84PjEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:58:20 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)) 06:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:58:20 INFO - Running setup.py (path:/tmp/pip-64r9ON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:58:20 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)) 06:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:58:20 INFO - Running setup.py (path:/tmp/pip-49eLj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:58:20 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)) 06:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:58:20 INFO - Running setup.py (path:/tmp/pip-hbtLcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:58:21 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)) 06:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:58:21 INFO - Running setup.py (path:/tmp/pip-cH2bcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:58:21 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)) 06:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:58:21 INFO - Running setup.py (path:/tmp/pip-GXu8he-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:58:21 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)) 06:58:21 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)) 06:58:21 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)) 06:58:21 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)) 06:58:21 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)) 06:58:21 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)) 06:58:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:58:21 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 06:58:21 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 06:58:21 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 06:58:21 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 06:58:21 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 06:58:21 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 06:58:23 INFO - Downloading blessings-1.6.tar.gz 06:58:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:58:23 INFO - Installing collected packages: blessings 06:58:23 INFO - Running setup.py install for blessings 06:58:23 INFO - Successfully installed blessings 06:58:23 INFO - Cleaning up... 06:58:23 INFO - Return code: 0 06:58:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:58:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:58:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:58:23 INFO - Reading from file tmpfile_stdout 06:58:23 INFO - Current package versions: 06:58:23 INFO - argparse == 1.2.1 06:58:23 INFO - blessings == 1.6 06:58:23 INFO - blobuploader == 1.2.4 06:58:23 INFO - docopt == 0.6.1 06:58:23 INFO - manifestparser == 1.1 06:58:23 INFO - mozInstall == 1.12 06:58:23 INFO - mozcrash == 0.17 06:58:23 INFO - mozdebug == 0.1 06:58:23 INFO - mozdevice == 0.48 06:58:23 INFO - mozfile == 1.2 06:58:23 INFO - mozhttpd == 0.7 06:58:23 INFO - mozinfo == 0.9 06:58:23 INFO - mozleak == 0.1 06:58:23 INFO - mozlog == 3.1 06:58:23 INFO - moznetwork == 0.27 06:58:23 INFO - mozprocess == 0.22 06:58:23 INFO - mozprofile == 0.28 06:58:23 INFO - mozrunner == 6.11 06:58:23 INFO - mozscreenshot == 0.1 06:58:23 INFO - mozsystemmonitor == 0.0 06:58:23 INFO - moztest == 0.7 06:58:23 INFO - mozversion == 1.4 06:58:23 INFO - psutil == 3.1.1 06:58:23 INFO - requests == 1.2.3 06:58:23 INFO - wsgiref == 0.1.2 06:58:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:58: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')]} 06:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58: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')]} 06:58:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:23 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 0x7ffe0a9b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ed85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f67410>, '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 0x1f68310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f687a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461756990.560480-593053154', '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 06:58:23 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 06:58:23 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 06:58:23 INFO - Using env: {'DISPLAY': ':0', 06:58:23 INFO - 'HOME': '/home/cltbld', 06:58:23 INFO - 'LANG': 'en_US.UTF-8', 06:58:23 INFO - 'LANGUAGE': 'en_US:en', 06:58:23 INFO - 'LOGNAME': 'cltbld', 06:58:23 INFO - 'MAIL': '/var/mail/cltbld', 06:58:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:23 INFO - 'MOZ_NO_REMOTE': '1', 06:58:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:23 INFO - 'NO_EM_RESTART': '1', 06:58:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:23 INFO - 'PWD': '/builds/slave/test', 06:58:23 INFO - 'SHELL': '/bin/bash', 06:58:23 INFO - 'SHLVL': '1', 06:58:23 INFO - 'TERM': 'linux', 06:58:23 INFO - 'TMOUT': '86400', 06:58:23 INFO - 'USER': 'cltbld', 06:58:23 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461756990.560480-593053154', 06:58:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:23 INFO - '_': '/tools/buildbot/bin/python'} 06:58:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:23 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)) 06:58:23 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)) 06:58:23 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)) 06:58:23 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)) 06:58:23 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)) 06:58:23 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)) 06:58:23 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)) 06:58:23 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)) 06:58:23 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)) 06:58:23 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)) 06:58:23 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)) 06:58:23 INFO - Cleaning up... 06:58:23 INFO - Return code: 0 06:58:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:58: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')]} 06:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58: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')]} 06:58:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:23 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 0x7ffe0a9b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ed85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f67410>, '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 0x1f68310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f687a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461756990.560480-593053154', '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 06:58:23 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 06:58:23 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 06:58:23 INFO - Using env: {'DISPLAY': ':0', 06:58:23 INFO - 'HOME': '/home/cltbld', 06:58:23 INFO - 'LANG': 'en_US.UTF-8', 06:58:23 INFO - 'LANGUAGE': 'en_US:en', 06:58:23 INFO - 'LOGNAME': 'cltbld', 06:58:23 INFO - 'MAIL': '/var/mail/cltbld', 06:58:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:23 INFO - 'MOZ_NO_REMOTE': '1', 06:58:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:23 INFO - 'NO_EM_RESTART': '1', 06:58:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:23 INFO - 'PWD': '/builds/slave/test', 06:58:23 INFO - 'SHELL': '/bin/bash', 06:58:23 INFO - 'SHLVL': '1', 06:58:23 INFO - 'TERM': 'linux', 06:58:23 INFO - 'TMOUT': '86400', 06:58:23 INFO - 'USER': 'cltbld', 06:58:23 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461756990.560480-593053154', 06:58:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:23 INFO - '_': '/tools/buildbot/bin/python'} 06:58:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:23 INFO - Downloading/unpacking jsonschema 06:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:58:25 INFO - Downloading/unpacking functools32 (from jsonschema) 06:58: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 06:58: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 06:58: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 06:58: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 06:58: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 06:58: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 06:58:25 INFO - Downloading functools32-3.2.3-2.tar.gz 06:58:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:58:26 INFO - warning: no files found matching '*.txt' 06:58:26 INFO - no previously-included directories found matching 'build' 06:58:26 INFO - no previously-included directories found matching 'dist' 06:58:26 INFO - no previously-included directories found matching '.git*' 06:58:26 INFO - Installing collected packages: jsonschema, functools32 06:58:26 INFO - Running setup.py install for functools32 06:58:26 INFO - warning: no files found matching '*.txt' 06:58:26 INFO - no previously-included directories found matching 'build' 06:58:26 INFO - no previously-included directories found matching 'dist' 06:58:26 INFO - no previously-included directories found matching '.git*' 06:58:26 INFO - Successfully installed jsonschema functools32 06:58:26 INFO - Cleaning up... 06:58:26 INFO - Return code: 0 06:58:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:58:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:26 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 0x7ffe0a9b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ed85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f67410>, '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 0x1f68310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f687a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461756990.560480-593053154', '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 06:58:26 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 06:58:26 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 06:58:26 INFO - Using env: {'DISPLAY': ':0', 06:58:26 INFO - 'HOME': '/home/cltbld', 06:58:26 INFO - 'LANG': 'en_US.UTF-8', 06:58:26 INFO - 'LANGUAGE': 'en_US:en', 06:58:26 INFO - 'LOGNAME': 'cltbld', 06:58:26 INFO - 'MAIL': '/var/mail/cltbld', 06:58:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:26 INFO - 'MOZ_NO_REMOTE': '1', 06:58:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:26 INFO - 'NO_EM_RESTART': '1', 06:58:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:26 INFO - 'PWD': '/builds/slave/test', 06:58:26 INFO - 'SHELL': '/bin/bash', 06:58:26 INFO - 'SHLVL': '1', 06:58:26 INFO - 'TERM': 'linux', 06:58:26 INFO - 'TMOUT': '86400', 06:58:26 INFO - 'USER': 'cltbld', 06:58:26 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461756990.560480-593053154', 06:58:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:26 INFO - '_': '/tools/buildbot/bin/python'} 06:58:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:26 INFO - Downloading/unpacking flake8 06:58:26 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 06:58:26 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 06:58:26 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 06:58:26 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 06:58:26 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 06:58:26 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 06:58:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:58:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:58: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 06:58: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 06:58: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 06:58: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 06:58: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 06:58: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 06:58:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:58:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:58: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 06:58: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 06:58: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 06:58: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 06:58: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 06:58: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 06:58:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:58: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 06:58: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 06:58: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 06:58: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 06:58: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 06:58: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 06:58:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:58:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:58:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:58:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:58:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:58:29 INFO - no previously-included directories found matching 'docs/_build' 06:58:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:58:29 INFO - Running setup.py install for pep8 06:58:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:58:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:58:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:58:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:58:29 INFO - no previously-included directories found matching 'docs/_build' 06:58:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:58:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:58:29 INFO - Cleaning up... 06:58:29 INFO - Return code: 0 06:58:29 INFO - Running post-action listener: _resource_record_post_action 06:58:29 INFO - Running post-action listener: _start_resource_monitoring 06:58:29 INFO - Starting resource monitoring. 06:58:29 INFO - ##### 06:58:29 INFO - ##### Running install step. 06:58:29 INFO - ##### 06:58:29 INFO - Running pre-action listener: _resource_record_pre_action 06:58:29 INFO - Running main action method: install 06:58:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:58:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:58:29 INFO - Reading from file tmpfile_stdout 06:58:29 INFO - Detecting whether we're running mozinstall >=1.0... 06:58:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:58:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:58:29 INFO - Reading from file tmpfile_stdout 06:58:29 INFO - Output received: 06:58:29 INFO - Usage: mozinstall [options] installer 06:58:29 INFO - Options: 06:58:29 INFO - -h, --help show this help message and exit 06:58:29 INFO - -d DEST, --destination=DEST 06:58:29 INFO - Directory to install application into. [default: 06:58:29 INFO - "/builds/slave/test"] 06:58:29 INFO - --app=APP Application being installed. [default: firefox] 06:58:29 INFO - mkdir: /builds/slave/test/build/application 06:58:29 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'] 06:58:29 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 06:58:46 INFO - Reading from file tmpfile_stdout 06:58:46 INFO - Output received: 06:58:46 INFO - /builds/slave/test/build/application/firefox/firefox 06:58:46 INFO - Running post-action listener: _resource_record_post_action 06:58:46 INFO - ##### 06:58:46 INFO - ##### Running run-tests step. 06:58:46 INFO - ##### 06:58:46 INFO - Running pre-action listener: _resource_record_pre_action 06:58:46 INFO - Running main action method: run_tests 06:58:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:58:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:58:46 INFO - Python 2.7.3 06:58:46 INFO - Return code: 0 06:58:46 INFO - grabbing minidump binary from tooltool 06:58:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:46 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 0x1f67410>, '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 0x1f68310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f687a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:58:46 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 06:58:46 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 06:58:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:58:46 INFO - Return code: 0 06:58:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:58:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:58:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:58:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:58:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:58:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:58:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:58:47 INFO - Return code: 0 06:58:47 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/LQOl2fRST_mWU8CEcbfq9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 06:58:47 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/LQOl2fRST_mWU8CEcbfq9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --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 06:58:47 INFO - Using env: {'DISPLAY': ':0', 06:58:47 INFO - 'HOME': '/home/cltbld', 06:58:47 INFO - 'LANG': 'en_US.UTF-8', 06:58:47 INFO - 'LANGUAGE': 'en_US:en', 06:58:47 INFO - 'LOGNAME': 'cltbld', 06:58:47 INFO - 'MAIL': '/var/mail/cltbld', 06:58:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:58:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:58:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:47 INFO - 'MOZ_NO_REMOTE': '1', 06:58:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:58:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:47 INFO - 'NO_EM_RESTART': '1', 06:58:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:47 INFO - 'PWD': '/builds/slave/test', 06:58:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:58:47 INFO - 'SHELL': '/bin/bash', 06:58:47 INFO - 'SHLVL': '1', 06:58:47 INFO - 'TERM': 'linux', 06:58:47 INFO - 'TMOUT': '86400', 06:58:47 INFO - 'USER': 'cltbld', 06:58:47 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461756990.560480-593053154', 06:58:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:47 INFO - '_': '/tools/buildbot/bin/python'} 06:58:47 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/LQOl2fRST_mWU8CEcbfq9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 06:58:47 INFO - mozversion application_buildid: 20160427043016 06:58:47 INFO - mozversion application_changeset: bc40974a002f891b186432370547a370984e35a7 06:58:47 INFO - mozversion application_display_name: Nightly 06:58:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:58:47 INFO - mozversion application_name: Firefox 06:58:47 INFO - mozversion application_remotingname: firefox 06:58:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 06:58:47 INFO - mozversion application_vendor: Mozilla 06:58:47 INFO - mozversion application_version: 49.0a1 06:58:47 INFO - mozversion platform_buildid: 20160427043016 06:58:47 INFO - mozversion platform_changeset: bc40974a002f891b186432370547a370984e35a7 06:58:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 06:58:47 INFO - mozversion platform_version: 49.0a1 06:58:47 INFO - using testdate: 1461765527 06:58:47 INFO - actual date: 1461765527 06:58:47 INFO - starting webserver on 'localhost:43735' 06:58:47 INFO - SUITE-START | Running 2 tests 06:58:47 INFO - TEST-START | dromaeo_css 06:58:47 INFO - operating with platform_type : linux_ 06:58:47 INFO - Initialising browser for dromaeo_css test... 06:58:47 INFO - TEST-INFO | started process 5536 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpibyt6r/profile http://localhost:43735/getInfo.html) 06:58:51 INFO - PROCESS | 5536 | __metrics Screen width/height:1600/1200 06:58:51 INFO - PROCESS | 5536 | colorDepth:24 06:58:51 INFO - PROCESS | 5536 | Browser inner width/height: 1024/697 06:58:51 INFO - PROCESS | 5536 | __metrics 06:58:52 ERROR - PROCESS | 5536 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:58:53 INFO - TEST-INFO | 5536: exit 0 06:58:53 INFO - Browser initialized. 06:58:53 INFO - Running cycle 1/1 for dromaeo_css test... 06:58:53 INFO - TEST-INFO | started process 5616 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpibyt6r/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:59:05 INFO - PROCESS | 5616 | RSS: Main: 154877952 06:59:05 INFO - PROCESS | 5616 | 06:59:56 INFO - PROCESS | 5616 | 1461765596107 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:02:03 INFO - PROCESS | 5616 | Cycle 1(1): loaded http://localhost:43735/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43735/tests/dromaeo/cssquery-ext.html) 07:02:04 INFO - PROCESS | 5616 | RSS: Main: 240488448 07:02:04 INFO - PROCESS | 5616 | 07:05:06 INFO - PROCESS | 5616 | Cycle 1(1): loaded http://localhost:43735/tests/dromaeo/cssquery-ext.html (next: http://localhost:43735/tests/dromaeo/cssquery-jquery.html) 07:05:07 INFO - PROCESS | 5616 | RSS: Main: 233041920 07:05:07 INFO - PROCESS | 5616 | 07:08:09 INFO - PROCESS | 5616 | Cycle 1(1): loaded http://localhost:43735/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43735/tests/dromaeo/cssquery-mootools.html) 07:08:09 INFO - PROCESS | 5616 | RSS: Main: 229474304 07:08:09 INFO - PROCESS | 5616 | 07:11:11 INFO - PROCESS | 5616 | Cycle 1(1): loaded http://localhost:43735/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43735/tests/dromaeo/cssquery-prototype.html) 07:11:12 INFO - PROCESS | 5616 | RSS: Main: 230862848 07:11:12 INFO - PROCESS | 5616 | 07:14:14 INFO - PROCESS | 5616 | Cycle 1(1): loaded http://localhost:43735/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43735/tests/dromaeo/cssquery-yui.html) 07:14:15 INFO - PROCESS | 5616 | RSS: Main: 202526720 07:14:15 INFO - PROCESS | 5616 | 07:17:18 INFO - PROCESS | 5616 | Cycle 1(1): loaded http://localhost:43735/tests/dromaeo/cssquery-yui.html (next: http://localhost:43735/tests/dromaeo/cssquery-dojo.html) 07:17:18 INFO - PROCESS | 5616 | RSS: Main: 271048704 07:17:18 INFO - PROCESS | 5616 | 07:17:18 INFO - PROCESS | 5616 | __start_tp_report 07:17:18 INFO - PROCESS | 5616 | _x_x_mozilla_page_load 07:17:18 INFO - PROCESS | 5616 | _x_x_mozilla_page_load_details 07:17:18 INFO - PROCESS | 5616 | |i|pagename|runs| 07:17:18 INFO - PROCESS | 5616 | |0;dojo.html;3038.969610303897;3096.5045592705173;3120.5475206095116;3129.342838004019;3162.1620270628287;5173.224016397542;5190.480951904808;5229.346331708542;5235.947640523594;5280.075986702331;5120.948790512094;5128.205128205125;5233.241180028894;5304.098303288441;5309;4648.604868586174;4686.601638860692;4734.928976065362;4786.425628924534;4818.277258411249;4758.191107511714;4774.80900763969;4779.139754844126;4819.807207711688;4865.124277630025;4652.953470465302;4722.220833562458;4780.259059845729;4812.446568644598;4837.7339246341435;4669.089527542131;4672.229082201433;4679.9298010529865;4681.602063824579;4709.6467764917425;4648.74431906245;4652.092841895832;4664.5102264262105;4676.36869022681;4710.976445117787;5046.21783623539;5079.79680812767;5089.923651145235;5094.592432605383;5097.7960881564695;5455.972720136414;5456.645318054314;5464.9453505465235;5469;5479.123340265578;5432.837014889559;5488.7530061146945;5552.111662134039;5561.860953476155;5563.833085007456;5173.456787037345;5191.117510023343;5200.5059519345605;5202.76587553561;5245;5655.406182350876;5657.8019769307875;5659.971700141556;5661.631993920382;5669.4047125051275;5339.519443250126;5404.108322126884;5411.810586629449;5434.456554344534;5482;5572.637778544463;5580.693061881554;5583.776648934078;5599.272094627754;5606.607537472338;5540.7783688652;5563;5563;5564.944350556442;5570.3315602128005;5418.566514678816;5553.222548843165;5593.049181639131;5633.971830140823;5641.464060914206;4223.493180818322;4231.78841057952;4235.597618226325;4236.809343579546;4273.1240095780295;3807.8286477108595;3810.1046254130256;3815.42768584709;3820.0449887528116;3837.5394952605866;5101.387833460009;5144.61415393847;5239.842804715865;5321.042212401805;5331.466853314638;5515.172724091338;5521.420250873681;5526.364468086141;5543.889122217533;5544.473275038865;5210.765515551733;5236.188390799432;5243.187305967581;5246.554042906319;5273.762680679379;4694.624430045588;4751.714897106184;4782.713037217778;4819.855404337875;4825.131476334223;5743.712814359265;5761.3950535194035;5765.509931655773;5775.27809023872;5784.8264552062665;5437.32033495813;5575.637583556974;5585.804496842591;5606.439356064361;5658.745356458887;5800.6809625471005;5844.853878653068;5854.590178687621;5872.94127058741;5887.470127688529;5496.395396506461;5501.229827824028;5505.394406615189;5508.421615730451;5516.972415137899;5572.665640061609;5579;5580.302462192226;5584.525315348241;5627.380988091225;5259.947400525945;5301.761420735999;5343.973280133574;5370.979513892348;5390.407055223844;5306.602004849729;5306.681599104066;5313.760880760297;5314.176302673091;5321.175217841241;5202.427732949448;5208.661437006583;5218.217267409919;5226.764795584284;5229.189475631283;5371.62398632092;5400.864978375572;5409.323834520685;5413.864653383697;5455.345358556999;5299.046171689133;5300.231466437422;5304;5305.946940530545;5358.437364076872 07:17:18 INFO - PROCESS | 5616 | |1;ext.html;610.2311088029085;636.328673249722;651.160003595362;658.2857599504534;660.1846719301661;30847.228819279528;38904.805475972615;39456.80271598645;39677.40483892744;39733.40399894004;41822.16355672885;42368.36447453291;42440;42501.14997700052;42584.57415425845;7399.408047356225;8625.741227763177;8832.337574681893;8856.070112638177;10114.140298074635;10190.745231369201;10369.06678398944;10381.896181038168;10390.480475976208;10403.271770976035;10336.483175841215;10458.947705261464;10469.895301046969;10470.952904709506;10470.952904709544;7343.082114735631;10119.342242754197;10288.48557572122;10377.495263186871;10382.117520010808;10205.744856378577;10348.58605655773;10363.222758293157;10365.118964887994;10367.89632103677;38777.80611096955;39537.40693889565;39555.60444395548;39559.60440395588;39563.60436395628;3460.619331873492;3465.8960231193105;3516.7186625069935;3627.7097832173627;3869.090763670535;33022;33457.49813752795;33503.832480837686;33507.49738753921;34918.476222856676;4314.094040251551;4344.956550434486;4367.3448982652535;4382.123575284956;4411.955880441186;334566;334611.99999999756;334822;337020;337980.3100984504;59398.40601593929;59798.70100649469;60064.099038514454;60136.39863601395;60148;63470;63602;63638.68180659067;63769;63790;15776.526704198892;16258.268377923021;16294.511164665078;16306.918465407596;16336.754948675542;12425.254484730945;12563.811542826865;12592.307423091817;12608;12618.684532886751;17345.826541734674;17440.5639859002;17486.47540573785;17575.648487030187;17577.82422175762;5008.973160502088;5676.914846277309;5857.882842343214;5878.500982249499;5970.940290597126;1025.2003437318904;1036.23836480187;1052.8526006359116;1113.4377139544479;1187.928724276546;31534.211644709067;32270.677293226767;32932.74005800337;33076.66923330784;33319;1104.216006635282;1125.083057308291;1172.3376292394769;1198.8681245063035;1318.775808112623;17025.574360641083;17456.738148927776;17559.561010974827;17560.38538651141;17605.64788704219;504046;508879;509588;510233;511151;57852.421475785544;57889;58067.419325807045;58176;58250;1259.779538580763;1357.7827547592337;1381.4267079162237;1417.5038736442368;1512.7050225206199;29166.70833291725;30168.54747178838;30330.69669303367;30765.19033130832;33188.834055830535;46391.304130438744;46642;46709.2993605103;46851.297230540884;46973.295400568335;306395;307865;308457;308877;309410;31761;32769;38279.808600956814;38574.80712596419;38911.61088389193;42080.3687944675;42512.1497570053;42862;43137.3529397053;43475.56524434715;34891;38848.22303553857;40235.1952960945;41143.17713645651;41792.58207417887;39289.2142157161;39666.40500392439;40042.1991560173;40148.1970360597;40653.18693626052;40206;40619.390709138796;40763.1847363057;40765.18469630532;41706.374404384565;34058.318833622696;35094.824525878226;35280.82359588288;35976.64023359733;36312.27375452529;27323.453530929666;27886.72113278841;27992.30019249535;28088.29779255453;28413 07:17:18 INFO - PROCESS | 5616 | |2;jquery.html;370.4517314374725;381.61647544218056;384.85567912032985;393.590665707664;395.8950878017324;17221.655566888654;18438.262469501205;18886.811131888695;18890.811091889078;18905.90547047263;18729.906350468227;18894.338698145566;19133.808661913376;19146.138423770928;19779.406617801487;5477.260569823083;5578.832635020955;5718.799842005531;5749.59752817303;5762.971185144069;5707.286589176353;5723.599348045638;5737.598368114233;5740.684262365568;5746.741396637161;5533.22534845122;5878.118282257653;5882.88234235315;5889.676067816268;5890.88218235635;5619.129034999582;5824.883502329951;5826.271716035496;5839;5870.148828419855;5656.575756818255;5692.57305702074;5710.314762228518;5726.455986681259;5759.5968282220265;13700.725985480234;13935.860641393558;20845.16619335225;21332.573348533097;21462.463438414008;2233.564454931289;2308.5729140109133;2408.3858616052794;2486.96269555955;2734.179746076169;9875.950620246853;10229;10442.947785261025;10445.373277603368;10604.893951060469;1896.0424985382294;1903.7239600258024;1935.2742721479444;1951.834094102003;1989.691597802343;59145.7042714788;79671.601641992;81268.59365703134;83296;84638.57680711619;9789.82522097353;10330.276880618285;10351.534180961875;10910.399928003877;10955.890441095646;13869.653258668613;14622.707545849024;14633.268336583129;14650.194239316726;14681.77977330341;7293.817654558678;7307.926920730831;7341.229170937081;7474.925250747532;7588.81027974294;7176.478142116942;7284.490085694057;7292.416606671453;7300.629603760847;7367.631618419057;4553.317002449593;4555.931661025087;4569.920686087822;4657.790399432034;4756.381670382897;1690.1464760295971;1693.6274019715643;1696.1434475589995;1747.772789537352;1888.8488920886296;943.4905151218403;959.5058544849409;961.485605201214;989.7030890732751;1017.9032991865761;18479.907600461913;19540.413787586396;19549.90225048894;19791.60416791685;19846.70229946552;907.7412937312835;978.471625322318;981.352307477076;983.3706427886159;1069.7272195590074;9959.787196842892;10639.414832184304;10718.410487423267;10814.783704326026;10873.207411692065;505447;506438;520856;531646;534130;87689.56155219184;87856.56071719728;89264.5536772312;90604;92533.5373323129;1039.8856125826153;1060.204846365226;1081.5998080710187;1087.581281206741;1097.0346095435966;14537.85462145365;16834.5690616299;16907.66184676275;17347.82652173462;17454.563635909202;32046.83976580102;40861.38707919443;43035.139297214504;43132.84335783261;44367.334489983325;55508.72245638746;56017;57109.71445142748;57203.71398142983;57982.7100864493;8147.1038185798325;8249.381296402913;8518.36112291593;8695.043545210148;8741.125887411208;11892.940535297268;12812.295323757282;13166;13172.275524845842;13347.332633368487;8631.870521942301;10977.670669879917;11805.350705711267;12157.513699451923;12261.386930653252;6608.867822643617;6833.043373927555;9378.95310523443;11780.941095294469;12080;11782.234154779911;11990.700232493908;12060.155789094679;12079.939600301943;12422.254664720145;8338.583070846313;8800;8811.118888111137;8838.425502342327;9036.774080648036;11436.142289328167;11473.4263286837;11498.195126341076;11527.365994870028;11568.826467603161 07:17:18 INFO - PROCESS | 5616 | |3;mootools.html;1295.6760809797552;1466.3035058347284;1531.479297039007;1655.2799532203492;1821.380730551613;8108.756737297883;8424.031236407815;8437.409381343308;8438.240558349748;8444.155584441552;7945.284924356807;8103.95948020259;8111.188881111901;8111.756647300575;8116.553589552572;1937.225109956022;2235.4970131720315;2266.467380165664;2290.6449500327476;2300.7469178390365;2307.1694190091553;2315.722113346401;2320.2807129789735;2321.0483701682315;2322.1872344679314;2213.3249358945513;2219.844610877239;2258.559580881729;2260.0394832196334;2260.42359198405;1917.6739954207749;1971.0932970833362;2165.945851353713;2246.73039235292;2280.395695140789;2259.581977334182;2282.6233671444193;2285.108807565051;2285.714285714286;2288.302067869299;8065.354771618257;8098.676052957874;8117.9594102029705;8136.877946830802;8151.470154439942;4818.156822556074;4937.333459982929;4943.826966056206;4965.77654005567;4973.776180071905;3034.256607131245;3124.390743804959;3240.1575590346442;3249.0902547286796;3290.440625093716;1145.9713507162305;1151.1078913841757;1159;1175.8765329640435;1176.476467971753;11367.317960922372;11647.184697071209;11670.474828632732;11691.590794322157;11705.239159454693;4305.720128191658;4496.572825581565;4514.232580461329;4586.610138138229;4605.746683932416;9912.752181195383;9938.403695778277;9949.452780097019;9950.601975921027;9952.10431061208;4967.925481117786;5026.673266237683;5038.445770965191;5039.974800125976;5040.7479626019285;3947.585503522146;4448.421705178306;4535.795889184995;4542.182407166676;4560.224761790503;3810.8285127169343;3822.7515211511163;3907.941380879289;3930.862419815293;3987.282289187916;1210.5218438716659;1231.205872212436;1233.2785320587377;1247.5758242197696;1249.0819247852821;960.7934294126796;968.8906202398215;972.5040229483014;977.5552123783662;990.1286867556504;5627.634203776742;5644.689542075143;5650.491455769001;5784.1034639630925;6070.210872586624;1008.445355054717;1028.228828378716;1038.402918321968;1091.4433638844089;1098.1983152298867;4057.8173982170874;4073.368627862686;4078.4494093297617;4084.611961863618;4087.6321131098343;9422.246220302359;9760.804783904283;9809.411435313761;9814.116729494379;9834.360766550151;9627.9037209627;9640.566174522164;9698.612055517842;9706.805863882682;9875.950620246853;7376.336129748241;7468;7544;7735.303822655988;7741.109772376136;5673.319201695823;5728.742206600797;5912.994790885474;5923.763049478145;5969.850753731192;9112.726618201465;9439.480828554495;9728.319017668695;9818.165455936325;9863.063009014133;9764.218862491125;9926.15627671627;9993.850092248476;10022.699319020441;10137.493125343555;7095.0421693070775;7129.857402852018;7344.779656610311;7360.852782944418;7364.484486085923;7827.726029588937;7833.138354781084;7864.72473463426;7869.449138560246;7895.447318687637;7042.683079261343;7066.787996360117;7158.463115266271;7457.440691948017;7482.438817088631;6944.791656250321;7060.682269297997;7094;7170.103737032871;7340.009098771598;6581.3418658133805;6605.207375115017;6643.70103345341;6659.567128136656;6667.666616669244;4783.282507623884;4783.330333753347;4817.807287708592;4937.481564435682;4989.775460104232;4747.145513807548;4803.207470767285;4823.397075365579;4918.0901533216465;4932.580730637936 07:17:18 INFO - PROCESS | 5616 | |4;prototype.html;317.65375740442914;326.4760060103534;332.20271348762964;332.7138660751753;336.33909368091696;5200.9598080383885;5250.65870718403;5349.277847490593;5371.677699338043;5399.541039011679;5228.712420816853;5302.409277216829;5315.661109111988;5333.759980800864;5338.813141540047;4151.771652559108;4154.189932963073;4167.124793842768;4189.37159426087;4199.1391764688315;3897.9610203897882;4138.3999320098565;4165;4187.33002719565;4191.958080419187;4066.471358723362;4070.308047631895;4074.816633251496;4077.2864748669012;4091.754494730311;4075.510938687347;4085.2238074765846;4090.8568200112854;4100.63094321511;4106.815193316278;3604.9098772530633;3605.405108157151;3613.5663720353464;3616.0959760059986;3636.2545678136185;5039.3196918415915;5104.948950510485;5127.051495473312;5129.820456284049;5145.922811157836;4588.564086411786;4608.400907881987;4615.561521655437;4664.65015123867;4667.533246675339;5440.156775699773;5447.836564903059;5491.807786727485;5495.725213739297;5500.50495455407;3817.522809648794;3908.1402091539817;3921.509811273591;3939.113699417637;3959.6339262954234;5455.645383050129;5650.1242307442;5745.482906538432;5780.132980052984;5807.912881306784;3867.477890484805;3949.7235193536753;3956.3472027115204;3976.562578116405;4012.297847876668;3836.731428799957;3929.7445666031617;4013.7792421417103;4039.3537034074407;4072.7418065547445;4623.53764623535;4634.146341463442;4666.789994450258;4667.486576476585;4677.7193368398;5552.083906155439;5554.1391084381985;5564.304461942257;5571.582131340166;5575.860603484864;1422.2746399336413;1459.9854001460062;1468.7136008478458;1469.1772607339924;1475.7122361139475;926.536731634183;937.3953799799092;945.3807755919884;947.2327414794039;948.0519480519481;5613.747381367848;5658.575606829504;5679.204911312419;5695.231143795618;5703.429657034263;6051.757929682852;6060.878782424327;6072.36240194782;6073.635581865102;6093.421124993119;5121.513456221653;5418.1330987042675;5423.132298832168;5684.943150568524;5693.146028095819;3233.143217047484;3249.333886553251;3254.414205442996;3268.9019329420157;3274.590676165479;6272.3100458949475;6340.587861788969;6343.9365606343345;6347.809565713036;6352.871787951088;6193.473554747897;6222.097795819581;6227.412009937437;6252.811965726497;6319.388555918304;6288;6324.525660575475;6343.223897308761;6367.439977205614;6383.553151279459;5432.402435732145;6013.6692481913915;6118.908216376847;6126.111713801563;6132.8773424532155;5494.423085575957;5674.878816650743;5676.801311954062;5707.4577915098;5708.65748055118;5875.6474611523445;5883.382244864228;5889.911651325319;5911.881762364643;5950.137230101524;3873.5158105236846;3906.6093390661845;3912.6087391260644;3992.1416895367634;4025.8389664414267;5691.14632805066;5710.600257981901;5730.971345143247;5742.478243265455;5747.448188989033;5544.805931792529;5569.470900264469;5574.9721251393485;5604.161149612529;5611.576938067857;5428.83713488596;5606.327240731139;5608.971955140199;5611.551075913835;5621.4659607337235;5431.538319242909;5460.389185190299;5490.396056433869;5492.670439773467;5498.202760599611;5465.180222966428;5489.670619762827;5590.524805391425;5629.549636029026;5632.5212356950115;5394.136938089887;5423.5932305076485;5441.102218134122;5457.69982650958;5478.534324582296 07:17:18 INFO - PROCESS | 5616 | |5;yui.html;705.5272967112035;737.9557226566407;761.3490465651865;774.860525105481;815.3436483630675;14005.509807156752;14095.78856317156;14329.35517901693;15318.540443786676;15829.60425989348;14927.850721492781;14948;15037.699246015072;15045.172515511642;15058.39766409345;653.382553486955;777.3353782515952;805.6535689653447;811.3833486550205;811.7037281392309;811.8376324735048;816.4040250617053;816.8366326734676;817.239966830847;817.7219745286601;837.1042984007115;843.3632607381419;843.7595285343679;845.0619812008665;845.6067928413287;674.5547938360659;822.7531740477892;836.8493671139192;837.0290463062848;850.4812064640564;618.712298781069;619.3218425823716;621.018790311307;621.1056079245872;621.3599992008194;14057.367418466194;14152.504662336873;14168.645783855383;14218.146911185362;14237.216953067576;13261.27063011534;13732.862671373257;13740.175589464565;13750.518731844437;13834.861651383459;11269.774604507946;11366.545338186463;11421.143414243881;11457.427128643618;11470.139739519485;3794.4687743715904;3809.1810260794064;3860.2665493556133;3905.7265991380614;3908.1988192420486;55162.448375516135;55265;55670.164947525416;55760.721196394166;55893.72053139749;10523.736906577244;10781.137508999262;10911.781764364669;11083.002529772359;11180.776384472265;18787.436376908714;19336.613267734567;19419.61160776805;19465;19495.512612184524;8271.179004467216;8350.123237060143;8429.452085614415;8496.872546911802;8593.269572086318;4681.180793361148;4689.62483001359;4783.306420568998;4891.29076283944;4904.926426103611;3334.583177102862;3400.897973060812;3407.897763067112;3415.043787739437;3420.794752314869;570.6633086478997;606.1604677521664;607.4563265877015;623.0685125736961;625.0780099353417;640.0431355124026;672.603164133154;788.2293737512648;788.286600626434;795.6697970342359;9677.274204434696;9710.805783884283;9725.708228753148;9730.854037189449;9735.41587504752;742.3319012888336;769.8922150898878;775.53467919248;784.0395515493589;788.4047544104164;4718.834840780625;4780;4789.4971028042255;4798.568128868418;4816.373871396766;62370.376296237366;63428.048579271344;63944.36055639477;64104;64691;55194.72402637961;56253.71873140608;57099;57222.42777572171;57753.13370299449;45400.09199815985;48944.26583601249;49355.50644493581;49980;50586.22948196795;9456.33805633599;9544.57049432791;9777.315587909063;9831.655892043744;9963.302568820403;33894.83052584721;34152.316953661284;34439.65560344364;34553.82723086369;35432.82283588566;41058.79470602628;41389;41555.58444415638;43183.568164317956;46048.309275361564;11042.558297668003;11431.271135866387;11651.941740291244;11657.300561966309;11973.401329933295;12818.55135070268;13995.300234988006;14152.504662336769;14181.29093545298;14254.429822806971;13037.217766934014;13371.331433428095;13664.111832730841;13675.726485470035;14102.083364581269;12493.625191244277;13184.274864882524;13649.249291288677;13781.931090344484;13900.582982510541;13053.804192937303;13103.541376051793;13698.589042328746;13719.1082579632;13877.861221387657;10537.578496860346;10708.571657133627;10843.783124337628;11119;11525.135614829089;11125.833112503156;11209.943950280196;11387.202895797214;11536.769264614828;11572.42137893085 07:17:18 INFO - PROCESS | 5616 | __end_tp_report 07:17:18 INFO - PROCESS | 5616 | __start_cc_report 07:17:18 INFO - PROCESS | 5616 | _x_x_mozilla_cycle_collect,777 07:17:18 INFO - PROCESS | 5616 | __end_cc_report 07:17:18 INFO - PROCESS | 5616 | __startTimestamp1461766638411__endTimestamp 07:17:18 INFO - PROCESS | 5616 | 07:17:18 INFO - PROCESS | 5616 | ------- Summary: start ------- 07:17:18 INFO - PROCESS | 5616 | Number of tests: 6 07:17:18 INFO - PROCESS | 5616 | 07:17:18 INFO - PROCESS | 5616 | [#0] dojo.html Cycles:165 Average:5150.48 Median:5305.95 stddev:570.20 (10.7%) stddev-sans-first:547.36 07:17:18 INFO - PROCESS | 5616 | Values: 3039.0 3096.5 3120.5 3129.3 3162.2 5173.2 5190.5 5229.3 5235.9 5280.1 5120.9 5128.2 5233.2 5304.1 5309.0 4648.6 4686.6 4734.9 4786.4 4818.3 4758.2 4774.8 4779.1 4819.8 4865.1 4653.0 4722.2 4780.3 4812.4 4837.7 4669.1 4672.2 4679.9 4681.6 4709.6 4648.7 4652.1 4664.5 4676.4 4711.0 5046.2 5079.8 5089.9 5094.6 5097.8 5456.0 5456.6 5464.9 5469.0 5479.1 5432.8 5488.8 5552.1 5561.9 5563.8 5173.5 5191.1 5200.5 5202.8 5245.0 5655.4 5657.8 5660.0 5661.6 5669.4 5339.5 5404.1 5411.8 5434.5 5482.0 5572.6 5580.7 5583.8 5599.3 5606.6 5540.8 5563.0 5563.0 5564.9 5570.3 5418.6 5553.2 5593.0 5634.0 5641.5 4223.5 4231.8 4235.6 4236.8 4273.1 3807.8 3810.1 3815.4 3820.0 3837.5 5101.4 5144.6 5239.8 5321.0 5331.5 5515.2 5521.4 5526.4 5543.9 5544.5 5210.8 5236.2 5243.2 5246.6 5273.8 4694.6 4751.7 4782.7 4819.9 4825.1 5743.7 5761.4 5765.5 5775.3 5784.8 5437.3 5575.6 5585.8 5606.4 5658.7 5800.7 5844.9 5854.6 5872.9 5887.5 5496.4 5501.2 5505.4 5508.4 5517.0 5572.7 5579.0 5580.3 5584.5 5627.4 5259.9 5301.8 5344.0 5371.0 5390.4 5306.6 5306.7 5313.8 5314.2 5321.2 5202.4 5208.7 5218.2 5226.8 5229.2 5371.6 5400.9 5409.3 5413.9 5455.3 5299.0 5300.2 5304.0 5305.9 5358.4 07:17:18 INFO - PROCESS | 5616 | 07:17:18 INFO - PROCESS | 5616 | [#1] ext.html Cycles:180 Average:55308.62 Median:34904.74 stddev:104266.15 (298.7%) stddev-sans-first:104477.76 07:17:18 INFO - PROCESS | 5616 | Values: 610.2 636.3 651.2 658.3 660.2 30847.2 38904.8 39456.8 39677.4 39733.4 41822.2 42368.4 42440.0 42501.1 42584.6 7399.4 8625.7 8832.3 8856.1 10114.1 10190.7 10369.1 10381.9 10390.5 10403.3 10336.5 10458.9 10469.9 10471.0 10471.0 7343.1 10119.3 10288.5 10377.5 10382.1 10205.7 10348.6 10363.2 10365.1 10367.9 38777.8 39537.4 39555.6 39559.6 39563.6 3460.6 3465.9 3516.7 3627.7 3869.1 33022.0 33457.5 33503.8 33507.5 34918.5 4314.1 4345.0 4367.3 4382.1 4412.0 334566.0 334612.0 334822.0 337020.0 337980.3 59398.4 59798.7 60064.1 60136.4 60148.0 63470.0 63602.0 63638.7 63769.0 63790.0 15776.5 16258.3 16294.5 16306.9 16336.8 12425.3 12563.8 12592.3 12608.0 12618.7 17345.8 17440.6 17486.5 17575.6 17577.8 5009.0 5676.9 5857.9 5878.5 5970.9 1025.2 1036.2 1052.9 1113.4 1187.9 31534.2 32270.7 32932.7 33076.7 33319.0 1104.2 1125.1 1172.3 1198.9 1318.8 17025.6 17456.7 17559.6 17560.4 17605.6 504046.0 508879.0 509588.0 510233.0 511151.0 57852.4 57889.0 58067.4 58176.0 58250.0 1259.8 1357.8 1381.4 1417.5 1512.7 29166.7 30168.5 30330.7 30765.2 33188.8 46391.3 46642.0 46709.3 46851.3 46973.3 306395.0 307865.0 308457.0 308877.0 309410.0 31761.0 32769.0 38279.8 38574.8 38911.6 42080.4 42512.1 42862.0 43137.4 43475.6 34891.0 38848.2 40235.2 41143.2 41792.6 39289.2 39666.4 40042.2 40148.2 40653.2 40206.0 40619.4 40763.2 40765.2 41706.4 34058.3 35094.8 35280.8 35976.6 36312.3 27323.5 27886.7 27992.3 28088.3 28413.0 07:17:18 INFO - PROCESS | 5616 | 07:17:18 INFO - PROCESS | 5616 | [#2] jquery.html Cycles:180 Average:29274.34 Median:20628.64 stddev:85514.46 (414.5%) stddev-sans-first:85726.81 07:17:18 INFO - PROCESS | 5616 | Values: 370.5 381.6 384.9 393.6 395.9 17221.7 18438.3 18886.8 18890.8 18905.9 18729.9 18894.3 19133.8 19146.1 19779.4 5477.3 5578.8 5718.8 5749.6 5763.0 5707.3 5723.6 5737.6 5740.7 5746.7 5533.2 5878.1 5882.9 5889.7 5890.9 5619.1 5824.9 5826.3 5839.0 5870.1 5656.6 5692.6 5710.3 5726.5 5759.6 13700.7 13935.9 20845.2 21332.6 21462.5 2233.6 2308.6 2408.4 2487.0 2734.2 9876.0 10229.0 10442.9 10445.4 10604.9 1896.0 1903.7 1935.3 1951.8 1989.7 59145.7 79671.6 81268.6 83296.0 84638.6 9789.8 10330.3 10351.5 10910.4 10955.9 13869.7 14622.7 14633.3 14650.2 14681.8 7293.8 7307.9 7341.2 7474.9 7588.8 7176.5 7284.5 7292.4 7300.6 7367.6 4553.3 4555.9 4569.9 4657.8 4756.4 1690.1 1693.6 1696.1 1747.8 1888.8 943.5 959.5 961.5 989.7 1017.9 18479.9 19540.4 19549.9 19791.6 19846.7 907.7 978.5 981.4 983.4 1069.7 9959.8 10639.4 10718.4 10814.8 10873.2 505447.0 506438.0 520856.0 531646.0 534130.0 87689.6 87856.6 89264.6 90604.0 92533.5 1039.9 1060.2 1081.6 1087.6 1097.0 14537.9 16834.6 16907.7 17347.8 17454.6 32046.8 40861.4 43035.1 43132.8 44367.3 55508.7 56017.0 57109.7 57203.7 57982.7 8147.1 8249.4 8518.4 8695.0 8741.1 11892.9 12812.3 13166.0 13172.3 13347.3 8631.9 10977.7 11805.4 12157.5 12261.4 6608.9 6833.0 9379.0 11780.9 12080.0 11782.2 11990.7 12060.2 12079.9 12422.3 8338.6 8800.0 8811.1 8838.4 9036.8 11436.1 11473.4 11498.2 11527.4 11568.8 07:17:18 INFO - PROCESS | 5616 | 07:17:18 INFO - PROCESS | 5616 | [#3] mootools.html Cycles:180 Average:5479.52 Median:4970.85 stddev:3042.96 (61.2%) stddev-sans-first:3035.25 07:17:18 INFO - PROCESS | 5616 | Values: 1295.7 1466.3 1531.5 1655.3 1821.4 8108.8 8424.0 8437.4 8438.2 8444.2 7945.3 8104.0 8111.2 8111.8 8116.6 1937.2 2235.5 2266.5 2290.6 2300.7 2307.2 2315.7 2320.3 2321.0 2322.2 2213.3 2219.8 2258.6 2260.0 2260.4 1917.7 1971.1 2165.9 2246.7 2280.4 2259.6 2282.6 2285.1 2285.7 2288.3 8065.4 8098.7 8118.0 8136.9 8151.5 4818.2 4937.3 4943.8 4965.8 4973.8 3034.3 3124.4 3240.2 3249.1 3290.4 1146.0 1151.1 1159.0 1175.9 1176.5 11367.3 11647.2 11670.5 11691.6 11705.2 4305.7 4496.6 4514.2 4586.6 4605.7 9912.8 9938.4 9949.5 9950.6 9952.1 4967.9 5026.7 5038.4 5040.0 5040.7 3947.6 4448.4 4535.8 4542.2 4560.2 3810.8 3822.8 3907.9 3930.9 3987.3 1210.5 1231.2 1233.3 1247.6 1249.1 960.8 968.9 972.5 977.6 990.1 5627.6 5644.7 5650.5 5784.1 6070.2 1008.4 1028.2 1038.4 1091.4 1098.2 4057.8 4073.4 4078.4 4084.6 4087.6 9422.2 9760.8 9809.4 9814.1 9834.4 9627.9 9640.6 9698.6 9706.8 9876.0 7376.3 7468.0 7544.0 7735.3 7741.1 5673.3 5728.7 5913.0 5923.8 5969.9 9112.7 9439.5 9728.3 9818.2 9863.1 9764.2 9926.2 9993.9 10022.7 10137.5 7095.0 7129.9 7344.8 7360.9 7364.5 7827.7 7833.1 7864.7 7869.4 7895.4 7042.7 7066.8 7158.5 7457.4 7482.4 6944.8 7060.7 7094.0 7170.1 7340.0 6581.3 6605.2 6643.7 6659.6 6667.7 4783.3 4783.3 4817.8 4937.5 4989.8 4747.1 4803.2 4823.4 4918.1 4932.6 07:17:18 INFO - PROCESS | 5616 | 07:17:18 INFO - PROCESS | 5616 | [#4] prototype.html Cycles:180 Average:4738.23 Median:5430.19 stddev:1434.04 (26.4%) stddev-sans-first:1399.15 07:17:18 INFO - PROCESS | 5616 | Values: 317.7 326.5 332.2 332.7 336.3 5201.0 5250.7 5349.3 5371.7 5399.5 5228.7 5302.4 5315.7 5333.8 5338.8 4151.8 4154.2 4167.1 4189.4 4199.1 3898.0 4138.4 4165.0 4187.3 4192.0 4066.5 4070.3 4074.8 4077.3 4091.8 4075.5 4085.2 4090.9 4100.6 4106.8 3604.9 3605.4 3613.6 3616.1 3636.3 5039.3 5104.9 5127.1 5129.8 5145.9 4588.6 4608.4 4615.6 4664.7 4667.5 5440.2 5447.8 5491.8 5495.7 5500.5 3817.5 3908.1 3921.5 3939.1 3959.6 5455.6 5650.1 5745.5 5780.1 5807.9 3867.5 3949.7 3956.3 3976.6 4012.3 3836.7 3929.7 4013.8 4039.4 4072.7 4623.5 4634.1 4666.8 4667.5 4677.7 5552.1 5554.1 5564.3 5571.6 5575.9 1422.3 1460.0 1468.7 1469.2 1475.7 926.5 937.4 945.4 947.2 948.1 5613.7 5658.6 5679.2 5695.2 5703.4 6051.8 6060.9 6072.4 6073.6 6093.4 5121.5 5418.1 5423.1 5684.9 5693.1 3233.1 3249.3 3254.4 3268.9 3274.6 6272.3 6340.6 6343.9 6347.8 6352.9 6193.5 6222.1 6227.4 6252.8 6319.4 6288.0 6324.5 6343.2 6367.4 6383.6 5432.4 6013.7 6118.9 6126.1 6132.9 5494.4 5674.9 5676.8 5707.5 5708.7 5875.6 5883.4 5889.9 5911.9 5950.1 3873.5 3906.6 3912.6 3992.1 4025.8 5691.1 5710.6 5731.0 5742.5 5747.4 5544.8 5569.5 5575.0 5604.2 5611.6 5428.8 5606.3 5609.0 5611.6 5621.5 5431.5 5460.4 5490.4 5492.7 5498.2 5465.2 5489.7 5590.5 5629.5 5632.5 5394.1 5423.6 5441.1 5457.7 5478.5 07:17:18 INFO - PROCESS | 5616 | 07:17:18 INFO - PROCESS | 5616 | [#5] yui.html Cycles:180 Average:15020.00 Median:25364.75 stddev:17168.30 (67.7%) stddev-sans-first:17182.81 07:17:18 INFO - PROCESS | 5616 | Values: 705.5 738.0 761.3 774.9 815.3 14005.5 14095.8 14329.4 15318.5 15829.6 14927.9 14948.0 15037.7 15045.2 15058.4 653.4 777.3 805.7 811.4 811.7 811.8 816.4 816.8 817.2 817.7 837.1 843.4 843.8 845.1 845.6 674.6 822.8 836.8 837.0 850.5 618.7 619.3 621.0 621.1 621.4 14057.4 14152.5 14168.6 14218.1 14237.2 13261.3 13732.9 13740.2 13750.5 13834.9 11269.8 11366.5 11421.1 11457.4 11470.1 3794.5 3809.2 3860.3 3905.7 3908.2 55162.4 55265.0 55670.2 55760.7 55893.7 10523.7 10781.1 10911.8 11083.0 11180.8 18787.4 19336.6 19419.6 19465.0 19495.5 8271.2 8350.1 8429.5 8496.9 8593.3 4681.2 4689.6 4783.3 4891.3 4904.9 3334.6 3400.9 3407.9 3415.0 3420.8 570.7 606.2 607.5 623.1 625.1 640.0 672.6 788.2 788.3 795.7 9677.3 9710.8 9725.7 9730.9 9735.4 742.3 769.9 775.5 784.0 788.4 4718.8 4780.0 4789.5 4798.6 4816.4 62370.4 63428.0 63944.4 64104.0 64691.0 55194.7 56253.7 57099.0 57222.4 57753.1 45400.1 48944.3 49355.5 49980.0 50586.2 9456.3 9544.6 9777.3 9831.7 9963.3 33894.8 34152.3 34439.7 34553.8 35432.8 41058.8 41389.0 41555.6 43183.6 46048.3 11042.6 11431.3 11651.9 11657.3 11973.4 12818.6 13995.3 14152.5 14181.3 14254.4 13037.2 13371.3 13664.1 13675.7 14102.1 12493.6 13184.3 13649.2 13781.9 13900.6 13053.8 13103.5 13698.6 13719.1 13877.9 10537.6 10708.6 10843.8 11119.0 11525.1 11125.8 11209.9 11387.2 11536.8 11572.4 07:17:18 INFO - PROCESS | 5616 | -------- Summary: end -------- 07:17:18 INFO - PROCESS | 5616 | 07:17:18 INFO - TEST-INFO | 5616: exit 0 07:17:18 INFO - TEST-OK | dromaeo_css | took 1111636ms 07:17:18 INFO - TEST-START | kraken 07:17:18 INFO - operating with platform_type : linux_ 07:17:18 INFO - Initialising browser for kraken test... 07:17:19 INFO - TEST-INFO | started process 5802 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpw5oWg8/profile http://localhost:43735/getInfo.html) 07:17:23 INFO - PROCESS | 5802 | __metrics Screen width/height:1600/1200 07:17:23 INFO - PROCESS | 5802 | colorDepth:24 07:17:23 INFO - PROCESS | 5802 | Browser inner width/height: 1024/697 07:17:23 INFO - PROCESS | 5802 | __metrics 07:17:24 ERROR - PROCESS | 5802 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:17:24 INFO - TEST-INFO | 5802: exit 0 07:17:24 INFO - Browser initialized. 07:17:24 INFO - Running cycle 1/1 for kraken test... 07:17:24 INFO - TEST-INFO | started process 5884 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpw5oWg8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:17:36 INFO - PROCESS | 5884 | RSS: Main: 154415104 07:17:36 INFO - PROCESS | 5884 | 07:17:39 INFO - PROCESS | 5884 | Cycle 1(1): loaded http://localhost:43735/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43735/tests/kraken/driver.html?testName=audio-beat-detection) 07:17:40 INFO - PROCESS | 5884 | RSS: Main: 209616896 07:17:40 INFO - PROCESS | 5884 | 07:17:42 INFO - PROCESS | 5884 | Cycle 1(1): loaded http://localhost:43735/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43735/tests/kraken/driver.html?testName=audio-dft) 07:17:43 INFO - PROCESS | 5884 | RSS: Main: 194916352 07:17:43 INFO - PROCESS | 5884 | 07:17:46 INFO - PROCESS | 5884 | Cycle 1(1): loaded http://localhost:43735/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43735/tests/kraken/driver.html?testName=audio-fft) 07:17:47 INFO - PROCESS | 5884 | RSS: Main: 266088448 07:17:47 INFO - PROCESS | 5884 | 07:17:49 INFO - PROCESS | 5884 | Cycle 1(1): loaded http://localhost:43735/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43735/tests/kraken/driver.html?testName=audio-oscillator) 07:17:49 INFO - PROCESS | 5884 | RSS: Main: 173940736 07:17:49 INFO - PROCESS | 5884 | 07:17:52 INFO - PROCESS | 5884 | Cycle 1(1): loaded http://localhost:43735/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43735/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:17:52 INFO - PROCESS | 5884 | RSS: Main: 178810880 07:17:52 INFO - PROCESS | 5884 | 07:17:55 INFO - PROCESS | 5884 | Cycle 1(1): loaded http://localhost:43735/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43735/tests/kraken/driver.html?testName=imaging-darkroom) 07:17:56 INFO - PROCESS | 5884 | RSS: Main: 215015424 07:17:56 INFO - PROCESS | 5884 | 07:17:59 INFO - PROCESS | 5884 | Cycle 1(1): loaded http://localhost:43735/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43735/tests/kraken/driver.html?testName=imaging-desaturate) 07:18:00 INFO - PROCESS | 5884 | RSS: Main: 215261184 07:18:00 INFO - PROCESS | 5884 | 07:18:02 INFO - PROCESS | 5884 | Cycle 1(1): loaded http://localhost:43735/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43735/tests/kraken/driver.html?testName=json-parse-financial) 07:18:03 INFO - PROCESS | 5884 | RSS: Main: 215318528 07:18:03 INFO - PROCESS | 5884 | 07:18:05 INFO - PROCESS | 5884 | Cycle 1(1): loaded http://localhost:43735/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43735/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:18:05 INFO - PROCESS | 5884 | RSS: Main: 204730368 07:18:05 INFO - PROCESS | 5884 | 07:18:07 INFO - PROCESS | 5884 | Cycle 1(1): loaded http://localhost:43735/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43735/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:18:07 INFO - PROCESS | 5884 | RSS: Main: 204902400 07:18:07 INFO - PROCESS | 5884 | 07:18:09 INFO - PROCESS | 5884 | Cycle 1(1): loaded http://localhost:43735/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43735/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:18:10 INFO - PROCESS | 5884 | RSS: Main: 216571904 07:18:10 INFO - PROCESS | 5884 | 07:18:13 INFO - PROCESS | 5884 | Cycle 1(1): loaded http://localhost:43735/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43735/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:18:13 INFO - PROCESS | 5884 | RSS: Main: 224833536 07:18:13 INFO - PROCESS | 5884 | 07:18:16 INFO - PROCESS | 5884 | Cycle 1(1): loaded http://localhost:43735/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43735/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:18:17 INFO - PROCESS | 5884 | RSS: Main: 219467776 07:18:17 INFO - PROCESS | 5884 | 07:18:18 INFO - PROCESS | 5884 | Cycle 1(1): loaded http://localhost:43735/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43735/tests/kraken/driver.html?testName=ai-astar) 07:18:19 INFO - PROCESS | 5884 | RSS: Main: 283181056 07:18:19 INFO - PROCESS | 5884 | 07:18:19 INFO - PROCESS | 5884 | __start_tp_report 07:18:19 INFO - PROCESS | 5884 | _x_x_mozilla_page_load 07:18:19 INFO - PROCESS | 5884 | _x_x_mozilla_page_load_details 07:18:19 INFO - PROCESS | 5884 | |i|pagename|runs| 07:18:19 INFO - PROCESS | 5884 | |0;ai-astar;110;111;107;110;114;112;101;112;113;111 07:18:19 INFO - PROCESS | 5884 | |1;audio-beat-detection;167;127;155;180;128;157;165;129;182;131 07:18:19 INFO - PROCESS | 5884 | |2;audio-dft;162;160;162;162;161;161;160;162;161;177 07:18:19 INFO - PROCESS | 5884 | |3;audio-fft;75;77;102;115;77;72;73;118;104;75 07:18:19 INFO - PROCESS | 5884 | |4;audio-oscillator;92;92;148;92;93;93;151;92;92;147 07:18:19 INFO - PROCESS | 5884 | |5;imaging-gaussian-blur;116;117;116;117;116;116;116;117;116;116 07:18:19 INFO - PROCESS | 5884 | |6;imaging-darkroom;146;146;146;146;146;146;146;146;146;147 07:18:19 INFO - PROCESS | 5884 | |7;imaging-desaturate;94;95;95;94;95;95;95;95;95;95 07:18:19 INFO - PROCESS | 5884 | |8;json-parse-financial;58;58;58;57;58;65;58;77;57;56 07:18:19 INFO - PROCESS | 5884 | |9;json-stringify-tinderbox;61;60;59;60;61;61;61;62;61;62 07:18:19 INFO - PROCESS | 5884 | |10;stanford-crypto-aes;77;78;76;76;76;85;77;86;79;77 07:18:19 INFO - PROCESS | 5884 | |11;stanford-crypto-ccm;124;121;127;123;122;122;122;131;155;131 07:18:19 INFO - PROCESS | 5884 | |12;stanford-crypto-pbkdf2;172;165;178;162;163;165;165;167;167;165 07:18:19 INFO - PROCESS | 5884 | |13;stanford-crypto-sha256-iterative;72;68;70;69;73;69;68;69;68;68 07:18:19 INFO - PROCESS | 5884 | __end_tp_report 07:18:19 INFO - PROCESS | 5884 | __start_cc_report 07:18:19 INFO - PROCESS | 5884 | _x_x_mozilla_cycle_collect,1638 07:18:19 INFO - PROCESS | 5884 | __end_cc_report 07:18:19 INFO - PROCESS | 5884 | __startTimestamp1461766699152__endTimestamp 07:18:19 INFO - PROCESS | 5884 | 07:18:19 INFO - PROCESS | 5884 | ------- Summary: start ------- 07:18:19 INFO - PROCESS | 5884 | Number of tests: 14 07:18:19 INFO - PROCESS | 5884 | 07:18:19 INFO - PROCESS | 5884 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.50 stddev:3.73 (3.3%) stddev-sans-first:3.95 07:18:19 INFO - PROCESS | 5884 | Values: 110.0 111.0 107.0 110.0 114.0 112.0 101.0 112.0 113.0 111.0 07:18:19 INFO - PROCESS | 5884 | 07:18:19 INFO - PROCESS | 5884 | [#1] audio-beat-detection Cycles:10 Average:152.10 Median:161.00 stddev:21.81 (13.5%) stddev-sans-first:22.46 07:18:19 INFO - PROCESS | 5884 | Values: 167.0 127.0 155.0 180.0 128.0 157.0 165.0 129.0 182.0 131.0 07:18:19 INFO - PROCESS | 5884 | 07:18:19 INFO - PROCESS | 5884 | [#2] audio-dft Cycles:10 Average:162.80 Median:162.00 stddev:5.05 (3.1%) stddev-sans-first:5.35 07:18:19 INFO - PROCESS | 5884 | Values: 162.0 160.0 162.0 162.0 161.0 161.0 160.0 162.0 161.0 177.0 07:18:19 INFO - PROCESS | 5884 | 07:18:19 INFO - PROCESS | 5884 | [#3] audio-fft Cycles:10 Average:88.80 Median:74.00 stddev:18.67 (25.2%) stddev-sans-first:19.12 07:18:19 INFO - PROCESS | 5884 | Values: 75.0 77.0 102.0 115.0 77.0 72.0 73.0 118.0 104.0 75.0 07:18:19 INFO - PROCESS | 5884 | 07:18:19 INFO - PROCESS | 5884 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:92.00 stddev:27.26 (29.6%) stddev-sans-first:28.19 07:18:19 INFO - PROCESS | 5884 | Values: 92.0 92.0 148.0 92.0 93.0 93.0 151.0 92.0 92.0 147.0 07:18:19 INFO - PROCESS | 5884 | 07:18:19 INFO - PROCESS | 5884 | [#5] imaging-gaussian-blur Cycles:10 Average:116.30 Median:116.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 07:18:19 INFO - PROCESS | 5884 | Values: 116.0 117.0 116.0 117.0 116.0 116.0 116.0 117.0 116.0 116.0 07:18:19 INFO - PROCESS | 5884 | 07:18:19 INFO - PROCESS | 5884 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 07:18:19 INFO - PROCESS | 5884 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 147.0 07:18:19 INFO - PROCESS | 5884 | 07:18:19 INFO - PROCESS | 5884 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 07:18:19 INFO - PROCESS | 5884 | Values: 94.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 07:18:19 INFO - PROCESS | 5884 | 07:18:19 INFO - PROCESS | 5884 | [#8] json-parse-financial Cycles:10 Average:60.20 Median:58.00 stddev:6.39 (11.0%) stddev-sans-first:6.73 07:18:19 INFO - PROCESS | 5884 | Values: 58.0 58.0 58.0 57.0 58.0 65.0 58.0 77.0 57.0 56.0 07:18:19 INFO - PROCESS | 5884 | 07:18:19 INFO - PROCESS | 5884 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.92 (1.5%) stddev-sans-first:0.97 07:18:19 INFO - PROCESS | 5884 | Values: 61.0 60.0 59.0 60.0 61.0 61.0 61.0 62.0 61.0 62.0 07:18:19 INFO - PROCESS | 5884 | 07:18:19 INFO - PROCESS | 5884 | [#10] stanford-crypto-aes Cycles:10 Average:78.70 Median:77.50 stddev:3.71 (4.8%) stddev-sans-first:3.89 07:18:19 INFO - PROCESS | 5884 | Values: 77.0 78.0 76.0 76.0 76.0 85.0 77.0 86.0 79.0 77.0 07:18:19 INFO - PROCESS | 5884 | 07:18:19 INFO - PROCESS | 5884 | [#11] stanford-crypto-ccm Cycles:10 Average:127.80 Median:125.50 stddev:10.25 (8.2%) stddev-sans-first:10.78 07:18:19 INFO - PROCESS | 5884 | Values: 124.0 121.0 127.0 123.0 122.0 122.0 122.0 131.0 155.0 131.0 07:18:19 INFO - PROCESS | 5884 | 07:18:19 INFO - PROCESS | 5884 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.90 Median:166.00 stddev:4.75 (2.9%) stddev-sans-first:4.66 07:18:19 INFO - PROCESS | 5884 | Values: 172.0 165.0 178.0 162.0 163.0 165.0 165.0 167.0 167.0 165.0 07:18:19 INFO - PROCESS | 5884 | 07:18:19 INFO - PROCESS | 5884 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:69.00 stddev:1.78 (2.6%) stddev-sans-first:1.62 07:18:19 INFO - PROCESS | 5884 | Values: 72.0 68.0 70.0 69.0 73.0 69.0 68.0 69.0 68.0 68.0 07:18:19 INFO - PROCESS | 5884 | -------- Summary: end -------- 07:18:19 INFO - PROCESS | 5884 | 07:18:20 INFO - TEST-INFO | 5884: exit 0 07:18:20 INFO - TEST-OK | kraken | took 61100ms 07:18:20 INFO - SUITE-END | took 1172s 07:18:20 INFO - Completed test suite (00:19:32) 07:18:20 INFO - javascript benchmark 07:18:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3038.969610303897, 3096.5045592705173, 3120.5475206095116, 3129.342838004019, 3162.1620270628287, 5173.224016397542, 5190.480951904808, 5229.346331708542, 5235.947640523594, 5280.075986702331, 5120.948790512094, 5128.205128205125, 5233.241180028894, 5304.098303288441, 5309.0, 4648.604868586174, 4686.601638860692, 4734.928976065362, 4786.425628924534, 4818.277258411249, 4758.191107511714, 4774.80900763969, 4779.139754844126, 4819.807207711688, 4865.124277630025, 4652.953470465302, 4722.220833562458, 4780.259059845729, 4812.446568644598, 4837.7339246341435, 4669.089527542131, 4672.229082201433, 4679.9298010529865, 4681.602063824579, 4709.6467764917425, 4648.74431906245, 4652.092841895832, 4664.5102264262105, 4676.36869022681, 4710.976445117787, 5046.21783623539, 5079.79680812767, 5089.923651145235, 5094.592432605383, 5097.7960881564695, 5455.972720136414, 5456.645318054314, 5464.9453505465235, 5469.0, 5479.123340265578, 5432.837014889559, 5488.7530061146945, 5552.111662134039, 5561.860953476155, 5563.833085007456, 5173.456787037345, 5191.117510023343, 5200.5059519345605, 5202.76587553561, 5245.0, 5655.406182350876, 5657.8019769307875, 5659.971700141556, 5661.631993920382, 5669.4047125051275, 5339.519443250126, 5404.108322126884, 5411.810586629449, 5434.456554344534, 5482.0, 5572.637778544463, 5580.693061881554, 5583.776648934078, 5599.272094627754, 5606.607537472338, 5540.7783688652, 5563.0, 5563.0, 5564.944350556442, 5570.3315602128005, 5418.566514678816, 5553.222548843165, 5593.049181639131, 5633.971830140823, 5641.464060914206, 4223.493180818322, 4231.78841057952, 4235.597618226325, 4236.809343579546, 4273.1240095780295, 3807.8286477108595, 3810.1046254130256, 3815.42768584709, 3820.0449887528116, 3837.5394952605866, 5101.387833460009, 5144.61415393847, 5239.842804715865, 5321.042212401805, 5331.466853314638, 5515.172724091338, 5521.420250873681, 5526.364468086141, 5543.889122217533, 5544.473275038865, 5210.765515551733, 5236.188390799432, 5243.187305967581, 5246.554042906319, 5273.762680679379, 4694.624430045588, 4751.714897106184, 4782.713037217778, 4819.855404337875, 4825.131476334223, 5743.712814359265, 5761.3950535194035, 5765.509931655773, 5775.27809023872, 5784.8264552062665, 5437.32033495813, 5575.637583556974, 5585.804496842591, 5606.439356064361, 5658.745356458887, 5800.6809625471005, 5844.853878653068, 5854.590178687621, 5872.94127058741, 5887.470127688529, 5496.395396506461, 5501.229827824028, 5505.394406615189, 5508.421615730451, 5516.972415137899, 5572.665640061609, 5579.0, 5580.302462192226, 5584.525315348241, 5627.380988091225, 5259.947400525945, 5301.761420735999, 5343.973280133574, 5370.979513892348, 5390.407055223844, 5306.602004849729, 5306.681599104066, 5313.760880760297, 5314.176302673091, 5321.175217841241, 5202.427732949448, 5208.661437006583, 5218.217267409919, 5226.764795584284, 5229.189475631283, 5371.62398632092, 5400.864978375572, 5409.323834520685, 5413.864653383697, 5455.345358556999, 5299.046171689133, 5300.231466437422, 5304.0, 5305.946940530545, 5358.437364076872], "value": 5113.594371427459, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [610.2311088029085, 636.328673249722, 651.160003595362, 658.2857599504534, 660.1846719301661, 30847.228819279528, 38904.805475972615, 39456.80271598645, 39677.40483892744, 39733.40399894004, 41822.16355672885, 42368.36447453291, 42440.0, 42501.14997700052, 42584.57415425845, 7399.408047356225, 8625.741227763177, 8832.337574681893, 8856.070112638177, 10114.140298074635, 10190.745231369201, 10369.06678398944, 10381.896181038168, 10390.480475976208, 10403.271770976035, 10336.483175841215, 10458.947705261464, 10469.895301046969, 10470.952904709506, 10470.952904709544, 7343.082114735631, 10119.342242754197, 10288.48557572122, 10377.495263186871, 10382.117520010808, 10205.744856378577, 10348.58605655773, 10363.222758293157, 10365.118964887994, 10367.89632103677, 38777.80611096955, 39537.40693889565, 39555.60444395548, 39559.60440395588, 39563.60436395628, 3460.619331873492, 3465.8960231193105, 3516.7186625069935, 3627.7097832173627, 3869.090763670535, 33022.0, 33457.49813752795, 33503.832480837686, 33507.49738753921, 34918.476222856676, 4314.094040251551, 4344.956550434486, 4367.3448982652535, 4382.123575284956, 4411.955880441186, 334566.0, 334611.99999999756, 334822.0, 337020.0, 337980.3100984504, 59398.40601593929, 59798.70100649469, 60064.099038514454, 60136.39863601395, 60148.0, 63470.0, 63602.0, 63638.68180659067, 63769.0, 63790.0, 15776.526704198892, 16258.268377923021, 16294.511164665078, 16306.918465407596, 16336.754948675542, 12425.254484730945, 12563.811542826865, 12592.307423091817, 12608.0, 12618.684532886751, 17345.826541734674, 17440.5639859002, 17486.47540573785, 17575.648487030187, 17577.82422175762, 5008.973160502088, 5676.914846277309, 5857.882842343214, 5878.500982249499, 5970.940290597126, 1025.2003437318904, 1036.23836480187, 1052.8526006359116, 1113.4377139544479, 1187.928724276546, 31534.211644709067, 32270.677293226767, 32932.74005800337, 33076.66923330784, 33319.0, 1104.216006635282, 1125.083057308291, 1172.3376292394769, 1198.8681245063035, 1318.775808112623, 17025.574360641083, 17456.738148927776, 17559.561010974827, 17560.38538651141, 17605.64788704219, 504046.0, 508879.0, 509588.0, 510233.0, 511151.0, 57852.421475785544, 57889.0, 58067.419325807045, 58176.0, 58250.0, 1259.779538580763, 1357.7827547592337, 1381.4267079162237, 1417.5038736442368, 1512.7050225206199, 29166.70833291725, 30168.54747178838, 30330.69669303367, 30765.19033130832, 33188.834055830535, 46391.304130438744, 46642.0, 46709.2993605103, 46851.297230540884, 46973.295400568335, 306395.0, 307865.0, 308457.0, 308877.0, 309410.0, 31761.0, 32769.0, 38279.808600956814, 38574.80712596419, 38911.61088389193, 42080.3687944675, 42512.1497570053, 42862.0, 43137.3529397053, 43475.56524434715, 34891.0, 38848.22303553857, 40235.1952960945, 41143.17713645651, 41792.58207417887, 39289.2142157161, 39666.40500392439, 40042.1991560173, 40148.1970360597, 40653.18693626052, 40206.0, 40619.390709138796, 40763.1847363057, 40765.18469630532, 41706.374404384565, 34058.318833622696, 35094.824525878226, 35280.82359588288, 35976.64023359733, 36312.27375452529, 27323.453530929666, 27886.72113278841, 27992.30019249535, 28088.29779255453, 28413.0], "value": 19994.824030218464, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.4517314374725, 381.61647544218056, 384.85567912032985, 393.590665707664, 395.8950878017324, 17221.655566888654, 18438.262469501205, 18886.811131888695, 18890.811091889078, 18905.90547047263, 18729.906350468227, 18894.338698145566, 19133.808661913376, 19146.138423770928, 19779.406617801487, 5477.260569823083, 5578.832635020955, 5718.799842005531, 5749.59752817303, 5762.971185144069, 5707.286589176353, 5723.599348045638, 5737.598368114233, 5740.684262365568, 5746.741396637161, 5533.22534845122, 5878.118282257653, 5882.88234235315, 5889.676067816268, 5890.88218235635, 5619.129034999582, 5824.883502329951, 5826.271716035496, 5839.0, 5870.148828419855, 5656.575756818255, 5692.57305702074, 5710.314762228518, 5726.455986681259, 5759.5968282220265, 13700.725985480234, 13935.860641393558, 20845.16619335225, 21332.573348533097, 21462.463438414008, 2233.564454931289, 2308.5729140109133, 2408.3858616052794, 2486.96269555955, 2734.179746076169, 9875.950620246853, 10229.0, 10442.947785261025, 10445.373277603368, 10604.893951060469, 1896.0424985382294, 1903.7239600258024, 1935.2742721479444, 1951.834094102003, 1989.691597802343, 59145.7042714788, 79671.601641992, 81268.59365703134, 83296.0, 84638.57680711619, 9789.82522097353, 10330.276880618285, 10351.534180961875, 10910.399928003877, 10955.890441095646, 13869.653258668613, 14622.707545849024, 14633.268336583129, 14650.194239316726, 14681.77977330341, 7293.817654558678, 7307.926920730831, 7341.229170937081, 7474.925250747532, 7588.81027974294, 7176.478142116942, 7284.490085694057, 7292.416606671453, 7300.629603760847, 7367.631618419057, 4553.317002449593, 4555.931661025087, 4569.920686087822, 4657.790399432034, 4756.381670382897, 1690.1464760295971, 1693.6274019715643, 1696.1434475589995, 1747.772789537352, 1888.8488920886296, 943.4905151218403, 959.5058544849409, 961.485605201214, 989.7030890732751, 1017.9032991865761, 18479.907600461913, 19540.413787586396, 19549.90225048894, 19791.60416791685, 19846.70229946552, 907.7412937312835, 978.471625322318, 981.352307477076, 983.3706427886159, 1069.7272195590074, 9959.787196842892, 10639.414832184304, 10718.410487423267, 10814.783704326026, 10873.207411692065, 505447.0, 506438.0, 520856.0, 531646.0, 534130.0, 87689.56155219184, 87856.56071719728, 89264.5536772312, 90604.0, 92533.5373323129, 1039.8856125826153, 1060.204846365226, 1081.5998080710187, 1087.581281206741, 1097.0346095435966, 14537.85462145365, 16834.5690616299, 16907.66184676275, 17347.82652173462, 17454.563635909202, 32046.83976580102, 40861.38707919443, 43035.139297214504, 43132.84335783261, 44367.334489983325, 55508.72245638746, 56017.0, 57109.71445142748, 57203.71398142983, 57982.7100864493, 8147.1038185798325, 8249.381296402913, 8518.36112291593, 8695.043545210148, 8741.125887411208, 11892.940535297268, 12812.295323757282, 13166.0, 13172.275524845842, 13347.332633368487, 8631.870521942301, 10977.670669879917, 11805.350705711267, 12157.513699451923, 12261.386930653252, 6608.867822643617, 6833.043373927555, 9378.95310523443, 11780.941095294469, 12080.0, 11782.234154779911, 11990.700232493908, 12060.155789094679, 12079.939600301943, 12422.254664720145, 8338.583070846313, 8800.0, 8811.118888111137, 8838.425502342327, 9036.774080648036, 11436.142289328167, 11473.4263286837, 11498.195126341076, 11527.365994870028, 11568.826467603161], "value": 8974.256607305306, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1295.6760809797552, 1466.3035058347284, 1531.479297039007, 1655.2799532203492, 1821.380730551613, 8108.756737297883, 8424.031236407815, 8437.409381343308, 8438.240558349748, 8444.155584441552, 7945.284924356807, 8103.95948020259, 8111.188881111901, 8111.756647300575, 8116.553589552572, 1937.225109956022, 2235.4970131720315, 2266.467380165664, 2290.6449500327476, 2300.7469178390365, 2307.1694190091553, 2315.722113346401, 2320.2807129789735, 2321.0483701682315, 2322.1872344679314, 2213.3249358945513, 2219.844610877239, 2258.559580881729, 2260.0394832196334, 2260.42359198405, 1917.6739954207749, 1971.0932970833362, 2165.945851353713, 2246.73039235292, 2280.395695140789, 2259.581977334182, 2282.6233671444193, 2285.108807565051, 2285.714285714286, 2288.302067869299, 8065.354771618257, 8098.676052957874, 8117.9594102029705, 8136.877946830802, 8151.470154439942, 4818.156822556074, 4937.333459982929, 4943.826966056206, 4965.77654005567, 4973.776180071905, 3034.256607131245, 3124.390743804959, 3240.1575590346442, 3249.0902547286796, 3290.440625093716, 1145.9713507162305, 1151.1078913841757, 1159.0, 1175.8765329640435, 1176.476467971753, 11367.317960922372, 11647.184697071209, 11670.474828632732, 11691.590794322157, 11705.239159454693, 4305.720128191658, 4496.572825581565, 4514.232580461329, 4586.610138138229, 4605.746683932416, 9912.752181195383, 9938.403695778277, 9949.452780097019, 9950.601975921027, 9952.10431061208, 4967.925481117786, 5026.673266237683, 5038.445770965191, 5039.974800125976, 5040.7479626019285, 3947.585503522146, 4448.421705178306, 4535.795889184995, 4542.182407166676, 4560.224761790503, 3810.8285127169343, 3822.7515211511163, 3907.941380879289, 3930.862419815293, 3987.282289187916, 1210.5218438716659, 1231.205872212436, 1233.2785320587377, 1247.5758242197696, 1249.0819247852821, 960.7934294126796, 968.8906202398215, 972.5040229483014, 977.5552123783662, 990.1286867556504, 5627.634203776742, 5644.689542075143, 5650.491455769001, 5784.1034639630925, 6070.210872586624, 1008.445355054717, 1028.228828378716, 1038.402918321968, 1091.4433638844089, 1098.1983152298867, 4057.8173982170874, 4073.368627862686, 4078.4494093297617, 4084.611961863618, 4087.6321131098343, 9422.246220302359, 9760.804783904283, 9809.411435313761, 9814.116729494379, 9834.360766550151, 9627.9037209627, 9640.566174522164, 9698.612055517842, 9706.805863882682, 9875.950620246853, 7376.336129748241, 7468.0, 7544.0, 7735.303822655988, 7741.109772376136, 5673.319201695823, 5728.742206600797, 5912.994790885474, 5923.763049478145, 5969.850753731192, 9112.726618201465, 9439.480828554495, 9728.319017668695, 9818.165455936325, 9863.063009014133, 9764.218862491125, 9926.15627671627, 9993.850092248476, 10022.699319020441, 10137.493125343555, 7095.0421693070775, 7129.857402852018, 7344.779656610311, 7360.852782944418, 7364.484486085923, 7827.726029588937, 7833.138354781084, 7864.72473463426, 7869.449138560246, 7895.447318687637, 7042.683079261343, 7066.787996360117, 7158.463115266271, 7457.440691948017, 7482.438817088631, 6944.791656250321, 7060.682269297997, 7094.0, 7170.103737032871, 7340.009098771598, 6581.3418658133805, 6605.207375115017, 6643.70103345341, 6659.567128136656, 6667.666616669244, 4783.282507623884, 4783.330333753347, 4817.807287708592, 4937.481564435682, 4989.775460104232, 4747.145513807548, 4803.207470767285, 4823.397075365579, 4918.0901533216465, 4932.580730637936], "value": 4445.129138498667, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.65375740442914, 326.4760060103534, 332.20271348762964, 332.7138660751753, 336.33909368091696, 5200.9598080383885, 5250.65870718403, 5349.277847490593, 5371.677699338043, 5399.541039011679, 5228.712420816853, 5302.409277216829, 5315.661109111988, 5333.759980800864, 5338.813141540047, 4151.771652559108, 4154.189932963073, 4167.124793842768, 4189.37159426087, 4199.1391764688315, 3897.9610203897882, 4138.3999320098565, 4165.0, 4187.33002719565, 4191.958080419187, 4066.471358723362, 4070.308047631895, 4074.816633251496, 4077.2864748669012, 4091.754494730311, 4075.510938687347, 4085.2238074765846, 4090.8568200112854, 4100.63094321511, 4106.815193316278, 3604.9098772530633, 3605.405108157151, 3613.5663720353464, 3616.0959760059986, 3636.2545678136185, 5039.3196918415915, 5104.948950510485, 5127.051495473312, 5129.820456284049, 5145.922811157836, 4588.564086411786, 4608.400907881987, 4615.561521655437, 4664.65015123867, 4667.533246675339, 5440.156775699773, 5447.836564903059, 5491.807786727485, 5495.725213739297, 5500.50495455407, 3817.522809648794, 3908.1402091539817, 3921.509811273591, 3939.113699417637, 3959.6339262954234, 5455.645383050129, 5650.1242307442, 5745.482906538432, 5780.132980052984, 5807.912881306784, 3867.477890484805, 3949.7235193536753, 3956.3472027115204, 3976.562578116405, 4012.297847876668, 3836.731428799957, 3929.7445666031617, 4013.7792421417103, 4039.3537034074407, 4072.7418065547445, 4623.53764623535, 4634.146341463442, 4666.789994450258, 4667.486576476585, 4677.7193368398, 5552.083906155439, 5554.1391084381985, 5564.304461942257, 5571.582131340166, 5575.860603484864, 1422.2746399336413, 1459.9854001460062, 1468.7136008478458, 1469.1772607339924, 1475.7122361139475, 926.536731634183, 937.3953799799092, 945.3807755919884, 947.2327414794039, 948.0519480519481, 5613.747381367848, 5658.575606829504, 5679.204911312419, 5695.231143795618, 5703.429657034263, 6051.757929682852, 6060.878782424327, 6072.36240194782, 6073.635581865102, 6093.421124993119, 5121.513456221653, 5418.1330987042675, 5423.132298832168, 5684.943150568524, 5693.146028095819, 3233.143217047484, 3249.333886553251, 3254.414205442996, 3268.9019329420157, 3274.590676165479, 6272.3100458949475, 6340.587861788969, 6343.9365606343345, 6347.809565713036, 6352.871787951088, 6193.473554747897, 6222.097795819581, 6227.412009937437, 6252.811965726497, 6319.388555918304, 6288.0, 6324.525660575475, 6343.223897308761, 6367.439977205614, 6383.553151279459, 5432.402435732145, 6013.6692481913915, 6118.908216376847, 6126.111713801563, 6132.8773424532155, 5494.423085575957, 5674.878816650743, 5676.801311954062, 5707.4577915098, 5708.65748055118, 5875.6474611523445, 5883.382244864228, 5889.911651325319, 5911.881762364643, 5950.137230101524, 3873.5158105236846, 3906.6093390661845, 3912.6087391260644, 3992.1416895367634, 4025.8389664414267, 5691.14632805066, 5710.600257981901, 5730.971345143247, 5742.478243265455, 5747.448188989033, 5544.805931792529, 5569.470900264469, 5574.9721251393485, 5604.161149612529, 5611.576938067857, 5428.83713488596, 5606.327240731139, 5608.971955140199, 5611.551075913835, 5621.4659607337235, 5431.538319242909, 5460.389185190299, 5490.396056433869, 5492.670439773467, 5498.202760599611, 5465.180222966428, 5489.670619762827, 5590.524805391425, 5629.549636029026, 5632.5212356950115, 5394.136938089887, 5423.5932305076485, 5441.102218134122, 5457.69982650958, 5478.534324582296], "value": 4282.56991006132, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.5272967112035, 737.9557226566407, 761.3490465651865, 774.860525105481, 815.3436483630675, 14005.509807156752, 14095.78856317156, 14329.35517901693, 15318.540443786676, 15829.60425989348, 14927.850721492781, 14948.0, 15037.699246015072, 15045.172515511642, 15058.39766409345, 653.382553486955, 777.3353782515952, 805.6535689653447, 811.3833486550205, 811.7037281392309, 811.8376324735048, 816.4040250617053, 816.8366326734676, 817.239966830847, 817.7219745286601, 837.1042984007115, 843.3632607381419, 843.7595285343679, 845.0619812008665, 845.6067928413287, 674.5547938360659, 822.7531740477892, 836.8493671139192, 837.0290463062848, 850.4812064640564, 618.712298781069, 619.3218425823716, 621.018790311307, 621.1056079245872, 621.3599992008194, 14057.367418466194, 14152.504662336873, 14168.645783855383, 14218.146911185362, 14237.216953067576, 13261.27063011534, 13732.862671373257, 13740.175589464565, 13750.518731844437, 13834.861651383459, 11269.774604507946, 11366.545338186463, 11421.143414243881, 11457.427128643618, 11470.139739519485, 3794.4687743715904, 3809.1810260794064, 3860.2665493556133, 3905.7265991380614, 3908.1988192420486, 55162.448375516135, 55265.0, 55670.164947525416, 55760.721196394166, 55893.72053139749, 10523.736906577244, 10781.137508999262, 10911.781764364669, 11083.002529772359, 11180.776384472265, 18787.436376908714, 19336.613267734567, 19419.61160776805, 19465.0, 19495.512612184524, 8271.179004467216, 8350.123237060143, 8429.452085614415, 8496.872546911802, 8593.269572086318, 4681.180793361148, 4689.62483001359, 4783.306420568998, 4891.29076283944, 4904.926426103611, 3334.583177102862, 3400.897973060812, 3407.897763067112, 3415.043787739437, 3420.794752314869, 570.6633086478997, 606.1604677521664, 607.4563265877015, 623.0685125736961, 625.0780099353417, 640.0431355124026, 672.603164133154, 788.2293737512648, 788.286600626434, 795.6697970342359, 9677.274204434696, 9710.805783884283, 9725.708228753148, 9730.854037189449, 9735.41587504752, 742.3319012888336, 769.8922150898878, 775.53467919248, 784.0395515493589, 788.4047544104164, 4718.834840780625, 4780.0, 4789.4971028042255, 4798.568128868418, 4816.373871396766, 62370.376296237366, 63428.048579271344, 63944.36055639477, 64104.0, 64691.0, 55194.72402637961, 56253.71873140608, 57099.0, 57222.42777572171, 57753.13370299449, 45400.09199815985, 48944.26583601249, 49355.50644493581, 49980.0, 50586.22948196795, 9456.33805633599, 9544.57049432791, 9777.315587909063, 9831.655892043744, 9963.302568820403, 33894.83052584721, 34152.316953661284, 34439.65560344364, 34553.82723086369, 35432.82283588566, 41058.79470602628, 41389.0, 41555.58444415638, 43183.568164317956, 46048.309275361564, 11042.558297668003, 11431.271135866387, 11651.941740291244, 11657.300561966309, 11973.401329933295, 12818.55135070268, 13995.300234988006, 14152.504662336769, 14181.29093545298, 14254.429822806971, 13037.217766934014, 13371.331433428095, 13664.111832730841, 13675.726485470035, 14102.083364581269, 12493.625191244277, 13184.274864882524, 13649.249291288677, 13781.931090344484, 13900.582982510541, 13053.804192937303, 13103.541376051793, 13698.589042328746, 13719.1082579632, 13877.861221387657, 10537.578496860346, 10708.571657133627, 10843.783124337628, 11119.0, 11525.135614829089, 11125.833112503156, 11209.943950280196, 11387.202895797214, 11536.769264614828, 11572.42137893085], "value": 6848.779885942199, "unit": "score"}], "name": "dromaeo_css", "value": 7019.64457947312, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 107.0, 110.0, 114.0, 112.0, 101.0, 112.0, 113.0, 111.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 127.0, 155.0, 180.0, 128.0, 157.0, 165.0, 129.0, 182.0, 131.0], "value": 152.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 162.0, 162.0, 161.0, 161.0, 160.0, 162.0, 161.0, 177.0], "value": 162.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 102.0, 115.0, 77.0, 72.0, 73.0, 118.0, 104.0, 75.0], "value": 88.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 148.0, 92.0, 93.0, 93.0, 151.0, 92.0, 92.0, 147.0], "value": 109.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 116.0, 116.0, 116.0, 117.0, 116.0, 116.0], "value": 116.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 58.0, 57.0, 58.0, 65.0, 58.0, 77.0, 57.0, 56.0], "value": 60.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 59.0, 60.0, 61.0, 61.0, 61.0, 62.0, 61.0, 62.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 76.0, 76.0, 76.0, 85.0, 77.0, 86.0, 79.0, 77.0], "value": 78.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 121.0, 127.0, 123.0, 122.0, 122.0, 122.0, 131.0, 155.0, 131.0], "value": 127.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 165.0, 178.0, 162.0, 163.0, 165.0, 165.0, 167.0, 167.0, 165.0], "value": 166.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 68.0, 70.0, 69.0, 73.0, 69.0, 68.0, 69.0, 68.0, 68.0], "value": 69.4, "unit": "score"}], "name": "kraken", "value": 1544.0, "alertThreshold": 2.0}]} 07:18:20 INFO - Return code: 0 07:18:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:18:20 ERROR - # TBPL SUCCESS # 07:18:20 INFO - Running post-action listener: _resource_record_post_action 07:18:20 INFO - Running post-run listener: _resource_record_post_run 07:18:21 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 533794816; Read time: 0; Write time: 494532 07:18:21 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244596736; Read time: 0; Write time: 263300 07:18:21 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 289198080; Read time: 0; Write time: 231232 07:18:21 INFO - Running post-run listener: _upload_blobber_files 07:18:21 INFO - Blob upload gear active. 07:18:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:18:21 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:18:21 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'] 07:18:21 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 07:18:21 INFO - (blobuploader) - INFO - Open directory for files ... 07:18:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:18:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:18:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:18:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:18:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:18:22 INFO - (blobuploader) - INFO - Done attempting. 07:18:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:18:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:18:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:18:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:18:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:18:23 INFO - (blobuploader) - INFO - Done attempting. 07:18:23 INFO - (blobuploader) - INFO - Iteration through files over. 07:18:23 INFO - Return code: 0 07:18:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:18:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:18:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/42cf2cc5a273024fd08f10548bb24ba14ab9fffa2d88c6c08a750640feb3c26331c4924db78a2c331fb84496a5e385b393f5034b44f19699f6c279a56f4a8574", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d39a52f25acdb002446d49333115779d131fa46607a66c98d24626b9f78dc4ea6ba4ecd41c7178f35f296717f1dd63d69c574f1c996f4d33de94c0f7068219f9"} 07:18:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:18:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:18:23 INFO - Contents: 07:18:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/42cf2cc5a273024fd08f10548bb24ba14ab9fffa2d88c6c08a750640feb3c26331c4924db78a2c331fb84496a5e385b393f5034b44f19699f6c279a56f4a8574", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d39a52f25acdb002446d49333115779d131fa46607a66c98d24626b9f78dc4ea6ba4ecd41c7178f35f296717f1dd63d69c574f1c996f4d33de94c0f7068219f9"} 07:18:23 INFO - Running post-run listener: copy_logs_to_upload_dir 07:18:23 INFO - Copying logs to upload dir... 07:18:23 INFO - mkdir: /builds/slave/test/build/upload/logs 07:18:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.813180 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-04-27 07:18:22.612107) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 07:18:22.616171) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1461756990.560480-593053154 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/42cf2cc5a273024fd08f10548bb24ba14ab9fffa2d88c6c08a750640feb3c26331c4924db78a2c331fb84496a5e385b393f5034b44f19699f6c279a56f4a8574", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d39a52f25acdb002446d49333115779d131fa46607a66c98d24626b9f78dc4ea6ba4ecd41c7178f35f296717f1dd63d69c574f1c996f4d33de94c0f7068219f9"} build_url:https://queue.taskcluster.net/v1/task/LQOl2fRST_mWU8CEcbfq9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011276 build_url: 'https://queue.taskcluster.net/v1/task/LQOl2fRST_mWU8CEcbfq9Q/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/42cf2cc5a273024fd08f10548bb24ba14ab9fffa2d88c6c08a750640feb3c26331c4924db78a2c331fb84496a5e385b393f5034b44f19699f6c279a56f4a8574", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d39a52f25acdb002446d49333115779d131fa46607a66c98d24626b9f78dc4ea6ba4ecd41c7178f35f296717f1dd63d69c574f1c996f4d33de94c0f7068219f9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 07:18:22.641423) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 07:18:22.641772) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1461756990.560480-593053154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004359 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 07:18:22.724731) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 07:18:22.725044) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 07:18:22.725368) ========= ========= Total master_lag: 0.18 =========