builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-040 starttime: 1466719825.39 results: success (0) buildid: 20160623122823 builduid: b5460e7bfd014a1ea1343355595f8464 revision: 13b02b96281e550c3cdbdf4eaed034aa1edefd69 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 15:10:25.387494) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 15:10:25.388050) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 15:10:25.388369) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 15:10:25.470626) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 15:10:25.471286) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9e0dfe3369c33a1556e63f89000001d8-1466719532.686411-1124632631 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-23 15:10:25-- 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% 40.7M=0s 2016-06-23 15:10:25 (40.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.196469 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 15:10:25.695220) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 15:10:25.695598) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9e0dfe3369c33a1556e63f89000001d8-1466719532.686411-1124632631 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.050160 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 15:10:25.758951) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 15:10:25.759309) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 13b02b96281e550c3cdbdf4eaed034aa1edefd69 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 13b02b96281e550c3cdbdf4eaed034aa1edefd69 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9e0dfe3369c33a1556e63f89000001d8-1466719532.686411-1124632631 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-23 15:10:25,813 truncating revision to first 12 chars 2016-06-23 15:10:25,813 Setting DEBUG logging. 2016-06-23 15:10:25,813 attempt 1/10 2016-06-23 15:10:25,813 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/13b02b96281e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-23 15:10:26,133 unpacking tar archive at: mozilla-beta-13b02b96281e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.641875 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 15:10:26.414737) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 15:10:26.415122) ========= script_repo_revision: 13b02b96281e550c3cdbdf4eaed034aa1edefd69 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 15:10:26.415553) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 15:10:26.415828) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 15:10:26.426371) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-06-23 15:10:26.426770) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9e0dfe3369c33a1556e63f89000001d8-1466719532.686411-1124632631 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:10:26 INFO - MultiFileLogger online at 20160623 15:10:26 in /builds/slave/test 15:10:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 15:10:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:10:26 INFO - {'append_to_log': False, 15:10:26 INFO - 'base_work_dir': '/builds/slave/test', 15:10:26 INFO - 'blob_upload_branch': 'Mozilla-Beta', 15:10:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:10:26 INFO - 'branch': 'Mozilla-Beta', 15:10:26 INFO - 'buildbot_json_path': 'buildprops.json', 15:10:26 INFO - 'config_files': ('talos/linux_config.py',), 15:10:26 INFO - 'default_actions': ('clobber', 15:10:26 INFO - 'read-buildbot-config', 15:10:26 INFO - 'download-and-extract', 15:10:26 INFO - 'populate-webroot', 15:10:26 INFO - 'create-virtualenv', 15:10:26 INFO - 'install', 15:10:26 INFO - 'run-tests'), 15:10:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:10:26 INFO - 'download_minidump_stackwalk': True, 15:10:26 INFO - 'download_symbols': 'ondemand', 15:10:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:10:26 INFO - 'tooltool.py': '/tools/tooltool.py', 15:10:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:10:26 INFO - '/tools/misc-python/virtualenv.py')}, 15:10:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:10:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:10:26 INFO - 'installer_path': 'installer.exe', 15:10:26 INFO - 'log_level': 'info', 15:10:26 INFO - 'log_name': 'talos', 15:10:26 INFO - 'log_to_console': True, 15:10:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:10:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:10:26 INFO - 'opt_config_files': (), 15:10:26 INFO - 'pip_index': False, 15:10:26 INFO - 'sps_profile': False, 15:10:26 INFO - 'sps_profile_interval': 0, 15:10:26 INFO - 'suite': 'dromaeojs-e10s', 15:10:26 INFO - 'system_bits': '32', 15:10:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:10:26 INFO - 'title': 'talos-linux64-ix-040', 15:10:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:10:26 INFO - 'use_talos_json': True, 15:10:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:10:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:10:26 INFO - 'work_dir': 'build'} 15:10:26 INFO - ##### 15:10:26 INFO - ##### Running clobber step. 15:10:26 INFO - ##### 15:10:26 INFO - Running pre-action listener: _resource_record_pre_action 15:10:26 INFO - Running main action method: clobber 15:10:26 INFO - rmtree: /builds/slave/test/build 15:10:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:10:28 INFO - Running post-action listener: _resource_record_post_action 15:10:28 INFO - ##### 15:10:28 INFO - ##### Running read-buildbot-config step. 15:10:28 INFO - ##### 15:10:28 INFO - Running pre-action listener: _resource_record_pre_action 15:10:28 INFO - Running main action method: read_buildbot_config 15:10:28 INFO - Using buildbot properties: 15:10:28 INFO - { 15:10:28 INFO - "project": "", 15:10:28 INFO - "product": "firefox", 15:10:28 INFO - "script_repo_revision": "production", 15:10:28 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 15:10:28 INFO - "repository": "", 15:10:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 15:10:28 INFO - "buildid": "20160623122823", 15:10:28 INFO - "pgo_build": "True", 15:10:28 INFO - "basedir": "/builds/slave/test", 15:10:28 INFO - "buildnumber": 56, 15:10:28 INFO - "slavename": "talos-linux64-ix-040", 15:10:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:10:28 INFO - "platform": "ubuntu64_hw", 15:10:28 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 15:10:28 INFO - "branch": "mozilla-beta", 15:10:28 INFO - "repo_path": "releases/mozilla-beta", 15:10:28 INFO - "revision": "13b02b96281e550c3cdbdf4eaed034aa1edefd69", 15:10:28 INFO - "stage_platform": "linux64-pgo", 15:10:28 INFO - "builduid": "b5460e7bfd014a1ea1343355595f8464", 15:10:28 INFO - "slavebuilddir": "test" 15:10:28 INFO - } 15:10:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 15:10:28 INFO - Running post-action listener: _resource_record_post_action 15:10:28 INFO - ##### 15:10:28 INFO - ##### Running download-and-extract step. 15:10:28 INFO - ##### 15:10:28 INFO - Running pre-action listener: _resource_record_pre_action 15:10:28 INFO - Running main action method: download_and_extract 15:10:28 INFO - mkdir: /builds/slave/test/build/tests 15:10:28 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')]} 15:10:28 INFO - https://queue.taskcluster.net/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:10:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 15:10:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 15:10:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 15:10:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:10:30 INFO - Downloaded 1327 bytes. 15:10:30 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 15:10:30 INFO - Using the following test package requirements: 15:10:30 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 15:10:30 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:10:30 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 15:10:30 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:10:30 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 15:10:30 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:10:30 INFO - u'jsshell-linux-x86_64.zip'], 15:10:30 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:10:30 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 15:10:30 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 15:10:30 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:10:30 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 15:10:30 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:10:30 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 15:10:30 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:10:30 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 15:10:30 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:10:30 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 15:10:30 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:10:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:10:30 INFO - https://queue.taskcluster.net/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:10:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 15:10:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 15:10:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 15:10:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:10:32 INFO - Downloaded 24186833 bytes. 15:10:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:10:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:10:33 INFO - Return code: 0 15:10:33 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:10:33 INFO - https://queue.taskcluster.net/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:10:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 15:10:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 15:10:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 15:10:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:10:34 INFO - Downloaded 24186833 bytes. 15:10:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:10:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:10:36 INFO - Return code: 0 15:10:36 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')]} 15:10:36 INFO - https://queue.taskcluster.net/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:10:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 15:10:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 15:10:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 15:10:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:10:37 INFO - Downloaded 10840145 bytes. 15:10:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:10:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:10:37 INFO - Return code: 0 15:10:37 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')]} 15:10:37 INFO - https://queue.taskcluster.net/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:10:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 15:10:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 15:10:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 15:10:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:10:38 INFO - Downloaded 56012995 bytes. 15:10:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 15:10:38 INFO - mkdir: /builds/slave/test/properties 15:10:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:10:38 INFO - Writing to file /builds/slave/test/properties/build_url 15:10:38 INFO - Contents: 15:10:38 INFO - build_url:https://queue.taskcluster.net/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 15:10:39 INFO - Running post-action listener: _resource_record_post_action 15:10:39 INFO - Running post-action listener: set_extra_try_arguments 15:10:39 INFO - ##### 15:10:39 INFO - ##### Running populate-webroot step. 15:10:39 INFO - ##### 15:10:39 INFO - Running pre-action listener: _resource_record_pre_action 15:10:39 INFO - Running main action method: populate_webroot 15:10:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:10:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:10:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:10:39 INFO - '--tppagecycles', 15:10:39 INFO - '7'], 15:10:39 INFO - 'tests': ['tsvgm']}}, 15:10:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:10:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:10:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:10:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:10:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:10:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:10:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:39 INFO - 'talos_options': ['--disable-e10s'], 15:10:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:10:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:10:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:39 INFO - 'talos_options': ['--disable-e10s'], 15:10:39 INFO - 'tests': ['damp', 'tps']}, 15:10:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:39 INFO - 'tests': ['damp', 'tps']}, 15:10:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:10:39 INFO - 'tests': ['dromaeo_dom']}, 15:10:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:10:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:10:39 INFO - 'tests': ['a11yr', 15:10:39 INFO - 'ts_paint', 15:10:39 INFO - 'tpaint', 15:10:39 INFO - 'sessionrestore', 15:10:39 INFO - 'sessionrestore_no_auto_restore', 15:10:39 INFO - 'tabpaint']}, 15:10:39 INFO - 'other-e10s': {'tests': ['a11yr', 15:10:39 INFO - 'ts_paint', 15:10:39 INFO - 'tpaint', 15:10:39 INFO - 'sessionrestore', 15:10:39 INFO - 'sessionrestore_no_auto_restore', 15:10:39 INFO - 'tabpaint']}, 15:10:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:10:39 INFO - 'ts_paint', 15:10:39 INFO - 'tpaint', 15:10:39 INFO - 'sessionrestore', 15:10:39 INFO - 'sessionrestore_no_auto_restore', 15:10:39 INFO - 'tabpaint']}, 15:10:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:10:39 INFO - 'ts_paint', 15:10:39 INFO - 'tpaint', 15:10:39 INFO - 'sessionrestore', 15:10:39 INFO - 'sessionrestore_no_auto_restore', 15:10:39 INFO - 'tabpaint']}, 15:10:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:10:39 INFO - 'tests': ['a11yr', 15:10:39 INFO - 'ts_paint', 15:10:39 INFO - 'tpaint', 15:10:39 INFO - 'sessionrestore', 15:10:39 INFO - 'sessionrestore_no_auto_restore', 15:10:39 INFO - 'tabpaint']}, 15:10:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:10:39 INFO - 'tests': ['a11yr', 15:10:39 INFO - 'ts_paint', 15:10:39 INFO - 'tpaint', 15:10:39 INFO - 'sessionrestore', 15:10:39 INFO - 'sessionrestore_no_auto_restore', 15:10:39 INFO - 'tabpaint']}, 15:10:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:10:39 INFO - 'tests': ['tsvgx', 15:10:39 INFO - 'tsvgr_opacity', 15:10:39 INFO - 'tart', 15:10:39 INFO - 'tscrollx', 15:10:39 INFO - 'cart']}, 15:10:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:10:39 INFO - 'tsvgr_opacity', 15:10:39 INFO - 'tart', 15:10:39 INFO - 'tscrollx', 15:10:39 INFO - 'cart']}, 15:10:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:39 INFO - 'talos_options': ['--disable-e10s'], 15:10:39 INFO - 'tests': ['tp5o']}, 15:10:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:39 INFO - 'tests': ['tp5o']}, 15:10:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:39 INFO - 'talos_options': ['--disable-e10s', 15:10:39 INFO - '--xperf_path', 15:10:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:10:39 INFO - 'tests': ['tp5n']}, 15:10:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:39 INFO - 'talos_options': ['--xperf_path', 15:10:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:10:39 INFO - 'tests': ['tp5n']}}, 15:10:39 INFO - 'talos.zip': {'path': '', 15:10:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:10:39 INFO - Running post-action listener: _resource_record_post_action 15:10:39 INFO - ##### 15:10:39 INFO - ##### Running create-virtualenv step. 15:10:39 INFO - ##### 15:10:39 INFO - Running pre-action listener: _resource_record_pre_action 15:10:39 INFO - Running main action method: create_virtualenv 15:10:39 INFO - Creating virtualenv /builds/slave/test/build/venv 15:10:39 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 15:10:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:10:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:10:39 INFO - Using real prefix '/usr' 15:10:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:10:40 INFO - Installing distribute.............................................................................................................................................................................................done. 15:10:42 INFO - Installing pip.................done. 15:10:42 INFO - Return code: 0 15:10:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:10: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')]} 15:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10: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')]} 15:10:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1628c3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22cd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235c410>, '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 0x235d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x235d7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466719532.686411-1124632631', '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 15:10: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', 'pip>=1.5'] in /builds/slave/test/build 15:10: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 pip>=1.5 15:10:42 INFO - Using env: {'DISPLAY': ':0', 15:10:42 INFO - 'HOME': '/home/cltbld', 15:10:42 INFO - 'LANG': 'en_US.UTF-8', 15:10:42 INFO - 'LANGUAGE': 'en_US:en', 15:10:42 INFO - 'LOGNAME': 'cltbld', 15:10:42 INFO - 'MAIL': '/var/mail/cltbld', 15:10:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:42 INFO - 'MOZ_NO_REMOTE': '1', 15:10:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:42 INFO - 'NO_EM_RESTART': '1', 15:10:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:42 INFO - 'PWD': '/builds/slave/test', 15:10:42 INFO - 'SHELL': '/bin/bash', 15:10:42 INFO - 'SHLVL': '1', 15:10:42 INFO - 'TERM': 'linux', 15:10:42 INFO - 'TMOUT': '86400', 15:10:42 INFO - 'USER': 'cltbld', 15:10:42 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466719532.686411-1124632631', 15:10:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:42 INFO - '_': '/tools/buildbot/bin/python'} 15:10:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:43 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 15:10:43 INFO - Cleaning up... 15:10:43 INFO - Return code: 0 15:10:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:10:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:10:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:10:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1628c3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22cd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235c410>, '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 0x235d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x235d7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466719532.686411-1124632631', '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 15:10:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 15:10:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 15:10:43 INFO - Using env: {'DISPLAY': ':0', 15:10:43 INFO - 'HOME': '/home/cltbld', 15:10:43 INFO - 'LANG': 'en_US.UTF-8', 15:10:43 INFO - 'LANGUAGE': 'en_US:en', 15:10:43 INFO - 'LOGNAME': 'cltbld', 15:10:43 INFO - 'MAIL': '/var/mail/cltbld', 15:10:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:43 INFO - 'MOZ_NO_REMOTE': '1', 15:10:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:43 INFO - 'NO_EM_RESTART': '1', 15:10:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:43 INFO - 'PWD': '/builds/slave/test', 15:10:43 INFO - 'SHELL': '/bin/bash', 15:10:43 INFO - 'SHLVL': '1', 15:10:43 INFO - 'TERM': 'linux', 15:10:43 INFO - 'TMOUT': '86400', 15:10:43 INFO - 'USER': 'cltbld', 15:10:43 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466719532.686411-1124632631', 15:10:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:43 INFO - '_': '/tools/buildbot/bin/python'} 15:10:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:43 INFO - Downloading/unpacking psutil>=0.7.1 15:10:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:10:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:10:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:10:45 INFO - Installing collected packages: psutil 15:10:45 INFO - Running setup.py install for psutil 15:10:45 INFO - building 'psutil._psutil_linux' extension 15:10:45 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 15:10:47 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 15:10:47 INFO - building 'psutil._psutil_posix' extension 15:10:47 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 15:10:48 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 15:10:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:10:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:10:48 INFO - Successfully installed psutil 15:10:48 INFO - Cleaning up... 15:10:48 INFO - Return code: 0 15:10:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:10:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:10:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:48 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 0x7f1628c3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22cd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235c410>, '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 0x235d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x235d7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466719532.686411-1124632631', '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 15:10:48 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 15:10:48 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 15:10:48 INFO - Using env: {'DISPLAY': ':0', 15:10:48 INFO - 'HOME': '/home/cltbld', 15:10:48 INFO - 'LANG': 'en_US.UTF-8', 15:10:48 INFO - 'LANGUAGE': 'en_US:en', 15:10:48 INFO - 'LOGNAME': 'cltbld', 15:10:48 INFO - 'MAIL': '/var/mail/cltbld', 15:10:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:48 INFO - 'MOZ_NO_REMOTE': '1', 15:10:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:48 INFO - 'NO_EM_RESTART': '1', 15:10:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:48 INFO - 'PWD': '/builds/slave/test', 15:10:48 INFO - 'SHELL': '/bin/bash', 15:10:48 INFO - 'SHLVL': '1', 15:10:48 INFO - 'TERM': 'linux', 15:10:48 INFO - 'TMOUT': '86400', 15:10:48 INFO - 'USER': 'cltbld', 15:10:48 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466719532.686411-1124632631', 15:10:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:48 INFO - '_': '/tools/buildbot/bin/python'} 15:10:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:10:48 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 15:10:48 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 15:10:48 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 15:10:48 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 15:10:48 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 15:10:48 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 15:10:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:10:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:10:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:10:50 INFO - Installing collected packages: mozsystemmonitor 15:10:50 INFO - Running setup.py install for mozsystemmonitor 15:10:50 INFO - Successfully installed mozsystemmonitor 15:10:50 INFO - Cleaning up... 15:10:50 INFO - Return code: 0 15:10:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:10:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:10:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:10:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:50 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 0x7f1628c3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22cd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235c410>, '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 0x235d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x235d7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466719532.686411-1124632631', '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 15:10:50 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 15:10:50 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 15:10:50 INFO - Using env: {'DISPLAY': ':0', 15:10:50 INFO - 'HOME': '/home/cltbld', 15:10:50 INFO - 'LANG': 'en_US.UTF-8', 15:10:50 INFO - 'LANGUAGE': 'en_US:en', 15:10:50 INFO - 'LOGNAME': 'cltbld', 15:10:50 INFO - 'MAIL': '/var/mail/cltbld', 15:10:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:50 INFO - 'MOZ_NO_REMOTE': '1', 15:10:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:50 INFO - 'NO_EM_RESTART': '1', 15:10:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:50 INFO - 'PWD': '/builds/slave/test', 15:10:50 INFO - 'SHELL': '/bin/bash', 15:10:50 INFO - 'SHLVL': '1', 15:10:50 INFO - 'TERM': 'linux', 15:10:50 INFO - 'TMOUT': '86400', 15:10:50 INFO - 'USER': 'cltbld', 15:10:50 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466719532.686411-1124632631', 15:10:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:50 INFO - '_': '/tools/buildbot/bin/python'} 15:10:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:50 INFO - Downloading/unpacking blobuploader==1.2.4 15:10:50 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 15:10:50 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 15:10:50 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 15:10:50 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 15:10:50 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 15:10:50 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 15:10:52 INFO - Downloading blobuploader-1.2.4.tar.gz 15:10:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:10:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:10:52 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 15:10:52 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 15:10:52 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 15:10:52 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 15:10:52 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 15:10:52 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 15:10:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:10:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:10:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:53 INFO - Downloading docopt-0.6.1.tar.gz 15:10:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:10:53 INFO - Installing collected packages: blobuploader, requests, docopt 15:10:53 INFO - Running setup.py install for blobuploader 15:10:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:10:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:10:53 INFO - Running setup.py install for requests 15:10:54 INFO - Running setup.py install for docopt 15:10:54 INFO - Successfully installed blobuploader requests docopt 15:10:54 INFO - Cleaning up... 15:10:54 INFO - Return code: 0 15:10:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:10:54 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')]} 15:10:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:54 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')]} 15:10:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:54 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 0x7f1628c3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22cd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235c410>, '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 0x235d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x235d7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466719532.686411-1124632631', '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 15:10:54 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 15:10:54 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 15:10:54 INFO - Using env: {'DISPLAY': ':0', 15:10:54 INFO - 'HOME': '/home/cltbld', 15:10:54 INFO - 'LANG': 'en_US.UTF-8', 15:10:54 INFO - 'LANGUAGE': 'en_US:en', 15:10:54 INFO - 'LOGNAME': 'cltbld', 15:10:54 INFO - 'MAIL': '/var/mail/cltbld', 15:10:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:54 INFO - 'MOZ_NO_REMOTE': '1', 15:10:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:54 INFO - 'NO_EM_RESTART': '1', 15:10:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:54 INFO - 'PWD': '/builds/slave/test', 15:10:54 INFO - 'SHELL': '/bin/bash', 15:10:54 INFO - 'SHLVL': '1', 15:10:54 INFO - 'TERM': 'linux', 15:10:54 INFO - 'TMOUT': '86400', 15:10:54 INFO - 'USER': 'cltbld', 15:10:54 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466719532.686411-1124632631', 15:10:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:54 INFO - '_': '/tools/buildbot/bin/python'} 15:10:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:10:54 INFO - Running setup.py (path:/tmp/pip-4pRPva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:10:54 INFO - Running setup.py (path:/tmp/pip-7uKRMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:10:54 INFO - Running setup.py (path:/tmp/pip-wFYD_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:10:54 INFO - Running setup.py (path:/tmp/pip-15avpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:10:54 INFO - Running setup.py (path:/tmp/pip-va10OY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:10:54 INFO - Running setup.py (path:/tmp/pip-YygLqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:10:54 INFO - Running setup.py (path:/tmp/pip-N_K0cu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:10:54 INFO - Running setup.py (path:/tmp/pip-IxAV0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:10:54 INFO - Running setup.py (path:/tmp/pip-Thz4ft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:10:55 INFO - Running setup.py (path:/tmp/pip-ahrJmI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:10:55 INFO - Running setup.py (path:/tmp/pip-j8fn0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:10:55 INFO - Running setup.py (path:/tmp/pip-kGxoCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:10:55 INFO - Running setup.py (path:/tmp/pip-Smh1FZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:10:55 INFO - Running setup.py (path:/tmp/pip-cxx2Pz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:10:55 INFO - Running setup.py (path:/tmp/pip-PPJbtx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:10:55 INFO - Running setup.py (path:/tmp/pip-ulJQlF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:10:55 INFO - Running setup.py (path:/tmp/pip-FeKUKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:10:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:10:55 INFO - Running setup.py install for manifestparser 15:10:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:10:55 INFO - Running setup.py install for mozcrash 15:10:55 INFO - Running setup.py install for mozdebug 15:10:55 INFO - Running setup.py install for mozdevice 15:10:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:10:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:10:56 INFO - Running setup.py install for mozfile 15:10:56 INFO - Running setup.py install for mozhttpd 15:10:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:10:56 INFO - Running setup.py install for mozinfo 15:10:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:10:56 INFO - Running setup.py install for mozInstall 15:10:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:10:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:10:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:10:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:10:56 INFO - Running setup.py install for mozleak 15:10:56 INFO - Running setup.py install for mozlog 15:10:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:10:56 INFO - Running setup.py install for moznetwork 15:10:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:10:56 INFO - Running setup.py install for mozprocess 15:10:56 INFO - Running setup.py install for mozprofile 15:10:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:10:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:10:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:10:56 INFO - Running setup.py install for mozrunner 15:10:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:10:57 INFO - Running setup.py install for mozscreenshot 15:10:57 INFO - Running setup.py install for moztest 15:10:57 INFO - Running setup.py install for mozversion 15:10:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:10:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:10:57 INFO - Cleaning up... 15:10:57 INFO - Return code: 0 15:10:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:10:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:10:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:57 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 0x7f1628c3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22cd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235c410>, '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 0x235d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x235d7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466719532.686411-1124632631', '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 15:10:57 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 15:10:57 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 15:10:57 INFO - Using env: {'DISPLAY': ':0', 15:10:57 INFO - 'HOME': '/home/cltbld', 15:10:57 INFO - 'LANG': 'en_US.UTF-8', 15:10:57 INFO - 'LANGUAGE': 'en_US:en', 15:10:57 INFO - 'LOGNAME': 'cltbld', 15:10:57 INFO - 'MAIL': '/var/mail/cltbld', 15:10:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:57 INFO - 'MOZ_NO_REMOTE': '1', 15:10:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:57 INFO - 'NO_EM_RESTART': '1', 15:10:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:57 INFO - 'PWD': '/builds/slave/test', 15:10:57 INFO - 'SHELL': '/bin/bash', 15:10:57 INFO - 'SHLVL': '1', 15:10:57 INFO - 'TERM': 'linux', 15:10:57 INFO - 'TMOUT': '86400', 15:10:57 INFO - 'USER': 'cltbld', 15:10:57 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466719532.686411-1124632631', 15:10:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:57 INFO - '_': '/tools/buildbot/bin/python'} 15:10:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:10:57 INFO - Running setup.py (path:/tmp/pip-F8V43C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:10:57 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)) 15:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:10:57 INFO - Running setup.py (path:/tmp/pip-Y5QO8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:10:57 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)) 15:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:10:57 INFO - Running setup.py (path:/tmp/pip-_YA_th-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:10:57 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)) 15:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:10:57 INFO - Running setup.py (path:/tmp/pip-vnuz_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:10:57 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)) 15:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:10:57 INFO - Running setup.py (path:/tmp/pip-QCX8bw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:10:57 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)) 15:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:10:57 INFO - Running setup.py (path:/tmp/pip-GXahhu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:10:58 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)) 15:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:10:58 INFO - Running setup.py (path:/tmp/pip-BTuPmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:10:58 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)) 15:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:10:58 INFO - Running setup.py (path:/tmp/pip-nbto36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:10:58 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)) 15:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:10:58 INFO - Running setup.py (path:/tmp/pip-qerz19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:10:58 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)) 15:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:10:58 INFO - Running setup.py (path:/tmp/pip-zCt0uN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:10:58 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)) 15:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:10:58 INFO - Running setup.py (path:/tmp/pip-LcnNcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:10:58 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)) 15:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:10:58 INFO - Running setup.py (path:/tmp/pip-zlK9gM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:10:58 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)) 15:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:10:58 INFO - Running setup.py (path:/tmp/pip-XRzI5_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:10:58 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)) 15:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:10:58 INFO - Running setup.py (path:/tmp/pip-PARPKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:10:58 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)) 15:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:10:58 INFO - Running setup.py (path:/tmp/pip-ZP8kZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:10:58 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)) 15:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:10:58 INFO - Running setup.py (path:/tmp/pip-7ER6U6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:10:58 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)) 15:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:10:58 INFO - Running setup.py (path:/tmp/pip-K0_knd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:10:58 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)) 15:10:58 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)) 15:10:58 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)) 15:10:58 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)) 15:10:58 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)) 15:10:58 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)) 15:10:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:11:00 INFO - Downloading blessings-1.6.tar.gz 15:11:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:11:00 INFO - Installing collected packages: blessings 15:11:00 INFO - Running setup.py install for blessings 15:11:00 INFO - Successfully installed blessings 15:11:00 INFO - Cleaning up... 15:11:00 INFO - Return code: 0 15:11:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:11:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:11:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:11:01 INFO - Reading from file tmpfile_stdout 15:11:01 INFO - Current package versions: 15:11:01 INFO - argparse == 1.2.1 15:11:01 INFO - blessings == 1.6 15:11:01 INFO - blobuploader == 1.2.4 15:11:01 INFO - docopt == 0.6.1 15:11:01 INFO - manifestparser == 1.1 15:11:01 INFO - mozInstall == 1.12 15:11:01 INFO - mozcrash == 0.17 15:11:01 INFO - mozdebug == 0.1 15:11:01 INFO - mozdevice == 0.48 15:11:01 INFO - mozfile == 1.2 15:11:01 INFO - mozhttpd == 0.7 15:11:01 INFO - mozinfo == 0.9 15:11:01 INFO - mozleak == 0.1 15:11:01 INFO - mozlog == 3.1 15:11:01 INFO - moznetwork == 0.27 15:11:01 INFO - mozprocess == 0.22 15:11:01 INFO - mozprofile == 0.28 15:11:01 INFO - mozrunner == 6.11 15:11:01 INFO - mozscreenshot == 0.1 15:11:01 INFO - mozsystemmonitor == 0.0 15:11:01 INFO - moztest == 0.7 15:11:01 INFO - mozversion == 1.4 15:11:01 INFO - psutil == 3.1.1 15:11:01 INFO - requests == 1.2.3 15:11:01 INFO - wsgiref == 0.1.2 15:11:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:11:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:11:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:11:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:11:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11:01 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 0x7f1628c3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22cd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235c410>, '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 0x235d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x235d7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466719532.686411-1124632631', '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 15:11:01 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 15:11:01 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 15:11:01 INFO - Using env: {'DISPLAY': ':0', 15:11:01 INFO - 'HOME': '/home/cltbld', 15:11:01 INFO - 'LANG': 'en_US.UTF-8', 15:11:01 INFO - 'LANGUAGE': 'en_US:en', 15:11:01 INFO - 'LOGNAME': 'cltbld', 15:11:01 INFO - 'MAIL': '/var/mail/cltbld', 15:11:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:01 INFO - 'MOZ_NO_REMOTE': '1', 15:11:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:11:01 INFO - 'NO_EM_RESTART': '1', 15:11:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:11:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:01 INFO - 'PWD': '/builds/slave/test', 15:11:01 INFO - 'SHELL': '/bin/bash', 15:11:01 INFO - 'SHLVL': '1', 15:11:01 INFO - 'TERM': 'linux', 15:11:01 INFO - 'TMOUT': '86400', 15:11:01 INFO - 'USER': 'cltbld', 15:11:01 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466719532.686411-1124632631', 15:11:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:01 INFO - '_': '/tools/buildbot/bin/python'} 15:11:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:11:01 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)) 15:11:01 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)) 15:11:01 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)) 15:11:01 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)) 15:11:01 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)) 15:11:01 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)) 15:11:01 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)) 15:11:01 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)) 15:11:01 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)) 15:11:01 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)) 15:11:01 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)) 15:11:01 INFO - Cleaning up... 15:11:01 INFO - Return code: 0 15:11:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:11:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:11:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:11:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:11:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11:01 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 0x7f1628c3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22cd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235c410>, '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 0x235d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x235d7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466719532.686411-1124632631', '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 15:11:01 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 15:11:01 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 15:11:01 INFO - Using env: {'DISPLAY': ':0', 15:11:01 INFO - 'HOME': '/home/cltbld', 15:11:01 INFO - 'LANG': 'en_US.UTF-8', 15:11:01 INFO - 'LANGUAGE': 'en_US:en', 15:11:01 INFO - 'LOGNAME': 'cltbld', 15:11:01 INFO - 'MAIL': '/var/mail/cltbld', 15:11:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:01 INFO - 'MOZ_NO_REMOTE': '1', 15:11:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:11:01 INFO - 'NO_EM_RESTART': '1', 15:11:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:11:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:01 INFO - 'PWD': '/builds/slave/test', 15:11:01 INFO - 'SHELL': '/bin/bash', 15:11:01 INFO - 'SHLVL': '1', 15:11:01 INFO - 'TERM': 'linux', 15:11:01 INFO - 'TMOUT': '86400', 15:11:01 INFO - 'USER': 'cltbld', 15:11:01 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466719532.686411-1124632631', 15:11:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:01 INFO - '_': '/tools/buildbot/bin/python'} 15:11:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:11:01 INFO - Downloading/unpacking jsonschema 15:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:11:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:11:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:11:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:11:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:11:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:11:03 INFO - Downloading/unpacking functools32 (from jsonschema) 15:11:03 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 15:11:03 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 15:11:03 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 15:11:03 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 15:11:03 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 15:11:03 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 15:11:03 INFO - Downloading functools32-3.2.3-2.tar.gz 15:11:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:11:03 INFO - warning: no files found matching '*.txt' 15:11:03 INFO - no previously-included directories found matching 'build' 15:11:03 INFO - no previously-included directories found matching 'dist' 15:11:03 INFO - no previously-included directories found matching '.git*' 15:11:03 INFO - Installing collected packages: jsonschema, functools32 15:11:03 INFO - Running setup.py install for functools32 15:11:03 INFO - warning: no files found matching '*.txt' 15:11:03 INFO - no previously-included directories found matching 'build' 15:11:03 INFO - no previously-included directories found matching 'dist' 15:11:03 INFO - no previously-included directories found matching '.git*' 15:11:03 INFO - Successfully installed jsonschema functools32 15:11:03 INFO - Cleaning up... 15:11:04 INFO - Return code: 0 15:11:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:11: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')]} 15:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:11:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11: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')]} 15:11:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:11:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11:04 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 0x7f1628c3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22cd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235c410>, '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 0x235d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x235d7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466719532.686411-1124632631', '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 15:11:04 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 15:11:04 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 15:11:04 INFO - Using env: {'DISPLAY': ':0', 15:11:04 INFO - 'HOME': '/home/cltbld', 15:11:04 INFO - 'LANG': 'en_US.UTF-8', 15:11:04 INFO - 'LANGUAGE': 'en_US:en', 15:11:04 INFO - 'LOGNAME': 'cltbld', 15:11:04 INFO - 'MAIL': '/var/mail/cltbld', 15:11:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:04 INFO - 'MOZ_NO_REMOTE': '1', 15:11:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:11:04 INFO - 'NO_EM_RESTART': '1', 15:11:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:11:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:04 INFO - 'PWD': '/builds/slave/test', 15:11:04 INFO - 'SHELL': '/bin/bash', 15:11:04 INFO - 'SHLVL': '1', 15:11:04 INFO - 'TERM': 'linux', 15:11:04 INFO - 'TMOUT': '86400', 15:11:04 INFO - 'USER': 'cltbld', 15:11:04 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466719532.686411-1124632631', 15:11:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:04 INFO - '_': '/tools/buildbot/bin/python'} 15:11:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:11:04 INFO - Downloading/unpacking flake8 15:11:04 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 15:11:04 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 15:11:04 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 15:11:04 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 15:11:04 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 15:11:04 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 15:11:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:11:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:11:06 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 15:11:06 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 15:11:06 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 15:11:06 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 15:11:06 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 15:11:06 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 15:11:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:11:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:11:06 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 15:11:06 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 15:11:06 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 15:11:06 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 15:11:06 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 15:11:06 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 15:11:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:11:06 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 15:11:06 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 15:11:06 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 15:11:06 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 15:11:06 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 15:11:06 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 15:11:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:11:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:11:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:11:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:11:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:11:06 INFO - no previously-included directories found matching 'docs/_build' 15:11:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:11:06 INFO - Running setup.py install for pep8 15:11:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:11:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:11:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:11:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:11:07 INFO - no previously-included directories found matching 'docs/_build' 15:11:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:11:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:11:07 INFO - Cleaning up... 15:11:07 INFO - Return code: 0 15:11:07 INFO - Running post-action listener: _resource_record_post_action 15:11:07 INFO - Running post-action listener: _start_resource_monitoring 15:11:07 INFO - Starting resource monitoring. 15:11:07 INFO - ##### 15:11:07 INFO - ##### Running install step. 15:11:07 INFO - ##### 15:11:07 INFO - Running pre-action listener: _resource_record_pre_action 15:11:07 INFO - Running main action method: install 15:11:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:11:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:11:07 INFO - Reading from file tmpfile_stdout 15:11:07 INFO - Detecting whether we're running mozinstall >=1.0... 15:11:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:11:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:11:07 INFO - Reading from file tmpfile_stdout 15:11:07 INFO - Output received: 15:11:07 INFO - Usage: mozinstall [options] installer 15:11:07 INFO - Options: 15:11:07 INFO - -h, --help show this help message and exit 15:11:07 INFO - -d DEST, --destination=DEST 15:11:07 INFO - Directory to install application into. [default: 15:11:07 INFO - "/builds/slave/test"] 15:11:07 INFO - --app=APP Application being installed. [default: firefox] 15:11:07 INFO - mkdir: /builds/slave/test/build/application 15:11:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:11:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:11:20 INFO - Reading from file tmpfile_stdout 15:11:20 INFO - Output received: 15:11:20 INFO - /builds/slave/test/build/application/firefox/firefox 15:11:20 INFO - Running post-action listener: _resource_record_post_action 15:11:20 INFO - ##### 15:11:20 INFO - ##### Running run-tests step. 15:11:20 INFO - ##### 15:11:20 INFO - Running pre-action listener: _resource_record_pre_action 15:11:20 INFO - Running main action method: run_tests 15:11:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:11:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:11:20 INFO - Python 2.7.3 15:11:20 INFO - Return code: 0 15:11:20 INFO - grabbing minidump binary from tooltool 15:11: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')]} 15:11:20 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 0x235c410>, '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 0x235d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x235d7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:11:20 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 15:11:20 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 15:11:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:11:20 INFO - Return code: 0 15:11:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:11:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:11:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:11:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:11:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:11:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:11:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:11:21 INFO - Return code: 0 15:11:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:11:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:11:21 INFO - Using env: {'DISPLAY': ':0', 15:11:21 INFO - 'HOME': '/home/cltbld', 15:11:21 INFO - 'LANG': 'en_US.UTF-8', 15:11:21 INFO - 'LANGUAGE': 'en_US:en', 15:11:21 INFO - 'LOGNAME': 'cltbld', 15:11:21 INFO - 'MAIL': '/var/mail/cltbld', 15:11:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:11:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:11:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:21 INFO - 'MOZ_NO_REMOTE': '1', 15:11:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:11:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:11:21 INFO - 'NO_EM_RESTART': '1', 15:11:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:11:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:21 INFO - 'PWD': '/builds/slave/test', 15:11:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:11:21 INFO - 'SHELL': '/bin/bash', 15:11:21 INFO - 'SHLVL': '1', 15:11:21 INFO - 'TERM': 'linux', 15:11:21 INFO - 'TMOUT': '86400', 15:11:21 INFO - 'USER': 'cltbld', 15:11:21 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466719532.686411-1124632631', 15:11:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:21 INFO - '_': '/tools/buildbot/bin/python'} 15:11:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:11:22 INFO - mozversion application_buildid: 20160623122823 15:11:22 INFO - mozversion application_changeset: 13b02b96281e550c3cdbdf4eaed034aa1edefd69 15:11:22 INFO - mozversion application_display_name: Firefox 15:11:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:11:22 INFO - mozversion application_name: Firefox 15:11:22 INFO - mozversion application_remotingname: firefox 15:11:22 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:11:22 INFO - mozversion application_vendor: Mozilla 15:11:22 INFO - mozversion application_version: 48.0 15:11:22 INFO - mozversion platform_buildid: 20160623122823 15:11:22 INFO - mozversion platform_changeset: 13b02b96281e550c3cdbdf4eaed034aa1edefd69 15:11:22 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:11:22 INFO - mozversion platform_version: 48.0 15:11:22 INFO - using testdate: 1466719882 15:11:22 INFO - actual date: 1466719882 15:11:22 INFO - starting webserver on 'localhost:40173' 15:11:22 INFO - SUITE-START | Running 2 tests 15:11:22 INFO - TEST-START | dromaeo_css 15:11:22 INFO - operating with platform_type : linux_ 15:11:22 INFO - Initialising browser for dromaeo_css test... 15:11:22 INFO - TEST-INFO | started process 3338 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_Mno43/profile http://localhost:40173/getInfo.html) 15:11:25 INFO - PROCESS | 3338 | 15:11:25 INFO - PROCESS | 3338 | (process:3419): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:11:26 INFO - PROCESS | 3338 | __metrics Screen width/height:1600/1200 15:11:26 INFO - PROCESS | 3338 | colorDepth:24 15:11:26 INFO - PROCESS | 3338 | Browser inner width/height: 1024/697 15:11:26 INFO - PROCESS | 3338 | __metrics 15:11:27 ERROR - PROCESS | 3338 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 15:11:28 INFO - TEST-INFO | 3338: exit 0 15:11:28 INFO - Browser initialized. 15:11:28 INFO - Running cycle 1/1 for dromaeo_css test... 15:11:28 INFO - TEST-INFO | started process 3469 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_Mno43/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:11:29 INFO - PROCESS | 3469 | 15:11:29 INFO - PROCESS | 3469 | (process:3534): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:11:39 INFO - PROCESS | 3469 | RSS: Main: 151293952 15:11:39 INFO - PROCESS | 3469 | 15:12:29 INFO - PROCESS | 3469 | 1466719949473 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] 15:14:36 INFO - PROCESS | 3469 | Cycle 1(1): loaded http://localhost:40173/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40173/tests/dromaeo/cssquery-ext.html) 15:14:37 INFO - PROCESS | 3469 | RSS: Main: 154742784 15:14:37 INFO - PROCESS | 3469 | 15:17:39 INFO - PROCESS | 3469 | Cycle 1(1): loaded http://localhost:40173/tests/dromaeo/cssquery-ext.html (next: http://localhost:40173/tests/dromaeo/cssquery-jquery.html) 15:17:40 INFO - PROCESS | 3469 | RSS: Main: 153006080 15:17:40 INFO - PROCESS | 3469 | 15:20:41 INFO - PROCESS | 3469 | Cycle 1(1): loaded http://localhost:40173/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40173/tests/dromaeo/cssquery-mootools.html) 15:20:42 INFO - PROCESS | 3469 | RSS: Main: 153001984 15:20:42 INFO - PROCESS | 3469 | 15:23:44 INFO - PROCESS | 3469 | Cycle 1(1): loaded http://localhost:40173/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40173/tests/dromaeo/cssquery-prototype.html) 15:23:44 INFO - PROCESS | 3469 | RSS: Main: 154095616 15:23:44 INFO - PROCESS | 3469 | 15:26:46 INFO - PROCESS | 3469 | Cycle 1(1): loaded http://localhost:40173/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40173/tests/dromaeo/cssquery-yui.html) 15:26:47 INFO - PROCESS | 3469 | RSS: Main: 152125440 15:26:47 INFO - PROCESS | 3469 | 15:29:49 INFO - PROCESS | 3469 | Cycle 1(1): loaded http://localhost:40173/tests/dromaeo/cssquery-yui.html (next: http://localhost:40173/tests/dromaeo/cssquery-dojo.html) 15:29:50 INFO - PROCESS | 3469 | RSS: Main: 155799552 15:29:50 INFO - PROCESS | 3469 | 15:29:50 INFO - PROCESS | 3469 | __start_tp_report 15:29:50 INFO - PROCESS | 3469 | _x_x_mozilla_page_load 15:29:50 INFO - PROCESS | 3469 | _x_x_mozilla_page_load_details 15:29:50 INFO - PROCESS | 3469 | |i|pagename|runs| 15:29:50 INFO - PROCESS | 3469 | |0;dojo.html;3337.1156643489476;3361.5629968104145;3368.747343949203;3382.9154271143234;3404.7616666833314;5492.231087647728;5494.587905907063;5530.695811730353;5545.168224766282;5549.255386644421;5465.6447330923465;5509.614326997112;5521.861953451155;5536.972315138419;5542.1132618781;4980.651354405193;4992.400911890578;5060.4686507916695;5061.898762024757;5063.215201643751;4998.850034498971;5008.223725322581;5052.46949070346;5067.670601410897;5099.388073431193;5091.109055915219;5113.616478764089;5119.667221630601;5123.718195499246;5189.040027594907;5056.3173971513925;5059.064073146461;5071.112555302844;5076.543111120017;5088.7964481420695;4887.706737595756;4904.435989861176;4985.576226020793;4991.900161996776;5052.292679024939;5394.136938089926;5396.487333703292;5437.238786569884;5438.129899216106;5473.972630136864;5860;5875.735591898375;5892.322382925976;5900.704964751788;5924.259467566554;5846.824595262149;5895.764169433218;5924.348321684612;5957.046872500379;6060.939390606081;5467.398586155519;5529.529989950859;5536.086545719952;5549.750261238213;5554.1113421852715;5999.370066142992;6001.969990150022;6007.068904319837;6014.849628759229;6018.849528761816;5781.306243250837;5798.536117110621;5834.67909264986;5848.912266316009;5875.294964604275;5853.0635098384055;5880.94119058804;5904.409559044061;5905.350411454737;5912.645241285537;5692.715364231772;5852.882942341129;5871.324797648325;5874.970625146932;5875.50058245054;5731.426857314235;5797.188393624896;5803.100519419497;5808.535317174616;5819.709014549256;4442.644588432918;4454.420925279757;4456.108778244364;4473.776311184428;4477.731336119843;3963.920721585552;3977.3238549446664;3987.1626958339075;3994.08136128692;4019.9799001005395;5604.551635869121;5702.45826646468;5704.201411802351;5704.771809127588;5726.484616384545;5889.469947704727;5914.438128377883;5945.524358051345;6014.1580178775;6018.578699491081;5729.083346664514;5730.19777231188;5735;5739.569532285095;5752.07966725322;4903.166461701448;4959.851204463872;4983.975080124576;4994.675346102492;5050.696958182521;6192.504599632019;6227.906581401283;6233.937660623426;6241.937580624226;6251.374862513712;5988.520918326611;6000.249968753906;6042;6052.788152414644;6052.818415447544;5940.702964851826;5998.190244316961;6031.547633927561;6151.231096112986;6240.968795155995;5895.322037965689;5902.881942361043;5912.852178695567;5917.171595976481;5921.348651648229;5968.104784282393;5968.76124954997;5971.044632858721;5993.850153746192;6014.578979471395;5725.169850371756;5772.797952071657;5841.094630332305;5848.4151584841175;5872.677002764718;5855.473007429352;5875.882482350244;5881.05903055509;5888.087346461305;5895.02732049207;5712.942870571241;5735.8566035849435;5742.799002034909;5757.884842303214;5766.913496297475;5710.914336284876;5837.241158649348;5851.239338885917;5881.676507792113;5885.234919460443;5777.62445441045;5796.275465566804;5812;5815.912761308668;5820.243368362086 15:29:50 INFO - PROCESS | 3469 | |1;ext.html;609.7134346856976;665.6006396162302;672.4754691340756;675.0987431778574;699.7900629811055;38217.42673859891;38910.610893891055;38981.80509097451;39062.218755624905;39156.21687566247;40447.59552404475;40998.38502422458;41213;41312.58687413125;41449;8462.49225046496;8613.440126391795;8615.181557752003;8619.482831030158;8623.525706086195;8597;8906.86639700405;8921.687740929068;8951.552422378887;8974.192322690957;8928.910710892906;8943.77640558988;8974.147455991702;8979.595918183697;9003.324750643695;8895.644174233055;8909.287257019423;8913.955430222839;8928.508932008737;8952.552372381388;8805.075467075929;8902.955485222532;8908.73273801787;8922.553872306424;8929.598168082452;39792.20415591672;40065.799671001456;40080.39879401811;40228.19543609141;40336.79831600853;3598.4062629666073;3637.563492380931;3754.605766394544;3990.4213888985932;4167.2082304362375;29682.851585741933;29710.70289297101;29913.76776578294;29938.55092173619;29991.700082999327;4403.22943484892;4466.57567531084;4487.214737420938;4487.416635837353;4509.7970591323465;293466;294822;296796;297935.51032244915;297954;62152.68923655443;62510.68744656248;62566.374336256966;62595.374046259865;62840.371596283454;66086.00870986939;68888.65555672189;69074;70153.29846701468;70386.64806676036;19256.807431925783;19379.612407752047;19462.416127516197;19473.92893390877;19533.609327813363;15077.698446031018;15090.773638395432;15140.621484462756;15151.469698560719;15219.315130818919;20460.69308960367;20620.484487887923;20792.27227047046;20797;20832.1667133313;7541.547507149478;7563.659635316424;7615.7334493292465;7926.207379262028;7962.610868331669;1069.0859315285475;1140.492480846032;1200.537792949703;1225.7119576899422;1292.560529419983;33830.15424614355;35377.292454150775;36822.8158859204;37080.44379334312;37222;1168.7253495428567;1193.9880601193877;1213.3629844331797;1241.4599649152647;1275.4770544076885;16115.677686446206;16222.35110595563;16408.179591020402;16529.83470165307;16653.084080375695;469760;530406;541872;560053;848473;56824;57886.7105664469;57921.710391448614;57924.710376447845;57986.13020804691;1535.9692806143814;1561.8047744031996;1564.8591626753646;1568.749000159969;1576.0464918724235;28780.856095720224;30233.69766302309;30353.392932141676;30737.077887663407;30746.231344216572;52147.73926130345;53223.93552129013;53294.467055330504;53459.732701336245;53482.4651753493;456321;457110;457427;460494;462478;30470.695293046785;30651.693483064882;30810.537841931942;30884.69115308818;31223.531647025768;48254;48406.75796621135;48968.75515622399;49314.75342623264;49416.50583494119;40485;41160;41455.7927210362;41699.79150104352;41990.58009419989;40332;40620.79689601533;41363.379549306184;42089.78955105205;42232.788836055624;42153.78923105365;42542.36186457144;42697.78651106724;42895.78552107344;43153.56846431496;34752.478712818825;35842.10106806872;36085.09787255339;36429;36945.63054369422;27601.723982759915;28007.439851203268;28032.859835701507;28191.43617127687;28317.71682283151 15:29:50 INFO - PROCESS | 3469 | |2;jquery.html;393.3764982502733;394.07196053294507;420.2435615891397;436.4195619825632;443.9178751930892;15287.847121528781;18676.53308667284;19277.71083433748;19285.22859085635;19290.131944062516;18630.813691863077;18884.716729249074;19482;19907.701384479245;19929.40211793645;5711.228984087147;5773.307203135609;5926.199963005004;5963.642181469104;5988.490978266853;5852.561057920651;5863.79476718315;5915.615484993483;5943.940560594382;5958.9702051489685;5812.302523697141;5964.13520039594;5972.581919265654;5987.970060149693;6016.037434010559;5932.288125424933;5939.2575928009;5948.851278718023;5955.612885162451;5994.400559943992;5262.210668399733;5279.9208011879855;5344.331958505187;5349.7057661828585;5356.919646205271;23113;23640.29079127629;24084.397890052715;24693.382665433328;24701;2577.587585986233;2613.2552222616464;2654.4558365535017;2703;2707.0254708304997;14330.785038224434;14340;14379;14658.047226930215;14708.70582588353;1973.1219607274768;2060.2892002259196;2081.490034941434;2149.709789178472;2167.328128280238;82938.58530707368;83032.58483707542;83129.16870831275;83164;83717.58141209316;10794.24440289188;11015.724606884893;11099.83350249747;11162.665120046411;11180.944095279472;13459.327033648278;15001.849981500263;15718.921405393128;15812.92093539525;15843;8330.625121869409;8455.830883382298;8742.825143497095;8823.029466758651;8850.557472126497;8561.82876342482;8608.827823443497;8613.61238744258;8650.956745216234;8690.739277821549;6744.730210791611;6798.184217893884;6856.41720453767;6915.135608048994;6938.271481494471;2026.9898650506652;2081.157131361801;2118.894055297229;2122.5224324527167;2168.1760930846176;1088.2817340555196;1106.7233191702076;1169.7660467906453;1171.976560468786;1244.993775031119;19107.713384299248;19568;19692.50768730793;19930.202791888452;20296.797032029786;1121.8373335866254;1169.5672601137633;1188.6612315490045;1193.6419074277683;1230.3848075962019;9586.904130958601;11293.15301352402;11394.829077563843;11490.597829075943;11517.424128793527;178848;503069;508217;515631;526549;82075;82259.17740822515;82953.58523207346;83287.16712832794;86430.13569864347;1149.7642983188593;1161.4483120517687;1180.6812160716559;1182.2965335625117;1182.3083496154845;17017.149142543072;17376.39182628602;17618.471445856645;17738.73391899097;17921.910390447963;37667.43498847465;37908.05229869275;37949;38533.4219986706;39367.212655747295;52658.473415265355;53742.46257537375;54037.459625403244;54184.18723719069;54494.45505544894;9055;9197.942236642604;9360.391574547633;9454.196393306645;9503;13677.726445471233;13914.860851391357;14040.508582199574;14048.719025619635;14475.131492110508;11935.164538482222;12082.154249202471;12088.637340879788;12134.150609457252;12230.816537751763;12086.093542984136;12132.150749447454;12180.390980451119;12300.507979680713;12533.122681412213;12221.572244971383;12327.93836030814;12369.62891113268;12540.749185016432;12783.041271904458;9098.499582523025;9161.221296189631;9166.587503562489;9316.860247096434;9395.107464790834;11480.598179063692;11530.308181509135;11530.82703759461;11653.242539234923;12119.394030298627 15:29:50 INFO - PROCESS | 3469 | |3;mootools.html;1584.7464405695086;1600.1599160440767;1789.0965062643363;1883.1902282018727;1902;7518.097828260603;8083.353331733462;8115.797105072376;8373.37199710022;8394.916050839489;8370.916290837089;8426.410151289412;8470.195331443518;8480.363972702056;8481.363897707666;2121.6393213153724;2152.3865698275995;2159.8380121490873;2167.967480487786;2174.771648976858;2418.7097548294228;2439.2682195341326;2472.320111969205;2475.1337032038823;2481.900723971039;2435.062500937143;2439.8048156147465;2447.938801529967;2474.8515089094712;2479.1570865905587;2387.4747555537756;2426.381272775431;2449.4856080223262;2452.803775697949;2458.6312053191987;2356.2342238772294;2359.858408495496;2369.5379401016808;2370.7629237076326;2387.9641805372935;8428.662853485914;8537.445066070748;8567.357448191347;8579.184977427134;8583.742487725316;5313.734313284321;5434.64674796137;5472.863178420532;5476.534494567966;5479.068558345091;3378.6114596821435;3393.3213357328386;3419.196488825124;3424;3488.075659950115;1085.1969542538543;1135.6820090374708;1140.2531341971023;1150.580038286028;1159.7796418680507;11897.821532677104;11902.464389102512;11907.583234586835;11931;11932.28406295625;4723.527647235249;4724;4778.187708089633;4822.493638168012;4828.758562071953;10146.44194569291;10147.137493313003;10166.237532185116;10184.439855808001;10189.08298253146;5428.70142142186;5436.048691478975;5483.040467918178;5483.725813709299;5513.641613295123;4791.808327666924;4958.256261560723;4960.379952505937;4967.130752118364;5040.621953353513;3824.2351529694174;3864.613538646169;3892.5718171001167;3915.804209789499;3995.900102497461;1126.4311522680994;1127.5827943660734;1131.8189089745601;1161.4250945781723;1244.8733895824294;1001.1790331927749;1017.3793985668736;1035.4305132177271;1040.885502594714;1048.3605000949415;5737.971310143423;5885.970570147122;5919.644821310649;5941.405859414111;6060.787872424532;1037.9325343852624;1054.1724746074294;1067.1889364083352;1068.4497483795851;1105.3367979212408;4058.9797051014557;4103.363978583325;4116.361963895601;4133.855315064018;4144.896377590524;10111.292209545409;10487.790244195074;10492.737681558023;10555.630552930765;10563.894361056291;10290.691279261635;10303.227257955683;10307.175425965905;10308.587656493657;10333.586656533655;8030.19698030204;8065.072516660542;8078.3133433658795;8090.312323452455;8105.635246413925;5792.652440853562;5804.042333015005;5846.853828654148;5872.295324560909;5968.015277479168;8677.566121693764;8811.559422029;8898.4660920345;8942.46345219289;8948.060453652273;8839.823203535765;9004.099590040943;9049.59276832531;9055.320850936074;9095.317851161322;7230.13238411394;7379.594122323324;7428.1086269647985;7452.292032256927;7610.086789585063;7934.722284720007;7963.084245311632;7980.241877021674;7992.440529163136;8009.479383840032;6966.477514186355;7178.892316615359;7228.855422891618;7275.417966562768;7397.778066658009;7098.112735908012;7175.174854891754;7249.855002899807;7260.201377848327;7386.556806591621;6701.430378417889;6730.730770769114;6737.3599508046655;6769.661516924036;6820.590764554143;4836.806527738851;4971.627127965345;5005.374328208974;5022.623303252198;5025.84922452327;5159.2003239497935;5216.9739151304;5237.485488797084;5298.8940221196135;5321.574274058144 15:29:50 INFO - PROCESS | 3469 | |4;prototype.html;350.7667401178215;368.90408493791614;369.2725331097737;381.51738051365027;381.5764501403443;6442.484601231902;6650.401463868251;6677.866442671149;6691.43122834559;6785.287544807798;6604.570702904308;6671.733130674767;6684.966575167129;6693.39759421652;6716.194056713189;5071.163258062434;5071.56891664209;5078.4921507849285;5087.694738315713;5109.259157422191;5042.747862606855;5080.110980578403;5099.566536844372;5102.260172275018;5116.411612664554;5029.874253143664;5059.16523773577;5069.493050694938;5079;5087.974560127194;4964.680727766866;4990.775415106329;5049.166887463564;5057.9494205057845;5079.746012699368;4413.757243351614;4440.400545926291;4459.99650078733;4464.241079016542;4466.620337271336;6381.68091595423;6388.776392826276;6389.393007664265;6440.935590644081;6444.420002199825;5930.466258036798;5945.464908158287;5946.8810623787285;5949.434803693643;5960.738072278298;7029.402500787439;7067.116610423697;7067.893981590229;7079.752208672672;7082.256363081854;4616.0767846430845;4800.495947925488;4800.519948005206;4963.900721985576;4978.900421991576;7293.927060729377;7312.670929808171;7349.963250183715;7364.852702945965;7409.740659076906;4941.975290123526;4945.406551213805;4948;4950;4959.578435832923;5029.06962211992;5029.723365214948;5030.2957585938;5032.6980381177245;5037.647364684437;5813.883722325614;5824.650520968756;5825;5826.388229235954;5839.328477225088;6964.373206411346;7067.045948796949;7078.575285482888;7082.716691332289;7088.787336379917;1743.4856717268435;1764.655892101028;1769.5222289981632;1770.1326350088364;1771.3003363671535;1137.3289759042204;1142.3774043146338;1143.6683361824978;1154.3997121496943;1160.4661855546374;6683.899741503881;6763.763268285685;6771.62756048422;6776.11910451648;6778.559393639398;7190.64046797658;7194.352508274281;7196.820079497949;7204.279572042754;7225.783226503108;6754.5609535380045;6757.155355580552;6772.255051944282;6776.390124888783;6781.6609169541325;3841.5774264830848;3882.3011857865854;3906.980465097713;3908.687305015592;3920.4119382092913;7508.511946723445;7515.21090285523;7527.172011078777;7535.095788505305;7559.622018899033;7345;7390.5196162249285;7396.260373962561;7409.88885166723;7417.369523590447;7511.399088072941;7537.359324457482;7541.509801862861;7544.132424771222;7562.470627056054;7046.929530704628;7129.82175445618;7189.712411503481;7192.676329565077;7199.604021778852;7108.182559005781;7116.146062472537;7117.395021423237;7129.108861392326;7138.607376594337;7510.361619262424;7527.327798631407;7527.924720752722;7544.962275188589;7545.283198096172;4950.331705219749;4953.529414705597;4953.9752301239705;4957.454679985127;4961.652684312064;7055.788326350218;7148.64256787169;7189;7197.640117993975;7213.20654727969;7146.285371462812;7146.749863754952;7150.570965742072;7161;7173.964130179315;7125;7134.714611415485;7138.46461515378;7139.607321597362;7154.069970903749;6986.895196572157;6998.860022799618;7010.509264351446;7016.929830701628;7023.47323950716;6912.758053468105;7070.257622949722;7135.143782746104;7189.892151617834;7194.388476979306;6812.591244525344;6995.965020174866;7010;7017.842056060693;7018.298170182941 15:29:50 INFO - PROCESS | 3469 | |5;yui.html;711.9430445564353;732.051992669493;735.8381156145648;742.8625704244715;765.9655315510802;13192.472301107957;13314.93342533286;13328.40022199001;13338.999999999987;13349.132306400077;12478.688032799184;12597.055220858427;12776;12796.68008299793;12842.678933026678;740.0712106306578;888.3337496877342;896.8744375787395;904.7647611620993;910.5583791860976;889.2041622747637;895.6283142495856;895.6506962284714;896.085992287866;897.8159477307137;918.9264858811279;924.944503329799;925.2413021322518;925.9675911343104;928.1692884868039;914.3142643017736;915.5102020419077;918.4672889723944;919.0855099176296;921.1709461484718;676.891697328425;678.8879834827247;680.6562685843618;682.4847240333567;684.9178098628197;13233;13287.335633218301;13309.534166304133;13365;13406.262655553941;14122.22327771972;14290.142591444443;14351.138931664134;14358.56924292273;14494.42022319106;10423;10524.421156836372;10532.210084243712;10582.788344233073;10703.892961070445;3845.480860083881;3871.5160604924386;3904.3557812960826;3909.7458665186673;3926.332523471017;58190.418095818924;58221;58905.11642325368;59043;59519;11261.774764504664;11269.436528173559;11636.12729045325;11656.533738650529;11679.532818687157;21127.26054588082;21142.78857211408;21188.15247390118;21204;21236.469088272606;8631.352648551383;8846.734597962071;9133.086691330815;9138.63445462174;9232.584533696;4725.078609671081;4730.597899178609;4768.427788665383;4826.686265392738;4845.2732090186755;3594.6405359463843;3648.9817550912076;3650.069232345788;3651.1054791575702;3662.3407786598136;635.5392340553062;653.2194028136427;661.6394065234459;668.1781408867121;671.9731210751613;668.7124536449373;753.8153152477678;761.4365369626437;763.3625922354785;766.3830616353778;9384.483853387992;9726.95136524327;9735.56189971453;9806.166475849634;9820.852687209697;654.0614218596329;664.9434798042124;749.1796482851269;755.1278273594007;756.8864670299499;4151.501819781645;4211.831526738896;4224.415893645531;4293.205756934977;4343.413639158736;60396.39603603908;60743.08885366723;61098.38901611016;62711.68644156841;62714.686426568485;54848;55876.161857572166;56456.717716411156;56877;57254.71372643193;48488.27267590989;49216.753916230904;49234.507654923706;49538.00923981572;49615.25577116346;8542.957285213533;8658.39391242607;8764.780880477783;8770.38607297483;8892.64429422816;35968.820155899055;36220.81889590535;36907.446388304736;37629.96980058446;39960.200795983335;47745.5225447755;47818.52181478141;47836.52163478321;48391.27413088877;48837.313947733215;11255.324680519196;11317.264377815416;11371.260868043551;11415.37215453158;11487.942560287145;12279.447424865724;12451.688707782378;12547.874521255037;12984;13386.598402047954;12082.879171208528;12176.573819916615;12230.44962976686;12323.938380308042;12640.6839829005;12027.699307517381;12141.939290303491;12178.878211218129;12491.375431228584;12682.619521414372;11284.548618055185;11638.709032273922;11985.940070299941;12089.214201076902;12160.574379896661;10359;10511.684649460529;10647.627333043307;10668;10816.891831081588;10225.386476811414;10652.987966143204;10726;10742.785144297226;10772.569097236335 15:29:50 INFO - PROCESS | 3469 | __end_tp_report 15:29:50 INFO - PROCESS | 3469 | __start_cc_report 15:29:50 INFO - PROCESS | 3469 | _x_x_mozilla_cycle_collect,335 15:29:50 INFO - PROCESS | 3469 | __end_cc_report 15:29:50 INFO - PROCESS | 3469 | __startTimestamp1466720990020__endTimestamp 15:29:50 INFO - PROCESS | 3469 | 15:29:50 INFO - PROCESS | 3469 | ------- Summary: start ------- 15:29:50 INFO - PROCESS | 3469 | Number of tests: 6 15:29:50 INFO - PROCESS | 3469 | 15:29:50 INFO - PROCESS | 3469 | [#0] dojo.html Cycles:165 Average:5511.77 Median:5757.88 stddev:621.35 (10.8%) stddev-sans-first:599.38 15:29:50 INFO - PROCESS | 3469 | Values: 3337.1 3361.6 3368.7 3382.9 3404.8 5492.2 5494.6 5530.7 5545.2 5549.3 5465.6 5509.6 5521.9 5537.0 5542.1 4980.7 4992.4 5060.5 5061.9 5063.2 4998.9 5008.2 5052.5 5067.7 5099.4 5091.1 5113.6 5119.7 5123.7 5189.0 5056.3 5059.1 5071.1 5076.5 5088.8 4887.7 4904.4 4985.6 4991.9 5052.3 5394.1 5396.5 5437.2 5438.1 5474.0 5860.0 5875.7 5892.3 5900.7 5924.3 5846.8 5895.8 5924.3 5957.0 6060.9 5467.4 5529.5 5536.1 5549.8 5554.1 5999.4 6002.0 6007.1 6014.8 6018.8 5781.3 5798.5 5834.7 5848.9 5875.3 5853.1 5880.9 5904.4 5905.4 5912.6 5692.7 5852.9 5871.3 5875.0 5875.5 5731.4 5797.2 5803.1 5808.5 5819.7 4442.6 4454.4 4456.1 4473.8 4477.7 3963.9 3977.3 3987.2 3994.1 4020.0 5604.6 5702.5 5704.2 5704.8 5726.5 5889.5 5914.4 5945.5 6014.2 6018.6 5729.1 5730.2 5735.0 5739.6 5752.1 4903.2 4959.9 4984.0 4994.7 5050.7 6192.5 6227.9 6233.9 6241.9 6251.4 5988.5 6000.2 6042.0 6052.8 6052.8 5940.7 5998.2 6031.5 6151.2 6241.0 5895.3 5902.9 5912.9 5917.2 5921.3 5968.1 5968.8 5971.0 5993.9 6014.6 5725.2 5772.8 5841.1 5848.4 5872.7 5855.5 5875.9 5881.1 5888.1 5895.0 5712.9 5735.9 5742.8 5757.9 5766.9 5710.9 5837.2 5851.2 5881.7 5885.2 5777.6 5796.3 5812.0 5815.9 5820.2 15:29:50 INFO - PROCESS | 3469 | 15:29:50 INFO - PROCESS | 3469 | [#1] ext.html Cycles:180 Average:61364.41 Median:41262.79 stddev:125478.73 (304.1%) stddev-sans-first:125747.82 15:29:50 INFO - PROCESS | 3469 | Values: 609.7 665.6 672.5 675.1 699.8 38217.4 38910.6 38981.8 39062.2 39156.2 40447.6 40998.4 41213.0 41312.6 41449.0 8462.5 8613.4 8615.2 8619.5 8623.5 8597.0 8906.9 8921.7 8951.6 8974.2 8928.9 8943.8 8974.1 8979.6 9003.3 8895.6 8909.3 8914.0 8928.5 8952.6 8805.1 8903.0 8908.7 8922.6 8929.6 39792.2 40065.8 40080.4 40228.2 40336.8 3598.4 3637.6 3754.6 3990.4 4167.2 29682.9 29710.7 29913.8 29938.6 29991.7 4403.2 4466.6 4487.2 4487.4 4509.8 293466.0 294822.0 296796.0 297935.5 297954.0 62152.7 62510.7 62566.4 62595.4 62840.4 66086.0 68888.7 69074.0 70153.3 70386.6 19256.8 19379.6 19462.4 19473.9 19533.6 15077.7 15090.8 15140.6 15151.5 15219.3 20460.7 20620.5 20792.3 20797.0 20832.2 7541.5 7563.7 7615.7 7926.2 7962.6 1069.1 1140.5 1200.5 1225.7 1292.6 33830.2 35377.3 36822.8 37080.4 37222.0 1168.7 1194.0 1213.4 1241.5 1275.5 16115.7 16222.4 16408.2 16529.8 16653.1 469760.0 530406.0 541872.0 560053.0 848473.0 56824.0 57886.7 57921.7 57924.7 57986.1 1536.0 1561.8 1564.9 1568.7 1576.0 28780.9 30233.7 30353.4 30737.1 30746.2 52147.7 53223.9 53294.5 53459.7 53482.5 456321.0 457110.0 457427.0 460494.0 462478.0 30470.7 30651.7 30810.5 30884.7 31223.5 48254.0 48406.8 48968.8 49314.8 49416.5 40485.0 41160.0 41455.8 41699.8 41990.6 40332.0 40620.8 41363.4 42089.8 42232.8 42153.8 42542.4 42697.8 42895.8 43153.6 34752.5 35842.1 36085.1 36429.0 36945.6 27601.7 28007.4 28032.9 28191.4 28317.7 15:29:50 INFO - PROCESS | 3469 | 15:29:50 INFO - PROCESS | 3469 | [#2] jquery.html Cycles:180 Average:27801.90 Median:23376.65 stddev:76904.10 (329.0%) stddev-sans-first:77092.30 15:29:50 INFO - PROCESS | 3469 | Values: 393.4 394.1 420.2 436.4 443.9 15287.8 18676.5 19277.7 19285.2 19290.1 18630.8 18884.7 19482.0 19907.7 19929.4 5711.2 5773.3 5926.2 5963.6 5988.5 5852.6 5863.8 5915.6 5943.9 5959.0 5812.3 5964.1 5972.6 5988.0 6016.0 5932.3 5939.3 5948.9 5955.6 5994.4 5262.2 5279.9 5344.3 5349.7 5356.9 23113.0 23640.3 24084.4 24693.4 24701.0 2577.6 2613.3 2654.5 2703.0 2707.0 14330.8 14340.0 14379.0 14658.0 14708.7 1973.1 2060.3 2081.5 2149.7 2167.3 82938.6 83032.6 83129.2 83164.0 83717.6 10794.2 11015.7 11099.8 11162.7 11180.9 13459.3 15001.8 15718.9 15812.9 15843.0 8330.6 8455.8 8742.8 8823.0 8850.6 8561.8 8608.8 8613.6 8651.0 8690.7 6744.7 6798.2 6856.4 6915.1 6938.3 2027.0 2081.2 2118.9 2122.5 2168.2 1088.3 1106.7 1169.8 1172.0 1245.0 19107.7 19568.0 19692.5 19930.2 20296.8 1121.8 1169.6 1188.7 1193.6 1230.4 9586.9 11293.2 11394.8 11490.6 11517.4 178848.0 503069.0 508217.0 515631.0 526549.0 82075.0 82259.2 82953.6 83287.2 86430.1 1149.8 1161.4 1180.7 1182.3 1182.3 17017.1 17376.4 17618.5 17738.7 17921.9 37667.4 37908.1 37949.0 38533.4 39367.2 52658.5 53742.5 54037.5 54184.2 54494.5 9055.0 9197.9 9360.4 9454.2 9503.0 13677.7 13914.9 14040.5 14048.7 14475.1 11935.2 12082.2 12088.6 12134.2 12230.8 12086.1 12132.2 12180.4 12300.5 12533.1 12221.6 12327.9 12369.6 12540.7 12783.0 9098.5 9161.2 9166.6 9316.9 9395.1 11480.6 11530.3 11530.8 11653.2 12119.4 15:29:50 INFO - PROCESS | 3469 | 15:29:50 INFO - PROCESS | 3469 | [#3] mootools.html Cycles:180 Average:5624.86 Median:4832.78 stddev:3050.58 (63.1%) stddev-sans-first:3044.03 15:29:50 INFO - PROCESS | 3469 | Values: 1584.7 1600.2 1789.1 1883.2 1902.0 7518.1 8083.4 8115.8 8373.4 8394.9 8370.9 8426.4 8470.2 8480.4 8481.4 2121.6 2152.4 2159.8 2168.0 2174.8 2418.7 2439.3 2472.3 2475.1 2481.9 2435.1 2439.8 2447.9 2474.9 2479.2 2387.5 2426.4 2449.5 2452.8 2458.6 2356.2 2359.9 2369.5 2370.8 2388.0 8428.7 8537.4 8567.4 8579.2 8583.7 5313.7 5434.6 5472.9 5476.5 5479.1 3378.6 3393.3 3419.2 3424.0 3488.1 1085.2 1135.7 1140.3 1150.6 1159.8 11897.8 11902.5 11907.6 11931.0 11932.3 4723.5 4724.0 4778.2 4822.5 4828.8 10146.4 10147.1 10166.2 10184.4 10189.1 5428.7 5436.0 5483.0 5483.7 5513.6 4791.8 4958.3 4960.4 4967.1 5040.6 3824.2 3864.6 3892.6 3915.8 3995.9 1126.4 1127.6 1131.8 1161.4 1244.9 1001.2 1017.4 1035.4 1040.9 1048.4 5738.0 5886.0 5919.6 5941.4 6060.8 1037.9 1054.2 1067.2 1068.4 1105.3 4059.0 4103.4 4116.4 4133.9 4144.9 10111.3 10487.8 10492.7 10555.6 10563.9 10290.7 10303.2 10307.2 10308.6 10333.6 8030.2 8065.1 8078.3 8090.3 8105.6 5792.7 5804.0 5846.9 5872.3 5968.0 8677.6 8811.6 8898.5 8942.5 8948.1 8839.8 9004.1 9049.6 9055.3 9095.3 7230.1 7379.6 7428.1 7452.3 7610.1 7934.7 7963.1 7980.2 7992.4 8009.5 6966.5 7178.9 7228.9 7275.4 7397.8 7098.1 7175.2 7249.9 7260.2 7386.6 6701.4 6730.7 6737.4 6769.7 6820.6 4836.8 4971.6 5005.4 5022.6 5025.8 5159.2 5217.0 5237.5 5298.9 5321.6 15:29:50 INFO - PROCESS | 3469 | 15:29:50 INFO - PROCESS | 3469 | [#4] prototype.html Cycles:180 Average:5893.16 Median:6755.86 stddev:1785.61 (26.4%) stddev-sans-first:1741.48 15:29:50 INFO - PROCESS | 3469 | Values: 350.8 368.9 369.3 381.5 381.6 6442.5 6650.4 6677.9 6691.4 6785.3 6604.6 6671.7 6685.0 6693.4 6716.2 5071.2 5071.6 5078.5 5087.7 5109.3 5042.7 5080.1 5099.6 5102.3 5116.4 5029.9 5059.2 5069.5 5079.0 5088.0 4964.7 4990.8 5049.2 5057.9 5079.7 4413.8 4440.4 4460.0 4464.2 4466.6 6381.7 6388.8 6389.4 6440.9 6444.4 5930.5 5945.5 5946.9 5949.4 5960.7 7029.4 7067.1 7067.9 7079.8 7082.3 4616.1 4800.5 4800.5 4963.9 4978.9 7293.9 7312.7 7350.0 7364.9 7409.7 4942.0 4945.4 4948.0 4950.0 4959.6 5029.1 5029.7 5030.3 5032.7 5037.6 5813.9 5824.7 5825.0 5826.4 5839.3 6964.4 7067.0 7078.6 7082.7 7088.8 1743.5 1764.7 1769.5 1770.1 1771.3 1137.3 1142.4 1143.7 1154.4 1160.5 6683.9 6763.8 6771.6 6776.1 6778.6 7190.6 7194.4 7196.8 7204.3 7225.8 6754.6 6757.2 6772.3 6776.4 6781.7 3841.6 3882.3 3907.0 3908.7 3920.4 7508.5 7515.2 7527.2 7535.1 7559.6 7345.0 7390.5 7396.3 7409.9 7417.4 7511.4 7537.4 7541.5 7544.1 7562.5 7046.9 7129.8 7189.7 7192.7 7199.6 7108.2 7116.1 7117.4 7129.1 7138.6 7510.4 7527.3 7527.9 7545.0 7545.3 4950.3 4953.5 4954.0 4957.5 4961.7 7055.8 7148.6 7189.0 7197.6 7213.2 7146.3 7146.7 7150.6 7161.0 7174.0 7125.0 7134.7 7138.5 7139.6 7154.1 6986.9 6998.9 7010.5 7016.9 7023.5 6912.8 7070.3 7135.1 7189.9 7194.4 6812.6 6996.0 7010.0 7017.8 7018.3 15:29:50 INFO - PROCESS | 3469 | 15:29:50 INFO - PROCESS | 3469 | [#5] yui.html Cycles:180 Average:15027.75 Median:4727.84 stddev:17618.02 (372.6%) stddev-sans-first:17634.64 15:29:50 INFO - PROCESS | 3469 | Values: 711.9 732.1 735.8 742.9 766.0 13192.5 13314.9 13328.4 13339.0 13349.1 12478.7 12597.1 12776.0 12796.7 12842.7 740.1 888.3 896.9 904.8 910.6 889.2 895.6 895.7 896.1 897.8 918.9 924.9 925.2 926.0 928.2 914.3 915.5 918.5 919.1 921.2 676.9 678.9 680.7 682.5 684.9 13233.0 13287.3 13309.5 13365.0 13406.3 14122.2 14290.1 14351.1 14358.6 14494.4 10423.0 10524.4 10532.2 10582.8 10703.9 3845.5 3871.5 3904.4 3909.7 3926.3 58190.4 58221.0 58905.1 59043.0 59519.0 11261.8 11269.4 11636.1 11656.5 11679.5 21127.3 21142.8 21188.2 21204.0 21236.5 8631.4 8846.7 9133.1 9138.6 9232.6 4725.1 4730.6 4768.4 4826.7 4845.3 3594.6 3649.0 3650.1 3651.1 3662.3 635.5 653.2 661.6 668.2 672.0 668.7 753.8 761.4 763.4 766.4 9384.5 9727.0 9735.6 9806.2 9820.9 654.1 664.9 749.2 755.1 756.9 4151.5 4211.8 4224.4 4293.2 4343.4 60396.4 60743.1 61098.4 62711.7 62714.7 54848.0 55876.2 56456.7 56877.0 57254.7 48488.3 49216.8 49234.5 49538.0 49615.3 8543.0 8658.4 8764.8 8770.4 8892.6 35968.8 36220.8 36907.4 37630.0 39960.2 47745.5 47818.5 47836.5 48391.3 48837.3 11255.3 11317.3 11371.3 11415.4 11487.9 12279.4 12451.7 12547.9 12984.0 13386.6 12082.9 12176.6 12230.4 12323.9 12640.7 12027.7 12141.9 12178.9 12491.4 12682.6 11284.5 11638.7 11985.9 12089.2 12160.6 10359.0 10511.7 10647.6 10668.0 10816.9 10225.4 10653.0 10726.0 10742.8 10772.6 15:29:50 INFO - PROCESS | 3469 | -------- Summary: end -------- 15:29:50 INFO - PROCESS | 3469 | 15:29:50 INFO - TEST-INFO | 3469: exit 0 15:29:50 INFO - TEST-OK | dromaeo_css | took 1108508ms 15:29:50 INFO - TEST-START | kraken 15:29:50 INFO - operating with platform_type : linux_ 15:29:50 INFO - Initialising browser for kraken test... 15:29:50 INFO - TEST-INFO | started process 3704 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpicvdaJ/profile http://localhost:40173/getInfo.html) 15:29:54 INFO - PROCESS | 3704 | 15:29:54 INFO - PROCESS | 3704 | (process:3782): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:29:54 INFO - PROCESS | 3704 | __metrics Screen width/height:1600/1200 15:29:54 INFO - PROCESS | 3704 | colorDepth:24 15:29:54 INFO - PROCESS | 3704 | Browser inner width/height: 1024/697 15:29:54 INFO - PROCESS | 3704 | __metrics 15:29:55 ERROR - PROCESS | 3704 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 15:29:56 INFO - TEST-INFO | 3704: exit 0 15:29:56 INFO - Browser initialized. 15:29:56 INFO - Running cycle 1/1 for kraken test... 15:29:56 INFO - TEST-INFO | started process 3832 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpicvdaJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:29:57 INFO - PROCESS | 3832 | 15:29:57 INFO - PROCESS | 3832 | (process:3901): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:30:07 INFO - PROCESS | 3832 | RSS: Main: 150892544 15:30:07 INFO - PROCESS | 3832 | 15:30:10 INFO - PROCESS | 3832 | Cycle 1(1): loaded http://localhost:40173/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40173/tests/kraken/driver.html?testName=audio-beat-detection) 15:30:11 INFO - PROCESS | 3832 | RSS: Main: 156217344 15:30:11 INFO - PROCESS | 3832 | 15:30:13 INFO - PROCESS | 3832 | Cycle 1(1): loaded http://localhost:40173/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40173/tests/kraken/driver.html?testName=audio-dft) 15:30:14 INFO - PROCESS | 3832 | RSS: Main: 156266496 15:30:14 INFO - PROCESS | 3832 | 15:30:17 INFO - PROCESS | 3832 | Cycle 1(1): loaded http://localhost:40173/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40173/tests/kraken/driver.html?testName=audio-fft) 15:30:18 INFO - PROCESS | 3832 | RSS: Main: 156565504 15:30:18 INFO - PROCESS | 3832 | 15:30:20 INFO - PROCESS | 3832 | Cycle 1(1): loaded http://localhost:40173/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40173/tests/kraken/driver.html?testName=audio-oscillator) 15:30:20 INFO - PROCESS | 3832 | RSS: Main: 156127232 15:30:20 INFO - PROCESS | 3832 | 15:30:22 INFO - PROCESS | 3832 | Cycle 1(1): loaded http://localhost:40173/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40173/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:30:23 INFO - PROCESS | 3832 | RSS: Main: 156114944 15:30:23 INFO - PROCESS | 3832 | 15:30:26 INFO - PROCESS | 3832 | Cycle 1(1): loaded http://localhost:40173/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40173/tests/kraken/driver.html?testName=imaging-darkroom) 15:30:27 INFO - PROCESS | 3832 | RSS: Main: 156389376 15:30:27 INFO - PROCESS | 3832 | 15:30:30 INFO - PROCESS | 3832 | Cycle 1(1): loaded http://localhost:40173/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40173/tests/kraken/driver.html?testName=imaging-desaturate) 15:30:31 INFO - PROCESS | 3832 | RSS: Main: 156643328 15:30:31 INFO - PROCESS | 3832 | 15:30:33 INFO - PROCESS | 3832 | Cycle 1(1): loaded http://localhost:40173/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40173/tests/kraken/driver.html?testName=json-parse-financial) 15:30:34 INFO - PROCESS | 3832 | RSS: Main: 156504064 15:30:34 INFO - PROCESS | 3832 | 15:30:35 INFO - PROCESS | 3832 | Cycle 1(1): loaded http://localhost:40173/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40173/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:30:36 INFO - PROCESS | 3832 | RSS: Main: 156520448 15:30:36 INFO - PROCESS | 3832 | 15:30:38 INFO - PROCESS | 3832 | Cycle 1(1): loaded http://localhost:40173/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40173/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:30:38 INFO - PROCESS | 3832 | RSS: Main: 156065792 15:30:38 INFO - PROCESS | 3832 | 15:30:40 INFO - PROCESS | 3832 | Cycle 1(1): loaded http://localhost:40173/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40173/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:30:41 INFO - PROCESS | 3832 | RSS: Main: 156385280 15:30:41 INFO - PROCESS | 3832 | 15:30:43 INFO - PROCESS | 3832 | Cycle 1(1): loaded http://localhost:40173/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40173/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:30:44 INFO - PROCESS | 3832 | RSS: Main: 157073408 15:30:44 INFO - PROCESS | 3832 | 15:30:47 INFO - PROCESS | 3832 | Cycle 1(1): loaded http://localhost:40173/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40173/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:30:47 INFO - PROCESS | 3832 | RSS: Main: 156917760 15:30:47 INFO - PROCESS | 3832 | 15:30:49 INFO - PROCESS | 3832 | Cycle 1(1): loaded http://localhost:40173/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40173/tests/kraken/driver.html?testName=ai-astar) 15:30:49 INFO - PROCESS | 3832 | RSS: Main: 157888512 15:30:49 INFO - PROCESS | 3832 | 15:30:49 INFO - PROCESS | 3832 | __start_tp_report 15:30:49 INFO - PROCESS | 3832 | _x_x_mozilla_page_load 15:30:49 INFO - PROCESS | 3832 | _x_x_mozilla_page_load_details 15:30:49 INFO - PROCESS | 3832 | |i|pagename|runs| 15:30:49 INFO - PROCESS | 3832 | |0;ai-astar;111;105;112;112;112;122;110;111;111;110 15:30:49 INFO - PROCESS | 3832 | |1;audio-beat-detection;155;128;151;171;129;158;155;135;196;130 15:30:49 INFO - PROCESS | 3832 | |2;audio-dft;165;164;163;164;166;167;165;165;162;160 15:30:49 INFO - PROCESS | 3832 | |3;audio-fft;77;76;76;170;76;76;73;77;170;77 15:30:49 INFO - PROCESS | 3832 | |4;audio-oscillator;92;91;146;93;93;92;137;92;91;144 15:30:49 INFO - PROCESS | 3832 | |5;imaging-gaussian-blur;117;117;118;117;117;118;116;117;117;117 15:30:49 INFO - PROCESS | 3832 | |6;imaging-darkroom;147;147;146;146;146;145;147;146;146;146 15:30:49 INFO - PROCESS | 3832 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;96;95 15:30:49 INFO - PROCESS | 3832 | |8;json-parse-financial;54;59;55;56;57;58;57;78;58;53 15:30:49 INFO - PROCESS | 3832 | |9;json-stringify-tinderbox;62;58;58;62;59;59;58;59;58;59 15:30:49 INFO - PROCESS | 3832 | |10;stanford-crypto-aes;74;74;75;75;77;84;76;79;74;75 15:30:49 INFO - PROCESS | 3832 | |11;stanford-crypto-ccm;117;116;117;117;116;126;119;120;137;127 15:30:49 INFO - PROCESS | 3832 | |12;stanford-crypto-pbkdf2;163;160;159;165;159;159;168;163;162;168 15:30:49 INFO - PROCESS | 3832 | |13;stanford-crypto-sha256-iterative;67;68;67;67;68;69;75;67;69;68 15:30:49 INFO - PROCESS | 3832 | __end_tp_report 15:30:49 INFO - PROCESS | 3832 | __start_cc_report 15:30:49 INFO - PROCESS | 3832 | _x_x_mozilla_cycle_collect,854 15:30:49 INFO - PROCESS | 3832 | __end_cc_report 15:30:49 INFO - PROCESS | 3832 | __startTimestamp1466721049888__endTimestamp 15:30:49 INFO - PROCESS | 3832 | 15:30:49 INFO - PROCESS | 3832 | ------- Summary: start ------- 15:30:49 INFO - PROCESS | 3832 | Number of tests: 14 15:30:49 INFO - PROCESS | 3832 | 15:30:49 INFO - PROCESS | 3832 | [#0] ai-astar Cycles:10 Average:111.60 Median:111.50 stddev:4.20 (3.8%) stddev-sans-first:4.44 15:30:49 INFO - PROCESS | 3832 | Values: 111.0 105.0 112.0 112.0 112.0 122.0 110.0 111.0 111.0 110.0 15:30:49 INFO - PROCESS | 3832 | 15:30:49 INFO - PROCESS | 3832 | [#1] audio-beat-detection Cycles:10 Average:150.80 Median:155.00 stddev:21.64 (14.0%) stddev-sans-first:22.90 15:30:49 INFO - PROCESS | 3832 | Values: 155.0 128.0 151.0 171.0 129.0 158.0 155.0 135.0 196.0 130.0 15:30:49 INFO - PROCESS | 3832 | 15:30:49 INFO - PROCESS | 3832 | [#2] audio-dft Cycles:10 Average:164.10 Median:165.00 stddev:2.02 (1.2%) stddev-sans-first:2.12 15:30:49 INFO - PROCESS | 3832 | Values: 165.0 164.0 163.0 164.0 166.0 167.0 165.0 165.0 162.0 160.0 15:30:49 INFO - PROCESS | 3832 | 15:30:49 INFO - PROCESS | 3832 | [#3] audio-fft Cycles:10 Average:94.80 Median:76.00 stddev:39.65 (52.2%) stddev-sans-first:41.53 15:30:49 INFO - PROCESS | 3832 | Values: 77.0 76.0 76.0 170.0 76.0 76.0 73.0 77.0 170.0 77.0 15:30:49 INFO - PROCESS | 3832 | 15:30:49 INFO - PROCESS | 3832 | [#4] audio-oscillator Cycles:10 Average:107.10 Median:92.00 stddev:24.42 (26.5%) stddev-sans-first:25.29 15:30:49 INFO - PROCESS | 3832 | Values: 92.0 91.0 146.0 93.0 93.0 92.0 137.0 92.0 91.0 144.0 15:30:49 INFO - PROCESS | 3832 | 15:30:49 INFO - PROCESS | 3832 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 15:30:49 INFO - PROCESS | 3832 | Values: 117.0 117.0 118.0 117.0 117.0 118.0 116.0 117.0 117.0 117.0 15:30:49 INFO - PROCESS | 3832 | 15:30:49 INFO - PROCESS | 3832 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 15:30:49 INFO - PROCESS | 3832 | Values: 147.0 147.0 146.0 146.0 146.0 145.0 147.0 146.0 146.0 146.0 15:30:49 INFO - PROCESS | 3832 | 15:30:49 INFO - PROCESS | 3832 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 15:30:49 INFO - PROCESS | 3832 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 15:30:49 INFO - PROCESS | 3832 | 15:30:49 INFO - PROCESS | 3832 | [#8] json-parse-financial Cycles:10 Average:58.50 Median:57.50 stddev:7.11 (12.4%) stddev-sans-first:7.35 15:30:49 INFO - PROCESS | 3832 | Values: 54.0 59.0 55.0 56.0 57.0 58.0 57.0 78.0 58.0 53.0 15:30:49 INFO - PROCESS | 3832 | 15:30:49 INFO - PROCESS | 3832 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:59.00 stddev:1.55 (2.6%) stddev-sans-first:1.27 15:30:49 INFO - PROCESS | 3832 | Values: 62.0 58.0 58.0 62.0 59.0 59.0 58.0 59.0 58.0 59.0 15:30:49 INFO - PROCESS | 3832 | 15:30:49 INFO - PROCESS | 3832 | [#10] stanford-crypto-aes Cycles:10 Average:76.30 Median:75.50 stddev:3.13 (4.1%) stddev-sans-first:3.21 15:30:49 INFO - PROCESS | 3832 | Values: 74.0 74.0 75.0 75.0 77.0 84.0 76.0 79.0 74.0 75.0 15:30:49 INFO - PROCESS | 3832 | 15:30:49 INFO - PROCESS | 3832 | [#11] stanford-crypto-ccm Cycles:10 Average:121.20 Median:119.50 stddev:6.83 (5.7%) stddev-sans-first:7.07 15:30:49 INFO - PROCESS | 3832 | Values: 117.0 116.0 117.0 117.0 116.0 126.0 119.0 120.0 137.0 127.0 15:30:49 INFO - PROCESS | 3832 | 15:30:49 INFO - PROCESS | 3832 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.60 Median:163.00 stddev:3.50 (2.1%) stddev-sans-first:3.71 15:30:49 INFO - PROCESS | 3832 | Values: 163.0 160.0 159.0 165.0 159.0 159.0 168.0 163.0 162.0 168.0 15:30:49 INFO - PROCESS | 3832 | 15:30:49 INFO - PROCESS | 3832 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.00 stddev:2.42 (3.6%) stddev-sans-first:2.50 15:30:49 INFO - PROCESS | 3832 | Values: 67.0 68.0 67.0 67.0 68.0 69.0 75.0 67.0 69.0 68.0 15:30:49 INFO - PROCESS | 3832 | -------- Summary: end -------- 15:30:49 INFO - PROCESS | 3832 | 15:30:50 INFO - TEST-INFO | 3832: exit 0 15:30:50 INFO - TEST-OK | kraken | took 60139ms 15:30:50 INFO - SUITE-END | took 1168s 15:30:51 INFO - Completed test suite (00:19:28) 15:30:51 INFO - javascript benchmark 15:30:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3337.1156643489476, 3361.5629968104145, 3368.747343949203, 3382.9154271143234, 3404.7616666833314, 5492.231087647728, 5494.587905907063, 5530.695811730353, 5545.168224766282, 5549.255386644421, 5465.6447330923465, 5509.614326997112, 5521.861953451155, 5536.972315138419, 5542.1132618781, 4980.651354405193, 4992.400911890578, 5060.4686507916695, 5061.898762024757, 5063.215201643751, 4998.850034498971, 5008.223725322581, 5052.46949070346, 5067.670601410897, 5099.388073431193, 5091.109055915219, 5113.616478764089, 5119.667221630601, 5123.718195499246, 5189.040027594907, 5056.3173971513925, 5059.064073146461, 5071.112555302844, 5076.543111120017, 5088.7964481420695, 4887.706737595756, 4904.435989861176, 4985.576226020793, 4991.900161996776, 5052.292679024939, 5394.136938089926, 5396.487333703292, 5437.238786569884, 5438.129899216106, 5473.972630136864, 5860.0, 5875.735591898375, 5892.322382925976, 5900.704964751788, 5924.259467566554, 5846.824595262149, 5895.764169433218, 5924.348321684612, 5957.046872500379, 6060.939390606081, 5467.398586155519, 5529.529989950859, 5536.086545719952, 5549.750261238213, 5554.1113421852715, 5999.370066142992, 6001.969990150022, 6007.068904319837, 6014.849628759229, 6018.849528761816, 5781.306243250837, 5798.536117110621, 5834.67909264986, 5848.912266316009, 5875.294964604275, 5853.0635098384055, 5880.94119058804, 5904.409559044061, 5905.350411454737, 5912.645241285537, 5692.715364231772, 5852.882942341129, 5871.324797648325, 5874.970625146932, 5875.50058245054, 5731.426857314235, 5797.188393624896, 5803.100519419497, 5808.535317174616, 5819.709014549256, 4442.644588432918, 4454.420925279757, 4456.108778244364, 4473.776311184428, 4477.731336119843, 3963.920721585552, 3977.3238549446664, 3987.1626958339075, 3994.08136128692, 4019.9799001005395, 5604.551635869121, 5702.45826646468, 5704.201411802351, 5704.771809127588, 5726.484616384545, 5889.469947704727, 5914.438128377883, 5945.524358051345, 6014.1580178775, 6018.578699491081, 5729.083346664514, 5730.19777231188, 5735.0, 5739.569532285095, 5752.07966725322, 4903.166461701448, 4959.851204463872, 4983.975080124576, 4994.675346102492, 5050.696958182521, 6192.504599632019, 6227.906581401283, 6233.937660623426, 6241.937580624226, 6251.374862513712, 5988.520918326611, 6000.249968753906, 6042.0, 6052.788152414644, 6052.818415447544, 5940.702964851826, 5998.190244316961, 6031.547633927561, 6151.231096112986, 6240.968795155995, 5895.322037965689, 5902.881942361043, 5912.852178695567, 5917.171595976481, 5921.348651648229, 5968.104784282393, 5968.76124954997, 5971.044632858721, 5993.850153746192, 6014.578979471395, 5725.169850371756, 5772.797952071657, 5841.094630332305, 5848.4151584841175, 5872.677002764718, 5855.473007429352, 5875.882482350244, 5881.05903055509, 5888.087346461305, 5895.02732049207, 5712.942870571241, 5735.8566035849435, 5742.799002034909, 5757.884842303214, 5766.913496297475, 5710.914336284876, 5837.241158649348, 5851.239338885917, 5881.676507792113, 5885.234919460443, 5777.62445441045, 5796.275465566804, 5812.0, 5815.912761308668, 5820.243368362086], "value": 5470.9020500181505, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [609.7134346856976, 665.6006396162302, 672.4754691340756, 675.0987431778574, 699.7900629811055, 38217.42673859891, 38910.610893891055, 38981.80509097451, 39062.218755624905, 39156.21687566247, 40447.59552404475, 40998.38502422458, 41213.0, 41312.58687413125, 41449.0, 8462.49225046496, 8613.440126391795, 8615.181557752003, 8619.482831030158, 8623.525706086195, 8597.0, 8906.86639700405, 8921.687740929068, 8951.552422378887, 8974.192322690957, 8928.910710892906, 8943.77640558988, 8974.147455991702, 8979.595918183697, 9003.324750643695, 8895.644174233055, 8909.287257019423, 8913.955430222839, 8928.508932008737, 8952.552372381388, 8805.075467075929, 8902.955485222532, 8908.73273801787, 8922.553872306424, 8929.598168082452, 39792.20415591672, 40065.799671001456, 40080.39879401811, 40228.19543609141, 40336.79831600853, 3598.4062629666073, 3637.563492380931, 3754.605766394544, 3990.4213888985932, 4167.2082304362375, 29682.851585741933, 29710.70289297101, 29913.76776578294, 29938.55092173619, 29991.700082999327, 4403.22943484892, 4466.57567531084, 4487.214737420938, 4487.416635837353, 4509.7970591323465, 293466.0, 294822.0, 296796.0, 297935.51032244915, 297954.0, 62152.68923655443, 62510.68744656248, 62566.374336256966, 62595.374046259865, 62840.371596283454, 66086.00870986939, 68888.65555672189, 69074.0, 70153.29846701468, 70386.64806676036, 19256.807431925783, 19379.612407752047, 19462.416127516197, 19473.92893390877, 19533.609327813363, 15077.698446031018, 15090.773638395432, 15140.621484462756, 15151.469698560719, 15219.315130818919, 20460.69308960367, 20620.484487887923, 20792.27227047046, 20797.0, 20832.1667133313, 7541.547507149478, 7563.659635316424, 7615.7334493292465, 7926.207379262028, 7962.610868331669, 1069.0859315285475, 1140.492480846032, 1200.537792949703, 1225.7119576899422, 1292.560529419983, 33830.15424614355, 35377.292454150775, 36822.8158859204, 37080.44379334312, 37222.0, 1168.7253495428567, 1193.9880601193877, 1213.3629844331797, 1241.4599649152647, 1275.4770544076885, 16115.677686446206, 16222.35110595563, 16408.179591020402, 16529.83470165307, 16653.084080375695, 469760.0, 530406.0, 541872.0, 560053.0, 848473.0, 56824.0, 57886.7105664469, 57921.710391448614, 57924.710376447845, 57986.13020804691, 1535.9692806143814, 1561.8047744031996, 1564.8591626753646, 1568.749000159969, 1576.0464918724235, 28780.856095720224, 30233.69766302309, 30353.392932141676, 30737.077887663407, 30746.231344216572, 52147.73926130345, 53223.93552129013, 53294.467055330504, 53459.732701336245, 53482.4651753493, 456321.0, 457110.0, 457427.0, 460494.0, 462478.0, 30470.695293046785, 30651.693483064882, 30810.537841931942, 30884.69115308818, 31223.531647025768, 48254.0, 48406.75796621135, 48968.75515622399, 49314.75342623264, 49416.50583494119, 40485.0, 41160.0, 41455.7927210362, 41699.79150104352, 41990.58009419989, 40332.0, 40620.79689601533, 41363.379549306184, 42089.78955105205, 42232.788836055624, 42153.78923105365, 42542.36186457144, 42697.78651106724, 42895.78552107344, 43153.56846431496, 34752.478712818825, 35842.10106806872, 36085.09787255339, 36429.0, 36945.63054369422, 27601.723982759915, 28007.439851203268, 28032.859835701507, 28191.43617127687, 28317.71682283151], "value": 20758.90185554116, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.3764982502733, 394.07196053294507, 420.2435615891397, 436.4195619825632, 443.9178751930892, 15287.847121528781, 18676.53308667284, 19277.71083433748, 19285.22859085635, 19290.131944062516, 18630.813691863077, 18884.716729249074, 19482.0, 19907.701384479245, 19929.40211793645, 5711.228984087147, 5773.307203135609, 5926.199963005004, 5963.642181469104, 5988.490978266853, 5852.561057920651, 5863.79476718315, 5915.615484993483, 5943.940560594382, 5958.9702051489685, 5812.302523697141, 5964.13520039594, 5972.581919265654, 5987.970060149693, 6016.037434010559, 5932.288125424933, 5939.2575928009, 5948.851278718023, 5955.612885162451, 5994.400559943992, 5262.210668399733, 5279.9208011879855, 5344.331958505187, 5349.7057661828585, 5356.919646205271, 23113.0, 23640.29079127629, 24084.397890052715, 24693.382665433328, 24701.0, 2577.587585986233, 2613.2552222616464, 2654.4558365535017, 2703.0, 2707.0254708304997, 14330.785038224434, 14340.0, 14379.0, 14658.047226930215, 14708.70582588353, 1973.1219607274768, 2060.2892002259196, 2081.490034941434, 2149.709789178472, 2167.328128280238, 82938.58530707368, 83032.58483707542, 83129.16870831275, 83164.0, 83717.58141209316, 10794.24440289188, 11015.724606884893, 11099.83350249747, 11162.665120046411, 11180.944095279472, 13459.327033648278, 15001.849981500263, 15718.921405393128, 15812.92093539525, 15843.0, 8330.625121869409, 8455.830883382298, 8742.825143497095, 8823.029466758651, 8850.557472126497, 8561.82876342482, 8608.827823443497, 8613.61238744258, 8650.956745216234, 8690.739277821549, 6744.730210791611, 6798.184217893884, 6856.41720453767, 6915.135608048994, 6938.271481494471, 2026.9898650506652, 2081.157131361801, 2118.894055297229, 2122.5224324527167, 2168.1760930846176, 1088.2817340555196, 1106.7233191702076, 1169.7660467906453, 1171.976560468786, 1244.993775031119, 19107.713384299248, 19568.0, 19692.50768730793, 19930.202791888452, 20296.797032029786, 1121.8373335866254, 1169.5672601137633, 1188.6612315490045, 1193.6419074277683, 1230.3848075962019, 9586.904130958601, 11293.15301352402, 11394.829077563843, 11490.597829075943, 11517.424128793527, 178848.0, 503069.0, 508217.0, 515631.0, 526549.0, 82075.0, 82259.17740822515, 82953.58523207346, 83287.16712832794, 86430.13569864347, 1149.7642983188593, 1161.4483120517687, 1180.6812160716559, 1182.2965335625117, 1182.3083496154845, 17017.149142543072, 17376.39182628602, 17618.471445856645, 17738.73391899097, 17921.910390447963, 37667.43498847465, 37908.05229869275, 37949.0, 38533.4219986706, 39367.212655747295, 52658.473415265355, 53742.46257537375, 54037.459625403244, 54184.18723719069, 54494.45505544894, 9055.0, 9197.942236642604, 9360.391574547633, 9454.196393306645, 9503.0, 13677.726445471233, 13914.860851391357, 14040.508582199574, 14048.719025619635, 14475.131492110508, 11935.164538482222, 12082.154249202471, 12088.637340879788, 12134.150609457252, 12230.816537751763, 12086.093542984136, 12132.150749447454, 12180.390980451119, 12300.507979680713, 12533.122681412213, 12221.572244971383, 12327.93836030814, 12369.62891113268, 12540.749185016432, 12783.041271904458, 9098.499582523025, 9161.221296189631, 9166.587503562489, 9316.860247096434, 9395.107464790834, 11480.598179063692, 11530.308181509135, 11530.82703759461, 11653.242539234923, 12119.394030298627], "value": 9706.72743606573, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1584.7464405695086, 1600.1599160440767, 1789.0965062643363, 1883.1902282018727, 1902.0, 7518.097828260603, 8083.353331733462, 8115.797105072376, 8373.37199710022, 8394.916050839489, 8370.916290837089, 8426.410151289412, 8470.195331443518, 8480.363972702056, 8481.363897707666, 2121.6393213153724, 2152.3865698275995, 2159.8380121490873, 2167.967480487786, 2174.771648976858, 2418.7097548294228, 2439.2682195341326, 2472.320111969205, 2475.1337032038823, 2481.900723971039, 2435.062500937143, 2439.8048156147465, 2447.938801529967, 2474.8515089094712, 2479.1570865905587, 2387.4747555537756, 2426.381272775431, 2449.4856080223262, 2452.803775697949, 2458.6312053191987, 2356.2342238772294, 2359.858408495496, 2369.5379401016808, 2370.7629237076326, 2387.9641805372935, 8428.662853485914, 8537.445066070748, 8567.357448191347, 8579.184977427134, 8583.742487725316, 5313.734313284321, 5434.64674796137, 5472.863178420532, 5476.534494567966, 5479.068558345091, 3378.6114596821435, 3393.3213357328386, 3419.196488825124, 3424.0, 3488.075659950115, 1085.1969542538543, 1135.6820090374708, 1140.2531341971023, 1150.580038286028, 1159.7796418680507, 11897.821532677104, 11902.464389102512, 11907.583234586835, 11931.0, 11932.28406295625, 4723.527647235249, 4724.0, 4778.187708089633, 4822.493638168012, 4828.758562071953, 10146.44194569291, 10147.137493313003, 10166.237532185116, 10184.439855808001, 10189.08298253146, 5428.70142142186, 5436.048691478975, 5483.040467918178, 5483.725813709299, 5513.641613295123, 4791.808327666924, 4958.256261560723, 4960.379952505937, 4967.130752118364, 5040.621953353513, 3824.2351529694174, 3864.613538646169, 3892.5718171001167, 3915.804209789499, 3995.900102497461, 1126.4311522680994, 1127.5827943660734, 1131.8189089745601, 1161.4250945781723, 1244.8733895824294, 1001.1790331927749, 1017.3793985668736, 1035.4305132177271, 1040.885502594714, 1048.3605000949415, 5737.971310143423, 5885.970570147122, 5919.644821310649, 5941.405859414111, 6060.787872424532, 1037.9325343852624, 1054.1724746074294, 1067.1889364083352, 1068.4497483795851, 1105.3367979212408, 4058.9797051014557, 4103.363978583325, 4116.361963895601, 4133.855315064018, 4144.896377590524, 10111.292209545409, 10487.790244195074, 10492.737681558023, 10555.630552930765, 10563.894361056291, 10290.691279261635, 10303.227257955683, 10307.175425965905, 10308.587656493657, 10333.586656533655, 8030.19698030204, 8065.072516660542, 8078.3133433658795, 8090.312323452455, 8105.635246413925, 5792.652440853562, 5804.042333015005, 5846.853828654148, 5872.295324560909, 5968.015277479168, 8677.566121693764, 8811.559422029, 8898.4660920345, 8942.46345219289, 8948.060453652273, 8839.823203535765, 9004.099590040943, 9049.59276832531, 9055.320850936074, 9095.317851161322, 7230.13238411394, 7379.594122323324, 7428.1086269647985, 7452.292032256927, 7610.086789585063, 7934.722284720007, 7963.084245311632, 7980.241877021674, 7992.440529163136, 8009.479383840032, 6966.477514186355, 7178.892316615359, 7228.855422891618, 7275.417966562768, 7397.778066658009, 7098.112735908012, 7175.174854891754, 7249.855002899807, 7260.201377848327, 7386.556806591621, 6701.430378417889, 6730.730770769114, 6737.3599508046655, 6769.661516924036, 6820.590764554143, 4836.806527738851, 4971.627127965345, 5005.374328208974, 5022.623303252198, 5025.84922452327, 5159.2003239497935, 5216.9739151304, 5237.485488797084, 5298.8940221196135, 5321.574274058144], "value": 4591.098935875789, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.7667401178215, 368.90408493791614, 369.2725331097737, 381.51738051365027, 381.5764501403443, 6442.484601231902, 6650.401463868251, 6677.866442671149, 6691.43122834559, 6785.287544807798, 6604.570702904308, 6671.733130674767, 6684.966575167129, 6693.39759421652, 6716.194056713189, 5071.163258062434, 5071.56891664209, 5078.4921507849285, 5087.694738315713, 5109.259157422191, 5042.747862606855, 5080.110980578403, 5099.566536844372, 5102.260172275018, 5116.411612664554, 5029.874253143664, 5059.16523773577, 5069.493050694938, 5079.0, 5087.974560127194, 4964.680727766866, 4990.775415106329, 5049.166887463564, 5057.9494205057845, 5079.746012699368, 4413.757243351614, 4440.400545926291, 4459.99650078733, 4464.241079016542, 4466.620337271336, 6381.68091595423, 6388.776392826276, 6389.393007664265, 6440.935590644081, 6444.420002199825, 5930.466258036798, 5945.464908158287, 5946.8810623787285, 5949.434803693643, 5960.738072278298, 7029.402500787439, 7067.116610423697, 7067.893981590229, 7079.752208672672, 7082.256363081854, 4616.0767846430845, 4800.495947925488, 4800.519948005206, 4963.900721985576, 4978.900421991576, 7293.927060729377, 7312.670929808171, 7349.963250183715, 7364.852702945965, 7409.740659076906, 4941.975290123526, 4945.406551213805, 4948.0, 4950.0, 4959.578435832923, 5029.06962211992, 5029.723365214948, 5030.2957585938, 5032.6980381177245, 5037.647364684437, 5813.883722325614, 5824.650520968756, 5825.0, 5826.388229235954, 5839.328477225088, 6964.373206411346, 7067.045948796949, 7078.575285482888, 7082.716691332289, 7088.787336379917, 1743.4856717268435, 1764.655892101028, 1769.5222289981632, 1770.1326350088364, 1771.3003363671535, 1137.3289759042204, 1142.3774043146338, 1143.6683361824978, 1154.3997121496943, 1160.4661855546374, 6683.899741503881, 6763.763268285685, 6771.62756048422, 6776.11910451648, 6778.559393639398, 7190.64046797658, 7194.352508274281, 7196.820079497949, 7204.279572042754, 7225.783226503108, 6754.5609535380045, 6757.155355580552, 6772.255051944282, 6776.390124888783, 6781.6609169541325, 3841.5774264830848, 3882.3011857865854, 3906.980465097713, 3908.687305015592, 3920.4119382092913, 7508.511946723445, 7515.21090285523, 7527.172011078777, 7535.095788505305, 7559.622018899033, 7345.0, 7390.5196162249285, 7396.260373962561, 7409.88885166723, 7417.369523590447, 7511.399088072941, 7537.359324457482, 7541.509801862861, 7544.132424771222, 7562.470627056054, 7046.929530704628, 7129.82175445618, 7189.712411503481, 7192.676329565077, 7199.604021778852, 7108.182559005781, 7116.146062472537, 7117.395021423237, 7129.108861392326, 7138.607376594337, 7510.361619262424, 7527.327798631407, 7527.924720752722, 7544.962275188589, 7545.283198096172, 4950.331705219749, 4953.529414705597, 4953.9752301239705, 4957.454679985127, 4961.652684312064, 7055.788326350218, 7148.64256787169, 7189.0, 7197.640117993975, 7213.20654727969, 7146.285371462812, 7146.749863754952, 7150.570965742072, 7161.0, 7173.964130179315, 7125.0, 7134.714611415485, 7138.46461515378, 7139.607321597362, 7154.069970903749, 6986.895196572157, 6998.860022799618, 7010.509264351446, 7016.929830701628, 7023.47323950716, 6912.758053468105, 7070.257622949722, 7135.143782746104, 7189.892151617834, 7194.388476979306, 6812.591244525344, 6995.965020174866, 7010.0, 7017.842056060693, 7018.298170182941], "value": 5306.734061200217, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.9430445564353, 732.051992669493, 735.8381156145648, 742.8625704244715, 765.9655315510802, 13192.472301107957, 13314.93342533286, 13328.40022199001, 13338.999999999987, 13349.132306400077, 12478.688032799184, 12597.055220858427, 12776.0, 12796.68008299793, 12842.678933026678, 740.0712106306578, 888.3337496877342, 896.8744375787395, 904.7647611620993, 910.5583791860976, 889.2041622747637, 895.6283142495856, 895.6506962284714, 896.085992287866, 897.8159477307137, 918.9264858811279, 924.944503329799, 925.2413021322518, 925.9675911343104, 928.1692884868039, 914.3142643017736, 915.5102020419077, 918.4672889723944, 919.0855099176296, 921.1709461484718, 676.891697328425, 678.8879834827247, 680.6562685843618, 682.4847240333567, 684.9178098628197, 13233.0, 13287.335633218301, 13309.534166304133, 13365.0, 13406.262655553941, 14122.22327771972, 14290.142591444443, 14351.138931664134, 14358.56924292273, 14494.42022319106, 10423.0, 10524.421156836372, 10532.210084243712, 10582.788344233073, 10703.892961070445, 3845.480860083881, 3871.5160604924386, 3904.3557812960826, 3909.7458665186673, 3926.332523471017, 58190.418095818924, 58221.0, 58905.11642325368, 59043.0, 59519.0, 11261.774764504664, 11269.436528173559, 11636.12729045325, 11656.533738650529, 11679.532818687157, 21127.26054588082, 21142.78857211408, 21188.15247390118, 21204.0, 21236.469088272606, 8631.352648551383, 8846.734597962071, 9133.086691330815, 9138.63445462174, 9232.584533696, 4725.078609671081, 4730.597899178609, 4768.427788665383, 4826.686265392738, 4845.2732090186755, 3594.6405359463843, 3648.9817550912076, 3650.069232345788, 3651.1054791575702, 3662.3407786598136, 635.5392340553062, 653.2194028136427, 661.6394065234459, 668.1781408867121, 671.9731210751613, 668.7124536449373, 753.8153152477678, 761.4365369626437, 763.3625922354785, 766.3830616353778, 9384.483853387992, 9726.95136524327, 9735.56189971453, 9806.166475849634, 9820.852687209697, 654.0614218596329, 664.9434798042124, 749.1796482851269, 755.1278273594007, 756.8864670299499, 4151.501819781645, 4211.831526738896, 4224.415893645531, 4293.205756934977, 4343.413639158736, 60396.39603603908, 60743.08885366723, 61098.38901611016, 62711.68644156841, 62714.686426568485, 54848.0, 55876.161857572166, 56456.717716411156, 56877.0, 57254.71372643193, 48488.27267590989, 49216.753916230904, 49234.507654923706, 49538.00923981572, 49615.25577116346, 8542.957285213533, 8658.39391242607, 8764.780880477783, 8770.38607297483, 8892.64429422816, 35968.820155899055, 36220.81889590535, 36907.446388304736, 37629.96980058446, 39960.200795983335, 47745.5225447755, 47818.52181478141, 47836.52163478321, 48391.27413088877, 48837.313947733215, 11255.324680519196, 11317.264377815416, 11371.260868043551, 11415.37215453158, 11487.942560287145, 12279.447424865724, 12451.688707782378, 12547.874521255037, 12984.0, 13386.598402047954, 12082.879171208528, 12176.573819916615, 12230.44962976686, 12323.938380308042, 12640.6839829005, 12027.699307517381, 12141.939290303491, 12178.878211218129, 12491.375431228584, 12682.619521414372, 11284.548618055185, 11638.709032273922, 11985.940070299941, 12089.214201076902, 12160.574379896661, 10359.0, 10511.684649460529, 10647.627333043307, 10668.0, 10816.891831081588, 10225.386476811414, 10652.987966143204, 10726.0, 10742.785144297226, 10772.569097236335], "value": 6833.100669040068, "unit": "score"}], "name": "dromaeo_css", "value": 7538.580073595134, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 112.0, 112.0, 112.0, 122.0, 110.0, 111.0, 111.0, 110.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 128.0, 151.0, 171.0, 129.0, 158.0, 155.0, 135.0, 196.0, 130.0], "value": 150.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 163.0, 164.0, 166.0, 167.0, 165.0, 165.0, 162.0, 160.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 170.0, 76.0, 76.0, 73.0, 77.0, 170.0, 77.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 146.0, 93.0, 93.0, 92.0, 137.0, 92.0, 91.0, 144.0], "value": 107.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 116.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 145.0, 147.0, 146.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 59.0, 55.0, 56.0, 57.0, 58.0, 57.0, 78.0, 58.0, 53.0], "value": 58.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 58.0, 58.0, 62.0, 59.0, 59.0, 58.0, 59.0, 58.0, 59.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 75.0, 77.0, 84.0, 76.0, 79.0, 74.0, 75.0], "value": 76.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 116.0, 126.0, 119.0, 120.0, 137.0, 127.0], "value": 121.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 159.0, 165.0, 159.0, 159.0, 168.0, 163.0, 162.0, 168.0], "value": 162.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 67.0, 68.0, 69.0, 75.0, 67.0, 69.0, 68.0], "value": 68.5, "unit": "score"}], "name": "kraken", "value": 1533.1000000000001, "alertThreshold": 2.0}]} 15:30:51 INFO - Return code: 0 15:30:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:30:51 ERROR - # TBPL SUCCESS # 15:30:51 INFO - Running post-action listener: _resource_record_post_action 15:30:51 INFO - Running post-run listener: _resource_record_post_run 15:30:52 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 7696384; Write bytes: 349462528; Read time: 1964; Write time: 231768 15:30:52 INFO - install - Wall time: 13s; CPU: 13.0%; Read bytes: 0; Write bytes: 4669440; Read time: 0; Write time: 356 15:30:52 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 5935104; Write bytes: 344793088; Read time: 1888; Write time: 231412 15:30:52 INFO - Running post-run listener: _upload_blobber_files 15:30:52 INFO - Blob upload gear active. 15:30:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:30:52 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 15:30:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:30:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:30:52 INFO - (blobuploader) - INFO - Open directory for files ... 15:30:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:30:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:30:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:30:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:30:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:30:53 INFO - (blobuploader) - INFO - Done attempting. 15:30:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:30:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:30:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:30:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:30:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:30:54 INFO - (blobuploader) - INFO - Done attempting. 15:30:54 INFO - (blobuploader) - INFO - Iteration through files over. 15:30:54 INFO - Return code: 0 15:30:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:30:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:30:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b4a760750e664aa53d40eb40e4b4b02ed02c60596808477c26e8da1f9d2735446e4d2dd974cdaec7abe243914d43b17ad6a30ede9e22b96ec40aa795ce7d8ff4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/742ed2caa10e6a7e4b00a7951addf27ae6687cc53e9dddb32b508e55f183add26d7bb3087b9dbed0468ad06d053d2c224ace966ea89598eff30b7b554656a365"} 15:30:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:30:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:30:54 INFO - Contents: 15:30:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b4a760750e664aa53d40eb40e4b4b02ed02c60596808477c26e8da1f9d2735446e4d2dd974cdaec7abe243914d43b17ad6a30ede9e22b96ec40aa795ce7d8ff4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/742ed2caa10e6a7e4b00a7951addf27ae6687cc53e9dddb32b508e55f183add26d7bb3087b9dbed0468ad06d053d2c224ace966ea89598eff30b7b554656a365"} 15:30:54 INFO - Running post-run listener: copy_logs_to_upload_dir 15:30:54 INFO - Copying logs to upload dir... 15:30:54 INFO - mkdir: /builds/slave/test/build/upload/logs 15:30:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1227.822572 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-06-23 15:30:54.284724) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 15:30:54.287961) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9e0dfe3369c33a1556e63f89000001d8-1466719532.686411-1124632631 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/Mozilla-Beta/sha512/b4a760750e664aa53d40eb40e4b4b02ed02c60596808477c26e8da1f9d2735446e4d2dd974cdaec7abe243914d43b17ad6a30ede9e22b96ec40aa795ce7d8ff4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/742ed2caa10e6a7e4b00a7951addf27ae6687cc53e9dddb32b508e55f183add26d7bb3087b9dbed0468ad06d053d2c224ace966ea89598eff30b7b554656a365"} build_url:https://queue.taskcluster.net/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011257 build_url: 'https://queue.taskcluster.net/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b4a760750e664aa53d40eb40e4b4b02ed02c60596808477c26e8da1f9d2735446e4d2dd974cdaec7abe243914d43b17ad6a30ede9e22b96ec40aa795ce7d8ff4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/742ed2caa10e6a7e4b00a7951addf27ae6687cc53e9dddb32b508e55f183add26d7bb3087b9dbed0468ad06d053d2c224ace966ea89598eff30b7b554656a365"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 15:30:54.316740) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 15:30:54.317122) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9e0dfe3369c33a1556e63f89000001d8-1466719532.686411-1124632631 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004379 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 15:30:54.397523) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 15:30:54.397855) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 15:30:54.398151) ========= ========= Total master_lag: 0.18 =========