builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-026 starttime: 1461180735.81 results: success (0) buildid: 20160420110249 builduid: 562744aed783432f9de25064e09a31a0 revision: 30c5dbcee7ddeafcaffa50e01429c45d459bb8fc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 12:32:15.815099) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 12:32:15.815642) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 12:32:15.815923) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 12:32:15.832413) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 12:32:15.832721) ========= 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=41bf3e9aed84707956354da8000001c5-1461176189.671725-1788962282 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-20 12:32:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 34.0M=0s 2016-04-20 12:32:16 (34.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120891 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 12:32:15.967721) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 12:32:15.968213) ========= 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=41bf3e9aed84707956354da8000001c5-1461176189.671725-1788962282 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021962 ========= master_lag: 0.12 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 12:32:16.112239) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 12:32:16.112586) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 30c5dbcee7ddeafcaffa50e01429c45d459bb8fc --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 30c5dbcee7ddeafcaffa50e01429c45d459bb8fc --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=41bf3e9aed84707956354da8000001c5-1461176189.671725-1788962282 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-20 12:32:16,424 truncating revision to first 12 chars 2016-04-20 12:32:16,424 Setting DEBUG logging. 2016-04-20 12:32:16,425 attempt 1/10 2016-04-20 12:32:16,425 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/30c5dbcee7dd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-20 12:32:16,824 unpacking tar archive at: mozilla-central-30c5dbcee7dd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.682428 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 12:32:16.820502) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 12:32:16.820773) ========= script_repo_revision: 30c5dbcee7ddeafcaffa50e01429c45d459bb8fc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 12:32:16.821148) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 12:32:16.821415) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 12:32:16.831239) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-04-20 12:32:16.831567) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=41bf3e9aed84707956354da8000001c5-1461176189.671725-1788962282 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:32:17 INFO - MultiFileLogger online at 20160420 12:32:17 in /builds/slave/test 12:32:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 12:32:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:32:17 INFO - {'append_to_log': False, 12:32:17 INFO - 'base_work_dir': '/builds/slave/test', 12:32:17 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 12:32:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:32:17 INFO - 'branch': 'Firefox-Non-PGO', 12:32:17 INFO - 'buildbot_json_path': 'buildprops.json', 12:32:17 INFO - 'config_files': ('talos/linux_config.py',), 12:32:17 INFO - 'default_actions': ('clobber', 12:32:17 INFO - 'read-buildbot-config', 12:32:17 INFO - 'download-and-extract', 12:32:17 INFO - 'populate-webroot', 12:32:17 INFO - 'create-virtualenv', 12:32:17 INFO - 'install', 12:32:17 INFO - 'run-tests'), 12:32:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:32:17 INFO - 'download_minidump_stackwalk': True, 12:32:17 INFO - 'download_symbols': 'ondemand', 12:32:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:32:17 INFO - 'tooltool.py': '/tools/tooltool.py', 12:32:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:32:17 INFO - '/tools/misc-python/virtualenv.py')}, 12:32:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:32:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:32:17 INFO - 'installer_path': 'installer.exe', 12:32:17 INFO - 'log_level': 'info', 12:32:17 INFO - 'log_name': 'talos', 12:32:17 INFO - 'log_to_console': True, 12:32:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:32:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:32:17 INFO - 'opt_config_files': (), 12:32:17 INFO - 'pip_index': False, 12:32:17 INFO - 'sps_profile': False, 12:32:17 INFO - 'sps_profile_interval': 0, 12:32:17 INFO - 'suite': 'dromaeojs-e10s', 12:32:17 INFO - 'system_bits': '32', 12:32:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:32:17 INFO - 'title': 'talos-linux64-ix-026', 12:32:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:32:17 INFO - 'use_talos_json': True, 12:32:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:32:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:32:17 INFO - 'work_dir': 'build'} 12:32:17 INFO - ##### 12:32:17 INFO - ##### Running clobber step. 12:32:17 INFO - ##### 12:32:17 INFO - Running pre-action listener: _resource_record_pre_action 12:32:17 INFO - Running main action method: clobber 12:32:17 INFO - rmtree: /builds/slave/test/build 12:32:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:32:17 INFO - Running post-action listener: _resource_record_post_action 12:32:17 INFO - ##### 12:32:17 INFO - ##### Running read-buildbot-config step. 12:32:17 INFO - ##### 12:32:17 INFO - Running pre-action listener: _resource_record_pre_action 12:32:17 INFO - Running main action method: read_buildbot_config 12:32:17 INFO - Using buildbot properties: 12:32:17 INFO - { 12:32:17 INFO - "project": "", 12:32:17 INFO - "product": "firefox", 12:32:17 INFO - "script_repo_revision": "production", 12:32:17 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 12:32:17 INFO - "repository": "", 12:32:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 12:32:17 INFO - "buildid": "20160420110249", 12:32:17 INFO - "pgo_build": "False", 12:32:17 INFO - "basedir": "/builds/slave/test", 12:32:17 INFO - "buildnumber": 33, 12:32:17 INFO - "slavename": "talos-linux64-ix-026", 12:32:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:32:17 INFO - "platform": "ubuntu64_hw", 12:32:17 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 12:32:17 INFO - "branch": "mozilla-central", 12:32:17 INFO - "repo_path": "mozilla-central", 12:32:17 INFO - "revision": "30c5dbcee7ddeafcaffa50e01429c45d459bb8fc", 12:32:17 INFO - "stage_platform": "linux64", 12:32:17 INFO - "builduid": "562744aed783432f9de25064e09a31a0", 12:32:17 INFO - "slavebuilddir": "test" 12:32:17 INFO - } 12:32:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/eSEazso5QVCwLOTfWrAySg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 12:32:17 INFO - Running post-action listener: _resource_record_post_action 12:32:17 INFO - ##### 12:32:17 INFO - ##### Running download-and-extract step. 12:32:17 INFO - ##### 12:32:17 INFO - Running pre-action listener: _resource_record_pre_action 12:32:17 INFO - Running main action method: download_and_extract 12:32:17 INFO - mkdir: /builds/slave/test/build/tests 12:32:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:32:17 INFO - https://queue.taskcluster.net/v1/task/eSEazso5QVCwLOTfWrAySg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:32:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eSEazso5QVCwLOTfWrAySg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:32:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eSEazso5QVCwLOTfWrAySg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:32:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eSEazso5QVCwLOTfWrAySg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:32:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eSEazso5QVCwLOTfWrAySg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:32:28 INFO - Downloaded 1361 bytes. 12:32:28 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:32:28 INFO - Using the following test package requirements: 12:32:28 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 12:32:28 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:32:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:32:28 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:32:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:32:28 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:32:28 INFO - u'jsshell-linux-x86_64.zip'], 12:32:28 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:32:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:32:28 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 12:32:28 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:32:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:32:28 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:32:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:32:28 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:32:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:32:28 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:32:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:32:28 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:32: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')]} 12:32:28 INFO - https://queue.taskcluster.net/v1/task/eSEazso5QVCwLOTfWrAySg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:32:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eSEazso5QVCwLOTfWrAySg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:32:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eSEazso5QVCwLOTfWrAySg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:32:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eSEazso5QVCwLOTfWrAySg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:32:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eSEazso5QVCwLOTfWrAySg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:32:39 INFO - Downloaded 22267541 bytes. 12:32:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:32:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:32:40 INFO - Return code: 0 12:32:40 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:32:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:32:40 INFO - https://queue.taskcluster.net/v1/task/eSEazso5QVCwLOTfWrAySg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:32:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eSEazso5QVCwLOTfWrAySg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:32:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eSEazso5QVCwLOTfWrAySg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:32:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eSEazso5QVCwLOTfWrAySg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:32:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eSEazso5QVCwLOTfWrAySg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:32:48 INFO - Downloaded 22267541 bytes. 12:32:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:32:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:32:49 INFO - Return code: 0 12:32:49 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')]} 12:32:49 INFO - https://queue.taskcluster.net/v1/task/eSEazso5QVCwLOTfWrAySg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:32:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eSEazso5QVCwLOTfWrAySg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 12:32:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eSEazso5QVCwLOTfWrAySg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 12:32:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eSEazso5QVCwLOTfWrAySg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 12:32:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eSEazso5QVCwLOTfWrAySg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:32:55 INFO - Downloaded 10845952 bytes. 12:32:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:32:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 12:32:55 INFO - Return code: 0 12:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:32:55 INFO - https://queue.taskcluster.net/v1/task/eSEazso5QVCwLOTfWrAySg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:32:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eSEazso5QVCwLOTfWrAySg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:32:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eSEazso5QVCwLOTfWrAySg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:32:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eSEazso5QVCwLOTfWrAySg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:32:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eSEazso5QVCwLOTfWrAySg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:33:00 INFO - Downloaded 54595309 bytes. 12:33:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eSEazso5QVCwLOTfWrAySg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:33:00 INFO - mkdir: /builds/slave/test/properties 12:33:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:33:00 INFO - Writing to file /builds/slave/test/properties/build_url 12:33:00 INFO - Contents: 12:33:00 INFO - build_url:https://queue.taskcluster.net/v1/task/eSEazso5QVCwLOTfWrAySg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:33:02 INFO - Running post-action listener: _resource_record_post_action 12:33:02 INFO - Running post-action listener: set_extra_try_arguments 12:33:02 INFO - ##### 12:33:02 INFO - ##### Running populate-webroot step. 12:33:02 INFO - ##### 12:33:02 INFO - Running pre-action listener: _resource_record_pre_action 12:33:02 INFO - Running main action method: populate_webroot 12:33:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:33:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:33:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:33:02 INFO - '--tppagecycles', 12:33:02 INFO - '7'], 12:33:02 INFO - 'tests': ['tsvgm']}}, 12:33:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:33:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:33:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:33:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:33:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:33:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:33:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:33:02 INFO - 'talos_options': ['--disable-e10s'], 12:33:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:33:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:33:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:33:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:33:02 INFO - 'talos_options': ['--disable-e10s'], 12:33:02 INFO - 'tests': ['damp', 'tps']}, 12:33:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:33:02 INFO - 'tests': ['damp', 'tps']}, 12:33:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:33:02 INFO - 'tests': ['dromaeo_dom']}, 12:33:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:33:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:33:02 INFO - 'tests': ['a11yr', 12:33:02 INFO - 'ts_paint', 12:33:02 INFO - 'tpaint', 12:33:02 INFO - 'sessionrestore', 12:33:02 INFO - 'sessionrestore_no_auto_restore', 12:33:02 INFO - 'tabpaint']}, 12:33:02 INFO - 'other-e10s': {'tests': ['a11yr', 12:33:02 INFO - 'ts_paint', 12:33:02 INFO - 'tpaint', 12:33:02 INFO - 'sessionrestore', 12:33:02 INFO - 'sessionrestore_no_auto_restore', 12:33:02 INFO - 'tabpaint']}, 12:33:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:33:02 INFO - 'ts_paint', 12:33:02 INFO - 'tpaint', 12:33:02 INFO - 'sessionrestore', 12:33:02 INFO - 'sessionrestore_no_auto_restore', 12:33:02 INFO - 'tabpaint']}, 12:33:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:33:02 INFO - 'ts_paint', 12:33:02 INFO - 'tpaint', 12:33:02 INFO - 'sessionrestore', 12:33:02 INFO - 'sessionrestore_no_auto_restore', 12:33:02 INFO - 'tabpaint']}, 12:33:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:33:02 INFO - 'tests': ['a11yr', 12:33:02 INFO - 'ts_paint', 12:33:02 INFO - 'tpaint', 12:33:02 INFO - 'sessionrestore', 12:33:02 INFO - 'sessionrestore_no_auto_restore', 12:33:02 INFO - 'tabpaint']}, 12:33:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:33:02 INFO - 'tests': ['a11yr', 12:33:02 INFO - 'ts_paint', 12:33:02 INFO - 'tpaint', 12:33:02 INFO - 'sessionrestore', 12:33:02 INFO - 'sessionrestore_no_auto_restore', 12:33:02 INFO - 'tabpaint']}, 12:33:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:33:02 INFO - 'tests': ['tsvgx', 12:33:02 INFO - 'tsvgr_opacity', 12:33:02 INFO - 'tart', 12:33:02 INFO - 'tscrollx', 12:33:02 INFO - 'cart']}, 12:33:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:33:02 INFO - 'tsvgr_opacity', 12:33:02 INFO - 'tart', 12:33:02 INFO - 'tscrollx', 12:33:02 INFO - 'cart']}, 12:33:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:33:02 INFO - 'talos_options': ['--disable-e10s'], 12:33:02 INFO - 'tests': ['tp5o']}, 12:33:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:33:02 INFO - 'tests': ['tp5o']}, 12:33:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:33:02 INFO - 'talos_options': ['--disable-e10s', 12:33:02 INFO - '--xperf_path', 12:33:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:33:02 INFO - 'tests': ['tp5n']}, 12:33:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:33:02 INFO - 'talos_options': ['--xperf_path', 12:33:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:33:02 INFO - 'tests': ['tp5n']}}, 12:33:02 INFO - 'talos.zip': {'path': '', 12:33:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:33:02 INFO - Running post-action listener: _resource_record_post_action 12:33:02 INFO - ##### 12:33:02 INFO - ##### Running create-virtualenv step. 12:33:02 INFO - ##### 12:33:02 INFO - Running pre-action listener: _resource_record_pre_action 12:33:02 INFO - Running main action method: create_virtualenv 12:33:02 INFO - Creating virtualenv /builds/slave/test/build/venv 12:33:02 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 12:33:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:33:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:33:02 INFO - Using real prefix '/usr' 12:33:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:33:03 INFO - Installing distribute.............................................................................................................................................................................................done. 12:33:05 INFO - Installing pip.................done. 12:33:05 INFO - Return code: 0 12:33:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:33:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:33:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:33:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:33:05 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 0x7fd9c60a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bde5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6d410>, '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 0x1c6e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c6e7a0>, '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': '41bf3e9aed84707956354da8000001c5-1461176189.671725-1788962282', '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 12:33:05 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 12:33:05 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 12:33:05 INFO - Using env: {'DISPLAY': ':0', 12:33:05 INFO - 'HOME': '/home/cltbld', 12:33:05 INFO - 'LANG': 'en_US.UTF-8', 12:33:05 INFO - 'LANGUAGE': 'en_US:en', 12:33:05 INFO - 'LOGNAME': 'cltbld', 12:33:05 INFO - 'MAIL': '/var/mail/cltbld', 12:33:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:33:05 INFO - 'MOZ_NO_REMOTE': '1', 12:33:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:33:05 INFO - 'NO_EM_RESTART': '1', 12:33:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:33:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:33:05 INFO - 'PWD': '/builds/slave/test', 12:33:05 INFO - 'SHELL': '/bin/bash', 12:33:05 INFO - 'SHLVL': '1', 12:33:05 INFO - 'TERM': 'linux', 12:33:05 INFO - 'TMOUT': '86400', 12:33:05 INFO - 'USER': 'cltbld', 12:33:05 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461176189.671725-1788962282', 12:33:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:33:05 INFO - '_': '/tools/buildbot/bin/python'} 12:33:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:33:05 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 12:33:05 INFO - Cleaning up... 12:33:05 INFO - Return code: 0 12:33:05 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:33:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:33:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:33:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:33:05 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 0x7fd9c60a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bde5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6d410>, '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 0x1c6e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c6e7a0>, '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': '41bf3e9aed84707956354da8000001c5-1461176189.671725-1788962282', '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 12:33:05 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 12:33:05 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 12:33:05 INFO - Using env: {'DISPLAY': ':0', 12:33:05 INFO - 'HOME': '/home/cltbld', 12:33:05 INFO - 'LANG': 'en_US.UTF-8', 12:33:05 INFO - 'LANGUAGE': 'en_US:en', 12:33:05 INFO - 'LOGNAME': 'cltbld', 12:33:05 INFO - 'MAIL': '/var/mail/cltbld', 12:33:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:33:05 INFO - 'MOZ_NO_REMOTE': '1', 12:33:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:33:05 INFO - 'NO_EM_RESTART': '1', 12:33:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:33:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:33:05 INFO - 'PWD': '/builds/slave/test', 12:33:05 INFO - 'SHELL': '/bin/bash', 12:33:05 INFO - 'SHLVL': '1', 12:33:05 INFO - 'TERM': 'linux', 12:33:05 INFO - 'TMOUT': '86400', 12:33:05 INFO - 'USER': 'cltbld', 12:33:05 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461176189.671725-1788962282', 12:33:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:33:05 INFO - '_': '/tools/buildbot/bin/python'} 12:33:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:33:05 INFO - Downloading/unpacking psutil>=0.7.1 12:33:05 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 12:33:05 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 12:33:05 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 12:33:05 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 12:33:05 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 12:33:05 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 12:33:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:33:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:33:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:33:07 INFO - Installing collected packages: psutil 12:33:07 INFO - Running setup.py install for psutil 12:33:07 INFO - building 'psutil._psutil_linux' extension 12:33:07 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 12:33:07 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 12:33:07 INFO - building 'psutil._psutil_posix' extension 12:33:07 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 12:33:07 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 12:33:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:33:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:33:07 INFO - Successfully installed psutil 12:33:07 INFO - Cleaning up... 12:33:08 INFO - Return code: 0 12:33:08 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:33:08 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')]} 12:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:33:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:33:08 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')]} 12:33:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:33:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:33:08 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 0x7fd9c60a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bde5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6d410>, '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 0x1c6e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c6e7a0>, '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': '41bf3e9aed84707956354da8000001c5-1461176189.671725-1788962282', '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 12:33:08 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 12:33:08 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 12:33:08 INFO - Using env: {'DISPLAY': ':0', 12:33:08 INFO - 'HOME': '/home/cltbld', 12:33:08 INFO - 'LANG': 'en_US.UTF-8', 12:33:08 INFO - 'LANGUAGE': 'en_US:en', 12:33:08 INFO - 'LOGNAME': 'cltbld', 12:33:08 INFO - 'MAIL': '/var/mail/cltbld', 12:33:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:33:08 INFO - 'MOZ_NO_REMOTE': '1', 12:33:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:33:08 INFO - 'NO_EM_RESTART': '1', 12:33:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:33:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:33:08 INFO - 'PWD': '/builds/slave/test', 12:33:08 INFO - 'SHELL': '/bin/bash', 12:33:08 INFO - 'SHLVL': '1', 12:33:08 INFO - 'TERM': 'linux', 12:33:08 INFO - 'TMOUT': '86400', 12:33:08 INFO - 'USER': 'cltbld', 12:33:08 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461176189.671725-1788962282', 12:33:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:33:08 INFO - '_': '/tools/buildbot/bin/python'} 12:33:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:33:08 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:33:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:33:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:33:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:33:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:33:10 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:33:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:33:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:33:10 INFO - Installing collected packages: mozsystemmonitor 12:33:10 INFO - Running setup.py install for mozsystemmonitor 12:33:10 INFO - Successfully installed mozsystemmonitor 12:33:10 INFO - Cleaning up... 12:33:10 INFO - Return code: 0 12:33:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:33:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:33:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:33:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:33:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:33:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:33:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:33:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd9c60a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bde5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6d410>, '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 0x1c6e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c6e7a0>, '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': '41bf3e9aed84707956354da8000001c5-1461176189.671725-1788962282', '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 12:33:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:33:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:33:10 INFO - Using env: {'DISPLAY': ':0', 12:33:10 INFO - 'HOME': '/home/cltbld', 12:33:10 INFO - 'LANG': 'en_US.UTF-8', 12:33:10 INFO - 'LANGUAGE': 'en_US:en', 12:33:10 INFO - 'LOGNAME': 'cltbld', 12:33:10 INFO - 'MAIL': '/var/mail/cltbld', 12:33:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:33:10 INFO - 'MOZ_NO_REMOTE': '1', 12:33:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:33:10 INFO - 'NO_EM_RESTART': '1', 12:33:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:33:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:33:10 INFO - 'PWD': '/builds/slave/test', 12:33:10 INFO - 'SHELL': '/bin/bash', 12:33:10 INFO - 'SHLVL': '1', 12:33:10 INFO - 'TERM': 'linux', 12:33:10 INFO - 'TMOUT': '86400', 12:33:10 INFO - 'USER': 'cltbld', 12:33:10 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461176189.671725-1788962282', 12:33:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:33:10 INFO - '_': '/tools/buildbot/bin/python'} 12:33:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:33:10 INFO - Downloading/unpacking blobuploader==1.2.4 12:33:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:33:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:33:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:33:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:33:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:33:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:33:12 INFO - Downloading blobuploader-1.2.4.tar.gz 12:33:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:33:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:33:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:33:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:33:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:33:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:33:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:33:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:33:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:33:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:33:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:33:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:33:13 INFO - Downloading docopt-0.6.1.tar.gz 12:33:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:33:13 INFO - Installing collected packages: blobuploader, requests, docopt 12:33:13 INFO - Running setup.py install for blobuploader 12:33:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:33:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:33:13 INFO - Running setup.py install for requests 12:33:13 INFO - Running setup.py install for docopt 12:33:13 INFO - Successfully installed blobuploader requests docopt 12:33:13 INFO - Cleaning up... 12:33:13 INFO - Return code: 0 12:33:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:33:13 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')]} 12:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:33:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:33:13 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')]} 12:33:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:33:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:33:13 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 0x7fd9c60a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bde5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6d410>, '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 0x1c6e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c6e7a0>, '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': '41bf3e9aed84707956354da8000001c5-1461176189.671725-1788962282', '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 12:33:13 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 12:33:13 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 12:33:13 INFO - Using env: {'DISPLAY': ':0', 12:33:13 INFO - 'HOME': '/home/cltbld', 12:33:13 INFO - 'LANG': 'en_US.UTF-8', 12:33:13 INFO - 'LANGUAGE': 'en_US:en', 12:33:13 INFO - 'LOGNAME': 'cltbld', 12:33:13 INFO - 'MAIL': '/var/mail/cltbld', 12:33:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:33:13 INFO - 'MOZ_NO_REMOTE': '1', 12:33:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:33:13 INFO - 'NO_EM_RESTART': '1', 12:33:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:33:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:33:13 INFO - 'PWD': '/builds/slave/test', 12:33:13 INFO - 'SHELL': '/bin/bash', 12:33:13 INFO - 'SHLVL': '1', 12:33:13 INFO - 'TERM': 'linux', 12:33:13 INFO - 'TMOUT': '86400', 12:33:13 INFO - 'USER': 'cltbld', 12:33:13 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461176189.671725-1788962282', 12:33:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:33:13 INFO - '_': '/tools/buildbot/bin/python'} 12:33:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:33:13 INFO - Running setup.py (path:/tmp/pip-UJhxxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:33:13 INFO - Running setup.py (path:/tmp/pip-akraE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:33:14 INFO - Running setup.py (path:/tmp/pip-v6Skzd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:33:14 INFO - Running setup.py (path:/tmp/pip-3UtPmf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:33:14 INFO - Running setup.py (path:/tmp/pip-p9kNB7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:33:14 INFO - Running setup.py (path:/tmp/pip-oT2CYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:33:14 INFO - Running setup.py (path:/tmp/pip-Q6XVik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:33:14 INFO - Running setup.py (path:/tmp/pip-k2gU9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:33:14 INFO - Running setup.py (path:/tmp/pip-nnYFc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:33:14 INFO - Running setup.py (path:/tmp/pip-xixASv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:33:14 INFO - Running setup.py (path:/tmp/pip-LREKj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:33:14 INFO - Running setup.py (path:/tmp/pip-p6M0ef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:33:14 INFO - Running setup.py (path:/tmp/pip-WRgqN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:33:14 INFO - Running setup.py (path:/tmp/pip-bPrfmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:33:14 INFO - Running setup.py (path:/tmp/pip-92NqFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:33:14 INFO - Running setup.py (path:/tmp/pip-6DNGcG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:33:15 INFO - Running setup.py (path:/tmp/pip-QjtQWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:33:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:33:15 INFO - Running setup.py install for manifestparser 12:33:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:33:15 INFO - Running setup.py install for mozcrash 12:33:15 INFO - Running setup.py install for mozdebug 12:33:15 INFO - Running setup.py install for mozdevice 12:33:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:33:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:33:15 INFO - Running setup.py install for mozfile 12:33:15 INFO - Running setup.py install for mozhttpd 12:33:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:33:15 INFO - Running setup.py install for mozinfo 12:33:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:33:15 INFO - Running setup.py install for mozInstall 12:33:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:33:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:33:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:33:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:33:15 INFO - Running setup.py install for mozleak 12:33:16 INFO - Running setup.py install for mozlog 12:33:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:33:16 INFO - Running setup.py install for moznetwork 12:33:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:33:16 INFO - Running setup.py install for mozprocess 12:33:16 INFO - Running setup.py install for mozprofile 12:33:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:33:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:33:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:33:16 INFO - Running setup.py install for mozrunner 12:33:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:33:16 INFO - Running setup.py install for mozscreenshot 12:33:16 INFO - Running setup.py install for moztest 12:33:16 INFO - Running setup.py install for mozversion 12:33:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:33:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:33:16 INFO - Cleaning up... 12:33:16 INFO - Return code: 0 12:33:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:33:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:33:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:33:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:33:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:33:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:33:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:33:16 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 0x7fd9c60a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bde5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6d410>, '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 0x1c6e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c6e7a0>, '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': '41bf3e9aed84707956354da8000001c5-1461176189.671725-1788962282', '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 12:33:16 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 12:33:16 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 12:33:16 INFO - Using env: {'DISPLAY': ':0', 12:33:16 INFO - 'HOME': '/home/cltbld', 12:33:16 INFO - 'LANG': 'en_US.UTF-8', 12:33:16 INFO - 'LANGUAGE': 'en_US:en', 12:33:16 INFO - 'LOGNAME': 'cltbld', 12:33:16 INFO - 'MAIL': '/var/mail/cltbld', 12:33:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:33:16 INFO - 'MOZ_NO_REMOTE': '1', 12:33:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:33:16 INFO - 'NO_EM_RESTART': '1', 12:33:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:33:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:33:16 INFO - 'PWD': '/builds/slave/test', 12:33:16 INFO - 'SHELL': '/bin/bash', 12:33:16 INFO - 'SHLVL': '1', 12:33:16 INFO - 'TERM': 'linux', 12:33:16 INFO - 'TMOUT': '86400', 12:33:16 INFO - 'USER': 'cltbld', 12:33:16 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461176189.671725-1788962282', 12:33:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:33:16 INFO - '_': '/tools/buildbot/bin/python'} 12:33:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:33:17 INFO - Running setup.py (path:/tmp/pip-VF0c27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:33:17 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)) 12:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:33:17 INFO - Running setup.py (path:/tmp/pip-OOPy2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:33:17 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)) 12:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:33:17 INFO - Running setup.py (path:/tmp/pip-NbtEvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:33:17 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)) 12:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:33:17 INFO - Running setup.py (path:/tmp/pip-2izh52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:33:17 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)) 12:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:33:17 INFO - Running setup.py (path:/tmp/pip-QO3WP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:33:17 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)) 12:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:33:17 INFO - Running setup.py (path:/tmp/pip-ulAq8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:33:17 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)) 12:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:33:17 INFO - Running setup.py (path:/tmp/pip-dhPwJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:33:17 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)) 12:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:33:17 INFO - Running setup.py (path:/tmp/pip-mgcIAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:33:17 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)) 12:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:33:17 INFO - Running setup.py (path:/tmp/pip-QK8eYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:33:17 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)) 12:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:33:17 INFO - Running setup.py (path:/tmp/pip-LoCN4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:33:17 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)) 12:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:33:17 INFO - Running setup.py (path:/tmp/pip-oVRLiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:33:17 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)) 12:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:33:17 INFO - Running setup.py (path:/tmp/pip-_xaAB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:33:18 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)) 12:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:33:18 INFO - Running setup.py (path:/tmp/pip-J4owJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:33:18 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)) 12:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:33:18 INFO - Running setup.py (path:/tmp/pip-U56hxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:33:18 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)) 12:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:33:18 INFO - Running setup.py (path:/tmp/pip-akxhau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:33:18 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)) 12:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:33:18 INFO - Running setup.py (path:/tmp/pip-Ngiwlj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:33:18 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)) 12:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:33:18 INFO - Running setup.py (path:/tmp/pip-ei4Yor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:33:18 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)) 12:33:18 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)) 12:33:18 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)) 12:33:18 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)) 12:33:18 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)) 12:33:18 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)) 12:33:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:33:18 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 12:33:18 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 12:33:18 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 12:33:18 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 12:33:18 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 12:33:18 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 12:33:20 INFO - Downloading blessings-1.6.tar.gz 12:33:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:33:20 INFO - Installing collected packages: blessings 12:33:20 INFO - Running setup.py install for blessings 12:33:20 INFO - Successfully installed blessings 12:33:20 INFO - Cleaning up... 12:33:20 INFO - Return code: 0 12:33:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:33:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:33:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:33:20 INFO - Reading from file tmpfile_stdout 12:33:20 INFO - Current package versions: 12:33:20 INFO - argparse == 1.2.1 12:33:20 INFO - blessings == 1.6 12:33:20 INFO - blobuploader == 1.2.4 12:33:20 INFO - docopt == 0.6.1 12:33:20 INFO - manifestparser == 1.1 12:33:20 INFO - mozInstall == 1.12 12:33:20 INFO - mozcrash == 0.17 12:33:20 INFO - mozdebug == 0.1 12:33:20 INFO - mozdevice == 0.48 12:33:20 INFO - mozfile == 1.2 12:33:20 INFO - mozhttpd == 0.7 12:33:20 INFO - mozinfo == 0.9 12:33:20 INFO - mozleak == 0.1 12:33:20 INFO - mozlog == 3.1 12:33:20 INFO - moznetwork == 0.27 12:33:20 INFO - mozprocess == 0.22 12:33:20 INFO - mozprofile == 0.28 12:33:20 INFO - mozrunner == 6.11 12:33:20 INFO - mozscreenshot == 0.1 12:33:20 INFO - mozsystemmonitor == 0.0 12:33:20 INFO - moztest == 0.7 12:33:20 INFO - mozversion == 1.4 12:33:20 INFO - psutil == 3.1.1 12:33:20 INFO - requests == 1.2.3 12:33:20 INFO - wsgiref == 0.1.2 12:33:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:33: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')]} 12:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:33:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:33: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')]} 12:33:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:33:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:33:20 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 0x7fd9c60a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bde5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6d410>, '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 0x1c6e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c6e7a0>, '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': '41bf3e9aed84707956354da8000001c5-1461176189.671725-1788962282', '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 12:33:20 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 12:33:20 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 12:33:20 INFO - Using env: {'DISPLAY': ':0', 12:33:20 INFO - 'HOME': '/home/cltbld', 12:33:20 INFO - 'LANG': 'en_US.UTF-8', 12:33:20 INFO - 'LANGUAGE': 'en_US:en', 12:33:20 INFO - 'LOGNAME': 'cltbld', 12:33:20 INFO - 'MAIL': '/var/mail/cltbld', 12:33:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:33:20 INFO - 'MOZ_NO_REMOTE': '1', 12:33:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:33:20 INFO - 'NO_EM_RESTART': '1', 12:33:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:33:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:33:20 INFO - 'PWD': '/builds/slave/test', 12:33:20 INFO - 'SHELL': '/bin/bash', 12:33:20 INFO - 'SHLVL': '1', 12:33:20 INFO - 'TERM': 'linux', 12:33:20 INFO - 'TMOUT': '86400', 12:33:20 INFO - 'USER': 'cltbld', 12:33:20 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461176189.671725-1788962282', 12:33:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:33:20 INFO - '_': '/tools/buildbot/bin/python'} 12:33:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:33:20 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)) 12:33:20 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)) 12:33:20 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)) 12:33:20 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)) 12:33:20 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)) 12:33:20 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)) 12:33:20 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)) 12:33:20 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)) 12:33:20 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)) 12:33:20 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)) 12:33:20 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)) 12:33:20 INFO - Cleaning up... 12:33:20 INFO - Return code: 0 12:33:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:33: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')]} 12:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:33:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:33: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')]} 12:33:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:33:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:33:20 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 0x7fd9c60a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bde5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6d410>, '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 0x1c6e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c6e7a0>, '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': '41bf3e9aed84707956354da8000001c5-1461176189.671725-1788962282', '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 12:33:20 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 12:33:20 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 12:33:20 INFO - Using env: {'DISPLAY': ':0', 12:33:20 INFO - 'HOME': '/home/cltbld', 12:33:20 INFO - 'LANG': 'en_US.UTF-8', 12:33:20 INFO - 'LANGUAGE': 'en_US:en', 12:33:20 INFO - 'LOGNAME': 'cltbld', 12:33:20 INFO - 'MAIL': '/var/mail/cltbld', 12:33:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:33:20 INFO - 'MOZ_NO_REMOTE': '1', 12:33:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:33:20 INFO - 'NO_EM_RESTART': '1', 12:33:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:33:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:33:20 INFO - 'PWD': '/builds/slave/test', 12:33:20 INFO - 'SHELL': '/bin/bash', 12:33:20 INFO - 'SHLVL': '1', 12:33:20 INFO - 'TERM': 'linux', 12:33:20 INFO - 'TMOUT': '86400', 12:33:20 INFO - 'USER': 'cltbld', 12:33:20 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461176189.671725-1788962282', 12:33:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:33:20 INFO - '_': '/tools/buildbot/bin/python'} 12:33:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:33:21 INFO - Downloading/unpacking jsonschema 12:33:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:33:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:33:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:33:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:33:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:33:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:33:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:33:23 INFO - Downloading/unpacking functools32 (from jsonschema) 12:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:33:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:33:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:33:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:33:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:33:23 INFO - Downloading functools32-3.2.3-2.tar.gz 12:33:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:33:23 INFO - warning: no files found matching '*.txt' 12:33:23 INFO - no previously-included directories found matching 'build' 12:33:23 INFO - no previously-included directories found matching 'dist' 12:33:23 INFO - no previously-included directories found matching '.git*' 12:33:23 INFO - Installing collected packages: jsonschema, functools32 12:33:23 INFO - Running setup.py install for functools32 12:33:23 INFO - warning: no files found matching '*.txt' 12:33:23 INFO - no previously-included directories found matching 'build' 12:33:23 INFO - no previously-included directories found matching 'dist' 12:33:23 INFO - no previously-included directories found matching '.git*' 12:33:23 INFO - Successfully installed jsonschema functools32 12:33:23 INFO - Cleaning up... 12:33:23 INFO - Return code: 0 12:33:23 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:33:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:33:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:33:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:33:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:33:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:33:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9c60a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bde5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6d410>, '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 0x1c6e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c6e7a0>, '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': '41bf3e9aed84707956354da8000001c5-1461176189.671725-1788962282', '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 12:33:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 12:33:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 12:33:23 INFO - Using env: {'DISPLAY': ':0', 12:33:23 INFO - 'HOME': '/home/cltbld', 12:33:23 INFO - 'LANG': 'en_US.UTF-8', 12:33:23 INFO - 'LANGUAGE': 'en_US:en', 12:33:23 INFO - 'LOGNAME': 'cltbld', 12:33:23 INFO - 'MAIL': '/var/mail/cltbld', 12:33:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:33:23 INFO - 'MOZ_NO_REMOTE': '1', 12:33:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:33:23 INFO - 'NO_EM_RESTART': '1', 12:33:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:33:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:33:23 INFO - 'PWD': '/builds/slave/test', 12:33:23 INFO - 'SHELL': '/bin/bash', 12:33:23 INFO - 'SHLVL': '1', 12:33:23 INFO - 'TERM': 'linux', 12:33:23 INFO - 'TMOUT': '86400', 12:33:23 INFO - 'USER': 'cltbld', 12:33:23 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461176189.671725-1788962282', 12:33:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:33:23 INFO - '_': '/tools/buildbot/bin/python'} 12:33:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:33:23 INFO - Downloading/unpacking flake8 12:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:33:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:33:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:33:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:33:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:33:25 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:33:25 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:33:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:33:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:33:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:33:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:33:25 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:33:25 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:33:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:33:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:33:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:33:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:33:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:33:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:33:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:33:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:33:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:33:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:33:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:33:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:33:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:33:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:33:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:33:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:33:26 INFO - no previously-included directories found matching 'docs/_build' 12:33:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:33:26 INFO - Running setup.py install for pep8 12:33:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:33:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:33:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:33:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:33:26 INFO - no previously-included directories found matching 'docs/_build' 12:33:26 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:33:26 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:33:26 INFO - Cleaning up... 12:33:26 INFO - Return code: 0 12:33:26 INFO - Running post-action listener: _resource_record_post_action 12:33:26 INFO - Running post-action listener: _start_resource_monitoring 12:33:26 INFO - Starting resource monitoring. 12:33:26 INFO - ##### 12:33:26 INFO - ##### Running install step. 12:33:26 INFO - ##### 12:33:26 INFO - Running pre-action listener: _resource_record_pre_action 12:33:26 INFO - Running main action method: install 12:33:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:33:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:33:26 INFO - Reading from file tmpfile_stdout 12:33:26 INFO - Detecting whether we're running mozinstall >=1.0... 12:33:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:33:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:33:26 INFO - Reading from file tmpfile_stdout 12:33:26 INFO - Output received: 12:33:26 INFO - Usage: mozinstall [options] installer 12:33:26 INFO - Options: 12:33:26 INFO - -h, --help show this help message and exit 12:33:26 INFO - -d DEST, --destination=DEST 12:33:26 INFO - Directory to install application into. [default: 12:33:26 INFO - "/builds/slave/test"] 12:33:26 INFO - --app=APP Application being installed. [default: firefox] 12:33:26 INFO - mkdir: /builds/slave/test/build/application 12:33:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:33:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:33:42 INFO - Reading from file tmpfile_stdout 12:33:42 INFO - Output received: 12:33:42 INFO - /builds/slave/test/build/application/firefox/firefox 12:33:42 INFO - Running post-action listener: _resource_record_post_action 12:33:42 INFO - ##### 12:33:42 INFO - ##### Running run-tests step. 12:33:42 INFO - ##### 12:33:42 INFO - Running pre-action listener: _resource_record_pre_action 12:33:42 INFO - Running main action method: run_tests 12:33:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:33:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:33:42 INFO - Python 2.7.3 12:33:42 INFO - Return code: 0 12:33:42 INFO - grabbing minidump binary from tooltool 12:33: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')]} 12:33:42 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 0x1c6d410>, '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 0x1c6e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c6e7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:33:42 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 12:33:42 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 12:33:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:33:42 INFO - Return code: 0 12:33:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:33:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:33:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:33:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:33:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:33:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:33:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:33:43 INFO - Return code: 0 12:33:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eSEazso5QVCwLOTfWrAySg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 12:33:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eSEazso5QVCwLOTfWrAySg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 12:33:43 INFO - Using env: {'DISPLAY': ':0', 12:33:43 INFO - 'HOME': '/home/cltbld', 12:33:43 INFO - 'LANG': 'en_US.UTF-8', 12:33:43 INFO - 'LANGUAGE': 'en_US:en', 12:33:43 INFO - 'LOGNAME': 'cltbld', 12:33:43 INFO - 'MAIL': '/var/mail/cltbld', 12:33:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:33:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:33:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:33:43 INFO - 'MOZ_NO_REMOTE': '1', 12:33:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:33:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:33:43 INFO - 'NO_EM_RESTART': '1', 12:33:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:33:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:33:43 INFO - 'PWD': '/builds/slave/test', 12:33:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:33:43 INFO - 'SHELL': '/bin/bash', 12:33:43 INFO - 'SHLVL': '1', 12:33:43 INFO - 'TERM': 'linux', 12:33:43 INFO - 'TMOUT': '86400', 12:33:43 INFO - 'USER': 'cltbld', 12:33:43 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461176189.671725-1788962282', 12:33:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:33:43 INFO - '_': '/tools/buildbot/bin/python'} 12:33:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eSEazso5QVCwLOTfWrAySg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 12:33:43 INFO - mozversion application_buildid: 20160420110249 12:33:43 INFO - mozversion application_changeset: 30c5dbcee7ddeafcaffa50e01429c45d459bb8fc 12:33:43 INFO - mozversion application_display_name: Nightly 12:33:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:33:43 INFO - mozversion application_name: Firefox 12:33:43 INFO - mozversion application_remotingname: firefox 12:33:43 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:33:43 INFO - mozversion application_vendor: Mozilla 12:33:43 INFO - mozversion application_version: 48.0a1 12:33:43 INFO - mozversion platform_buildid: 20160420110249 12:33:43 INFO - mozversion platform_changeset: 30c5dbcee7ddeafcaffa50e01429c45d459bb8fc 12:33:43 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:33:43 INFO - mozversion platform_version: 48.0a1 12:33:43 INFO - using testdate: 1461180823 12:33:43 INFO - actual date: 1461180823 12:33:43 INFO - starting webserver on 'localhost:45243' 12:33:43 INFO - SUITE-START | Running 2 tests 12:33:43 INFO - TEST-START | dromaeo_css 12:33:43 INFO - operating with platform_type : linux_ 12:33:43 INFO - Initialising browser for dromaeo_css test... 12:33:43 INFO - TEST-INFO | started process 5458 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7mojmC/profile http://localhost:45243/getInfo.html) 12:33:47 INFO - PROCESS | 5458 | 12:33:47 INFO - PROCESS | 5458 | (process:5525): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:33:48 INFO - PROCESS | 5458 | __metrics Screen width/height:1600/1200 12:33:48 INFO - PROCESS | 5458 | colorDepth:24 12:33:48 INFO - PROCESS | 5458 | Browser inner width/height: 1024/697 12:33:48 INFO - PROCESS | 5458 | __metrics 12:33:49 ERROR - PROCESS | 5458 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 12:33:50 INFO - TEST-INFO | 5458: exit 0 12:33:50 INFO - Browser initialized. 12:33:50 INFO - Running cycle 1/1 for dromaeo_css test... 12:33:50 INFO - TEST-INFO | started process 5576 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7mojmC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:33:52 INFO - PROCESS | 5576 | 12:33:52 INFO - PROCESS | 5576 | (process:5636): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:34:02 INFO - PROCESS | 5576 | RSS: Main: 164683776 12:34:02 INFO - PROCESS | 5576 | 12:34:51 INFO - PROCESS | 5576 | 1461180891733 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] 12:37:03 INFO - PROCESS | 5576 | Cycle 1(1): loaded http://localhost:45243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45243/tests/dromaeo/cssquery-ext.html) 12:37:04 INFO - PROCESS | 5576 | RSS: Main: 169656320 12:37:04 INFO - PROCESS | 5576 | 12:40:06 INFO - PROCESS | 5576 | Cycle 1(1): loaded http://localhost:45243/tests/dromaeo/cssquery-ext.html (next: http://localhost:45243/tests/dromaeo/cssquery-jquery.html) 12:40:07 INFO - PROCESS | 5576 | RSS: Main: 165916672 12:40:07 INFO - PROCESS | 5576 | 12:43:08 INFO - PROCESS | 5576 | Cycle 1(1): loaded http://localhost:45243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45243/tests/dromaeo/cssquery-mootools.html) 12:43:09 INFO - PROCESS | 5576 | RSS: Main: 166846464 12:43:09 INFO - PROCESS | 5576 | 12:46:11 INFO - PROCESS | 5576 | Cycle 1(1): loaded http://localhost:45243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45243/tests/dromaeo/cssquery-prototype.html) 12:46:11 INFO - PROCESS | 5576 | RSS: Main: 164564992 12:46:11 INFO - PROCESS | 5576 | 12:49:14 INFO - PROCESS | 5576 | Cycle 1(1): loaded http://localhost:45243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45243/tests/dromaeo/cssquery-yui.html) 12:49:15 INFO - PROCESS | 5576 | RSS: Main: 166084608 12:49:15 INFO - PROCESS | 5576 | 12:52:17 INFO - PROCESS | 5576 | Cycle 1(1): loaded http://localhost:45243/tests/dromaeo/cssquery-yui.html (next: http://localhost:45243/tests/dromaeo/cssquery-dojo.html) 12:52:18 INFO - PROCESS | 5576 | RSS: Main: 167776256 12:52:18 INFO - PROCESS | 5576 | 12:52:18 INFO - PROCESS | 5576 | __start_tp_report 12:52:18 INFO - PROCESS | 5576 | _x_x_mozilla_page_load 12:52:18 INFO - PROCESS | 5576 | _x_x_mozilla_page_load_details 12:52:18 INFO - PROCESS | 5576 | |i|pagename|runs| 12:52:18 INFO - PROCESS | 5576 | |0;dojo.html;2567.3838278813087;2647.510210611037;2666.853323067231;2686.3418462476698;2698.352395425096;4709.9058018839605;4735.218688916329;4742.549457801512;4760.547747963938;4818.927716084258;4600.332951722006;4665.930011049837;4743.905121897568;4744.335792988984;4811.927821082687;4298.14037192562;4386.912261754779;4390.582894625006;4391.890202744941;4413.44831896013;562.0783341163783;4160.521540022906;4304.870853874389;4347.804348804296;4367.672424568154;4327.935080973788;4335.6965012449145;4344.500382456026;4378.387025816404;4385;4340.197063543223;4340.348947657845;4342.478902531717;4347.478302603708;4362.389265502832;4234.534201237861;4302.397664326997;4305.311150215982;4325.52419233884;4337.457817772778;4584.381108550337;4625.606823420013;4631.675782695213;4632.2125238709505;4655.86032419028;4880.438749543812;4987.351644286219;5019.4227663818765;5019.698818070891;5044.2937988681615;5138.948610513884;5146.150885103953;5151.278820965068;5154.664946778447;5198.324217851693;4722.1028004679;4786.0906427778955;4792.137415265286;4802.375691160127;4834.492378300263;5067.695938243717;5114.795408183705;5202.687838729688;5223.059849227176;5328.760205790749;4999.0501804657;5014.172661510883;5020.1214787412055;5027.572656324253;5037.3955125384455;5044.697318160922;5107.8507335849135;5113.258577506241;5124.897502049938;5139.640225184201;4799.784009719571;4901.264810278415;4998.600111991032;5012.04771093491;5051.318072060299;4925.876853078702;4938.876528086755;4941.925871111936;4956.132676781621;5014.398272207285;4172.874813755592;4174.7077704561;4175.603317684815;4185.162967406531;4208.8316467340965;3594.370985077601;3629.9637003630155;3646.7629604076183;3733.607971163043;3733.9439908401396;4406.889827754332;4426;4464.3973063635995;4471.932921006188;4496.213162696515;4956.603471722326;4965.453800081988;4987.251912213197;4999.325091112726;5051.898962020812;4260.360945858084;4341.15347507233;4373.934390984138;4402.537733537996;4407.977960110243;4436.600705936481;4438.5561443856;4448.466184057934;4451.9554804451545;4494.910101797946;4714.717116972993;4768.094062128184;4785.473597904158;4793.0413917216;4819.542143496362;4917.975410122926;5058.772355243949;5067.265246539305;5150.922736159036;5158.406783219978;4767.523247675344;4776.522347765195;4785.066911952136;4796.795476907455;4835.492273311393;4786.042791441656;4918.385201849769;4946.678465899705;4964.3298154748645;5012.122878496321;5039.3448851649055;5068.29043933857;5087.949120508748;5138.306328645585;5147.073526765069;4924.556789888928;4924.63065270099;4926.211806111005;4934.457209706858;4977.0792403405485;4701.1537923174155;4824.421069471686;4924.433690125681;4930.753462326941;4967.950320496749;4771.95228047729;4791.880202994953;4815.205491094071;4826.565609095198;4857.247126695368;4859.246816743411;4894.902101958012;4901.803927842846;4903;4959.330490383752;4694;4794.544518270759;4822.397200349957;4838.274258861199;4864.148773964613 12:52:18 INFO - PROCESS | 5576 | |1;ext.html;561.2842341385324;579.6029719642045;605.1497645807639;618.3074956049226;648.9837754056151;34041.99999999997;35102.59589616419;35338.469922951175;35349.646503534954;35368;36999.445008324896;37784.811075944584;37787.433188502124;37847.24305513895;38143.427848582294;7648.349890259321;7830.686772529092;7840.568768717718;7848.4113691473085;7867.095284042322;7721.150673425918;7766.262205090507;7787.493812902143;7793.766187014398;7869.842603147934;7830.216978302181;7892.131865494791;7905.723299684512;7909.446338756289;7924.564148971805;7779.688812447524;7823.061232652061;7857.489263197931;7860.567668778186;7872.173421790715;7707.499012564222;7795;7800.960995194988;7802.258785415376;7836.451448398614;29991.850040749876;35713;36052.459213111826;36166.819165904264;36305;3154.558361829346;3239.805611663308;3245.6267529234206;3780.3951367781297;3830.9616903830884;26625.866870665715;26738.86630566854;27005.324866878287;27950.16149515518;27981.160565183076;2965.024989226632;2980.6423229212414;2998.475266828318;3010.2173434906863;3088.027271409499;179371;179864;180001;180517.9999999987;180713;33068.83465582657;33224.66775332264;33256.667433325354;35447.29105417877;36249.00630465297;33496;33549.83225083908;33667;33879;33939.66060339365;13370.732585348238;13572.864271357357;13581.660458488617;13582.388792504362;13597.252151131783;11399.943000284946;11520.13598980063;11555;11559.884401156049;11589.76820463586;8163.510189388656;8256.25693687571;8266.421350505527;8317.667293308321;8332.416730828905;3220.2915358621067;3230.5800245967876;3255.853486593109;3279.1146390474437;3279.770416070852;840.2060053249743;865.8354912566592;922.4280945813505;944.2964991081689;967.4292167621137;28155;29295.707042929298;29441.411171776446;29514;29798.55302170469;953.3421938862163;981.916537094355;995.3977843404781;997.4514017290461;1020.0207800511592;14871.851281487263;15495.922520387327;15694.450694225647;15845.52463426099;15848;357980;363217;364793;365333;365638;51342.48657513452;51565;51875;52281.47718522766;52584.47415525872;1215.398377802993;1248.8314077599407;1250.5998080614297;1252.204849920289;1259.0745801835644;26185.250548692875;27399.589006164526;27806;27904;28131.296717581405;44269.335959961274;44801.32798007967;44903.32645010393;45657;45720.54279457296;315656;316698;317556;318373;318958;26201.082962096236;26513.86743066272;26519.33701657474;26712.732872671026;41403.58596413997;40466.59533404746;41351.58648413477;41632.791836040626;41910.79044604758;41962.79018604887;34697.826510867286;35121.64878351184;35299.29401411906;35805.283894322485;36348.45477317895;34332.485012724326;34538;34969.82515087408;35017.474737878445;35276.823615882786;32148.35703285968;32884.50673239856;33097.338053238316;33194.66805331916;35730.64269357273;27998.580021300106;29599.85200073986;30300.090997270116;30342;30418;21508;21784.564308714052;22450.214242502087;22877.77122228823;23037.424064398525 12:52:18 INFO - PROCESS | 5576 | |2;jquery.html;375.3824957944181;378.94694742736016;385.9440381144736;387.75377635201636;397.3840547151914;15742.29159687814;16000.119993400358;17042.403515876947;17058.061806600632;17081.48755537336;10444.321119127251;11272.32366058037;11356.48895799689;11379.829302560469;11381.943090284558;4658.208104622214;4820.25286080658;4937.629677774164;5294.311739473863;5295.602829787781;5180.740962951856;5222.477752224766;5224.8693782655355;5228.137357336035;5249.947500524984;5481.945180548183;5503.697296648683;5505.366882808488;5520.806771762989;5541.33503979523;5290.920636190422;5451.781928722866;5492.642978206404;5493.505584497394;5603.579731520153;5381;5399.325084364455;5437.34751829783;5445.618806683534;5449.482299181572;12284;12415.813762793565;18143;18365.7245141323;18520.3517876875;1888.499547619868;1934.3616606519815;1944.562473443464;1963.8232559069752;2023.281734984074;8983.191512763882;9187.989321174666;9471.810563788686;12055.457504412323;12824.294663793487;1735.1237624999421;1735.3318972195668;1752.4830175098377;1806.638672265539;1826.3151318255655;65106.67446662784;66521;67539.66230168818;67842.66078669624;68071.65964170148;9780.31537792362;9863.210943124534;10285.640002599874;10331.896681033244;10361.74095647615;14351.49309322527;14353.354099065567;14370.856291437161;14414.927925360516;14434;7363.7422690205585;7416;7475.215102414277;7561.9243807562325;7623.809404764815;6902.792916212522;7108.92891071093;7136.250693677193;7182.96408517954;7270.8182295441975;4351.238533256731;4400.823967041282;4461.866144015685;4518.548145185521;4535.886602834956;1817.3275887921288;1875.7842848072373;1892.4038927737718;1925.4801203675208;1933.2846846666823;398.7567583773896;405.3190639725231;431.7603729929919;781.4959351218432;943.7542443974025;10468.424236667057;10701.785964280827;10719.78560428787;10862;10910.054285343072;423.7626928919815;429.46317103620476;433.2137171034562;437.3963929776888;438.58772753611504;5637.577181711388;5733.799317023884;5753.568482363839;5842.152887831326;5879.735411906475;405523;406928;408856;413566;414672;78244.60877695575;78685;79777.60111199523;80283.19716802874;80870;445.100896189695;883.5228976352697;930.1396208506968;932.1517419148543;945.5555888732284;15366.385344586091;15507.689846203239;15529.68940621204;15623.515766002212;15844.683106337578;33243.66756332406;34166.31667366589;35266.471002934464;35412.64587354093;35707.10732231611;47678.28482572695;47991;48289;48313;48397.5160248393;7719.691212351443;7801.882971755314;7858.960705196666;7985.480943738638;8070.394720395876;8700.477971321741;11157.21899467062;11767.882321177021;11838.408079596158;11883.346415947206;10287.279890407599;10312.742181445525;10317.226208034277;10419.42693151884;10551.208659350426;9888.950555247466;10294.794104118026;10432.582696692047;10453.790924181625;10828.5127169276;10093.495325233856;10094.899051009395;10362.01560851748;10443.164546836388;10509.159267258448;6751;7195.352418282379;7423.109226892808;7859.410544209321;8025;9820.803583928424;9869.11177993984;10009.099181073738;10032.64885728996;10059.094681478702 12:52:18 INFO - PROCESS | 5576 | |3;mootools.html;1410.9223992680402;1444.8482909294523;1573.5279416175144;1745.1187150489002;1758.0770095699763;6656.733730650768;7601.657925393357;7690.5770182639935;7866.370690344773;7888.684452621896;7692.307692307705;7695.807604809868;7758.224177582239;7766.262205090507;7766.728164514243;2217.6895234667118;2230.4200907764016;2245.8203343732544;2248.2693124734446;2251.122062395667;2178.2920550821045;2217.1796435318956;2219.533897881447;2227.2204728345114;2230.8326875484404;2215.7894999975056;2242.529068895534;2244.842860999731;2253.5154941687533;2263.8868056597103;2161;2168.4687251623295;2169.0673010605433;2177.074743234119;2178.215842296772;2172.174573662014;2185.0385830234645;2196.5826492966285;2197.2858820883116;2198.1537108213292;7804.453688241825;7895.526268423913;7929.207079292082;7932.524048557105;7938.087119981161;4524.8416305429155;4714.363560919301;4716;4747;4758.214894542396;2830.3631682871396;2902.956455653167;2924.546695262238;2930.0184438213223;2957.452871218831;885.7918389178537;903.4172958441768;907.9273658107336;919.4942781470164;919.6735159018519;9963.90036099637;10270.9486452568;10298.845517317246;10371.792564148675;10445.529951152217;4074.246264441088;4114.6091121343425;4211.578842115764;4261.424707664426;4277.657787377002;8480.236778689825;8506.404551681446;8536.74389768308;8543.273821725099;8550.871736923951;4646.745378747787;4649.163150632919;4652.837150699777;4655.255159174516;4668.789904454307;3775.4903088083306;4111.1366613011005;4211.642010429148;4345.261305578059;4354.412154359121;3467.514547963287;3498.8775392861126;3552.4138517144384;3586.7130629549574;3631.219287853124;1058.6241884131177;1091.5906535049357;1099.5107177306181;1105.3423213188141;1117.201201141188;821.6466919224671;836.5273620404452;836.6862426590029;841.0538144587339;865.8181781825887;5347.518723314843;5432.538234250133;5467.043267428184;5593.8321850344555;5603.803866864721;888.6223355074068;898.4205187653927;901.7520181950016;914.835329640671;918.5315489100607;3673.3204357194004;3682.1531047859144;3744.700423966076;3803.6576708096404;3827.2154208387215;9377.156055954996;9731.805363892683;9816.901830981742;9831.410115393099;9833.115019648267;9630.4703241321;9643.855342169873;9699.418034917928;9704.078112579293;9715.902840971641;7122.964385178041;7132.857342853114;7308.04995350601;7313.378362839112;7316.9634151828905;5354.4110147884485;5364.249005139206;5372.140457526777;5572.4148964358155;5588.6646801192055;8526.78683032929;8659.870101948602;8703.738887833375;8772.342074344577;8794.120587941155;8571.914280857112;8689;8702.782430439289;9150.63397464094;9222.123898229658;5987.13186587951;6664;6781.593104413751;6950.06174166481;6971.65141742921;7453.776386708408;7497.662605182671;7531.171571127062;7558.281963213486;7570.015897933234;6581.308962559054;6771.52599318043;6822.317768223138;6882.518223724292;6901.792946211622;6682.866342673216;6739.6967136478;6938.895916561155;6943.062686537252;6944.340287672663;6271.090691849748;6282.465990390868;6361.936380636134;6382.106505089198;6474.1907261592305;4498.21281275782;4520.141173177086;4619;4672.883177920579;4764.237721964469;4683.414573178353;4701.647376446848;4770.141374552614;4800.06398752254;4820.108279968217 12:52:18 INFO - PROCESS | 5576 | |4;prototype.html;302.2187644937834;303.4295524414101;310.821277765285;313.47962382445144;322.6563709649222;5132.743362831862;5256.132738098218;5264.789408423663;5384.757685904134;5390.973045134779;5279.63042587019;5310.415854256029;5325.946740532603;5326.6537675051095;5327.413984461706;4121.505419349667;4160.521540022891;4174.770387628671;4175.081482073939;4175.914262291811;3860.2665493556133;4111.794410279489;4158.168366326747;4172.457580514529;4174.457320548325;4035.8183881725245;4048.615381538764;4064.1668457966193;4069.5959893836725;4078.449409329747;4031.475908131939;4049.2508885856064;4057.756534607933;4062.4109504122034;4076.898077548085;3567.1973805893726;3574.1422058705725;3576.177479179777;3582.17609949713;3587.6232995535356;4863;5071.290019397287;5097.5667068299235;5104.642675012714;5110.872228194287;4685.062987402499;4692;4700.811967521295;4704.670673052888;4725.66920315578;5580.386157522669;5583.441655834425;5627.437256274381;5656.208130861683;5672.092465205547;3797.677197438221;3930.862419815293;3932.134930315326;3935.8032098394965;3943.1719338938856;5810.1865738796605;5835.270591176103;5870.236869207019;5887.440693134188;5940.2871655401195;4013.1171142348635;4016.594192032765;4020.0753826619457;4026.657734092635;4036.29364861154;3955.7626542407547;4067.2882245607493;4068.7558746475306;4081.3673880548563;4086.611771881726;4603.309503574491;4644.842865635305;4651.976740116278;4675.181843177498;4683.250679891269;5309.362876454773;5524.1989911462615;5605.971970140124;5616.550675945915;5618.701693204702;1382.4677499162894;1413.9293035348192;1415.9646008849654;1416.3060100550863;1420.7797791342152;934.8223837470858;938.5494962417941;955.4219697083165;955.8231727130503;964.8408012677829;4881.023185609763;4884.7313397762755;4886.486918873538;4888.144574699413;4895.73073480962;5716.685162412585;5717.742701578439;5723.370429252779;5725.8568535786935;5740.512056475246;4713.481517033124;4856.4415092264135;4875.902481950341;4880.365552478226;4885.511448855086;3051.206686261588;3058.5870907427657;3062.724354808078;3067.8466076696077;3084.583581216507;5335.359756829128;5356.116240820221;5364.9731751341;5372.086745253317;5413.296271484682;5722.828315150552;5880.705964701748;6035.185249991283;6040.486558642477;6044.727987240497;5521.868017056574;5533.170024496358;5551;5560.499555040065;5565.666060036411;5701.486866182064;5807.738651760766;5858.070964517741;5862.94137058624;5871.530277577869;5683.090705487102;5687;5691.516221121085;5714.714264286686;5746.770129194785;5408.296921400193;5481.616286860041;5489.368722596792;5492.890142197054;5528.80649177293;3964.365701487748;3995.6403923647013;3999.1801680655976;4035.1324465240114;4047.6761859050616;5527.226188333556;5612.887742245214;5762.855928601818;5828.766849326149;5831.650100993954;5601.271834661468;5613.214150019082;5631.662100273997;5632.633878797865;5632.774689012557;5612.102063669793;5613.971930140323;5619.325680918152;5621.707007388405;5643;5199.168133098686;5538.750756216061;5562.694051827189;5570.164475328733;5574.554035677217;5648.15277708347;5665.895150445788;5693.572982026281;5694.291712486321;5713.143028545752;5303.780130569913;5561.221429000024;5564.55483561306;5568.972155139199;5576.721163941867 12:52:18 INFO - PROCESS | 5576 | |5;yui.html;710.7015053677457;742.6954948471127;744.571871174075;800.5276886636883;801.6032064128258;11664.475098620562;11960.10299227558;12006.939965300184;12054.397280136001;12058.974987126094;11374;11384.487698053586;11502.712432189179;11534.423278836066;12137.514499420013;831.9251267385933;832.6544484039132;841.032812265893;843.9367047471465;844.6748002019206;814.2346194577078;821.0229826506468;821.1419067074921;821.876718492225;825.1707034430389;855.6235256487157;856.5588721808242;857.3012994409568;857.7298151082389;859.9957000215021;852.3564708644996;856.5631527920774;856.6230858422274;857.0486759696731;860.0797147052656;630.9747610095591;631.0313668518802;631.8894193516117;632.0582332324849;632.7658766256468;12072;12113.818292725617;12191.939040304742;12201.694957626041;12261.386930653433;12168.81746773799;12175.878241217652;12319.137660363778;12538.937305313415;12843.486260549567;8764.1674040966;9118.5440727964;9254.07459254076;11025.283356581876;11157.888421115847;3080.9845950770327;3099.1942095055224;3139.6232452105664;3162.5256211568217;3177.698118678722;42030.579694203276;42317.57682423167;42547;42695.57304426947;42738;9579.90420095804;9623.615055397706;9754.902450975542;9785.510724463891;10372.481375931173;16534;16542.338306467605;16605.83394166067;16622.25199866009;16623;6846.110005699326;6924.307569243036;6986.790396288119;7004.4396448284015;7048.612326321999;3947.7631342119566;3951.9604803952166;3989.0426297688346;3990.74060186087;4024.9597504024587;2760.1305588739883;2831.0940499040107;2839.162447078117;2850.50116229659;2859.6711378191358;479.7793015213041;491.6632107006712;500.6970782676501;504.2738456622452;510.77270614576156;565.7821738630657;595.4224402329734;603.0983679399326;623.9407256310734;630.6941133550224;7002.299770023059;7038.788836334918;7126.144862616519;7319.890201646979;7435;567.4722508067537;583.6177303865975;589.1575047681771;590.1207201270076;603.5774957529746;3539;3614;3664.4136938089778;3725.5343082114737;3746.7189960752507;43948.340774888406;45487;51070.23394649083;52568;52612;41912;42845;42847.35728964068;43190.35214471786;43292;33303.50044749331;33381.499277510855;36265.63734362675;36973.63026369702;37539.81230093832;6986.755463558751;7337;7466.141393739789;7487.176410594939;7574.091109066947;26067;26342.20973370802;26574.601380979686;27434.314142145806;27544;33395.83302083474;33632.49551256684;34966.825165874005;35086.64913350834;36616.45075323819;10309.639162629272;10671.46642667848;10673.252872299176;10902.345859248471;10954.56181752721;11162.609308674157;11588.94205528967;11612.419379031184;11648.825267620823;12049;9013;9104.271658267455;9110.817783644157;9417.340786145178;9445.149936505748;11009.779804403706;11137.944310278397;11220;11400;11775.76448471043;9197.448153110834;9435.811283774423;9471.242300615797;9592.808143837225;9639.807203856024;9529.52352382392;9599.520023998912;9866.457344845816;9911.801763964824;10187.134093602126;8240.752777416687;8380;8603.870941935751;8632.78418039554;8656.350773691873 12:52:18 INFO - PROCESS | 5576 | __end_tp_report 12:52:18 INFO - PROCESS | 5576 | __start_cc_report 12:52:18 INFO - PROCESS | 5576 | _x_x_mozilla_cycle_collect,368 12:52:18 INFO - PROCESS | 5576 | __end_cc_report 12:52:18 INFO - PROCESS | 5576 | __startTimestamp1461181938117__endTimestamp 12:52:18 INFO - PROCESS | 5576 | 12:52:18 INFO - PROCESS | 5576 | ------- Summary: start ------- 12:52:18 INFO - PROCESS | 5576 | Number of tests: 6 12:52:18 INFO - PROCESS | 5576 | 12:52:18 INFO - PROCESS | 5576 | [#0] dojo.html Cycles:165 Average:4634.06 Median:4794.54 stddev:587.00 (12.2%) stddev-sans-first:565.97 12:52:18 INFO - PROCESS | 5576 | Values: 2567.4 2647.5 2666.9 2686.3 2698.4 4709.9 4735.2 4742.5 4760.5 4818.9 4600.3 4665.9 4743.9 4744.3 4811.9 4298.1 4386.9 4390.6 4391.9 4413.4 562.1 4160.5 4304.9 4347.8 4367.7 4327.9 4335.7 4344.5 4378.4 4385.0 4340.2 4340.3 4342.5 4347.5 4362.4 4234.5 4302.4 4305.3 4325.5 4337.5 4584.4 4625.6 4631.7 4632.2 4655.9 4880.4 4987.4 5019.4 5019.7 5044.3 5138.9 5146.2 5151.3 5154.7 5198.3 4722.1 4786.1 4792.1 4802.4 4834.5 5067.7 5114.8 5202.7 5223.1 5328.8 4999.1 5014.2 5020.1 5027.6 5037.4 5044.7 5107.9 5113.3 5124.9 5139.6 4799.8 4901.3 4998.6 5012.0 5051.3 4925.9 4938.9 4941.9 4956.1 5014.4 4172.9 4174.7 4175.6 4185.2 4208.8 3594.4 3630.0 3646.8 3733.6 3733.9 4406.9 4426.0 4464.4 4471.9 4496.2 4956.6 4965.5 4987.3 4999.3 5051.9 4260.4 4341.2 4373.9 4402.5 4408.0 4436.6 4438.6 4448.5 4452.0 4494.9 4714.7 4768.1 4785.5 4793.0 4819.5 4918.0 5058.8 5067.3 5150.9 5158.4 4767.5 4776.5 4785.1 4796.8 4835.5 4786.0 4918.4 4946.7 4964.3 5012.1 5039.3 5068.3 5087.9 5138.3 5147.1 4924.6 4924.6 4926.2 4934.5 4977.1 4701.2 4824.4 4924.4 4930.8 4968.0 4772.0 4791.9 4815.2 4826.6 4857.2 4859.2 4894.9 4901.8 4903.0 4959.3 4694.0 4794.5 4822.4 4838.3 4864.1 12:52:18 INFO - PROCESS | 5576 | 12:52:18 INFO - PROCESS | 5576 | [#1] ext.html Cycles:180 Average:42933.92 Median:34993.65 stddev:78523.28 (224.4%) stddev-sans-first:78679.11 12:52:18 INFO - PROCESS | 5576 | Values: 561.3 579.6 605.1 618.3 649.0 34042.0 35102.6 35338.5 35349.6 35368.0 36999.4 37784.8 37787.4 37847.2 38143.4 7648.3 7830.7 7840.6 7848.4 7867.1 7721.2 7766.3 7787.5 7793.8 7869.8 7830.2 7892.1 7905.7 7909.4 7924.6 7779.7 7823.1 7857.5 7860.6 7872.2 7707.5 7795.0 7801.0 7802.3 7836.5 29991.9 35713.0 36052.5 36166.8 36305.0 3154.6 3239.8 3245.6 3780.4 3831.0 26625.9 26738.9 27005.3 27950.2 27981.2 2965.0 2980.6 2998.5 3010.2 3088.0 179371.0 179864.0 180001.0 180518.0 180713.0 33068.8 33224.7 33256.7 35447.3 36249.0 33496.0 33549.8 33667.0 33879.0 33939.7 13370.7 13572.9 13581.7 13582.4 13597.3 11399.9 11520.1 11555.0 11559.9 11589.8 8163.5 8256.3 8266.4 8317.7 8332.4 3220.3 3230.6 3255.9 3279.1 3279.8 840.2 865.8 922.4 944.3 967.4 28155.0 29295.7 29441.4 29514.0 29798.6 953.3 981.9 995.4 997.5 1020.0 14871.9 15495.9 15694.5 15845.5 15848.0 357980.0 363217.0 364793.0 365333.0 365638.0 51342.5 51565.0 51875.0 52281.5 52584.5 1215.4 1248.8 1250.6 1252.2 1259.1 26185.3 27399.6 27806.0 27904.0 28131.3 44269.3 44801.3 44903.3 45657.0 45720.5 315656.0 316698.0 317556.0 318373.0 318958.0 26201.1 26513.9 26519.3 26712.7 41403.6 40466.6 41351.6 41632.8 41910.8 41962.8 34697.8 35121.6 35299.3 35805.3 36348.5 34332.5 34538.0 34969.8 35017.5 35276.8 32148.4 32884.5 33097.3 33194.7 35730.6 27998.6 29599.9 30300.1 30342.0 30418.0 21508.0 21784.6 22450.2 22877.8 23037.4 12:52:18 INFO - PROCESS | 5576 | 12:52:18 INFO - PROCESS | 5576 | [#2] jquery.html Cycles:180 Average:24198.17 Median:432.49 stddev:67627.33 (15636.8%) stddev-sans-first:67793.38 12:52:18 INFO - PROCESS | 5576 | Values: 375.4 378.9 385.9 387.8 397.4 15742.3 16000.1 17042.4 17058.1 17081.5 10444.3 11272.3 11356.5 11379.8 11381.9 4658.2 4820.3 4937.6 5294.3 5295.6 5180.7 5222.5 5224.9 5228.1 5249.9 5481.9 5503.7 5505.4 5520.8 5541.3 5290.9 5451.8 5492.6 5493.5 5603.6 5381.0 5399.3 5437.3 5445.6 5449.5 12284.0 12415.8 18143.0 18365.7 18520.4 1888.5 1934.4 1944.6 1963.8 2023.3 8983.2 9188.0 9471.8 12055.5 12824.3 1735.1 1735.3 1752.5 1806.6 1826.3 65106.7 66521.0 67539.7 67842.7 68071.7 9780.3 9863.2 10285.6 10331.9 10361.7 14351.5 14353.4 14370.9 14414.9 14434.0 7363.7 7416.0 7475.2 7561.9 7623.8 6902.8 7108.9 7136.3 7183.0 7270.8 4351.2 4400.8 4461.9 4518.5 4535.9 1817.3 1875.8 1892.4 1925.5 1933.3 398.8 405.3 431.8 781.5 943.8 10468.4 10701.8 10719.8 10862.0 10910.1 423.8 429.5 433.2 437.4 438.6 5637.6 5733.8 5753.6 5842.2 5879.7 405523.0 406928.0 408856.0 413566.0 414672.0 78244.6 78685.0 79777.6 80283.2 80870.0 445.1 883.5 930.1 932.2 945.6 15366.4 15507.7 15529.7 15623.5 15844.7 33243.7 34166.3 35266.5 35412.6 35707.1 47678.3 47991.0 48289.0 48313.0 48397.5 7719.7 7801.9 7859.0 7985.5 8070.4 8700.5 11157.2 11767.9 11838.4 11883.3 10287.3 10312.7 10317.2 10419.4 10551.2 9889.0 10294.8 10432.6 10453.8 10828.5 10093.5 10094.9 10362.0 10443.2 10509.2 6751.0 7195.4 7423.1 7859.4 8025.0 9820.8 9869.1 10009.1 10032.6 10059.1 12:52:18 INFO - PROCESS | 5576 | 12:52:18 INFO - PROCESS | 5576 | [#3] mootools.html Cycles:180 Average:5137.52 Median:5580.54 stddev:2820.35 (50.5%) stddev-sans-first:2814.36 12:52:18 INFO - PROCESS | 5576 | Values: 1410.9 1444.8 1573.5 1745.1 1758.1 6656.7 7601.7 7690.6 7866.4 7888.7 7692.3 7695.8 7758.2 7766.3 7766.7 2217.7 2230.4 2245.8 2248.3 2251.1 2178.3 2217.2 2219.5 2227.2 2230.8 2215.8 2242.5 2244.8 2253.5 2263.9 2161.0 2168.5 2169.1 2177.1 2178.2 2172.2 2185.0 2196.6 2197.3 2198.2 7804.5 7895.5 7929.2 7932.5 7938.1 4524.8 4714.4 4716.0 4747.0 4758.2 2830.4 2903.0 2924.5 2930.0 2957.5 885.8 903.4 907.9 919.5 919.7 9963.9 10270.9 10298.8 10371.8 10445.5 4074.2 4114.6 4211.6 4261.4 4277.7 8480.2 8506.4 8536.7 8543.3 8550.9 4646.7 4649.2 4652.8 4655.3 4668.8 3775.5 4111.1 4211.6 4345.3 4354.4 3467.5 3498.9 3552.4 3586.7 3631.2 1058.6 1091.6 1099.5 1105.3 1117.2 821.6 836.5 836.7 841.1 865.8 5347.5 5432.5 5467.0 5593.8 5603.8 888.6 898.4 901.8 914.8 918.5 3673.3 3682.2 3744.7 3803.7 3827.2 9377.2 9731.8 9816.9 9831.4 9833.1 9630.5 9643.9 9699.4 9704.1 9715.9 7123.0 7132.9 7308.0 7313.4 7317.0 5354.4 5364.2 5372.1 5572.4 5588.7 8526.8 8659.9 8703.7 8772.3 8794.1 8571.9 8689.0 8702.8 9150.6 9222.1 5987.1 6664.0 6781.6 6950.1 6971.7 7453.8 7497.7 7531.2 7558.3 7570.0 6581.3 6771.5 6822.3 6882.5 6901.8 6682.9 6739.7 6938.9 6943.1 6944.3 6271.1 6282.5 6361.9 6382.1 6474.2 4498.2 4520.1 4619.0 4672.9 4764.2 4683.4 4701.6 4770.1 4800.1 4820.1 12:52:18 INFO - PROCESS | 5576 | 12:52:18 INFO - PROCESS | 5576 | [#4] prototype.html Cycles:180 Average:4629.70 Median:5306.57 stddev:1367.45 (25.8%) stddev-sans-first:1332.16 12:52:18 INFO - PROCESS | 5576 | Values: 302.2 303.4 310.8 313.5 322.7 5132.7 5256.1 5264.8 5384.8 5391.0 5279.6 5310.4 5325.9 5326.7 5327.4 4121.5 4160.5 4174.8 4175.1 4175.9 3860.3 4111.8 4158.2 4172.5 4174.5 4035.8 4048.6 4064.2 4069.6 4078.4 4031.5 4049.3 4057.8 4062.4 4076.9 3567.2 3574.1 3576.2 3582.2 3587.6 4863.0 5071.3 5097.6 5104.6 5110.9 4685.1 4692.0 4700.8 4704.7 4725.7 5580.4 5583.4 5627.4 5656.2 5672.1 3797.7 3930.9 3932.1 3935.8 3943.2 5810.2 5835.3 5870.2 5887.4 5940.3 4013.1 4016.6 4020.1 4026.7 4036.3 3955.8 4067.3 4068.8 4081.4 4086.6 4603.3 4644.8 4652.0 4675.2 4683.3 5309.4 5524.2 5606.0 5616.6 5618.7 1382.5 1413.9 1416.0 1416.3 1420.8 934.8 938.5 955.4 955.8 964.8 4881.0 4884.7 4886.5 4888.1 4895.7 5716.7 5717.7 5723.4 5725.9 5740.5 4713.5 4856.4 4875.9 4880.4 4885.5 3051.2 3058.6 3062.7 3067.8 3084.6 5335.4 5356.1 5365.0 5372.1 5413.3 5722.8 5880.7 6035.2 6040.5 6044.7 5521.9 5533.2 5551.0 5560.5 5565.7 5701.5 5807.7 5858.1 5862.9 5871.5 5683.1 5687.0 5691.5 5714.7 5746.8 5408.3 5481.6 5489.4 5492.9 5528.8 3964.4 3995.6 3999.2 4035.1 4047.7 5527.2 5612.9 5762.9 5828.8 5831.7 5601.3 5613.2 5631.7 5632.6 5632.8 5612.1 5614.0 5619.3 5621.7 5643.0 5199.2 5538.8 5562.7 5570.2 5574.6 5648.2 5665.9 5693.6 5694.3 5713.1 5303.8 5561.2 5564.6 5569.0 5576.7 12:52:18 INFO - PROCESS | 5576 | 12:52:18 INFO - PROCESS | 5576 | [#5] yui.html Cycles:180 Average:11889.73 Median:22983.39 stddev:13097.89 (57.0%) stddev-sans-first:13107.73 12:52:18 INFO - PROCESS | 5576 | Values: 710.7 742.7 744.6 800.5 801.6 11664.5 11960.1 12006.9 12054.4 12059.0 11374.0 11384.5 11502.7 11534.4 12137.5 831.9 832.7 841.0 843.9 844.7 814.2 821.0 821.1 821.9 825.2 855.6 856.6 857.3 857.7 860.0 852.4 856.6 856.6 857.0 860.1 631.0 631.0 631.9 632.1 632.8 12072.0 12113.8 12191.9 12201.7 12261.4 12168.8 12175.9 12319.1 12538.9 12843.5 8764.2 9118.5 9254.1 11025.3 11157.9 3081.0 3099.2 3139.6 3162.5 3177.7 42030.6 42317.6 42547.0 42695.6 42738.0 9579.9 9623.6 9754.9 9785.5 10372.5 16534.0 16542.3 16605.8 16622.3 16623.0 6846.1 6924.3 6986.8 7004.4 7048.6 3947.8 3952.0 3989.0 3990.7 4025.0 2760.1 2831.1 2839.2 2850.5 2859.7 479.8 491.7 500.7 504.3 510.8 565.8 595.4 603.1 623.9 630.7 7002.3 7038.8 7126.1 7319.9 7435.0 567.5 583.6 589.2 590.1 603.6 3539.0 3614.0 3664.4 3725.5 3746.7 43948.3 45487.0 51070.2 52568.0 52612.0 41912.0 42845.0 42847.4 43190.4 43292.0 33303.5 33381.5 36265.6 36973.6 37539.8 6986.8 7337.0 7466.1 7487.2 7574.1 26067.0 26342.2 26574.6 27434.3 27544.0 33395.8 33632.5 34966.8 35086.6 36616.5 10309.6 10671.5 10673.3 10902.3 10954.6 11162.6 11588.9 11612.4 11648.8 12049.0 9013.0 9104.3 9110.8 9417.3 9445.1 11009.8 11137.9 11220.0 11400.0 11775.8 9197.4 9435.8 9471.2 9592.8 9639.8 9529.5 9599.5 9866.5 9911.8 10187.1 8240.8 8380.0 8603.9 8632.8 8656.4 12:52:18 INFO - PROCESS | 5576 | -------- Summary: end -------- 12:52:18 INFO - PROCESS | 5576 | 12:52:18 INFO - TEST-INFO | 5576: exit 0 12:52:18 INFO - TEST-OK | dromaeo_css | took 1114946ms 12:52:18 INFO - TEST-START | kraken 12:52:18 INFO - operating with platform_type : linux_ 12:52:18 INFO - Initialising browser for kraken test... 12:52:18 INFO - TEST-INFO | started process 5809 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8UoCGO/profile http://localhost:45243/getInfo.html) 12:52:22 INFO - PROCESS | 5809 | 12:52:22 INFO - PROCESS | 5809 | (process:5879): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:52:23 INFO - PROCESS | 5809 | __metrics Screen width/height:1600/1200 12:52:23 INFO - PROCESS | 5809 | colorDepth:24 12:52:23 INFO - PROCESS | 5809 | Browser inner width/height: 1024/697 12:52:23 INFO - PROCESS | 5809 | __metrics 12:52:24 ERROR - PROCESS | 5809 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 12:52:24 INFO - TEST-INFO | 5809: exit 0 12:52:24 INFO - Browser initialized. 12:52:24 INFO - Running cycle 1/1 for kraken test... 12:52:24 INFO - TEST-INFO | started process 5930 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8UoCGO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:52:27 INFO - PROCESS | 5930 | 12:52:27 INFO - PROCESS | 5930 | (process:5990): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:52:37 INFO - PROCESS | 5930 | RSS: Main: 165031936 12:52:37 INFO - PROCESS | 5930 | 12:52:39 INFO - PROCESS | 5930 | Cycle 1(1): loaded http://localhost:45243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45243/tests/kraken/driver.html?testName=audio-beat-detection) 12:52:40 INFO - PROCESS | 5930 | RSS: Main: 168534016 12:52:40 INFO - PROCESS | 5930 | 12:52:43 INFO - PROCESS | 5930 | Cycle 1(1): loaded http://localhost:45243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45243/tests/kraken/driver.html?testName=audio-dft) 12:52:44 INFO - PROCESS | 5930 | RSS: Main: 171515904 12:52:44 INFO - PROCESS | 5930 | 12:52:47 INFO - PROCESS | 5930 | Cycle 1(1): loaded http://localhost:45243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45243/tests/kraken/driver.html?testName=audio-fft) 12:52:47 INFO - PROCESS | 5930 | RSS: Main: 164581376 12:52:47 INFO - PROCESS | 5930 | 12:52:49 INFO - PROCESS | 5930 | Cycle 1(1): loaded http://localhost:45243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45243/tests/kraken/driver.html?testName=audio-oscillator) 12:52:50 INFO - PROCESS | 5930 | RSS: Main: 164892672 12:52:50 INFO - PROCESS | 5930 | 12:52:52 INFO - PROCESS | 5930 | Cycle 1(1): loaded http://localhost:45243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:52:53 INFO - PROCESS | 5930 | RSS: Main: 165203968 12:52:53 INFO - PROCESS | 5930 | 12:52:56 INFO - PROCESS | 5930 | Cycle 1(1): loaded http://localhost:45243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45243/tests/kraken/driver.html?testName=imaging-darkroom) 12:52:57 INFO - PROCESS | 5930 | RSS: Main: 165289984 12:52:57 INFO - PROCESS | 5930 | 12:53:00 INFO - PROCESS | 5930 | Cycle 1(1): loaded http://localhost:45243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45243/tests/kraken/driver.html?testName=imaging-desaturate) 12:53:01 INFO - PROCESS | 5930 | RSS: Main: 162992128 12:53:01 INFO - PROCESS | 5930 | 12:53:04 INFO - PROCESS | 5930 | Cycle 1(1): loaded http://localhost:45243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45243/tests/kraken/driver.html?testName=json-parse-financial) 12:53:04 INFO - PROCESS | 5930 | RSS: Main: 163831808 12:53:04 INFO - PROCESS | 5930 | 12:53:06 INFO - PROCESS | 5930 | Cycle 1(1): loaded http://localhost:45243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:53:07 INFO - PROCESS | 5930 | RSS: Main: 164241408 12:53:07 INFO - PROCESS | 5930 | 12:53:09 INFO - PROCESS | 5930 | Cycle 1(1): loaded http://localhost:45243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45243/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:53:09 INFO - PROCESS | 5930 | RSS: Main: 164040704 12:53:09 INFO - PROCESS | 5930 | 12:53:11 INFO - PROCESS | 5930 | Cycle 1(1): loaded http://localhost:45243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:53:12 INFO - PROCESS | 5930 | RSS: Main: 164311040 12:53:12 INFO - PROCESS | 5930 | 12:53:15 INFO - PROCESS | 5930 | Cycle 1(1): loaded http://localhost:45243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:53:16 INFO - PROCESS | 5930 | RSS: Main: 164712448 12:53:16 INFO - PROCESS | 5930 | 12:53:19 INFO - PROCESS | 5930 | Cycle 1(1): loaded http://localhost:45243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:53:19 INFO - PROCESS | 5930 | RSS: Main: 164753408 12:53:19 INFO - PROCESS | 5930 | 12:53:21 INFO - PROCESS | 5930 | Cycle 1(1): loaded http://localhost:45243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45243/tests/kraken/driver.html?testName=ai-astar) 12:53:21 INFO - PROCESS | 5930 | RSS: Main: 165961728 12:53:21 INFO - PROCESS | 5930 | 12:53:21 INFO - PROCESS | 5930 | __start_tp_report 12:53:21 INFO - PROCESS | 5930 | _x_x_mozilla_page_load 12:53:21 INFO - PROCESS | 5930 | _x_x_mozilla_page_load_details 12:53:21 INFO - PROCESS | 5930 | |i|pagename|runs| 12:53:21 INFO - PROCESS | 5930 | |0;ai-astar;114;107;113;114;114;125;115;113;113;113 12:53:21 INFO - PROCESS | 5930 | |1;audio-beat-detection;168;131;162;198;142;166;160;134;195;135 12:53:21 INFO - PROCESS | 5930 | |2;audio-dft;162;164;167;169;163;161;162;164;167;163 12:53:21 INFO - PROCESS | 5930 | |3;audio-fft;74;75;74;171;77;78;77;80;154;75 12:53:21 INFO - PROCESS | 5930 | |4;audio-oscillator;95;95;153;95;94;94;141;95;94;146 12:53:21 INFO - PROCESS | 5930 | |5;imaging-gaussian-blur;117;118;117;118;119;117;117;118;117;118 12:53:21 INFO - PROCESS | 5930 | |6;imaging-darkroom;147;148;148;148;147;148;147;146;146;147 12:53:21 INFO - PROCESS | 5930 | |7;imaging-desaturate;97;96;95;98;96;96;95;95;99;96 12:53:21 INFO - PROCESS | 5930 | |8;json-parse-financial;65;66;64;73;67;64;65;89;63;63 12:53:21 INFO - PROCESS | 5930 | |9;json-stringify-tinderbox;66;68;65;65;65;65;66;69;66;67 12:53:21 INFO - PROCESS | 5930 | |10;stanford-crypto-aes;81;92;81;80;83;81;81;90;82;82 12:53:21 INFO - PROCESS | 5930 | |11;stanford-crypto-ccm;137;131;134;134;132;139;139;144;167;136 12:53:21 INFO - PROCESS | 5930 | |12;stanford-crypto-pbkdf2;177;174;182;181;174;172;183;173;183;173 12:53:21 INFO - PROCESS | 5930 | |13;stanford-crypto-sha256-iterative;75;72;71;72;74;72;73;73;70;84 12:53:21 INFO - PROCESS | 5930 | __end_tp_report 12:53:21 INFO - PROCESS | 5930 | __start_cc_report 12:53:21 INFO - PROCESS | 5930 | _x_x_mozilla_cycle_collect,927 12:53:21 INFO - PROCESS | 5930 | __end_cc_report 12:53:21 INFO - PROCESS | 5930 | __startTimestamp1461182001785__endTimestamp 12:53:21 INFO - PROCESS | 5930 | 12:53:21 INFO - PROCESS | 5930 | ------- Summary: start ------- 12:53:21 INFO - PROCESS | 5930 | Number of tests: 14 12:53:21 INFO - PROCESS | 5930 | 12:53:21 INFO - PROCESS | 5930 | [#0] ai-astar Cycles:10 Average:114.10 Median:114.00 stddev:4.41 (3.9%) stddev-sans-first:4.68 12:53:21 INFO - PROCESS | 5930 | Values: 114.0 107.0 113.0 114.0 114.0 125.0 115.0 113.0 113.0 113.0 12:53:21 INFO - PROCESS | 5930 | 12:53:21 INFO - PROCESS | 5930 | [#1] audio-beat-detection Cycles:10 Average:159.10 Median:164.00 stddev:24.11 (14.7%) stddev-sans-first:25.35 12:53:21 INFO - PROCESS | 5930 | Values: 168.0 131.0 162.0 198.0 142.0 166.0 160.0 134.0 195.0 135.0 12:53:21 INFO - PROCESS | 5930 | 12:53:21 INFO - PROCESS | 5930 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.00 stddev:2.62 (1.6%) stddev-sans-first:2.65 12:53:21 INFO - PROCESS | 5930 | Values: 162.0 164.0 167.0 169.0 163.0 161.0 162.0 164.0 167.0 163.0 12:53:21 INFO - PROCESS | 5930 | 12:53:21 INFO - PROCESS | 5930 | [#3] audio-fft Cycles:10 Average:93.50 Median:76.00 stddev:36.63 (48.2%) stddev-sans-first:38.17 12:53:21 INFO - PROCESS | 5930 | Values: 74.0 75.0 74.0 171.0 77.0 78.0 77.0 80.0 154.0 75.0 12:53:21 INFO - PROCESS | 5930 | 12:53:21 INFO - PROCESS | 5930 | [#4] audio-oscillator Cycles:10 Average:110.20 Median:94.50 stddev:25.33 (26.8%) stddev-sans-first:26.26 12:53:21 INFO - PROCESS | 5930 | Values: 95.0 95.0 153.0 95.0 94.0 94.0 141.0 95.0 94.0 146.0 12:53:21 INFO - PROCESS | 5930 | 12:53:21 INFO - PROCESS | 5930 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 12:53:21 INFO - PROCESS | 5930 | Values: 117.0 118.0 117.0 118.0 119.0 117.0 117.0 118.0 117.0 118.0 12:53:21 INFO - PROCESS | 5930 | 12:53:21 INFO - PROCESS | 5930 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.50 stddev:0.79 (0.5%) stddev-sans-first:0.83 12:53:21 INFO - PROCESS | 5930 | Values: 147.0 148.0 148.0 148.0 147.0 148.0 147.0 146.0 146.0 147.0 12:53:21 INFO - PROCESS | 5930 | 12:53:21 INFO - PROCESS | 5930 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:1.34 (1.4%) stddev-sans-first:1.39 12:53:21 INFO - PROCESS | 5930 | Values: 97.0 96.0 95.0 98.0 96.0 96.0 95.0 95.0 99.0 96.0 12:53:21 INFO - PROCESS | 5930 | 12:53:21 INFO - PROCESS | 5930 | [#8] json-parse-financial Cycles:10 Average:67.90 Median:65.50 stddev:7.96 (12.2%) stddev-sans-first:8.38 12:53:21 INFO - PROCESS | 5930 | Values: 65.0 66.0 64.0 73.0 67.0 64.0 65.0 89.0 63.0 63.0 12:53:21 INFO - PROCESS | 5930 | 12:53:21 INFO - PROCESS | 5930 | [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:66.00 stddev:1.40 (2.1%) stddev-sans-first:1.48 12:53:21 INFO - PROCESS | 5930 | Values: 66.0 68.0 65.0 65.0 65.0 65.0 66.0 69.0 66.0 67.0 12:53:21 INFO - PROCESS | 5930 | 12:53:21 INFO - PROCESS | 5930 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:82.00 stddev:4.16 (5.1%) stddev-sans-first:4.33 12:53:21 INFO - PROCESS | 5930 | Values: 81.0 92.0 81.0 80.0 83.0 81.0 81.0 90.0 82.0 82.0 12:53:21 INFO - PROCESS | 5930 | 12:53:21 INFO - PROCESS | 5930 | [#11] stanford-crypto-ccm Cycles:10 Average:139.30 Median:138.00 stddev:10.46 (7.6%) stddev-sans-first:11.06 12:53:21 INFO - PROCESS | 5930 | Values: 137.0 131.0 134.0 134.0 132.0 139.0 139.0 144.0 167.0 136.0 12:53:21 INFO - PROCESS | 5930 | 12:53:21 INFO - PROCESS | 5930 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.20 Median:179.00 stddev:4.57 (2.6%) stddev-sans-first:4.84 12:53:21 INFO - PROCESS | 5930 | Values: 177.0 174.0 182.0 181.0 174.0 172.0 183.0 173.0 183.0 173.0 12:53:21 INFO - PROCESS | 5930 | 12:53:21 INFO - PROCESS | 5930 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.60 Median:73.00 stddev:3.92 (5.4%) stddev-sans-first:4.13 12:53:21 INFO - PROCESS | 5930 | Values: 75.0 72.0 71.0 72.0 74.0 72.0 73.0 73.0 70.0 84.0 12:53:21 INFO - PROCESS | 5930 | -------- Summary: end -------- 12:53:21 INFO - PROCESS | 5930 | 12:53:22 INFO - TEST-INFO | 5930: exit 0 12:53:22 INFO - TEST-OK | kraken | took 63901ms 12:53:22 INFO - SUITE-END | took 1178s 12:53:22 INFO - Completed test suite (00:19:38) 12:53:22 INFO - javascript benchmark 12:53:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2567.3838278813087, 2647.510210611037, 2666.853323067231, 2686.3418462476698, 2698.352395425096, 4709.9058018839605, 4735.218688916329, 4742.549457801512, 4760.547747963938, 4818.927716084258, 4600.332951722006, 4665.930011049837, 4743.905121897568, 4744.335792988984, 4811.927821082687, 4298.14037192562, 4386.912261754779, 4390.582894625006, 4391.890202744941, 4413.44831896013, 562.0783341163783, 4160.521540022906, 4304.870853874389, 4347.804348804296, 4367.672424568154, 4327.935080973788, 4335.6965012449145, 4344.500382456026, 4378.387025816404, 4385.0, 4340.197063543223, 4340.348947657845, 4342.478902531717, 4347.478302603708, 4362.389265502832, 4234.534201237861, 4302.397664326997, 4305.311150215982, 4325.52419233884, 4337.457817772778, 4584.381108550337, 4625.606823420013, 4631.675782695213, 4632.2125238709505, 4655.86032419028, 4880.438749543812, 4987.351644286219, 5019.4227663818765, 5019.698818070891, 5044.2937988681615, 5138.948610513884, 5146.150885103953, 5151.278820965068, 5154.664946778447, 5198.324217851693, 4722.1028004679, 4786.0906427778955, 4792.137415265286, 4802.375691160127, 4834.492378300263, 5067.695938243717, 5114.795408183705, 5202.687838729688, 5223.059849227176, 5328.760205790749, 4999.0501804657, 5014.172661510883, 5020.1214787412055, 5027.572656324253, 5037.3955125384455, 5044.697318160922, 5107.8507335849135, 5113.258577506241, 5124.897502049938, 5139.640225184201, 4799.784009719571, 4901.264810278415, 4998.600111991032, 5012.04771093491, 5051.318072060299, 4925.876853078702, 4938.876528086755, 4941.925871111936, 4956.132676781621, 5014.398272207285, 4172.874813755592, 4174.7077704561, 4175.603317684815, 4185.162967406531, 4208.8316467340965, 3594.370985077601, 3629.9637003630155, 3646.7629604076183, 3733.607971163043, 3733.9439908401396, 4406.889827754332, 4426.0, 4464.3973063635995, 4471.932921006188, 4496.213162696515, 4956.603471722326, 4965.453800081988, 4987.251912213197, 4999.325091112726, 5051.898962020812, 4260.360945858084, 4341.15347507233, 4373.934390984138, 4402.537733537996, 4407.977960110243, 4436.600705936481, 4438.5561443856, 4448.466184057934, 4451.9554804451545, 4494.910101797946, 4714.717116972993, 4768.094062128184, 4785.473597904158, 4793.0413917216, 4819.542143496362, 4917.975410122926, 5058.772355243949, 5067.265246539305, 5150.922736159036, 5158.406783219978, 4767.523247675344, 4776.522347765195, 4785.066911952136, 4796.795476907455, 4835.492273311393, 4786.042791441656, 4918.385201849769, 4946.678465899705, 4964.3298154748645, 5012.122878496321, 5039.3448851649055, 5068.29043933857, 5087.949120508748, 5138.306328645585, 5147.073526765069, 4924.556789888928, 4924.63065270099, 4926.211806111005, 4934.457209706858, 4977.0792403405485, 4701.1537923174155, 4824.421069471686, 4924.433690125681, 4930.753462326941, 4967.950320496749, 4771.95228047729, 4791.880202994953, 4815.205491094071, 4826.565609095198, 4857.247126695368, 4859.246816743411, 4894.902101958012, 4901.803927842846, 4903.0, 4959.330490383752, 4694.0, 4794.544518270759, 4822.397200349957, 4838.274258861199, 4864.148773964613], "value": 4598.415597454283, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.2842341385324, 579.6029719642045, 605.1497645807639, 618.3074956049226, 648.9837754056151, 34041.99999999997, 35102.59589616419, 35338.469922951175, 35349.646503534954, 35368.0, 36999.445008324896, 37784.811075944584, 37787.433188502124, 37847.24305513895, 38143.427848582294, 7648.349890259321, 7830.686772529092, 7840.568768717718, 7848.4113691473085, 7867.095284042322, 7721.150673425918, 7766.262205090507, 7787.493812902143, 7793.766187014398, 7869.842603147934, 7830.216978302181, 7892.131865494791, 7905.723299684512, 7909.446338756289, 7924.564148971805, 7779.688812447524, 7823.061232652061, 7857.489263197931, 7860.567668778186, 7872.173421790715, 7707.499012564222, 7795.0, 7800.960995194988, 7802.258785415376, 7836.451448398614, 29991.850040749876, 35713.0, 36052.459213111826, 36166.819165904264, 36305.0, 3154.558361829346, 3239.805611663308, 3245.6267529234206, 3780.3951367781297, 3830.9616903830884, 26625.866870665715, 26738.86630566854, 27005.324866878287, 27950.16149515518, 27981.160565183076, 2965.024989226632, 2980.6423229212414, 2998.475266828318, 3010.2173434906863, 3088.027271409499, 179371.0, 179864.0, 180001.0, 180517.9999999987, 180713.0, 33068.83465582657, 33224.66775332264, 33256.667433325354, 35447.29105417877, 36249.00630465297, 33496.0, 33549.83225083908, 33667.0, 33879.0, 33939.66060339365, 13370.732585348238, 13572.864271357357, 13581.660458488617, 13582.388792504362, 13597.252151131783, 11399.943000284946, 11520.13598980063, 11555.0, 11559.884401156049, 11589.76820463586, 8163.510189388656, 8256.25693687571, 8266.421350505527, 8317.667293308321, 8332.416730828905, 3220.2915358621067, 3230.5800245967876, 3255.853486593109, 3279.1146390474437, 3279.770416070852, 840.2060053249743, 865.8354912566592, 922.4280945813505, 944.2964991081689, 967.4292167621137, 28155.0, 29295.707042929298, 29441.411171776446, 29514.0, 29798.55302170469, 953.3421938862163, 981.916537094355, 995.3977843404781, 997.4514017290461, 1020.0207800511592, 14871.851281487263, 15495.922520387327, 15694.450694225647, 15845.52463426099, 15848.0, 357980.0, 363217.0, 364793.0, 365333.0, 365638.0, 51342.48657513452, 51565.0, 51875.0, 52281.47718522766, 52584.47415525872, 1215.398377802993, 1248.8314077599407, 1250.5998080614297, 1252.204849920289, 1259.0745801835644, 26185.250548692875, 27399.589006164526, 27806.0, 27904.0, 28131.296717581405, 44269.335959961274, 44801.32798007967, 44903.32645010393, 45657.0, 45720.54279457296, 315656.0, 316698.0, 317556.0, 318373.0, 318958.0, 26201.082962096236, 26513.86743066272, 26519.33701657474, 26712.732872671026, 41403.58596413997, 40466.59533404746, 41351.58648413477, 41632.791836040626, 41910.79044604758, 41962.79018604887, 34697.826510867286, 35121.64878351184, 35299.29401411906, 35805.283894322485, 36348.45477317895, 34332.485012724326, 34538.0, 34969.82515087408, 35017.474737878445, 35276.823615882786, 32148.35703285968, 32884.50673239856, 33097.338053238316, 33194.66805331916, 35730.64269357273, 27998.580021300106, 29599.85200073986, 30300.090997270116, 30342.0, 30418.0, 21508.0, 21784.564308714052, 22450.214242502087, 22877.77122228823, 23037.424064398525], "value": 16059.542068760396, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.3824957944181, 378.94694742736016, 385.9440381144736, 387.75377635201636, 397.3840547151914, 15742.29159687814, 16000.119993400358, 17042.403515876947, 17058.061806600632, 17081.48755537336, 10444.321119127251, 11272.32366058037, 11356.48895799689, 11379.829302560469, 11381.943090284558, 4658.208104622214, 4820.25286080658, 4937.629677774164, 5294.311739473863, 5295.602829787781, 5180.740962951856, 5222.477752224766, 5224.8693782655355, 5228.137357336035, 5249.947500524984, 5481.945180548183, 5503.697296648683, 5505.366882808488, 5520.806771762989, 5541.33503979523, 5290.920636190422, 5451.781928722866, 5492.642978206404, 5493.505584497394, 5603.579731520153, 5381.0, 5399.325084364455, 5437.34751829783, 5445.618806683534, 5449.482299181572, 12284.0, 12415.813762793565, 18143.0, 18365.7245141323, 18520.3517876875, 1888.499547619868, 1934.3616606519815, 1944.562473443464, 1963.8232559069752, 2023.281734984074, 8983.191512763882, 9187.989321174666, 9471.810563788686, 12055.457504412323, 12824.294663793487, 1735.1237624999421, 1735.3318972195668, 1752.4830175098377, 1806.638672265539, 1826.3151318255655, 65106.67446662784, 66521.0, 67539.66230168818, 67842.66078669624, 68071.65964170148, 9780.31537792362, 9863.210943124534, 10285.640002599874, 10331.896681033244, 10361.74095647615, 14351.49309322527, 14353.354099065567, 14370.856291437161, 14414.927925360516, 14434.0, 7363.7422690205585, 7416.0, 7475.215102414277, 7561.9243807562325, 7623.809404764815, 6902.792916212522, 7108.92891071093, 7136.250693677193, 7182.96408517954, 7270.8182295441975, 4351.238533256731, 4400.823967041282, 4461.866144015685, 4518.548145185521, 4535.886602834956, 1817.3275887921288, 1875.7842848072373, 1892.4038927737718, 1925.4801203675208, 1933.2846846666823, 398.7567583773896, 405.3190639725231, 431.7603729929919, 781.4959351218432, 943.7542443974025, 10468.424236667057, 10701.785964280827, 10719.78560428787, 10862.0, 10910.054285343072, 423.7626928919815, 429.46317103620476, 433.2137171034562, 437.3963929776888, 438.58772753611504, 5637.577181711388, 5733.799317023884, 5753.568482363839, 5842.152887831326, 5879.735411906475, 405523.0, 406928.0, 408856.0, 413566.0, 414672.0, 78244.60877695575, 78685.0, 79777.60111199523, 80283.19716802874, 80870.0, 445.100896189695, 883.5228976352697, 930.1396208506968, 932.1517419148543, 945.5555888732284, 15366.385344586091, 15507.689846203239, 15529.68940621204, 15623.515766002212, 15844.683106337578, 33243.66756332406, 34166.31667366589, 35266.471002934464, 35412.64587354093, 35707.10732231611, 47678.28482572695, 47991.0, 48289.0, 48313.0, 48397.5160248393, 7719.691212351443, 7801.882971755314, 7858.960705196666, 7985.480943738638, 8070.394720395876, 8700.477971321741, 11157.21899467062, 11767.882321177021, 11838.408079596158, 11883.346415947206, 10287.279890407599, 10312.742181445525, 10317.226208034277, 10419.42693151884, 10551.208659350426, 9888.950555247466, 10294.794104118026, 10432.582696692047, 10453.790924181625, 10828.5127169276, 10093.495325233856, 10094.899051009395, 10362.01560851748, 10443.164546836388, 10509.159267258448, 6751.0, 7195.352418282379, 7423.109226892808, 7859.410544209321, 8025.0, 9820.803583928424, 9869.11177993984, 10009.099181073738, 10032.64885728996, 10059.094681478702], "value": 7641.389472733127, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1410.9223992680402, 1444.8482909294523, 1573.5279416175144, 1745.1187150489002, 1758.0770095699763, 6656.733730650768, 7601.657925393357, 7690.5770182639935, 7866.370690344773, 7888.684452621896, 7692.307692307705, 7695.807604809868, 7758.224177582239, 7766.262205090507, 7766.728164514243, 2217.6895234667118, 2230.4200907764016, 2245.8203343732544, 2248.2693124734446, 2251.122062395667, 2178.2920550821045, 2217.1796435318956, 2219.533897881447, 2227.2204728345114, 2230.8326875484404, 2215.7894999975056, 2242.529068895534, 2244.842860999731, 2253.5154941687533, 2263.8868056597103, 2161.0, 2168.4687251623295, 2169.0673010605433, 2177.074743234119, 2178.215842296772, 2172.174573662014, 2185.0385830234645, 2196.5826492966285, 2197.2858820883116, 2198.1537108213292, 7804.453688241825, 7895.526268423913, 7929.207079292082, 7932.524048557105, 7938.087119981161, 4524.8416305429155, 4714.363560919301, 4716.0, 4747.0, 4758.214894542396, 2830.3631682871396, 2902.956455653167, 2924.546695262238, 2930.0184438213223, 2957.452871218831, 885.7918389178537, 903.4172958441768, 907.9273658107336, 919.4942781470164, 919.6735159018519, 9963.90036099637, 10270.9486452568, 10298.845517317246, 10371.792564148675, 10445.529951152217, 4074.246264441088, 4114.6091121343425, 4211.578842115764, 4261.424707664426, 4277.657787377002, 8480.236778689825, 8506.404551681446, 8536.74389768308, 8543.273821725099, 8550.871736923951, 4646.745378747787, 4649.163150632919, 4652.837150699777, 4655.255159174516, 4668.789904454307, 3775.4903088083306, 4111.1366613011005, 4211.642010429148, 4345.261305578059, 4354.412154359121, 3467.514547963287, 3498.8775392861126, 3552.4138517144384, 3586.7130629549574, 3631.219287853124, 1058.6241884131177, 1091.5906535049357, 1099.5107177306181, 1105.3423213188141, 1117.201201141188, 821.6466919224671, 836.5273620404452, 836.6862426590029, 841.0538144587339, 865.8181781825887, 5347.518723314843, 5432.538234250133, 5467.043267428184, 5593.8321850344555, 5603.803866864721, 888.6223355074068, 898.4205187653927, 901.7520181950016, 914.835329640671, 918.5315489100607, 3673.3204357194004, 3682.1531047859144, 3744.700423966076, 3803.6576708096404, 3827.2154208387215, 9377.156055954996, 9731.805363892683, 9816.901830981742, 9831.410115393099, 9833.115019648267, 9630.4703241321, 9643.855342169873, 9699.418034917928, 9704.078112579293, 9715.902840971641, 7122.964385178041, 7132.857342853114, 7308.04995350601, 7313.378362839112, 7316.9634151828905, 5354.4110147884485, 5364.249005139206, 5372.140457526777, 5572.4148964358155, 5588.6646801192055, 8526.78683032929, 8659.870101948602, 8703.738887833375, 8772.342074344577, 8794.120587941155, 8571.914280857112, 8689.0, 8702.782430439289, 9150.63397464094, 9222.123898229658, 5987.13186587951, 6664.0, 6781.593104413751, 6950.06174166481, 6971.65141742921, 7453.776386708408, 7497.662605182671, 7531.171571127062, 7558.281963213486, 7570.015897933234, 6581.308962559054, 6771.52599318043, 6822.317768223138, 6882.518223724292, 6901.792946211622, 6682.866342673216, 6739.6967136478, 6938.895916561155, 6943.062686537252, 6944.340287672663, 6271.090691849748, 6282.465990390868, 6361.936380636134, 6382.106505089198, 6474.1907261592305, 4498.21281275782, 4520.141173177086, 4619.0, 4672.883177920579, 4764.237721964469, 4683.414573178353, 4701.647376446848, 4770.141374552614, 4800.06398752254, 4820.108279968217], "value": 4159.271874529529, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.2187644937834, 303.4295524414101, 310.821277765285, 313.47962382445144, 322.6563709649222, 5132.743362831862, 5256.132738098218, 5264.789408423663, 5384.757685904134, 5390.973045134779, 5279.63042587019, 5310.415854256029, 5325.946740532603, 5326.6537675051095, 5327.413984461706, 4121.505419349667, 4160.521540022891, 4174.770387628671, 4175.081482073939, 4175.914262291811, 3860.2665493556133, 4111.794410279489, 4158.168366326747, 4172.457580514529, 4174.457320548325, 4035.8183881725245, 4048.615381538764, 4064.1668457966193, 4069.5959893836725, 4078.449409329747, 4031.475908131939, 4049.2508885856064, 4057.756534607933, 4062.4109504122034, 4076.898077548085, 3567.1973805893726, 3574.1422058705725, 3576.177479179777, 3582.17609949713, 3587.6232995535356, 4863.0, 5071.290019397287, 5097.5667068299235, 5104.642675012714, 5110.872228194287, 4685.062987402499, 4692.0, 4700.811967521295, 4704.670673052888, 4725.66920315578, 5580.386157522669, 5583.441655834425, 5627.437256274381, 5656.208130861683, 5672.092465205547, 3797.677197438221, 3930.862419815293, 3932.134930315326, 3935.8032098394965, 3943.1719338938856, 5810.1865738796605, 5835.270591176103, 5870.236869207019, 5887.440693134188, 5940.2871655401195, 4013.1171142348635, 4016.594192032765, 4020.0753826619457, 4026.657734092635, 4036.29364861154, 3955.7626542407547, 4067.2882245607493, 4068.7558746475306, 4081.3673880548563, 4086.611771881726, 4603.309503574491, 4644.842865635305, 4651.976740116278, 4675.181843177498, 4683.250679891269, 5309.362876454773, 5524.1989911462615, 5605.971970140124, 5616.550675945915, 5618.701693204702, 1382.4677499162894, 1413.9293035348192, 1415.9646008849654, 1416.3060100550863, 1420.7797791342152, 934.8223837470858, 938.5494962417941, 955.4219697083165, 955.8231727130503, 964.8408012677829, 4881.023185609763, 4884.7313397762755, 4886.486918873538, 4888.144574699413, 4895.73073480962, 5716.685162412585, 5717.742701578439, 5723.370429252779, 5725.8568535786935, 5740.512056475246, 4713.481517033124, 4856.4415092264135, 4875.902481950341, 4880.365552478226, 4885.511448855086, 3051.206686261588, 3058.5870907427657, 3062.724354808078, 3067.8466076696077, 3084.583581216507, 5335.359756829128, 5356.116240820221, 5364.9731751341, 5372.086745253317, 5413.296271484682, 5722.828315150552, 5880.705964701748, 6035.185249991283, 6040.486558642477, 6044.727987240497, 5521.868017056574, 5533.170024496358, 5551.0, 5560.499555040065, 5565.666060036411, 5701.486866182064, 5807.738651760766, 5858.070964517741, 5862.94137058624, 5871.530277577869, 5683.090705487102, 5687.0, 5691.516221121085, 5714.714264286686, 5746.770129194785, 5408.296921400193, 5481.616286860041, 5489.368722596792, 5492.890142197054, 5528.80649177293, 3964.365701487748, 3995.6403923647013, 3999.1801680655976, 4035.1324465240114, 4047.6761859050616, 5527.226188333556, 5612.887742245214, 5762.855928601818, 5828.766849326149, 5831.650100993954, 5601.271834661468, 5613.214150019082, 5631.662100273997, 5632.633878797865, 5632.774689012557, 5612.102063669793, 5613.971930140323, 5619.325680918152, 5621.707007388405, 5643.0, 5199.168133098686, 5538.750756216061, 5562.694051827189, 5570.164475328733, 5574.554035677217, 5648.15277708347, 5665.895150445788, 5693.572982026281, 5694.291712486321, 5713.143028545752, 5303.780130569913, 5561.221429000024, 5564.55483561306, 5568.972155139199, 5576.721163941867], "value": 4190.33600937016, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.7015053677457, 742.6954948471127, 744.571871174075, 800.5276886636883, 801.6032064128258, 11664.475098620562, 11960.10299227558, 12006.939965300184, 12054.397280136001, 12058.974987126094, 11374.0, 11384.487698053586, 11502.712432189179, 11534.423278836066, 12137.514499420013, 831.9251267385933, 832.6544484039132, 841.032812265893, 843.9367047471465, 844.6748002019206, 814.2346194577078, 821.0229826506468, 821.1419067074921, 821.876718492225, 825.1707034430389, 855.6235256487157, 856.5588721808242, 857.3012994409568, 857.7298151082389, 859.9957000215021, 852.3564708644996, 856.5631527920774, 856.6230858422274, 857.0486759696731, 860.0797147052656, 630.9747610095591, 631.0313668518802, 631.8894193516117, 632.0582332324849, 632.7658766256468, 12072.0, 12113.818292725617, 12191.939040304742, 12201.694957626041, 12261.386930653433, 12168.81746773799, 12175.878241217652, 12319.137660363778, 12538.937305313415, 12843.486260549567, 8764.1674040966, 9118.5440727964, 9254.07459254076, 11025.283356581876, 11157.888421115847, 3080.9845950770327, 3099.1942095055224, 3139.6232452105664, 3162.5256211568217, 3177.698118678722, 42030.579694203276, 42317.57682423167, 42547.0, 42695.57304426947, 42738.0, 9579.90420095804, 9623.615055397706, 9754.902450975542, 9785.510724463891, 10372.481375931173, 16534.0, 16542.338306467605, 16605.83394166067, 16622.25199866009, 16623.0, 6846.110005699326, 6924.307569243036, 6986.790396288119, 7004.4396448284015, 7048.612326321999, 3947.7631342119566, 3951.9604803952166, 3989.0426297688346, 3990.74060186087, 4024.9597504024587, 2760.1305588739883, 2831.0940499040107, 2839.162447078117, 2850.50116229659, 2859.6711378191358, 479.7793015213041, 491.6632107006712, 500.6970782676501, 504.2738456622452, 510.77270614576156, 565.7821738630657, 595.4224402329734, 603.0983679399326, 623.9407256310734, 630.6941133550224, 7002.299770023059, 7038.788836334918, 7126.144862616519, 7319.890201646979, 7435.0, 567.4722508067537, 583.6177303865975, 589.1575047681771, 590.1207201270076, 603.5774957529746, 3539.0, 3614.0, 3664.4136938089778, 3725.5343082114737, 3746.7189960752507, 43948.340774888406, 45487.0, 51070.23394649083, 52568.0, 52612.0, 41912.0, 42845.0, 42847.35728964068, 43190.35214471786, 43292.0, 33303.50044749331, 33381.499277510855, 36265.63734362675, 36973.63026369702, 37539.81230093832, 6986.755463558751, 7337.0, 7466.141393739789, 7487.176410594939, 7574.091109066947, 26067.0, 26342.20973370802, 26574.601380979686, 27434.314142145806, 27544.0, 33395.83302083474, 33632.49551256684, 34966.825165874005, 35086.64913350834, 36616.45075323819, 10309.639162629272, 10671.46642667848, 10673.252872299176, 10902.345859248471, 10954.56181752721, 11162.609308674157, 11588.94205528967, 11612.419379031184, 11648.825267620823, 12049.0, 9013.0, 9104.271658267455, 9110.817783644157, 9417.340786145178, 9445.149936505748, 11009.779804403706, 11137.944310278397, 11220.0, 11400.0, 11775.76448471043, 9197.448153110834, 9435.811283774423, 9471.242300615797, 9592.808143837225, 9639.807203856024, 9529.52352382392, 9599.520023998912, 9866.457344845816, 9911.801763964824, 10187.134093602126, 8240.752777416687, 8380.0, 8603.870941935751, 8632.78418039554, 8656.350773691873], "value": 5739.450605256131, "unit": "score"}], "name": "dromaeo_css", "value": 6193.677466064625, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 107.0, 113.0, 114.0, 114.0, 125.0, 115.0, 113.0, 113.0, 113.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 131.0, 162.0, 198.0, 142.0, 166.0, 160.0, 134.0, 195.0, 135.0], "value": 159.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 167.0, 169.0, 163.0, 161.0, 162.0, 164.0, 167.0, 163.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 171.0, 77.0, 78.0, 77.0, 80.0, 154.0, 75.0], "value": 93.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 153.0, 95.0, 94.0, 94.0, 141.0, 95.0, 94.0, 146.0], "value": 110.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 119.0, 117.0, 117.0, 118.0, 117.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 148.0, 147.0, 148.0, 147.0, 146.0, 146.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 95.0, 98.0, 96.0, 96.0, 95.0, 95.0, 99.0, 96.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 64.0, 73.0, 67.0, 64.0, 65.0, 89.0, 63.0, 63.0], "value": 67.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 65.0, 65.0, 65.0, 65.0, 66.0, 69.0, 66.0, 67.0], "value": 66.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 92.0, 81.0, 80.0, 83.0, 81.0, 81.0, 90.0, 82.0, 82.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 131.0, 134.0, 134.0, 132.0, 139.0, 139.0, 144.0, 167.0, 136.0], "value": 139.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 174.0, 182.0, 181.0, 174.0, 172.0, 183.0, 173.0, 183.0, 173.0], "value": 177.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 72.0, 71.0, 72.0, 74.0, 72.0, 73.0, 73.0, 70.0, 84.0], "value": 73.6, "unit": "score"}], "name": "kraken", "value": 1609.7, "alertThreshold": 2.0}]} 12:53:22 INFO - Return code: 0 12:53:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:53:23 ERROR - # TBPL SUCCESS # 12:53:23 INFO - Running post-action listener: _resource_record_post_action 12:53:23 INFO - Running post-run listener: _resource_record_post_run 12:53:24 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 372891648; Read time: 12; Write time: 231664 12:53:24 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 75071488; Read time: 0; Write time: 53920 12:53:24 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 278040576; Read time: 12; Write time: 169960 12:53:24 INFO - Running post-run listener: _upload_blobber_files 12:53:24 INFO - Blob upload gear active. 12:53:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:53:24 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 12:53:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:53:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:53:24 INFO - (blobuploader) - INFO - Open directory for files ... 12:53:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:53:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:53:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:53:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:53:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:53:25 INFO - (blobuploader) - INFO - Done attempting. 12:53:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:53:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:53:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:53:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:53:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:53:26 INFO - (blobuploader) - INFO - Done attempting. 12:53:26 INFO - (blobuploader) - INFO - Iteration through files over. 12:53:26 INFO - Return code: 0 12:53:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:53:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:53:26 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3df1740e7cc7222dfe5d86143ecf962e0c4a96d37b020169f57b6b03e02d3ee9d587911b82719a5c99969f67d08d4b9858ed243d30293e5fd9a741454ba16dfd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2b90b9146329eefccee5012f9a6542954de4003e1681558d2e2fbc7f943427211128f0215c44a5ddb47ae90ed6be74d255c29f0da4e3ed7415ca14a0dc37df81"} 12:53:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:53:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:53:26 INFO - Contents: 12:53:26 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3df1740e7cc7222dfe5d86143ecf962e0c4a96d37b020169f57b6b03e02d3ee9d587911b82719a5c99969f67d08d4b9858ed243d30293e5fd9a741454ba16dfd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2b90b9146329eefccee5012f9a6542954de4003e1681558d2e2fbc7f943427211128f0215c44a5ddb47ae90ed6be74d255c29f0da4e3ed7415ca14a0dc37df81"} 12:53:26 INFO - Running post-run listener: copy_logs_to_upload_dir 12:53:26 INFO - Copying logs to upload dir... 12:53:26 INFO - mkdir: /builds/slave/test/build/upload/logs 12:53:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.084251 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-04-20 12:53:25.937688) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 12:53:25.941606) ========= 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=41bf3e9aed84707956354da8000001c5-1461176189.671725-1788962282 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3df1740e7cc7222dfe5d86143ecf962e0c4a96d37b020169f57b6b03e02d3ee9d587911b82719a5c99969f67d08d4b9858ed243d30293e5fd9a741454ba16dfd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2b90b9146329eefccee5012f9a6542954de4003e1681558d2e2fbc7f943427211128f0215c44a5ddb47ae90ed6be74d255c29f0da4e3ed7415ca14a0dc37df81"} build_url:https://queue.taskcluster.net/v1/task/eSEazso5QVCwLOTfWrAySg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011098 build_url: 'https://queue.taskcluster.net/v1/task/eSEazso5QVCwLOTfWrAySg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3df1740e7cc7222dfe5d86143ecf962e0c4a96d37b020169f57b6b03e02d3ee9d587911b82719a5c99969f67d08d4b9858ed243d30293e5fd9a741454ba16dfd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2b90b9146329eefccee5012f9a6542954de4003e1681558d2e2fbc7f943427211128f0215c44a5ddb47ae90ed6be74d255c29f0da4e3ed7415ca14a0dc37df81"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 12:53:25.968583) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 12:53:25.968914) ========= 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=41bf3e9aed84707956354da8000001c5-1461176189.671725-1788962282 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004529 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 12:53:26.052824) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 12:53:26.053157) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 12:53:26.053631) ========= ========= Total master_lag: 0.28 =========