builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-038 starttime: 1460988634.46 results: success (0) buildid: 20160418054123 builduid: 76ce0d81b70e43a4a119c6d091e37136 revision: 6066850740cd4711ee5502fda89f422440b7c2cc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 07:10:34.460150) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 07:10:34.460594) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 07:10:34.460906) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 07:10:34.548775) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 07:10:34.549099) ========= 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=8783db0840cc980e80bb0bd400000236-1460986938.304110-757000833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-18 07:10:34-- 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% 222M=0s 2016-04-18 07:10:34 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.140105 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 07:10:34.703769) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 07:10:34.704134) ========= 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=8783db0840cc980e80bb0bd400000236-1460986938.304110-757000833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016348 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 07:10:34.756114) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 07:10:34.756475) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6066850740cd4711ee5502fda89f422440b7c2cc --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 6066850740cd4711ee5502fda89f422440b7c2cc --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=8783db0840cc980e80bb0bd400000236-1460986938.304110-757000833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-18 07:10:34,787 truncating revision to first 12 chars 2016-04-18 07:10:34,787 Setting DEBUG logging. 2016-04-18 07:10:34,787 attempt 1/10 2016-04-18 07:10:34,787 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6066850740cd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-18 07:10:35,054 unpacking tar archive at: mozilla-central-6066850740cd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.558308 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 07:10:35.329938) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 07:10:35.330302) ========= script_repo_revision: 6066850740cd4711ee5502fda89f422440b7c2cc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 07:10:35.330761) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 07:10:35.331094) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 07:10:35.341397) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-04-18 07:10:35.341711) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=8783db0840cc980e80bb0bd400000236-1460986938.304110-757000833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:10:35 INFO - MultiFileLogger online at 20160418 07:10:35 in /builds/slave/test 07:10:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 07:10:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:10:35 INFO - {'append_to_log': False, 07:10:35 INFO - 'base_work_dir': '/builds/slave/test', 07:10:35 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:10:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:10:35 INFO - 'branch': 'Firefox-Non-PGO', 07:10:35 INFO - 'buildbot_json_path': 'buildprops.json', 07:10:35 INFO - 'config_files': ('talos/linux_config.py',), 07:10:35 INFO - 'default_actions': ('clobber', 07:10:35 INFO - 'read-buildbot-config', 07:10:35 INFO - 'download-and-extract', 07:10:35 INFO - 'populate-webroot', 07:10:35 INFO - 'create-virtualenv', 07:10:35 INFO - 'install', 07:10:35 INFO - 'run-tests'), 07:10:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:10:35 INFO - 'download_minidump_stackwalk': True, 07:10:35 INFO - 'download_symbols': 'ondemand', 07:10:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:10:35 INFO - 'tooltool.py': '/tools/tooltool.py', 07:10:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:10:35 INFO - '/tools/misc-python/virtualenv.py')}, 07:10:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:10:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:10:35 INFO - 'installer_path': 'installer.exe', 07:10:35 INFO - 'log_level': 'info', 07:10:35 INFO - 'log_name': 'talos', 07:10:35 INFO - 'log_to_console': True, 07:10:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:10:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:10:35 INFO - 'opt_config_files': (), 07:10:35 INFO - 'pip_index': False, 07:10:35 INFO - 'sps_profile': False, 07:10:35 INFO - 'sps_profile_interval': 0, 07:10:35 INFO - 'suite': 'dromaeojs', 07:10:35 INFO - 'system_bits': '32', 07:10:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:10:35 INFO - 'title': 'talos-linux64-ix-038', 07:10:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:10:35 INFO - 'use_talos_json': True, 07:10:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:10:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:10:35 INFO - 'work_dir': 'build'} 07:10:35 INFO - ##### 07:10:35 INFO - ##### Running clobber step. 07:10:35 INFO - ##### 07:10:35 INFO - Running pre-action listener: _resource_record_pre_action 07:10:35 INFO - Running main action method: clobber 07:10:35 INFO - rmtree: /builds/slave/test/build 07:10:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:10:36 INFO - Running post-action listener: _resource_record_post_action 07:10:36 INFO - ##### 07:10:36 INFO - ##### Running read-buildbot-config step. 07:10:36 INFO - ##### 07:10:36 INFO - Running pre-action listener: _resource_record_pre_action 07:10:36 INFO - Running main action method: read_buildbot_config 07:10:36 INFO - Using buildbot properties: 07:10:36 INFO - { 07:10:36 INFO - "project": "", 07:10:36 INFO - "product": "firefox", 07:10:36 INFO - "script_repo_revision": "production", 07:10:36 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:10:36 INFO - "repository": "", 07:10:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 07:10:36 INFO - "buildid": "20160418054123", 07:10:36 INFO - "pgo_build": "False", 07:10:36 INFO - "basedir": "/builds/slave/test", 07:10:36 INFO - "buildnumber": 69, 07:10:36 INFO - "slavename": "talos-linux64-ix-038", 07:10:36 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:10:36 INFO - "platform": "ubuntu64_hw", 07:10:36 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 07:10:36 INFO - "branch": "mozilla-central", 07:10:36 INFO - "repo_path": "mozilla-central", 07:10:36 INFO - "revision": "6066850740cd4711ee5502fda89f422440b7c2cc", 07:10:36 INFO - "stage_platform": "linux64", 07:10:36 INFO - "builduid": "76ce0d81b70e43a4a119c6d091e37136", 07:10:36 INFO - "slavebuilddir": "test" 07:10:36 INFO - } 07:10:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/JUzF-dg1RheGjeMudkMTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 07:10:36 INFO - Running post-action listener: _resource_record_post_action 07:10:36 INFO - ##### 07:10:36 INFO - ##### Running download-and-extract step. 07:10:36 INFO - ##### 07:10:36 INFO - Running pre-action listener: _resource_record_pre_action 07:10:36 INFO - Running main action method: download_and_extract 07:10:36 INFO - mkdir: /builds/slave/test/build/tests 07:10:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:36 INFO - https://queue.taskcluster.net/v1/task/JUzF-dg1RheGjeMudkMTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:10:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JUzF-dg1RheGjeMudkMTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:10:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JUzF-dg1RheGjeMudkMTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:10:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JUzF-dg1RheGjeMudkMTCQ/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 07:10:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JUzF-dg1RheGjeMudkMTCQ/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 07:10:38 INFO - Downloaded 1361 bytes. 07:10:38 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:10:38 INFO - Using the following test package requirements: 07:10:38 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:10:38 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:10:38 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:10:38 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:10:38 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:10:38 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:10:38 INFO - u'jsshell-linux-x86_64.zip'], 07:10:38 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:10:38 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:10:38 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:10:38 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:10:38 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:10:38 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:10:38 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:10:38 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:10:38 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:10:38 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:10:38 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:10:38 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:10:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:38 INFO - https://queue.taskcluster.net/v1/task/JUzF-dg1RheGjeMudkMTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:10:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JUzF-dg1RheGjeMudkMTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:10:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JUzF-dg1RheGjeMudkMTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:10:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JUzF-dg1RheGjeMudkMTCQ/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 07:10:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JUzF-dg1RheGjeMudkMTCQ/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 07:10:40 INFO - Downloaded 22203510 bytes. 07:10:40 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'] 07:10:40 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 07:10:41 INFO - Return code: 0 07:10:41 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 07:10:41 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')]} 07:10:41 INFO - https://queue.taskcluster.net/v1/task/JUzF-dg1RheGjeMudkMTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:10:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JUzF-dg1RheGjeMudkMTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:10:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JUzF-dg1RheGjeMudkMTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:10:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JUzF-dg1RheGjeMudkMTCQ/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 07:10:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JUzF-dg1RheGjeMudkMTCQ/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 07:10:55 INFO - Downloaded 22203510 bytes. 07:10:55 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'] 07:10:55 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 07:10:56 INFO - Return code: 0 07:10:56 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')]} 07:10:56 INFO - https://queue.taskcluster.net/v1/task/JUzF-dg1RheGjeMudkMTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:10:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JUzF-dg1RheGjeMudkMTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:10:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JUzF-dg1RheGjeMudkMTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:10:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JUzF-dg1RheGjeMudkMTCQ/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 07:10:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JUzF-dg1RheGjeMudkMTCQ/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 07:10:58 INFO - Downloaded 10845952 bytes. 07:10:58 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'] 07:10:58 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 07:10:58 INFO - Return code: 0 07:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:58 INFO - https://queue.taskcluster.net/v1/task/JUzF-dg1RheGjeMudkMTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:10:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JUzF-dg1RheGjeMudkMTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:10:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JUzF-dg1RheGjeMudkMTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:10:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JUzF-dg1RheGjeMudkMTCQ/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 07:10:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JUzF-dg1RheGjeMudkMTCQ/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 07:11:01 INFO - Downloaded 54451586 bytes. 07:11:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JUzF-dg1RheGjeMudkMTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:11:01 INFO - mkdir: /builds/slave/test/properties 07:11:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:11:01 INFO - Writing to file /builds/slave/test/properties/build_url 07:11:01 INFO - Contents: 07:11:01 INFO - build_url:https://queue.taskcluster.net/v1/task/JUzF-dg1RheGjeMudkMTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:11:02 INFO - Running post-action listener: _resource_record_post_action 07:11:02 INFO - Running post-action listener: set_extra_try_arguments 07:11:02 INFO - ##### 07:11:02 INFO - ##### Running populate-webroot step. 07:11:02 INFO - ##### 07:11:02 INFO - Running pre-action listener: _resource_record_pre_action 07:11:02 INFO - Running main action method: populate_webroot 07:11:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:11:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:11:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:11:02 INFO - '--tppagecycles', 07:11:02 INFO - '7'], 07:11:02 INFO - 'tests': ['tsvgm']}}, 07:11:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:11:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:11:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:11:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:11:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:11:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:11:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:02 INFO - 'talos_options': ['--disable-e10s'], 07:11:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:11:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:11:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:02 INFO - 'talos_options': ['--disable-e10s'], 07:11:02 INFO - 'tests': ['damp', 'tps']}, 07:11:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:02 INFO - 'tests': ['damp', 'tps']}, 07:11:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:11:02 INFO - 'tests': ['dromaeo_dom']}, 07:11:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:11:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:11:02 INFO - 'tests': ['a11yr', 07:11:02 INFO - 'ts_paint', 07:11:02 INFO - 'tpaint', 07:11:02 INFO - 'sessionrestore', 07:11:02 INFO - 'sessionrestore_no_auto_restore', 07:11:02 INFO - 'tabpaint']}, 07:11:02 INFO - 'other-e10s': {'tests': ['a11yr', 07:11:02 INFO - 'ts_paint', 07:11:02 INFO - 'tpaint', 07:11:02 INFO - 'sessionrestore', 07:11:02 INFO - 'sessionrestore_no_auto_restore', 07:11:02 INFO - 'tabpaint']}, 07:11:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:11:02 INFO - 'ts_paint', 07:11:02 INFO - 'tpaint', 07:11:02 INFO - 'sessionrestore', 07:11:02 INFO - 'sessionrestore_no_auto_restore', 07:11:02 INFO - 'tabpaint']}, 07:11:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:11:02 INFO - 'ts_paint', 07:11:02 INFO - 'tpaint', 07:11:02 INFO - 'sessionrestore', 07:11:02 INFO - 'sessionrestore_no_auto_restore', 07:11:02 INFO - 'tabpaint']}, 07:11:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:11:02 INFO - 'tests': ['a11yr', 07:11:02 INFO - 'ts_paint', 07:11:02 INFO - 'tpaint', 07:11:02 INFO - 'sessionrestore', 07:11:02 INFO - 'sessionrestore_no_auto_restore', 07:11:02 INFO - 'tabpaint']}, 07:11:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:11:02 INFO - 'tests': ['a11yr', 07:11:02 INFO - 'ts_paint', 07:11:02 INFO - 'tpaint', 07:11:02 INFO - 'sessionrestore', 07:11:02 INFO - 'sessionrestore_no_auto_restore', 07:11:02 INFO - 'tabpaint']}, 07:11:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:11:02 INFO - 'tests': ['tsvgx', 07:11:02 INFO - 'tsvgr_opacity', 07:11:02 INFO - 'tart', 07:11:02 INFO - 'tscrollx', 07:11:02 INFO - 'cart']}, 07:11:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:11:02 INFO - 'tsvgr_opacity', 07:11:02 INFO - 'tart', 07:11:02 INFO - 'tscrollx', 07:11:02 INFO - 'cart']}, 07:11:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:02 INFO - 'talos_options': ['--disable-e10s'], 07:11:02 INFO - 'tests': ['tp5o']}, 07:11:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:02 INFO - 'tests': ['tp5o']}, 07:11:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:02 INFO - 'talos_options': ['--disable-e10s', 07:11:02 INFO - '--xperf_path', 07:11:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:11:02 INFO - 'tests': ['tp5n']}, 07:11:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:02 INFO - 'talos_options': ['--xperf_path', 07:11:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:11:02 INFO - 'tests': ['tp5n']}}, 07:11:02 INFO - 'talos.zip': {'path': '', 07:11:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:11:02 INFO - Running post-action listener: _resource_record_post_action 07:11:02 INFO - ##### 07:11:02 INFO - ##### Running create-virtualenv step. 07:11:02 INFO - ##### 07:11:02 INFO - Running pre-action listener: _resource_record_pre_action 07:11:02 INFO - Running main action method: create_virtualenv 07:11:02 INFO - Creating virtualenv /builds/slave/test/build/venv 07:11: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 07:11:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:11:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:11:02 INFO - Using real prefix '/usr' 07:11:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:11:02 INFO - Installing distribute.............................................................................................................................................................................................done. 07:11:04 INFO - Installing pip.................done. 07:11:04 INFO - Return code: 0 07:11:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:11:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d848d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfb410>, '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 0x2bfc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bfc7a0>, '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': '8783db0840cc980e80bb0bd400000236-1460986938.304110-757000833', '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 07:11:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:11:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:11:04 INFO - Using env: {'DISPLAY': ':0', 07:11:04 INFO - 'HOME': '/home/cltbld', 07:11:04 INFO - 'LANG': 'en_US.UTF-8', 07:11:04 INFO - 'LANGUAGE': 'en_US:en', 07:11:04 INFO - 'LOGNAME': 'cltbld', 07:11:04 INFO - 'MAIL': '/var/mail/cltbld', 07:11:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:04 INFO - 'MOZ_NO_REMOTE': '1', 07:11:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:04 INFO - 'NO_EM_RESTART': '1', 07:11:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:04 INFO - 'PWD': '/builds/slave/test', 07:11:04 INFO - 'SHELL': '/bin/bash', 07:11:04 INFO - 'SHLVL': '1', 07:11:04 INFO - 'TERM': 'linux', 07:11:04 INFO - 'TMOUT': '86400', 07:11:04 INFO - 'USER': 'cltbld', 07:11:04 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1460986938.304110-757000833', 07:11:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:04 INFO - '_': '/tools/buildbot/bin/python'} 07:11:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:04 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 07:11:04 INFO - Cleaning up... 07:11:04 INFO - Return code: 0 07:11:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:11:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2d848d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfb410>, '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 0x2bfc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bfc7a0>, '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': '8783db0840cc980e80bb0bd400000236-1460986938.304110-757000833', '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 07:11:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 07:11:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:11:04 INFO - Using env: {'DISPLAY': ':0', 07:11:04 INFO - 'HOME': '/home/cltbld', 07:11:04 INFO - 'LANG': 'en_US.UTF-8', 07:11:04 INFO - 'LANGUAGE': 'en_US:en', 07:11:04 INFO - 'LOGNAME': 'cltbld', 07:11:04 INFO - 'MAIL': '/var/mail/cltbld', 07:11:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:04 INFO - 'MOZ_NO_REMOTE': '1', 07:11:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:04 INFO - 'NO_EM_RESTART': '1', 07:11:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:04 INFO - 'PWD': '/builds/slave/test', 07:11:04 INFO - 'SHELL': '/bin/bash', 07:11:04 INFO - 'SHLVL': '1', 07:11:04 INFO - 'TERM': 'linux', 07:11:04 INFO - 'TMOUT': '86400', 07:11:04 INFO - 'USER': 'cltbld', 07:11:04 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1460986938.304110-757000833', 07:11:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:04 INFO - '_': '/tools/buildbot/bin/python'} 07:11:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:05 INFO - Downloading/unpacking psutil>=0.7.1 07:11: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 07:11: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 07:11: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 07:11: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 07:11: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 07:11: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 07:11:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:11:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:11:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:11:07 INFO - Installing collected packages: psutil 07:11:07 INFO - Running setup.py install for psutil 07:11:07 INFO - building 'psutil._psutil_linux' extension 07:11: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 07:11: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 07:11:07 INFO - building 'psutil._psutil_posix' extension 07:11: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 07:11: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 07:11:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:11:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:11:07 INFO - Successfully installed psutil 07:11:07 INFO - Cleaning up... 07:11:07 INFO - Return code: 0 07:11:07 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:11:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2d848d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfb410>, '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 0x2bfc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bfc7a0>, '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': '8783db0840cc980e80bb0bd400000236-1460986938.304110-757000833', '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 07:11:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 07:11:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:11:07 INFO - Using env: {'DISPLAY': ':0', 07:11:07 INFO - 'HOME': '/home/cltbld', 07:11:07 INFO - 'LANG': 'en_US.UTF-8', 07:11:07 INFO - 'LANGUAGE': 'en_US:en', 07:11:07 INFO - 'LOGNAME': 'cltbld', 07:11:07 INFO - 'MAIL': '/var/mail/cltbld', 07:11:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:07 INFO - 'MOZ_NO_REMOTE': '1', 07:11:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:07 INFO - 'NO_EM_RESTART': '1', 07:11:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:07 INFO - 'PWD': '/builds/slave/test', 07:11:07 INFO - 'SHELL': '/bin/bash', 07:11:07 INFO - 'SHLVL': '1', 07:11:07 INFO - 'TERM': 'linux', 07:11:07 INFO - 'TMOUT': '86400', 07:11:07 INFO - 'USER': 'cltbld', 07:11:07 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1460986938.304110-757000833', 07:11:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:07 INFO - '_': '/tools/buildbot/bin/python'} 07:11:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:11:07 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 07:11:07 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 07:11:07 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 07:11:07 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 07:11:07 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 07:11:07 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 07:11:09 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:11:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:11:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:11:09 INFO - Installing collected packages: mozsystemmonitor 07:11:09 INFO - Running setup.py install for mozsystemmonitor 07:11:09 INFO - Successfully installed mozsystemmonitor 07:11:09 INFO - Cleaning up... 07:11:09 INFO - Return code: 0 07:11:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:11:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:09 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 0x7f2d848d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfb410>, '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 0x2bfc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bfc7a0>, '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': '8783db0840cc980e80bb0bd400000236-1460986938.304110-757000833', '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 07:11:09 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 07:11:09 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 07:11:09 INFO - Using env: {'DISPLAY': ':0', 07:11:09 INFO - 'HOME': '/home/cltbld', 07:11:09 INFO - 'LANG': 'en_US.UTF-8', 07:11:09 INFO - 'LANGUAGE': 'en_US:en', 07:11:09 INFO - 'LOGNAME': 'cltbld', 07:11:09 INFO - 'MAIL': '/var/mail/cltbld', 07:11:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:09 INFO - 'MOZ_NO_REMOTE': '1', 07:11:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:09 INFO - 'NO_EM_RESTART': '1', 07:11:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:09 INFO - 'PWD': '/builds/slave/test', 07:11:09 INFO - 'SHELL': '/bin/bash', 07:11:09 INFO - 'SHLVL': '1', 07:11:09 INFO - 'TERM': 'linux', 07:11:09 INFO - 'TMOUT': '86400', 07:11:09 INFO - 'USER': 'cltbld', 07:11:09 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1460986938.304110-757000833', 07:11:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:09 INFO - '_': '/tools/buildbot/bin/python'} 07:11:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:10 INFO - Downloading/unpacking blobuploader==1.2.4 07:11: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 07:11: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 07:11: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 07:11: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 07:11: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 07:11: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 07:11:12 INFO - Downloading blobuploader-1.2.4.tar.gz 07:11:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:11:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:11: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 07:11: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 07:11: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 07:11: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 07:11: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 07:11: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 07:11:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:11:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:11: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 07:11: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 07:11: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 07:11: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 07:11: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 07:11: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 07:11:12 INFO - Downloading docopt-0.6.1.tar.gz 07:11:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:11:12 INFO - Installing collected packages: blobuploader, requests, docopt 07:11:12 INFO - Running setup.py install for blobuploader 07:11:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:11:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:11:12 INFO - Running setup.py install for requests 07:11:13 INFO - Running setup.py install for docopt 07:11:13 INFO - Successfully installed blobuploader requests docopt 07:11:13 INFO - Cleaning up... 07:11:13 INFO - Return code: 0 07:11:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:11: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')]} 07:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11: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')]} 07:11:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11: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 0x7f2d848d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfb410>, '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 0x2bfc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bfc7a0>, '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': '8783db0840cc980e80bb0bd400000236-1460986938.304110-757000833', '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 07:11: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 07:11: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 07:11:13 INFO - Using env: {'DISPLAY': ':0', 07:11:13 INFO - 'HOME': '/home/cltbld', 07:11:13 INFO - 'LANG': 'en_US.UTF-8', 07:11:13 INFO - 'LANGUAGE': 'en_US:en', 07:11:13 INFO - 'LOGNAME': 'cltbld', 07:11:13 INFO - 'MAIL': '/var/mail/cltbld', 07:11:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:13 INFO - 'MOZ_NO_REMOTE': '1', 07:11:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:13 INFO - 'NO_EM_RESTART': '1', 07:11:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:13 INFO - 'PWD': '/builds/slave/test', 07:11:13 INFO - 'SHELL': '/bin/bash', 07:11:13 INFO - 'SHLVL': '1', 07:11:13 INFO - 'TERM': 'linux', 07:11:13 INFO - 'TMOUT': '86400', 07:11:13 INFO - 'USER': 'cltbld', 07:11:13 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1460986938.304110-757000833', 07:11:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:13 INFO - '_': '/tools/buildbot/bin/python'} 07:11:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:11:13 INFO - Running setup.py (path:/tmp/pip-jJbhxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:11:13 INFO - Running setup.py (path:/tmp/pip-6EW9gh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:11:13 INFO - Running setup.py (path:/tmp/pip-waUjVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:11:13 INFO - Running setup.py (path:/tmp/pip-Sabpz6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:11:13 INFO - Running setup.py (path:/tmp/pip-FsgCuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:11:13 INFO - Running setup.py (path:/tmp/pip-1cLQ06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:11:14 INFO - Running setup.py (path:/tmp/pip-jFKl85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:11:14 INFO - Running setup.py (path:/tmp/pip-a0obj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:11:14 INFO - Running setup.py (path:/tmp/pip-lEDCeR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:11:14 INFO - Running setup.py (path:/tmp/pip-5puV_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:11:14 INFO - Running setup.py (path:/tmp/pip-lZjX6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:11:14 INFO - Running setup.py (path:/tmp/pip-QVBpcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:11:14 INFO - Running setup.py (path:/tmp/pip-Zf2K_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:11:14 INFO - Running setup.py (path:/tmp/pip-6NhMNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:11:14 INFO - Running setup.py (path:/tmp/pip-GMOk2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:11:14 INFO - Running setup.py (path:/tmp/pip-LwkGJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:11:14 INFO - Running setup.py (path:/tmp/pip-k8rpen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:11:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:11:14 INFO - Running setup.py install for manifestparser 07:11:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:11:15 INFO - Running setup.py install for mozcrash 07:11:15 INFO - Running setup.py install for mozdebug 07:11:15 INFO - Running setup.py install for mozdevice 07:11:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:11:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:11:15 INFO - Running setup.py install for mozfile 07:11:15 INFO - Running setup.py install for mozhttpd 07:11:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:11:15 INFO - Running setup.py install for mozinfo 07:11:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:11:15 INFO - Running setup.py install for mozInstall 07:11:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:11:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:11:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:11:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:11:15 INFO - Running setup.py install for mozleak 07:11:15 INFO - Running setup.py install for mozlog 07:11:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:11:15 INFO - Running setup.py install for moznetwork 07:11:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:11:16 INFO - Running setup.py install for mozprocess 07:11:16 INFO - Running setup.py install for mozprofile 07:11:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:11:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:11:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:11:16 INFO - Running setup.py install for mozrunner 07:11:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:11:16 INFO - Running setup.py install for mozscreenshot 07:11:16 INFO - Running setup.py install for moztest 07:11:16 INFO - Running setup.py install for mozversion 07:11:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:11:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:11:16 INFO - Cleaning up... 07:11:16 INFO - Return code: 0 07:11:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:11: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')]} 07:11:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11: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')]} 07:11:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11: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 0x7f2d848d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfb410>, '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 0x2bfc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bfc7a0>, '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': '8783db0840cc980e80bb0bd400000236-1460986938.304110-757000833', '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 07:11: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 07:11: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 07:11:16 INFO - Using env: {'DISPLAY': ':0', 07:11:16 INFO - 'HOME': '/home/cltbld', 07:11:16 INFO - 'LANG': 'en_US.UTF-8', 07:11:16 INFO - 'LANGUAGE': 'en_US:en', 07:11:16 INFO - 'LOGNAME': 'cltbld', 07:11:16 INFO - 'MAIL': '/var/mail/cltbld', 07:11:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:16 INFO - 'MOZ_NO_REMOTE': '1', 07:11:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:16 INFO - 'NO_EM_RESTART': '1', 07:11:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:16 INFO - 'PWD': '/builds/slave/test', 07:11:16 INFO - 'SHELL': '/bin/bash', 07:11:16 INFO - 'SHLVL': '1', 07:11:16 INFO - 'TERM': 'linux', 07:11:16 INFO - 'TMOUT': '86400', 07:11:16 INFO - 'USER': 'cltbld', 07:11:16 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1460986938.304110-757000833', 07:11:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:16 INFO - '_': '/tools/buildbot/bin/python'} 07:11:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:11:16 INFO - Running setup.py (path:/tmp/pip-imXEnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:11: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)) 07:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:11:17 INFO - Running setup.py (path:/tmp/pip-BM891g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:11: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)) 07:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:11:17 INFO - Running setup.py (path:/tmp/pip-t0ZyYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:11: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)) 07:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:11:17 INFO - Running setup.py (path:/tmp/pip-EF1Y3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:11: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)) 07:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:11:17 INFO - Running setup.py (path:/tmp/pip-0rliqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:11: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)) 07:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:11:17 INFO - Running setup.py (path:/tmp/pip-g3VOFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:11: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)) 07:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:11:17 INFO - Running setup.py (path:/tmp/pip-0C7oUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:11: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)) 07:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:11:17 INFO - Running setup.py (path:/tmp/pip-r6JmzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:11: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)) 07:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:11:17 INFO - Running setup.py (path:/tmp/pip-oNzffO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:11: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)) 07:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:11:17 INFO - Running setup.py (path:/tmp/pip-TBPpah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:11: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)) 07:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:11:17 INFO - Running setup.py (path:/tmp/pip-uJqlH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:11: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)) 07:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:11:17 INFO - Running setup.py (path:/tmp/pip-rZjeQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:11:17 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)) 07:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:11:17 INFO - Running setup.py (path:/tmp/pip-QmFrwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:11:17 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)) 07:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:11:17 INFO - Running setup.py (path:/tmp/pip-uTJzO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:11:17 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)) 07:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:11:18 INFO - Running setup.py (path:/tmp/pip-jbDySC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:11: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)) 07:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:11:18 INFO - Running setup.py (path:/tmp/pip-GhfNEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:11: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)) 07:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:11:18 INFO - Running setup.py (path:/tmp/pip-poEu9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:11: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)) 07:11: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)) 07:11: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)) 07:11: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)) 07:11: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)) 07:11: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)) 07:11:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:11: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 07:11: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 07:11: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 07:11: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 07:11: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 07:11: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 07:11:20 INFO - Downloading blessings-1.6.tar.gz 07:11:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:11:20 INFO - Installing collected packages: blessings 07:11:20 INFO - Running setup.py install for blessings 07:11:20 INFO - Successfully installed blessings 07:11:20 INFO - Cleaning up... 07:11:20 INFO - Return code: 0 07:11:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:11:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:11:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:11:20 INFO - Reading from file tmpfile_stdout 07:11:20 INFO - Current package versions: 07:11:20 INFO - argparse == 1.2.1 07:11:20 INFO - blessings == 1.6 07:11:20 INFO - blobuploader == 1.2.4 07:11:20 INFO - docopt == 0.6.1 07:11:20 INFO - manifestparser == 1.1 07:11:20 INFO - mozInstall == 1.12 07:11:20 INFO - mozcrash == 0.17 07:11:20 INFO - mozdebug == 0.1 07:11:20 INFO - mozdevice == 0.48 07:11:20 INFO - mozfile == 1.2 07:11:20 INFO - mozhttpd == 0.7 07:11:20 INFO - mozinfo == 0.9 07:11:20 INFO - mozleak == 0.1 07:11:20 INFO - mozlog == 3.1 07:11:20 INFO - moznetwork == 0.27 07:11:20 INFO - mozprocess == 0.22 07:11:20 INFO - mozprofile == 0.28 07:11:20 INFO - mozrunner == 6.11 07:11:20 INFO - mozscreenshot == 0.1 07:11:20 INFO - mozsystemmonitor == 0.0 07:11:20 INFO - moztest == 0.7 07:11:20 INFO - mozversion == 1.4 07:11:20 INFO - psutil == 3.1.1 07:11:20 INFO - requests == 1.2.3 07:11:20 INFO - wsgiref == 0.1.2 07:11:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:11:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11: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 0x7f2d848d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfb410>, '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 0x2bfc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bfc7a0>, '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': '8783db0840cc980e80bb0bd400000236-1460986938.304110-757000833', '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 07:11: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 07:11: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 07:11:20 INFO - Using env: {'DISPLAY': ':0', 07:11:20 INFO - 'HOME': '/home/cltbld', 07:11:20 INFO - 'LANG': 'en_US.UTF-8', 07:11:20 INFO - 'LANGUAGE': 'en_US:en', 07:11:20 INFO - 'LOGNAME': 'cltbld', 07:11:20 INFO - 'MAIL': '/var/mail/cltbld', 07:11:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:20 INFO - 'MOZ_NO_REMOTE': '1', 07:11:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:20 INFO - 'NO_EM_RESTART': '1', 07:11:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:20 INFO - 'PWD': '/builds/slave/test', 07:11:20 INFO - 'SHELL': '/bin/bash', 07:11:20 INFO - 'SHLVL': '1', 07:11:20 INFO - 'TERM': 'linux', 07:11:20 INFO - 'TMOUT': '86400', 07:11:20 INFO - 'USER': 'cltbld', 07:11:20 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1460986938.304110-757000833', 07:11:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:20 INFO - '_': '/tools/buildbot/bin/python'} 07:11:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11: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)) 07:11: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)) 07:11: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)) 07:11: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)) 07:11: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)) 07:11: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)) 07:11: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)) 07:11: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)) 07:11: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)) 07:11: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)) 07:11: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)) 07:11:20 INFO - Cleaning up... 07:11:20 INFO - Return code: 0 07:11:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:11:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11: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 0x7f2d848d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfb410>, '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 0x2bfc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bfc7a0>, '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': '8783db0840cc980e80bb0bd400000236-1460986938.304110-757000833', '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 07:11: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 07:11: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 07:11:20 INFO - Using env: {'DISPLAY': ':0', 07:11:20 INFO - 'HOME': '/home/cltbld', 07:11:20 INFO - 'LANG': 'en_US.UTF-8', 07:11:20 INFO - 'LANGUAGE': 'en_US:en', 07:11:20 INFO - 'LOGNAME': 'cltbld', 07:11:20 INFO - 'MAIL': '/var/mail/cltbld', 07:11:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:20 INFO - 'MOZ_NO_REMOTE': '1', 07:11:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:20 INFO - 'NO_EM_RESTART': '1', 07:11:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:20 INFO - 'PWD': '/builds/slave/test', 07:11:20 INFO - 'SHELL': '/bin/bash', 07:11:20 INFO - 'SHLVL': '1', 07:11:20 INFO - 'TERM': 'linux', 07:11:20 INFO - 'TMOUT': '86400', 07:11:20 INFO - 'USER': 'cltbld', 07:11:20 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1460986938.304110-757000833', 07:11:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:20 INFO - '_': '/tools/buildbot/bin/python'} 07:11:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:20 INFO - Downloading/unpacking jsonschema 07:11:20 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 07:11:20 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 07:11:20 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 07:11:20 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 07:11:20 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 07:11:20 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 07:11:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:11:22 INFO - Downloading/unpacking functools32 (from jsonschema) 07:11:22 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 07:11:22 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 07:11:22 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 07:11:22 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 07:11:22 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 07:11:22 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 07:11:23 INFO - Downloading functools32-3.2.3-2.tar.gz 07:11:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:11:23 INFO - warning: no files found matching '*.txt' 07:11:23 INFO - no previously-included directories found matching 'build' 07:11:23 INFO - no previously-included directories found matching 'dist' 07:11:23 INFO - no previously-included directories found matching '.git*' 07:11:23 INFO - Installing collected packages: jsonschema, functools32 07:11:23 INFO - Running setup.py install for functools32 07:11:23 INFO - warning: no files found matching '*.txt' 07:11:23 INFO - no previously-included directories found matching 'build' 07:11:23 INFO - no previously-included directories found matching 'dist' 07:11:23 INFO - no previously-included directories found matching '.git*' 07:11:23 INFO - Successfully installed jsonschema functools32 07:11:23 INFO - Cleaning up... 07:11:23 INFO - Return code: 0 07:11:23 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:11: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')]} 07:11:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11: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')]} 07:11:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11: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 0x7f2d848d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfb410>, '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 0x2bfc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bfc7a0>, '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': '8783db0840cc980e80bb0bd400000236-1460986938.304110-757000833', '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 07:11: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 07:11: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 07:11:23 INFO - Using env: {'DISPLAY': ':0', 07:11:23 INFO - 'HOME': '/home/cltbld', 07:11:23 INFO - 'LANG': 'en_US.UTF-8', 07:11:23 INFO - 'LANGUAGE': 'en_US:en', 07:11:23 INFO - 'LOGNAME': 'cltbld', 07:11:23 INFO - 'MAIL': '/var/mail/cltbld', 07:11:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:23 INFO - 'MOZ_NO_REMOTE': '1', 07:11:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:23 INFO - 'NO_EM_RESTART': '1', 07:11:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:23 INFO - 'PWD': '/builds/slave/test', 07:11:23 INFO - 'SHELL': '/bin/bash', 07:11:23 INFO - 'SHLVL': '1', 07:11:23 INFO - 'TERM': 'linux', 07:11:23 INFO - 'TMOUT': '86400', 07:11:23 INFO - 'USER': 'cltbld', 07:11:23 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1460986938.304110-757000833', 07:11:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:23 INFO - '_': '/tools/buildbot/bin/python'} 07:11:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:23 INFO - Downloading/unpacking flake8 07:11: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 07:11: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 07:11: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 07:11: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 07:11: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 07:11: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 07:11:25 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:11:25 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:11: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 07:11: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 07:11: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 07:11: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 07:11: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 07:11: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 07:11:25 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:11:25 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:11: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 07:11: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 07:11: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 07:11: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 07:11: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 07:11: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 07:11:25 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:11: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 07:11: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 07:11: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 07:11: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 07:11: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 07:11: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 07:11:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:11:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:11:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:11:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:11:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:11:26 INFO - no previously-included directories found matching 'docs/_build' 07:11:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:11:26 INFO - Running setup.py install for pep8 07:11:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:11:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:11:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:11:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:11:26 INFO - no previously-included directories found matching 'docs/_build' 07:11:26 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:11:26 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:11:26 INFO - Cleaning up... 07:11:26 INFO - Return code: 0 07:11:26 INFO - Running post-action listener: _resource_record_post_action 07:11:26 INFO - Running post-action listener: _start_resource_monitoring 07:11:26 INFO - Starting resource monitoring. 07:11:26 INFO - ##### 07:11:26 INFO - ##### Running install step. 07:11:26 INFO - ##### 07:11:26 INFO - Running pre-action listener: _resource_record_pre_action 07:11:26 INFO - Running main action method: install 07:11:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:11:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:11:26 INFO - Reading from file tmpfile_stdout 07:11:26 INFO - Detecting whether we're running mozinstall >=1.0... 07:11:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:11:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:11:26 INFO - Reading from file tmpfile_stdout 07:11:26 INFO - Output received: 07:11:26 INFO - Usage: mozinstall [options] installer 07:11:26 INFO - Options: 07:11:26 INFO - -h, --help show this help message and exit 07:11:26 INFO - -d DEST, --destination=DEST 07:11:26 INFO - Directory to install application into. [default: 07:11:26 INFO - "/builds/slave/test"] 07:11:26 INFO - --app=APP Application being installed. [default: firefox] 07:11:26 INFO - mkdir: /builds/slave/test/build/application 07:11: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'] 07:11: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 07:11:42 INFO - Reading from file tmpfile_stdout 07:11:42 INFO - Output received: 07:11:42 INFO - /builds/slave/test/build/application/firefox/firefox 07:11:42 INFO - Running post-action listener: _resource_record_post_action 07:11:42 INFO - ##### 07:11:42 INFO - ##### Running run-tests step. 07:11:42 INFO - ##### 07:11:42 INFO - Running pre-action listener: _resource_record_pre_action 07:11:42 INFO - Running main action method: run_tests 07:11:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:11:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:11:42 INFO - Python 2.7.3 07:11:42 INFO - Return code: 0 07:11:42 INFO - grabbing minidump binary from tooltool 07:11: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')]} 07:11: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 0x2bfb410>, '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 0x2bfc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bfc7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:11: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 07:11: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 07:11:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:11:42 INFO - Return code: 0 07:11:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:11:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:11:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:11:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:11:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:11:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:11:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:11:43 INFO - Return code: 0 07:11: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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JUzF-dg1RheGjeMudkMTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:11: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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JUzF-dg1RheGjeMudkMTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:11:43 INFO - Using env: {'DISPLAY': ':0', 07:11:43 INFO - 'HOME': '/home/cltbld', 07:11:43 INFO - 'LANG': 'en_US.UTF-8', 07:11:43 INFO - 'LANGUAGE': 'en_US:en', 07:11:43 INFO - 'LOGNAME': 'cltbld', 07:11:43 INFO - 'MAIL': '/var/mail/cltbld', 07:11:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:11:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:11:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:43 INFO - 'MOZ_NO_REMOTE': '1', 07:11:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:11:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:43 INFO - 'NO_EM_RESTART': '1', 07:11:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:43 INFO - 'PWD': '/builds/slave/test', 07:11:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:11:43 INFO - 'SHELL': '/bin/bash', 07:11:43 INFO - 'SHLVL': '1', 07:11:43 INFO - 'TERM': 'linux', 07:11:43 INFO - 'TMOUT': '86400', 07:11:43 INFO - 'USER': 'cltbld', 07:11:43 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1460986938.304110-757000833', 07:11:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:43 INFO - '_': '/tools/buildbot/bin/python'} 07:11: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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JUzF-dg1RheGjeMudkMTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:11:43 INFO - mozversion application_buildid: 20160418054123 07:11:43 INFO - mozversion application_changeset: 6066850740cd4711ee5502fda89f422440b7c2cc 07:11:43 INFO - mozversion application_display_name: Nightly 07:11:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:11:43 INFO - mozversion application_name: Firefox 07:11:43 INFO - mozversion application_remotingname: firefox 07:11:43 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:11:43 INFO - mozversion application_vendor: Mozilla 07:11:43 INFO - mozversion application_version: 48.0a1 07:11:43 INFO - mozversion platform_buildid: 20160418054123 07:11:43 INFO - mozversion platform_changeset: 6066850740cd4711ee5502fda89f422440b7c2cc 07:11:43 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:11:43 INFO - mozversion platform_version: 48.0a1 07:11:43 INFO - using testdate: 1460988703 07:11:43 INFO - actual date: 1460988703 07:11:43 INFO - starting webserver on 'localhost:39982' 07:11:43 INFO - SUITE-START | Running 2 tests 07:11:43 INFO - TEST-START | dromaeo_css 07:11:43 INFO - operating with platform_type : linux_ 07:11:43 INFO - Initialising browser for dromaeo_css test... 07:11:43 INFO - TEST-INFO | started process 15817 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBUqYQK/profile http://localhost:39982/getInfo.html) 07:11:48 INFO - PROCESS | 15817 | __metrics Screen width/height:1600/1200 07:11:48 INFO - PROCESS | 15817 | colorDepth:24 07:11:48 INFO - PROCESS | 15817 | Browser inner width/height: 1024/697 07:11:48 INFO - PROCESS | 15817 | __metrics 07:11:49 ERROR - PROCESS | 15817 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:11:49 INFO - TEST-INFO | 15817: exit 0 07:11:49 INFO - Browser initialized. 07:11:49 INFO - Running cycle 1/1 for dromaeo_css test... 07:11:49 INFO - TEST-INFO | started process 15898 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBUqYQK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:12:01 INFO - PROCESS | 15898 | RSS: Main: 154738688 07:12:01 INFO - PROCESS | 15898 | 07:12:53 INFO - PROCESS | 15898 | 1460988773170 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:15:04 INFO - PROCESS | 15898 | Cycle 1(1): loaded http://localhost:39982/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39982/tests/dromaeo/cssquery-ext.html) 07:15:05 INFO - PROCESS | 15898 | RSS: Main: 233070592 07:15:05 INFO - PROCESS | 15898 | 07:18:07 INFO - PROCESS | 15898 | Cycle 1(1): loaded http://localhost:39982/tests/dromaeo/cssquery-ext.html (next: http://localhost:39982/tests/dromaeo/cssquery-jquery.html) 07:18:08 INFO - PROCESS | 15898 | RSS: Main: 242679808 07:18:08 INFO - PROCESS | 15898 | 07:21:10 INFO - PROCESS | 15898 | Cycle 1(1): loaded http://localhost:39982/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39982/tests/dromaeo/cssquery-mootools.html) 07:21:10 INFO - PROCESS | 15898 | RSS: Main: 233172992 07:21:10 INFO - PROCESS | 15898 | 07:24:13 INFO - PROCESS | 15898 | Cycle 1(1): loaded http://localhost:39982/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39982/tests/dromaeo/cssquery-prototype.html) 07:24:13 INFO - PROCESS | 15898 | RSS: Main: 235368448 07:24:13 INFO - PROCESS | 15898 | 07:27:16 INFO - PROCESS | 15898 | Cycle 1(1): loaded http://localhost:39982/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39982/tests/dromaeo/cssquery-yui.html) 07:27:17 INFO - PROCESS | 15898 | RSS: Main: 215343104 07:27:17 INFO - PROCESS | 15898 | 07:30:19 INFO - PROCESS | 15898 | Cycle 1(1): loaded http://localhost:39982/tests/dromaeo/cssquery-yui.html (next: http://localhost:39982/tests/dromaeo/cssquery-dojo.html) 07:30:20 INFO - PROCESS | 15898 | RSS: Main: 275542016 07:30:20 INFO - PROCESS | 15898 | 07:30:20 INFO - PROCESS | 15898 | __start_tp_report 07:30:20 INFO - PROCESS | 15898 | _x_x_mozilla_page_load 07:30:20 INFO - PROCESS | 15898 | _x_x_mozilla_page_load_details 07:30:20 INFO - PROCESS | 15898 | |i|pagename|runs| 07:30:20 INFO - PROCESS | 15898 | |0;dojo.html;2575.729548397418;2642.8546429946346;2655.5352813257673;2659.74732400422;2675.78593712503;4440.37834703141;4542.8864278392975;4552.29439436887;4560.794764235609;4578.610818080467;4573.656975726825;4602.631789456844;4606.239970404888;4657.0453057123295;4673.1821931162085;4183.247015537202;4184.853530126438;4238.851640192594;4269.957300426987;4310.806013729374;4220.1348723511755;4280.3793449949735;4287.571242875703;4327.978360108195;4334.653227741789;4124.154548317588;4173.436586060873;4212.389203565496;4228.4080228768;4267.4025636410925;4222.683298752606;4254.234237837188;4262.1049579588325;4265.104328091104;4311.396404503372;4193.5387107418155;4219.1139860629;4219.514755803091;4250.022494826177;4252.319628859399;4342.739435633841;4456.77716114193;4470.552944705503;4518.932216016762;4527.4340707411575;4848.127337079324;4865.391826021747;4891.241857512091;4897.1674815281485;4939.481354457766;4873.171560834631;4907.9263811042865;4911.263310503417;4913.336699545587;4915.188993816016;4450.10997800438;4624.5144259852905;4695.671303008825;4696.788644511005;4698.201305778026;4970.329005584272;4975.651704380659;4988.575971042429;4996.950640365564;5028.220625803006;4612.238980568169;4775.95224047762;4778.784954677048;4783.162946484351;4790.856274311706;4887.804487820447;4902.950970490249;4904.852854414374;4927.457979622239;4945.23348880924;4809.398825146856;4873.220284754422;4881.8535443936735;4883.58489528387;4888.095702295087;4700.365450664117;4817.8313759018265;4859.586935110485;4874.683145595525;4921.114199444063;4195;4195.202911446815;4217;4223.345381465878;4242.936355954663;3646.9817650911577;3653.8903832885057;3662.908427289339;3685.355062863988;3702.4816525686424;4119.546849846514;4191.11986482842;4231.597998190167;4240.151969606091;4243.8090285937205;4917.729524876095;4924.9507504925205;4931.48219436954;4949.950500494949;4968.950310496921;3982.48227730399;4044.8876558946527;4233.491980962242;4258.446401967724;4285.5071666758095;4298.570142985739;4395.340698895191;4433.911321773547;4440.4227450431235;4480.507144214133;4592.471865735483;4618.861434156981;4627.282771170474;4642.1644104060915;4652.13935421948;4862.805487780449;4874.22012478016;4882.511748825089;4884.7069175849565;4932.679375840559;4486.013077123028;4600.516945720785;4638.721676699409;4700.318453824245;4724.173269677862;4824.879378015437;4828.830990915301;4844.079624871263;4845.854624361275;4901.044296362318;4886.462489126265;4904.779284932115;4905.656604037826;4912.238603016538;4960.553550180501;4693.882652933567;4769.833055843029;4796.904061918673;4812.470628230962;4846.418429788448;4679.3916790816975;4695.201815691409;4711.528847115261;4719.3156992235245;4742.478327383916;4624.468186158635;4655.138799322136;4674.158651442773;4678.50875658051;4721.929171062506;4748.3352330674425;4800.615950724004;4806.759662016815;4836.347093142381;4837.540433658797;4642.16441040616;4648.070385922897;4652.767361631837;4676.6492513060975;4735.076660051257 07:30:20 INFO - PROCESS | 15898 | |1;ext.html;592.1443514122093;592.5348601347943;610.41095342994;625.2497003595684;638.9424951754341;33438.16404589886;35190.648093519056;35217;35223.82388088063;35255.29489410217;40312;41402.7929860351;41465.378019329735;41481.377779333256;41535.58464415355;7679.500832445887;7946.562939038351;7947.443678942476;7950.204979502061;7954.721584744535;7763.844723105534;7844.2155784421675;7882.448228623999;7882.566458844762;7883.054033515986;7854.3716502679645;7929.365650747955;7931.444798864082;7937.682492700314;7940.483868548555;7819.921800781976;7873.645685944118;7883.487573307717;7883.763487095396;7888.447808653396;7817.765467035998;7924.80187995299;7925.048994120685;7927.286544211049;7928.167542408022;37699.434508482394;38221.42667859984;38232;38276.80861595702;38331.808340958116;2976.836274004929;2997.2207226121363;3069.600951876264;3142.7328677062246;3582.8208589570677;28814.711852881414;29008.734753974404;29180.8540957296;29906.252343691365;30084.8495757522;3410.0963244740165;3410.38613049651;3446.7070299024363;3447.7414193935556;3496.021114088059;272319;275729;276435;277105.6144719284;277992;51167.97664046698;52718;52961.735191323794;53080;53087.46912530903;51483.48516514787;61105;62754.372456274854;62897.68551157215;62937.37062629407;13383.263920484467;13635.727285454235;13656.453741850413;13663.658408539668;13668.316584170752;9021.729348119567;9435.339526233098;9449.196818270524;9468.431894086378;9865.75335616601;17847.46457606274;17916.283348665907;17932.820671793375;17951.551211219823;18013.549661258574;6813.659317034128;6964.686589103401;6989.7553585624255;7062.081929349254;7109.964450177716;818.145038434837;860.4192170285032;893.7274131389859;924.9953750231206;952.7760976170595;26965.865170674413;27163.86418067897;27500;27766.722332776415;27831.860840695666;958.3148049144895;959.4291396619001;1015.791762688647;1026.8049070676548;1039.7244730146517;14407.135571865721;15036.699266014837;15037.368460519585;16058.197090145446;16313.755293670605;337131;342399;344440;344494;344768;49891.750541247064;50671.49328506668;50705;50757;50769.907611086164;1104.5526561742506;1156.6125348008343;1281.3529167770403;1286.2154086007529;1286.5111257722006;24376;27261;27296.454070918866;27511.724882751718;27614.585781212896;39478.60521394749;40290.395644064774;40331;40378;40397;243432;249150;249705;250148;250218;22127.889360553094;22865;24573.385665357793;25284.367890802878;25876.61185082263;38953.80523097367;39182.41226381664;39281;39502.40746388749;39996.400053999794;31234.843825780725;33838.32323353568;33909.830450847585;34131.82934085314;34372;32494.67505325011;33018.504722428705;33501.32997339991;33506.66493335035;33609.83195084009;33116.668833311356;33420.832895836335;34011.82994085014;34098.31803363968;34102.317953641286;29129.271768205963;29819.25451863634;30003.242461277183;30208.848955755082;30223.546646799874;23537.293881183592;23776.40558986039;23961.400964976016;23994.28017159488;24168.516629666956 07:30:20 INFO - PROCESS | 15898 | |2;jquery.html;382;384.7556801431092;386.6500816760832;395.483893518958;395.97426167299125;16299.59251018725;17092.316307347723;17212;17252.223649935753;17266.309347626095;16412.425565105223;16823.158842057877;17031.48905532836;17067.573310667238;17128.229229684664;5033.899322013557;5252.028374750684;5273.367195936493;5290.497402746733;5303.496167864047;3691.53855768029;5682.715864206793;6011.5190784737115;6015.0676645120075;6028.668423236721;4983.775730092137;5953.940460595382;5961.046232602785;5962.314333851619;5996.130561068642;5196.818111366084;5211.5309622134;5250.133727934886;5262.473752624726;5263.26314315996;3281.2125089978235;3487.0410637074756;3492.7729697569575;3493.2489514754448;4798.2802579613335;12439.75120497585;12466.563670271587;14206.147631142165;19818.80181198184;20327.5934481311;1878.6524492968845;1889.2159753702197;1890.3273964002638;1978.2482656590403;2001.729766481521;8605.913940860637;8696.608652610648;9112.498812565307;9145.81708365829;9204.539773011322;1738.148307329412;1750.474857542732;1753.0533511903684;1760.9647807043787;1805.4312891439154;66460.6676966617;69461.65269173673;69759.30240697629;70277.64861175764;70365.29634703639;9757.902420975699;9806;9916;10030.348027378197;10125;13811.378487968066;13942.302884855717;13960.511382101578;13964.930175349058;13989.930050349683;6937.7679615434545;7010.334018268256;7019.5086343956455;7021.648917554102;7080.398166155935;6385.45723613498;6472.190976127984;6573.718124965586;6578.934210657928;6738.764143255061;4307.418498502662;4355.803988820448;4381.539938306496;4453.265211240109;4460.955390446119;1683.7979442466983;1694.618710790087;1728.196388679245;1803.819618038212;1822.8177182281931;897.2194191053694;897.3583887520455;912.9406588571721;933.421278807144;947.1333729637305;15314.234288285541;16074.035557866566;16666.916665416597;16694.749578756328;16941;864.5936409887343;900.7162743735702;938.4885237545418;944.1408318430196;948.7580666930027;9090.818183636291;9472.431654100637;9479.857802132974;9516.95241523788;9576.138147566753;401543;403115;404513;405592;406243;74153.6292318535;75946.62026689942;76393;76524.61737691387;77096.22903770891;914.3279689428398;915.0620613870702;928.7631653928205;931.4364809290417;932.9067093290616;14643.56069317922;14723.263836807902;14733.116013039253;14779.187144707144;15136.167510787012;33232.516634755964;34030.31939361248;35510.579576816635;35746.92759217227;36123.458148127276;42936;43242.56757432511;44978.3253251208;45293.32060019037;46095.76952115218;7441.181470038183;7586.3930885527925;7592.8481430372185;7637.847243054996;7690.077190737147;7106.609136497542;11521.193516453768;11615.419229038345;12212.450439730055;12230.571929982409;9745.463999480096;10071.093601575893;10298.433586152834;10719.946400268262;10781.353118812896;10325.74185645365;10356.378617282988;10417.16662667;10525.210609204494;10576.629817956335;10655.733606659896;10692.62575809843;10736.355818650905;11176.497057632589;11183.930972770064;7844.4901081429525;7961.72133975308;7963.761087167394;7971.481853679492;8135.877961830459;8120.512769233865;9427;9870.753231169278;9962.950185249027;10183 07:30:20 INFO - PROCESS | 15898 | |3;mootools.html;1228.1709845854045;1446.7251222267769;1469.3828591991364;1614.878884083694;1813.4831573001698;6501.349865013496;7524.172341042481;7778.766637000885;7791.493552919056;7800.8049798755055;7495.213002634713;7655.15793262742;7659.961700191491;7677.3090421862025;7682.462227644067;1866.9346572869952;2162.9891850540725;2188.8248940084754;2190.8356873234493;2269.9432514187197;2266.1388672304583;2277.954440911189;2279.9316020519327;2289.919852805152;2290.1640901071155;2199.571083638691;2242.4618091657967;2244.3154837774473;2245.438640339915;2247.056236380724;1816.5821860971985;2156.55790562935;2240.327901629521;2241.3612120545567;2242.495438526335;2152.2682288022147;2155.687425323335;2173.3262688566597;2173.467500462381;2195.056125865877;7629;7642.273983971514;7687.96156019222;7690.2694244046725;7695.6152192390155;4578.473475550321;4740.454847692525;4750.71495710255;4756.809727610891;4814.927776083362;2858.7141285871453;2902.1728807290033;2942.440936222111;2974.73227409532;2974.762019038472;807.2129673568282;812.5530957973091;819.9344052475848;826.1614461321764;830.7839961609965;10699.83950240747;10715.892841071567;10720.035196832245;10736.516856741466;10744.086752626035;4153.979230103831;4234.364845273234;4393.758343291086;4429.822807087745;4461.709988850715;9061.818763624822;9074.773130671654;9092.36353455265;9094.090590940854;9101.863472047924;4049.372347286175;4830.565249127525;4832.057748739033;4850.369451971221;4865.440474345425;4015.377616469452;4132.876013719593;4136.276151673445;4136.338185890243;4149.937750933738;3688.5758137814496;3691.4093745000673;3768.6419790119894;3817.61823817616;3841;1231.8768123187788;1244.4835393311673;1259.9874001260052;1268.8604253532103;1273.0770191611007;741.6365980669541;769.6959700918218;782.8160382310152;853.6542700206427;857.7726902370877;5283.9471605284225;5339.065663508871;5356.491133342326;5420.457954204627;5465.508104270635;800.6357107516067;812.8780682897494;813.1137060603852;853.9615717292737;867.5011868175824;3698.389765688631;3733.085394078468;3790.128270497801;3798;3835.5780864104927;9436.905630943602;9666.75833104164;9806.31355805101;9848.359856609297;9908.306418550632;9715.61137554504;9728.562214700356;9743.561539730586;9752.26857985654;9787.706368808947;6957.686904089328;7263.673134708951;7391.926080739231;7398.112226532743;7400.222976587381;5180.274761533464;5218.66078704883;5249.816256431007;5262.263283140287;5417.6478528895495;8554.27288680469;8560.743177704679;8756.868646970428;8772.824543509221;8852.867206992029;8708.433951793113;8803.603837827184;8938.553072346227;8999.730008099768;9007.594658240263;5816.41835816415;6035.6076855004285;6038.124471951454;6803.081583986296;6958.965205173941;6454.580452270775;6818.659067046528;7398.445116616168;7422.220666830121;7453.850922981618;6607.438367738604;6674.766383176566;6729.192496900403;6740.831479212863;6749.3250674932115;6471.4822814175695;6498.180509457359;6525.151730275224;6688.565243259172;6725.0248713935225;6230.127782110418;6292.087647291209;6298.244210694746;6298.622082675054;6340.144080549251;4549.385832912647;4581.312803079565;4699.459562150397;4703.176944034712;4759.309900064402;4513.571210734975;4572.1312950539295;4680.368150299666;4691.225947718588;4700.929486057644 07:30:20 INFO - PROCESS | 15898 | |4;prototype.html;307.40517099412637;311.91734190439536;316.765593460839;321.22424345206326;324.6769464382936;4979.452260251374;4988.27669987852;4994.101061808873;5008.599312055036;5075.020741910658;4923.384576927884;4963.305137280783;4969.378827646544;4979.925301120486;4990.328240039582;3728.1984373359724;3796.8291426885717;3956.1494278730065;3964.603539646041;3984.621460961204;3949.328614135604;3956;3966.504186976628;3971.324874771296;3973.086190176261;3619.94570081449;3902.590228026059;3936.2127574485075;3937.940930886039;3953.6639385652256;3750.0999760057525;3917.5103112110987;3926.1362500249897;3937.6652984496354;3937.9803100984454;3468.670476304747;3487.337405892872;3494.6505349465106;3497.108237399447;3497.562804649419;4825.831095911626;4827.106985207748;4829.396325459317;4831.710097394132;4835.758212089417;4226.429432026668;4438.245498265303;4444.11117776446;4444.422225110748;4511.488651301818;5194.831162988336;5206.114960456732;5211.348581427322;5233.895322093575;5251.10731175701;3644.835982380799;3687.3178461984617;3691.8338674759702;3701.3535322244456;3707.703383729295;5382.273393091921;5467;5486.039943009957;5524.530414914737;5535.474129957647;3891.9610803892165;3898.4542164097047;3902.434147048662;3912;3912.4326972588815;3964.1080756829483;3974.682025437958;3979.820908059144;3980.1641655252142;3998.140399814054;4365.232081007197;4435.223835828717;4459.397981272552;4460.241758900995;4473.865784026484;5210.947890521046;5219.5041471060185;5233.555147812479;5244.082285600005;5265;1375.3948262764352;1385.4873696732272;1387.7016441465134;1388.8402833674054;1390.4716207841159;883.6862913665556;884.195382202193;960.5869476125333;961.3847137831793;977.5063592885547;4539.776758501435;4555.157295900269;4610.625527853158;4615.30770384445;4624.421947256593;5359.812406565751;5368.4631536846;5375.3280839895015;5387.81142660005;5396.433374495621;4403.053343531156;4542.477615074243;4585.747783871852;4590.380298659705;4598.540145985442;2897.9565306520417;2902.4050069735654;2919.854007299669;2924.1958461422855;2930.3113768264443;5132.28148059272;5133.409657889316;5146.768395422215;5158.561522270574;5161.38063432383;5364.195370694349;5565.4677121909435;5589.776408943678;5600.971995139998;5621.634593751393;5099.56653684441;5130.666506677054;5164.9999999999245;5170.1469257572835;5178.197379406198;5467;5471.863203419946;5471.890562188813;5473.658953556404;5474.479924407175;5099.770510327118;5359.812406565751;5359.919601205907;5360.142377219626;5388.946110538845;5136.845894623168;5144.948550514447;5149.562287205629;5152.227165925141;5164.612654051037;3750.568684601306;3774.8864085094415;3785.242951409784;3787.337215987136;3800.619938006177;5184.45563215872;5438.401775804738;5441.83674489766;5442.401335853132;5477.123660214346;4975.10448119342;5086.18621020635;5252.40006196935;5292.629515933848;5298.178782288752;5227.3465816772905;5267.2889159962915;5269.42036376006;5278.208268759717;5280.471952804843;5184.377874655065;5188.58491320701;5196.480351964773;5209.453007434165;5222.55608273301;5072.5688316493515;5327.280817089798;5363.088274993339;5368.114261146867;5374.570034397317;5223.112070948024;5224.164133738584;5239.921401178909;5247.475252474875;5247.501487358695 07:30:20 INFO - PROCESS | 15898 | |5;yui.html;581.7324030945765;583.3437382944187;595.1578516399295;643.9437094129706;683.3678847066462;10280.897191028087;10720.78558428833;11094.112471002321;11277.605283815057;11343.205975581703;13496.730065398686;13592.456301747943;13624.250666213355;13640.727185456284;13659.590212293622;645.1451826330108;668.261570964085;668.8194187569353;669.213673933129;809.7854068671807;819.9918000819976;825.7894236969595;826.6775957376628;826.8842362069315;827.1191181391798;863.4775960543875;864.511550973701;871.877937088808;871.9215270625642;872.4329186029069;861.2119910282115;863.935204859638;864.0409145848104;864.2222000199807;865.0441262405014;634.5589815078522;635.678982114034;635.7647670361949;635.7901892375551;636.0268788753215;11294.983451489323;11315.321080735182;11337.943310283395;11379.487923043484;11385.943070284678;12481;12556.372181390894;12613.432395542222;12651;12908.548200812926;9541.570629321697;9730.270229732798;9812.509374531244;9997.15024222942;10023.148032417253;4106.240345536085;4122.91754164915;4169.687273454503;4282.314829627245;4323.07053983392;43124.568754312684;44100.77949610264;44167.77916110399;44382.77808610968;44391.77804110959;9322.48726320059;9324.90675093254;9356.719298421058;9392.389494682824;9465.290103242147;14719.705605888037;15151.696966060837;15274.31265593051;15310;15331.770023449657;6259.843503912348;6503.804885853432;6595.70319335631;6629.834254143685;6632.436242919406;3718.8326525306425;3729.272791805572;3763.6236376362695;3785.167263202091;3852.8651497197466;2828.7454129128478;2919.678835328112;2925.166327596667;2961;2966.036038287522;534.2120372450604;539.2935254816203;544.2652419234003;548.7722595123059;549.0309603549738;485.5241862974305;522.3888050980286;549.7114015142002;588.6350462713145;625.8873402787451;7691.538507689556;7770.805729856799;7836.138024817265;7893.486923349964;8084.919150808417;582.251806428737;597.8146774499919;600.2616781358865;618.0852338538988;624.6408315218767;3817.5800661927165;3903.6486716195677;3929.390944403622;4003.0592810689463;4007.5992400760274;51073.233901491505;53040.73479632577;53135.73432132815;53199.468005320225;53211.46788532143;45431.772841135586;46799;47134;47242.5275747245;47579;41520.79239603843;41941.161176776295;42498.15003699971;42706.57293427088;43667.12665746667;7270.454715896223;7498.100227972678;7515.511491753018;7728.806779830325;7736.7678969631;27738.44523109567;28517.144485665463;28683.713162868105;28839.855800720863;29193.416131677674;34107.31785364328;37917;38249.61750382461;38389.80805096068;39273;9014.32392570573;9041.728748137566;9122.680706175252;9132.908670913472;9194.31042671789;10392.116670082825;10475.16198704117;10707.678769636923;10865.78268434611;11094.722631933942;9863.704088877344;9899.257555683496;9928.15610673072;10019.348742331726;10107.191424686154;8958.955205224192;8997.145271199226;9048.095190480899;9115.498647574446;9356.859647105435;9059.728208153765;9212.401193922373;9310.627574896927;9349.298802589698;9692.515374231401;7667.539947603162;7826.221228226652;7828.45200835936;7848.568328741746;7938.642761075881;8127.471714338549;8449.915500845158;8527.957360213408;8587.742367728979;8599.656013759379 07:30:20 INFO - PROCESS | 15898 | __end_tp_report 07:30:20 INFO - PROCESS | 15898 | __start_cc_report 07:30:20 INFO - PROCESS | 15898 | _x_x_mozilla_cycle_collect,914 07:30:20 INFO - PROCESS | 15898 | __end_cc_report 07:30:20 INFO - PROCESS | 15898 | __startTimestamp1460989820241__endTimestamp 07:30:20 INFO - PROCESS | 15898 | 07:30:20 INFO - PROCESS | 15898 | ------- Summary: start ------- 07:30:20 INFO - PROCESS | 15898 | Number of tests: 6 07:30:20 INFO - PROCESS | 15898 | 07:30:20 INFO - PROCESS | 15898 | [#0] dojo.html Cycles:165 Average:4527.59 Median:4652.77 stddev:456.44 (9.8%) stddev-sans-first:431.39 07:30:20 INFO - PROCESS | 15898 | Values: 2575.7 2642.9 2655.5 2659.7 2675.8 4440.4 4542.9 4552.3 4560.8 4578.6 4573.7 4602.6 4606.2 4657.0 4673.2 4183.2 4184.9 4238.9 4270.0 4310.8 4220.1 4280.4 4287.6 4328.0 4334.7 4124.2 4173.4 4212.4 4228.4 4267.4 4222.7 4254.2 4262.1 4265.1 4311.4 4193.5 4219.1 4219.5 4250.0 4252.3 4342.7 4456.8 4470.6 4518.9 4527.4 4848.1 4865.4 4891.2 4897.2 4939.5 4873.2 4907.9 4911.3 4913.3 4915.2 4450.1 4624.5 4695.7 4696.8 4698.2 4970.3 4975.7 4988.6 4997.0 5028.2 4612.2 4776.0 4778.8 4783.2 4790.9 4887.8 4903.0 4904.9 4927.5 4945.2 4809.4 4873.2 4881.9 4883.6 4888.1 4700.4 4817.8 4859.6 4874.7 4921.1 4195.0 4195.2 4217.0 4223.3 4242.9 3647.0 3653.9 3662.9 3685.4 3702.5 4119.5 4191.1 4231.6 4240.2 4243.8 4917.7 4925.0 4931.5 4950.0 4969.0 3982.5 4044.9 4233.5 4258.4 4285.5 4298.6 4395.3 4433.9 4440.4 4480.5 4592.5 4618.9 4627.3 4642.2 4652.1 4862.8 4874.2 4882.5 4884.7 4932.7 4486.0 4600.5 4638.7 4700.3 4724.2 4824.9 4828.8 4844.1 4845.9 4901.0 4886.5 4904.8 4905.7 4912.2 4960.6 4693.9 4769.8 4796.9 4812.5 4846.4 4679.4 4695.2 4711.5 4719.3 4742.5 4624.5 4655.1 4674.2 4678.5 4721.9 4748.3 4800.6 4806.8 4836.3 4837.5 4642.2 4648.1 4652.8 4676.6 4735.1 07:30:20 INFO - PROCESS | 15898 | 07:30:20 INFO - PROCESS | 15898 | [#1] ext.html Cycles:180 Average:44429.09 Median:174107.87 stddev:76542.25 (44.0%) stddev-sans-first:76686.21 07:30:20 INFO - PROCESS | 15898 | Values: 592.1 592.5 610.4 625.2 638.9 33438.2 35190.6 35217.0 35223.8 35255.3 40312.0 41402.8 41465.4 41481.4 41535.6 7679.5 7946.6 7947.4 7950.2 7954.7 7763.8 7844.2 7882.4 7882.6 7883.1 7854.4 7929.4 7931.4 7937.7 7940.5 7819.9 7873.6 7883.5 7883.8 7888.4 7817.8 7924.8 7925.0 7927.3 7928.2 37699.4 38221.4 38232.0 38276.8 38331.8 2976.8 2997.2 3069.6 3142.7 3582.8 28814.7 29008.7 29180.9 29906.3 30084.8 3410.1 3410.4 3446.7 3447.7 3496.0 272319.0 275729.0 276435.0 277105.6 277992.0 51168.0 52718.0 52961.7 53080.0 53087.5 51483.5 61105.0 62754.4 62897.7 62937.4 13383.3 13635.7 13656.5 13663.7 13668.3 9021.7 9435.3 9449.2 9468.4 9865.8 17847.5 17916.3 17932.8 17951.6 18013.5 6813.7 6964.7 6989.8 7062.1 7110.0 818.1 860.4 893.7 925.0 952.8 26965.9 27163.9 27500.0 27766.7 27831.9 958.3 959.4 1015.8 1026.8 1039.7 14407.1 15036.7 15037.4 16058.2 16313.8 337131.0 342399.0 344440.0 344494.0 344768.0 49891.8 50671.5 50705.0 50757.0 50769.9 1104.6 1156.6 1281.4 1286.2 1286.5 24376.0 27261.0 27296.5 27511.7 27614.6 39478.6 40290.4 40331.0 40378.0 40397.0 243432.0 249150.0 249705.0 250148.0 250218.0 22127.9 22865.0 24573.4 25284.4 25876.6 38953.8 39182.4 39281.0 39502.4 39996.4 31234.8 33838.3 33909.8 34131.8 34372.0 32494.7 33018.5 33501.3 33506.7 33609.8 33116.7 33420.8 34011.8 34098.3 34102.3 29129.3 29819.3 30003.2 30208.8 30223.5 23537.3 23776.4 23961.4 23994.3 24168.5 07:30:20 INFO - PROCESS | 15898 | 07:30:20 INFO - PROCESS | 15898 | [#2] jquery.html Cycles:180 Average:24214.53 Median:4417.40 stddev:66595.50 (1507.6%) stddev-sans-first:66758.28 07:30:20 INFO - PROCESS | 15898 | Values: 382.0 384.8 386.7 395.5 396.0 16299.6 17092.3 17212.0 17252.2 17266.3 16412.4 16823.2 17031.5 17067.6 17128.2 5033.9 5252.0 5273.4 5290.5 5303.5 3691.5 5682.7 6011.5 6015.1 6028.7 4983.8 5953.9 5961.0 5962.3 5996.1 5196.8 5211.5 5250.1 5262.5 5263.3 3281.2 3487.0 3492.8 3493.2 4798.3 12439.8 12466.6 14206.1 19818.8 20327.6 1878.7 1889.2 1890.3 1978.2 2001.7 8605.9 8696.6 9112.5 9145.8 9204.5 1738.1 1750.5 1753.1 1761.0 1805.4 66460.7 69461.7 69759.3 70277.6 70365.3 9757.9 9806.0 9916.0 10030.3 10125.0 13811.4 13942.3 13960.5 13964.9 13989.9 6937.8 7010.3 7019.5 7021.6 7080.4 6385.5 6472.2 6573.7 6578.9 6738.8 4307.4 4355.8 4381.5 4453.3 4461.0 1683.8 1694.6 1728.2 1803.8 1822.8 897.2 897.4 912.9 933.4 947.1 15314.2 16074.0 16666.9 16694.7 16941.0 864.6 900.7 938.5 944.1 948.8 9090.8 9472.4 9479.9 9517.0 9576.1 401543.0 403115.0 404513.0 405592.0 406243.0 74153.6 75946.6 76393.0 76524.6 77096.2 914.3 915.1 928.8 931.4 932.9 14643.6 14723.3 14733.1 14779.2 15136.2 33232.5 34030.3 35510.6 35746.9 36123.5 42936.0 43242.6 44978.3 45293.3 46095.8 7441.2 7586.4 7592.8 7637.8 7690.1 7106.6 11521.2 11615.4 12212.5 12230.6 9745.5 10071.1 10298.4 10719.9 10781.4 10325.7 10356.4 10417.2 10525.2 10576.6 10655.7 10692.6 10736.4 11176.5 11183.9 7844.5 7961.7 7963.8 7971.5 8135.9 8120.5 9427.0 9870.8 9963.0 10183.0 07:30:20 INFO - PROCESS | 15898 | 07:30:20 INFO - PROCESS | 15898 | [#3] mootools.html Cycles:180 Average:5122.05 Median:5347.78 stddev:2844.30 (53.2%) stddev-sans-first:2837.22 07:30:20 INFO - PROCESS | 15898 | Values: 1228.2 1446.7 1469.4 1614.9 1813.5 6501.3 7524.2 7778.8 7791.5 7800.8 7495.2 7655.2 7660.0 7677.3 7682.5 1866.9 2163.0 2188.8 2190.8 2269.9 2266.1 2278.0 2279.9 2289.9 2290.2 2199.6 2242.5 2244.3 2245.4 2247.1 1816.6 2156.6 2240.3 2241.4 2242.5 2152.3 2155.7 2173.3 2173.5 2195.1 7629.0 7642.3 7688.0 7690.3 7695.6 4578.5 4740.5 4750.7 4756.8 4814.9 2858.7 2902.2 2942.4 2974.7 2974.8 807.2 812.6 819.9 826.2 830.8 10699.8 10715.9 10720.0 10736.5 10744.1 4154.0 4234.4 4393.8 4429.8 4461.7 9061.8 9074.8 9092.4 9094.1 9101.9 4049.4 4830.6 4832.1 4850.4 4865.4 4015.4 4132.9 4136.3 4136.3 4149.9 3688.6 3691.4 3768.6 3817.6 3841.0 1231.9 1244.5 1260.0 1268.9 1273.1 741.6 769.7 782.8 853.7 857.8 5283.9 5339.1 5356.5 5420.5 5465.5 800.6 812.9 813.1 854.0 867.5 3698.4 3733.1 3790.1 3798.0 3835.6 9436.9 9666.8 9806.3 9848.4 9908.3 9715.6 9728.6 9743.6 9752.3 9787.7 6957.7 7263.7 7391.9 7398.1 7400.2 5180.3 5218.7 5249.8 5262.3 5417.6 8554.3 8560.7 8756.9 8772.8 8852.9 8708.4 8803.6 8938.6 8999.7 9007.6 5816.4 6035.6 6038.1 6803.1 6959.0 6454.6 6818.7 7398.4 7422.2 7453.9 6607.4 6674.8 6729.2 6740.8 6749.3 6471.5 6498.2 6525.2 6688.6 6725.0 6230.1 6292.1 6298.2 6298.6 6340.1 4549.4 4581.3 4699.5 4703.2 4759.3 4513.6 4572.1 4680.4 4691.2 4700.9 07:30:20 INFO - PROCESS | 15898 | 07:30:20 INFO - PROCESS | 15898 | [#4] prototype.html Cycles:180 Average:4373.91 Median:4984.10 stddev:1263.23 (25.3%) stddev-sans-first:1229.34 07:30:20 INFO - PROCESS | 15898 | Values: 307.4 311.9 316.8 321.2 324.7 4979.5 4988.3 4994.1 5008.6 5075.0 4923.4 4963.3 4969.4 4979.9 4990.3 3728.2 3796.8 3956.1 3964.6 3984.6 3949.3 3956.0 3966.5 3971.3 3973.1 3619.9 3902.6 3936.2 3937.9 3953.7 3750.1 3917.5 3926.1 3937.7 3938.0 3468.7 3487.3 3494.7 3497.1 3497.6 4825.8 4827.1 4829.4 4831.7 4835.8 4226.4 4438.2 4444.1 4444.4 4511.5 5194.8 5206.1 5211.3 5233.9 5251.1 3644.8 3687.3 3691.8 3701.4 3707.7 5382.3 5467.0 5486.0 5524.5 5535.5 3892.0 3898.5 3902.4 3912.0 3912.4 3964.1 3974.7 3979.8 3980.2 3998.1 4365.2 4435.2 4459.4 4460.2 4473.9 5210.9 5219.5 5233.6 5244.1 5265.0 1375.4 1385.5 1387.7 1388.8 1390.5 883.7 884.2 960.6 961.4 977.5 4539.8 4555.2 4610.6 4615.3 4624.4 5359.8 5368.5 5375.3 5387.8 5396.4 4403.1 4542.5 4585.7 4590.4 4598.5 2898.0 2902.4 2919.9 2924.2 2930.3 5132.3 5133.4 5146.8 5158.6 5161.4 5364.2 5565.5 5589.8 5601.0 5621.6 5099.6 5130.7 5165.0 5170.1 5178.2 5467.0 5471.9 5471.9 5473.7 5474.5 5099.8 5359.8 5359.9 5360.1 5388.9 5136.8 5144.9 5149.6 5152.2 5164.6 3750.6 3774.9 3785.2 3787.3 3800.6 5184.5 5438.4 5441.8 5442.4 5477.1 4975.1 5086.2 5252.4 5292.6 5298.2 5227.3 5267.3 5269.4 5278.2 5280.5 5184.4 5188.6 5196.5 5209.5 5222.6 5072.6 5327.3 5363.1 5368.1 5374.6 5223.1 5224.2 5239.9 5247.5 5247.5 07:30:20 INFO - PROCESS | 15898 | 07:30:20 INFO - PROCESS | 15898 | [#5] yui.html Cycles:180 Average:12293.44 Median:565.72 stddev:14319.40 (2531.2%) stddev-sans-first:14332.56 07:30:20 INFO - PROCESS | 15898 | Values: 581.7 583.3 595.2 643.9 683.4 10280.9 10720.8 11094.1 11277.6 11343.2 13496.7 13592.5 13624.3 13640.7 13659.6 645.1 668.3 668.8 669.2 809.8 820.0 825.8 826.7 826.9 827.1 863.5 864.5 871.9 871.9 872.4 861.2 863.9 864.0 864.2 865.0 634.6 635.7 635.8 635.8 636.0 11295.0 11315.3 11337.9 11379.5 11385.9 12481.0 12556.4 12613.4 12651.0 12908.5 9541.6 9730.3 9812.5 9997.2 10023.1 4106.2 4122.9 4169.7 4282.3 4323.1 43124.6 44100.8 44167.8 44382.8 44391.8 9322.5 9324.9 9356.7 9392.4 9465.3 14719.7 15151.7 15274.3 15310.0 15331.8 6259.8 6503.8 6595.7 6629.8 6632.4 3718.8 3729.3 3763.6 3785.2 3852.9 2828.7 2919.7 2925.2 2961.0 2966.0 534.2 539.3 544.3 548.8 549.0 485.5 522.4 549.7 588.6 625.9 7691.5 7770.8 7836.1 7893.5 8084.9 582.3 597.8 600.3 618.1 624.6 3817.6 3903.6 3929.4 4003.1 4007.6 51073.2 53040.7 53135.7 53199.5 53211.5 45431.8 46799.0 47134.0 47242.5 47579.0 41520.8 41941.2 42498.2 42706.6 43667.1 7270.5 7498.1 7515.5 7728.8 7736.8 27738.4 28517.1 28683.7 28839.9 29193.4 34107.3 37917.0 38249.6 38389.8 39273.0 9014.3 9041.7 9122.7 9132.9 9194.3 10392.1 10475.2 10707.7 10865.8 11094.7 9863.7 9899.3 9928.2 10019.3 10107.2 8959.0 8997.1 9048.1 9115.5 9356.9 9059.7 9212.4 9310.6 9349.3 9692.5 7667.5 7826.2 7828.5 7848.6 7938.6 8127.5 8449.9 8528.0 8587.7 8599.7 07:30:20 INFO - PROCESS | 15898 | -------- Summary: end -------- 07:30:20 INFO - PROCESS | 15898 | 07:30:21 INFO - TEST-INFO | 15898: exit 0 07:30:21 INFO - TEST-OK | dromaeo_css | took 1117299ms 07:30:21 INFO - TEST-START | kraken 07:30:21 INFO - operating with platform_type : linux_ 07:30:21 INFO - Initialising browser for kraken test... 07:30:21 INFO - TEST-INFO | started process 16085 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDgBVvG/profile http://localhost:39982/getInfo.html) 07:30:25 INFO - PROCESS | 16085 | __metrics Screen width/height:1600/1200 07:30:25 INFO - PROCESS | 16085 | colorDepth:24 07:30:25 INFO - PROCESS | 16085 | Browser inner width/height: 1024/697 07:30:25 INFO - PROCESS | 16085 | __metrics 07:30:26 ERROR - PROCESS | 16085 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:30:27 INFO - TEST-INFO | 16085: exit 0 07:30:27 INFO - Browser initialized. 07:30:27 INFO - Running cycle 1/1 for kraken test... 07:30:27 INFO - TEST-INFO | started process 16166 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDgBVvG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:30:39 INFO - PROCESS | 16166 | RSS: Main: 154009600 07:30:39 INFO - PROCESS | 16166 | 07:30:41 INFO - PROCESS | 16166 | Cycle 1(1): loaded http://localhost:39982/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39982/tests/kraken/driver.html?testName=audio-beat-detection) 07:30:42 INFO - PROCESS | 16166 | RSS: Main: 208969728 07:30:42 INFO - PROCESS | 16166 | 07:30:45 INFO - PROCESS | 16166 | Cycle 1(1): loaded http://localhost:39982/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39982/tests/kraken/driver.html?testName=audio-dft) 07:30:46 INFO - PROCESS | 16166 | RSS: Main: 194863104 07:30:46 INFO - PROCESS | 16166 | 07:30:49 INFO - PROCESS | 16166 | Cycle 1(1): loaded http://localhost:39982/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39982/tests/kraken/driver.html?testName=audio-fft) 07:30:49 INFO - PROCESS | 16166 | RSS: Main: 264900608 07:30:49 INFO - PROCESS | 16166 | 07:30:52 INFO - PROCESS | 16166 | Cycle 1(1): loaded http://localhost:39982/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39982/tests/kraken/driver.html?testName=audio-oscillator) 07:30:52 INFO - PROCESS | 16166 | RSS: Main: 174325760 07:30:52 INFO - PROCESS | 16166 | 07:30:54 INFO - PROCESS | 16166 | Cycle 1(1): loaded http://localhost:39982/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39982/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:30:55 INFO - PROCESS | 16166 | RSS: Main: 178802688 07:30:55 INFO - PROCESS | 16166 | 07:30:58 INFO - PROCESS | 16166 | Cycle 1(1): loaded http://localhost:39982/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39982/tests/kraken/driver.html?testName=imaging-darkroom) 07:30:59 INFO - PROCESS | 16166 | RSS: Main: 214687744 07:30:59 INFO - PROCESS | 16166 | 07:31:02 INFO - PROCESS | 16166 | Cycle 1(1): loaded http://localhost:39982/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39982/tests/kraken/driver.html?testName=imaging-desaturate) 07:31:03 INFO - PROCESS | 16166 | RSS: Main: 215400448 07:31:03 INFO - PROCESS | 16166 | 07:31:06 INFO - PROCESS | 16166 | Cycle 1(1): loaded http://localhost:39982/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39982/tests/kraken/driver.html?testName=json-parse-financial) 07:31:06 INFO - PROCESS | 16166 | RSS: Main: 215138304 07:31:06 INFO - PROCESS | 16166 | 07:31:08 INFO - PROCESS | 16166 | Cycle 1(1): loaded http://localhost:39982/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39982/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:31:09 INFO - PROCESS | 16166 | RSS: Main: 201981952 07:31:09 INFO - PROCESS | 16166 | 07:31:10 INFO - PROCESS | 16166 | Cycle 1(1): loaded http://localhost:39982/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39982/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:31:11 INFO - PROCESS | 16166 | RSS: Main: 205508608 07:31:11 INFO - PROCESS | 16166 | 07:31:13 INFO - PROCESS | 16166 | Cycle 1(1): loaded http://localhost:39982/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39982/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:31:14 INFO - PROCESS | 16166 | RSS: Main: 220598272 07:31:14 INFO - PROCESS | 16166 | 07:31:17 INFO - PROCESS | 16166 | Cycle 1(1): loaded http://localhost:39982/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39982/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:31:17 INFO - PROCESS | 16166 | RSS: Main: 223674368 07:31:17 INFO - PROCESS | 16166 | 07:31:20 INFO - PROCESS | 16166 | Cycle 1(1): loaded http://localhost:39982/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39982/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:31:21 INFO - PROCESS | 16166 | RSS: Main: 219291648 07:31:21 INFO - PROCESS | 16166 | 07:31:23 INFO - PROCESS | 16166 | Cycle 1(1): loaded http://localhost:39982/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39982/tests/kraken/driver.html?testName=ai-astar) 07:31:23 INFO - PROCESS | 16166 | RSS: Main: 282054656 07:31:23 INFO - PROCESS | 16166 | 07:31:23 INFO - PROCESS | 16166 | __start_tp_report 07:31:23 INFO - PROCESS | 16166 | _x_x_mozilla_page_load 07:31:23 INFO - PROCESS | 16166 | _x_x_mozilla_page_load_details 07:31:23 INFO - PROCESS | 16166 | |i|pagename|runs| 07:31:23 INFO - PROCESS | 16166 | |0;ai-astar;112;113;107;112;113;115;101;112;112;113 07:31:23 INFO - PROCESS | 16166 | |1;audio-beat-detection;161;141;160;191;139;161;158;134;182;134 07:31:23 INFO - PROCESS | 16166 | |2;audio-dft;160;161;160;161;163;162;162;161;162;161 07:31:23 INFO - PROCESS | 16166 | |3;audio-fft;74;74;86;112;74;73;74;119;103;74 07:31:23 INFO - PROCESS | 16166 | |4;audio-oscillator;94;93;147;95;96;94;143;93;93;148 07:31:23 INFO - PROCESS | 16166 | |5;imaging-gaussian-blur;117;116;117;117;117;117;116;117;117;117 07:31:23 INFO - PROCESS | 16166 | |6;imaging-darkroom;147;146;146;146;146;146;146;147;146;147 07:31:23 INFO - PROCESS | 16166 | |7;imaging-desaturate;95;95;95;95;95;94;94;95;94;95 07:31:23 INFO - PROCESS | 16166 | |8;json-parse-financial;65;65;65;65;66;65;66;80;64;63 07:31:23 INFO - PROCESS | 16166 | |9;json-stringify-tinderbox;65;65;64;65;66;64;66;65;64;64 07:31:23 INFO - PROCESS | 16166 | |10;stanford-crypto-aes;78;79;80;79;79;79;78;79;79;80 07:31:23 INFO - PROCESS | 16166 | |11;stanford-crypto-ccm;132;142;132;130;135;131;141;135;169;136 07:31:23 INFO - PROCESS | 16166 | |12;stanford-crypto-pbkdf2;174;175;172;172;172;175;175;173;173;179 07:31:23 INFO - PROCESS | 16166 | |13;stanford-crypto-sha256-iterative;73;73;72;73;73;73;72;70;72;71 07:31:23 INFO - PROCESS | 16166 | __end_tp_report 07:31:23 INFO - PROCESS | 16166 | __start_cc_report 07:31:23 INFO - PROCESS | 16166 | _x_x_mozilla_cycle_collect,1877 07:31:23 INFO - PROCESS | 16166 | __end_cc_report 07:31:23 INFO - PROCESS | 16166 | __startTimestamp1460989883326__endTimestamp 07:31:23 INFO - PROCESS | 16166 | 07:31:23 INFO - PROCESS | 16166 | ------- Summary: start ------- 07:31:23 INFO - PROCESS | 16166 | Number of tests: 14 07:31:23 INFO - PROCESS | 16166 | 07:31:23 INFO - PROCESS | 16166 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.50 stddev:4.06 (3.6%) stddev-sans-first:4.28 07:31:23 INFO - PROCESS | 16166 | Values: 112.0 113.0 107.0 112.0 113.0 115.0 101.0 112.0 112.0 113.0 07:31:23 INFO - PROCESS | 16166 | 07:31:23 INFO - PROCESS | 16166 | [#1] audio-beat-detection Cycles:10 Average:156.10 Median:160.50 stddev:19.59 (12.2%) stddev-sans-first:20.69 07:31:23 INFO - PROCESS | 16166 | Values: 161.0 141.0 160.0 191.0 139.0 161.0 158.0 134.0 182.0 134.0 07:31:23 INFO - PROCESS | 16166 | 07:31:23 INFO - PROCESS | 16166 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.95 (0.6%) stddev-sans-first:0.88 07:31:23 INFO - PROCESS | 16166 | Values: 160.0 161.0 160.0 161.0 163.0 162.0 162.0 161.0 162.0 161.0 07:31:23 INFO - PROCESS | 16166 | 07:31:23 INFO - PROCESS | 16166 | [#3] audio-fft Cycles:10 Average:86.30 Median:74.00 stddev:18.08 (24.4%) stddev-sans-first:18.62 07:31:23 INFO - PROCESS | 16166 | Values: 74.0 74.0 86.0 112.0 74.0 73.0 74.0 119.0 103.0 74.0 07:31:23 INFO - PROCESS | 16166 | 07:31:23 INFO - PROCESS | 16166 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:93.50 stddev:25.17 (26.9%) stddev-sans-first:26.05 07:31:23 INFO - PROCESS | 16166 | Values: 94.0 93.0 147.0 95.0 96.0 94.0 143.0 93.0 93.0 148.0 07:31:23 INFO - PROCESS | 16166 | 07:31:23 INFO - PROCESS | 16166 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:31:23 INFO - PROCESS | 16166 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 07:31:23 INFO - PROCESS | 16166 | 07:31:23 INFO - PROCESS | 16166 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 07:31:23 INFO - PROCESS | 16166 | Values: 147.0 146.0 146.0 146.0 146.0 146.0 146.0 147.0 146.0 147.0 07:31:23 INFO - PROCESS | 16166 | 07:31:23 INFO - PROCESS | 16166 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 07:31:23 INFO - PROCESS | 16166 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 94.0 95.0 94.0 95.0 07:31:23 INFO - PROCESS | 16166 | 07:31:23 INFO - PROCESS | 16166 | [#8] json-parse-financial Cycles:10 Average:66.40 Median:65.00 stddev:4.86 (7.5%) stddev-sans-first:5.13 07:31:23 INFO - PROCESS | 16166 | Values: 65.0 65.0 65.0 65.0 66.0 65.0 66.0 80.0 64.0 63.0 07:31:23 INFO - PROCESS | 16166 | 07:31:23 INFO - PROCESS | 16166 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 07:31:23 INFO - PROCESS | 16166 | Values: 65.0 65.0 64.0 65.0 66.0 64.0 66.0 65.0 64.0 64.0 07:31:23 INFO - PROCESS | 16166 | 07:31:23 INFO - PROCESS | 16166 | [#10] stanford-crypto-aes Cycles:10 Average:79.00 Median:79.00 stddev:0.67 (0.8%) stddev-sans-first:0.60 07:31:23 INFO - PROCESS | 16166 | Values: 78.0 79.0 80.0 79.0 79.0 79.0 78.0 79.0 79.0 80.0 07:31:23 INFO - PROCESS | 16166 | 07:31:23 INFO - PROCESS | 16166 | [#11] stanford-crypto-ccm Cycles:10 Average:138.30 Median:135.50 stddev:11.51 (8.5%) stddev-sans-first:11.98 07:31:23 INFO - PROCESS | 16166 | Values: 132.0 142.0 132.0 130.0 135.0 131.0 141.0 135.0 169.0 136.0 07:31:23 INFO - PROCESS | 16166 | 07:31:23 INFO - PROCESS | 16166 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.00 Median:174.50 stddev:2.16 (1.2%) stddev-sans-first:2.29 07:31:23 INFO - PROCESS | 16166 | Values: 174.0 175.0 172.0 172.0 172.0 175.0 175.0 173.0 173.0 179.0 07:31:23 INFO - PROCESS | 16166 | 07:31:23 INFO - PROCESS | 16166 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.20 Median:73.00 stddev:1.03 (1.4%) stddev-sans-first:1.05 07:31:23 INFO - PROCESS | 16166 | Values: 73.0 73.0 72.0 73.0 73.0 73.0 72.0 70.0 72.0 71.0 07:31:23 INFO - PROCESS | 16166 | -------- Summary: end -------- 07:31:23 INFO - PROCESS | 16166 | 07:31:24 INFO - TEST-INFO | 16166: exit 0 07:31:24 INFO - TEST-OK | kraken | took 63241ms 07:31:24 INFO - SUITE-END | took 1180s 07:31:24 INFO - Completed test suite (00:19:40) 07:31:24 INFO - javascript benchmark 07:31:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2575.729548397418, 2642.8546429946346, 2655.5352813257673, 2659.74732400422, 2675.78593712503, 4440.37834703141, 4542.8864278392975, 4552.29439436887, 4560.794764235609, 4578.610818080467, 4573.656975726825, 4602.631789456844, 4606.239970404888, 4657.0453057123295, 4673.1821931162085, 4183.247015537202, 4184.853530126438, 4238.851640192594, 4269.957300426987, 4310.806013729374, 4220.1348723511755, 4280.3793449949735, 4287.571242875703, 4327.978360108195, 4334.653227741789, 4124.154548317588, 4173.436586060873, 4212.389203565496, 4228.4080228768, 4267.4025636410925, 4222.683298752606, 4254.234237837188, 4262.1049579588325, 4265.104328091104, 4311.396404503372, 4193.5387107418155, 4219.1139860629, 4219.514755803091, 4250.022494826177, 4252.319628859399, 4342.739435633841, 4456.77716114193, 4470.552944705503, 4518.932216016762, 4527.4340707411575, 4848.127337079324, 4865.391826021747, 4891.241857512091, 4897.1674815281485, 4939.481354457766, 4873.171560834631, 4907.9263811042865, 4911.263310503417, 4913.336699545587, 4915.188993816016, 4450.10997800438, 4624.5144259852905, 4695.671303008825, 4696.788644511005, 4698.201305778026, 4970.329005584272, 4975.651704380659, 4988.575971042429, 4996.950640365564, 5028.220625803006, 4612.238980568169, 4775.95224047762, 4778.784954677048, 4783.162946484351, 4790.856274311706, 4887.804487820447, 4902.950970490249, 4904.852854414374, 4927.457979622239, 4945.23348880924, 4809.398825146856, 4873.220284754422, 4881.8535443936735, 4883.58489528387, 4888.095702295087, 4700.365450664117, 4817.8313759018265, 4859.586935110485, 4874.683145595525, 4921.114199444063, 4195.0, 4195.202911446815, 4217.0, 4223.345381465878, 4242.936355954663, 3646.9817650911577, 3653.8903832885057, 3662.908427289339, 3685.355062863988, 3702.4816525686424, 4119.546849846514, 4191.11986482842, 4231.597998190167, 4240.151969606091, 4243.8090285937205, 4917.729524876095, 4924.9507504925205, 4931.48219436954, 4949.950500494949, 4968.950310496921, 3982.48227730399, 4044.8876558946527, 4233.491980962242, 4258.446401967724, 4285.5071666758095, 4298.570142985739, 4395.340698895191, 4433.911321773547, 4440.4227450431235, 4480.507144214133, 4592.471865735483, 4618.861434156981, 4627.282771170474, 4642.1644104060915, 4652.13935421948, 4862.805487780449, 4874.22012478016, 4882.511748825089, 4884.7069175849565, 4932.679375840559, 4486.013077123028, 4600.516945720785, 4638.721676699409, 4700.318453824245, 4724.173269677862, 4824.879378015437, 4828.830990915301, 4844.079624871263, 4845.854624361275, 4901.044296362318, 4886.462489126265, 4904.779284932115, 4905.656604037826, 4912.238603016538, 4960.553550180501, 4693.882652933567, 4769.833055843029, 4796.904061918673, 4812.470628230962, 4846.418429788448, 4679.3916790816975, 4695.201815691409, 4711.528847115261, 4719.3156992235245, 4742.478327383916, 4624.468186158635, 4655.138799322136, 4674.158651442773, 4678.50875658051, 4721.929171062506, 4748.3352330674425, 4800.615950724004, 4806.759662016815, 4836.347093142381, 4837.540433658797, 4642.16441040616, 4648.070385922897, 4652.767361631837, 4676.6492513060975, 4735.076660051257], "value": 4500.000494135014, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.1443514122093, 592.5348601347943, 610.41095342994, 625.2497003595684, 638.9424951754341, 33438.16404589886, 35190.648093519056, 35217.0, 35223.82388088063, 35255.29489410217, 40312.0, 41402.7929860351, 41465.378019329735, 41481.377779333256, 41535.58464415355, 7679.500832445887, 7946.562939038351, 7947.443678942476, 7950.204979502061, 7954.721584744535, 7763.844723105534, 7844.2155784421675, 7882.448228623999, 7882.566458844762, 7883.054033515986, 7854.3716502679645, 7929.365650747955, 7931.444798864082, 7937.682492700314, 7940.483868548555, 7819.921800781976, 7873.645685944118, 7883.487573307717, 7883.763487095396, 7888.447808653396, 7817.765467035998, 7924.80187995299, 7925.048994120685, 7927.286544211049, 7928.167542408022, 37699.434508482394, 38221.42667859984, 38232.0, 38276.80861595702, 38331.808340958116, 2976.836274004929, 2997.2207226121363, 3069.600951876264, 3142.7328677062246, 3582.8208589570677, 28814.711852881414, 29008.734753974404, 29180.8540957296, 29906.252343691365, 30084.8495757522, 3410.0963244740165, 3410.38613049651, 3446.7070299024363, 3447.7414193935556, 3496.021114088059, 272319.0, 275729.0, 276435.0, 277105.6144719284, 277992.0, 51167.97664046698, 52718.0, 52961.735191323794, 53080.0, 53087.46912530903, 51483.48516514787, 61105.0, 62754.372456274854, 62897.68551157215, 62937.37062629407, 13383.263920484467, 13635.727285454235, 13656.453741850413, 13663.658408539668, 13668.316584170752, 9021.729348119567, 9435.339526233098, 9449.196818270524, 9468.431894086378, 9865.75335616601, 17847.46457606274, 17916.283348665907, 17932.820671793375, 17951.551211219823, 18013.549661258574, 6813.659317034128, 6964.686589103401, 6989.7553585624255, 7062.081929349254, 7109.964450177716, 818.145038434837, 860.4192170285032, 893.7274131389859, 924.9953750231206, 952.7760976170595, 26965.865170674413, 27163.86418067897, 27500.0, 27766.722332776415, 27831.860840695666, 958.3148049144895, 959.4291396619001, 1015.791762688647, 1026.8049070676548, 1039.7244730146517, 14407.135571865721, 15036.699266014837, 15037.368460519585, 16058.197090145446, 16313.755293670605, 337131.0, 342399.0, 344440.0, 344494.0, 344768.0, 49891.750541247064, 50671.49328506668, 50705.0, 50757.0, 50769.907611086164, 1104.5526561742506, 1156.6125348008343, 1281.3529167770403, 1286.2154086007529, 1286.5111257722006, 24376.0, 27261.0, 27296.454070918866, 27511.724882751718, 27614.585781212896, 39478.60521394749, 40290.395644064774, 40331.0, 40378.0, 40397.0, 243432.0, 249150.0, 249705.0, 250148.0, 250218.0, 22127.889360553094, 22865.0, 24573.385665357793, 25284.367890802878, 25876.61185082263, 38953.80523097367, 39182.41226381664, 39281.0, 39502.40746388749, 39996.400053999794, 31234.843825780725, 33838.32323353568, 33909.830450847585, 34131.82934085314, 34372.0, 32494.67505325011, 33018.504722428705, 33501.32997339991, 33506.66493335035, 33609.83195084009, 33116.668833311356, 33420.832895836335, 34011.82994085014, 34098.31803363968, 34102.317953641286, 29129.271768205963, 29819.25451863634, 30003.242461277183, 30208.848955755082, 30223.546646799874, 23537.293881183592, 23776.40558986039, 23961.400964976016, 23994.28017159488, 24168.516629666956], "value": 17113.320572288565, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.0, 384.7556801431092, 386.6500816760832, 395.483893518958, 395.97426167299125, 16299.59251018725, 17092.316307347723, 17212.0, 17252.223649935753, 17266.309347626095, 16412.425565105223, 16823.158842057877, 17031.48905532836, 17067.573310667238, 17128.229229684664, 5033.899322013557, 5252.028374750684, 5273.367195936493, 5290.497402746733, 5303.496167864047, 3691.53855768029, 5682.715864206793, 6011.5190784737115, 6015.0676645120075, 6028.668423236721, 4983.775730092137, 5953.940460595382, 5961.046232602785, 5962.314333851619, 5996.130561068642, 5196.818111366084, 5211.5309622134, 5250.133727934886, 5262.473752624726, 5263.26314315996, 3281.2125089978235, 3487.0410637074756, 3492.7729697569575, 3493.2489514754448, 4798.2802579613335, 12439.75120497585, 12466.563670271587, 14206.147631142165, 19818.80181198184, 20327.5934481311, 1878.6524492968845, 1889.2159753702197, 1890.3273964002638, 1978.2482656590403, 2001.729766481521, 8605.913940860637, 8696.608652610648, 9112.498812565307, 9145.81708365829, 9204.539773011322, 1738.148307329412, 1750.474857542732, 1753.0533511903684, 1760.9647807043787, 1805.4312891439154, 66460.6676966617, 69461.65269173673, 69759.30240697629, 70277.64861175764, 70365.29634703639, 9757.902420975699, 9806.0, 9916.0, 10030.348027378197, 10125.0, 13811.378487968066, 13942.302884855717, 13960.511382101578, 13964.930175349058, 13989.930050349683, 6937.7679615434545, 7010.334018268256, 7019.5086343956455, 7021.648917554102, 7080.398166155935, 6385.45723613498, 6472.190976127984, 6573.718124965586, 6578.934210657928, 6738.764143255061, 4307.418498502662, 4355.803988820448, 4381.539938306496, 4453.265211240109, 4460.955390446119, 1683.7979442466983, 1694.618710790087, 1728.196388679245, 1803.819618038212, 1822.8177182281931, 897.2194191053694, 897.3583887520455, 912.9406588571721, 933.421278807144, 947.1333729637305, 15314.234288285541, 16074.035557866566, 16666.916665416597, 16694.749578756328, 16941.0, 864.5936409887343, 900.7162743735702, 938.4885237545418, 944.1408318430196, 948.7580666930027, 9090.818183636291, 9472.431654100637, 9479.857802132974, 9516.95241523788, 9576.138147566753, 401543.0, 403115.0, 404513.0, 405592.0, 406243.0, 74153.6292318535, 75946.62026689942, 76393.0, 76524.61737691387, 77096.22903770891, 914.3279689428398, 915.0620613870702, 928.7631653928205, 931.4364809290417, 932.9067093290616, 14643.56069317922, 14723.263836807902, 14733.116013039253, 14779.187144707144, 15136.167510787012, 33232.516634755964, 34030.31939361248, 35510.579576816635, 35746.92759217227, 36123.458148127276, 42936.0, 43242.56757432511, 44978.3253251208, 45293.32060019037, 46095.76952115218, 7441.181470038183, 7586.3930885527925, 7592.8481430372185, 7637.847243054996, 7690.077190737147, 7106.609136497542, 11521.193516453768, 11615.419229038345, 12212.450439730055, 12230.571929982409, 9745.463999480096, 10071.093601575893, 10298.433586152834, 10719.946400268262, 10781.353118812896, 10325.74185645365, 10356.378617282988, 10417.16662667, 10525.210609204494, 10576.629817956335, 10655.733606659896, 10692.62575809843, 10736.355818650905, 11176.497057632589, 11183.930972770064, 7844.4901081429525, 7961.72133975308, 7963.761087167394, 7971.481853679492, 8135.877961830459, 8120.512769233865, 9427.0, 9870.753231169278, 9962.950185249027, 10183.0], "value": 8029.202307056434, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1228.1709845854045, 1446.7251222267769, 1469.3828591991364, 1614.878884083694, 1813.4831573001698, 6501.349865013496, 7524.172341042481, 7778.766637000885, 7791.493552919056, 7800.8049798755055, 7495.213002634713, 7655.15793262742, 7659.961700191491, 7677.3090421862025, 7682.462227644067, 1866.9346572869952, 2162.9891850540725, 2188.8248940084754, 2190.8356873234493, 2269.9432514187197, 2266.1388672304583, 2277.954440911189, 2279.9316020519327, 2289.919852805152, 2290.1640901071155, 2199.571083638691, 2242.4618091657967, 2244.3154837774473, 2245.438640339915, 2247.056236380724, 1816.5821860971985, 2156.55790562935, 2240.327901629521, 2241.3612120545567, 2242.495438526335, 2152.2682288022147, 2155.687425323335, 2173.3262688566597, 2173.467500462381, 2195.056125865877, 7629.0, 7642.273983971514, 7687.96156019222, 7690.2694244046725, 7695.6152192390155, 4578.473475550321, 4740.454847692525, 4750.71495710255, 4756.809727610891, 4814.927776083362, 2858.7141285871453, 2902.1728807290033, 2942.440936222111, 2974.73227409532, 2974.762019038472, 807.2129673568282, 812.5530957973091, 819.9344052475848, 826.1614461321764, 830.7839961609965, 10699.83950240747, 10715.892841071567, 10720.035196832245, 10736.516856741466, 10744.086752626035, 4153.979230103831, 4234.364845273234, 4393.758343291086, 4429.822807087745, 4461.709988850715, 9061.818763624822, 9074.773130671654, 9092.36353455265, 9094.090590940854, 9101.863472047924, 4049.372347286175, 4830.565249127525, 4832.057748739033, 4850.369451971221, 4865.440474345425, 4015.377616469452, 4132.876013719593, 4136.276151673445, 4136.338185890243, 4149.937750933738, 3688.5758137814496, 3691.4093745000673, 3768.6419790119894, 3817.61823817616, 3841.0, 1231.8768123187788, 1244.4835393311673, 1259.9874001260052, 1268.8604253532103, 1273.0770191611007, 741.6365980669541, 769.6959700918218, 782.8160382310152, 853.6542700206427, 857.7726902370877, 5283.9471605284225, 5339.065663508871, 5356.491133342326, 5420.457954204627, 5465.508104270635, 800.6357107516067, 812.8780682897494, 813.1137060603852, 853.9615717292737, 867.5011868175824, 3698.389765688631, 3733.085394078468, 3790.128270497801, 3798.0, 3835.5780864104927, 9436.905630943602, 9666.75833104164, 9806.31355805101, 9848.359856609297, 9908.306418550632, 9715.61137554504, 9728.562214700356, 9743.561539730586, 9752.26857985654, 9787.706368808947, 6957.686904089328, 7263.673134708951, 7391.926080739231, 7398.112226532743, 7400.222976587381, 5180.274761533464, 5218.66078704883, 5249.816256431007, 5262.263283140287, 5417.6478528895495, 8554.27288680469, 8560.743177704679, 8756.868646970428, 8772.824543509221, 8852.867206992029, 8708.433951793113, 8803.603837827184, 8938.553072346227, 8999.730008099768, 9007.594658240263, 5816.41835816415, 6035.6076855004285, 6038.124471951454, 6803.081583986296, 6958.965205173941, 6454.580452270775, 6818.659067046528, 7398.445116616168, 7422.220666830121, 7453.850922981618, 6607.438367738604, 6674.766383176566, 6729.192496900403, 6740.831479212863, 6749.3250674932115, 6471.4822814175695, 6498.180509457359, 6525.151730275224, 6688.565243259172, 6725.0248713935225, 6230.127782110418, 6292.087647291209, 6298.244210694746, 6298.622082675054, 6340.144080549251, 4549.385832912647, 4581.312803079565, 4699.459562150397, 4703.176944034712, 4759.309900064402, 4513.571210734975, 4572.1312950539295, 4680.368150299666, 4691.225947718588, 4700.929486057644], "value": 4130.4414708675295, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.40517099412637, 311.91734190439536, 316.765593460839, 321.22424345206326, 324.6769464382936, 4979.452260251374, 4988.27669987852, 4994.101061808873, 5008.599312055036, 5075.020741910658, 4923.384576927884, 4963.305137280783, 4969.378827646544, 4979.925301120486, 4990.328240039582, 3728.1984373359724, 3796.8291426885717, 3956.1494278730065, 3964.603539646041, 3984.621460961204, 3949.328614135604, 3956.0, 3966.504186976628, 3971.324874771296, 3973.086190176261, 3619.94570081449, 3902.590228026059, 3936.2127574485075, 3937.940930886039, 3953.6639385652256, 3750.0999760057525, 3917.5103112110987, 3926.1362500249897, 3937.6652984496354, 3937.9803100984454, 3468.670476304747, 3487.337405892872, 3494.6505349465106, 3497.108237399447, 3497.562804649419, 4825.831095911626, 4827.106985207748, 4829.396325459317, 4831.710097394132, 4835.758212089417, 4226.429432026668, 4438.245498265303, 4444.11117776446, 4444.422225110748, 4511.488651301818, 5194.831162988336, 5206.114960456732, 5211.348581427322, 5233.895322093575, 5251.10731175701, 3644.835982380799, 3687.3178461984617, 3691.8338674759702, 3701.3535322244456, 3707.703383729295, 5382.273393091921, 5467.0, 5486.039943009957, 5524.530414914737, 5535.474129957647, 3891.9610803892165, 3898.4542164097047, 3902.434147048662, 3912.0, 3912.4326972588815, 3964.1080756829483, 3974.682025437958, 3979.820908059144, 3980.1641655252142, 3998.140399814054, 4365.232081007197, 4435.223835828717, 4459.397981272552, 4460.241758900995, 4473.865784026484, 5210.947890521046, 5219.5041471060185, 5233.555147812479, 5244.082285600005, 5265.0, 1375.3948262764352, 1385.4873696732272, 1387.7016441465134, 1388.8402833674054, 1390.4716207841159, 883.6862913665556, 884.195382202193, 960.5869476125333, 961.3847137831793, 977.5063592885547, 4539.776758501435, 4555.157295900269, 4610.625527853158, 4615.30770384445, 4624.421947256593, 5359.812406565751, 5368.4631536846, 5375.3280839895015, 5387.81142660005, 5396.433374495621, 4403.053343531156, 4542.477615074243, 4585.747783871852, 4590.380298659705, 4598.540145985442, 2897.9565306520417, 2902.4050069735654, 2919.854007299669, 2924.1958461422855, 2930.3113768264443, 5132.28148059272, 5133.409657889316, 5146.768395422215, 5158.561522270574, 5161.38063432383, 5364.195370694349, 5565.4677121909435, 5589.776408943678, 5600.971995139998, 5621.634593751393, 5099.56653684441, 5130.666506677054, 5164.9999999999245, 5170.1469257572835, 5178.197379406198, 5467.0, 5471.863203419946, 5471.890562188813, 5473.658953556404, 5474.479924407175, 5099.770510327118, 5359.812406565751, 5359.919601205907, 5360.142377219626, 5388.946110538845, 5136.845894623168, 5144.948550514447, 5149.562287205629, 5152.227165925141, 5164.612654051037, 3750.568684601306, 3774.8864085094415, 3785.242951409784, 3787.337215987136, 3800.619938006177, 5184.45563215872, 5438.401775804738, 5441.83674489766, 5442.401335853132, 5477.123660214346, 4975.10448119342, 5086.18621020635, 5252.40006196935, 5292.629515933848, 5298.178782288752, 5227.3465816772905, 5267.2889159962915, 5269.42036376006, 5278.208268759717, 5280.471952804843, 5184.377874655065, 5188.58491320701, 5196.480351964773, 5209.453007434165, 5222.55608273301, 5072.5688316493515, 5327.280817089798, 5363.088274993339, 5368.114261146867, 5374.570034397317, 5223.112070948024, 5224.164133738584, 5239.921401178909, 5247.475252474875, 5247.501487358695], "value": 3978.0943601954405, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.7324030945765, 583.3437382944187, 595.1578516399295, 643.9437094129706, 683.3678847066462, 10280.897191028087, 10720.78558428833, 11094.112471002321, 11277.605283815057, 11343.205975581703, 13496.730065398686, 13592.456301747943, 13624.250666213355, 13640.727185456284, 13659.590212293622, 645.1451826330108, 668.261570964085, 668.8194187569353, 669.213673933129, 809.7854068671807, 819.9918000819976, 825.7894236969595, 826.6775957376628, 826.8842362069315, 827.1191181391798, 863.4775960543875, 864.511550973701, 871.877937088808, 871.9215270625642, 872.4329186029069, 861.2119910282115, 863.935204859638, 864.0409145848104, 864.2222000199807, 865.0441262405014, 634.5589815078522, 635.678982114034, 635.7647670361949, 635.7901892375551, 636.0268788753215, 11294.983451489323, 11315.321080735182, 11337.943310283395, 11379.487923043484, 11385.943070284678, 12481.0, 12556.372181390894, 12613.432395542222, 12651.0, 12908.548200812926, 9541.570629321697, 9730.270229732798, 9812.509374531244, 9997.15024222942, 10023.148032417253, 4106.240345536085, 4122.91754164915, 4169.687273454503, 4282.314829627245, 4323.07053983392, 43124.568754312684, 44100.77949610264, 44167.77916110399, 44382.77808610968, 44391.77804110959, 9322.48726320059, 9324.90675093254, 9356.719298421058, 9392.389494682824, 9465.290103242147, 14719.705605888037, 15151.696966060837, 15274.31265593051, 15310.0, 15331.770023449657, 6259.843503912348, 6503.804885853432, 6595.70319335631, 6629.834254143685, 6632.436242919406, 3718.8326525306425, 3729.272791805572, 3763.6236376362695, 3785.167263202091, 3852.8651497197466, 2828.7454129128478, 2919.678835328112, 2925.166327596667, 2961.0, 2966.036038287522, 534.2120372450604, 539.2935254816203, 544.2652419234003, 548.7722595123059, 549.0309603549738, 485.5241862974305, 522.3888050980286, 549.7114015142002, 588.6350462713145, 625.8873402787451, 7691.538507689556, 7770.805729856799, 7836.138024817265, 7893.486923349964, 8084.919150808417, 582.251806428737, 597.8146774499919, 600.2616781358865, 618.0852338538988, 624.6408315218767, 3817.5800661927165, 3903.6486716195677, 3929.390944403622, 4003.0592810689463, 4007.5992400760274, 51073.233901491505, 53040.73479632577, 53135.73432132815, 53199.468005320225, 53211.46788532143, 45431.772841135586, 46799.0, 47134.0, 47242.5275747245, 47579.0, 41520.79239603843, 41941.161176776295, 42498.15003699971, 42706.57293427088, 43667.12665746667, 7270.454715896223, 7498.100227972678, 7515.511491753018, 7728.806779830325, 7736.7678969631, 27738.44523109567, 28517.144485665463, 28683.713162868105, 28839.855800720863, 29193.416131677674, 34107.31785364328, 37917.0, 38249.61750382461, 38389.80805096068, 39273.0, 9014.32392570573, 9041.728748137566, 9122.680706175252, 9132.908670913472, 9194.31042671789, 10392.116670082825, 10475.16198704117, 10707.678769636923, 10865.78268434611, 11094.722631933942, 9863.704088877344, 9899.257555683496, 9928.15610673072, 10019.348742331726, 10107.191424686154, 8958.955205224192, 8997.145271199226, 9048.095190480899, 9115.498647574446, 9356.859647105435, 9059.728208153765, 9212.401193922373, 9310.627574896927, 9349.298802589698, 9692.515374231401, 7667.539947603162, 7826.221228226652, 7828.45200835936, 7848.568328741746, 7938.642761075881, 8127.471714338549, 8449.915500845158, 8527.957360213408, 8587.742367728979, 8599.656013759379], "value": 5711.857047767798, "unit": "score"}], "name": "dromaeo_css", "value": 6222.323852199099, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 107.0, 112.0, 113.0, 115.0, 101.0, 112.0, 112.0, 113.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 141.0, 160.0, 191.0, 139.0, 161.0, 158.0, 134.0, 182.0, 134.0], "value": 156.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 161.0, 163.0, 162.0, 162.0, 161.0, 162.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 86.0, 112.0, 74.0, 73.0, 74.0, 119.0, 103.0, 74.0], "value": 86.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 147.0, 95.0, 96.0, 94.0, 143.0, 93.0, 93.0, 148.0], "value": 109.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 66.0, 80.0, 64.0, 63.0], "value": 66.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 65.0, 66.0, 64.0, 66.0, 65.0, 64.0, 64.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 80.0, 79.0, 79.0, 79.0, 78.0, 79.0, 79.0, 80.0], "value": 79.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 142.0, 132.0, 130.0, 135.0, 131.0, 141.0, 135.0, 169.0, 136.0], "value": 138.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 175.0, 172.0, 172.0, 172.0, 175.0, 175.0, 173.0, 173.0, 179.0], "value": 174.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 72.0, 73.0, 73.0, 73.0, 72.0, 70.0, 72.0, 71.0], "value": 72.2, "unit": "score"}], "name": "kraken", "value": 1576.8000000000002, "alertThreshold": 2.0}]} 07:31:24 INFO - Return code: 0 07:31:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:31:24 ERROR - # TBPL SUCCESS # 07:31:24 INFO - Running post-action listener: _resource_record_post_action 07:31:24 INFO - Running post-run listener: _resource_record_post_run 07:31:25 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 0; Write bytes: 521461760; Read time: 0; Write time: 634172 07:31:25 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234139648; Read time: 0; Write time: 360196 07:31:25 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 287322112; Read time: 0; Write time: 273976 07:31:25 INFO - Running post-run listener: _upload_blobber_files 07:31:25 INFO - Blob upload gear active. 07:31:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:31:25 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:31:25 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'] 07:31:25 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 07:31:26 INFO - (blobuploader) - INFO - Open directory for files ... 07:31:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:31:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:31:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:31:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:31:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:31:26 INFO - (blobuploader) - INFO - Done attempting. 07:31:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:31:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:31:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:31:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:31:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:31:27 INFO - (blobuploader) - INFO - Done attempting. 07:31:27 INFO - (blobuploader) - INFO - Iteration through files over. 07:31:27 INFO - Return code: 0 07:31:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:31:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:31:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f9c14873e2730b8507686ffa79172ee5c0e57b1364dc26ffa63027fcc240abdc08f94641e0a2eb7a2019686882aceec36f4620440ae1544a9e0233bb59a33ef5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/58e5987fb77e9e232bfd618c4e18c5f8e9fbbc82b639f6b24fd3a37cb15645255787d7a3163d351ed0d438f53a7581bba603a77d59826e190228ded0e142ca84"} 07:31:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:31:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:31:27 INFO - Contents: 07:31:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f9c14873e2730b8507686ffa79172ee5c0e57b1364dc26ffa63027fcc240abdc08f94641e0a2eb7a2019686882aceec36f4620440ae1544a9e0233bb59a33ef5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/58e5987fb77e9e232bfd618c4e18c5f8e9fbbc82b639f6b24fd3a37cb15645255787d7a3163d351ed0d438f53a7581bba603a77d59826e190228ded0e142ca84"} 07:31:27 INFO - Running post-run listener: copy_logs_to_upload_dir 07:31:27 INFO - Copying logs to upload dir... 07:31:27 INFO - mkdir: /builds/slave/test/build/upload/logs 07:31:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.605333 ========= master_lag: 12.96 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-04-18 07:31:40.911860) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 07:31:40.919559) ========= 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=8783db0840cc980e80bb0bd400000236-1460986938.304110-757000833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f9c14873e2730b8507686ffa79172ee5c0e57b1364dc26ffa63027fcc240abdc08f94641e0a2eb7a2019686882aceec36f4620440ae1544a9e0233bb59a33ef5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/58e5987fb77e9e232bfd618c4e18c5f8e9fbbc82b639f6b24fd3a37cb15645255787d7a3163d351ed0d438f53a7581bba603a77d59826e190228ded0e142ca84"} build_url:https://queue.taskcluster.net/v1/task/JUzF-dg1RheGjeMudkMTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011355 build_url: 'https://queue.taskcluster.net/v1/task/JUzF-dg1RheGjeMudkMTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f9c14873e2730b8507686ffa79172ee5c0e57b1364dc26ffa63027fcc240abdc08f94641e0a2eb7a2019686882aceec36f4620440ae1544a9e0233bb59a33ef5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/58e5987fb77e9e232bfd618c4e18c5f8e9fbbc82b639f6b24fd3a37cb15645255787d7a3163d351ed0d438f53a7581bba603a77d59826e190228ded0e142ca84"}' ========= master_lag: 0.57 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 07:31:41.505070) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 07:31:41.508489) ========= 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=8783db0840cc980e80bb0bd400000236-1460986938.304110-757000833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004507 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 07:31:41.525049) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 07:31:41.525526) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 07:31:41.525937) ========= ========= Total master_lag: 13.62 =========