builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-003 starttime: 1461225974.13 results: success (0) buildid: 20160420223218 builduid: 8c22164edd3044b391623e2d02b71cea revision: 72023950385695172b8c84e3d804adccfe14f843 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 01:06:14.132143) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 01:06:14.132915) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 01:06:14.133229) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 01:06:14.153210) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 01:06:14.153592) ========= 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=7de08804244eb36560b44971000001c3-1461224819.546117-234883395 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-21 01:06:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 113M=0s 2016-04-21 01:06:14 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.081947 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 01:06:14.249421) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 01:06:14.249772) ========= 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=7de08804244eb36560b44971000001c3-1461224819.546117-234883395 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022510 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 01:06:14.299757) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 01:06:14.300136) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 72023950385695172b8c84e3d804adccfe14f843 --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 72023950385695172b8c84e3d804adccfe14f843 --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=7de08804244eb36560b44971000001c3-1461224819.546117-234883395 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-21 01:06:14,749 truncating revision to first 12 chars 2016-04-21 01:06:14,749 Setting DEBUG logging. 2016-04-21 01:06:14,749 attempt 1/10 2016-04-21 01:06:14,749 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/720239503856?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-21 01:06:15,099 unpacking tar archive at: mozilla-inbound-720239503856/testing/mozharness/ program finished with exit code 0 elapsedTime=0.609718 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 01:06:14.923828) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 01:06:14.924184) ========= script_repo_revision: 72023950385695172b8c84e3d804adccfe14f843 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 01:06:14.924875) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 01:06:14.925167) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 01:06:14.935340) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-04-21 01:06:14.935731) ========= /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=7de08804244eb36560b44971000001c3-1461224819.546117-234883395 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:06:15 INFO - MultiFileLogger online at 20160421 01:06:15 in /builds/slave/test 01:06:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 01:06:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:06:15 INFO - {'append_to_log': False, 01:06:15 INFO - 'base_work_dir': '/builds/slave/test', 01:06:15 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 01:06:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:06:15 INFO - 'branch': 'Mozilla-Inbound', 01:06:15 INFO - 'buildbot_json_path': 'buildprops.json', 01:06:15 INFO - 'config_files': ('talos/linux_config.py',), 01:06:15 INFO - 'default_actions': ('clobber', 01:06:15 INFO - 'read-buildbot-config', 01:06:15 INFO - 'download-and-extract', 01:06:15 INFO - 'populate-webroot', 01:06:15 INFO - 'create-virtualenv', 01:06:15 INFO - 'install', 01:06:15 INFO - 'run-tests'), 01:06:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:06:15 INFO - 'download_minidump_stackwalk': True, 01:06:15 INFO - 'download_symbols': 'ondemand', 01:06:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:06:15 INFO - 'tooltool.py': '/tools/tooltool.py', 01:06:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:06:15 INFO - '/tools/misc-python/virtualenv.py')}, 01:06:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:06:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:06:15 INFO - 'installer_path': 'installer.exe', 01:06:15 INFO - 'log_level': 'info', 01:06:15 INFO - 'log_name': 'talos', 01:06:15 INFO - 'log_to_console': True, 01:06:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:06:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:06:15 INFO - 'opt_config_files': (), 01:06:15 INFO - 'pip_index': False, 01:06:15 INFO - 'sps_profile': False, 01:06:15 INFO - 'sps_profile_interval': 0, 01:06:15 INFO - 'suite': 'dromaeojs', 01:06:15 INFO - 'system_bits': '32', 01:06:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:06:15 INFO - 'title': 'talos-linux64-ix-003', 01:06:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:06:15 INFO - 'use_talos_json': True, 01:06:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:06:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:06:15 INFO - 'work_dir': 'build'} 01:06:15 INFO - ##### 01:06:15 INFO - ##### Running clobber step. 01:06:15 INFO - ##### 01:06:15 INFO - Running pre-action listener: _resource_record_pre_action 01:06:15 INFO - Running main action method: clobber 01:06:15 INFO - rmtree: /builds/slave/test/build 01:06:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:06:16 INFO - Running post-action listener: _resource_record_post_action 01:06:16 INFO - ##### 01:06:16 INFO - ##### Running read-buildbot-config step. 01:06:16 INFO - ##### 01:06:16 INFO - Running pre-action listener: _resource_record_pre_action 01:06:16 INFO - Running main action method: read_buildbot_config 01:06:16 INFO - Using buildbot properties: 01:06:16 INFO - { 01:06:16 INFO - "project": "", 01:06:16 INFO - "product": "firefox", 01:06:16 INFO - "script_repo_revision": "production", 01:06:16 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 01:06:16 INFO - "repository": "", 01:06:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 01:06:16 INFO - "buildid": "20160420223218", 01:06:16 INFO - "pgo_build": "True", 01:06:16 INFO - "basedir": "/builds/slave/test", 01:06:16 INFO - "buildnumber": 1736, 01:06:16 INFO - "slavename": "talos-linux64-ix-003", 01:06:16 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:06:16 INFO - "platform": "ubuntu64_hw", 01:06:16 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 01:06:16 INFO - "branch": "mozilla-inbound", 01:06:16 INFO - "repo_path": "integration/mozilla-inbound", 01:06:16 INFO - "revision": "72023950385695172b8c84e3d804adccfe14f843", 01:06:16 INFO - "stage_platform": "linux64-pgo", 01:06:16 INFO - "builduid": "8c22164edd3044b391623e2d02b71cea", 01:06:16 INFO - "slavebuilddir": "test" 01:06:16 INFO - } 01:06:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/Xl-FcnEoRkOjEzQooYP8Tw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 01:06:16 INFO - Running post-action listener: _resource_record_post_action 01:06:16 INFO - ##### 01:06:16 INFO - ##### Running download-and-extract step. 01:06:16 INFO - ##### 01:06:16 INFO - Running pre-action listener: _resource_record_pre_action 01:06:16 INFO - Running main action method: download_and_extract 01:06:16 INFO - mkdir: /builds/slave/test/build/tests 01:06:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:16 INFO - https://queue.taskcluster.net/v1/task/Xl-FcnEoRkOjEzQooYP8Tw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:06:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl-FcnEoRkOjEzQooYP8Tw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 01:06:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl-FcnEoRkOjEzQooYP8Tw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 01:06:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl-FcnEoRkOjEzQooYP8Tw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 01:06:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl-FcnEoRkOjEzQooYP8Tw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:06:20 INFO - Downloaded 1361 bytes. 01:06:20 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 01:06:20 INFO - Using the following test package requirements: 01:06:20 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 01:06:20 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:06:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:06:20 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:06:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:06:20 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:06:20 INFO - u'jsshell-linux-x86_64.zip'], 01:06:20 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:06:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:06:20 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 01:06:20 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:06:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:06:20 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:06:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:06:20 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:06:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:06:20 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:06:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:06:20 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:06:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:20 INFO - https://queue.taskcluster.net/v1/task/Xl-FcnEoRkOjEzQooYP8Tw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:06:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl-FcnEoRkOjEzQooYP8Tw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:06:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl-FcnEoRkOjEzQooYP8Tw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:06:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl-FcnEoRkOjEzQooYP8Tw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:06:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl-FcnEoRkOjEzQooYP8Tw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:06:29 INFO - Downloaded 23853060 bytes. 01:06:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:06:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:06:30 INFO - Return code: 0 01:06:30 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:06:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:30 INFO - https://queue.taskcluster.net/v1/task/Xl-FcnEoRkOjEzQooYP8Tw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:06:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl-FcnEoRkOjEzQooYP8Tw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:06:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl-FcnEoRkOjEzQooYP8Tw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:06:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl-FcnEoRkOjEzQooYP8Tw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:06:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl-FcnEoRkOjEzQooYP8Tw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:06:32 INFO - Downloaded 23853060 bytes. 01:06:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:06:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:06:33 INFO - Return code: 0 01:06:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:33 INFO - https://queue.taskcluster.net/v1/task/Xl-FcnEoRkOjEzQooYP8Tw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:06:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl-FcnEoRkOjEzQooYP8Tw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 01:06:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl-FcnEoRkOjEzQooYP8Tw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 01:06:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl-FcnEoRkOjEzQooYP8Tw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 01:06:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl-FcnEoRkOjEzQooYP8Tw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:06:35 INFO - Downloaded 10845952 bytes. 01:06:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:06:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 01:06:35 INFO - Return code: 0 01:06:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:35 INFO - https://queue.taskcluster.net/v1/task/Xl-FcnEoRkOjEzQooYP8Tw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:06:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl-FcnEoRkOjEzQooYP8Tw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 01:06:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl-FcnEoRkOjEzQooYP8Tw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 01:06:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl-FcnEoRkOjEzQooYP8Tw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 01:06:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl-FcnEoRkOjEzQooYP8Tw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:06:36 INFO - Downloaded 58337446 bytes. 01:06:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Xl-FcnEoRkOjEzQooYP8Tw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 01:06:36 INFO - mkdir: /builds/slave/test/properties 01:06:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:06:36 INFO - Writing to file /builds/slave/test/properties/build_url 01:06:36 INFO - Contents: 01:06:36 INFO - build_url:https://queue.taskcluster.net/v1/task/Xl-FcnEoRkOjEzQooYP8Tw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 01:06:37 INFO - Running post-action listener: _resource_record_post_action 01:06:37 INFO - Running post-action listener: set_extra_try_arguments 01:06:37 INFO - ##### 01:06:37 INFO - ##### Running populate-webroot step. 01:06:37 INFO - ##### 01:06:37 INFO - Running pre-action listener: _resource_record_pre_action 01:06:37 INFO - Running main action method: populate_webroot 01:06:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:06:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:06:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:06:37 INFO - '--tppagecycles', 01:06:37 INFO - '7'], 01:06:37 INFO - 'tests': ['tsvgm']}}, 01:06:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:06:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:06:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:06:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:06:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:06:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:06:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:06:37 INFO - 'talos_options': ['--disable-e10s'], 01:06:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:06:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:06:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:06:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:06:37 INFO - 'talos_options': ['--disable-e10s'], 01:06:37 INFO - 'tests': ['damp', 'tps']}, 01:06:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:06:37 INFO - 'tests': ['damp', 'tps']}, 01:06:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:06:37 INFO - 'tests': ['dromaeo_dom']}, 01:06:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:06:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:06:37 INFO - 'tests': ['a11yr', 01:06:37 INFO - 'ts_paint', 01:06:37 INFO - 'tpaint', 01:06:37 INFO - 'sessionrestore', 01:06:37 INFO - 'sessionrestore_no_auto_restore', 01:06:37 INFO - 'tabpaint']}, 01:06:37 INFO - 'other-e10s': {'tests': ['a11yr', 01:06:37 INFO - 'ts_paint', 01:06:37 INFO - 'tpaint', 01:06:37 INFO - 'sessionrestore', 01:06:37 INFO - 'sessionrestore_no_auto_restore', 01:06:37 INFO - 'tabpaint']}, 01:06:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:06:37 INFO - 'ts_paint', 01:06:37 INFO - 'tpaint', 01:06:37 INFO - 'sessionrestore', 01:06:37 INFO - 'sessionrestore_no_auto_restore', 01:06:37 INFO - 'tabpaint']}, 01:06:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:06:37 INFO - 'ts_paint', 01:06:37 INFO - 'tpaint', 01:06:37 INFO - 'sessionrestore', 01:06:37 INFO - 'sessionrestore_no_auto_restore', 01:06:37 INFO - 'tabpaint']}, 01:06:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:06:37 INFO - 'tests': ['a11yr', 01:06:37 INFO - 'ts_paint', 01:06:37 INFO - 'tpaint', 01:06:37 INFO - 'sessionrestore', 01:06:37 INFO - 'sessionrestore_no_auto_restore', 01:06:37 INFO - 'tabpaint']}, 01:06:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:06:37 INFO - 'tests': ['a11yr', 01:06:37 INFO - 'ts_paint', 01:06:37 INFO - 'tpaint', 01:06:37 INFO - 'sessionrestore', 01:06:37 INFO - 'sessionrestore_no_auto_restore', 01:06:37 INFO - 'tabpaint']}, 01:06:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:06:37 INFO - 'tests': ['tsvgx', 01:06:37 INFO - 'tsvgr_opacity', 01:06:37 INFO - 'tart', 01:06:37 INFO - 'tscrollx', 01:06:37 INFO - 'cart']}, 01:06:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:06:37 INFO - 'tsvgr_opacity', 01:06:37 INFO - 'tart', 01:06:37 INFO - 'tscrollx', 01:06:37 INFO - 'cart']}, 01:06:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:06:37 INFO - 'talos_options': ['--disable-e10s'], 01:06:37 INFO - 'tests': ['tp5o']}, 01:06:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:06:37 INFO - 'tests': ['tp5o']}, 01:06:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:06:37 INFO - 'talos_options': ['--disable-e10s', 01:06:37 INFO - '--xperf_path', 01:06:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:06:37 INFO - 'tests': ['tp5n']}, 01:06:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:06:37 INFO - 'talos_options': ['--xperf_path', 01:06:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:06:37 INFO - 'tests': ['tp5n']}}, 01:06:37 INFO - 'talos.zip': {'path': '', 01:06:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:06:37 INFO - Running post-action listener: _resource_record_post_action 01:06:37 INFO - ##### 01:06:37 INFO - ##### Running create-virtualenv step. 01:06:37 INFO - ##### 01:06:37 INFO - Running pre-action listener: _resource_record_pre_action 01:06:37 INFO - Running main action method: create_virtualenv 01:06:37 INFO - Creating virtualenv /builds/slave/test/build/venv 01:06:37 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 01:06:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:06:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:06:37 INFO - Using real prefix '/usr' 01:06:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:06:38 INFO - Installing distribute.............................................................................................................................................................................................done. 01:06:40 INFO - Installing pip.................done. 01:06:40 INFO - Return code: 0 01:06:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:06:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:06:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:06:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:40 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 0x7fd7e6779f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28575a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e6410>, '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 0x28e7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e77a0>, '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': '7de08804244eb36560b44971000001c3-1461224819.546117-234883395', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:06:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:06:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:06:40 INFO - Using env: {'DISPLAY': ':0', 01:06:40 INFO - 'HOME': '/home/cltbld', 01:06:40 INFO - 'LANG': 'en_US.UTF-8', 01:06:40 INFO - 'LANGUAGE': 'en_US:en', 01:06:40 INFO - 'LOGNAME': 'cltbld', 01:06:40 INFO - 'MAIL': '/var/mail/cltbld', 01:06:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:06:40 INFO - 'MOZ_NO_REMOTE': '1', 01:06:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:06:40 INFO - 'NO_EM_RESTART': '1', 01:06:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:06:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:06:40 INFO - 'PWD': '/builds/slave/test', 01:06:40 INFO - 'SHELL': '/bin/bash', 01:06:40 INFO - 'SHLVL': '1', 01:06:40 INFO - 'TERM': 'linux', 01:06:40 INFO - 'TMOUT': '86400', 01:06:40 INFO - 'USER': 'cltbld', 01:06:40 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461224819.546117-234883395', 01:06:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:06:40 INFO - '_': '/tools/buildbot/bin/python'} 01:06:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:06:40 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 01:06:40 INFO - Cleaning up... 01:06:40 INFO - Return code: 0 01:06:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:06:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:06:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:06:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:40 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 0x7fd7e6779f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28575a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e6410>, '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 0x28e7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e77a0>, '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': '7de08804244eb36560b44971000001c3-1461224819.546117-234883395', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:06:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 01:06:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 01:06:40 INFO - Using env: {'DISPLAY': ':0', 01:06:40 INFO - 'HOME': '/home/cltbld', 01:06:40 INFO - 'LANG': 'en_US.UTF-8', 01:06:40 INFO - 'LANGUAGE': 'en_US:en', 01:06:40 INFO - 'LOGNAME': 'cltbld', 01:06:40 INFO - 'MAIL': '/var/mail/cltbld', 01:06:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:06:40 INFO - 'MOZ_NO_REMOTE': '1', 01:06:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:06:40 INFO - 'NO_EM_RESTART': '1', 01:06:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:06:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:06:40 INFO - 'PWD': '/builds/slave/test', 01:06:40 INFO - 'SHELL': '/bin/bash', 01:06:40 INFO - 'SHLVL': '1', 01:06:40 INFO - 'TERM': 'linux', 01:06:40 INFO - 'TMOUT': '86400', 01:06:40 INFO - 'USER': 'cltbld', 01:06:40 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461224819.546117-234883395', 01:06:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:06:40 INFO - '_': '/tools/buildbot/bin/python'} 01:06:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:06:40 INFO - Downloading/unpacking psutil>=0.7.1 01:06:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:06:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:06:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:06:42 INFO - Installing collected packages: psutil 01:06:42 INFO - Running setup.py install for psutil 01:06:42 INFO - building 'psutil._psutil_linux' extension 01:06:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 01:06:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 01:06:42 INFO - building 'psutil._psutil_posix' extension 01:06:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 01:06:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 01:06:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:06:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:06:42 INFO - Successfully installed psutil 01:06:42 INFO - Cleaning up... 01:06:43 INFO - Return code: 0 01:06:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:06: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')]} 01:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:06:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06: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')]} 01:06:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:06:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:43 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 0x7fd7e6779f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28575a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e6410>, '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 0x28e7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e77a0>, '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': '7de08804244eb36560b44971000001c3-1461224819.546117-234883395', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:06:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 01:06:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 01:06:43 INFO - Using env: {'DISPLAY': ':0', 01:06:43 INFO - 'HOME': '/home/cltbld', 01:06:43 INFO - 'LANG': 'en_US.UTF-8', 01:06:43 INFO - 'LANGUAGE': 'en_US:en', 01:06:43 INFO - 'LOGNAME': 'cltbld', 01:06:43 INFO - 'MAIL': '/var/mail/cltbld', 01:06:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:06:43 INFO - 'MOZ_NO_REMOTE': '1', 01:06:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:06:43 INFO - 'NO_EM_RESTART': '1', 01:06:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:06:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:06:43 INFO - 'PWD': '/builds/slave/test', 01:06:43 INFO - 'SHELL': '/bin/bash', 01:06:43 INFO - 'SHLVL': '1', 01:06:43 INFO - 'TERM': 'linux', 01:06:43 INFO - 'TMOUT': '86400', 01:06:43 INFO - 'USER': 'cltbld', 01:06:43 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461224819.546117-234883395', 01:06:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:06:43 INFO - '_': '/tools/buildbot/bin/python'} 01:06:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:06:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:06:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:06:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:06:45 INFO - Installing collected packages: mozsystemmonitor 01:06:45 INFO - Running setup.py install for mozsystemmonitor 01:06:45 INFO - Successfully installed mozsystemmonitor 01:06:45 INFO - Cleaning up... 01:06:45 INFO - Return code: 0 01:06:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:06:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:06:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:06:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:45 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 0x7fd7e6779f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28575a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e6410>, '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 0x28e7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e77a0>, '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': '7de08804244eb36560b44971000001c3-1461224819.546117-234883395', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:06:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:06:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:06:45 INFO - Using env: {'DISPLAY': ':0', 01:06:45 INFO - 'HOME': '/home/cltbld', 01:06:45 INFO - 'LANG': 'en_US.UTF-8', 01:06:45 INFO - 'LANGUAGE': 'en_US:en', 01:06:45 INFO - 'LOGNAME': 'cltbld', 01:06:45 INFO - 'MAIL': '/var/mail/cltbld', 01:06:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:06:45 INFO - 'MOZ_NO_REMOTE': '1', 01:06:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:06:45 INFO - 'NO_EM_RESTART': '1', 01:06:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:06:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:06:45 INFO - 'PWD': '/builds/slave/test', 01:06:45 INFO - 'SHELL': '/bin/bash', 01:06:45 INFO - 'SHLVL': '1', 01:06:45 INFO - 'TERM': 'linux', 01:06:45 INFO - 'TMOUT': '86400', 01:06:45 INFO - 'USER': 'cltbld', 01:06:45 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461224819.546117-234883395', 01:06:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:06:45 INFO - '_': '/tools/buildbot/bin/python'} 01:06:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:06:45 INFO - Downloading/unpacking blobuploader==1.2.4 01:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:47 INFO - Downloading blobuploader-1.2.4.tar.gz 01:06:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:06:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:06:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:48 INFO - Downloading docopt-0.6.1.tar.gz 01:06:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:06:48 INFO - Installing collected packages: blobuploader, requests, docopt 01:06:48 INFO - Running setup.py install for blobuploader 01:06:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:06:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:06:48 INFO - Running setup.py install for requests 01:06:48 INFO - Running setup.py install for docopt 01:06:48 INFO - Successfully installed blobuploader requests docopt 01:06:48 INFO - Cleaning up... 01:06:48 INFO - Return code: 0 01:06:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:06:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:06:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:06:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:48 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 0x7fd7e6779f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28575a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e6410>, '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 0x28e7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e77a0>, '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': '7de08804244eb36560b44971000001c3-1461224819.546117-234883395', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:06:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:06:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:06:48 INFO - Using env: {'DISPLAY': ':0', 01:06:48 INFO - 'HOME': '/home/cltbld', 01:06:48 INFO - 'LANG': 'en_US.UTF-8', 01:06:48 INFO - 'LANGUAGE': 'en_US:en', 01:06:48 INFO - 'LOGNAME': 'cltbld', 01:06:48 INFO - 'MAIL': '/var/mail/cltbld', 01:06:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:06:48 INFO - 'MOZ_NO_REMOTE': '1', 01:06:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:06:48 INFO - 'NO_EM_RESTART': '1', 01:06:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:06:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:06:48 INFO - 'PWD': '/builds/slave/test', 01:06:48 INFO - 'SHELL': '/bin/bash', 01:06:48 INFO - 'SHLVL': '1', 01:06:48 INFO - 'TERM': 'linux', 01:06:48 INFO - 'TMOUT': '86400', 01:06:48 INFO - 'USER': 'cltbld', 01:06:48 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461224819.546117-234883395', 01:06:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:06:48 INFO - '_': '/tools/buildbot/bin/python'} 01:06:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:06:48 INFO - Running setup.py (path:/tmp/pip-Zb7iEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:06:48 INFO - Running setup.py (path:/tmp/pip-e5mbhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:06:49 INFO - Running setup.py (path:/tmp/pip-suMKi2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:06:49 INFO - Running setup.py (path:/tmp/pip-6Xv4L2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:06:49 INFO - Running setup.py (path:/tmp/pip-9d6odL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:06:49 INFO - Running setup.py (path:/tmp/pip-q_xFj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:06:49 INFO - Running setup.py (path:/tmp/pip-ZlaiPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:06:49 INFO - Running setup.py (path:/tmp/pip-z6PSw4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:06:49 INFO - Running setup.py (path:/tmp/pip-p04by6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:06:49 INFO - Running setup.py (path:/tmp/pip-eSpGaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:06:49 INFO - Running setup.py (path:/tmp/pip-wLJJrq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:06:49 INFO - Running setup.py (path:/tmp/pip-kcIdwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:06:49 INFO - Running setup.py (path:/tmp/pip-Y3ucPh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:06:49 INFO - Running setup.py (path:/tmp/pip-6qfrYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:06:49 INFO - Running setup.py (path:/tmp/pip-Ma70rL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:06:49 INFO - Running setup.py (path:/tmp/pip-TgzZhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:06:50 INFO - Running setup.py (path:/tmp/pip-H6HpyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:06:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:06:50 INFO - Running setup.py install for manifestparser 01:06:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:06:50 INFO - Running setup.py install for mozcrash 01:06:50 INFO - Running setup.py install for mozdebug 01:06:50 INFO - Running setup.py install for mozdevice 01:06:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:06:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:06:50 INFO - Running setup.py install for mozfile 01:06:50 INFO - Running setup.py install for mozhttpd 01:06:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:06:50 INFO - Running setup.py install for mozinfo 01:06:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:06:50 INFO - Running setup.py install for mozInstall 01:06:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:06:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:06:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:06:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:06:50 INFO - Running setup.py install for mozleak 01:06:51 INFO - Running setup.py install for mozlog 01:06:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:06:51 INFO - Running setup.py install for moznetwork 01:06:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:06:51 INFO - Running setup.py install for mozprocess 01:06:51 INFO - Running setup.py install for mozprofile 01:06:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:06:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:06:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:06:51 INFO - Running setup.py install for mozrunner 01:06:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:06:51 INFO - Running setup.py install for mozscreenshot 01:06:51 INFO - Running setup.py install for moztest 01:06:51 INFO - Running setup.py install for mozversion 01:06:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:06:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:06:51 INFO - Cleaning up... 01:06:51 INFO - Return code: 0 01:06:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:06:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:06:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:51 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 0x7fd7e6779f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28575a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e6410>, '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 0x28e7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e77a0>, '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': '7de08804244eb36560b44971000001c3-1461224819.546117-234883395', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:06:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:06:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:06:51 INFO - Using env: {'DISPLAY': ':0', 01:06:51 INFO - 'HOME': '/home/cltbld', 01:06:51 INFO - 'LANG': 'en_US.UTF-8', 01:06:51 INFO - 'LANGUAGE': 'en_US:en', 01:06:51 INFO - 'LOGNAME': 'cltbld', 01:06:51 INFO - 'MAIL': '/var/mail/cltbld', 01:06:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:06:51 INFO - 'MOZ_NO_REMOTE': '1', 01:06:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:06:51 INFO - 'NO_EM_RESTART': '1', 01:06:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:06:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:06:51 INFO - 'PWD': '/builds/slave/test', 01:06:51 INFO - 'SHELL': '/bin/bash', 01:06:51 INFO - 'SHLVL': '1', 01:06:51 INFO - 'TERM': 'linux', 01:06:51 INFO - 'TMOUT': '86400', 01:06:51 INFO - 'USER': 'cltbld', 01:06:51 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461224819.546117-234883395', 01:06:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:06:51 INFO - '_': '/tools/buildbot/bin/python'} 01:06:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:06:52 INFO - Running setup.py (path:/tmp/pip-ZdPVwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:06:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 01:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:06:52 INFO - Running setup.py (path:/tmp/pip-OopaP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:06:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:06:52 INFO - Running setup.py (path:/tmp/pip-5Mi566-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:06:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:06:52 INFO - Running setup.py (path:/tmp/pip-wTx4r3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:06:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:06:52 INFO - Running setup.py (path:/tmp/pip-MyL5Qz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:06:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 01:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:06:52 INFO - Running setup.py (path:/tmp/pip-G6az19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:06:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 01:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:06:52 INFO - Running setup.py (path:/tmp/pip-ZDL7eO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:06:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 01:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:06:52 INFO - Running setup.py (path:/tmp/pip-ovE0DW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:06:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 01:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:06:52 INFO - Running setup.py (path:/tmp/pip-tNTzBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:06:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 01:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:06:52 INFO - Running setup.py (path:/tmp/pip-osmvcX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:06:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:06:52 INFO - Running setup.py (path:/tmp/pip-hvgjZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:06:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 01:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:06:52 INFO - Running setup.py (path:/tmp/pip-Kn2RUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:06:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:06:52 INFO - Running setup.py (path:/tmp/pip-a8fTIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:06:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 01:06:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:06:53 INFO - Running setup.py (path:/tmp/pip-0XV9vk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:06:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:06:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:06:53 INFO - Running setup.py (path:/tmp/pip-4adU17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:06:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 01:06:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:06:53 INFO - Running setup.py (path:/tmp/pip-baiPzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:06:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 01:06:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:06:53 INFO - Running setup.py (path:/tmp/pip-CJpFct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:06:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 01:06:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:06:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:06:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:06:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:06:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:06:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:55 INFO - Downloading blessings-1.6.tar.gz 01:06:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:06:55 INFO - Installing collected packages: blessings 01:06:55 INFO - Running setup.py install for blessings 01:06:55 INFO - Successfully installed blessings 01:06:55 INFO - Cleaning up... 01:06:55 INFO - Return code: 0 01:06:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:06:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:06:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:06:55 INFO - Reading from file tmpfile_stdout 01:06:55 INFO - Current package versions: 01:06:55 INFO - argparse == 1.2.1 01:06:55 INFO - blessings == 1.6 01:06:55 INFO - blobuploader == 1.2.4 01:06:55 INFO - docopt == 0.6.1 01:06:55 INFO - manifestparser == 1.1 01:06:55 INFO - mozInstall == 1.12 01:06:55 INFO - mozcrash == 0.17 01:06:55 INFO - mozdebug == 0.1 01:06:55 INFO - mozdevice == 0.48 01:06:55 INFO - mozfile == 1.2 01:06:55 INFO - mozhttpd == 0.7 01:06:55 INFO - mozinfo == 0.9 01:06:55 INFO - mozleak == 0.1 01:06:55 INFO - mozlog == 3.1 01:06:55 INFO - moznetwork == 0.27 01:06:55 INFO - mozprocess == 0.22 01:06:55 INFO - mozprofile == 0.28 01:06:55 INFO - mozrunner == 6.11 01:06:55 INFO - mozscreenshot == 0.1 01:06:55 INFO - mozsystemmonitor == 0.0 01:06:55 INFO - moztest == 0.7 01:06:55 INFO - mozversion == 1.4 01:06:55 INFO - psutil == 3.1.1 01:06:55 INFO - requests == 1.2.3 01:06:55 INFO - wsgiref == 0.1.2 01:06:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:06:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:06:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:55 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 0x7fd7e6779f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28575a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e6410>, '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 0x28e7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e77a0>, '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': '7de08804244eb36560b44971000001c3-1461224819.546117-234883395', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:06:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 01:06:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:06:55 INFO - Using env: {'DISPLAY': ':0', 01:06:55 INFO - 'HOME': '/home/cltbld', 01:06:55 INFO - 'LANG': 'en_US.UTF-8', 01:06:55 INFO - 'LANGUAGE': 'en_US:en', 01:06:55 INFO - 'LOGNAME': 'cltbld', 01:06:55 INFO - 'MAIL': '/var/mail/cltbld', 01:06:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:06:55 INFO - 'MOZ_NO_REMOTE': '1', 01:06:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:06:55 INFO - 'NO_EM_RESTART': '1', 01:06:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:06:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:06:55 INFO - 'PWD': '/builds/slave/test', 01:06:55 INFO - 'SHELL': '/bin/bash', 01:06:55 INFO - 'SHLVL': '1', 01:06:55 INFO - 'TERM': 'linux', 01:06:55 INFO - 'TMOUT': '86400', 01:06:55 INFO - 'USER': 'cltbld', 01:06:55 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461224819.546117-234883395', 01:06:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:06:55 INFO - '_': '/tools/buildbot/bin/python'} 01:06:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:06:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:06:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 01:06:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 01:06:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:06:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 01:06:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 01:06:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 01:06:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 01:06:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 01:06:55 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:06:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:06:55 INFO - Cleaning up... 01:06:55 INFO - Return code: 0 01:06:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:06:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:06:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:55 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 0x7fd7e6779f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28575a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e6410>, '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 0x28e7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e77a0>, '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': '7de08804244eb36560b44971000001c3-1461224819.546117-234883395', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:06:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:06:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:06:55 INFO - Using env: {'DISPLAY': ':0', 01:06:55 INFO - 'HOME': '/home/cltbld', 01:06:55 INFO - 'LANG': 'en_US.UTF-8', 01:06:55 INFO - 'LANGUAGE': 'en_US:en', 01:06:55 INFO - 'LOGNAME': 'cltbld', 01:06:55 INFO - 'MAIL': '/var/mail/cltbld', 01:06:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:06:55 INFO - 'MOZ_NO_REMOTE': '1', 01:06:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:06:55 INFO - 'NO_EM_RESTART': '1', 01:06:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:06:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:06:55 INFO - 'PWD': '/builds/slave/test', 01:06:55 INFO - 'SHELL': '/bin/bash', 01:06:55 INFO - 'SHLVL': '1', 01:06:55 INFO - 'TERM': 'linux', 01:06:55 INFO - 'TMOUT': '86400', 01:06:55 INFO - 'USER': 'cltbld', 01:06:55 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461224819.546117-234883395', 01:06:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:06:55 INFO - '_': '/tools/buildbot/bin/python'} 01:06:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:06:56 INFO - Downloading/unpacking jsonschema 01:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:06:57 INFO - Downloading/unpacking functools32 (from jsonschema) 01:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:58 INFO - Downloading functools32-3.2.3-2.tar.gz 01:06:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:06:58 INFO - warning: no files found matching '*.txt' 01:06:58 INFO - no previously-included directories found matching 'build' 01:06:58 INFO - no previously-included directories found matching 'dist' 01:06:58 INFO - no previously-included directories found matching '.git*' 01:06:58 INFO - Installing collected packages: jsonschema, functools32 01:06:58 INFO - Running setup.py install for functools32 01:06:58 INFO - warning: no files found matching '*.txt' 01:06:58 INFO - no previously-included directories found matching 'build' 01:06:58 INFO - no previously-included directories found matching 'dist' 01:06:58 INFO - no previously-included directories found matching '.git*' 01:06:58 INFO - Successfully installed jsonschema functools32 01:06:58 INFO - Cleaning up... 01:06:58 INFO - Return code: 0 01:06:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:06:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:06:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:58 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 0x7fd7e6779f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28575a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e6410>, '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 0x28e7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e77a0>, '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': '7de08804244eb36560b44971000001c3-1461224819.546117-234883395', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:06:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 01:06:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 01:06:58 INFO - Using env: {'DISPLAY': ':0', 01:06:58 INFO - 'HOME': '/home/cltbld', 01:06:58 INFO - 'LANG': 'en_US.UTF-8', 01:06:58 INFO - 'LANGUAGE': 'en_US:en', 01:06:58 INFO - 'LOGNAME': 'cltbld', 01:06:58 INFO - 'MAIL': '/var/mail/cltbld', 01:06:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:06:58 INFO - 'MOZ_NO_REMOTE': '1', 01:06:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:06:58 INFO - 'NO_EM_RESTART': '1', 01:06:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:06:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:06:58 INFO - 'PWD': '/builds/slave/test', 01:06:58 INFO - 'SHELL': '/bin/bash', 01:06:58 INFO - 'SHLVL': '1', 01:06:58 INFO - 'TERM': 'linux', 01:06:58 INFO - 'TMOUT': '86400', 01:06:58 INFO - 'USER': 'cltbld', 01:06:58 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461224819.546117-234883395', 01:06:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:06:58 INFO - '_': '/tools/buildbot/bin/python'} 01:06:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:06:58 INFO - Downloading/unpacking flake8 01:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:07:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:07:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:07:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:07:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:07:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:07:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:07:01 INFO - no previously-included directories found matching 'docs/_build' 01:07:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:07:01 INFO - Running setup.py install for pep8 01:07:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:07:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:07:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:07:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:07:01 INFO - no previously-included directories found matching 'docs/_build' 01:07:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:07:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:07:01 INFO - Cleaning up... 01:07:01 INFO - Return code: 0 01:07:01 INFO - Running post-action listener: _resource_record_post_action 01:07:01 INFO - Running post-action listener: _start_resource_monitoring 01:07:01 INFO - Starting resource monitoring. 01:07:01 INFO - ##### 01:07:01 INFO - ##### Running install step. 01:07:01 INFO - ##### 01:07:01 INFO - Running pre-action listener: _resource_record_pre_action 01:07:01 INFO - Running main action method: install 01:07:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:07:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:07:01 INFO - Reading from file tmpfile_stdout 01:07:01 INFO - Detecting whether we're running mozinstall >=1.0... 01:07:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:07:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:07:01 INFO - Reading from file tmpfile_stdout 01:07:01 INFO - Output received: 01:07:01 INFO - Usage: mozinstall [options] installer 01:07:01 INFO - Options: 01:07:01 INFO - -h, --help show this help message and exit 01:07:01 INFO - -d DEST, --destination=DEST 01:07:01 INFO - Directory to install application into. [default: 01:07:01 INFO - "/builds/slave/test"] 01:07:01 INFO - --app=APP Application being installed. [default: firefox] 01:07:01 INFO - mkdir: /builds/slave/test/build/application 01:07:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:07:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:07:18 INFO - Reading from file tmpfile_stdout 01:07:18 INFO - Output received: 01:07:18 INFO - /builds/slave/test/build/application/firefox/firefox 01:07:18 INFO - Running post-action listener: _resource_record_post_action 01:07:18 INFO - ##### 01:07:18 INFO - ##### Running run-tests step. 01:07:18 INFO - ##### 01:07:18 INFO - Running pre-action listener: _resource_record_pre_action 01:07:18 INFO - Running main action method: run_tests 01:07:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:07:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:07:18 INFO - Python 2.7.3 01:07:18 INFO - Return code: 0 01:07:18 INFO - grabbing minidump binary from tooltool 01:07:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:18 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 0x28e6410>, '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 0x28e7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e77a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:07:18 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 01:07:18 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 01:07:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:07:18 INFO - Return code: 0 01:07:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:07:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:07:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:07:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:07:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:07:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:07:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:07:19 INFO - Return code: 0 01:07:19 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/Xl-FcnEoRkOjEzQooYP8Tw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 01:07:19 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/Xl-FcnEoRkOjEzQooYP8Tw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 01:07:19 INFO - Using env: {'DISPLAY': ':0', 01:07:19 INFO - 'HOME': '/home/cltbld', 01:07:19 INFO - 'LANG': 'en_US.UTF-8', 01:07:19 INFO - 'LANGUAGE': 'en_US:en', 01:07:19 INFO - 'LOGNAME': 'cltbld', 01:07:19 INFO - 'MAIL': '/var/mail/cltbld', 01:07:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:07:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:07:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:07:19 INFO - 'MOZ_NO_REMOTE': '1', 01:07:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:07:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:07:19 INFO - 'NO_EM_RESTART': '1', 01:07:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:07:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:07:19 INFO - 'PWD': '/builds/slave/test', 01:07:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:07:19 INFO - 'SHELL': '/bin/bash', 01:07:19 INFO - 'SHLVL': '1', 01:07:19 INFO - 'TERM': 'linux', 01:07:19 INFO - 'TMOUT': '86400', 01:07:19 INFO - 'USER': 'cltbld', 01:07:19 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461224819.546117-234883395', 01:07:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:07:19 INFO - '_': '/tools/buildbot/bin/python'} 01:07:19 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/Xl-FcnEoRkOjEzQooYP8Tw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 01:07:19 INFO - mozversion application_buildid: 20160420223218 01:07:19 INFO - mozversion application_changeset: 72023950385695172b8c84e3d804adccfe14f843 01:07:19 INFO - mozversion application_display_name: Nightly 01:07:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:07:19 INFO - mozversion application_name: Firefox 01:07:19 INFO - mozversion application_remotingname: firefox 01:07:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:07:19 INFO - mozversion application_vendor: Mozilla 01:07:19 INFO - mozversion application_version: 48.0a1 01:07:19 INFO - mozversion platform_buildid: 20160420223218 01:07:19 INFO - mozversion platform_changeset: 72023950385695172b8c84e3d804adccfe14f843 01:07:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:07:19 INFO - mozversion platform_version: 48.0a1 01:07:19 INFO - using testdate: 1461226039 01:07:19 INFO - actual date: 1461226039 01:07:19 INFO - starting webserver on 'localhost:53531' 01:07:19 INFO - SUITE-START | Running 2 tests 01:07:19 INFO - TEST-START | dromaeo_css 01:07:19 INFO - operating with platform_type : linux_ 01:07:19 INFO - Initialising browser for dromaeo_css test... 01:07:19 INFO - TEST-INFO | started process 25655 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXEgyjO/profile http://localhost:53531/getInfo.html) 01:07:24 INFO - PROCESS | 25655 | __metrics Screen width/height:1600/1200 01:07:24 INFO - PROCESS | 25655 | colorDepth:24 01:07:24 INFO - PROCESS | 25655 | Browser inner width/height: 1024/697 01:07:24 INFO - PROCESS | 25655 | __metrics 01:07:25 ERROR - PROCESS | 25655 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:07:26 INFO - TEST-INFO | 25655: exit 0 01:07:26 INFO - Browser initialized. 01:07:26 INFO - Running cycle 1/1 for dromaeo_css test... 01:07:26 INFO - TEST-INFO | started process 25735 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXEgyjO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:07:38 INFO - PROCESS | 25735 | RSS: Main: 153022464 01:07:38 INFO - PROCESS | 25735 | 01:08:29 INFO - PROCESS | 25735 | 1461226109162 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 01:10:36 INFO - PROCESS | 25735 | Cycle 1(1): loaded http://localhost:53531/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53531/tests/dromaeo/cssquery-ext.html) 01:10:37 INFO - PROCESS | 25735 | RSS: Main: 244195328 01:10:37 INFO - PROCESS | 25735 | 01:13:39 INFO - PROCESS | 25735 | Cycle 1(1): loaded http://localhost:53531/tests/dromaeo/cssquery-ext.html (next: http://localhost:53531/tests/dromaeo/cssquery-jquery.html) 01:13:40 INFO - PROCESS | 25735 | RSS: Main: 240984064 01:13:40 INFO - PROCESS | 25735 | 01:16:42 INFO - PROCESS | 25735 | Cycle 1(1): loaded http://localhost:53531/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53531/tests/dromaeo/cssquery-mootools.html) 01:16:43 INFO - PROCESS | 25735 | RSS: Main: 240009216 01:16:43 INFO - PROCESS | 25735 | 01:19:45 INFO - PROCESS | 25735 | Cycle 1(1): loaded http://localhost:53531/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53531/tests/dromaeo/cssquery-prototype.html) 01:19:45 INFO - PROCESS | 25735 | RSS: Main: 234487808 01:19:45 INFO - PROCESS | 25735 | 01:22:48 INFO - PROCESS | 25735 | Cycle 1(1): loaded http://localhost:53531/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53531/tests/dromaeo/cssquery-yui.html) 01:22:48 INFO - PROCESS | 25735 | RSS: Main: 224550912 01:22:48 INFO - PROCESS | 25735 | 01:25:51 INFO - PROCESS | 25735 | Cycle 1(1): loaded http://localhost:53531/tests/dromaeo/cssquery-yui.html (next: http://localhost:53531/tests/dromaeo/cssquery-dojo.html) 01:25:51 INFO - PROCESS | 25735 | RSS: Main: 264835072 01:25:51 INFO - PROCESS | 25735 | 01:25:51 INFO - PROCESS | 25735 | __start_tp_report 01:25:51 INFO - PROCESS | 25735 | _x_x_mozilla_page_load 01:25:51 INFO - PROCESS | 25735 | _x_x_mozilla_page_load_details 01:25:51 INFO - PROCESS | 25735 | |i|pagename|runs| 01:25:51 INFO - PROCESS | 25735 | |0;dojo.html;3039.0578920534635;3093.5050391937293;3132.3578666373396;3134.545490903819;3159.3365393267413;5043.747812609373;5127.230915362702;5201.401838788541;5201.505856943589;5252.1859111837675;5202.245674377213;5202.401723801754;5208.401033881095;5292.285541451903;5373.328333958255;4618.907621847561;4658.90682186356;4746.359241502388;4794.520547945195;4811.927821082687;4783.258594917794;4795.688280261789;4808.927866081994;4842.830500932468;4894.167991441445;4679.60223381013;4762.309465127554;4794.808207671689;4805.687630304019;4841.588464980463;4725.125851717409;4732.810687572493;4735.5974742146955;4746.43042834862;4771.212749896263;4644.790984405709;4689.859304220879;4714.245720684708;4729.148753224418;4787.688800227974;5076.162433198518;5089.770960306758;5102.183650615883;5125.077486052509;5128.153854613985;5488.7530061147345;5490.752916118784;5495.835124946258;5496.972515137399;5516.972415137899;5513.917291240635;5552.500274975271;5580.91628625571;5648.096304591246;5709.65742055478;5133.589312854962;5151.665141765773;5153.072446959546;5157.226416037587;5204.063268611649;5584.4136365681015;5590.8043218487155;5591.692456914828;5594.580406469531;5606.074997625427;5410.107332290128;5412.539934105566;5476.890462190734;5574.554035677136;5586.776528938797;5518.806841760599;5555.194496797942;5560.582956278296;5561.193626924073;5570.3315602127195;5500.147477141049;5502.202180683778;5504.036793561111;5510.228568000483;5551.555875529948;5274.182501712241;5451.918221226685;5495.505404513533;5497.890042199134;5544.77820887168;4205.17998990194;4205.684573656988;4208.915821683549;4219.156168766198;4237.63980061692;3719.0702324418894;3773;3776.660100590905;3811.676007539335;3830.9042273943373;5220.895582088337;5286.286351342596;5288.127458969304;5338.706371149547;5344.6258761887075;5492.231087647732;5499.395066542677;5522.006038912954;5528.253685752452;5533.944660553423;5174.249733788655;5182.896342073137;5192.065428222881;5212.635115541876;5217.765200565984;4642.257238841769;4850.442199147144;4872.805087796449;4897.804087836518;4915.852524424202;5697.9430205698245;5707.429257074343;5713.057345538023;5715.428457154335;5719.227904232958;5576.498115169736;5577.191307260506;5585.413531579125;5586.413426590149;5639.464250896158;5570.053090974463;5700.657960522382;5736.541076713769;5780.624259423124;5790.681512516852;5487.5609951203005;5492.835214943558;5507.752151153128;5517.420670829505;5524.171374293727;5413.918791218056;5584.413636568264;5609.467100625434;5615.3823079462045;5622.85942851432;5441.564674825925;5480.6437581557075;5481.424450432647;5496.230527726041;5528.419515950928;5403.108487099585;5404.054290499225;5410.107332290128;5410.242566040836;5411.377691565521;5226.71253081069;5339.439358867263;5347.946520534745;5350.732463376893;5371.409144994126;5461.15352120422;5476.479734425223;5496.120620700669;5521.420250873601;5548.583856210881;5372.5701943843615;5391.353037635352;5398.865028374165;5400.054990376747;5419.674819510842 01:25:51 INFO - PROCESS | 25735 | |1;ext.html;606.3300053440947;635.923689157301;642.4571237304476;650.6453982579494;661.7617657643248;31309.217269568242;32002.839985800096;32082.518762218555;37503.62496375036;38211.42682859753;40855;41721.58278417215;41750.58249417505;41788.791056044676;41901.58098419015;8470.872936905951;8643.567821608925;8656.177663121993;8667.913320866774;8671.739847804576;7889.8816517752275;10088.192944564455;10114.089731924125;10432.382980638013;10462.215333849992;10203;10212.591496340137;10216.540255688511;10218.540165692562;10220.642277520288;7721.420893433015;10029.498525073754;10137.290389672726;10138.59445622178;10212.131968782662;9943.950280248624;10088.243381746324;10092.243081768896;10096.747581310452;10098.14165795901;38180;39254.803725981474;39288;39292.41061384082;39306.803465982484;3400.0819778659625;3437.2094418283687;3805.5052843130493;3838.059675379522;4041.3533834586324;29419;31850.522242166386;32014.519782203286;32124.678753212636;32178;4198.8320467181275;4204.62158405745;4262.147570485915;4312.331588603772;4343.131373725268;298392;299899;300113;301224.4938775314;301277;35448.46827297592;57231;57244;57523.42476575264;57554;33874.83062584721;33913.83043084769;34039;34044.31911361759;34047;12845.871541284467;12942.547010854574;12943.158694684815;12965.481380744664;12968.80546791799;10866.782664346669;10885.727856803485;10970.177236707119;10978.231523793418;10986.395748233765;8412.200840920103;8486.957565212258;8523.360747943805;8577.485350878967;8599.39804213699;3260.4457242268873;3282.770206085599;3317.618473875487;3328.86684532616;3342.131045928076;934.444005816538;1017.399734156851;1055.9894401056044;1184.798584240681;1204.8915597596258;28823.423531529254;30602;31401.37197256088;32759.836200818845;34675.65324346775;1137.6302701622005;1143.0969534067992;1153.9769204615861;1165.2367699157066;1174.2074099982478;15429.151396673291;16037.599060023593;16039.278232479566;16063.839361606468;16325.428609998593;463435;470800;472972;473246;473247;55174;55975.44024559702;56053.43946560564;56063;56109.719451403296;1352.7970804379422;1393.2212511087068;1408.8714093692356;1408.9788653170006;1430.306301443799;30046.84976575103;30887.382252355277;30921;31807;32130.35739285248;49042.75478622584;49762.50237497579;49908.25137623011;49992.50007499878;50087.74956125196;413513;414314;414611;418567;418635;27060.32349191286;28227.2943176414;28322.2919427016;28386.43227135487;28410.715892840806;45461;46202;46707.29939050985;46832;47859;39621.60378396179;40019;40138.1972360557;40255;41290.79354603328;39739.602603974745;39796.02039796113;43219.78390108029;44222;45327;39288.2142357157;39707.40438893477;40041.1991760169;40077.799611001756;40140.1971960565;32397.514037288987;34897.79901723042;35083.29833403369;35478.645213547534;35480.290394191456;27060.864695677184;27513.211641243255;27546.724532754415;27565.72434275712;27586.72413275922 01:25:51 INFO - PROCESS | 25735 | |2;jquery.html;389.7349802134547;392.15099309993866;411.3254263008668;415.3748608344441;419.24954331746176;14956.13048368954;19314.90342548287;19460.41618751436;19520.99999999998;19528.902355488204;18107.275708971658;18112;18409.355672551465;18438.262469501205;18961.715574266396;5588.608797384195;5668.943310566883;5723.112917497794;5754.683492407916;5764.7982320618785;5489.313835770528;5670.914936275959;5683.3464151622675;5697.116946873241;5701.14482827575;5614.8596285093;5628.268325117729;5676.262085928824;5678.403767604404;5690.886182276352;5529.253550770655;5601.075822489284;5626.549876009909;5631.1271752878365;5657.434256574351;4941.827036053721;5025.673331233458;5099.69401835891;5105.642605017651;5144.382674079097;22166.445838853997;22490.77509224903;22504.662430063563;22702.31893043195;22834.31497055091;2349.8825058746993;2411.3730430088126;2469.530789150074;2592.3907881647797;2794.874230659605;9371.671991480334;13578.660533486644;14015.229162396065;14017.08888922227;14431.711365772626;1778.2264714848952;1864.3474783825689;1966.459223713476;2038.7859274776083;2054.876707397561;73603.63198184028;76989.61505192493;78542.21457785406;78583.21416785817;79774;10691.35851848876;10885.510152043176;10887.945560272306;11017.559297628006;11079.50142243585;15406.768898466533;15496.380144794308;15501.224938753017;15512.224388780516;15522.5343239703;7399.297066778648;7512.32389084985;7559.28186822251;7670.274188307586;7685.692572297045;7063.223045464994;7102.360787529147;7144.106986626672;7253.455990800606;7259.382952449101;4629.560191781776;4714.033623107255;4755.0489902019735;4765.69023013503;4772.928406073912;1956.4130760771711;1957.6100968312658;1961.499817546545;1983.2501159722385;2032.2886989553538;932.4172392254841;991.0386924683046;1014.9951547967459;1026.958921643141;1044.8276034454382;18327.908360458114;18586.628267434575;18925.62148757017;19102.426927192206;19210.327638532584;982.7297493189287;986.7483791633088;1005.703317521333;1005.8843233028149;1015.355249416611;10185.643502477378;10522.63170789034;10594.364338139736;10606.628767993083;10610.628627997983;427020;435011;447783;447943;449994;88895.77698564618;88938;90411;91476;91718;1012.7771890184148;1027.445179603021;1030.618671091701;1047.350642601592;1050.4380156616173;16277.511674649779;16343.346266149696;16420.26108825082;16543.338266469687;16579.336826526804;30836.074917752503;35656.64343356533;36405.45391819072;36512.08719782027;37043.62956370402;51162;52581.73709131583;53127.468725312254;53154.01344899226;53912;8322.142310026007;8329.208725171098;8344.624491898001;8441.493510389397;8506;9275.39709918853;12099;12661.177023493443;12909.289989050692;13271.402786874807;11166.1067114629;11268.774624507629;11289.830652540055;11332.546698131982;11497.022753066083;5513.476219759116;9994.350932096122;10291.53688084053;10926.235163538477;11655.475503602527;10854.45727713627;10899.836502452312;10971.725706857073;11251.212415130862;11296.265742726697;7945.721899733481;8257.917420825956;8358.28954538871;8403.873941890753;8611.13888611134;9800.950995244979;10875.891241087804;11223.775524489301;11522.193446458667;11592.0146787524 01:25:51 INFO - PROCESS | 25735 | |3;mootools.html;1369.1442848219863;1523.253605733191;1538.4000239906438;1728.7752592163017;1839.7148441991487;7911.287984081431;8266.83466330673;8273.462224955374;8297.95851020744;8304.045034820998;8124.146964568709;8149.714759983387;8154.959225203866;8188.1402452742495;8214.548199849007;1993.6212119697284;2261.231181398324;2280.281711260956;2292.2893902890073;2309.8036666883336;2303.9171589352977;2324.848884822481;2325.0699720112007;2326.7905888470036;2328.84862483938;2206.4483879030245;2260.3445000949705;2261.9095236190615;2262.6606009098687;2265.0713207584895;1947.3865732294282;2179.5422961178174;2216.2575537195057;2220.6335954567476;2247.9775202248097;2291.346966114666;2306.1467257114805;2315.9189428369928;2316.872572008539;2318.802901753353;8075.95962020192;8089.635966381527;8153.429259951806;8157.796055098611;8161.755147345589;4854.805807767685;4987.950120498785;4989.201727723583;5002.374703162105;5009.373828271466;3191.4255434021866;3223.5487031815564;3251.7398608111293;3302.53764472974;3310.3213841162506;1080.9729756756064;1091.1107447430397;1109.351029647649;1136.159242160795;1139.954401823926;11295.20933534653;11359.659210223625;11374.37440940748;11378.089752819755;11384.943075284653;4322.827086916551;4467.687261891637;4504.144212599595;4531;4532.909341813145;9774.218062555121;9779.951100244452;9780.413175209367;9782.119609235204;9782.951085244527;5077.898442031139;5091.236314552847;5097.388313402341;5098.949010509921;5111.080005598954;4150.27370210212;4486.820527178877;4617.746023968647;4629.259318509023;4632.351470794091;3736.4021756518828;3757.830897609614;3853.2100919311474;3861.7489863158803;3901.2197560488016;1204.4941124727636;1233.3648171191844;1234.3643023842728;1251.599488163797;1252.6743046807712;783.5220515485549;870.7648934787572;934.7149119518613;939.4879790514186;966.7631430299481;5421.807202415463;5545.861353466115;5576.665400076008;5615.382307946123;5700.287464066992;890.6303883888114;892.0410558649348;958.9328746987784;988.9011098890054;1003.3377970539555;4010.3382941814857;4072.531658859269;4077.2457095436844;4079.6736261099636;4097.268986157875;9933.701988940344;10245.282830201962;10316.381017138996;10326.535305911251;10362.481875906175;10091.949540252252;10164;10251.38491690486;10256.538455769509;10322.22583306255;7726.497777644435;7936.880946785803;8002.199780022068;8012.439129261013;8027.317677997319;5631.352394474688;5776.220210271559;5781.103928891029;5806.44838740319;5882.647041177543;9496.382735122195;9512.429254244767;9532.142107210384;9604.03959604034;9644.565994530123;9475.099865512766;9527.666531671359;9568.904310956801;9725.85411218818;9868.950655246677;6410.871782564416;6643.900341494978;6650.334966503311;7008.614526200904;7103.82240443993;7677.577733224726;7754.108277548155;7881.133075361591;7888.368930485432;7945.801354966172;7116.288371163049;7167.1757747859665;7215.170255420484;7284.162321333115;7323.63381830917;7285.927140728525;7286;7288.854222915618;7318.853622927405;7391;6791.151106111736;6806.081179040964;6807.489438292247;6822.795316140524;6952.582845029315;5021.899562008666;5035.949640503694;5037.722925239147;5089.185730283137;5112.514311140436;5123.129068058364;5160.922586161286;5171.146760784429;5180.197069454241;5294.973525132504 01:25:51 INFO - PROCESS | 25735 | |4;prototype.html;335.03946237399384;339.7180340317537;341.93845107880577;349.0627664720225;352.68624374206104;5532.3914369419435;5668.829935101953;5672.376038635747;5728.627639203454;5783.855403614906;5718.399568045358;5746.942530574693;5759.827205183851;5764.7982320618785;5777.62445441046;4449.911001779962;4475.888102797424;4486.484054333744;4487.349334346518;4512.142692888341;4355.847545335914;4481.955180448186;4500.302453119755;4507.4816396114375;4512.954870451303;4440.245158323077;4460.79926403311;4461.442319710036;4463.085067561158;4466.3747075409465;4224.746515209097;4466.240739074366;4468.441444819381;4468.664850136237;4475.462944446655;3839.2513459875336;3843.8654647087496;3864.9227015459815;3871.187050719352;3877.3796192609047;5479.506844384025;5519.889602207973;5525.0883604205255;5535.557155427597;5551.8889622207325;4928.211486162197;5069.112905241568;5072.163093089635;5076.517730815566;5101.336826212606;5992.161097446361;6022.156898034279;6022.638641681469;6024;6030.577859549833;4245.787710614488;4247.87256382309;4254.617084462382;4258.829646814123;4261.87214383569;5998.4601385875485;6210.751569937197;6280.591761535531;6311.842203944938;6321.273053598849;4318.719283246579;4325.697201195949;4344.761038142869;4354.651627869763;4355.542668019875;4396.538363471789;4399.23013472641;4399.5380485049245;4406.20688276107;4408.9118217636105;4884.0521455192065;5020.849374518771;5053.267276244997;5085.440601533828;5092.898142037138;5710.771569137271;5900.64596124234;6040.124181993587;6072.969635151884;6076.696165191811;1496.368957835964;1510.4411367793987;1516.8558986896228;1520.5286361228054;1521.9619509512129;1004.1514919892679;1005.261133067195;1018.8588780565814;1024.0987930621154;1025.6922923123034;5728.856778580485;5764.625299355528;5776;5783.219265399117;5795.88408231833;6156.476699480505;6167.907481387782;6175.3515880832765;6181.721822517998;6195.442410183015;5562.249096372019;5751.367349591542;5758.913616295759;5780.566457515703;5793.391693872167;3299.389612921569;3304.603447586305;3317.7179939705397;3321.9169520762175;3328.3676101541114;6189.752409903554;6340.429361357407;6353.237611486558;6403.231612206565;6476.417122459001;6368.745250189941;6388.648624325614;6389.552731308857;6394.712237949303;6401.679916004275;6275.152854364785;6464.547481676332;6500;6500.382463665944;6514.348565143448;6191.907121393093;6210.596311239755;6214.5960512566535;6239.875202495834;6256.906146407717;6198.6280823150755;6204.286507051566;6205;6251.843703907439;6254.718537665725;6191.226096737908;6468.191476065492;6477.708503117466;6495.0906873036865;6514.9348506514325;4321.870343889688;4354.172707185625;4368.60682538573;4374.868753937387;4379.080393117353;5730.799422020209;5984.970075149597;6295.55931084838;6299.842503937438;6331.936680633319;6129.478994285536;6141.109539116893;6144.938550614615;6154.261488621394;6162.168107305456;6003.519718422428;6094.329623741473;6106.664133472702;6129.816105516842;6150.507959363151;5917.6745279010065;5960.165576819162;5968.253968253968;6012.188354572077;6013.098035294566;6047.425494578008;6084.300305464752;6118.755249790137;6125.754969801158;6155.599886007395;5855.121731740273;5958.404159584007;5980.910286345796;5981.641101533922;5990.430909063632 01:25:51 INFO - PROCESS | 25735 | |5;yui.html;722.8445884134911;770.8766597344425;776.5534817479951;815.873539601362;827.3050637464529;13401.59795206143;13696.315184240799;13735.31323433828;13755.105918115341;13782.104163229384;13009.089363744542;13019.153755005918;13065.542706005292;13083.607491775238;13130.212187268771;649.3052433895746;764.1746913333586;788.3062904643905;791.3234184772024;791.4538968112013;791.3945831438954;795.2921899509441;796.1083586383259;797.4497596658316;799.7800604833659;697.6546609428315;845.0408786027872;846.6063280574532;848.1772680499905;848.2874385516166;821.1378053044309;834.8747687846811;837.3134030095324;837.8659414493712;838.7525679924406;614.2383444528753;614.241411856357;614.6772944204283;614.6957256158186;614.9108379285024;12887.871121288761;12904.354782260849;12916.289604071771;12918.870811291861;12996.675083122998;13147.802782958262;13362.665933351647;13590.524331648345;13861.86138138626;13883.861161388359;11082;11153.665390038312;11189.104871610252;11270.380129092897;11384.373859437728;3726.664600185969;3744.513213282256;3757.6242375762477;3842.9615703842883;3885.106425522146;51536;52806.20790688143;53328.93342133174;53353;53381.733091334296;10826.133909287395;10983.505742241618;11096.833547496793;11112;11134.721631959104;18459.815401846077;18495.260189592267;18495.90752046231;18532.166052527667;18556.907215463838;7770.961145194238;8250.46371985819;8324.958375208207;8331.791705207419;8335.81659614208;4457.24226881431;4528.637708983273;4696.8590942271785;4705.788239529229;4708.128996135726;3347.297067615828;3406.880759173417;3413.232022794901;3414.573178352706;3419.692227699519;545.5717261949351;598.1924402057188;625.6840295650667;643.2249139786546;657.9703913323912;695.7703957693949;724.9601271929989;733.2667332667332;744.9383035723173;754.5661244784271;9005.954970225106;9193.954030229806;9458.290628202913;9496.952515237379;9628.05641779669;703.2159142556116;703.395080231001;707.7947395255318;713.1727196452091;733.1349008170411;4404.493483249404;4493.168763778712;4519.706219095749;4524.796384162721;4573.519780423074;55732.442675572725;57441;61510.69244653838;61737;62689;47657.28514072292;47750;47830.760846195546;51626.48373516217;52651.210231846555;46139.30791038137;46533.06933861304;47222.52777472181;48123.75938120287;48386;9072.410293330913;9276.907230927603;9402.81194376095;9411.623535058521;9472.573734182117;31310;31702.524462132624;31945.6805431952;32271;32892.50661240036;41175.794121029205;43923;44923.550764491934;45482.772586138184;45575.54424455713;11231.66305010851;11552.191346605658;11574.88425115738;11674.357910315015;12040.819387709016;12975.351232438528;13028.218306901616;13042.804357934448;13351.198928064347;13422.39599218057;12314.322712250912;12561.497540098293;12928;13279.20730701343;13291.268980205794;12445;12972.156809807333;13011.934940325238;13042.347882606022;13122.671933201746;12391.93804030974;12846.486140554647;13194.208347499181;13230.206187628773;13319.06766526334;10098.697039088838;10289.2797504174;10304.330218535772;10348;11069.391183484986;10220;10612.151027917593;10677.679669609925;10772.515236814519;10912 01:25:51 INFO - PROCESS | 25735 | __end_tp_report 01:25:51 INFO - PROCESS | 25735 | __start_cc_report 01:25:51 INFO - PROCESS | 25735 | _x_x_mozilla_cycle_collect,780 01:25:51 INFO - PROCESS | 25735 | __end_cc_report 01:25:51 INFO - PROCESS | 25735 | __startTimestamp1461227151710__endTimestamp 01:25:51 INFO - PROCESS | 25735 | 01:25:51 INFO - PROCESS | 25735 | ------- Summary: start ------- 01:25:51 INFO - PROCESS | 25735 | Number of tests: 6 01:25:51 INFO - PROCESS | 25735 | 01:25:51 INFO - PROCESS | 25735 | [#0] dojo.html Cycles:165 Average:5161.73 Median:5391.35 stddev:567.80 (10.5%) stddev-sans-first:544.58 01:25:51 INFO - PROCESS | 25735 | Values: 3039.1 3093.5 3132.4 3134.5 3159.3 5043.7 5127.2 5201.4 5201.5 5252.2 5202.2 5202.4 5208.4 5292.3 5373.3 4618.9 4658.9 4746.4 4794.5 4811.9 4783.3 4795.7 4808.9 4842.8 4894.2 4679.6 4762.3 4794.8 4805.7 4841.6 4725.1 4732.8 4735.6 4746.4 4771.2 4644.8 4689.9 4714.2 4729.1 4787.7 5076.2 5089.8 5102.2 5125.1 5128.2 5488.8 5490.8 5495.8 5497.0 5517.0 5513.9 5552.5 5580.9 5648.1 5709.7 5133.6 5151.7 5153.1 5157.2 5204.1 5584.4 5590.8 5591.7 5594.6 5606.1 5410.1 5412.5 5476.9 5574.6 5586.8 5518.8 5555.2 5560.6 5561.2 5570.3 5500.1 5502.2 5504.0 5510.2 5551.6 5274.2 5451.9 5495.5 5497.9 5544.8 4205.2 4205.7 4208.9 4219.2 4237.6 3719.1 3773.0 3776.7 3811.7 3830.9 5220.9 5286.3 5288.1 5338.7 5344.6 5492.2 5499.4 5522.0 5528.3 5533.9 5174.2 5182.9 5192.1 5212.6 5217.8 4642.3 4850.4 4872.8 4897.8 4915.9 5697.9 5707.4 5713.1 5715.4 5719.2 5576.5 5577.2 5585.4 5586.4 5639.5 5570.1 5700.7 5736.5 5780.6 5790.7 5487.6 5492.8 5507.8 5517.4 5524.2 5413.9 5584.4 5609.5 5615.4 5622.9 5441.6 5480.6 5481.4 5496.2 5528.4 5403.1 5404.1 5410.1 5410.2 5411.4 5226.7 5339.4 5347.9 5350.7 5371.4 5461.2 5476.5 5496.1 5521.4 5548.6 5372.6 5391.4 5398.9 5400.1 5419.7 01:25:51 INFO - PROCESS | 25735 | 01:25:51 INFO - PROCESS | 25735 | [#1] ext.html Cycles:180 Average:54453.89 Median:19056.43 stddev:106505.14 (558.9%) stddev-sans-first:106727.18 01:25:51 INFO - PROCESS | 25735 | Values: 606.3 635.9 642.5 650.6 661.8 31309.2 32002.8 32082.5 37503.6 38211.4 40855.0 41721.6 41750.6 41788.8 41901.6 8470.9 8643.6 8656.2 8667.9 8671.7 7889.9 10088.2 10114.1 10432.4 10462.2 10203.0 10212.6 10216.5 10218.5 10220.6 7721.4 10029.5 10137.3 10138.6 10212.1 9944.0 10088.2 10092.2 10096.7 10098.1 38180.0 39254.8 39288.0 39292.4 39306.8 3400.1 3437.2 3805.5 3838.1 4041.4 29419.0 31850.5 32014.5 32124.7 32178.0 4198.8 4204.6 4262.1 4312.3 4343.1 298392.0 299899.0 300113.0 301224.5 301277.0 35448.5 57231.0 57244.0 57523.4 57554.0 33874.8 33913.8 34039.0 34044.3 34047.0 12845.9 12942.5 12943.2 12965.5 12968.8 10866.8 10885.7 10970.2 10978.2 10986.4 8412.2 8487.0 8523.4 8577.5 8599.4 3260.4 3282.8 3317.6 3328.9 3342.1 934.4 1017.4 1056.0 1184.8 1204.9 28823.4 30602.0 31401.4 32759.8 34675.7 1137.6 1143.1 1154.0 1165.2 1174.2 15429.2 16037.6 16039.3 16063.8 16325.4 463435.0 470800.0 472972.0 473246.0 473247.0 55174.0 55975.4 56053.4 56063.0 56109.7 1352.8 1393.2 1408.9 1409.0 1430.3 30046.8 30887.4 30921.0 31807.0 32130.4 49042.8 49762.5 49908.3 49992.5 50087.7 413513.0 414314.0 414611.0 418567.0 418635.0 27060.3 28227.3 28322.3 28386.4 28410.7 45461.0 46202.0 46707.3 46832.0 47859.0 39621.6 40019.0 40138.2 40255.0 41290.8 39739.6 39796.0 43219.8 44222.0 45327.0 39288.2 39707.4 40041.2 40077.8 40140.2 32397.5 34897.8 35083.3 35478.6 35480.3 27060.9 27513.2 27546.7 27565.7 27586.7 01:25:51 INFO - PROCESS | 25735 | 01:25:51 INFO - PROCESS | 25735 | [#2] jquery.html Cycles:180 Average:26971.61 Median:16815.47 stddev:72962.51 (433.9%) stddev-sans-first:73139.89 01:25:51 INFO - PROCESS | 25735 | Values: 389.7 392.2 411.3 415.4 419.2 14956.1 19314.9 19460.4 19521.0 19528.9 18107.3 18112.0 18409.4 18438.3 18961.7 5588.6 5668.9 5723.1 5754.7 5764.8 5489.3 5670.9 5683.3 5697.1 5701.1 5614.9 5628.3 5676.3 5678.4 5690.9 5529.3 5601.1 5626.5 5631.1 5657.4 4941.8 5025.7 5099.7 5105.6 5144.4 22166.4 22490.8 22504.7 22702.3 22834.3 2349.9 2411.4 2469.5 2592.4 2794.9 9371.7 13578.7 14015.2 14017.1 14431.7 1778.2 1864.3 1966.5 2038.8 2054.9 73603.6 76989.6 78542.2 78583.2 79774.0 10691.4 10885.5 10887.9 11017.6 11079.5 15406.8 15496.4 15501.2 15512.2 15522.5 7399.3 7512.3 7559.3 7670.3 7685.7 7063.2 7102.4 7144.1 7253.5 7259.4 4629.6 4714.0 4755.0 4765.7 4772.9 1956.4 1957.6 1961.5 1983.3 2032.3 932.4 991.0 1015.0 1027.0 1044.8 18327.9 18586.6 18925.6 19102.4 19210.3 982.7 986.7 1005.7 1005.9 1015.4 10185.6 10522.6 10594.4 10606.6 10610.6 427020.0 435011.0 447783.0 447943.0 449994.0 88895.8 88938.0 90411.0 91476.0 91718.0 1012.8 1027.4 1030.6 1047.4 1050.4 16277.5 16343.3 16420.3 16543.3 16579.3 30836.1 35656.6 36405.5 36512.1 37043.6 51162.0 52581.7 53127.5 53154.0 53912.0 8322.1 8329.2 8344.6 8441.5 8506.0 9275.4 12099.0 12661.2 12909.3 13271.4 11166.1 11268.8 11289.8 11332.5 11497.0 5513.5 9994.4 10291.5 10926.2 11655.5 10854.5 10899.8 10971.7 11251.2 11296.3 7945.7 8257.9 8358.3 8403.9 8611.1 9801.0 10875.9 11223.8 11522.2 11592.0 01:25:51 INFO - PROCESS | 25735 | 01:25:51 INFO - PROCESS | 25735 | [#3] mootools.html Cycles:180 Average:5501.02 Median:5094.31 stddev:3052.55 (59.9%) stddev-sans-first:3045.32 01:25:51 INFO - PROCESS | 25735 | Values: 1369.1 1523.3 1538.4 1728.8 1839.7 7911.3 8266.8 8273.5 8298.0 8304.0 8124.1 8149.7 8155.0 8188.1 8214.5 1993.6 2261.2 2280.3 2292.3 2309.8 2303.9 2324.8 2325.1 2326.8 2328.8 2206.4 2260.3 2261.9 2262.7 2265.1 1947.4 2179.5 2216.3 2220.6 2248.0 2291.3 2306.1 2315.9 2316.9 2318.8 8076.0 8089.6 8153.4 8157.8 8161.8 4854.8 4988.0 4989.2 5002.4 5009.4 3191.4 3223.5 3251.7 3302.5 3310.3 1081.0 1091.1 1109.4 1136.2 1140.0 11295.2 11359.7 11374.4 11378.1 11384.9 4322.8 4467.7 4504.1 4531.0 4532.9 9774.2 9780.0 9780.4 9782.1 9783.0 5077.9 5091.2 5097.4 5098.9 5111.1 4150.3 4486.8 4617.7 4629.3 4632.4 3736.4 3757.8 3853.2 3861.7 3901.2 1204.5 1233.4 1234.4 1251.6 1252.7 783.5 870.8 934.7 939.5 966.8 5421.8 5545.9 5576.7 5615.4 5700.3 890.6 892.0 958.9 988.9 1003.3 4010.3 4072.5 4077.2 4079.7 4097.3 9933.7 10245.3 10316.4 10326.5 10362.5 10091.9 10164.0 10251.4 10256.5 10322.2 7726.5 7936.9 8002.2 8012.4 8027.3 5631.4 5776.2 5781.1 5806.4 5882.6 9496.4 9512.4 9532.1 9604.0 9644.6 9475.1 9527.7 9568.9 9725.9 9869.0 6410.9 6643.9 6650.3 7008.6 7103.8 7677.6 7754.1 7881.1 7888.4 7945.8 7116.3 7167.2 7215.2 7284.2 7323.6 7285.9 7286.0 7288.9 7318.9 7391.0 6791.2 6806.1 6807.5 6822.8 6952.6 5021.9 5035.9 5037.7 5089.2 5112.5 5123.1 5160.9 5171.1 5180.2 5295.0 01:25:51 INFO - PROCESS | 25735 | 01:25:51 INFO - PROCESS | 25735 | [#4] prototype.html Cycles:180 Average:5072.65 Median:5755.14 stddev:1511.69 (26.3%) stddev-sans-first:1473.51 01:25:51 INFO - PROCESS | 25735 | Values: 335.0 339.7 341.9 349.1 352.7 5532.4 5668.8 5672.4 5728.6 5783.9 5718.4 5746.9 5759.8 5764.8 5777.6 4449.9 4475.9 4486.5 4487.3 4512.1 4355.8 4482.0 4500.3 4507.5 4513.0 4440.2 4460.8 4461.4 4463.1 4466.4 4224.7 4466.2 4468.4 4468.7 4475.5 3839.3 3843.9 3864.9 3871.2 3877.4 5479.5 5519.9 5525.1 5535.6 5551.9 4928.2 5069.1 5072.2 5076.5 5101.3 5992.2 6022.2 6022.6 6024.0 6030.6 4245.8 4247.9 4254.6 4258.8 4261.9 5998.5 6210.8 6280.6 6311.8 6321.3 4318.7 4325.7 4344.8 4354.7 4355.5 4396.5 4399.2 4399.5 4406.2 4408.9 4884.1 5020.8 5053.3 5085.4 5092.9 5710.8 5900.6 6040.1 6073.0 6076.7 1496.4 1510.4 1516.9 1520.5 1522.0 1004.2 1005.3 1018.9 1024.1 1025.7 5728.9 5764.6 5776.0 5783.2 5795.9 6156.5 6167.9 6175.4 6181.7 6195.4 5562.2 5751.4 5758.9 5780.6 5793.4 3299.4 3304.6 3317.7 3321.9 3328.4 6189.8 6340.4 6353.2 6403.2 6476.4 6368.7 6388.6 6389.6 6394.7 6401.7 6275.2 6464.5 6500.0 6500.4 6514.3 6191.9 6210.6 6214.6 6239.9 6256.9 6198.6 6204.3 6205.0 6251.8 6254.7 6191.2 6468.2 6477.7 6495.1 6514.9 4321.9 4354.2 4368.6 4374.9 4379.1 5730.8 5985.0 6295.6 6299.8 6331.9 6129.5 6141.1 6144.9 6154.3 6162.2 6003.5 6094.3 6106.7 6129.8 6150.5 5917.7 5960.2 5968.3 6012.2 6013.1 6047.4 6084.3 6118.8 6125.8 6155.6 5855.1 5958.4 5980.9 5981.6 5990.4 01:25:51 INFO - PROCESS | 25735 | 01:25:51 INFO - PROCESS | 25735 | [#5] yui.html Cycles:180 Average:14283.36 Median:4506.44 stddev:16168.79 (358.8%) stddev-sans-first:16182.08 01:25:51 INFO - PROCESS | 25735 | Values: 722.8 770.9 776.6 815.9 827.3 13401.6 13696.3 13735.3 13755.1 13782.1 13009.1 13019.2 13065.5 13083.6 13130.2 649.3 764.2 788.3 791.3 791.5 791.4 795.3 796.1 797.4 799.8 697.7 845.0 846.6 848.2 848.3 821.1 834.9 837.3 837.9 838.8 614.2 614.2 614.7 614.7 614.9 12887.9 12904.4 12916.3 12918.9 12996.7 13147.8 13362.7 13590.5 13861.9 13883.9 11082.0 11153.7 11189.1 11270.4 11384.4 3726.7 3744.5 3757.6 3843.0 3885.1 51536.0 52806.2 53328.9 53353.0 53381.7 10826.1 10983.5 11096.8 11112.0 11134.7 18459.8 18495.3 18495.9 18532.2 18556.9 7771.0 8250.5 8325.0 8331.8 8335.8 4457.2 4528.6 4696.9 4705.8 4708.1 3347.3 3406.9 3413.2 3414.6 3419.7 545.6 598.2 625.7 643.2 658.0 695.8 725.0 733.3 744.9 754.6 9006.0 9194.0 9458.3 9497.0 9628.1 703.2 703.4 707.8 713.2 733.1 4404.5 4493.2 4519.7 4524.8 4573.5 55732.4 57441.0 61510.7 61737.0 62689.0 47657.3 47750.0 47830.8 51626.5 52651.2 46139.3 46533.1 47222.5 48123.8 48386.0 9072.4 9276.9 9402.8 9411.6 9472.6 31310.0 31702.5 31945.7 32271.0 32892.5 41175.8 43923.0 44923.6 45482.8 45575.5 11231.7 11552.2 11574.9 11674.4 12040.8 12975.4 13028.2 13042.8 13351.2 13422.4 12314.3 12561.5 12928.0 13279.2 13291.3 12445.0 12972.2 13011.9 13042.3 13122.7 12391.9 12846.5 13194.2 13230.2 13319.1 10098.7 10289.3 10304.3 10348.0 11069.4 10220.0 10612.2 10677.7 10772.5 10912.0 01:25:51 INFO - PROCESS | 25735 | -------- Summary: end -------- 01:25:51 INFO - PROCESS | 25735 | 01:25:52 INFO - TEST-INFO | 25735: exit 0 01:25:52 INFO - TEST-OK | dromaeo_css | took 1112636ms 01:25:52 INFO - TEST-START | kraken 01:25:52 INFO - operating with platform_type : linux_ 01:25:52 INFO - Initialising browser for kraken test... 01:25:52 INFO - TEST-INFO | started process 25918 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpG_cvkl/profile http://localhost:53531/getInfo.html) 01:25:56 INFO - PROCESS | 25918 | __metrics Screen width/height:1600/1200 01:25:56 INFO - PROCESS | 25918 | colorDepth:24 01:25:56 INFO - PROCESS | 25918 | Browser inner width/height: 1024/697 01:25:56 INFO - PROCESS | 25918 | __metrics 01:25:57 ERROR - PROCESS | 25918 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:25:58 INFO - TEST-INFO | 25918: exit 0 01:25:58 INFO - Browser initialized. 01:25:58 INFO - Running cycle 1/1 for kraken test... 01:25:58 INFO - TEST-INFO | started process 26002 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpG_cvkl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:26:10 INFO - PROCESS | 26002 | RSS: Main: 152563712 01:26:10 INFO - PROCESS | 26002 | 01:26:12 INFO - PROCESS | 26002 | Cycle 1(1): loaded http://localhost:53531/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53531/tests/kraken/driver.html?testName=audio-beat-detection) 01:26:13 INFO - PROCESS | 26002 | RSS: Main: 208781312 01:26:13 INFO - PROCESS | 26002 | 01:26:16 INFO - PROCESS | 26002 | Cycle 1(1): loaded http://localhost:53531/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53531/tests/kraken/driver.html?testName=audio-dft) 01:26:17 INFO - PROCESS | 26002 | RSS: Main: 193904640 01:26:17 INFO - PROCESS | 26002 | 01:26:20 INFO - PROCESS | 26002 | Cycle 1(1): loaded http://localhost:53531/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53531/tests/kraken/driver.html?testName=audio-fft) 01:26:20 INFO - PROCESS | 26002 | RSS: Main: 266403840 01:26:20 INFO - PROCESS | 26002 | 01:26:22 INFO - PROCESS | 26002 | Cycle 1(1): loaded http://localhost:53531/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53531/tests/kraken/driver.html?testName=audio-oscillator) 01:26:23 INFO - PROCESS | 26002 | RSS: Main: 172949504 01:26:23 INFO - PROCESS | 26002 | 01:26:25 INFO - PROCESS | 26002 | Cycle 1(1): loaded http://localhost:53531/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53531/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:26:26 INFO - PROCESS | 26002 | RSS: Main: 177147904 01:26:26 INFO - PROCESS | 26002 | 01:26:29 INFO - PROCESS | 26002 | Cycle 1(1): loaded http://localhost:53531/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53531/tests/kraken/driver.html?testName=imaging-darkroom) 01:26:29 INFO - PROCESS | 26002 | RSS: Main: 213737472 01:26:29 INFO - PROCESS | 26002 | 01:26:33 INFO - PROCESS | 26002 | Cycle 1(1): loaded http://localhost:53531/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53531/tests/kraken/driver.html?testName=imaging-desaturate) 01:26:33 INFO - PROCESS | 26002 | RSS: Main: 214941696 01:26:33 INFO - PROCESS | 26002 | 01:26:36 INFO - PROCESS | 26002 | Cycle 1(1): loaded http://localhost:53531/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53531/tests/kraken/driver.html?testName=json-parse-financial) 01:26:37 INFO - PROCESS | 26002 | RSS: Main: 214409216 01:26:37 INFO - PROCESS | 26002 | 01:26:38 INFO - PROCESS | 26002 | Cycle 1(1): loaded http://localhost:53531/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53531/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:26:39 INFO - PROCESS | 26002 | RSS: Main: 205049856 01:26:39 INFO - PROCESS | 26002 | 01:26:41 INFO - PROCESS | 26002 | Cycle 1(1): loaded http://localhost:53531/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53531/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:26:41 INFO - PROCESS | 26002 | RSS: Main: 204541952 01:26:41 INFO - PROCESS | 26002 | 01:26:43 INFO - PROCESS | 26002 | Cycle 1(1): loaded http://localhost:53531/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53531/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:26:44 INFO - PROCESS | 26002 | RSS: Main: 218537984 01:26:44 INFO - PROCESS | 26002 | 01:26:46 INFO - PROCESS | 26002 | Cycle 1(1): loaded http://localhost:53531/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53531/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:26:47 INFO - PROCESS | 26002 | RSS: Main: 222785536 01:26:47 INFO - PROCESS | 26002 | 01:26:50 INFO - PROCESS | 26002 | Cycle 1(1): loaded http://localhost:53531/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53531/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:26:50 INFO - PROCESS | 26002 | RSS: Main: 218660864 01:26:50 INFO - PROCESS | 26002 | 01:26:52 INFO - PROCESS | 26002 | Cycle 1(1): loaded http://localhost:53531/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53531/tests/kraken/driver.html?testName=ai-astar) 01:26:52 INFO - PROCESS | 26002 | RSS: Main: 282312704 01:26:52 INFO - PROCESS | 26002 | 01:26:52 INFO - PROCESS | 26002 | __start_tp_report 01:26:52 INFO - PROCESS | 26002 | _x_x_mozilla_page_load 01:26:52 INFO - PROCESS | 26002 | _x_x_mozilla_page_load_details 01:26:52 INFO - PROCESS | 26002 | |i|pagename|runs| 01:26:52 INFO - PROCESS | 26002 | |0;ai-astar;111;111;106;110;112;111;99;112;112;111 01:26:52 INFO - PROCESS | 26002 | |1;audio-beat-detection;163;131;156;193;129;153;156;129;185;129 01:26:52 INFO - PROCESS | 26002 | |2;audio-dft;161;161;160;161;161;160;161;160;161;162 01:26:52 INFO - PROCESS | 26002 | |3;audio-fft;76;73;119;122;74;72;76;110;106;74 01:26:52 INFO - PROCESS | 26002 | |4;audio-oscillator;93;93;153;93;94;92;149;92;92;155 01:26:52 INFO - PROCESS | 26002 | |5;imaging-gaussian-blur;117;116;117;117;117;116;116;116;117;117 01:26:52 INFO - PROCESS | 26002 | |6;imaging-darkroom;146;145;145;147;146;145;145;145;147;145 01:26:52 INFO - PROCESS | 26002 | |7;imaging-desaturate;94;94;94;95;96;95;95;94;95;95 01:26:52 INFO - PROCESS | 26002 | |8;json-parse-financial;56;57;57;57;56;57;56;79;55;54 01:26:52 INFO - PROCESS | 26002 | |9;json-stringify-tinderbox;63;63;62;62;62;61;63;62;62;61 01:26:52 INFO - PROCESS | 26002 | |10;stanford-crypto-aes;75;85;75;75;84;77;76;77;77;76 01:26:52 INFO - PROCESS | 26002 | |11;stanford-crypto-ccm;130;126;126;122;122;120;131;126;155;136 01:26:52 INFO - PROCESS | 26002 | |12;stanford-crypto-pbkdf2;176;169;169;173;170;179;171;172;167;167 01:26:52 INFO - PROCESS | 26002 | |13;stanford-crypto-sha256-iterative;68;69;69;69;71;69;69;67;71;68 01:26:52 INFO - PROCESS | 26002 | __end_tp_report 01:26:52 INFO - PROCESS | 26002 | __start_cc_report 01:26:52 INFO - PROCESS | 26002 | _x_x_mozilla_cycle_collect,1614 01:26:52 INFO - PROCESS | 26002 | __end_cc_report 01:26:52 INFO - PROCESS | 26002 | __startTimestamp1461227212926__endTimestamp 01:26:52 INFO - PROCESS | 26002 | 01:26:52 INFO - PROCESS | 26002 | ------- Summary: start ------- 01:26:52 INFO - PROCESS | 26002 | Number of tests: 14 01:26:52 INFO - PROCESS | 26002 | 01:26:52 INFO - PROCESS | 26002 | [#0] ai-astar Cycles:10 Average:109.50 Median:111.50 stddev:4.09 (3.7%) stddev-sans-first:4.30 01:26:52 INFO - PROCESS | 26002 | Values: 111.0 111.0 106.0 110.0 112.0 111.0 99.0 112.0 112.0 111.0 01:26:52 INFO - PROCESS | 26002 | 01:26:52 INFO - PROCESS | 26002 | [#1] audio-beat-detection Cycles:10 Average:152.40 Median:156.00 stddev:23.45 (15.0%) stddev-sans-first:24.56 01:26:52 INFO - PROCESS | 26002 | Values: 163.0 131.0 156.0 193.0 129.0 153.0 156.0 129.0 185.0 129.0 01:26:52 INFO - PROCESS | 26002 | 01:26:52 INFO - PROCESS | 26002 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 01:26:52 INFO - PROCESS | 26002 | Values: 161.0 161.0 160.0 161.0 161.0 160.0 161.0 160.0 161.0 162.0 01:26:52 INFO - PROCESS | 26002 | 01:26:52 INFO - PROCESS | 26002 | [#3] audio-fft Cycles:10 Average:90.20 Median:73.50 stddev:21.18 (28.8%) stddev-sans-first:21.83 01:26:52 INFO - PROCESS | 26002 | Values: 76.0 73.0 119.0 122.0 74.0 72.0 76.0 110.0 106.0 74.0 01:26:52 INFO - PROCESS | 26002 | 01:26:52 INFO - PROCESS | 26002 | [#4] audio-oscillator Cycles:10 Average:110.60 Median:92.50 stddev:28.84 (31.2%) stddev-sans-first:29.88 01:26:52 INFO - PROCESS | 26002 | Values: 93.0 93.0 153.0 93.0 94.0 92.0 149.0 92.0 92.0 155.0 01:26:52 INFO - PROCESS | 26002 | 01:26:52 INFO - PROCESS | 26002 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 01:26:52 INFO - PROCESS | 26002 | Values: 117.0 116.0 117.0 117.0 117.0 116.0 116.0 116.0 117.0 117.0 01:26:52 INFO - PROCESS | 26002 | 01:26:52 INFO - PROCESS | 26002 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:145.50 stddev:0.84 (0.6%) stddev-sans-first:0.88 01:26:52 INFO - PROCESS | 26002 | Values: 146.0 145.0 145.0 147.0 146.0 145.0 145.0 145.0 147.0 145.0 01:26:52 INFO - PROCESS | 26002 | 01:26:52 INFO - PROCESS | 26002 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 01:26:52 INFO - PROCESS | 26002 | Values: 94.0 94.0 94.0 95.0 96.0 95.0 95.0 94.0 95.0 95.0 01:26:52 INFO - PROCESS | 26002 | 01:26:52 INFO - PROCESS | 26002 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:57.00 stddev:7.31 (12.8%) stddev-sans-first:7.70 01:26:52 INFO - PROCESS | 26002 | Values: 56.0 57.0 57.0 57.0 56.0 57.0 56.0 79.0 55.0 54.0 01:26:52 INFO - PROCESS | 26002 | 01:26:52 INFO - PROCESS | 26002 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 01:26:52 INFO - PROCESS | 26002 | Values: 63.0 63.0 62.0 62.0 62.0 61.0 63.0 62.0 62.0 61.0 01:26:52 INFO - PROCESS | 26002 | 01:26:52 INFO - PROCESS | 26002 | [#10] stanford-crypto-aes Cycles:10 Average:77.70 Median:77.00 stddev:3.68 (4.8%) stddev-sans-first:3.77 01:26:52 INFO - PROCESS | 26002 | Values: 75.0 85.0 75.0 75.0 84.0 77.0 76.0 77.0 77.0 76.0 01:26:52 INFO - PROCESS | 26002 | 01:26:52 INFO - PROCESS | 26002 | [#11] stanford-crypto-ccm Cycles:10 Average:129.40 Median:128.00 stddev:10.19 (8.0%) stddev-sans-first:10.81 01:26:52 INFO - PROCESS | 26002 | Values: 130.0 126.0 126.0 122.0 122.0 120.0 131.0 126.0 155.0 136.0 01:26:52 INFO - PROCESS | 26002 | 01:26:52 INFO - PROCESS | 26002 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.30 Median:171.50 stddev:3.86 (2.3%) stddev-sans-first:3.70 01:26:52 INFO - PROCESS | 26002 | Values: 176.0 169.0 169.0 173.0 170.0 179.0 171.0 172.0 167.0 167.0 01:26:52 INFO - PROCESS | 26002 | 01:26:52 INFO - PROCESS | 26002 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:1.25 (1.8%) stddev-sans-first:1.27 01:26:52 INFO - PROCESS | 26002 | Values: 68.0 69.0 69.0 69.0 71.0 69.0 69.0 67.0 71.0 68.0 01:26:52 INFO - PROCESS | 26002 | -------- Summary: end -------- 01:26:52 INFO - PROCESS | 26002 | 01:26:53 INFO - TEST-INFO | 26002: exit 0 01:26:53 INFO - TEST-OK | kraken | took 61438ms 01:26:53 INFO - SUITE-END | took 1174s 01:26:54 INFO - Completed test suite (00:19:34) 01:26:54 INFO - javascript benchmark 01:26:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3039.0578920534635, 3093.5050391937293, 3132.3578666373396, 3134.545490903819, 3159.3365393267413, 5043.747812609373, 5127.230915362702, 5201.401838788541, 5201.505856943589, 5252.1859111837675, 5202.245674377213, 5202.401723801754, 5208.401033881095, 5292.285541451903, 5373.328333958255, 4618.907621847561, 4658.90682186356, 4746.359241502388, 4794.520547945195, 4811.927821082687, 4783.258594917794, 4795.688280261789, 4808.927866081994, 4842.830500932468, 4894.167991441445, 4679.60223381013, 4762.309465127554, 4794.808207671689, 4805.687630304019, 4841.588464980463, 4725.125851717409, 4732.810687572493, 4735.5974742146955, 4746.43042834862, 4771.212749896263, 4644.790984405709, 4689.859304220879, 4714.245720684708, 4729.148753224418, 4787.688800227974, 5076.162433198518, 5089.770960306758, 5102.183650615883, 5125.077486052509, 5128.153854613985, 5488.7530061147345, 5490.752916118784, 5495.835124946258, 5496.972515137399, 5516.972415137899, 5513.917291240635, 5552.500274975271, 5580.91628625571, 5648.096304591246, 5709.65742055478, 5133.589312854962, 5151.665141765773, 5153.072446959546, 5157.226416037587, 5204.063268611649, 5584.4136365681015, 5590.8043218487155, 5591.692456914828, 5594.580406469531, 5606.074997625427, 5410.107332290128, 5412.539934105566, 5476.890462190734, 5574.554035677136, 5586.776528938797, 5518.806841760599, 5555.194496797942, 5560.582956278296, 5561.193626924073, 5570.3315602127195, 5500.147477141049, 5502.202180683778, 5504.036793561111, 5510.228568000483, 5551.555875529948, 5274.182501712241, 5451.918221226685, 5495.505404513533, 5497.890042199134, 5544.77820887168, 4205.17998990194, 4205.684573656988, 4208.915821683549, 4219.156168766198, 4237.63980061692, 3719.0702324418894, 3773.0, 3776.660100590905, 3811.676007539335, 3830.9042273943373, 5220.895582088337, 5286.286351342596, 5288.127458969304, 5338.706371149547, 5344.6258761887075, 5492.231087647732, 5499.395066542677, 5522.006038912954, 5528.253685752452, 5533.944660553423, 5174.249733788655, 5182.896342073137, 5192.065428222881, 5212.635115541876, 5217.765200565984, 4642.257238841769, 4850.442199147144, 4872.805087796449, 4897.804087836518, 4915.852524424202, 5697.9430205698245, 5707.429257074343, 5713.057345538023, 5715.428457154335, 5719.227904232958, 5576.498115169736, 5577.191307260506, 5585.413531579125, 5586.413426590149, 5639.464250896158, 5570.053090974463, 5700.657960522382, 5736.541076713769, 5780.624259423124, 5790.681512516852, 5487.5609951203005, 5492.835214943558, 5507.752151153128, 5517.420670829505, 5524.171374293727, 5413.918791218056, 5584.413636568264, 5609.467100625434, 5615.3823079462045, 5622.85942851432, 5441.564674825925, 5480.6437581557075, 5481.424450432647, 5496.230527726041, 5528.419515950928, 5403.108487099585, 5404.054290499225, 5410.107332290128, 5410.242566040836, 5411.377691565521, 5226.71253081069, 5339.439358867263, 5347.946520534745, 5350.732463376893, 5371.409144994126, 5461.15352120422, 5476.479734425223, 5496.120620700669, 5521.420250873601, 5548.583856210881, 5372.5701943843615, 5391.353037635352, 5398.865028374165, 5400.054990376747, 5419.674819510842], "value": 5124.952456793217, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [606.3300053440947, 635.923689157301, 642.4571237304476, 650.6453982579494, 661.7617657643248, 31309.217269568242, 32002.839985800096, 32082.518762218555, 37503.62496375036, 38211.42682859753, 40855.0, 41721.58278417215, 41750.58249417505, 41788.791056044676, 41901.58098419015, 8470.872936905951, 8643.567821608925, 8656.177663121993, 8667.913320866774, 8671.739847804576, 7889.8816517752275, 10088.192944564455, 10114.089731924125, 10432.382980638013, 10462.215333849992, 10203.0, 10212.591496340137, 10216.540255688511, 10218.540165692562, 10220.642277520288, 7721.420893433015, 10029.498525073754, 10137.290389672726, 10138.59445622178, 10212.131968782662, 9943.950280248624, 10088.243381746324, 10092.243081768896, 10096.747581310452, 10098.14165795901, 38180.0, 39254.803725981474, 39288.0, 39292.41061384082, 39306.803465982484, 3400.0819778659625, 3437.2094418283687, 3805.5052843130493, 3838.059675379522, 4041.3533834586324, 29419.0, 31850.522242166386, 32014.519782203286, 32124.678753212636, 32178.0, 4198.8320467181275, 4204.62158405745, 4262.147570485915, 4312.331588603772, 4343.131373725268, 298392.0, 299899.0, 300113.0, 301224.4938775314, 301277.0, 35448.46827297592, 57231.0, 57244.0, 57523.42476575264, 57554.0, 33874.83062584721, 33913.83043084769, 34039.0, 34044.31911361759, 34047.0, 12845.871541284467, 12942.547010854574, 12943.158694684815, 12965.481380744664, 12968.80546791799, 10866.782664346669, 10885.727856803485, 10970.177236707119, 10978.231523793418, 10986.395748233765, 8412.200840920103, 8486.957565212258, 8523.360747943805, 8577.485350878967, 8599.39804213699, 3260.4457242268873, 3282.770206085599, 3317.618473875487, 3328.86684532616, 3342.131045928076, 934.444005816538, 1017.399734156851, 1055.9894401056044, 1184.798584240681, 1204.8915597596258, 28823.423531529254, 30602.0, 31401.37197256088, 32759.836200818845, 34675.65324346775, 1137.6302701622005, 1143.0969534067992, 1153.9769204615861, 1165.2367699157066, 1174.2074099982478, 15429.151396673291, 16037.599060023593, 16039.278232479566, 16063.839361606468, 16325.428609998593, 463435.0, 470800.0, 472972.0, 473246.0, 473247.0, 55174.0, 55975.44024559702, 56053.43946560564, 56063.0, 56109.719451403296, 1352.7970804379422, 1393.2212511087068, 1408.8714093692356, 1408.9788653170006, 1430.306301443799, 30046.84976575103, 30887.382252355277, 30921.0, 31807.0, 32130.35739285248, 49042.75478622584, 49762.50237497579, 49908.25137623011, 49992.50007499878, 50087.74956125196, 413513.0, 414314.0, 414611.0, 418567.0, 418635.0, 27060.32349191286, 28227.2943176414, 28322.2919427016, 28386.43227135487, 28410.715892840806, 45461.0, 46202.0, 46707.29939050985, 46832.0, 47859.0, 39621.60378396179, 40019.0, 40138.1972360557, 40255.0, 41290.79354603328, 39739.602603974745, 39796.02039796113, 43219.78390108029, 44222.0, 45327.0, 39288.2142357157, 39707.40438893477, 40041.1991760169, 40077.799611001756, 40140.1971960565, 32397.514037288987, 34897.79901723042, 35083.29833403369, 35478.645213547534, 35480.290394191456, 27060.864695677184, 27513.211641243255, 27546.724532754415, 27565.72434275712, 27586.72413275922], "value": 18490.51883671068, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.7349802134547, 392.15099309993866, 411.3254263008668, 415.3748608344441, 419.24954331746176, 14956.13048368954, 19314.90342548287, 19460.41618751436, 19520.99999999998, 19528.902355488204, 18107.275708971658, 18112.0, 18409.355672551465, 18438.262469501205, 18961.715574266396, 5588.608797384195, 5668.943310566883, 5723.112917497794, 5754.683492407916, 5764.7982320618785, 5489.313835770528, 5670.914936275959, 5683.3464151622675, 5697.116946873241, 5701.14482827575, 5614.8596285093, 5628.268325117729, 5676.262085928824, 5678.403767604404, 5690.886182276352, 5529.253550770655, 5601.075822489284, 5626.549876009909, 5631.1271752878365, 5657.434256574351, 4941.827036053721, 5025.673331233458, 5099.69401835891, 5105.642605017651, 5144.382674079097, 22166.445838853997, 22490.77509224903, 22504.662430063563, 22702.31893043195, 22834.31497055091, 2349.8825058746993, 2411.3730430088126, 2469.530789150074, 2592.3907881647797, 2794.874230659605, 9371.671991480334, 13578.660533486644, 14015.229162396065, 14017.08888922227, 14431.711365772626, 1778.2264714848952, 1864.3474783825689, 1966.459223713476, 2038.7859274776083, 2054.876707397561, 73603.63198184028, 76989.61505192493, 78542.21457785406, 78583.21416785817, 79774.0, 10691.35851848876, 10885.510152043176, 10887.945560272306, 11017.559297628006, 11079.50142243585, 15406.768898466533, 15496.380144794308, 15501.224938753017, 15512.224388780516, 15522.5343239703, 7399.297066778648, 7512.32389084985, 7559.28186822251, 7670.274188307586, 7685.692572297045, 7063.223045464994, 7102.360787529147, 7144.106986626672, 7253.455990800606, 7259.382952449101, 4629.560191781776, 4714.033623107255, 4755.0489902019735, 4765.69023013503, 4772.928406073912, 1956.4130760771711, 1957.6100968312658, 1961.499817546545, 1983.2501159722385, 2032.2886989553538, 932.4172392254841, 991.0386924683046, 1014.9951547967459, 1026.958921643141, 1044.8276034454382, 18327.908360458114, 18586.628267434575, 18925.62148757017, 19102.426927192206, 19210.327638532584, 982.7297493189287, 986.7483791633088, 1005.703317521333, 1005.8843233028149, 1015.355249416611, 10185.643502477378, 10522.63170789034, 10594.364338139736, 10606.628767993083, 10610.628627997983, 427020.0, 435011.0, 447783.0, 447943.0, 449994.0, 88895.77698564618, 88938.0, 90411.0, 91476.0, 91718.0, 1012.7771890184148, 1027.445179603021, 1030.618671091701, 1047.350642601592, 1050.4380156616173, 16277.511674649779, 16343.346266149696, 16420.26108825082, 16543.338266469687, 16579.336826526804, 30836.074917752503, 35656.64343356533, 36405.45391819072, 36512.08719782027, 37043.62956370402, 51162.0, 52581.73709131583, 53127.468725312254, 53154.01344899226, 53912.0, 8322.142310026007, 8329.208725171098, 8344.624491898001, 8441.493510389397, 8506.0, 9275.39709918853, 12099.0, 12661.177023493443, 12909.289989050692, 13271.402786874807, 11166.1067114629, 11268.774624507629, 11289.830652540055, 11332.546698131982, 11497.022753066083, 5513.476219759116, 9994.350932096122, 10291.53688084053, 10926.235163538477, 11655.475503602527, 10854.45727713627, 10899.836502452312, 10971.725706857073, 11251.212415130862, 11296.265742726697, 7945.721899733481, 8257.917420825956, 8358.28954538871, 8403.873941890753, 8611.13888611134, 9800.950995244979, 10875.891241087804, 11223.775524489301, 11522.193446458667, 11592.0146787524], "value": 8961.506049155778, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1369.1442848219863, 1523.253605733191, 1538.4000239906438, 1728.7752592163017, 1839.7148441991487, 7911.287984081431, 8266.83466330673, 8273.462224955374, 8297.95851020744, 8304.045034820998, 8124.146964568709, 8149.714759983387, 8154.959225203866, 8188.1402452742495, 8214.548199849007, 1993.6212119697284, 2261.231181398324, 2280.281711260956, 2292.2893902890073, 2309.8036666883336, 2303.9171589352977, 2324.848884822481, 2325.0699720112007, 2326.7905888470036, 2328.84862483938, 2206.4483879030245, 2260.3445000949705, 2261.9095236190615, 2262.6606009098687, 2265.0713207584895, 1947.3865732294282, 2179.5422961178174, 2216.2575537195057, 2220.6335954567476, 2247.9775202248097, 2291.346966114666, 2306.1467257114805, 2315.9189428369928, 2316.872572008539, 2318.802901753353, 8075.95962020192, 8089.635966381527, 8153.429259951806, 8157.796055098611, 8161.755147345589, 4854.805807767685, 4987.950120498785, 4989.201727723583, 5002.374703162105, 5009.373828271466, 3191.4255434021866, 3223.5487031815564, 3251.7398608111293, 3302.53764472974, 3310.3213841162506, 1080.9729756756064, 1091.1107447430397, 1109.351029647649, 1136.159242160795, 1139.954401823926, 11295.20933534653, 11359.659210223625, 11374.37440940748, 11378.089752819755, 11384.943075284653, 4322.827086916551, 4467.687261891637, 4504.144212599595, 4531.0, 4532.909341813145, 9774.218062555121, 9779.951100244452, 9780.413175209367, 9782.119609235204, 9782.951085244527, 5077.898442031139, 5091.236314552847, 5097.388313402341, 5098.949010509921, 5111.080005598954, 4150.27370210212, 4486.820527178877, 4617.746023968647, 4629.259318509023, 4632.351470794091, 3736.4021756518828, 3757.830897609614, 3853.2100919311474, 3861.7489863158803, 3901.2197560488016, 1204.4941124727636, 1233.3648171191844, 1234.3643023842728, 1251.599488163797, 1252.6743046807712, 783.5220515485549, 870.7648934787572, 934.7149119518613, 939.4879790514186, 966.7631430299481, 5421.807202415463, 5545.861353466115, 5576.665400076008, 5615.382307946123, 5700.287464066992, 890.6303883888114, 892.0410558649348, 958.9328746987784, 988.9011098890054, 1003.3377970539555, 4010.3382941814857, 4072.531658859269, 4077.2457095436844, 4079.6736261099636, 4097.268986157875, 9933.701988940344, 10245.282830201962, 10316.381017138996, 10326.535305911251, 10362.481875906175, 10091.949540252252, 10164.0, 10251.38491690486, 10256.538455769509, 10322.22583306255, 7726.497777644435, 7936.880946785803, 8002.199780022068, 8012.439129261013, 8027.317677997319, 5631.352394474688, 5776.220210271559, 5781.103928891029, 5806.44838740319, 5882.647041177543, 9496.382735122195, 9512.429254244767, 9532.142107210384, 9604.03959604034, 9644.565994530123, 9475.099865512766, 9527.666531671359, 9568.904310956801, 9725.85411218818, 9868.950655246677, 6410.871782564416, 6643.900341494978, 6650.334966503311, 7008.614526200904, 7103.82240443993, 7677.577733224726, 7754.108277548155, 7881.133075361591, 7888.368930485432, 7945.801354966172, 7116.288371163049, 7167.1757747859665, 7215.170255420484, 7284.162321333115, 7323.63381830917, 7285.927140728525, 7286.0, 7288.854222915618, 7318.853622927405, 7391.0, 6791.151106111736, 6806.081179040964, 6807.489438292247, 6822.795316140524, 6952.582845029315, 5021.899562008666, 5035.949640503694, 5037.722925239147, 5089.185730283137, 5112.514311140436, 5123.129068058364, 5160.922586161286, 5171.146760784429, 5180.197069454241, 5294.973525132504], "value": 4444.858760342001, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.03946237399384, 339.7180340317537, 341.93845107880577, 349.0627664720225, 352.68624374206104, 5532.3914369419435, 5668.829935101953, 5672.376038635747, 5728.627639203454, 5783.855403614906, 5718.399568045358, 5746.942530574693, 5759.827205183851, 5764.7982320618785, 5777.62445441046, 4449.911001779962, 4475.888102797424, 4486.484054333744, 4487.349334346518, 4512.142692888341, 4355.847545335914, 4481.955180448186, 4500.302453119755, 4507.4816396114375, 4512.954870451303, 4440.245158323077, 4460.79926403311, 4461.442319710036, 4463.085067561158, 4466.3747075409465, 4224.746515209097, 4466.240739074366, 4468.441444819381, 4468.664850136237, 4475.462944446655, 3839.2513459875336, 3843.8654647087496, 3864.9227015459815, 3871.187050719352, 3877.3796192609047, 5479.506844384025, 5519.889602207973, 5525.0883604205255, 5535.557155427597, 5551.8889622207325, 4928.211486162197, 5069.112905241568, 5072.163093089635, 5076.517730815566, 5101.336826212606, 5992.161097446361, 6022.156898034279, 6022.638641681469, 6024.0, 6030.577859549833, 4245.787710614488, 4247.87256382309, 4254.617084462382, 4258.829646814123, 4261.87214383569, 5998.4601385875485, 6210.751569937197, 6280.591761535531, 6311.842203944938, 6321.273053598849, 4318.719283246579, 4325.697201195949, 4344.761038142869, 4354.651627869763, 4355.542668019875, 4396.538363471789, 4399.23013472641, 4399.5380485049245, 4406.20688276107, 4408.9118217636105, 4884.0521455192065, 5020.849374518771, 5053.267276244997, 5085.440601533828, 5092.898142037138, 5710.771569137271, 5900.64596124234, 6040.124181993587, 6072.969635151884, 6076.696165191811, 1496.368957835964, 1510.4411367793987, 1516.8558986896228, 1520.5286361228054, 1521.9619509512129, 1004.1514919892679, 1005.261133067195, 1018.8588780565814, 1024.0987930621154, 1025.6922923123034, 5728.856778580485, 5764.625299355528, 5776.0, 5783.219265399117, 5795.88408231833, 6156.476699480505, 6167.907481387782, 6175.3515880832765, 6181.721822517998, 6195.442410183015, 5562.249096372019, 5751.367349591542, 5758.913616295759, 5780.566457515703, 5793.391693872167, 3299.389612921569, 3304.603447586305, 3317.7179939705397, 3321.9169520762175, 3328.3676101541114, 6189.752409903554, 6340.429361357407, 6353.237611486558, 6403.231612206565, 6476.417122459001, 6368.745250189941, 6388.648624325614, 6389.552731308857, 6394.712237949303, 6401.679916004275, 6275.152854364785, 6464.547481676332, 6500.0, 6500.382463665944, 6514.348565143448, 6191.907121393093, 6210.596311239755, 6214.5960512566535, 6239.875202495834, 6256.906146407717, 6198.6280823150755, 6204.286507051566, 6205.0, 6251.843703907439, 6254.718537665725, 6191.226096737908, 6468.191476065492, 6477.708503117466, 6495.0906873036865, 6514.9348506514325, 4321.870343889688, 4354.172707185625, 4368.60682538573, 4374.868753937387, 4379.080393117353, 5730.799422020209, 5984.970075149597, 6295.55931084838, 6299.842503937438, 6331.936680633319, 6129.478994285536, 6141.109539116893, 6144.938550614615, 6154.261488621394, 6162.168107305456, 6003.519718422428, 6094.329623741473, 6106.664133472702, 6129.816105516842, 6150.507959363151, 5917.6745279010065, 5960.165576819162, 5968.253968253968, 6012.188354572077, 6013.098035294566, 6047.425494578008, 6084.300305464752, 6118.755249790137, 6125.754969801158, 6155.599886007395, 5855.121731740273, 5958.404159584007, 5980.910286345796, 5981.641101533922, 5990.430909063632], "value": 4585.116536063276, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [722.8445884134911, 770.8766597344425, 776.5534817479951, 815.873539601362, 827.3050637464529, 13401.59795206143, 13696.315184240799, 13735.31323433828, 13755.105918115341, 13782.104163229384, 13009.089363744542, 13019.153755005918, 13065.542706005292, 13083.607491775238, 13130.212187268771, 649.3052433895746, 764.1746913333586, 788.3062904643905, 791.3234184772024, 791.4538968112013, 791.3945831438954, 795.2921899509441, 796.1083586383259, 797.4497596658316, 799.7800604833659, 697.6546609428315, 845.0408786027872, 846.6063280574532, 848.1772680499905, 848.2874385516166, 821.1378053044309, 834.8747687846811, 837.3134030095324, 837.8659414493712, 838.7525679924406, 614.2383444528753, 614.241411856357, 614.6772944204283, 614.6957256158186, 614.9108379285024, 12887.871121288761, 12904.354782260849, 12916.289604071771, 12918.870811291861, 12996.675083122998, 13147.802782958262, 13362.665933351647, 13590.524331648345, 13861.86138138626, 13883.861161388359, 11082.0, 11153.665390038312, 11189.104871610252, 11270.380129092897, 11384.373859437728, 3726.664600185969, 3744.513213282256, 3757.6242375762477, 3842.9615703842883, 3885.106425522146, 51536.0, 52806.20790688143, 53328.93342133174, 53353.0, 53381.733091334296, 10826.133909287395, 10983.505742241618, 11096.833547496793, 11112.0, 11134.721631959104, 18459.815401846077, 18495.260189592267, 18495.90752046231, 18532.166052527667, 18556.907215463838, 7770.961145194238, 8250.46371985819, 8324.958375208207, 8331.791705207419, 8335.81659614208, 4457.24226881431, 4528.637708983273, 4696.8590942271785, 4705.788239529229, 4708.128996135726, 3347.297067615828, 3406.880759173417, 3413.232022794901, 3414.573178352706, 3419.692227699519, 545.5717261949351, 598.1924402057188, 625.6840295650667, 643.2249139786546, 657.9703913323912, 695.7703957693949, 724.9601271929989, 733.2667332667332, 744.9383035723173, 754.5661244784271, 9005.954970225106, 9193.954030229806, 9458.290628202913, 9496.952515237379, 9628.05641779669, 703.2159142556116, 703.395080231001, 707.7947395255318, 713.1727196452091, 733.1349008170411, 4404.493483249404, 4493.168763778712, 4519.706219095749, 4524.796384162721, 4573.519780423074, 55732.442675572725, 57441.0, 61510.69244653838, 61737.0, 62689.0, 47657.28514072292, 47750.0, 47830.760846195546, 51626.48373516217, 52651.210231846555, 46139.30791038137, 46533.06933861304, 47222.52777472181, 48123.75938120287, 48386.0, 9072.410293330913, 9276.907230927603, 9402.81194376095, 9411.623535058521, 9472.573734182117, 31310.0, 31702.524462132624, 31945.6805431952, 32271.0, 32892.50661240036, 41175.794121029205, 43923.0, 44923.550764491934, 45482.772586138184, 45575.54424455713, 11231.66305010851, 11552.191346605658, 11574.88425115738, 11674.357910315015, 12040.819387709016, 12975.351232438528, 13028.218306901616, 13042.804357934448, 13351.198928064347, 13422.39599218057, 12314.322712250912, 12561.497540098293, 12928.0, 13279.20730701343, 13291.268980205794, 12445.0, 12972.156809807333, 13011.934940325238, 13042.347882606022, 13122.671933201746, 12391.93804030974, 12846.486140554647, 13194.208347499181, 13230.206187628773, 13319.06766526334, 10098.697039088838, 10289.2797504174, 10304.330218535772, 10348.0, 11069.391183484986, 10220.0, 10612.151027917593, 10677.679669609925, 10772.515236814519, 10912.0], "value": 6610.201424757902, "unit": "score"}], "name": "dromaeo_css", "value": 6967.5586479757685, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 106.0, 110.0, 112.0, 111.0, 99.0, 112.0, 112.0, 111.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 131.0, 156.0, 193.0, 129.0, 153.0, 156.0, 129.0, 185.0, 129.0], "value": 152.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 161.0, 161.0, 160.0, 161.0, 160.0, 161.0, 162.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 119.0, 122.0, 74.0, 72.0, 76.0, 110.0, 106.0, 74.0], "value": 90.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 153.0, 93.0, 94.0, 92.0, 149.0, 92.0, 92.0, 155.0], "value": 110.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 147.0, 146.0, 145.0, 145.0, 145.0, 147.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 96.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 57.0, 57.0, 56.0, 57.0, 56.0, 79.0, 55.0, 54.0], "value": 58.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 62.0, 62.0, 61.0, 63.0, 62.0, 62.0, 61.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 85.0, 75.0, 75.0, 84.0, 77.0, 76.0, 77.0, 77.0, 76.0], "value": 77.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 126.0, 126.0, 122.0, 122.0, 120.0, 131.0, 126.0, 155.0, 136.0], "value": 129.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 169.0, 169.0, 173.0, 170.0, 179.0, 171.0, 172.0, 167.0, 167.0], "value": 171.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 69.0, 69.0, 71.0, 69.0, 69.0, 67.0, 71.0, 68.0], "value": 69.0, "unit": "score"}], "name": "kraken", "value": 1548.3000000000002, "alertThreshold": 2.0}]} 01:26:54 INFO - Return code: 0 01:26:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:26:54 ERROR - # TBPL SUCCESS # 01:26:54 INFO - Running post-action listener: _resource_record_post_action 01:26:54 INFO - Running post-run listener: _resource_record_post_run 01:26:55 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 8192; Write bytes: 533491712; Read time: 44; Write time: 546476 01:26:55 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244445184; Read time: 0; Write time: 251992 01:26:55 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 8192; Write bytes: 289046528; Read time: 44; Write time: 294484 01:26:55 INFO - Running post-run listener: _upload_blobber_files 01:26:55 INFO - Blob upload gear active. 01:26:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:26:55 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 01:26:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:26:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:26:55 INFO - (blobuploader) - INFO - Open directory for files ... 01:26:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:26:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:26:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:26:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:26:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:26:56 INFO - (blobuploader) - INFO - Done attempting. 01:26:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:26:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:26:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:26:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:26:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:26:57 INFO - (blobuploader) - INFO - Done attempting. 01:26:57 INFO - (blobuploader) - INFO - Iteration through files over. 01:26:57 INFO - Return code: 0 01:26:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:26:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:26:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ab9f3f29cf1e5aebf7906c2b20b3ffe2723bf296a6a86008b5b8040c050041a4b415ba83f734a1e8c72f4fdb0e8baba796f039cb33eaafe758806aa7ff41a87f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c08f6de8b2d6ac50d8bedc51427d679c99f88b19102e661846964ebbcacc1276cd4fdb8a584b0596968de07993dbd397c85a6302683ff5480c5d1a1689894084"} 01:26:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:26:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:26:57 INFO - Contents: 01:26:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ab9f3f29cf1e5aebf7906c2b20b3ffe2723bf296a6a86008b5b8040c050041a4b415ba83f734a1e8c72f4fdb0e8baba796f039cb33eaafe758806aa7ff41a87f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c08f6de8b2d6ac50d8bedc51427d679c99f88b19102e661846964ebbcacc1276cd4fdb8a584b0596968de07993dbd397c85a6302683ff5480c5d1a1689894084"} 01:26:57 INFO - Running post-run listener: copy_logs_to_upload_dir 01:26:57 INFO - Copying logs to upload dir... 01:26:57 INFO - mkdir: /builds/slave/test/build/upload/logs 01:26:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.314463 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-04-21 01:26:57.269170) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 01:26:57.272606) ========= 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=7de08804244eb36560b44971000001c3-1461224819.546117-234883395 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/ab9f3f29cf1e5aebf7906c2b20b3ffe2723bf296a6a86008b5b8040c050041a4b415ba83f734a1e8c72f4fdb0e8baba796f039cb33eaafe758806aa7ff41a87f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c08f6de8b2d6ac50d8bedc51427d679c99f88b19102e661846964ebbcacc1276cd4fdb8a584b0596968de07993dbd397c85a6302683ff5480c5d1a1689894084"} build_url:https://queue.taskcluster.net/v1/task/Xl-FcnEoRkOjEzQooYP8Tw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011171 build_url: 'https://queue.taskcluster.net/v1/task/Xl-FcnEoRkOjEzQooYP8Tw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ab9f3f29cf1e5aebf7906c2b20b3ffe2723bf296a6a86008b5b8040c050041a4b415ba83f734a1e8c72f4fdb0e8baba796f039cb33eaafe758806aa7ff41a87f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c08f6de8b2d6ac50d8bedc51427d679c99f88b19102e661846964ebbcacc1276cd4fdb8a584b0596968de07993dbd397c85a6302683ff5480c5d1a1689894084"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 01:26:57.297630) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 01:26:57.297972) ========= 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=7de08804244eb36560b44971000001c3-1461224819.546117-234883395 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004395 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 01:26:57.380335) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 01:26:57.380713) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 01:26:57.381069) ========= ========= Total master_lag: 0.17 =========