builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-022 starttime: 1461722885.11 results: success (0) buildid: 20160426163015 builduid: 247b08562b174961b82790c424750e3b revision: 52072b6bec1416578615ec73027eb80a65d3fcd4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 19:08:05.109757) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 19:08:05.110218) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 19:08:05.110502) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 19:08:05.133490) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 19:08:05.133778) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1461712007.173771-80039984 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-26 19:08:05-- 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% 17.2M=0.001s 2016-04-26 19:08:05 (17.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.078358 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 19:08:05.224798) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 19:08:05.225074) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1461712007.173771-80039984 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017009 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 19:08:05.274053) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 19:08:05.274364) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 52072b6bec1416578615ec73027eb80a65d3fcd4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 52072b6bec1416578615ec73027eb80a65d3fcd4 --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=9c43b49b387003dc8f5b4e5c000001c4-1461712007.173771-80039984 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-26 19:08:05,921 truncating revision to first 12 chars 2016-04-26 19:08:05,921 Setting DEBUG logging. 2016-04-26 19:08:05,921 attempt 1/10 2016-04-26 19:08:05,921 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/52072b6bec14?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-26 19:08:06,470 unpacking tar archive at: mozilla-central-52072b6bec14/testing/mozharness/ program finished with exit code 0 elapsedTime=0.850532 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 19:08:06.137771) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 19:08:06.138123) ========= script_repo_revision: 52072b6bec1416578615ec73027eb80a65d3fcd4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 19:08:06.138525) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 19:08:06.138815) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 19:08:06.147596) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-04-26 19:08:06.147889) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=9c43b49b387003dc8f5b4e5c000001c4-1461712007.173771-80039984 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:08:06 INFO - MultiFileLogger online at 20160426 19:08:06 in /builds/slave/test 19:08:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 19:08:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:08:06 INFO - {'append_to_log': False, 19:08:06 INFO - 'base_work_dir': '/builds/slave/test', 19:08:06 INFO - 'blob_upload_branch': 'Firefox', 19:08:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:08:06 INFO - 'branch': 'Firefox', 19:08:06 INFO - 'buildbot_json_path': 'buildprops.json', 19:08:06 INFO - 'config_files': ('talos/linux_config.py',), 19:08:06 INFO - 'default_actions': ('clobber', 19:08:06 INFO - 'read-buildbot-config', 19:08:06 INFO - 'download-and-extract', 19:08:06 INFO - 'populate-webroot', 19:08:06 INFO - 'create-virtualenv', 19:08:06 INFO - 'install', 19:08:06 INFO - 'run-tests'), 19:08:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:08:06 INFO - 'download_minidump_stackwalk': True, 19:08:06 INFO - 'download_symbols': 'ondemand', 19:08:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:08:06 INFO - 'tooltool.py': '/tools/tooltool.py', 19:08:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:08:06 INFO - '/tools/misc-python/virtualenv.py')}, 19:08:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:08:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:08:06 INFO - 'installer_path': 'installer.exe', 19:08:06 INFO - 'log_level': 'info', 19:08:06 INFO - 'log_name': 'talos', 19:08:06 INFO - 'log_to_console': True, 19:08:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:08:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:08:06 INFO - 'opt_config_files': (), 19:08:06 INFO - 'pip_index': False, 19:08:06 INFO - 'sps_profile': False, 19:08:06 INFO - 'sps_profile_interval': 0, 19:08:06 INFO - 'suite': 'dromaeojs-e10s', 19:08:06 INFO - 'system_bits': '32', 19:08:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:08:06 INFO - 'title': 'talos-linux64-ix-022', 19:08:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:08:06 INFO - 'use_talos_json': True, 19:08:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:08:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:08:06 INFO - 'work_dir': 'build'} 19:08:06 INFO - ##### 19:08:06 INFO - ##### Running clobber step. 19:08:06 INFO - ##### 19:08:06 INFO - Running pre-action listener: _resource_record_pre_action 19:08:06 INFO - Running main action method: clobber 19:08:06 INFO - rmtree: /builds/slave/test/build 19:08:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:08:07 INFO - Running post-action listener: _resource_record_post_action 19:08:07 INFO - ##### 19:08:07 INFO - ##### Running read-buildbot-config step. 19:08:07 INFO - ##### 19:08:07 INFO - Running pre-action listener: _resource_record_pre_action 19:08:07 INFO - Running main action method: read_buildbot_config 19:08:07 INFO - Using buildbot properties: 19:08:07 INFO - { 19:08:07 INFO - "project": "", 19:08:07 INFO - "product": "firefox", 19:08:07 INFO - "script_repo_revision": "production", 19:08:07 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 19:08:07 INFO - "repository": "", 19:08:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 19:08:07 INFO - "buildid": "20160426163015", 19:08:07 INFO - "pgo_build": "True", 19:08:07 INFO - "basedir": "/builds/slave/test", 19:08:07 INFO - "buildnumber": 190, 19:08:07 INFO - "slavename": "talos-linux64-ix-022", 19:08:07 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:08:07 INFO - "platform": "ubuntu64_hw", 19:08:07 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 19:08:07 INFO - "branch": "mozilla-central", 19:08:07 INFO - "repo_path": "mozilla-central", 19:08:07 INFO - "revision": "52072b6bec1416578615ec73027eb80a65d3fcd4", 19:08:07 INFO - "stage_platform": "linux64-pgo", 19:08:07 INFO - "builduid": "247b08562b174961b82790c424750e3b", 19:08:07 INFO - "slavebuilddir": "test" 19:08:07 INFO - } 19:08:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/eabI_t4BQVCpnXivflvv2g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 19:08:07 INFO - Running post-action listener: _resource_record_post_action 19:08:07 INFO - ##### 19:08:07 INFO - ##### Running download-and-extract step. 19:08:07 INFO - ##### 19:08:07 INFO - Running pre-action listener: _resource_record_pre_action 19:08:07 INFO - Running main action method: download_and_extract 19:08:07 INFO - mkdir: /builds/slave/test/build/tests 19:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:07 INFO - https://queue.taskcluster.net/v1/task/eabI_t4BQVCpnXivflvv2g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:08:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eabI_t4BQVCpnXivflvv2g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:08:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eabI_t4BQVCpnXivflvv2g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:08:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eabI_t4BQVCpnXivflvv2g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:08:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eabI_t4BQVCpnXivflvv2g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:08:09 INFO - Downloaded 1361 bytes. 19:08:09 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:08:09 INFO - Using the following test package requirements: 19:08:09 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 19:08:09 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:08:09 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:08:09 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:09 INFO - u'jsshell-linux-x86_64.zip'], 19:08:09 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:08:09 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 19:08:09 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:08:09 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:08:09 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:08:09 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:08:09 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:08:09 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')]} 19:08:09 INFO - https://queue.taskcluster.net/v1/task/eabI_t4BQVCpnXivflvv2g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:08:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eabI_t4BQVCpnXivflvv2g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:08:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eabI_t4BQVCpnXivflvv2g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:08:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eabI_t4BQVCpnXivflvv2g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:08:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eabI_t4BQVCpnXivflvv2g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:08:14 INFO - Downloaded 23863887 bytes. 19:08:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:08:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:08:15 INFO - Return code: 0 19:08:15 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:08:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:15 INFO - https://queue.taskcluster.net/v1/task/eabI_t4BQVCpnXivflvv2g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:08:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eabI_t4BQVCpnXivflvv2g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:08:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eabI_t4BQVCpnXivflvv2g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:08:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eabI_t4BQVCpnXivflvv2g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:08:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eabI_t4BQVCpnXivflvv2g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:08:19 INFO - Downloaded 23863887 bytes. 19:08:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:08:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:08:20 INFO - Return code: 0 19:08: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')]} 19:08:20 INFO - https://queue.taskcluster.net/v1/task/eabI_t4BQVCpnXivflvv2g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:08:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eabI_t4BQVCpnXivflvv2g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:08:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eabI_t4BQVCpnXivflvv2g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:08:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eabI_t4BQVCpnXivflvv2g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:08:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eabI_t4BQVCpnXivflvv2g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:08:21 INFO - Downloaded 10840145 bytes. 19:08:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:08:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 19:08:21 INFO - Return code: 0 19:08:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:21 INFO - https://queue.taskcluster.net/v1/task/eabI_t4BQVCpnXivflvv2g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:08:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eabI_t4BQVCpnXivflvv2g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:08:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eabI_t4BQVCpnXivflvv2g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:08:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eabI_t4BQVCpnXivflvv2g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:08:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eabI_t4BQVCpnXivflvv2g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:08:23 INFO - Downloaded 58369174 bytes. 19:08:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eabI_t4BQVCpnXivflvv2g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:08:23 INFO - mkdir: /builds/slave/test/properties 19:08:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:08:23 INFO - Writing to file /builds/slave/test/properties/build_url 19:08:23 INFO - Contents: 19:08:23 INFO - build_url:https://queue.taskcluster.net/v1/task/eabI_t4BQVCpnXivflvv2g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:08:23 INFO - Running post-action listener: _resource_record_post_action 19:08:23 INFO - Running post-action listener: set_extra_try_arguments 19:08:23 INFO - ##### 19:08:23 INFO - ##### Running populate-webroot step. 19:08:23 INFO - ##### 19:08:23 INFO - Running pre-action listener: _resource_record_pre_action 19:08:23 INFO - Running main action method: populate_webroot 19:08:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:08:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:08:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:08:23 INFO - '--tppagecycles', 19:08:23 INFO - '7'], 19:08:23 INFO - 'tests': ['tsvgm']}}, 19:08:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:08:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:08:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:08:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:08:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:08:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:08:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:23 INFO - 'talos_options': ['--disable-e10s'], 19:08:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:08:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:08:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:23 INFO - 'talos_options': ['--disable-e10s'], 19:08:23 INFO - 'tests': ['damp', 'tps']}, 19:08:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:23 INFO - 'tests': ['damp', 'tps']}, 19:08:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:08:23 INFO - 'tests': ['dromaeo_dom']}, 19:08:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:08:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:08:23 INFO - 'tests': ['a11yr', 19:08:23 INFO - 'ts_paint', 19:08:23 INFO - 'tpaint', 19:08:23 INFO - 'sessionrestore', 19:08:23 INFO - 'sessionrestore_no_auto_restore', 19:08:23 INFO - 'tabpaint']}, 19:08:23 INFO - 'other-e10s': {'tests': ['a11yr', 19:08:23 INFO - 'ts_paint', 19:08:23 INFO - 'tpaint', 19:08:23 INFO - 'sessionrestore', 19:08:23 INFO - 'sessionrestore_no_auto_restore', 19:08:23 INFO - 'tabpaint']}, 19:08:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:08:23 INFO - 'ts_paint', 19:08:23 INFO - 'tpaint', 19:08:23 INFO - 'sessionrestore', 19:08:23 INFO - 'sessionrestore_no_auto_restore', 19:08:23 INFO - 'tabpaint']}, 19:08:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:08:23 INFO - 'ts_paint', 19:08:23 INFO - 'tpaint', 19:08:23 INFO - 'sessionrestore', 19:08:23 INFO - 'sessionrestore_no_auto_restore', 19:08:23 INFO - 'tabpaint']}, 19:08:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:08:23 INFO - 'tests': ['a11yr', 19:08:23 INFO - 'ts_paint', 19:08:23 INFO - 'tpaint', 19:08:23 INFO - 'sessionrestore', 19:08:23 INFO - 'sessionrestore_no_auto_restore', 19:08:23 INFO - 'tabpaint']}, 19:08:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:08:23 INFO - 'tests': ['a11yr', 19:08:23 INFO - 'ts_paint', 19:08:23 INFO - 'tpaint', 19:08:23 INFO - 'sessionrestore', 19:08:23 INFO - 'sessionrestore_no_auto_restore', 19:08:23 INFO - 'tabpaint']}, 19:08:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:08:23 INFO - 'tests': ['tsvgx', 19:08:23 INFO - 'tsvgr_opacity', 19:08:23 INFO - 'tart', 19:08:23 INFO - 'tscrollx', 19:08:23 INFO - 'cart']}, 19:08:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:08:23 INFO - 'tsvgr_opacity', 19:08:23 INFO - 'tart', 19:08:23 INFO - 'tscrollx', 19:08:23 INFO - 'cart']}, 19:08:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:23 INFO - 'talos_options': ['--disable-e10s'], 19:08:23 INFO - 'tests': ['tp5o']}, 19:08:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:23 INFO - 'tests': ['tp5o']}, 19:08:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:23 INFO - 'talos_options': ['--disable-e10s', 19:08:23 INFO - '--xperf_path', 19:08:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:08:23 INFO - 'tests': ['tp5n']}, 19:08:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:23 INFO - 'talos_options': ['--xperf_path', 19:08:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:08:23 INFO - 'tests': ['tp5n']}}, 19:08:23 INFO - 'talos.zip': {'path': '', 19:08:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:08:23 INFO - Running post-action listener: _resource_record_post_action 19:08:23 INFO - ##### 19:08:23 INFO - ##### Running create-virtualenv step. 19:08:23 INFO - ##### 19:08:23 INFO - Running pre-action listener: _resource_record_pre_action 19:08:23 INFO - Running main action method: create_virtualenv 19:08:23 INFO - Creating virtualenv /builds/slave/test/build/venv 19:08:23 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 19:08:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:08:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:08:24 INFO - Using real prefix '/usr' 19:08:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:08:24 INFO - Installing distribute.............................................................................................................................................................................................done. 19:08:26 INFO - Installing pip.................done. 19:08:26 INFO - Return code: 0 19:08:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:08:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd76665af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c640>, '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 0x2c0d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c0d9d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1461712007.173771-80039984', '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 19:08:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:08:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:08:26 INFO - Using env: {'DISPLAY': ':0', 19:08:26 INFO - 'HOME': '/home/cltbld', 19:08:26 INFO - 'LANG': 'en_US.UTF-8', 19:08:26 INFO - 'LANGUAGE': 'en_US:en', 19:08:26 INFO - 'LOGNAME': 'cltbld', 19:08:26 INFO - 'MAIL': '/var/mail/cltbld', 19:08:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:26 INFO - 'MOZ_NO_REMOTE': '1', 19:08:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:26 INFO - 'NO_EM_RESTART': '1', 19:08:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:26 INFO - 'PWD': '/builds/slave/test', 19:08:26 INFO - 'SHELL': '/bin/bash', 19:08:26 INFO - 'SHLVL': '1', 19:08:26 INFO - 'TERM': 'linux', 19:08:26 INFO - 'TMOUT': '86400', 19:08:26 INFO - 'USER': 'cltbld', 19:08:26 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1461712007.173771-80039984', 19:08:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:26 INFO - '_': '/tools/buildbot/bin/python'} 19:08:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:26 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 19:08:26 INFO - Cleaning up... 19:08:26 INFO - Return code: 0 19:08:26 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:08:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd76665af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c640>, '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 0x2c0d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c0d9d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1461712007.173771-80039984', '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 19:08:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 19:08:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 19:08:26 INFO - Using env: {'DISPLAY': ':0', 19:08:26 INFO - 'HOME': '/home/cltbld', 19:08:26 INFO - 'LANG': 'en_US.UTF-8', 19:08:26 INFO - 'LANGUAGE': 'en_US:en', 19:08:26 INFO - 'LOGNAME': 'cltbld', 19:08:26 INFO - 'MAIL': '/var/mail/cltbld', 19:08:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:26 INFO - 'MOZ_NO_REMOTE': '1', 19:08:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:26 INFO - 'NO_EM_RESTART': '1', 19:08:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:26 INFO - 'PWD': '/builds/slave/test', 19:08:26 INFO - 'SHELL': '/bin/bash', 19:08:26 INFO - 'SHLVL': '1', 19:08:26 INFO - 'TERM': 'linux', 19:08:26 INFO - 'TMOUT': '86400', 19:08:26 INFO - 'USER': 'cltbld', 19:08:26 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1461712007.173771-80039984', 19:08:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:26 INFO - '_': '/tools/buildbot/bin/python'} 19:08:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:26 INFO - Downloading/unpacking psutil>=0.7.1 19:08:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:08:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:08:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:08:28 INFO - Installing collected packages: psutil 19:08:28 INFO - Running setup.py install for psutil 19:08:29 INFO - building 'psutil._psutil_linux' extension 19:08:29 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 19:08:29 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 19:08:29 INFO - building 'psutil._psutil_posix' extension 19:08:29 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 19:08:29 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 19:08:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:08:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:08:29 INFO - Successfully installed psutil 19:08:29 INFO - Cleaning up... 19:08:29 INFO - Return code: 0 19:08:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:08:29 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')]} 19:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:29 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')]} 19:08:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:29 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 0x7fd76665af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c640>, '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 0x2c0d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c0d9d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1461712007.173771-80039984', '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 19:08:29 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 19:08:29 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 19:08:29 INFO - Using env: {'DISPLAY': ':0', 19:08:29 INFO - 'HOME': '/home/cltbld', 19:08:29 INFO - 'LANG': 'en_US.UTF-8', 19:08:29 INFO - 'LANGUAGE': 'en_US:en', 19:08:29 INFO - 'LOGNAME': 'cltbld', 19:08:29 INFO - 'MAIL': '/var/mail/cltbld', 19:08:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:29 INFO - 'MOZ_NO_REMOTE': '1', 19:08:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:29 INFO - 'NO_EM_RESTART': '1', 19:08:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:29 INFO - 'PWD': '/builds/slave/test', 19:08:29 INFO - 'SHELL': '/bin/bash', 19:08:29 INFO - 'SHLVL': '1', 19:08:29 INFO - 'TERM': 'linux', 19:08:29 INFO - 'TMOUT': '86400', 19:08:29 INFO - 'USER': 'cltbld', 19:08:29 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1461712007.173771-80039984', 19:08:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:29 INFO - '_': '/tools/buildbot/bin/python'} 19:08:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:29 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:08:29 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 19:08:29 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 19:08:29 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 19:08:29 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 19:08:29 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 19:08:29 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 19:08:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:08:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:08:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:08:31 INFO - Installing collected packages: mozsystemmonitor 19:08:31 INFO - Running setup.py install for mozsystemmonitor 19:08:31 INFO - Successfully installed mozsystemmonitor 19:08:31 INFO - Cleaning up... 19:08:31 INFO - Return code: 0 19:08:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:08:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:31 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 0x7fd76665af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c640>, '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 0x2c0d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c0d9d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1461712007.173771-80039984', '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 19:08:31 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 19:08:31 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 19:08:31 INFO - Using env: {'DISPLAY': ':0', 19:08:31 INFO - 'HOME': '/home/cltbld', 19:08:31 INFO - 'LANG': 'en_US.UTF-8', 19:08:31 INFO - 'LANGUAGE': 'en_US:en', 19:08:31 INFO - 'LOGNAME': 'cltbld', 19:08:31 INFO - 'MAIL': '/var/mail/cltbld', 19:08:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:31 INFO - 'MOZ_NO_REMOTE': '1', 19:08:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:31 INFO - 'NO_EM_RESTART': '1', 19:08:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:31 INFO - 'PWD': '/builds/slave/test', 19:08:31 INFO - 'SHELL': '/bin/bash', 19:08:31 INFO - 'SHLVL': '1', 19:08:31 INFO - 'TERM': 'linux', 19:08:31 INFO - 'TMOUT': '86400', 19:08:31 INFO - 'USER': 'cltbld', 19:08:31 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1461712007.173771-80039984', 19:08:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:31 INFO - '_': '/tools/buildbot/bin/python'} 19:08:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:31 INFO - Downloading/unpacking blobuploader==1.2.4 19:08:31 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 19:08:31 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 19:08:31 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 19:08:31 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 19:08:31 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 19:08:31 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 19:08:33 INFO - Downloading blobuploader-1.2.4.tar.gz 19:08:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:08:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:08:33 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 19:08:33 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 19:08:33 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 19:08:33 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 19:08:33 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 19:08:33 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 19:08:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:08:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:08:34 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 19:08:34 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 19:08:34 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 19:08:34 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 19:08:34 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 19:08:34 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 19:08:34 INFO - Downloading docopt-0.6.1.tar.gz 19:08:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:08:34 INFO - Installing collected packages: blobuploader, requests, docopt 19:08:34 INFO - Running setup.py install for blobuploader 19:08:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:08:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:08:34 INFO - Running setup.py install for requests 19:08:35 INFO - Running setup.py install for docopt 19:08:35 INFO - Successfully installed blobuploader requests docopt 19:08:35 INFO - Cleaning up... 19:08:35 INFO - Return code: 0 19:08:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:08: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')]} 19:08:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08: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')]} 19:08:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:35 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 0x7fd76665af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c640>, '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 0x2c0d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c0d9d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1461712007.173771-80039984', '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 19:08:35 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 19:08:35 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 19:08:35 INFO - Using env: {'DISPLAY': ':0', 19:08:35 INFO - 'HOME': '/home/cltbld', 19:08:35 INFO - 'LANG': 'en_US.UTF-8', 19:08:35 INFO - 'LANGUAGE': 'en_US:en', 19:08:35 INFO - 'LOGNAME': 'cltbld', 19:08:35 INFO - 'MAIL': '/var/mail/cltbld', 19:08:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:35 INFO - 'MOZ_NO_REMOTE': '1', 19:08:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:35 INFO - 'NO_EM_RESTART': '1', 19:08:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:35 INFO - 'PWD': '/builds/slave/test', 19:08:35 INFO - 'SHELL': '/bin/bash', 19:08:35 INFO - 'SHLVL': '1', 19:08:35 INFO - 'TERM': 'linux', 19:08:35 INFO - 'TMOUT': '86400', 19:08:35 INFO - 'USER': 'cltbld', 19:08:35 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1461712007.173771-80039984', 19:08:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:35 INFO - '_': '/tools/buildbot/bin/python'} 19:08:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:08:35 INFO - Running setup.py (path:/tmp/pip-nE_Q2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:08:35 INFO - Running setup.py (path:/tmp/pip-ZE5AwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:08:35 INFO - Running setup.py (path:/tmp/pip-FVwFQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:08:35 INFO - Running setup.py (path:/tmp/pip-Ibi_uN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:08:35 INFO - Running setup.py (path:/tmp/pip-H1tNiQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:08:35 INFO - Running setup.py (path:/tmp/pip-tsfnjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:08:35 INFO - Running setup.py (path:/tmp/pip-kqka9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:08:35 INFO - Running setup.py (path:/tmp/pip-jualds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:08:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:08:36 INFO - Running setup.py (path:/tmp/pip-XC_YrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:08:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:08:36 INFO - Running setup.py (path:/tmp/pip-g7kuaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:08:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:08:36 INFO - Running setup.py (path:/tmp/pip-ae7jDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:08:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:08:36 INFO - Running setup.py (path:/tmp/pip-Ipv_yC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:08:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:08:36 INFO - Running setup.py (path:/tmp/pip-reOiYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:08:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:08:36 INFO - Running setup.py (path:/tmp/pip-dHdsqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:08:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:08:36 INFO - Running setup.py (path:/tmp/pip-cUpBHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:08:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:08:36 INFO - Running setup.py (path:/tmp/pip-Qspm4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:08:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:08:36 INFO - Running setup.py (path:/tmp/pip-HjluiX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:08:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:08:36 INFO - Running setup.py install for manifestparser 19:08:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:08:36 INFO - Running setup.py install for mozcrash 19:08:36 INFO - Running setup.py install for mozdebug 19:08:36 INFO - Running setup.py install for mozdevice 19:08:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:08:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:08:37 INFO - Running setup.py install for mozfile 19:08:37 INFO - Running setup.py install for mozhttpd 19:08:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:08:37 INFO - Running setup.py install for mozinfo 19:08:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:08:37 INFO - Running setup.py install for mozInstall 19:08:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:08:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:08:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:08:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:08:37 INFO - Running setup.py install for mozleak 19:08:37 INFO - Running setup.py install for mozlog 19:08:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:08:37 INFO - Running setup.py install for moznetwork 19:08:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:08:37 INFO - Running setup.py install for mozprocess 19:08:37 INFO - Running setup.py install for mozprofile 19:08:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:08:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:08:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:08:37 INFO - Running setup.py install for mozrunner 19:08:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:08:38 INFO - Running setup.py install for mozscreenshot 19:08:38 INFO - Running setup.py install for moztest 19:08:38 INFO - Running setup.py install for mozversion 19:08:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:08:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:08:38 INFO - Cleaning up... 19:08:38 INFO - Return code: 0 19:08:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:08:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:38 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 0x7fd76665af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c640>, '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 0x2c0d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c0d9d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1461712007.173771-80039984', '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 19:08:38 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 19:08:38 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 19:08:38 INFO - Using env: {'DISPLAY': ':0', 19:08:38 INFO - 'HOME': '/home/cltbld', 19:08:38 INFO - 'LANG': 'en_US.UTF-8', 19:08:38 INFO - 'LANGUAGE': 'en_US:en', 19:08:38 INFO - 'LOGNAME': 'cltbld', 19:08:38 INFO - 'MAIL': '/var/mail/cltbld', 19:08:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:38 INFO - 'MOZ_NO_REMOTE': '1', 19:08:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:38 INFO - 'NO_EM_RESTART': '1', 19:08:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:38 INFO - 'PWD': '/builds/slave/test', 19:08:38 INFO - 'SHELL': '/bin/bash', 19:08:38 INFO - 'SHLVL': '1', 19:08:38 INFO - 'TERM': 'linux', 19:08:38 INFO - 'TMOUT': '86400', 19:08:38 INFO - 'USER': 'cltbld', 19:08:38 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1461712007.173771-80039984', 19:08:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:38 INFO - '_': '/tools/buildbot/bin/python'} 19:08:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:08:38 INFO - Running setup.py (path:/tmp/pip-spDrSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:08:38 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)) 19:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:08:38 INFO - Running setup.py (path:/tmp/pip-7sO88n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:08:38 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)) 19:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:08:38 INFO - Running setup.py (path:/tmp/pip-IUS72u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:08:38 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)) 19:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:08:38 INFO - Running setup.py (path:/tmp/pip-R36kDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:08:38 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)) 19:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:08:38 INFO - Running setup.py (path:/tmp/pip-uq2fD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:08:39 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)) 19:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:08:39 INFO - Running setup.py (path:/tmp/pip-s5zH2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:08:39 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)) 19:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:08:39 INFO - Running setup.py (path:/tmp/pip-tjAonv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:08:39 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)) 19:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:08:39 INFO - Running setup.py (path:/tmp/pip-UP6RKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:08:39 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)) 19:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:08:39 INFO - Running setup.py (path:/tmp/pip-0fJtgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:08:39 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)) 19:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:08:39 INFO - Running setup.py (path:/tmp/pip-mHRH6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:08:39 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)) 19:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:08:39 INFO - Running setup.py (path:/tmp/pip-nlORtG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:08:39 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)) 19:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:08:39 INFO - Running setup.py (path:/tmp/pip-Bj2wgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:08:39 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)) 19:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:08:39 INFO - Running setup.py (path:/tmp/pip-PpVK4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:08:39 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)) 19:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:08:39 INFO - Running setup.py (path:/tmp/pip-2l93IF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:08:39 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)) 19:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:08:39 INFO - Running setup.py (path:/tmp/pip-z7pkN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:08:39 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)) 19:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:08:39 INFO - Running setup.py (path:/tmp/pip-D6tn9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:08:39 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)) 19:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:08:39 INFO - Running setup.py (path:/tmp/pip-3i9Lku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:08:39 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)) 19:08:39 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)) 19:08:39 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)) 19:08:39 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)) 19:08:39 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)) 19:08:39 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)) 19:08:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:08:39 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 19:08:39 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 19:08:39 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 19:08:39 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 19:08:39 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 19:08:39 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 19:08:41 INFO - Downloading blessings-1.6.tar.gz 19:08:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:08:41 INFO - Installing collected packages: blessings 19:08:41 INFO - Running setup.py install for blessings 19:08:41 INFO - Successfully installed blessings 19:08:41 INFO - Cleaning up... 19:08:42 INFO - Return code: 0 19:08:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:08:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:08:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:08:42 INFO - Reading from file tmpfile_stdout 19:08:42 INFO - Current package versions: 19:08:42 INFO - argparse == 1.2.1 19:08:42 INFO - blessings == 1.6 19:08:42 INFO - blobuploader == 1.2.4 19:08:42 INFO - docopt == 0.6.1 19:08:42 INFO - manifestparser == 1.1 19:08:42 INFO - mozInstall == 1.12 19:08:42 INFO - mozcrash == 0.17 19:08:42 INFO - mozdebug == 0.1 19:08:42 INFO - mozdevice == 0.48 19:08:42 INFO - mozfile == 1.2 19:08:42 INFO - mozhttpd == 0.7 19:08:42 INFO - mozinfo == 0.9 19:08:42 INFO - mozleak == 0.1 19:08:42 INFO - mozlog == 3.1 19:08:42 INFO - moznetwork == 0.27 19:08:42 INFO - mozprocess == 0.22 19:08:42 INFO - mozprofile == 0.28 19:08:42 INFO - mozrunner == 6.11 19:08:42 INFO - mozscreenshot == 0.1 19:08:42 INFO - mozsystemmonitor == 0.0 19:08:42 INFO - moztest == 0.7 19:08:42 INFO - mozversion == 1.4 19:08:42 INFO - psutil == 3.1.1 19:08:42 INFO - requests == 1.2.3 19:08:42 INFO - wsgiref == 0.1.2 19:08:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:08:42 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')]} 19:08:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:42 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')]} 19:08:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:42 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 0x7fd76665af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c640>, '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 0x2c0d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c0d9d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1461712007.173771-80039984', '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 19:08:42 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 19:08:42 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 19:08:42 INFO - Using env: {'DISPLAY': ':0', 19:08:42 INFO - 'HOME': '/home/cltbld', 19:08:42 INFO - 'LANG': 'en_US.UTF-8', 19:08:42 INFO - 'LANGUAGE': 'en_US:en', 19:08:42 INFO - 'LOGNAME': 'cltbld', 19:08:42 INFO - 'MAIL': '/var/mail/cltbld', 19:08:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:42 INFO - 'MOZ_NO_REMOTE': '1', 19:08:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:42 INFO - 'NO_EM_RESTART': '1', 19:08:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:42 INFO - 'PWD': '/builds/slave/test', 19:08:42 INFO - 'SHELL': '/bin/bash', 19:08:42 INFO - 'SHLVL': '1', 19:08:42 INFO - 'TERM': 'linux', 19:08:42 INFO - 'TMOUT': '86400', 19:08:42 INFO - 'USER': 'cltbld', 19:08:42 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1461712007.173771-80039984', 19:08:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:42 INFO - '_': '/tools/buildbot/bin/python'} 19:08:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:42 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)) 19:08:42 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)) 19:08:42 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)) 19:08:42 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)) 19:08:42 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)) 19:08:42 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)) 19:08:42 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)) 19:08:42 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)) 19:08:42 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)) 19:08:42 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)) 19:08:42 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)) 19:08:42 INFO - Cleaning up... 19:08:42 INFO - Return code: 0 19:08:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:08:42 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')]} 19:08:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:42 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')]} 19:08:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:42 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 0x7fd76665af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c640>, '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 0x2c0d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c0d9d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1461712007.173771-80039984', '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 19:08:42 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 19:08:42 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 19:08:42 INFO - Using env: {'DISPLAY': ':0', 19:08:42 INFO - 'HOME': '/home/cltbld', 19:08:42 INFO - 'LANG': 'en_US.UTF-8', 19:08:42 INFO - 'LANGUAGE': 'en_US:en', 19:08:42 INFO - 'LOGNAME': 'cltbld', 19:08:42 INFO - 'MAIL': '/var/mail/cltbld', 19:08:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:42 INFO - 'MOZ_NO_REMOTE': '1', 19:08:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:42 INFO - 'NO_EM_RESTART': '1', 19:08:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:42 INFO - 'PWD': '/builds/slave/test', 19:08:42 INFO - 'SHELL': '/bin/bash', 19:08:42 INFO - 'SHLVL': '1', 19:08:42 INFO - 'TERM': 'linux', 19:08:42 INFO - 'TMOUT': '86400', 19:08:42 INFO - 'USER': 'cltbld', 19:08:42 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1461712007.173771-80039984', 19:08:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:42 INFO - '_': '/tools/buildbot/bin/python'} 19:08:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:42 INFO - Downloading/unpacking jsonschema 19:08:42 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 19:08:42 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 19:08:42 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 19:08:42 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 19:08:42 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 19:08:42 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 19:08:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:08:44 INFO - Downloading/unpacking functools32 (from jsonschema) 19:08:44 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 19:08:44 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 19:08:44 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 19:08:44 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 19:08:44 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 19:08:44 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 19:08:44 INFO - Downloading functools32-3.2.3-2.tar.gz 19:08:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:08:44 INFO - warning: no files found matching '*.txt' 19:08:44 INFO - no previously-included directories found matching 'build' 19:08:44 INFO - no previously-included directories found matching 'dist' 19:08:44 INFO - no previously-included directories found matching '.git*' 19:08:44 INFO - Installing collected packages: jsonschema, functools32 19:08:44 INFO - Running setup.py install for functools32 19:08:44 INFO - warning: no files found matching '*.txt' 19:08:44 INFO - no previously-included directories found matching 'build' 19:08:44 INFO - no previously-included directories found matching 'dist' 19:08:44 INFO - no previously-included directories found matching '.git*' 19:08:44 INFO - Successfully installed jsonschema functools32 19:08:44 INFO - Cleaning up... 19:08:45 INFO - Return code: 0 19:08:45 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:08: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')]} 19:08:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08: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')]} 19:08:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd76665af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c640>, '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 0x2c0d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c0d9d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1461712007.173771-80039984', '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 19:08: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', 'flake8'] in /builds/slave/test/build 19:08: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 flake8 19:08:45 INFO - Using env: {'DISPLAY': ':0', 19:08:45 INFO - 'HOME': '/home/cltbld', 19:08:45 INFO - 'LANG': 'en_US.UTF-8', 19:08:45 INFO - 'LANGUAGE': 'en_US:en', 19:08:45 INFO - 'LOGNAME': 'cltbld', 19:08:45 INFO - 'MAIL': '/var/mail/cltbld', 19:08:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:45 INFO - 'MOZ_NO_REMOTE': '1', 19:08:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:45 INFO - 'NO_EM_RESTART': '1', 19:08:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:45 INFO - 'PWD': '/builds/slave/test', 19:08:45 INFO - 'SHELL': '/bin/bash', 19:08:45 INFO - 'SHLVL': '1', 19:08:45 INFO - 'TERM': 'linux', 19:08:45 INFO - 'TMOUT': '86400', 19:08:45 INFO - 'USER': 'cltbld', 19:08:45 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1461712007.173771-80039984', 19:08:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:45 INFO - '_': '/tools/buildbot/bin/python'} 19:08:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:45 INFO - Downloading/unpacking flake8 19:08: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 19:08: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 19:08: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 19:08: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 19:08: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 19:08: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 19:08:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:08:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:08: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 19:08: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 19:08: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 19:08: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 19:08: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 19:08: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 19:08:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:08:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:08: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 19:08: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 19:08: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 19:08: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 19:08: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 19:08: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 19:08:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:08: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 19:08: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 19:08: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 19:08: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 19:08: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 19:08: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 19:08:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:08:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:08:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:08:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:08:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:08:47 INFO - no previously-included directories found matching 'docs/_build' 19:08:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:08:47 INFO - Running setup.py install for pep8 19:08:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:08:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:08:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:08:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:08:47 INFO - no previously-included directories found matching 'docs/_build' 19:08:47 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:08:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:08:47 INFO - Cleaning up... 19:08:48 INFO - Return code: 0 19:08:48 INFO - Running post-action listener: _resource_record_post_action 19:08:48 INFO - Running post-action listener: _start_resource_monitoring 19:08:48 INFO - Starting resource monitoring. 19:08:48 INFO - ##### 19:08:48 INFO - ##### Running install step. 19:08:48 INFO - ##### 19:08:48 INFO - Running pre-action listener: _resource_record_pre_action 19:08:48 INFO - Running main action method: install 19:08:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:08:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:08:48 INFO - Reading from file tmpfile_stdout 19:08:48 INFO - Detecting whether we're running mozinstall >=1.0... 19:08:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:08:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:08:48 INFO - Reading from file tmpfile_stdout 19:08:48 INFO - Output received: 19:08:48 INFO - Usage: mozinstall [options] installer 19:08:48 INFO - Options: 19:08:48 INFO - -h, --help show this help message and exit 19:08:48 INFO - -d DEST, --destination=DEST 19:08:48 INFO - Directory to install application into. [default: 19:08:48 INFO - "/builds/slave/test"] 19:08:48 INFO - --app=APP Application being installed. [default: firefox] 19:08:48 INFO - mkdir: /builds/slave/test/build/application 19:08:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:08:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:09:04 INFO - Reading from file tmpfile_stdout 19:09:04 INFO - Output received: 19:09:04 INFO - /builds/slave/test/build/application/firefox/firefox 19:09:04 INFO - Running post-action listener: _resource_record_post_action 19:09:04 INFO - ##### 19:09:04 INFO - ##### Running run-tests step. 19:09:04 INFO - ##### 19:09:04 INFO - Running pre-action listener: _resource_record_pre_action 19:09:04 INFO - Running main action method: run_tests 19:09:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:09:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:09:04 INFO - Python 2.7.3 19:09:04 INFO - Return code: 0 19:09:04 INFO - grabbing minidump binary from tooltool 19:09:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:04 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 0x2c0c640>, '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 0x2c0d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c0d9d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:09:04 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 19:09:04 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 19:09:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:09:05 INFO - Return code: 0 19:09:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:09:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:09:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:09:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:09:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:09:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:09:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:09:05 INFO - Return code: 0 19:09:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eabI_t4BQVCpnXivflvv2g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 19:09:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eabI_t4BQVCpnXivflvv2g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:09:05 INFO - Using env: {'DISPLAY': ':0', 19:09:05 INFO - 'HOME': '/home/cltbld', 19:09:05 INFO - 'LANG': 'en_US.UTF-8', 19:09:05 INFO - 'LANGUAGE': 'en_US:en', 19:09:05 INFO - 'LOGNAME': 'cltbld', 19:09:05 INFO - 'MAIL': '/var/mail/cltbld', 19:09:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:09:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:09:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:05 INFO - 'MOZ_NO_REMOTE': '1', 19:09:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:09:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:05 INFO - 'NO_EM_RESTART': '1', 19:09:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:05 INFO - 'PWD': '/builds/slave/test', 19:09:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:09:05 INFO - 'SHELL': '/bin/bash', 19:09:05 INFO - 'SHLVL': '1', 19:09:05 INFO - 'TERM': 'linux', 19:09:05 INFO - 'TMOUT': '86400', 19:09:05 INFO - 'USER': 'cltbld', 19:09:05 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1461712007.173771-80039984', 19:09:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:05 INFO - '_': '/tools/buildbot/bin/python'} 19:09:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eabI_t4BQVCpnXivflvv2g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:09:06 INFO - mozversion application_buildid: 20160426163015 19:09:06 INFO - mozversion application_changeset: 52072b6bec1416578615ec73027eb80a65d3fcd4 19:09:06 INFO - mozversion application_display_name: Nightly 19:09:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:09:06 INFO - mozversion application_name: Firefox 19:09:06 INFO - mozversion application_remotingname: firefox 19:09:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:09:06 INFO - mozversion application_vendor: Mozilla 19:09:06 INFO - mozversion application_version: 49.0a1 19:09:06 INFO - mozversion platform_buildid: 20160426163015 19:09:06 INFO - mozversion platform_changeset: 52072b6bec1416578615ec73027eb80a65d3fcd4 19:09:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:09:06 INFO - mozversion platform_version: 49.0a1 19:09:06 INFO - using testdate: 1461722946 19:09:06 INFO - actual date: 1461722946 19:09:06 INFO - starting webserver on 'localhost:41715' 19:09:06 INFO - SUITE-START | Running 2 tests 19:09:06 INFO - TEST-START | dromaeo_css 19:09:06 INFO - operating with platform_type : linux_ 19:09:06 INFO - Initialising browser for dromaeo_css test... 19:09:06 INFO - TEST-INFO | started process 1409 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjkC1Kj/profile http://localhost:41715/getInfo.html) 19:09:10 INFO - PROCESS | 1409 | 19:09:10 INFO - PROCESS | 1409 | (process:1476): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:09:10 INFO - PROCESS | 1409 | __metrics Screen width/height:1600/1200 19:09:10 INFO - PROCESS | 1409 | colorDepth:24 19:09:10 INFO - PROCESS | 1409 | Browser inner width/height: 1024/697 19:09:10 INFO - PROCESS | 1409 | __metrics 19:09:11 ERROR - PROCESS | 1409 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 19:09:12 INFO - TEST-INFO | 1409: exit 0 19:09:12 INFO - Browser initialized. 19:09:12 INFO - Running cycle 1/1 for dromaeo_css test... 19:09:12 INFO - TEST-INFO | started process 1527 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjkC1Kj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:09:14 INFO - PROCESS | 1527 | 19:09:14 INFO - PROCESS | 1527 | (process:1590): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:09:24 INFO - PROCESS | 1527 | RSS: Main: 165146624 19:09:24 INFO - PROCESS | 1527 | 19:10:13 INFO - PROCESS | 1527 | 1461723013863 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] 19:12:21 INFO - PROCESS | 1527 | Cycle 1(1): loaded http://localhost:41715/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41715/tests/dromaeo/cssquery-ext.html) 19:12:22 INFO - PROCESS | 1527 | RSS: Main: 169312256 19:12:22 INFO - PROCESS | 1527 | 19:15:24 INFO - PROCESS | 1527 | Cycle 1(1): loaded http://localhost:41715/tests/dromaeo/cssquery-ext.html (next: http://localhost:41715/tests/dromaeo/cssquery-jquery.html) 19:15:25 INFO - PROCESS | 1527 | RSS: Main: 167829504 19:15:25 INFO - PROCESS | 1527 | 19:18:27 INFO - PROCESS | 1527 | Cycle 1(1): loaded http://localhost:41715/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41715/tests/dromaeo/cssquery-mootools.html) 19:18:27 INFO - PROCESS | 1527 | RSS: Main: 168210432 19:18:27 INFO - PROCESS | 1527 | 19:21:29 INFO - PROCESS | 1527 | Cycle 1(1): loaded http://localhost:41715/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41715/tests/dromaeo/cssquery-prototype.html) 19:21:30 INFO - PROCESS | 1527 | RSS: Main: 166084608 19:21:30 INFO - PROCESS | 1527 | 19:24:32 INFO - PROCESS | 1527 | Cycle 1(1): loaded http://localhost:41715/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41715/tests/dromaeo/cssquery-yui.html) 19:24:33 INFO - PROCESS | 1527 | RSS: Main: 167137280 19:24:33 INFO - PROCESS | 1527 | 19:27:35 INFO - PROCESS | 1527 | Cycle 1(1): loaded http://localhost:41715/tests/dromaeo/cssquery-yui.html (next: http://localhost:41715/tests/dromaeo/cssquery-dojo.html) 19:27:35 INFO - PROCESS | 1527 | RSS: Main: 169103360 19:27:35 INFO - PROCESS | 1527 | 19:27:35 INFO - PROCESS | 1527 | __start_tp_report 19:27:35 INFO - PROCESS | 1527 | _x_x_mozilla_page_load 19:27:35 INFO - PROCESS | 1527 | _x_x_mozilla_page_load_details 19:27:35 INFO - PROCESS | 1527 | |i|pagename|runs| 19:27:35 INFO - PROCESS | 1527 | |0;dojo.html;3155.731762800162;3204.7916885402446;3213.6464988851208;3242.448783706768;3251.122197006808;5465.2895123633925;5468.808591699286;5474.315710536183;5474.39781624022;5494.5054945054935;5345.064613692608;5422.267993820833;5456.0997435423205;5515.117581187011;5596.944030559694;4881.389826271716;4915.8525244242555;4975.27858460523;4977.527134922177;5029.9748501257445;927.1731246803862;4932.654714170009;4956.529129732669;4977.054359671669;5018.723970181639;4942;4955.355803745508;4957.529034741694;4963.404391473028;4991.550760431579;4804.903901921977;4995.375578052744;5022.045811295842;5065.341505604248;5105.770240339194;4849.4908034656555;4874.073925954058;4877.512248775094;4881.4630390657;4913.796119950635;5412.91880621791;5428.565714742811;5436.864078398072;5455.236266922634;5481.5340696040885;5700.800471983461;5778.0466223073145;5886.087656413263;5904.704764761745;5914.585978981473;5858.970705146489;5867.8533036674;5880.852978675524;5883.17635531026;5904.704764761745;5516.365617953947;5523.1163013917985;5526.696031718254;5537.975474537224;5539.446055394428;5852.326982396994;5913.940860591425;5918.378570250148;5963.493103086286;6009;5569.888602228014;5574.749136288796;5582.27430434041;5599.272094627754;5627.268455100811;5664.150377443417;5664.405237450091;5665.036943719495;5703.600747947687;5708.4862362387585;5696.943030569724;5726.799562015392;5729.369769325371;5798.33319168301;5799.565032622486;5687.374388817227;5812.883742325214;5841.299044114733;5870.853228669232;5946.70266486674;4387.3857659927635;4395.846145384896;4435.800388982503;4446.62203712688;4479.081788233404;3891.9221615568094;3897.279003384383;3927.4501569780255;3965.107850733562;4008.599140085968;5645.01212287848;5668.206451096849;5670.121131224667;5686.914696279559;5713.342965559014;5873.030949893306;5892.587518873724;5938.2280303560265;5966.164736936832;5978.521718262528;5401.540869026098;5554.416786237468;5625.184348269478;5650.576206784508;5691.886162276731;4919.06537757832;4937.0372777308085;4939.5554400104165;4941.2835138905375;4964;5999.551155773813;6017.338092809788;6029.758809647653;6034.6982650867285;6056.06131049688;5788.710564471844;5849.678267695147;5852.590318677737;5907.49786268172;5960.701964901651;6074.483668888017;6097.359777223328;6111.297200821962;6122.663253521099;6125.754969801158;5799.768009279582;5817.883642327214;5821.94178058231;5823.563232757645;5831.70841457917;5789.2184555086205;5946.762129514771;6004.519638429003;6036.7585296589405;6062.939370606414;5704.458076482728;5707.4577915098;5723.6851973141875;5744;5746.942530574641;5620.297462817148;5715.599908006399;5725.570582206268;5730.226419433323;5733.254676891977;5583.385827559046;5593.776248949996;5601.187827765033;5646.463585959327;5703.857403564944;5773.191753154478;5806.44838740319;5815.738291776795;5816.912746308724;5821.94178058214;5497.587680924026;5648.85877853057;5658.830235092953;5661.631993920382;5665.603407761417 19:27:35 INFO - PROCESS | 1527 | |1;ext.html;598.7006496751624;638.1640051532496;655.6262930129826;659.498780926496;664.3257094049541;29986.400271994546;36889.63110368899;37444.62555374445;37537.24925501488;37768.81115594422;38205;38838;39063;39134.608653913456;39191.41212881802;8418.536980466071;8627.22354988051;8631.65473381064;8652.091530389313;8663.220310172082;8485;8622.78443038926;8665.653373865038;8689.826203475926;8790.120987901191;8871.11288871111;8914.375993680445;8968.686095986643;8971.685990990283;8973.596188171548;8802.955985220096;8803.77990550235;8884.067172946812;8893.644254229823;8897.421667591618;8593.871091933626;8694.652213911437;8701.434406763603;8704.738857834274;8710.041895391565;38264.234715305814;38741.22517549633;38766.61233387687;38803.41794873079;38869.41695874564;3545.5213546171194;3712.9071773205615;3836.4437156612134;4038.515378154611;4293.785310734451;28745.42509149805;30584.8470757647;30643.893801788512;30937;31905.52141717876;4219.9578004219875;4231.61915427613;4303.33298338758;4327.156204540116;4328.913421731548;230413;232792;234626;234659.82670086712;235123;32517.349653006808;57539.972201945464;58852;58957.809430010086;59025.40974590285;33131;33217.667823321455;33286.50070248948;33305.50041749376;33464.665353346645;14823.40706371733;14895.404183832525;15037.924810375878;15119.773203401957;15148;12633.494660213488;12721.93639031799;12751.489940402465;12777.808332874829;12825.294608796607;8177.427580069457;8286.70996515119;8330.79203515499;8334.6666133354;8351;3258.4297747894025;3296.8846090386724;3311.2715202655377;3336.4494858348585;3343.715784158374;1098.555085190499;1123.730304726876;1132;1153.2993308875461;1157.1263695909702;29469.26326841803;29809.25476863096;29926.70073299239;30318.54522182169;30469.23826904301;1142.9199956003167;1170.5142365918218;1172.4958267944694;1211.2429731417865;1211.8424604801319;16061.875668703313;16408.179591020402;16562.50312490627;16623.91688041552;16635.001899885803;319415;321776;321815;321937;333354;55088.72455637696;55458.44541554533;55921.44078559244;55963;56361;1395.1001603965385;1481.0669278354567;1484.64368551549;1490.344248530643;1495.5662857771124;30048;31112.84443577858;31217.375652487277;31236.531452028692;31589.8420507896;49396;49819.25271121009;50005;50280.74859625679;50343.49656503388;294831;295411;295929;296210;296648;27731.722682772914;38023.62728286283;38625.2274954505;39104;39358;45087.54912450833;45345.54654453545;45717.54282457133;46620.300695490274;47491.525084750094;37513.2497350046;37764.05589860275;38441.42337864878;38618;39390;41162.176756465306;41194.794026029675;41486.1702765949;41678.79160604178;42556.148877022904;41271;41376.79311603423;42476;42716.572834272505;42786.35820462758;36770.816145919096;37210.441843372915;37313.81343093267;37435.62564374322;37965.81017094897;28258.304501729963;28509.572356414257;28847.85576072106;29001.7099828999;29266.853665731534 19:27:35 INFO - PROCESS | 1527 | |2;jquery.html;393.26852055177363;393.6240889950098;396.32426712455265;400.7815740421471;413.07883419973456;16724.83275167248;16793.748093778602;17237.310507579696;17362.91318543407;17900.37348692796;17023.40418085367;17251.396201132964;17318.82681173188;17792.288308467647;18526.351577694782;5393.973030134864;5442.863928401792;5580.107182850745;5616.045272303698;5628.212050312959;5568.777248910039;5580.553555715554;5596.328440587135;5606.103023516238;5627.437256274381;3876.8061596920043;5347.652402593839;5486.259354987065;5515.117581187011;5568.86077848055;5490.423505531901;5538.6399884007615;5554.361248456439;5559.416261292567;5563.165525171216;4774.16452120881;4958.181899986498;4960.975195124038;4965.3048573199785;4998.750062496861;14677.339519721638;14808.851911480962;21073.26243581467;21178.576428471497;21389.465263368384;2419.733829278778;2430.4774473488283;2482.404222986488;2485.825992180548;2762.9915080995493;9115.954420227856;9776.022397760238;13599.456021759117;13771.242581658005;14057.437702491889;1918.7793403758608;1922.4136638325306;1944.8930308833008;1995.1221462556573;2021.787712290203;48864.51135488635;62281.688591557206;65045.67477162631;65264.673676631784;71228.28771712269;10009.899901000897;10092.697219083439;10288.331258468175;10291.559181714565;10555.525001374957;13966.86033139676;14041;14071.085379450507;14176.432942682177;14251.144931303948;7649.617519124133;7964;7974.122846486882;8016.158303378178;8102;7874.448788584744;7901.2888840003525;8071.636776345079;8102.83794324122;8109.635066422025;4497;4502.234620114588;4545.204589196877;4601.539846015372;4626.976865115653;1864.4499872537363;1891.9810801892081;1901.8193271639173;1916.1090093106773;1928.5853541488366;917.5916717060844;1002.4336250018716;1015.619142821442;1052.084686322904;1130.1749722702473;17734.20196091179;17874.55313617144;18380.816191838177;18384.17271222798;18556.628867422845;1062.914966802654;1066.5200659703164;1092.1044743310567;1119.3955264157428;1129.0685184722636;10447.373157610567;10492.370457772558;10680.305780124267;10728.946355268174;10823.242373033969;456989;458801;488686;491252;498554;59604.70197649071;85343;85846.57076714576;86020.56989715136;86138;1059.5073290919759;1094.5129417409335;1096.1614365010773;1101.8347247912716;1123.6516679829115;16558.337666493204;16665.3333866644;16897.83102169012;17146.914265428593;17399.13004349803;35068.64931350654;36030.63969360273;36335.81832090823;37610.2477950434;38141.4278785824;47178.29232561446;47433.52566474291;47525;48201.517984821105;48370.51629483801;7981.361491080584;8117.1071182168735;8174;8350.87473687883;8397.740338949206;9205.86191207119;10072;12488.625341239778;12910.870891290966;13009.739805203653;11419.31484110956;11490.827637585277;11536.480858361227;11613.419329033684;11655.708607284885;11101.278416902875;11138.443077845914;11279.15406344511;11280.153988450735;11479.196456248317;11491.195616306779;11695.649130526097;11738.0609551234;11885;11912.225705329125;8175.79560510992;8251.752447426587;8497.320214382959;8497.447665901696;8551.102134275812;10862.65477392683;11773.587924422603;11801.704957376134;11974.760504790029;11982.442282503218 19:27:35 INFO - PROCESS | 1527 | |3;mootools.html;1518.8633023027928;1565.585119943215;1715.11671489183;1790.2570433270193;1852.5646473078832;7495.925040749591;7792.298693117618;7895.960520197391;8051.597420128992;8082.838343233139;7894;7980.640871160797;8030.9196908031045;8050.154733752959;8055.677772889092;2279.4415368234763;2307.6077066898583;2309.896054677535;2325.662778897059;2330.976690233093;2247.640377539594;2272.943176420586;2281.292799232235;2294.8737819419925;2302.3783578433813;2325.046730840356;2333.6616190652344;2335.4044718596733;2381.654365283618;2395.520895820834;2330.463993281555;2340.8829558522093;2344.449054472206;2353.305774796431;2370.6799582056374;2311.66480860276;2312.6184179610514;2315.455867871049;2317.385892738426;2321.6633588129625;8104.6758129674745;8187.79530511736;8191.139930307351;8195.016598008218;8244.752657420288;4881.194602890519;5067.594592432633;5074.416442109131;5094.363204599425;5095.031943930679;3304.074859039473;3385.460904321759;3430.776999495025;3448.9655103448895;3494.8427320770625;1151;1158.137187795098;1195.6771671648605;1199.7960346741074;1214.5607455165657;10398;10681.519331630096;10696.518656660392;10706.464676766209;10728.570857165703;4448.243798554254;4498.122866041091;4521.253993091169;4544.227481328182;4549.499555048942;9199.586018629045;9227.815443691223;9230.400023998418;9234.215091717146;9241;4975.601951843843;5019.67372120811;5067.467915868854;5067.873303167376;5073.416557095981;4238.788060596958;4585.633149348044;4604.930926036112;4750.501197374226;4760.59534939534;3883.8058097095595;3926.096997690547;3992.86024989124;4025.8590949317218;4043.9191216175514;1272.6436597752645;1297.7274772297924;1307.6600083978044;1320.2012782266781;1326.8474125475693;1000.8598796168542;1006.5822683586376;1011.8684571005722;1012.9189664826796;1025.5128813813528;5671.2060311556415;5977.67122808241;6050.394960503914;6057.303410107806;6161;447.085709723616;451.62515112456583;458.6033081384578;463.2102265637081;467.53246753246754;4185.079282557833;4225.260579398593;4240.363945408152;4254.829806807755;4263.2752432086;9969.451680157661;10325.225608079274;10409.5836166554;10446.582136714447;10476.63331783384;10209.9489502552;10224.693259202088;10228.897711022943;10239.641612543524;10322.329048611817;7393.408527317802;7895.2499512547365;7896.091949425775;7911.762647120596;7982.521048736979;5818.8254352369495;5842.678652673973;5859.2382990211;5931.347551769216;5951.047832346804;8901.243394311556;8903.910960890309;8993.190612844875;9114.726558203265;9140.040295769115;9143.26853851677;9150.77123071902;9201.401908875901;9215.354925155174;9268.768280793034;6830.658467076726;6991;7102.218755936946;7253.891191632024;7264.636768161677;8040.83918321642;8043.557604331584;8063.677452902053;8098.595070246582;8129.268365847102;7062;7175.497715159889;7221.711131554679;7262.600556969206;7293.416526677959;7331.41348692114;7358.080239970004;7411.2588741125455;7421.480496365419;7430.588188244216;6919.51230485448;6941.271166527442;6991;7023.192332881784;7034.366906978396;5156.355455568054;5185.299984502044;5206.609504287269;5314.734263286898;5320.068987927175;5193.68837869729;5252.501012403815;5363.195520671774;5386.919196211981;5404.7297635118875 19:27:35 INFO - PROCESS | 1527 | |4;prototype.html;330.45639922327774;331.4597206553318;338.56156277620477;338.7019422907841;339.0946173716177;5378.24704541364;5513.586481013925;5545.944540554593;5546.916796248054;5547.278853749007;5439.673619582828;5441.2654291670615;5476.151196564529;5483.835484935448;5503.504684578387;4010.278149933011;4101.876943691694;4204.915901681965;4228.619424251817;4251.97874010631;4239.342901850203;4245.516372921845;4250.703535421695;4257.8296868125235;4276.315789473685;4224.640905523034;4228.577142285762;4228.661707063443;4238.470191226097;4247.575242475743;3904.004478857887;4173.457450531442;4188.434561334211;4203.55862634422;4245.957540424587;3639.70882329413;3658.6158453362546;3660.524131862841;3670.1925576373155;3673.94489082664;5317.229001794757;5330.320948901122;5332.893342133174;5333.679979201222;5378.650387724824;4576.679632425731;4824.734639594821;4852.8544143675745;4860.659753817235;4882.609391248727;5709.885802283972;5733.598648094635;5749.655020698771;5750.769969201227;5805.158252053428;4032.3749818778138;4044.797760111983;4049.291374009566;4054.878353649395;4055.71609987301;5891.322497912752;5910.497607703351;5931.228940237742;5934.792282270143;5970.373110823388;4136.81465271739;4143.047099167208;4150.439690641785;4162.146759914211;4178.310578754532;4232.894177645583;4234.7670878102;4241.936370954438;4249.745015299092;4258.914821703549;4721.858344249678;4866.902661946812;4877.756112194376;4888.120138375127;4904.288878112725;5808.564357673192;5831.504322132581;5837.270341207349;5871.911921321183;5874;1529.2200977501332;1536.185821514599;1545.4281915691265;1552;1558.306553583667;937.7664109121921;966.7003228998892;1017.6946915925192;1018.5314755212685;1031.0359813574332;5793.710314484259;5841.94158058414;5846;5855.970720146372;5922;6315.684215789192;6336.714847831859;6363.1864918498;6367.745290188341;6403.64779937108;5824.504917082011;5878.970605146947;5889.9692553802915;5904.350521442638;5910.497607703307;3386;3408.471686888536;3414.112330793962;3421.401254780453;3427.7943323400677;6388.936110638927;6474.223093228843;6500.4799616030605;6515.348465153446;6554.80335589933;6390.456811171102;6396.680165991775;6405.48756099511;6409.166808314889;6444.516661250331;6313.368663133741;6437.163168788027;6461;6490.967545162244;6575.619119984857;6305.369463053658;6334.714937827901;6357;6363.5227357947415;6368.87262254743;6095.9390406097145;6280.461286984718;6290.9056364155485;6300.117983482224;6310.6213627182515;6497.935020649922;6541.836454088686;6549.4760419167305;6558.376954189535;6575.53971222029;4323.935140972825;4337.436133302651;4352.455943007124;4357.237483440449;4371.540988196193;6162.691865406622;6258;6305.464035557029;6345.270293916259;6362.936370636235;6137.716321767833;6140.109684095871;6146.985747351816;6151.5386346025125;6154.415145638753;5992.340842507408;6143.784967526115;6146.323904370605;6171.537134714825;6184.845378865564;5442.346918369821;5597.272354593877;5757.65454072757;6066.484348830399;6091.269047714125;5861.915545624073;5885.55858310637;5889.175515427758;5901.7639294427745;5916.73374698131;5475.589330800286;5688.886222275614;5729.971350143389;5746.712664366849;5769.451902069297 19:27:35 INFO - PROCESS | 1527 | |5;yui.html;805.8952336196301;842.5787106446777;847.9279261262797;865.8917635295588;888.5290795878183;14038.508652197175;14064.929675351634;14108.365123569438;14129.64675883102;15019.849801501981;14584.635384115403;14604.488842890501;14625.414983400651;14745.115293082423;14759.335829887654;799.7720649614861;804.4891493901386;804.9919500805005;817.3216230528647;820.6758330459465;820.4502983001404;823.1439303124743;827.3298628111219;827.7516744976513;829.9626516806758;860.853654878669;863.1411745313422;863.3222920007795;863.8013256950906;865;854.4189950833431;856.7858035491096;859.0807835615893;859.1537335724306;864.2999170671744;623.3392603839944;627.244170774216;628.1676778268812;631.643121636274;633.0377825704903;14161.504347347793;14180.574582762534;14218.786718199235;14280.357383917748;14292.356843942047;12876;13039.674008149777;13422.86577134226;13460.326983650877;13501.324933753272;11359;11480.138989575815;11562.53749850005;11724.355160466257;11796.882031179664;3664.633536646314;3713.6472035156617;3719.1445967427644;3777.565579958285;3817.8472861085525;60901.39098609002;60953.39046609522;61472.07791883081;62112.68943655298;62214.68892655508;11127.276727012719;11139.498722557504;11161.162912781574;11322.207445478902;11410.087193024538;20021.599568008558;20052.89973550123;20094.49763755918;20150;20463.18147274122;8275.379346549033;8307.584620769057;8362.54006029662;8388.203120703523;8388.958055209685;4693.155232058194;4750;4825.445073816486;4855.878603034882;4885.364902562644;3283.753718471124;3345.063382252973;3353.0108617957762;3357.3453176630323;3357.362101200764;609.8658295175143;617.9938200617936;652.0773106054974;676.2932735291533;679.8708245433352;622.8380621038563;684.2063206680227;701.5755467941924;706.156143408632;717.4547344018583;9369.203617692572;9733.415995040321;9851;9934.900650993397;9963.252756043326;603.9456448919531;616.8334549671564;623.382850977538;712.682856129028;716.1799739298474;4615.192341340319;4701.976490117528;4779.4264688236935;4789.4971028042255;4838.080764654705;67825;68815;69333.30666693268;69438.65280673564;69647.3035269651;62722.68638656777;63176.36823631797;63312.68343658252;63353;63755.36244637587;54515.18227226595;54517.454825452034;54533.72733136309;55281.17078243749;55614.16578751322;7893.565853878092;8109.7161599343735;8514.531700756517;8560.14398560139;8746.212840844355;35837.283254335285;35910.28179436344;36134;37492.250154997295;38013;45213;45262.321065184704;45596;46041.53958460507;50783.49216507788;11713.297202167898;11859;12065.09511786602;12316.630501084981;12717.55488557896;12679.746405071663;13754.724905501635;13755.17468951826;13797.724045519235;13841.238731869442;12772;12929.353532323534;12969.935150324189;12998.610041698765;13462.259575723428;13108.803367949678;13184.143030702973;13209.27348995776;13227.140235884637;13313;11335.716607084889;12753.426095825525;12831.679208019874;13212.867871321163;13634.522791702242;9593.184579310837;9681;10129.949350253202;10145.137663298407;10268.281220314806;10628.309159904582;10673.252872298865;10820.4048777318;10902.18233632465;10911.618093366695 19:27:35 INFO - PROCESS | 1527 | __end_tp_report 19:27:35 INFO - PROCESS | 1527 | __start_cc_report 19:27:35 INFO - PROCESS | 1527 | _x_x_mozilla_cycle_collect,343 19:27:35 INFO - PROCESS | 1527 | __end_cc_report 19:27:35 INFO - PROCESS | 1527 | __startTimestamp1461724055604__endTimestamp 19:27:35 INFO - PROCESS | 1527 | 19:27:35 INFO - PROCESS | 1527 | ------- Summary: start ------- 19:27:35 INFO - PROCESS | 1527 | Number of tests: 6 19:27:35 INFO - PROCESS | 1527 | 19:27:35 INFO - PROCESS | 1527 | [#0] dojo.html Cycles:165 Average:5405.09 Median:5661.63 stddev:714.62 (12.6%) stddev-sans-first:694.68 19:27:35 INFO - PROCESS | 1527 | Values: 3155.7 3204.8 3213.6 3242.4 3251.1 5465.3 5468.8 5474.3 5474.4 5494.5 5345.1 5422.3 5456.1 5515.1 5596.9 4881.4 4915.9 4975.3 4977.5 5030.0 927.2 4932.7 4956.5 4977.1 5018.7 4942.0 4955.4 4957.5 4963.4 4991.6 4804.9 4995.4 5022.0 5065.3 5105.8 4849.5 4874.1 4877.5 4881.5 4913.8 5412.9 5428.6 5436.9 5455.2 5481.5 5700.8 5778.0 5886.1 5904.7 5914.6 5859.0 5867.9 5880.9 5883.2 5904.7 5516.4 5523.1 5526.7 5538.0 5539.4 5852.3 5913.9 5918.4 5963.5 6009.0 5569.9 5574.7 5582.3 5599.3 5627.3 5664.2 5664.4 5665.0 5703.6 5708.5 5696.9 5726.8 5729.4 5798.3 5799.6 5687.4 5812.9 5841.3 5870.9 5946.7 4387.4 4395.8 4435.8 4446.6 4479.1 3891.9 3897.3 3927.5 3965.1 4008.6 5645.0 5668.2 5670.1 5686.9 5713.3 5873.0 5892.6 5938.2 5966.2 5978.5 5401.5 5554.4 5625.2 5650.6 5691.9 4919.1 4937.0 4939.6 4941.3 4964.0 5999.6 6017.3 6029.8 6034.7 6056.1 5788.7 5849.7 5852.6 5907.5 5960.7 6074.5 6097.4 6111.3 6122.7 6125.8 5799.8 5817.9 5821.9 5823.6 5831.7 5789.2 5946.8 6004.5 6036.8 6062.9 5704.5 5707.5 5723.7 5744.0 5746.9 5620.3 5715.6 5725.6 5730.2 5733.3 5583.4 5593.8 5601.2 5646.5 5703.9 5773.2 5806.4 5815.7 5816.9 5821.9 5497.6 5648.9 5658.8 5661.6 5665.6 19:27:35 INFO - PROCESS | 1527 | 19:27:35 INFO - PROCESS | 1527 | [#1] ext.html Cycles:180 Average:45373.17 Median:37994.72 stddev:74990.07 (197.4%) stddev-sans-first:75125.08 19:27:35 INFO - PROCESS | 1527 | Values: 598.7 638.2 655.6 659.5 664.3 29986.4 36889.6 37444.6 37537.2 37768.8 38205.0 38838.0 39063.0 39134.6 39191.4 8418.5 8627.2 8631.7 8652.1 8663.2 8485.0 8622.8 8665.7 8689.8 8790.1 8871.1 8914.4 8968.7 8971.7 8973.6 8803.0 8803.8 8884.1 8893.6 8897.4 8593.9 8694.7 8701.4 8704.7 8710.0 38264.2 38741.2 38766.6 38803.4 38869.4 3545.5 3712.9 3836.4 4038.5 4293.8 28745.4 30584.8 30643.9 30937.0 31905.5 4220.0 4231.6 4303.3 4327.2 4328.9 230413.0 232792.0 234626.0 234659.8 235123.0 32517.3 57540.0 58852.0 58957.8 59025.4 33131.0 33217.7 33286.5 33305.5 33464.7 14823.4 14895.4 15037.9 15119.8 15148.0 12633.5 12721.9 12751.5 12777.8 12825.3 8177.4 8286.7 8330.8 8334.7 8351.0 3258.4 3296.9 3311.3 3336.4 3343.7 1098.6 1123.7 1132.0 1153.3 1157.1 29469.3 29809.3 29926.7 30318.5 30469.2 1142.9 1170.5 1172.5 1211.2 1211.8 16061.9 16408.2 16562.5 16623.9 16635.0 319415.0 321776.0 321815.0 321937.0 333354.0 55088.7 55458.4 55921.4 55963.0 56361.0 1395.1 1481.1 1484.6 1490.3 1495.6 30048.0 31112.8 31217.4 31236.5 31589.8 49396.0 49819.3 50005.0 50280.7 50343.5 294831.0 295411.0 295929.0 296210.0 296648.0 27731.7 38023.6 38625.2 39104.0 39358.0 45087.5 45345.5 45717.5 46620.3 47491.5 37513.2 37764.1 38441.4 38618.0 39390.0 41162.2 41194.8 41486.2 41678.8 42556.1 41271.0 41376.8 42476.0 42716.6 42786.4 36770.8 37210.4 37313.8 37435.6 37965.8 28258.3 28509.6 28847.9 29001.7 29266.9 19:27:35 INFO - PROCESS | 1527 | 19:27:35 INFO - PROCESS | 1527 | [#2] jquery.html Cycles:180 Average:27043.26 Median:11904.60 stddev:78523.02 (659.6%) stddev-sans-first:78717.80 19:27:35 INFO - PROCESS | 1527 | Values: 393.3 393.6 396.3 400.8 413.1 16724.8 16793.7 17237.3 17362.9 17900.4 17023.4 17251.4 17318.8 17792.3 18526.4 5394.0 5442.9 5580.1 5616.0 5628.2 5568.8 5580.6 5596.3 5606.1 5627.4 3876.8 5347.7 5486.3 5515.1 5568.9 5490.4 5538.6 5554.4 5559.4 5563.2 4774.2 4958.2 4961.0 4965.3 4998.8 14677.3 14808.9 21073.3 21178.6 21389.5 2419.7 2430.5 2482.4 2485.8 2763.0 9116.0 9776.0 13599.5 13771.2 14057.4 1918.8 1922.4 1944.9 1995.1 2021.8 48864.5 62281.7 65045.7 65264.7 71228.3 10009.9 10092.7 10288.3 10291.6 10555.5 13966.9 14041.0 14071.1 14176.4 14251.1 7649.6 7964.0 7974.1 8016.2 8102.0 7874.4 7901.3 8071.6 8102.8 8109.6 4497.0 4502.2 4545.2 4601.5 4627.0 1864.4 1892.0 1901.8 1916.1 1928.6 917.6 1002.4 1015.6 1052.1 1130.2 17734.2 17874.6 18380.8 18384.2 18556.6 1062.9 1066.5 1092.1 1119.4 1129.1 10447.4 10492.4 10680.3 10728.9 10823.2 456989.0 458801.0 488686.0 491252.0 498554.0 59604.7 85343.0 85846.6 86020.6 86138.0 1059.5 1094.5 1096.2 1101.8 1123.7 16558.3 16665.3 16897.8 17146.9 17399.1 35068.6 36030.6 36335.8 37610.2 38141.4 47178.3 47433.5 47525.0 48201.5 48370.5 7981.4 8117.1 8174.0 8350.9 8397.7 9205.9 10072.0 12488.6 12910.9 13009.7 11419.3 11490.8 11536.5 11613.4 11655.7 11101.3 11138.4 11279.2 11280.2 11479.2 11491.2 11695.6 11738.1 11885.0 11912.2 8175.8 8251.8 8497.3 8497.4 8551.1 10862.7 11773.6 11801.7 11974.8 11982.4 19:27:35 INFO - PROCESS | 1527 | 19:27:35 INFO - PROCESS | 1527 | [#3] mootools.html Cycles:180 Average:5492.56 Median:4997.64 stddev:2954.51 (59.1%) stddev-sans-first:2947.71 19:27:35 INFO - PROCESS | 1527 | Values: 1518.9 1565.6 1715.1 1790.3 1852.6 7495.9 7792.3 7896.0 8051.6 8082.8 7894.0 7980.6 8030.9 8050.2 8055.7 2279.4 2307.6 2309.9 2325.7 2331.0 2247.6 2272.9 2281.3 2294.9 2302.4 2325.0 2333.7 2335.4 2381.7 2395.5 2330.5 2340.9 2344.4 2353.3 2370.7 2311.7 2312.6 2315.5 2317.4 2321.7 8104.7 8187.8 8191.1 8195.0 8244.8 4881.2 5067.6 5074.4 5094.4 5095.0 3304.1 3385.5 3430.8 3449.0 3494.8 1151.0 1158.1 1195.7 1199.8 1214.6 10398.0 10681.5 10696.5 10706.5 10728.6 4448.2 4498.1 4521.3 4544.2 4549.5 9199.6 9227.8 9230.4 9234.2 9241.0 4975.6 5019.7 5067.5 5067.9 5073.4 4238.8 4585.6 4604.9 4750.5 4760.6 3883.8 3926.1 3992.9 4025.9 4043.9 1272.6 1297.7 1307.7 1320.2 1326.8 1000.9 1006.6 1011.9 1012.9 1025.5 5671.2 5977.7 6050.4 6057.3 6161.0 447.1 451.6 458.6 463.2 467.5 4185.1 4225.3 4240.4 4254.8 4263.3 9969.5 10325.2 10409.6 10446.6 10476.6 10209.9 10224.7 10228.9 10239.6 10322.3 7393.4 7895.2 7896.1 7911.8 7982.5 5818.8 5842.7 5859.2 5931.3 5951.0 8901.2 8903.9 8993.2 9114.7 9140.0 9143.3 9150.8 9201.4 9215.4 9268.8 6830.7 6991.0 7102.2 7253.9 7264.6 8040.8 8043.6 8063.7 8098.6 8129.3 7062.0 7175.5 7221.7 7262.6 7293.4 7331.4 7358.1 7411.3 7421.5 7430.6 6919.5 6941.3 6991.0 7023.2 7034.4 5156.4 5185.3 5206.6 5314.7 5320.1 5193.7 5252.5 5363.2 5386.9 5404.7 19:27:35 INFO - PROCESS | 1527 | 19:27:35 INFO - PROCESS | 1527 | [#4] prototype.html Cycles:180 Average:4986.98 Median:5643.08 stddev:1529.68 (27.1%) stddev-sans-first:1493.51 19:27:35 INFO - PROCESS | 1527 | Values: 330.5 331.5 338.6 338.7 339.1 5378.2 5513.6 5545.9 5546.9 5547.3 5439.7 5441.3 5476.2 5483.8 5503.5 4010.3 4101.9 4204.9 4228.6 4252.0 4239.3 4245.5 4250.7 4257.8 4276.3 4224.6 4228.6 4228.7 4238.5 4247.6 3904.0 4173.5 4188.4 4203.6 4246.0 3639.7 3658.6 3660.5 3670.2 3673.9 5317.2 5330.3 5332.9 5333.7 5378.7 4576.7 4824.7 4852.9 4860.7 4882.6 5709.9 5733.6 5749.7 5750.8 5805.2 4032.4 4044.8 4049.3 4054.9 4055.7 5891.3 5910.5 5931.2 5934.8 5970.4 4136.8 4143.0 4150.4 4162.1 4178.3 4232.9 4234.8 4241.9 4249.7 4258.9 4721.9 4866.9 4877.8 4888.1 4904.3 5808.6 5831.5 5837.3 5871.9 5874.0 1529.2 1536.2 1545.4 1552.0 1558.3 937.8 966.7 1017.7 1018.5 1031.0 5793.7 5841.9 5846.0 5856.0 5922.0 6315.7 6336.7 6363.2 6367.7 6403.6 5824.5 5879.0 5890.0 5904.4 5910.5 3386.0 3408.5 3414.1 3421.4 3427.8 6388.9 6474.2 6500.5 6515.3 6554.8 6390.5 6396.7 6405.5 6409.2 6444.5 6313.4 6437.2 6461.0 6491.0 6575.6 6305.4 6334.7 6357.0 6363.5 6368.9 6095.9 6280.5 6290.9 6300.1 6310.6 6497.9 6541.8 6549.5 6558.4 6575.5 4323.9 4337.4 4352.5 4357.2 4371.5 6162.7 6258.0 6305.5 6345.3 6362.9 6137.7 6140.1 6147.0 6151.5 6154.4 5992.3 6143.8 6146.3 6171.5 6184.8 5442.3 5597.3 5757.7 6066.5 6091.3 5861.9 5885.6 5889.2 5901.8 5916.7 5475.6 5688.9 5730.0 5746.7 5769.5 19:27:35 INFO - PROCESS | 1527 | 19:27:35 INFO - PROCESS | 1527 | [#5] yui.html Cycles:180 Average:15742.21 Median:4764.71 stddev:19051.42 (399.8%) stddev-sans-first:19071.84 19:27:35 INFO - PROCESS | 1527 | Values: 805.9 842.6 847.9 865.9 888.5 14038.5 14064.9 14108.4 14129.6 15019.8 14584.6 14604.5 14625.4 14745.1 14759.3 799.8 804.5 805.0 817.3 820.7 820.5 823.1 827.3 827.8 830.0 860.9 863.1 863.3 863.8 865.0 854.4 856.8 859.1 859.2 864.3 623.3 627.2 628.2 631.6 633.0 14161.5 14180.6 14218.8 14280.4 14292.4 12876.0 13039.7 13422.9 13460.3 13501.3 11359.0 11480.1 11562.5 11724.4 11796.9 3664.6 3713.6 3719.1 3777.6 3817.8 60901.4 60953.4 61472.1 62112.7 62214.7 11127.3 11139.5 11161.2 11322.2 11410.1 20021.6 20052.9 20094.5 20150.0 20463.2 8275.4 8307.6 8362.5 8388.2 8389.0 4693.2 4750.0 4825.4 4855.9 4885.4 3283.8 3345.1 3353.0 3357.3 3357.4 609.9 618.0 652.1 676.3 679.9 622.8 684.2 701.6 706.2 717.5 9369.2 9733.4 9851.0 9934.9 9963.3 603.9 616.8 623.4 712.7 716.2 4615.2 4702.0 4779.4 4789.5 4838.1 67825.0 68815.0 69333.3 69438.7 69647.3 62722.7 63176.4 63312.7 63353.0 63755.4 54515.2 54517.5 54533.7 55281.2 55614.2 7893.6 8109.7 8514.5 8560.1 8746.2 35837.3 35910.3 36134.0 37492.3 38013.0 45213.0 45262.3 45596.0 46041.5 50783.5 11713.3 11859.0 12065.1 12316.6 12717.6 12679.7 13754.7 13755.2 13797.7 13841.2 12772.0 12929.4 12969.9 12998.6 13462.3 13108.8 13184.1 13209.3 13227.1 13313.0 11335.7 12753.4 12831.7 13212.9 13634.5 9593.2 9681.0 10129.9 10145.1 10268.3 10628.3 10673.3 10820.4 10902.2 10911.6 19:27:35 INFO - PROCESS | 1527 | -------- Summary: end -------- 19:27:35 INFO - PROCESS | 1527 | 19:27:36 INFO - TEST-INFO | 1527: exit 0 19:27:36 INFO - TEST-OK | dromaeo_css | took 1110107ms 19:27:36 INFO - TEST-START | kraken 19:27:36 INFO - operating with platform_type : linux_ 19:27:36 INFO - Initialising browser for kraken test... 19:27:36 INFO - TEST-INFO | started process 1765 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphGLucU/profile http://localhost:41715/getInfo.html) 19:27:40 INFO - PROCESS | 1765 | 19:27:40 INFO - PROCESS | 1765 | (process:1833): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:27:40 INFO - PROCESS | 1765 | __metrics Screen width/height:1600/1200 19:27:40 INFO - PROCESS | 1765 | colorDepth:24 19:27:40 INFO - PROCESS | 1765 | Browser inner width/height: 1024/697 19:27:40 INFO - PROCESS | 1765 | __metrics 19:27:41 ERROR - PROCESS | 1765 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 19:27:42 INFO - TEST-INFO | 1765: exit 0 19:27:42 INFO - Browser initialized. 19:27:42 INFO - Running cycle 1/1 for kraken test... 19:27:42 INFO - TEST-INFO | started process 1884 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphGLucU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:27:44 INFO - PROCESS | 1884 | 19:27:44 INFO - PROCESS | 1884 | (process:1946): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:27:54 INFO - PROCESS | 1884 | RSS: Main: 164761600 19:27:54 INFO - PROCESS | 1884 | 19:27:56 INFO - PROCESS | 1884 | Cycle 1(1): loaded http://localhost:41715/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41715/tests/kraken/driver.html?testName=audio-beat-detection) 19:27:57 INFO - PROCESS | 1884 | RSS: Main: 169426944 19:27:57 INFO - PROCESS | 1884 | 19:28:00 INFO - PROCESS | 1884 | Cycle 1(1): loaded http://localhost:41715/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41715/tests/kraken/driver.html?testName=audio-dft) 19:28:00 INFO - PROCESS | 1884 | RSS: Main: 173805568 19:28:00 INFO - PROCESS | 1884 | 19:28:03 INFO - PROCESS | 1884 | Cycle 1(1): loaded http://localhost:41715/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41715/tests/kraken/driver.html?testName=audio-fft) 19:28:04 INFO - PROCESS | 1884 | RSS: Main: 166334464 19:28:04 INFO - PROCESS | 1884 | 19:28:06 INFO - PROCESS | 1884 | Cycle 1(1): loaded http://localhost:41715/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41715/tests/kraken/driver.html?testName=audio-oscillator) 19:28:07 INFO - PROCESS | 1884 | RSS: Main: 166027264 19:28:07 INFO - PROCESS | 1884 | 19:28:09 INFO - PROCESS | 1884 | Cycle 1(1): loaded http://localhost:41715/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41715/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:28:10 INFO - PROCESS | 1884 | RSS: Main: 166895616 19:28:10 INFO - PROCESS | 1884 | 19:28:13 INFO - PROCESS | 1884 | Cycle 1(1): loaded http://localhost:41715/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41715/tests/kraken/driver.html?testName=imaging-darkroom) 19:28:13 INFO - PROCESS | 1884 | RSS: Main: 166817792 19:28:13 INFO - PROCESS | 1884 | 19:28:17 INFO - PROCESS | 1884 | Cycle 1(1): loaded http://localhost:41715/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41715/tests/kraken/driver.html?testName=imaging-desaturate) 19:28:17 INFO - PROCESS | 1884 | RSS: Main: 167108608 19:28:17 INFO - PROCESS | 1884 | 19:28:20 INFO - PROCESS | 1884 | Cycle 1(1): loaded http://localhost:41715/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41715/tests/kraken/driver.html?testName=json-parse-financial) 19:28:21 INFO - PROCESS | 1884 | RSS: Main: 167440384 19:28:21 INFO - PROCESS | 1884 | 19:28:22 INFO - PROCESS | 1884 | Cycle 1(1): loaded http://localhost:41715/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41715/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:28:23 INFO - PROCESS | 1884 | RSS: Main: 167792640 19:28:23 INFO - PROCESS | 1884 | 19:28:25 INFO - PROCESS | 1884 | Cycle 1(1): loaded http://localhost:41715/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41715/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:28:25 INFO - PROCESS | 1884 | RSS: Main: 167751680 19:28:25 INFO - PROCESS | 1884 | 19:28:28 INFO - PROCESS | 1884 | Cycle 1(1): loaded http://localhost:41715/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41715/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:28:28 INFO - PROCESS | 1884 | RSS: Main: 167583744 19:28:28 INFO - PROCESS | 1884 | 19:28:31 INFO - PROCESS | 1884 | Cycle 1(1): loaded http://localhost:41715/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41715/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:28:31 INFO - PROCESS | 1884 | RSS: Main: 168079360 19:28:31 INFO - PROCESS | 1884 | 19:28:35 INFO - PROCESS | 1884 | Cycle 1(1): loaded http://localhost:41715/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41715/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:28:35 INFO - PROCESS | 1884 | RSS: Main: 168038400 19:28:35 INFO - PROCESS | 1884 | 19:28:37 INFO - PROCESS | 1884 | Cycle 1(1): loaded http://localhost:41715/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41715/tests/kraken/driver.html?testName=ai-astar) 19:28:37 INFO - PROCESS | 1884 | RSS: Main: 170086400 19:28:37 INFO - PROCESS | 1884 | 19:28:37 INFO - PROCESS | 1884 | __start_tp_report 19:28:37 INFO - PROCESS | 1884 | _x_x_mozilla_page_load 19:28:37 INFO - PROCESS | 1884 | _x_x_mozilla_page_load_details 19:28:37 INFO - PROCESS | 1884 | |i|pagename|runs| 19:28:37 INFO - PROCESS | 1884 | |0;ai-astar;111;108;113;112;114;125;115;115;113;112 19:28:37 INFO - PROCESS | 1884 | |1;audio-beat-detection;159;130;155;182;132;161;152;136;180;128 19:28:37 INFO - PROCESS | 1884 | |2;audio-dft;161;163;163;161;164;167;173;162;165;162 19:28:37 INFO - PROCESS | 1884 | |3;audio-fft;77;77;73;173;77;77;74;74;157;79 19:28:37 INFO - PROCESS | 1884 | |4;audio-oscillator;94;92;147;93;93;93;140;93;93;148 19:28:37 INFO - PROCESS | 1884 | |5;imaging-gaussian-blur;117;117;116;118;118;118;117;120;118;118 19:28:37 INFO - PROCESS | 1884 | |6;imaging-darkroom;146;147;147;147;147;147;146;147;146;146 19:28:37 INFO - PROCESS | 1884 | |7;imaging-desaturate;96;95;95;95;95;95;95;95;95;94 19:28:37 INFO - PROCESS | 1884 | |8;json-parse-financial;59;59;58;60;58;59;57;78;56;56 19:28:37 INFO - PROCESS | 1884 | |9;json-stringify-tinderbox;61;61;61;63;62;61;61;62;63;60 19:28:37 INFO - PROCESS | 1884 | |10;stanford-crypto-aes;76;81;78;85;78;86;79;80;80;80 19:28:37 INFO - PROCESS | 1884 | |11;stanford-crypto-ccm;136;125;134;129;132;127;142;130;166;131 19:28:37 INFO - PROCESS | 1884 | |12;stanford-crypto-pbkdf2;205;207;206;211;204;202;201;207;202;204 19:28:37 INFO - PROCESS | 1884 | |13;stanford-crypto-sha256-iterative;71;72;71;73;70;77;74;68;70;79 19:28:37 INFO - PROCESS | 1884 | __end_tp_report 19:28:37 INFO - PROCESS | 1884 | __start_cc_report 19:28:37 INFO - PROCESS | 1884 | _x_x_mozilla_cycle_collect,848 19:28:37 INFO - PROCESS | 1884 | __end_cc_report 19:28:37 INFO - PROCESS | 1884 | __startTimestamp1461724117802__endTimestamp 19:28:37 INFO - PROCESS | 1884 | 19:28:37 INFO - PROCESS | 1884 | ------- Summary: start ------- 19:28:37 INFO - PROCESS | 1884 | Number of tests: 14 19:28:37 INFO - PROCESS | 1884 | 19:28:37 INFO - PROCESS | 1884 | [#0] ai-astar Cycles:10 Average:113.80 Median:113.50 stddev:4.44 (3.9%) stddev-sans-first:4.59 19:28:37 INFO - PROCESS | 1884 | Values: 111.0 108.0 113.0 112.0 114.0 125.0 115.0 115.0 113.0 112.0 19:28:37 INFO - PROCESS | 1884 | 19:28:37 INFO - PROCESS | 1884 | [#1] audio-beat-detection Cycles:10 Average:151.50 Median:157.00 stddev:19.82 (12.6%) stddev-sans-first:20.84 19:28:37 INFO - PROCESS | 1884 | Values: 159.0 130.0 155.0 182.0 132.0 161.0 152.0 136.0 180.0 128.0 19:28:37 INFO - PROCESS | 1884 | 19:28:37 INFO - PROCESS | 1884 | [#2] audio-dft Cycles:10 Average:164.10 Median:163.50 stddev:3.63 (2.2%) stddev-sans-first:3.68 19:28:37 INFO - PROCESS | 1884 | Values: 161.0 163.0 163.0 161.0 164.0 167.0 173.0 162.0 165.0 162.0 19:28:37 INFO - PROCESS | 1884 | 19:28:37 INFO - PROCESS | 1884 | [#3] audio-fft Cycles:10 Average:93.80 Median:77.00 stddev:37.76 (49.0%) stddev-sans-first:39.56 19:28:37 INFO - PROCESS | 1884 | Values: 77.0 77.0 73.0 173.0 77.0 77.0 74.0 74.0 157.0 79.0 19:28:37 INFO - PROCESS | 1884 | 19:28:37 INFO - PROCESS | 1884 | [#4] audio-oscillator Cycles:10 Average:108.60 Median:93.00 stddev:25.21 (27.1%) stddev-sans-first:26.18 19:28:37 INFO - PROCESS | 1884 | Values: 94.0 92.0 147.0 93.0 93.0 93.0 140.0 93.0 93.0 148.0 19:28:37 INFO - PROCESS | 1884 | 19:28:37 INFO - PROCESS | 1884 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:1.06 (0.9%) stddev-sans-first:1.09 19:28:37 INFO - PROCESS | 1884 | Values: 117.0 117.0 116.0 118.0 118.0 118.0 117.0 120.0 118.0 118.0 19:28:37 INFO - PROCESS | 1884 | 19:28:37 INFO - PROCESS | 1884 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 19:28:37 INFO - PROCESS | 1884 | Values: 146.0 147.0 147.0 147.0 147.0 147.0 146.0 147.0 146.0 146.0 19:28:37 INFO - PROCESS | 1884 | 19:28:37 INFO - PROCESS | 1884 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 19:28:37 INFO - PROCESS | 1884 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 19:28:37 INFO - PROCESS | 1884 | 19:28:37 INFO - PROCESS | 1884 | [#8] json-parse-financial Cycles:10 Average:60.00 Median:59.00 stddev:6.46 (11.0%) stddev-sans-first:6.85 19:28:37 INFO - PROCESS | 1884 | Values: 59.0 59.0 58.0 60.0 58.0 59.0 57.0 78.0 56.0 56.0 19:28:37 INFO - PROCESS | 1884 | 19:28:37 INFO - PROCESS | 1884 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:61.50 stddev:0.97 (1.6%) stddev-sans-first:1.01 19:28:37 INFO - PROCESS | 1884 | Values: 61.0 61.0 61.0 63.0 62.0 61.0 61.0 62.0 63.0 60.0 19:28:37 INFO - PROCESS | 1884 | 19:28:37 INFO - PROCESS | 1884 | [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:80.00 stddev:3.09 (3.9%) stddev-sans-first:2.86 19:28:37 INFO - PROCESS | 1884 | Values: 76.0 81.0 78.0 85.0 78.0 86.0 79.0 80.0 80.0 80.0 19:28:37 INFO - PROCESS | 1884 | 19:28:37 INFO - PROCESS | 1884 | [#11] stanford-crypto-ccm Cycles:10 Average:135.20 Median:133.00 stddev:11.84 (8.9%) stddev-sans-first:12.55 19:28:37 INFO - PROCESS | 1884 | Values: 136.0 125.0 134.0 129.0 132.0 127.0 142.0 130.0 166.0 131.0 19:28:37 INFO - PROCESS | 1884 | 19:28:37 INFO - PROCESS | 1884 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:204.90 Median:205.50 stddev:3.00 (1.5%) stddev-sans-first:3.18 19:28:37 INFO - PROCESS | 1884 | Values: 205.0 207.0 206.0 211.0 204.0 202.0 201.0 207.0 202.0 204.0 19:28:37 INFO - PROCESS | 1884 | 19:28:37 INFO - PROCESS | 1884 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.50 Median:72.50 stddev:3.37 (4.7%) stddev-sans-first:3.54 19:28:37 INFO - PROCESS | 1884 | Values: 71.0 72.0 71.0 73.0 70.0 77.0 74.0 68.0 70.0 79.0 19:28:37 INFO - PROCESS | 1884 | -------- Summary: end -------- 19:28:37 INFO - PROCESS | 1884 | 19:28:38 INFO - TEST-INFO | 1884: exit 0 19:28:38 INFO - TEST-OK | kraken | took 62433ms 19:28:38 INFO - SUITE-END | took 1172s 19:28:38 INFO - Completed test suite (00:19:32) 19:28:38 INFO - javascript benchmark 19:28:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3155.731762800162, 3204.7916885402446, 3213.6464988851208, 3242.448783706768, 3251.122197006808, 5465.2895123633925, 5468.808591699286, 5474.315710536183, 5474.39781624022, 5494.5054945054935, 5345.064613692608, 5422.267993820833, 5456.0997435423205, 5515.117581187011, 5596.944030559694, 4881.389826271716, 4915.8525244242555, 4975.27858460523, 4977.527134922177, 5029.9748501257445, 927.1731246803862, 4932.654714170009, 4956.529129732669, 4977.054359671669, 5018.723970181639, 4942.0, 4955.355803745508, 4957.529034741694, 4963.404391473028, 4991.550760431579, 4804.903901921977, 4995.375578052744, 5022.045811295842, 5065.341505604248, 5105.770240339194, 4849.4908034656555, 4874.073925954058, 4877.512248775094, 4881.4630390657, 4913.796119950635, 5412.91880621791, 5428.565714742811, 5436.864078398072, 5455.236266922634, 5481.5340696040885, 5700.800471983461, 5778.0466223073145, 5886.087656413263, 5904.704764761745, 5914.585978981473, 5858.970705146489, 5867.8533036674, 5880.852978675524, 5883.17635531026, 5904.704764761745, 5516.365617953947, 5523.1163013917985, 5526.696031718254, 5537.975474537224, 5539.446055394428, 5852.326982396994, 5913.940860591425, 5918.378570250148, 5963.493103086286, 6009.0, 5569.888602228014, 5574.749136288796, 5582.27430434041, 5599.272094627754, 5627.268455100811, 5664.150377443417, 5664.405237450091, 5665.036943719495, 5703.600747947687, 5708.4862362387585, 5696.943030569724, 5726.799562015392, 5729.369769325371, 5798.33319168301, 5799.565032622486, 5687.374388817227, 5812.883742325214, 5841.299044114733, 5870.853228669232, 5946.70266486674, 4387.3857659927635, 4395.846145384896, 4435.800388982503, 4446.62203712688, 4479.081788233404, 3891.9221615568094, 3897.279003384383, 3927.4501569780255, 3965.107850733562, 4008.599140085968, 5645.01212287848, 5668.206451096849, 5670.121131224667, 5686.914696279559, 5713.342965559014, 5873.030949893306, 5892.587518873724, 5938.2280303560265, 5966.164736936832, 5978.521718262528, 5401.540869026098, 5554.416786237468, 5625.184348269478, 5650.576206784508, 5691.886162276731, 4919.06537757832, 4937.0372777308085, 4939.5554400104165, 4941.2835138905375, 4964.0, 5999.551155773813, 6017.338092809788, 6029.758809647653, 6034.6982650867285, 6056.06131049688, 5788.710564471844, 5849.678267695147, 5852.590318677737, 5907.49786268172, 5960.701964901651, 6074.483668888017, 6097.359777223328, 6111.297200821962, 6122.663253521099, 6125.754969801158, 5799.768009279582, 5817.883642327214, 5821.94178058231, 5823.563232757645, 5831.70841457917, 5789.2184555086205, 5946.762129514771, 6004.519638429003, 6036.7585296589405, 6062.939370606414, 5704.458076482728, 5707.4577915098, 5723.6851973141875, 5744.0, 5746.942530574641, 5620.297462817148, 5715.599908006399, 5725.570582206268, 5730.226419433323, 5733.254676891977, 5583.385827559046, 5593.776248949996, 5601.187827765033, 5646.463585959327, 5703.857403564944, 5773.191753154478, 5806.44838740319, 5815.738291776795, 5816.912746308724, 5821.94178058214, 5497.587680924026, 5648.85877853057, 5658.830235092953, 5661.631993920382, 5665.603407761417], "value": 5358.442874249818, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.7006496751624, 638.1640051532496, 655.6262930129826, 659.498780926496, 664.3257094049541, 29986.400271994546, 36889.63110368899, 37444.62555374445, 37537.24925501488, 37768.81115594422, 38205.0, 38838.0, 39063.0, 39134.608653913456, 39191.41212881802, 8418.536980466071, 8627.22354988051, 8631.65473381064, 8652.091530389313, 8663.220310172082, 8485.0, 8622.78443038926, 8665.653373865038, 8689.826203475926, 8790.120987901191, 8871.11288871111, 8914.375993680445, 8968.686095986643, 8971.685990990283, 8973.596188171548, 8802.955985220096, 8803.77990550235, 8884.067172946812, 8893.644254229823, 8897.421667591618, 8593.871091933626, 8694.652213911437, 8701.434406763603, 8704.738857834274, 8710.041895391565, 38264.234715305814, 38741.22517549633, 38766.61233387687, 38803.41794873079, 38869.41695874564, 3545.5213546171194, 3712.9071773205615, 3836.4437156612134, 4038.515378154611, 4293.785310734451, 28745.42509149805, 30584.8470757647, 30643.893801788512, 30937.0, 31905.52141717876, 4219.9578004219875, 4231.61915427613, 4303.33298338758, 4327.156204540116, 4328.913421731548, 230413.0, 232792.0, 234626.0, 234659.82670086712, 235123.0, 32517.349653006808, 57539.972201945464, 58852.0, 58957.809430010086, 59025.40974590285, 33131.0, 33217.667823321455, 33286.50070248948, 33305.50041749376, 33464.665353346645, 14823.40706371733, 14895.404183832525, 15037.924810375878, 15119.773203401957, 15148.0, 12633.494660213488, 12721.93639031799, 12751.489940402465, 12777.808332874829, 12825.294608796607, 8177.427580069457, 8286.70996515119, 8330.79203515499, 8334.6666133354, 8351.0, 3258.4297747894025, 3296.8846090386724, 3311.2715202655377, 3336.4494858348585, 3343.715784158374, 1098.555085190499, 1123.730304726876, 1132.0, 1153.2993308875461, 1157.1263695909702, 29469.26326841803, 29809.25476863096, 29926.70073299239, 30318.54522182169, 30469.23826904301, 1142.9199956003167, 1170.5142365918218, 1172.4958267944694, 1211.2429731417865, 1211.8424604801319, 16061.875668703313, 16408.179591020402, 16562.50312490627, 16623.91688041552, 16635.001899885803, 319415.0, 321776.0, 321815.0, 321937.0, 333354.0, 55088.72455637696, 55458.44541554533, 55921.44078559244, 55963.0, 56361.0, 1395.1001603965385, 1481.0669278354567, 1484.64368551549, 1490.344248530643, 1495.5662857771124, 30048.0, 31112.84443577858, 31217.375652487277, 31236.531452028692, 31589.8420507896, 49396.0, 49819.25271121009, 50005.0, 50280.74859625679, 50343.49656503388, 294831.0, 295411.0, 295929.0, 296210.0, 296648.0, 27731.722682772914, 38023.62728286283, 38625.2274954505, 39104.0, 39358.0, 45087.54912450833, 45345.54654453545, 45717.54282457133, 46620.300695490274, 47491.525084750094, 37513.2497350046, 37764.05589860275, 38441.42337864878, 38618.0, 39390.0, 41162.176756465306, 41194.794026029675, 41486.1702765949, 41678.79160604178, 42556.148877022904, 41271.0, 41376.79311603423, 42476.0, 42716.572834272505, 42786.35820462758, 36770.816145919096, 37210.441843372915, 37313.81343093267, 37435.62564374322, 37965.81017094897, 28258.304501729963, 28509.572356414257, 28847.85576072106, 29001.7099828999, 29266.853665731534], "value": 18111.512897677807, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.26852055177363, 393.6240889950098, 396.32426712455265, 400.7815740421471, 413.07883419973456, 16724.83275167248, 16793.748093778602, 17237.310507579696, 17362.91318543407, 17900.37348692796, 17023.40418085367, 17251.396201132964, 17318.82681173188, 17792.288308467647, 18526.351577694782, 5393.973030134864, 5442.863928401792, 5580.107182850745, 5616.045272303698, 5628.212050312959, 5568.777248910039, 5580.553555715554, 5596.328440587135, 5606.103023516238, 5627.437256274381, 3876.8061596920043, 5347.652402593839, 5486.259354987065, 5515.117581187011, 5568.86077848055, 5490.423505531901, 5538.6399884007615, 5554.361248456439, 5559.416261292567, 5563.165525171216, 4774.16452120881, 4958.181899986498, 4960.975195124038, 4965.3048573199785, 4998.750062496861, 14677.339519721638, 14808.851911480962, 21073.26243581467, 21178.576428471497, 21389.465263368384, 2419.733829278778, 2430.4774473488283, 2482.404222986488, 2485.825992180548, 2762.9915080995493, 9115.954420227856, 9776.022397760238, 13599.456021759117, 13771.242581658005, 14057.437702491889, 1918.7793403758608, 1922.4136638325306, 1944.8930308833008, 1995.1221462556573, 2021.787712290203, 48864.51135488635, 62281.688591557206, 65045.67477162631, 65264.673676631784, 71228.28771712269, 10009.899901000897, 10092.697219083439, 10288.331258468175, 10291.559181714565, 10555.525001374957, 13966.86033139676, 14041.0, 14071.085379450507, 14176.432942682177, 14251.144931303948, 7649.617519124133, 7964.0, 7974.122846486882, 8016.158303378178, 8102.0, 7874.448788584744, 7901.2888840003525, 8071.636776345079, 8102.83794324122, 8109.635066422025, 4497.0, 4502.234620114588, 4545.204589196877, 4601.539846015372, 4626.976865115653, 1864.4499872537363, 1891.9810801892081, 1901.8193271639173, 1916.1090093106773, 1928.5853541488366, 917.5916717060844, 1002.4336250018716, 1015.619142821442, 1052.084686322904, 1130.1749722702473, 17734.20196091179, 17874.55313617144, 18380.816191838177, 18384.17271222798, 18556.628867422845, 1062.914966802654, 1066.5200659703164, 1092.1044743310567, 1119.3955264157428, 1129.0685184722636, 10447.373157610567, 10492.370457772558, 10680.305780124267, 10728.946355268174, 10823.242373033969, 456989.0, 458801.0, 488686.0, 491252.0, 498554.0, 59604.70197649071, 85343.0, 85846.57076714576, 86020.56989715136, 86138.0, 1059.5073290919759, 1094.5129417409335, 1096.1614365010773, 1101.8347247912716, 1123.6516679829115, 16558.337666493204, 16665.3333866644, 16897.83102169012, 17146.914265428593, 17399.13004349803, 35068.64931350654, 36030.63969360273, 36335.81832090823, 37610.2477950434, 38141.4278785824, 47178.29232561446, 47433.52566474291, 47525.0, 48201.517984821105, 48370.51629483801, 7981.361491080584, 8117.1071182168735, 8174.0, 8350.87473687883, 8397.740338949206, 9205.86191207119, 10072.0, 12488.625341239778, 12910.870891290966, 13009.739805203653, 11419.31484110956, 11490.827637585277, 11536.480858361227, 11613.419329033684, 11655.708607284885, 11101.278416902875, 11138.443077845914, 11279.15406344511, 11280.153988450735, 11479.196456248317, 11491.195616306779, 11695.649130526097, 11738.0609551234, 11885.0, 11912.225705329125, 8175.79560510992, 8251.752447426587, 8497.320214382959, 8497.447665901696, 8551.102134275812, 10862.65477392683, 11773.587924422603, 11801.704957376134, 11974.760504790029, 11982.442282503218], "value": 8827.599896493317, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1518.8633023027928, 1565.585119943215, 1715.11671489183, 1790.2570433270193, 1852.5646473078832, 7495.925040749591, 7792.298693117618, 7895.960520197391, 8051.597420128992, 8082.838343233139, 7894.0, 7980.640871160797, 8030.9196908031045, 8050.154733752959, 8055.677772889092, 2279.4415368234763, 2307.6077066898583, 2309.896054677535, 2325.662778897059, 2330.976690233093, 2247.640377539594, 2272.943176420586, 2281.292799232235, 2294.8737819419925, 2302.3783578433813, 2325.046730840356, 2333.6616190652344, 2335.4044718596733, 2381.654365283618, 2395.520895820834, 2330.463993281555, 2340.8829558522093, 2344.449054472206, 2353.305774796431, 2370.6799582056374, 2311.66480860276, 2312.6184179610514, 2315.455867871049, 2317.385892738426, 2321.6633588129625, 8104.6758129674745, 8187.79530511736, 8191.139930307351, 8195.016598008218, 8244.752657420288, 4881.194602890519, 5067.594592432633, 5074.416442109131, 5094.363204599425, 5095.031943930679, 3304.074859039473, 3385.460904321759, 3430.776999495025, 3448.9655103448895, 3494.8427320770625, 1151.0, 1158.137187795098, 1195.6771671648605, 1199.7960346741074, 1214.5607455165657, 10398.0, 10681.519331630096, 10696.518656660392, 10706.464676766209, 10728.570857165703, 4448.243798554254, 4498.122866041091, 4521.253993091169, 4544.227481328182, 4549.499555048942, 9199.586018629045, 9227.815443691223, 9230.400023998418, 9234.215091717146, 9241.0, 4975.601951843843, 5019.67372120811, 5067.467915868854, 5067.873303167376, 5073.416557095981, 4238.788060596958, 4585.633149348044, 4604.930926036112, 4750.501197374226, 4760.59534939534, 3883.8058097095595, 3926.096997690547, 3992.86024989124, 4025.8590949317218, 4043.9191216175514, 1272.6436597752645, 1297.7274772297924, 1307.6600083978044, 1320.2012782266781, 1326.8474125475693, 1000.8598796168542, 1006.5822683586376, 1011.8684571005722, 1012.9189664826796, 1025.5128813813528, 5671.2060311556415, 5977.67122808241, 6050.394960503914, 6057.303410107806, 6161.0, 447.085709723616, 451.62515112456583, 458.6033081384578, 463.2102265637081, 467.53246753246754, 4185.079282557833, 4225.260579398593, 4240.363945408152, 4254.829806807755, 4263.2752432086, 9969.451680157661, 10325.225608079274, 10409.5836166554, 10446.582136714447, 10476.63331783384, 10209.9489502552, 10224.693259202088, 10228.897711022943, 10239.641612543524, 10322.329048611817, 7393.408527317802, 7895.2499512547365, 7896.091949425775, 7911.762647120596, 7982.521048736979, 5818.8254352369495, 5842.678652673973, 5859.2382990211, 5931.347551769216, 5951.047832346804, 8901.243394311556, 8903.910960890309, 8993.190612844875, 9114.726558203265, 9140.040295769115, 9143.26853851677, 9150.77123071902, 9201.401908875901, 9215.354925155174, 9268.768280793034, 6830.658467076726, 6991.0, 7102.218755936946, 7253.891191632024, 7264.636768161677, 8040.83918321642, 8043.557604331584, 8063.677452902053, 8098.595070246582, 8129.268365847102, 7062.0, 7175.497715159889, 7221.711131554679, 7262.600556969206, 7293.416526677959, 7331.41348692114, 7358.080239970004, 7411.2588741125455, 7421.480496365419, 7430.588188244216, 6919.51230485448, 6941.271166527442, 6991.0, 7023.192332881784, 7034.366906978396, 5156.355455568054, 5185.299984502044, 5206.609504287269, 5314.734263286898, 5320.068987927175, 5193.68837869729, 5252.501012403815, 5363.195520671774, 5386.919196211981, 5404.7297635118875], "value": 4424.609641500781, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.45639922327774, 331.4597206553318, 338.56156277620477, 338.7019422907841, 339.0946173716177, 5378.24704541364, 5513.586481013925, 5545.944540554593, 5546.916796248054, 5547.278853749007, 5439.673619582828, 5441.2654291670615, 5476.151196564529, 5483.835484935448, 5503.504684578387, 4010.278149933011, 4101.876943691694, 4204.915901681965, 4228.619424251817, 4251.97874010631, 4239.342901850203, 4245.516372921845, 4250.703535421695, 4257.8296868125235, 4276.315789473685, 4224.640905523034, 4228.577142285762, 4228.661707063443, 4238.470191226097, 4247.575242475743, 3904.004478857887, 4173.457450531442, 4188.434561334211, 4203.55862634422, 4245.957540424587, 3639.70882329413, 3658.6158453362546, 3660.524131862841, 3670.1925576373155, 3673.94489082664, 5317.229001794757, 5330.320948901122, 5332.893342133174, 5333.679979201222, 5378.650387724824, 4576.679632425731, 4824.734639594821, 4852.8544143675745, 4860.659753817235, 4882.609391248727, 5709.885802283972, 5733.598648094635, 5749.655020698771, 5750.769969201227, 5805.158252053428, 4032.3749818778138, 4044.797760111983, 4049.291374009566, 4054.878353649395, 4055.71609987301, 5891.322497912752, 5910.497607703351, 5931.228940237742, 5934.792282270143, 5970.373110823388, 4136.81465271739, 4143.047099167208, 4150.439690641785, 4162.146759914211, 4178.310578754532, 4232.894177645583, 4234.7670878102, 4241.936370954438, 4249.745015299092, 4258.914821703549, 4721.858344249678, 4866.902661946812, 4877.756112194376, 4888.120138375127, 4904.288878112725, 5808.564357673192, 5831.504322132581, 5837.270341207349, 5871.911921321183, 5874.0, 1529.2200977501332, 1536.185821514599, 1545.4281915691265, 1552.0, 1558.306553583667, 937.7664109121921, 966.7003228998892, 1017.6946915925192, 1018.5314755212685, 1031.0359813574332, 5793.710314484259, 5841.94158058414, 5846.0, 5855.970720146372, 5922.0, 6315.684215789192, 6336.714847831859, 6363.1864918498, 6367.745290188341, 6403.64779937108, 5824.504917082011, 5878.970605146947, 5889.9692553802915, 5904.350521442638, 5910.497607703307, 3386.0, 3408.471686888536, 3414.112330793962, 3421.401254780453, 3427.7943323400677, 6388.936110638927, 6474.223093228843, 6500.4799616030605, 6515.348465153446, 6554.80335589933, 6390.456811171102, 6396.680165991775, 6405.48756099511, 6409.166808314889, 6444.516661250331, 6313.368663133741, 6437.163168788027, 6461.0, 6490.967545162244, 6575.619119984857, 6305.369463053658, 6334.714937827901, 6357.0, 6363.5227357947415, 6368.87262254743, 6095.9390406097145, 6280.461286984718, 6290.9056364155485, 6300.117983482224, 6310.6213627182515, 6497.935020649922, 6541.836454088686, 6549.4760419167305, 6558.376954189535, 6575.53971222029, 4323.935140972825, 4337.436133302651, 4352.455943007124, 4357.237483440449, 4371.540988196193, 6162.691865406622, 6258.0, 6305.464035557029, 6345.270293916259, 6362.936370636235, 6137.716321767833, 6140.109684095871, 6146.985747351816, 6151.5386346025125, 6154.415145638753, 5992.340842507408, 6143.784967526115, 6146.323904370605, 6171.537134714825, 6184.845378865564, 5442.346918369821, 5597.272354593877, 5757.65454072757, 6066.484348830399, 6091.269047714125, 5861.915545624073, 5885.55858310637, 5889.175515427758, 5901.7639294427745, 5916.73374698131, 5475.589330800286, 5688.886222275614, 5729.971350143389, 5746.712664366849, 5769.451902069297], "value": 4498.789084647976, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [805.8952336196301, 842.5787106446777, 847.9279261262797, 865.8917635295588, 888.5290795878183, 14038.508652197175, 14064.929675351634, 14108.365123569438, 14129.64675883102, 15019.849801501981, 14584.635384115403, 14604.488842890501, 14625.414983400651, 14745.115293082423, 14759.335829887654, 799.7720649614861, 804.4891493901386, 804.9919500805005, 817.3216230528647, 820.6758330459465, 820.4502983001404, 823.1439303124743, 827.3298628111219, 827.7516744976513, 829.9626516806758, 860.853654878669, 863.1411745313422, 863.3222920007795, 863.8013256950906, 865.0, 854.4189950833431, 856.7858035491096, 859.0807835615893, 859.1537335724306, 864.2999170671744, 623.3392603839944, 627.244170774216, 628.1676778268812, 631.643121636274, 633.0377825704903, 14161.504347347793, 14180.574582762534, 14218.786718199235, 14280.357383917748, 14292.356843942047, 12876.0, 13039.674008149777, 13422.86577134226, 13460.326983650877, 13501.324933753272, 11359.0, 11480.138989575815, 11562.53749850005, 11724.355160466257, 11796.882031179664, 3664.633536646314, 3713.6472035156617, 3719.1445967427644, 3777.565579958285, 3817.8472861085525, 60901.39098609002, 60953.39046609522, 61472.07791883081, 62112.68943655298, 62214.68892655508, 11127.276727012719, 11139.498722557504, 11161.162912781574, 11322.207445478902, 11410.087193024538, 20021.599568008558, 20052.89973550123, 20094.49763755918, 20150.0, 20463.18147274122, 8275.379346549033, 8307.584620769057, 8362.54006029662, 8388.203120703523, 8388.958055209685, 4693.155232058194, 4750.0, 4825.445073816486, 4855.878603034882, 4885.364902562644, 3283.753718471124, 3345.063382252973, 3353.0108617957762, 3357.3453176630323, 3357.362101200764, 609.8658295175143, 617.9938200617936, 652.0773106054974, 676.2932735291533, 679.8708245433352, 622.8380621038563, 684.2063206680227, 701.5755467941924, 706.156143408632, 717.4547344018583, 9369.203617692572, 9733.415995040321, 9851.0, 9934.900650993397, 9963.252756043326, 603.9456448919531, 616.8334549671564, 623.382850977538, 712.682856129028, 716.1799739298474, 4615.192341340319, 4701.976490117528, 4779.4264688236935, 4789.4971028042255, 4838.080764654705, 67825.0, 68815.0, 69333.30666693268, 69438.65280673564, 69647.3035269651, 62722.68638656777, 63176.36823631797, 63312.68343658252, 63353.0, 63755.36244637587, 54515.18227226595, 54517.454825452034, 54533.72733136309, 55281.17078243749, 55614.16578751322, 7893.565853878092, 8109.7161599343735, 8514.531700756517, 8560.14398560139, 8746.212840844355, 35837.283254335285, 35910.28179436344, 36134.0, 37492.250154997295, 38013.0, 45213.0, 45262.321065184704, 45596.0, 46041.53958460507, 50783.49216507788, 11713.297202167898, 11859.0, 12065.09511786602, 12316.630501084981, 12717.55488557896, 12679.746405071663, 13754.724905501635, 13755.17468951826, 13797.724045519235, 13841.238731869442, 12772.0, 12929.353532323534, 12969.935150324189, 12998.610041698765, 13462.259575723428, 13108.803367949678, 13184.143030702973, 13209.27348995776, 13227.140235884637, 13313.0, 11335.716607084889, 12753.426095825525, 12831.679208019874, 13212.867871321163, 13634.522791702242, 9593.184579310837, 9681.0, 10129.949350253202, 10145.137663298407, 10268.281220314806, 10628.309159904582, 10673.252872298865, 10820.4048777318, 10902.18233632465, 10911.618093366695], "value": 6893.546399256093, "unit": "score"}], "name": "dromaeo_css", "value": 6999.19586561905, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 108.0, 113.0, 112.0, 114.0, 125.0, 115.0, 115.0, 113.0, 112.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 130.0, 155.0, 182.0, 132.0, 161.0, 152.0, 136.0, 180.0, 128.0], "value": 151.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 163.0, 161.0, 164.0, 167.0, 173.0, 162.0, 165.0, 162.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 73.0, 173.0, 77.0, 77.0, 74.0, 74.0, 157.0, 79.0], "value": 93.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 92.0, 147.0, 93.0, 93.0, 93.0, 140.0, 93.0, 93.0, 148.0], "value": 108.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 118.0, 118.0, 118.0, 117.0, 120.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 58.0, 60.0, 58.0, 59.0, 57.0, 78.0, 56.0, 56.0], "value": 60.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 63.0, 62.0, 61.0, 61.0, 62.0, 63.0, 60.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 81.0, 78.0, 85.0, 78.0, 86.0, 79.0, 80.0, 80.0, 80.0], "value": 80.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 125.0, 134.0, 129.0, 132.0, 127.0, 142.0, 130.0, 166.0, 131.0], "value": 135.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [205.0, 207.0, 206.0, 211.0, 204.0, 202.0, 201.0, 207.0, 202.0, 204.0], "value": 204.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 71.0, 73.0, 70.0, 77.0, 74.0, 68.0, 70.0, 79.0], "value": 72.5, "unit": "score"}], "name": "kraken", "value": 1605.5, "alertThreshold": 2.0}]} 19:28:39 INFO - Return code: 0 19:28:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:28:39 ERROR - # TBPL SUCCESS # 19:28:39 INFO - Running post-action listener: _resource_record_post_action 19:28:39 INFO - Running post-run listener: _resource_record_post_run 19:28:40 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 8192; Write bytes: 534528000; Read time: 104; Write time: 418744 19:28:40 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 244764672; Read time: 0; Write time: 209620 19:28:40 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 8192; Write bytes: 289763328; Read time: 104; Write time: 209124 19:28:40 INFO - Running post-run listener: _upload_blobber_files 19:28:40 INFO - Blob upload gear active. 19:28:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:28:40 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 19:28:40 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:28:40 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:28:40 INFO - (blobuploader) - INFO - Open directory for files ... 19:28:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:28:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:28:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:28:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:28:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:28:41 INFO - (blobuploader) - INFO - Done attempting. 19:28:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:28:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:28:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:28:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:28:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:28:42 INFO - (blobuploader) - INFO - Done attempting. 19:28:42 INFO - (blobuploader) - INFO - Iteration through files over. 19:28:42 INFO - Return code: 0 19:28:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:28:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:28:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa6b155a717fc67b3fc5f4afcea8979ad6f8325a5b20ff7eaf6fa6d0038402486c2297ff45ee82ca458c1c7847af603591ce6d580bc8734c1f22787d68a8c8da", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3896cc6e6bff1e4f0a88ea8bd54ffb64d54a3cbda813684fea9bebd828e3a1f8bce4f57504642615ed30d0147d5c21449f84fe1ed8340dd8e0c9f51393f82959"} 19:28:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:28:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:28:42 INFO - Contents: 19:28:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa6b155a717fc67b3fc5f4afcea8979ad6f8325a5b20ff7eaf6fa6d0038402486c2297ff45ee82ca458c1c7847af603591ce6d580bc8734c1f22787d68a8c8da", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3896cc6e6bff1e4f0a88ea8bd54ffb64d54a3cbda813684fea9bebd828e3a1f8bce4f57504642615ed30d0147d5c21449f84fe1ed8340dd8e0c9f51393f82959"} 19:28:42 INFO - Running post-run listener: copy_logs_to_upload_dir 19:28:42 INFO - Copying logs to upload dir... 19:28:42 INFO - mkdir: /builds/slave/test/build/upload/logs 19:28:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.443746 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-04-26 19:28:41.620165) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 19:28:41.624187) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1461712007.173771-80039984 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa6b155a717fc67b3fc5f4afcea8979ad6f8325a5b20ff7eaf6fa6d0038402486c2297ff45ee82ca458c1c7847af603591ce6d580bc8734c1f22787d68a8c8da", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3896cc6e6bff1e4f0a88ea8bd54ffb64d54a3cbda813684fea9bebd828e3a1f8bce4f57504642615ed30d0147d5c21449f84fe1ed8340dd8e0c9f51393f82959"} build_url:https://queue.taskcluster.net/v1/task/eabI_t4BQVCpnXivflvv2g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011117 build_url: 'https://queue.taskcluster.net/v1/task/eabI_t4BQVCpnXivflvv2g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa6b155a717fc67b3fc5f4afcea8979ad6f8325a5b20ff7eaf6fa6d0038402486c2297ff45ee82ca458c1c7847af603591ce6d580bc8734c1f22787d68a8c8da", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3896cc6e6bff1e4f0a88ea8bd54ffb64d54a3cbda813684fea9bebd828e3a1f8bce4f57504642615ed30d0147d5c21449f84fe1ed8340dd8e0c9f51393f82959"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 19:28:41.649630) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 19:28:41.649998) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1461712007.173771-80039984 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 19:28:41.733920) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 19:28:41.734334) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 19:28:41.734687) ========= ========= Total master_lag: 0.18 =========