builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-051 starttime: 1467873306.47 results: success (0) buildid: 20160706204229 builduid: 8d63b2827b9f4cf9b8f9f0da9fefc1a1 revision: e4b27dae353c933a01584dfeff27d547ef60f04e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 23:35:06.469396) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 23:35:06.469789) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 23:35:06.470074) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 23:35:06.517276) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 23:35:06.517535) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1467872611.25231-945648131 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-06 23:35:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 58.8K=0.2s 2016-07-06 23:35:06 (58.8 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.352764 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 23:35:06.905829) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 23:35:06.906147) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1467872611.25231-945648131 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.148991 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 23:35:07.067459) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 23:35:07.067817) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev e4b27dae353c933a01584dfeff27d547ef60f04e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev e4b27dae353c933a01584dfeff27d547ef60f04e --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=5ac5dba3e01a12f1ff77ab15000001b1-1467872611.25231-945648131 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-06 23:35:07,196 truncating revision to first 12 chars 2016-07-06 23:35:07,196 Setting DEBUG logging. 2016-07-06 23:35:07,197 attempt 1/10 2016-07-06 23:35:07,197 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/e4b27dae353c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-06 23:35:07,497 unpacking tar archive at: mozilla-beta-e4b27dae353c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.632544 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 23:35:07.715087) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 23:35:07.715363) ========= script_repo_revision: e4b27dae353c933a01584dfeff27d547ef60f04e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 23:35:07.715720) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 23:35:07.715981) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 23:35:07.725376) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-07-06 23:35:07.725653) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1467872611.25231-945648131 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:35:08 INFO - MultiFileLogger online at 20160706 23:35:08 in /builds/slave/test 23:35:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 23:35:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:35:08 INFO - {'append_to_log': False, 23:35:08 INFO - 'base_work_dir': '/builds/slave/test', 23:35:08 INFO - 'blob_upload_branch': 'Mozilla-Beta', 23:35:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:35:08 INFO - 'branch': 'Mozilla-Beta', 23:35:08 INFO - 'buildbot_json_path': 'buildprops.json', 23:35:08 INFO - 'config_files': ('talos/linux_config.py',), 23:35:08 INFO - 'default_actions': ('clobber', 23:35:08 INFO - 'read-buildbot-config', 23:35:08 INFO - 'download-and-extract', 23:35:08 INFO - 'populate-webroot', 23:35:08 INFO - 'create-virtualenv', 23:35:08 INFO - 'install', 23:35:08 INFO - 'run-tests'), 23:35:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:35:08 INFO - 'download_minidump_stackwalk': True, 23:35:08 INFO - 'download_symbols': 'ondemand', 23:35:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:35:08 INFO - 'tooltool.py': '/tools/tooltool.py', 23:35:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:35:08 INFO - '/tools/misc-python/virtualenv.py')}, 23:35:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:35:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:35:08 INFO - 'installer_path': 'installer.exe', 23:35:08 INFO - 'log_level': 'info', 23:35:08 INFO - 'log_name': 'talos', 23:35:08 INFO - 'log_to_console': True, 23:35:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:35:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:35:08 INFO - 'opt_config_files': (), 23:35:08 INFO - 'pip_index': False, 23:35:08 INFO - 'sps_profile': False, 23:35:08 INFO - 'sps_profile_interval': 0, 23:35:08 INFO - 'suite': 'dromaeojs', 23:35:08 INFO - 'system_bits': '32', 23:35:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:35:08 INFO - 'title': 'talos-linux64-ix-051', 23:35:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:35:08 INFO - 'use_talos_json': True, 23:35:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:35:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:35:08 INFO - 'work_dir': 'build'} 23:35:08 INFO - ##### 23:35:08 INFO - ##### Running clobber step. 23:35:08 INFO - ##### 23:35:08 INFO - Running pre-action listener: _resource_record_pre_action 23:35:08 INFO - Running main action method: clobber 23:35:08 INFO - rmtree: /builds/slave/test/build 23:35:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:35:08 INFO - Running post-action listener: _resource_record_post_action 23:35:08 INFO - ##### 23:35:08 INFO - ##### Running read-buildbot-config step. 23:35:08 INFO - ##### 23:35:08 INFO - Running pre-action listener: _resource_record_pre_action 23:35:08 INFO - Running main action method: read_buildbot_config 23:35:08 INFO - Using buildbot properties: 23:35:08 INFO - { 23:35:08 INFO - "project": "", 23:35:08 INFO - "product": "firefox", 23:35:08 INFO - "script_repo_revision": "production", 23:35:08 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 23:35:08 INFO - "repository": "", 23:35:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 23:35:08 INFO - "buildid": "20160706204229", 23:35:08 INFO - "pgo_build": "True", 23:35:08 INFO - "basedir": "/builds/slave/test", 23:35:08 INFO - "buildnumber": 293, 23:35:08 INFO - "slavename": "talos-linux64-ix-051", 23:35:08 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 23:35:08 INFO - "platform": "ubuntu64_hw", 23:35:08 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 23:35:08 INFO - "branch": "mozilla-beta", 23:35:08 INFO - "repo_path": "releases/mozilla-beta", 23:35:08 INFO - "revision": "e4b27dae353c933a01584dfeff27d547ef60f04e", 23:35:08 INFO - "stage_platform": "linux64-pgo", 23:35:08 INFO - "builduid": "8d63b2827b9f4cf9b8f9f0da9fefc1a1", 23:35:08 INFO - "slavebuilddir": "test" 23:35:08 INFO - } 23:35:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 23:35:08 INFO - Running post-action listener: _resource_record_post_action 23:35:08 INFO - ##### 23:35:08 INFO - ##### Running download-and-extract step. 23:35:08 INFO - ##### 23:35:08 INFO - Running pre-action listener: _resource_record_pre_action 23:35:08 INFO - Running main action method: download_and_extract 23:35:08 INFO - mkdir: /builds/slave/test/build/tests 23:35:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:35:08 INFO - https://queue.taskcluster.net/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:35:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 23:35:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 23:35:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 23:35:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 23:35:18 INFO - Downloaded 1327 bytes. 23:35:18 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 23:35:18 INFO - Using the following test package requirements: 23:35:18 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 23:35:18 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:35:18 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 23:35:18 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:35:18 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 23:35:18 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:35:18 INFO - u'jsshell-linux-x86_64.zip'], 23:35:18 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:35:18 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 23:35:18 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 23:35:18 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:35:18 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 23:35:18 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:35:18 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 23:35:18 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:35:18 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 23:35:18 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:35:18 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 23:35:18 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:35:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:35:18 INFO - https://queue.taskcluster.net/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:35:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 23:35:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 23:35:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 23:35:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:35:33 INFO - Downloaded 24237506 bytes. 23:35:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:35:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:35:34 INFO - Return code: 0 23:35:34 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:35:34 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')]} 23:35:34 INFO - https://queue.taskcluster.net/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:35:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 23:35:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 23:35:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 23:35:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:35:35 INFO - Downloaded 24237506 bytes. 23:35:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:35:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:35:36 INFO - Return code: 0 23:35: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')]} 23:35:36 INFO - https://queue.taskcluster.net/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:35:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 23:35:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 23:35:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 23:35:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:35:37 INFO - Downloaded 10840145 bytes. 23:35:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:35:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 23:35:38 INFO - Return code: 0 23:35: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')]} 23:35:38 INFO - https://queue.taskcluster.net/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:35:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 23:35:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 23:35:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 23:35:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:35:40 INFO - Downloaded 56026598 bytes. 23:35:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 23:35:40 INFO - mkdir: /builds/slave/test/properties 23:35:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:35:40 INFO - Writing to file /builds/slave/test/properties/build_url 23:35:40 INFO - Contents: 23:35:40 INFO - build_url:https://queue.taskcluster.net/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 23:35:41 INFO - Running post-action listener: _resource_record_post_action 23:35:41 INFO - Running post-action listener: set_extra_try_arguments 23:35:41 INFO - ##### 23:35:41 INFO - ##### Running populate-webroot step. 23:35:41 INFO - ##### 23:35:41 INFO - Running pre-action listener: _resource_record_pre_action 23:35:41 INFO - Running main action method: populate_webroot 23:35:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:35:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:35:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:35:41 INFO - '--tppagecycles', 23:35:41 INFO - '7'], 23:35:41 INFO - 'tests': ['tsvgm']}}, 23:35:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:35:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:35:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:35:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:35:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:35:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:35:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:35:41 INFO - 'talos_options': ['--disable-e10s'], 23:35:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:35:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:35:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:35:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:35:41 INFO - 'talos_options': ['--disable-e10s'], 23:35:41 INFO - 'tests': ['damp', 'tps']}, 23:35:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:35:41 INFO - 'tests': ['damp', 'tps']}, 23:35:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:35:41 INFO - 'tests': ['dromaeo_dom']}, 23:35:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:35:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:35:41 INFO - 'tests': ['a11yr', 23:35:41 INFO - 'ts_paint', 23:35:41 INFO - 'tpaint', 23:35:41 INFO - 'sessionrestore', 23:35:41 INFO - 'sessionrestore_no_auto_restore', 23:35:41 INFO - 'tabpaint']}, 23:35:41 INFO - 'other-e10s': {'tests': ['a11yr', 23:35:41 INFO - 'ts_paint', 23:35:41 INFO - 'tpaint', 23:35:41 INFO - 'sessionrestore', 23:35:41 INFO - 'sessionrestore_no_auto_restore', 23:35:41 INFO - 'tabpaint']}, 23:35:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:35:41 INFO - 'ts_paint', 23:35:41 INFO - 'tpaint', 23:35:41 INFO - 'sessionrestore', 23:35:41 INFO - 'sessionrestore_no_auto_restore', 23:35:41 INFO - 'tabpaint']}, 23:35:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:35:41 INFO - 'ts_paint', 23:35:41 INFO - 'tpaint', 23:35:41 INFO - 'sessionrestore', 23:35:41 INFO - 'sessionrestore_no_auto_restore', 23:35:41 INFO - 'tabpaint']}, 23:35:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:35:41 INFO - 'tests': ['a11yr', 23:35:41 INFO - 'ts_paint', 23:35:41 INFO - 'tpaint', 23:35:41 INFO - 'sessionrestore', 23:35:41 INFO - 'sessionrestore_no_auto_restore', 23:35:41 INFO - 'tabpaint']}, 23:35:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:35:41 INFO - 'tests': ['a11yr', 23:35:41 INFO - 'ts_paint', 23:35:41 INFO - 'tpaint', 23:35:41 INFO - 'sessionrestore', 23:35:41 INFO - 'sessionrestore_no_auto_restore', 23:35:41 INFO - 'tabpaint']}, 23:35:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:35:41 INFO - 'tests': ['tsvgx', 23:35:41 INFO - 'tsvgr_opacity', 23:35:41 INFO - 'tart', 23:35:41 INFO - 'tscrollx', 23:35:41 INFO - 'cart']}, 23:35:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:35:41 INFO - 'tsvgr_opacity', 23:35:41 INFO - 'tart', 23:35:41 INFO - 'tscrollx', 23:35:41 INFO - 'cart']}, 23:35:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:35:41 INFO - 'talos_options': ['--disable-e10s'], 23:35:41 INFO - 'tests': ['tp5o']}, 23:35:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:35:41 INFO - 'tests': ['tp5o']}, 23:35:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:35:41 INFO - 'talos_options': ['--disable-e10s', 23:35:41 INFO - '--xperf_path', 23:35:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:35:41 INFO - 'tests': ['tp5n']}, 23:35:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:35:41 INFO - 'talos_options': ['--xperf_path', 23:35:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:35:41 INFO - 'tests': ['tp5n']}}, 23:35:41 INFO - 'talos.zip': {'path': '', 23:35:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:35:41 INFO - Running post-action listener: _resource_record_post_action 23:35:41 INFO - ##### 23:35:41 INFO - ##### Running create-virtualenv step. 23:35:41 INFO - ##### 23:35:41 INFO - Running pre-action listener: _resource_record_pre_action 23:35:41 INFO - Running main action method: create_virtualenv 23:35:41 INFO - Creating virtualenv /builds/slave/test/build/venv 23:35:41 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 23:35:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:35:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:35:41 INFO - Using real prefix '/usr' 23:35:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:35:42 INFO - Installing distribute.............................................................................................................................................................................................done. 23:35:44 INFO - Installing pip.................done. 23:35:44 INFO - Return code: 0 23:35:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:35:44 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')]} 23:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:35:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:35:44 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')]} 23:35:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:35:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:35:44 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 0x7ff185311f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ec7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257b640>, '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 0x257c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x257c9d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1467872611.25231-945648131', '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 23:35:44 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 23:35:44 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 23:35:44 INFO - Using env: {'DISPLAY': ':0', 23:35:44 INFO - 'HOME': '/home/cltbld', 23:35:44 INFO - 'LANG': 'en_US.UTF-8', 23:35:44 INFO - 'LANGUAGE': 'en_US:en', 23:35:44 INFO - 'LOGNAME': 'cltbld', 23:35:44 INFO - 'MAIL': '/var/mail/cltbld', 23:35:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:35:44 INFO - 'MOZ_NO_REMOTE': '1', 23:35:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:35:44 INFO - 'NO_EM_RESTART': '1', 23:35:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:35:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:35:44 INFO - 'PWD': '/builds/slave/test', 23:35:44 INFO - 'SHELL': '/bin/bash', 23:35:44 INFO - 'SHLVL': '1', 23:35:44 INFO - 'TERM': 'linux', 23:35:44 INFO - 'TMOUT': '86400', 23:35:44 INFO - 'USER': 'cltbld', 23:35:44 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467872611.25231-945648131', 23:35:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:35:44 INFO - '_': '/tools/buildbot/bin/python'} 23:35:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:35:44 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 23:35:44 INFO - Cleaning up... 23:35:44 INFO - Return code: 0 23:35:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 23:35:44 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')]} 23:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:35:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:35:44 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')]} 23:35:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:35:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:35:44 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 0x7ff185311f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ec7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257b640>, '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 0x257c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x257c9d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1467872611.25231-945648131', '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 23:35:44 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 23:35:44 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 23:35:44 INFO - Using env: {'DISPLAY': ':0', 23:35:44 INFO - 'HOME': '/home/cltbld', 23:35:44 INFO - 'LANG': 'en_US.UTF-8', 23:35:44 INFO - 'LANGUAGE': 'en_US:en', 23:35:44 INFO - 'LOGNAME': 'cltbld', 23:35:44 INFO - 'MAIL': '/var/mail/cltbld', 23:35:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:35:44 INFO - 'MOZ_NO_REMOTE': '1', 23:35:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:35:44 INFO - 'NO_EM_RESTART': '1', 23:35:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:35:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:35:44 INFO - 'PWD': '/builds/slave/test', 23:35:44 INFO - 'SHELL': '/bin/bash', 23:35:44 INFO - 'SHLVL': '1', 23:35:44 INFO - 'TERM': 'linux', 23:35:44 INFO - 'TMOUT': '86400', 23:35:44 INFO - 'USER': 'cltbld', 23:35:44 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467872611.25231-945648131', 23:35:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:35:44 INFO - '_': '/tools/buildbot/bin/python'} 23:35:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:35:45 INFO - Downloading/unpacking psutil>=0.7.1 23:35:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:35:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:35:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:35:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:35:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:35:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:35:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:35:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:35:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:35:47 INFO - Installing collected packages: psutil 23:35:47 INFO - Running setup.py install for psutil 23:35:47 INFO - building 'psutil._psutil_linux' extension 23:35:47 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 23:35:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 23:35:49 INFO - building 'psutil._psutil_posix' extension 23:35:49 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 23:35:49 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 23:35:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:35:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:35:49 INFO - Successfully installed psutil 23:35:49 INFO - Cleaning up... 23:35:49 INFO - Return code: 0 23:35:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 23:35:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:35:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:35:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:35:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:35:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:35:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:35:49 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 0x7ff185311f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ec7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257b640>, '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 0x257c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x257c9d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1467872611.25231-945648131', '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 23:35:49 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 23:35:49 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 23:35:49 INFO - Using env: {'DISPLAY': ':0', 23:35:49 INFO - 'HOME': '/home/cltbld', 23:35:49 INFO - 'LANG': 'en_US.UTF-8', 23:35:49 INFO - 'LANGUAGE': 'en_US:en', 23:35:49 INFO - 'LOGNAME': 'cltbld', 23:35:49 INFO - 'MAIL': '/var/mail/cltbld', 23:35:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:35:49 INFO - 'MOZ_NO_REMOTE': '1', 23:35:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:35:49 INFO - 'NO_EM_RESTART': '1', 23:35:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:35:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:35:49 INFO - 'PWD': '/builds/slave/test', 23:35:49 INFO - 'SHELL': '/bin/bash', 23:35:49 INFO - 'SHLVL': '1', 23:35:49 INFO - 'TERM': 'linux', 23:35:49 INFO - 'TMOUT': '86400', 23:35:49 INFO - 'USER': 'cltbld', 23:35:49 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467872611.25231-945648131', 23:35:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:35:49 INFO - '_': '/tools/buildbot/bin/python'} 23:35:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:35:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:35:49 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 23:35:49 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 23:35:49 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 23:35:49 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 23:35:49 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 23:35:49 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 23:35:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:35:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:35:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:35:51 INFO - Installing collected packages: mozsystemmonitor 23:35:51 INFO - Running setup.py install for mozsystemmonitor 23:35:51 INFO - Successfully installed mozsystemmonitor 23:35:51 INFO - Cleaning up... 23:35:51 INFO - Return code: 0 23:35:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:35:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:35:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:35:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:35:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:35:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:35:51 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 0x7ff185311f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ec7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257b640>, '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 0x257c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x257c9d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1467872611.25231-945648131', '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 23:35:51 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 23:35:51 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 23:35:51 INFO - Using env: {'DISPLAY': ':0', 23:35:51 INFO - 'HOME': '/home/cltbld', 23:35:51 INFO - 'LANG': 'en_US.UTF-8', 23:35:51 INFO - 'LANGUAGE': 'en_US:en', 23:35:51 INFO - 'LOGNAME': 'cltbld', 23:35:51 INFO - 'MAIL': '/var/mail/cltbld', 23:35:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:35:51 INFO - 'MOZ_NO_REMOTE': '1', 23:35:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:35:51 INFO - 'NO_EM_RESTART': '1', 23:35:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:35:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:35:51 INFO - 'PWD': '/builds/slave/test', 23:35:51 INFO - 'SHELL': '/bin/bash', 23:35:51 INFO - 'SHLVL': '1', 23:35:51 INFO - 'TERM': 'linux', 23:35:51 INFO - 'TMOUT': '86400', 23:35:51 INFO - 'USER': 'cltbld', 23:35:51 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467872611.25231-945648131', 23:35:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:35:51 INFO - '_': '/tools/buildbot/bin/python'} 23:35:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:35:51 INFO - Downloading/unpacking blobuploader==1.2.4 23:35:51 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 23:35:51 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 23:35:51 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 23:35:51 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 23:35:51 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 23:35:51 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 23:35:53 INFO - Downloading blobuploader-1.2.4.tar.gz 23:35:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:35:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:35:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:35:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:35:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:35:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:35:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:35:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:35:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:35:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:35:54 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 23:35:54 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 23:35:54 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 23:35:54 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 23:35:54 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 23:35:54 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 23:35:54 INFO - Downloading docopt-0.6.1.tar.gz 23:35:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:35:54 INFO - Installing collected packages: blobuploader, requests, docopt 23:35:54 INFO - Running setup.py install for blobuploader 23:35:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:35:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:35:54 INFO - Running setup.py install for requests 23:35:54 INFO - Running setup.py install for docopt 23:35:55 INFO - Successfully installed blobuploader requests docopt 23:35:55 INFO - Cleaning up... 23:35:55 INFO - Return code: 0 23:35:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:35:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:35:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:35:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:35:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:35:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:35:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:35:55 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 0x7ff185311f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ec7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257b640>, '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 0x257c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x257c9d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1467872611.25231-945648131', '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 23:35:55 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 23:35:55 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 23:35:55 INFO - Using env: {'DISPLAY': ':0', 23:35:55 INFO - 'HOME': '/home/cltbld', 23:35:55 INFO - 'LANG': 'en_US.UTF-8', 23:35:55 INFO - 'LANGUAGE': 'en_US:en', 23:35:55 INFO - 'LOGNAME': 'cltbld', 23:35:55 INFO - 'MAIL': '/var/mail/cltbld', 23:35:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:35:55 INFO - 'MOZ_NO_REMOTE': '1', 23:35:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:35:55 INFO - 'NO_EM_RESTART': '1', 23:35:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:35:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:35:55 INFO - 'PWD': '/builds/slave/test', 23:35:55 INFO - 'SHELL': '/bin/bash', 23:35:55 INFO - 'SHLVL': '1', 23:35:55 INFO - 'TERM': 'linux', 23:35:55 INFO - 'TMOUT': '86400', 23:35:55 INFO - 'USER': 'cltbld', 23:35:55 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467872611.25231-945648131', 23:35:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:35:55 INFO - '_': '/tools/buildbot/bin/python'} 23:35:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:35:55 INFO - Running setup.py (path:/tmp/pip-4lgenk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:35:55 INFO - Running setup.py (path:/tmp/pip-EggNb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:35:55 INFO - Running setup.py (path:/tmp/pip-sjr5Xx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:35:55 INFO - Running setup.py (path:/tmp/pip-_a74LI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:35:55 INFO - Running setup.py (path:/tmp/pip-bHuGFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:35:55 INFO - Running setup.py (path:/tmp/pip-_jbr3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:35:55 INFO - Running setup.py (path:/tmp/pip-rfixpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:35:55 INFO - Running setup.py (path:/tmp/pip-5oKn0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:35:55 INFO - Running setup.py (path:/tmp/pip-Ts794h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:35:55 INFO - Running setup.py (path:/tmp/pip-FyCpmu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:35:56 INFO - Running setup.py (path:/tmp/pip-Eue3Lj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:35:56 INFO - Running setup.py (path:/tmp/pip-WhHJZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:35:56 INFO - Running setup.py (path:/tmp/pip-EYyg5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:35:56 INFO - Running setup.py (path:/tmp/pip-1OpHvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:35:56 INFO - Running setup.py (path:/tmp/pip-GPibGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:35:56 INFO - Running setup.py (path:/tmp/pip-c7_WM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:35:56 INFO - Running setup.py (path:/tmp/pip-M4UyTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:35:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:35:56 INFO - Running setup.py install for manifestparser 23:35:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:35:56 INFO - Running setup.py install for mozcrash 23:35:56 INFO - Running setup.py install for mozdebug 23:35:56 INFO - Running setup.py install for mozdevice 23:35:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:35:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:35:56 INFO - Running setup.py install for mozfile 23:35:57 INFO - Running setup.py install for mozhttpd 23:35:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:35:57 INFO - Running setup.py install for mozinfo 23:35:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:35:57 INFO - Running setup.py install for mozInstall 23:35:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:35:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:35:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:35:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:35:57 INFO - Running setup.py install for mozleak 23:35:57 INFO - Running setup.py install for mozlog 23:35:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:35:57 INFO - Running setup.py install for moznetwork 23:35:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:35:57 INFO - Running setup.py install for mozprocess 23:35:57 INFO - Running setup.py install for mozprofile 23:35:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:35:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:35:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:35:57 INFO - Running setup.py install for mozrunner 23:35:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:35:57 INFO - Running setup.py install for mozscreenshot 23:35:58 INFO - Running setup.py install for moztest 23:35:58 INFO - Running setup.py install for mozversion 23:35:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:35:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:35:58 INFO - Cleaning up... 23:35:58 INFO - Return code: 0 23:35:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:35: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')]} 23:35:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:35:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:35: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')]} 23:35:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:35:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:35:58 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 0x7ff185311f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ec7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257b640>, '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 0x257c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x257c9d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1467872611.25231-945648131', '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 23:35:58 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 23:35:58 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 23:35:58 INFO - Using env: {'DISPLAY': ':0', 23:35:58 INFO - 'HOME': '/home/cltbld', 23:35:58 INFO - 'LANG': 'en_US.UTF-8', 23:35:58 INFO - 'LANGUAGE': 'en_US:en', 23:35:58 INFO - 'LOGNAME': 'cltbld', 23:35:58 INFO - 'MAIL': '/var/mail/cltbld', 23:35:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:35:58 INFO - 'MOZ_NO_REMOTE': '1', 23:35:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:35:58 INFO - 'NO_EM_RESTART': '1', 23:35:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:35:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:35:58 INFO - 'PWD': '/builds/slave/test', 23:35:58 INFO - 'SHELL': '/bin/bash', 23:35:58 INFO - 'SHLVL': '1', 23:35:58 INFO - 'TERM': 'linux', 23:35:58 INFO - 'TMOUT': '86400', 23:35:58 INFO - 'USER': 'cltbld', 23:35:58 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467872611.25231-945648131', 23:35:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:35:58 INFO - '_': '/tools/buildbot/bin/python'} 23:35:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:35:58 INFO - Running setup.py (path:/tmp/pip-gjqpqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:35:58 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)) 23:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:35:58 INFO - Running setup.py (path:/tmp/pip-vxwNfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:35:58 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)) 23:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:35:58 INFO - Running setup.py (path:/tmp/pip-QV_UdY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:35:58 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)) 23:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:35:58 INFO - Running setup.py (path:/tmp/pip-rHoufL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:35:58 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)) 23:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:35:58 INFO - Running setup.py (path:/tmp/pip-JyNYXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:35:58 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)) 23:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:35:58 INFO - Running setup.py (path:/tmp/pip-uUFgk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:35:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 23:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:35:58 INFO - Running setup.py (path:/tmp/pip-qNAK2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:35:59 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)) 23:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:35:59 INFO - Running setup.py (path:/tmp/pip-pktXRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:35:59 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)) 23:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:35:59 INFO - Running setup.py (path:/tmp/pip-hJOGSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:35:59 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)) 23:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:35:59 INFO - Running setup.py (path:/tmp/pip-LpwFJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:35:59 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)) 23:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:35:59 INFO - Running setup.py (path:/tmp/pip-AyMVG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:35:59 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)) 23:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:35:59 INFO - Running setup.py (path:/tmp/pip-E_Xokg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:35:59 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)) 23:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:35:59 INFO - Running setup.py (path:/tmp/pip-n6MDjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:35:59 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)) 23:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:35:59 INFO - Running setup.py (path:/tmp/pip-4w2202-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:35:59 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)) 23:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:35:59 INFO - Running setup.py (path:/tmp/pip-cbRxrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:35:59 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)) 23:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:35:59 INFO - Running setup.py (path:/tmp/pip-PvXg9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:35:59 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)) 23:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:35:59 INFO - Running setup.py (path:/tmp/pip-BUDfpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:35:59 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)) 23:35:59 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)) 23:35:59 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)) 23:35:59 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)) 23:35:59 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)) 23:35:59 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)) 23:35:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:35:59 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 23:35:59 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 23:35:59 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 23:35:59 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 23:35:59 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 23:35:59 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 23:36:01 INFO - Downloading blessings-1.6.tar.gz 23:36:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:36:01 INFO - Installing collected packages: blessings 23:36:01 INFO - Running setup.py install for blessings 23:36:01 INFO - Successfully installed blessings 23:36:01 INFO - Cleaning up... 23:36:02 INFO - Return code: 0 23:36:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:36:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:36:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:36:02 INFO - Reading from file tmpfile_stdout 23:36:02 INFO - Current package versions: 23:36:02 INFO - argparse == 1.2.1 23:36:02 INFO - blessings == 1.6 23:36:02 INFO - blobuploader == 1.2.4 23:36:02 INFO - docopt == 0.6.1 23:36:02 INFO - manifestparser == 1.1 23:36:02 INFO - mozInstall == 1.12 23:36:02 INFO - mozcrash == 0.17 23:36:02 INFO - mozdebug == 0.1 23:36:02 INFO - mozdevice == 0.48 23:36:02 INFO - mozfile == 1.2 23:36:02 INFO - mozhttpd == 0.7 23:36:02 INFO - mozinfo == 0.9 23:36:02 INFO - mozleak == 0.1 23:36:02 INFO - mozlog == 3.1 23:36:02 INFO - moznetwork == 0.27 23:36:02 INFO - mozprocess == 0.22 23:36:02 INFO - mozprofile == 0.28 23:36:02 INFO - mozrunner == 6.11 23:36:02 INFO - mozscreenshot == 0.1 23:36:02 INFO - mozsystemmonitor == 0.0 23:36:02 INFO - moztest == 0.7 23:36:02 INFO - mozversion == 1.4 23:36:02 INFO - psutil == 3.1.1 23:36:02 INFO - requests == 1.2.3 23:36:02 INFO - wsgiref == 0.1.2 23:36:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:36:02 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')]} 23:36:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:36:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:02 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')]} 23:36:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:36:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:02 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 0x7ff185311f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ec7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257b640>, '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 0x257c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x257c9d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1467872611.25231-945648131', '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 23:36:02 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 23:36:02 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 23:36:02 INFO - Using env: {'DISPLAY': ':0', 23:36:02 INFO - 'HOME': '/home/cltbld', 23:36:02 INFO - 'LANG': 'en_US.UTF-8', 23:36:02 INFO - 'LANGUAGE': 'en_US:en', 23:36:02 INFO - 'LOGNAME': 'cltbld', 23:36:02 INFO - 'MAIL': '/var/mail/cltbld', 23:36:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:36:02 INFO - 'MOZ_NO_REMOTE': '1', 23:36:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:36:02 INFO - 'NO_EM_RESTART': '1', 23:36:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:36:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:36:02 INFO - 'PWD': '/builds/slave/test', 23:36:02 INFO - 'SHELL': '/bin/bash', 23:36:02 INFO - 'SHLVL': '1', 23:36:02 INFO - 'TERM': 'linux', 23:36:02 INFO - 'TMOUT': '86400', 23:36:02 INFO - 'USER': 'cltbld', 23:36:02 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467872611.25231-945648131', 23:36:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:36:02 INFO - '_': '/tools/buildbot/bin/python'} 23:36:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:36:02 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)) 23:36:02 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)) 23:36:02 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)) 23:36:02 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)) 23:36:02 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)) 23:36:02 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)) 23:36:02 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)) 23:36:02 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)) 23:36:02 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)) 23:36:02 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)) 23:36:02 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)) 23:36:02 INFO - Cleaning up... 23:36:02 INFO - Return code: 0 23:36:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:36:02 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')]} 23:36:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:36:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:02 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')]} 23:36:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:36:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:02 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 0x7ff185311f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ec7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257b640>, '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 0x257c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x257c9d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1467872611.25231-945648131', '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 23:36:02 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 23:36:02 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 23:36:02 INFO - Using env: {'DISPLAY': ':0', 23:36:02 INFO - 'HOME': '/home/cltbld', 23:36:02 INFO - 'LANG': 'en_US.UTF-8', 23:36:02 INFO - 'LANGUAGE': 'en_US:en', 23:36:02 INFO - 'LOGNAME': 'cltbld', 23:36:02 INFO - 'MAIL': '/var/mail/cltbld', 23:36:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:36:02 INFO - 'MOZ_NO_REMOTE': '1', 23:36:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:36:02 INFO - 'NO_EM_RESTART': '1', 23:36:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:36:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:36:02 INFO - 'PWD': '/builds/slave/test', 23:36:02 INFO - 'SHELL': '/bin/bash', 23:36:02 INFO - 'SHLVL': '1', 23:36:02 INFO - 'TERM': 'linux', 23:36:02 INFO - 'TMOUT': '86400', 23:36:02 INFO - 'USER': 'cltbld', 23:36:02 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467872611.25231-945648131', 23:36:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:36:02 INFO - '_': '/tools/buildbot/bin/python'} 23:36:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:36:02 INFO - Downloading/unpacking jsonschema 23:36:02 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 23:36:02 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 23:36:02 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 23:36:02 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 23:36:02 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 23:36:02 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 23:36:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:36:04 INFO - Downloading/unpacking functools32 (from jsonschema) 23:36:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:36:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:36:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:36:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:36:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:36:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:36:04 INFO - Downloading functools32-3.2.3-2.tar.gz 23:36:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:36:04 INFO - warning: no files found matching '*.txt' 23:36:04 INFO - no previously-included directories found matching 'build' 23:36:04 INFO - no previously-included directories found matching 'dist' 23:36:04 INFO - no previously-included directories found matching '.git*' 23:36:04 INFO - Installing collected packages: jsonschema, functools32 23:36:04 INFO - Running setup.py install for functools32 23:36:05 INFO - warning: no files found matching '*.txt' 23:36:05 INFO - no previously-included directories found matching 'build' 23:36:05 INFO - no previously-included directories found matching 'dist' 23:36:05 INFO - no previously-included directories found matching '.git*' 23:36:05 INFO - Successfully installed jsonschema functools32 23:36:05 INFO - Cleaning up... 23:36:05 INFO - Return code: 0 23:36:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:36:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:36:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:36:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:36:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:36:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff185311f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ec7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257b640>, '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 0x257c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x257c9d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1467872611.25231-945648131', '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 23:36:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 23:36:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 23:36:05 INFO - Using env: {'DISPLAY': ':0', 23:36:05 INFO - 'HOME': '/home/cltbld', 23:36:05 INFO - 'LANG': 'en_US.UTF-8', 23:36:05 INFO - 'LANGUAGE': 'en_US:en', 23:36:05 INFO - 'LOGNAME': 'cltbld', 23:36:05 INFO - 'MAIL': '/var/mail/cltbld', 23:36:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:36:05 INFO - 'MOZ_NO_REMOTE': '1', 23:36:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:36:05 INFO - 'NO_EM_RESTART': '1', 23:36:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:36:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:36:05 INFO - 'PWD': '/builds/slave/test', 23:36:05 INFO - 'SHELL': '/bin/bash', 23:36:05 INFO - 'SHLVL': '1', 23:36:05 INFO - 'TERM': 'linux', 23:36:05 INFO - 'TMOUT': '86400', 23:36:05 INFO - 'USER': 'cltbld', 23:36:05 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467872611.25231-945648131', 23:36:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:36:05 INFO - '_': '/tools/buildbot/bin/python'} 23:36:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:36:05 INFO - Downloading/unpacking flake8 23:36: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 23:36: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 23:36: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 23:36: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 23:36: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 23:36: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 23:36:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:36:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:36: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 23:36: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 23:36: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 23:36: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 23:36: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 23:36: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 23:36:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:36:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:36: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 23:36: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 23:36: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 23:36: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 23:36: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 23:36: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 23:36:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:36: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 23:36: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 23:36: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 23:36: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 23:36: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 23:36: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 23:36:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:36:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:36:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:36:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:36:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:36:07 INFO - no previously-included directories found matching 'docs/_build' 23:36:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:36:08 INFO - Running setup.py install for pep8 23:36:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:36:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:36:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:36:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:36:08 INFO - no previously-included directories found matching 'docs/_build' 23:36:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:36:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:36:08 INFO - Cleaning up... 23:36:08 INFO - Return code: 0 23:36:08 INFO - Running post-action listener: _resource_record_post_action 23:36:08 INFO - Running post-action listener: _start_resource_monitoring 23:36:08 INFO - Starting resource monitoring. 23:36:08 INFO - ##### 23:36:08 INFO - ##### Running install step. 23:36:08 INFO - ##### 23:36:08 INFO - Running pre-action listener: _resource_record_pre_action 23:36:08 INFO - Running main action method: install 23:36:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:36:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:36:08 INFO - Reading from file tmpfile_stdout 23:36:08 INFO - Detecting whether we're running mozinstall >=1.0... 23:36:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:36:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:36:08 INFO - Reading from file tmpfile_stdout 23:36:08 INFO - Output received: 23:36:08 INFO - Usage: mozinstall [options] installer 23:36:08 INFO - Options: 23:36:08 INFO - -h, --help show this help message and exit 23:36:08 INFO - -d DEST, --destination=DEST 23:36:08 INFO - Directory to install application into. [default: 23:36:08 INFO - "/builds/slave/test"] 23:36:08 INFO - --app=APP Application being installed. [default: firefox] 23:36:08 INFO - mkdir: /builds/slave/test/build/application 23:36:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 23:36:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 23:36:21 INFO - Reading from file tmpfile_stdout 23:36:21 INFO - Output received: 23:36:21 INFO - /builds/slave/test/build/application/firefox/firefox 23:36:21 INFO - Running post-action listener: _resource_record_post_action 23:36:21 INFO - ##### 23:36:21 INFO - ##### Running run-tests step. 23:36:21 INFO - ##### 23:36:21 INFO - Running pre-action listener: _resource_record_pre_action 23:36:21 INFO - Running main action method: run_tests 23:36:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:36:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:36:21 INFO - Python 2.7.3 23:36:21 INFO - Return code: 0 23:36:21 INFO - grabbing minidump binary from tooltool 23:36:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:36:21 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 0x257b640>, '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 0x257c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x257c9d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:36:21 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 23:36:21 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 23:36:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:36:21 INFO - Return code: 0 23:36:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:36:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:36:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:36:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:36:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:36:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:36:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:36:22 INFO - Return code: 0 23:36:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 23:36:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --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 23:36:22 INFO - Using env: {'DISPLAY': ':0', 23:36:22 INFO - 'HOME': '/home/cltbld', 23:36:22 INFO - 'LANG': 'en_US.UTF-8', 23:36:22 INFO - 'LANGUAGE': 'en_US:en', 23:36:22 INFO - 'LOGNAME': 'cltbld', 23:36:22 INFO - 'MAIL': '/var/mail/cltbld', 23:36:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:36:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:36:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:36:22 INFO - 'MOZ_NO_REMOTE': '1', 23:36:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:36:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:36:22 INFO - 'NO_EM_RESTART': '1', 23:36:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:36:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:36:22 INFO - 'PWD': '/builds/slave/test', 23:36:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:36:22 INFO - 'SHELL': '/bin/bash', 23:36:22 INFO - 'SHLVL': '1', 23:36:22 INFO - 'TERM': 'linux', 23:36:22 INFO - 'TMOUT': '86400', 23:36:22 INFO - 'USER': 'cltbld', 23:36:22 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467872611.25231-945648131', 23:36:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:36:22 INFO - '_': '/tools/buildbot/bin/python'} 23:36:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 23:36:23 INFO - mozversion application_buildid: 20160706204229 23:36:23 INFO - mozversion application_changeset: e4b27dae353c933a01584dfeff27d547ef60f04e 23:36:23 INFO - mozversion application_display_name: Firefox 23:36:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:36:23 INFO - mozversion application_name: Firefox 23:36:23 INFO - mozversion application_remotingname: firefox 23:36:23 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 23:36:23 INFO - mozversion application_vendor: Mozilla 23:36:23 INFO - mozversion application_version: 48.0 23:36:23 INFO - mozversion platform_buildid: 20160706204229 23:36:23 INFO - mozversion platform_changeset: e4b27dae353c933a01584dfeff27d547ef60f04e 23:36:23 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 23:36:23 INFO - mozversion platform_version: 48.0 23:36:23 INFO - using testdate: 1467873383 23:36:23 INFO - actual date: 1467873383 23:36:23 INFO - starting webserver on 'localhost:46939' 23:36:23 INFO - SUITE-START | Running 2 tests 23:36:23 INFO - TEST-START | dromaeo_css 23:36:23 INFO - operating with platform_type : linux_ 23:36:23 INFO - Initialising browser for dromaeo_css test... 23:36:23 INFO - TEST-INFO | started process 3327 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPzttb_/profile http://localhost:46939/getInfo.html) 23:36:27 INFO - PROCESS | 3327 | __metrics Screen width/height:1600/1200 23:36:27 INFO - PROCESS | 3327 | colorDepth:24 23:36:27 INFO - PROCESS | 3327 | Browser inner width/height: 1024/697 23:36:27 INFO - PROCESS | 3327 | __metrics 23:36:28 ERROR - PROCESS | 3327 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:36:29 INFO - TEST-INFO | 3327: exit 0 23:36:29 INFO - Browser initialized. 23:36:29 INFO - Running cycle 1/1 for dromaeo_css test... 23:36:29 INFO - TEST-INFO | started process 3422 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPzttb_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:36:41 INFO - PROCESS | 3422 | RSS: Main: 139374592 23:36:41 INFO - PROCESS | 3422 | 23:37:32 INFO - PROCESS | 3422 | 1467873452376 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] 23:39:40 INFO - PROCESS | 3422 | Cycle 1(1): loaded http://localhost:46939/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46939/tests/dromaeo/cssquery-ext.html) 23:39:41 INFO - PROCESS | 3422 | RSS: Main: 249102336 23:39:41 INFO - PROCESS | 3422 | 23:42:43 INFO - PROCESS | 3422 | Cycle 1(1): loaded http://localhost:46939/tests/dromaeo/cssquery-ext.html (next: http://localhost:46939/tests/dromaeo/cssquery-jquery.html) 23:42:43 INFO - PROCESS | 3422 | RSS: Main: 224641024 23:42:43 INFO - PROCESS | 3422 | 23:45:45 INFO - PROCESS | 3422 | Cycle 1(1): loaded http://localhost:46939/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46939/tests/dromaeo/cssquery-mootools.html) 23:45:46 INFO - PROCESS | 3422 | RSS: Main: 211775488 23:45:46 INFO - PROCESS | 3422 | 23:48:47 INFO - PROCESS | 3422 | Cycle 1(1): loaded http://localhost:46939/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46939/tests/dromaeo/cssquery-prototype.html) 23:48:48 INFO - PROCESS | 3422 | RSS: Main: 219942912 23:48:48 INFO - PROCESS | 3422 | 23:51:51 INFO - PROCESS | 3422 | Cycle 1(1): loaded http://localhost:46939/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46939/tests/dromaeo/cssquery-yui.html) 23:51:51 INFO - PROCESS | 3422 | RSS: Main: 210681856 23:51:51 INFO - PROCESS | 3422 | 23:54:53 INFO - PROCESS | 3422 | Cycle 1(1): loaded http://localhost:46939/tests/dromaeo/cssquery-yui.html (next: http://localhost:46939/tests/dromaeo/cssquery-dojo.html) 23:54:54 INFO - PROCESS | 3422 | RSS: Main: 248832000 23:54:54 INFO - PROCESS | 3422 | 23:54:54 INFO - PROCESS | 3422 | __start_tp_report 23:54:54 INFO - PROCESS | 3422 | _x_x_mozilla_page_load 23:54:54 INFO - PROCESS | 3422 | _x_x_mozilla_page_load_details 23:54:54 INFO - PROCESS | 3422 | |i|pagename|runs| 23:54:54 INFO - PROCESS | 3422 | |0;dojo.html;3272.672732726727;3320.5517255170544;3328.866845326187;3340.615829179645;3369.157710572357;5455.563554915607;5477.616566840323;5483.945160548394;5497.257870187528;5500.092484740018;5457.945420545793;5463.672179669223;5472.179173124034;5484.862878428041;5502.504774570288;4934.80260789568;4940.4318503372215;5006.22403527452;5038.697678139305;5086.923696144542;4946.208606622941;5043.36957880265;5078.238264260353;5081.949180508203;5082.771275292602;4929.605631549485;4990.87522811929;4999.850004499871;5018.146915024437;5092.388913330406;5054.267131265964;5059.013492368989;5082.2122571001555;5088.033273677989;5111.514406131411;4877.463479017305;4897.191963326047;4967.478414766434;4998.300237966651;4999.075171093359;5350.411454739976;5363.329583802025;5369.006733754229;5388.46115388458;5414.972925135388;5880.26496687914;5923.111533270044;5923.259592550931;5929.822105336847;5932.11018347247;5898.587098903078;5932.584719069667;5956.493698035629;5971.164037034819;5988.31134419543;5495;5517.751701173457;5542.5565954723525;5543.279373681436;5557.083081291623;5848.64908105515;6052.092186172109;6063.393660633989;6071.271447426248;6077.361877002851;5731.426857314319;5816.767329306865;5819.301683797887;5822;5832.416758324219;5889.381614930457;5899.587028907935;5914.4381283777975;5929.703514824328;5931.970340148272;5749.8275051748515;5763.510101641407;5877.706114694333;5896.911546326808;5899.646021238739;5863.736131874076;5892.381299963527;5899.764009439575;5903.76384944606;5936.1392598073035;4558.749268790249;4565.155446242389;4573.771311434415;4574.176648203355;4597.195490789099;3983.342748446532;3986.740861843971;4048.919021619551;4079.1841631673783;4125.23683118624;5515.917261241085;5572.749226284827;5603.607747457639;5604.663720176803;5614.719264036864;5903.970480147572;5912.054071348563;5921.289445266596;5924;5928.4960778334325;5373.731313434313;5543.334799823966;5593.300837395325;5599.776008959678;5642.689652069093;5084.872878178076;5124.948750512447;5129.692218466904;5137;5141.845744627667;6083.117947897618;6086.695665216722;6097.75608975636;6105;6110.358412366726;5814.447627475383;5865.266841644794;5945.910811337833;5979.431953964367;5989.580729348903;6033.9698301508215;6066.090086487062;6067.575269731076;6072.30168530607;6074.331823499323;5783.334916484658;5807.245058142415;5810.477057064715;5813.476787089182;5822.854428639318;5759.596828221985;5925.1704761332585;5980.581359304807;6011.308699499614;6022.066579680157;5784.2191304175085;5784.768609255582;5812.82561523155;5814.215080964016;5817.331006934088;5679.77280908759;5761.596688231783;5798.739056742541;5817.214676018683;5819.330776960704;5667.8866422672145;5723.313202415737;5727.226824378656;5750.942490575041;5764.308283006066;5790.884182316414;5797.449242321973;5801.709914504342;5802;5820.621659592113;5567.777288908398;5666.17840413146;5669.971650141723;5679.233303503974;5698.515626171822 23:54:54 INFO - PROCESS | 3422 | |1;ext.html;652.2531701202124;678.7726111752563;680.2585182151455;724.5978481942523;746.276112171194;33201.84188027777;41041.384379234296;41736.16527669448;41794.791026044826;41863.79068104663;43784.78107609457;44271;44426.11147777043;44435.77782111093;44498.110037799226;8060.516369017878;8794.076621954699;8974.910250897472;8975.506347150904;10412.947935260314;10414;10538.420386878719;10542.156627469783;10550.99765522278;10554.78890422191;10542.683719488428;10612.522436490337;10613.893861061368;10620.681379558626;10627.52176152075;10522.42126683032;10574.259801813876;10591.470426478683;10591.894081059207;10595.576176952989;10474.42390668513;10586.894131058745;10598.364098154058;10907.18196135293;10914.563417463292;44115;44624.553754462366;44638.10723785506;44654.553454465364;44802;3833.674137698271;3946.3488524393442;4131.731437456586;4150.626443620058;4603.125406172817;34525.6547434525;34931.126721831904;35075;35302.470462942816;36397.818010909774;4336.3712261722185;4362.563743625612;4404.075144219718;4429.202743506167;4466.419365482467;339096;339175.99999999756;339301;339314;341837;39265.41101883474;39691.80154099269;64772.67613661996;65403.34596654068;65459;38414.615853841664;38523.22953540913;38612.80693596514;38672;38683.80658096748;16059.839401606068;16193.190340482928;16255.918720406558;16265.430709925096;16281.348746050026;14634.268286585628;15201.923990379977;15216.619584510254;15255.61860953463;15264.923675381551;9290.814183716288;9315.860262096074;9369.812603748023;9412.67055653049;9423.575939082757;3550.396432606463;3655.7440979131206;3665.6151104133683;3674.6325367463573;3692.464592634053;1174.9706257343635;1221.694576355911;1229.9200551964093;1237.672016915518;1279.2132838304376;34055.489167662505;34067.4889876652;34181;35243.29513409718;35354.64645353565;1245.1221888568537;1270.39021269791;1307.60118163959;1322.9140105893086;1385.7852032934911;17399;18004.417897437183;18035.42190807051;18143.257782169105;18151.67675315084;487379;490500;491950;493304;494421;60926.39073609207;61452.38547614556;61867;61970;62133;1365.8497565267812;1492.2091291615461;1538.3154496249063;1544.567521094073;1624.358378440533;30468.390632186787;31093;32248.83875580607;32307.35385292328;32347.514787277738;45230.09539809251;45504.54495455003;45875;45881.31178032399;45926;250770;251766;253631;254195;254558;28591;29540.704592953796;31230.37539249248;31793.523097154022;31818.522722158723;44919;45348.77325613483;45458;45833.77083114563;46254;41369.586304137774;41392;41432.3785143217;41533.79233103815;42600.786996064824;39848.286476707995;39905.800470997456;40047.19905601814;41308.79345603253;41976.790116049226;42058.78970605128;42774.78612606917;43144;43447.348289775044;43763;36382.27235455223;37363.6263637371;37530.62469375271;37576.43635345527;38435.42346864743;28954.276143095747;29393.2131949599;29450.349468547935;29613.555796662637;29667.368294743996 23:54:54 INFO - PROCESS | 3422 | |2;jquery.html;428.20567846644457;428.98284068637264;431.6999685218774;432.70792215254716;440.00693704630476;18728;18842.717359239607;19539.609207815836;20094.39716808498;20461.079251433723;20054.598908021868;20214.49463763403;20356;20524.28165014225;20580.794192058074;5585.357683866357;5726.255586773714;5835.124731290319;5854.970725146369;5855.912161317584;4320.4599425071865;5762.9135562966585;5798.536117110621;6255;6560.901586476183;6507.219133703962;6535.183102112236;6543;6547.836304092388;6548.967255163718;6270;6335.208098987627;6385.2656944451055;6398.13625160602;6398.808035758934;3956.643902048829;5424.755885985141;5657.3494048184575;5714.200011998323;5721.284839395075;21873.234436794795;22303.219387321366;22340.441488962744;22358.10567577295;22422.439439013993;2504.887280072383;2601.8829152688177;2615.215435369382;2803.313188268887;2900.390917907242;13879.375428105759;14025.158490490603;14139.293035348192;14198.503052393116;14269.215193164371;1997.6004799040104;2067.400453868376;2123.1189056541516;2146.61360955028;2202.9889850550644;78986.60506697487;80044.59977700132;80534;81163;81909;10830.891691083147;10975.890241097486;11131.888681113247;11231.66305010851;11436.370999595103;15294.311755971008;15296.77625789934;15419.61450963735;15421.922890385476;15443.691126177413;8720;9006.504642244608;9064.682736104336;9108.134727200906;9147.77130571741;9081.954590227007;9101.089891010979;9122.270218382513;9198.126178013077;9209.907900921038;4968.552830245295;4994.076095922266;5024.899502009939;5089.338386009795;5159.477954003578;1813.0696618590632;1951.8145776151243;1982.6233015726966;2004.38866145824;2071.7513898332295;1007.1640538353149;1097.3196618096672;1104.26566333389;1105.1269497097203;1198.8321634971112;17913;18090.819091809175;18177.72733409;18419.26322947094;19045.61908761817;1055.176961969665;1056.894310568937;1143.9142064345208;1164.772869290497;1199.0827017331749;10726.356418614909;10801.297915635458;10823;10918.72703182411;10920.945395272973;528131;536420;544805;550123;581787;87114;88241.55879220563;88310.55844720735;88316.55841720878;88354.11645883588;1095.912327013837;1108.8225883858545;1116.5757012335423;1131.7227279316455;1137.181229514748;16856;16948.237329319963;16996.320147194467;17116.315347385964;17133.82866171322;37517.81241093777;38172.52810249019;39200.41199381954;40198.39702404525;40531.79734101311;54944.17583736327;55296.72351638377;55629;55674.16488752591;55959.72020139873;8034.276915077671;8326.000879894451;8379.748607541784;8408.747737567883;8426.410151289596;11614.361210133524;11740.412979350827;12003.939980300043;12025;12254.20347677398;10607.363558186533;10615.31000484966;10809.297395669257;10863.348199108079;10871.347719136877;5201.531862132426;8617.48295102296;10042.493625956165;10353.378797272188;10812.56749730002;10654.62708805188;10849.294795838245;10922.07162391174;10981.450927453756;11064.17018723615;8115.107338192912;8189.631466583899;8193.59032048407;8245.051819040647;8315.334773218006;9580.473073980998;9890.851637225303;10635.468226588795;10689.572417103229;10873.456327183767 23:54:54 INFO - PROCESS | 3422 | |3;mootools.html;1388.1116085705157;1556.914369709666;1573.4492927475385;1791.3909270847917;1927.8746881452714;8283.627236774344;8450.535220562866;8473.364497662677;8485.44844585103;8487.448315859472;8340.291075258596;8540;8540.274076703472;8545.91454085459;8558.529280889548;2427.271818454461;2448.9142879999204;2451.7915977141965;2452.791512721421;2453.1046168148587;2416.2871952773885;2423.684920960273;2455.067074511683;2463.470353873917;2463.6427717980973;2394.760523947609;2411.46947671512;2417.311066346083;2444.4499987502845;2450.2649205238445;2376.881155942196;2419.5160967806332;2431.234161239213;2441.4628781668002;2444.1934161726585;2412.4210189554556;2474.2206205045354;2488.8631125288102;2489.4896546207983;2490.3151633300804;7523.924760752432;8031.397645176635;8713.695020674246;8749.518776467292;8777.7805554861;5234.502722241419;5295.973520132375;5354.759035843396;5365.409804921455;5370.113931201347;3550.0769799851964;3551.183227857581;3623.474596183565;3636.890893273206;3654.817259137059;1206.9094817888606;1210.5157936825253;1248.4194849395076;1271.5994461744522;1275.9106862519627;11866.881331186663;12253.387330633434;12321.199122057127;12339.321337326444;12372.56696015644;4787.257975013878;4788.281757736368;4818.638602104857;4846.466888642247;4891.9755401222765;10503.52734126966;10528.473576321307;10530.210234232463;10545.578176872992;10554.050135487689;5328.3605967284175;5396.78412863481;5410.269613602192;5420.783168673288;5424.213489044067;4926;4931.432885218246;4935.506449355107;4936.605071594336;4937.037277730879;3796.088938654703;3808.257389808961;3832.1186127190904;3837.1174629835295;3845.2117315950163;1199.3763243113533;1200.9579664711869;1209.3590397089556;1216.1304667163022;1216.7748966441059;925.546482223719;989.9257555683353;1068.8450174724621;1072.5441687282873;1078.665613659768;6012.767382686538;6125.234345706786;6137.202163718688;6214.9689251553455;6240.533474633457;1021.1779517488345;1031.4327120083924;1054;1056.144522936424;1059.2267644619471;3689.3543629864666;4203.70574059819;4244.384564238168;4261.829526818955;4263.232618128766;10394.896051039394;10472.371657700562;10594;10617;10634.521446534924;10165.796684066425;10348.068673819393;10351.378917264989;10450.529726162342;10455;7976.282134607914;8063.19368063189;8073.31376832964;8081.191880811989;8134.877976830352;5839.562032847469;5910.556708246812;5915.112733090071;6098.878022439438;6114.449699526886;9284.3036772241;9304.95347523258;9378.249740020918;9413.341066125306;9439.669611563562;9161.908380916106;9525.285603579621;9529.285303602119;9733.464659443798;9741.318107732392;7799.961000194962;7846.568438735696;7846.646900889587;7853.960730196312;7926.247006534601;8352.665893364197;8541;8560.357973151915;8564.486130831921;8569.271611912807;7525.096988361432;7611.086669599684;7812.101608314889;7855.214478552099;7936.722214722457;7631.046119235096;7658.234176582298;7680.69277228927;7712.498687585289;7752.3798096153305;7275.927240727525;7289.088863892013;7294.708211671474;7324.4140468763435;7339.266073392618;5213.947860521346;5220.112580861187;5282.31329927107;5355.089634762022;5364.490373414519;5383;5395.136778115482;5405.702686352289;5457.951394959726;5476.91784623239 23:54:54 INFO - PROCESS | 3422 | |4;prototype.html;363.11219069375375;366.9504616876721;367.4231456613118;371.4057507987219;371.9460678201661;6101.78643747469;6105.816825495232;6105.938940610598;6113.5414843886665;6139.72371243294;6062.424069713381;6123;6123.265208175025;6149.754009839612;6157.692115394224;4486.32705094236;4610.147122782279;4719.1977363848055;4721.7639118044135;4728.385309909707;4694.741789201593;4724.551167639069;4737.431508219001;4738.64460165489;4744.97627511862;4439.911201775963;4699.365585645945;4700.459447163568;4701.435827700664;4707.505711900252;4496.842610508633;4556.70381425208;4636.863968327748;4653.7440440775745;4688.835890743841;4156.937645935313;4162.500499939996;4167.541570427251;4168.8332466701295;4170.124273902484;5866.178734977107;5876.324222714357;5890.381509941437;5890.440408161217;5891.882162356729;5498.340199176125;5499.175123731432;5513.173024046385;5515.7242137892945;5517.889642207174;6412.006139048455;6418.390252925965;6434.195725534309;6438.678066096723;6451.322611125811;4405.052913623555;4518.91546028954;4552.22612155931;4568.588827005552;4588.334691469751;6662.300458451889;6777.322267773183;6779.389854913032;6785.59286442815;6795.2185498667795;4555.407796986437;4561.452625684873;4576.542345765397;4577.450705915311;4578.908421831611;4623.214053610895;4627.838025669085;4630.907381852411;4640.164770341304;4642.37327960721;5328.520433161034;5340.91988620171;5347.3583170019065;5351.705656188869;5354.732263386815;6402.775902843378;6451.451626611791;6505.219373675094;6527.934720652733;6530.934690653127;1630.4700972184087;1644.580631938848;1653.884228104021;1655.8095818980971;1658.461000174948;1034.674077665548;1083;1083.4257843343041;1087.6247694545368;1113.7104352868312;6128.1114238435175;6214.751409943642;6222.0355844844125;6228.096925945712;6241.282252540925;6622.437092847065;6628.105205797252;6637.46900247979;6639.4024537790865;6644.800655980328;6205.03821907596;6210.192674952227;6219.657918814418;6226.937730622636;6234.781782637677;3531.5762108547137;3571.8928432147077;3580.445031020196;3580.8925732228076;3581.3374525712825;6680.632565208863;6816.488763342769;6940.514164008471;6947.166340039228;6949.200841903245;6919.515633905679;6937.9653101735175;6942.444604431634;6949.096617439701;6950.339717726808;6910.827229319207;6971.721131154697;6987.266337034742;6992.6853291602;6997.195322537973;6745.561538499982;6762.797116086525;6771.322867713189;6774.661266936535;6775.1531058617675;6555.901661474986;6662.333766623299;6686.465082793462;6686.531942764154;6691.76578819739;6862.622555759282;6888.931110688829;6901.585904845725;6916.273791251846;6919.550229235084;4635.188841952712;4665;4672.392588963413;4673.626109911267;4680.461746899014;6799.966000169968;6800.6599670017295;6833.111695479754;6844.623545704835;6846.3153684633135;6441.613503189824;6553.475721942328;6556.442702370352;6563.278039415756;6578.967105164444;6535.313792051957;6543.770968016097;6563;6603.80188594343;6621;6441.227052753699;6441.645709485836;6446.161998940108;6447.774327898501;6448.774292899726;6574.342565743387;6576.671166441563;6582.835429114119;6595.109660196004;6595.769148079794;6076.392360763888;6275.713478736757;6365.586236894587;6420.1974753155855;6517.348265173445 23:54:54 INFO - PROCESS | 3422 | |5;yui.html;846.7883029242689;861.3539845116163;928.7770934975606;936.2697096264914;968.922486201104;14253.501127460528;14353.425862965469;14359.425622975068;14369.78445323321;14954.476593319236;14000.179976603027;14292;14346.354414051366;14364.20996845173;14384.1369517829;902.4720538484994;902.7788191892979;917.7889085510336;918.8254231695956;919.586186216202;893.6559424621503;896.9953651909838;899.1817446124029;899.6671231644301;899.8380291547519;959.5729900194416;962.0812124421196;966.3622009473748;967.1150896929337;968.7432830299977;961.4375590279694;962.3840741925103;962.74006018375;963.0177219236375;963.1572374172634;702.0382076555101;704.4082970304969;705.0517054561607;705.8694141583824;707.0702026834696;14496.855031449655;14503.854961450355;14527.128372297697;14564.85435145656;14610.780838287434;11753.059755219647;12372.257664540157;12590.874091259153;12990.22058676473;13919.930400348036;11454.198206125575;12163.878361216452;12213.145079844415;12300.077494187972;13356.19862808225;4008.8596899108393;4033.838646454138;4051.554329023805;4113.588641135862;4120.526139493966;53799.46200538023;54504;54811.17783233295;55000.72499637476;58604.12093818554;11564.42177891102;11747.17769756126;11936.343501107349;12023.278603283656;12058.457369418396;20489.590208195754;20671.17315307401;20681.069351879203;20701.58596828085;20783.168673253203;8827.558622069;8914.242289405343;8931.240844528158;8993.685221017233;9315;4961.305417241589;5061.31672224245;5088.491150884956;5123.948760512421;5184.403793563789;3595.2270261893295;3655.0314166745834;3657.5976642569294;3658;3664.0656632558525;647.1974751308438;661.8113837556274;663.9170103737033;673.4174938678008;689.2969171445098;681.6489507903434;750.6096829648552;772.1814876231213;803.7066470738256;828.6726742936506;9181.81636367269;9603.327767056378;9715.365088248798;9878.50607469638;10110.090091891765;662.5296039811691;717.3149642091894;782.2998416417274;784.6900474312614;793.1077537770009;4484.753338566345;4549.886252843706;4583.685238954374;4593.954060459353;4710.9764451177525;67447;69608.3039169612;69681;69719.30280697127;70254.29745702478;48744.512554873996;50459.74770126199;59333.70333148393;59827.40172598305;60111.69944150251;49945.75027124841;53105.2034219487;53381.733091334296;53753.462465375625;54282;8577.142285771373;8967.327450441113;9062.818743625223;9457.527123643653;9568.091031352289;40479;40992;41706.79146604247;41882.58117418787;42482.937926552084;47542.04915901732;48783;49130;49196.26205606991;49221.01557968892;11987.580434684744;12435.688229511465;12897.419616117484;12901.677458063623;13122.14706044104;13890.097143685629;14210.715785684435;14449.566513004627;14472.131672099707;14663.633409164857;11949.327485235202;12586.685332866751;13230.470781168646;13510.93244533771;13595.252261125734;12588.748225035632;13104.475820967436;13125.409356578786;13272;13442;12493.875061249271;12719.427625756678;13558.186508809504;13721.656958576115;14080.859191407955;10481.109105725795;10912.181586381212;10928.945355273172;10957.890421095686;11523.250988686044;11206.823283555435;11282.323060616389;11494.54021839117;11583.826242606536;11753.823692644788 23:54:54 INFO - PROCESS | 3422 | __end_tp_report 23:54:54 INFO - PROCESS | 3422 | __start_cc_report 23:54:54 INFO - PROCESS | 3422 | _x_x_mozilla_cycle_collect,770 23:54:54 INFO - PROCESS | 3422 | __end_cc_report 23:54:54 INFO - PROCESS | 3422 | __startTimestamp1467874494250__endTimestamp 23:54:54 INFO - PROCESS | 3422 | 23:54:54 INFO - PROCESS | 3422 | ------- Summary: start ------- 23:54:54 INFO - PROCESS | 3422 | Number of tests: 6 23:54:54 INFO - PROCESS | 3422 | 23:54:54 INFO - PROCESS | 3422 | [#0] dojo.html Cycles:165 Average:5484.87 Median:5723.31 stddev:603.26 (10.5%) stddev-sans-first:579.61 23:54:54 INFO - PROCESS | 3422 | Values: 3272.7 3320.6 3328.9 3340.6 3369.2 5455.6 5477.6 5483.9 5497.3 5500.1 5457.9 5463.7 5472.2 5484.9 5502.5 4934.8 4940.4 5006.2 5038.7 5086.9 4946.2 5043.4 5078.2 5081.9 5082.8 4929.6 4990.9 4999.9 5018.1 5092.4 5054.3 5059.0 5082.2 5088.0 5111.5 4877.5 4897.2 4967.5 4998.3 4999.1 5350.4 5363.3 5369.0 5388.5 5415.0 5880.3 5923.1 5923.3 5929.8 5932.1 5898.6 5932.6 5956.5 5971.2 5988.3 5495.0 5517.8 5542.6 5543.3 5557.1 5848.6 6052.1 6063.4 6071.3 6077.4 5731.4 5816.8 5819.3 5822.0 5832.4 5889.4 5899.6 5914.4 5929.7 5932.0 5749.8 5763.5 5877.7 5896.9 5899.6 5863.7 5892.4 5899.8 5903.8 5936.1 4558.7 4565.2 4573.8 4574.2 4597.2 3983.3 3986.7 4048.9 4079.2 4125.2 5515.9 5572.7 5603.6 5604.7 5614.7 5904.0 5912.1 5921.3 5924.0 5928.5 5373.7 5543.3 5593.3 5599.8 5642.7 5084.9 5124.9 5129.7 5137.0 5141.8 6083.1 6086.7 6097.8 6105.0 6110.4 5814.4 5865.3 5945.9 5979.4 5989.6 6034.0 6066.1 6067.6 6072.3 6074.3 5783.3 5807.2 5810.5 5813.5 5822.9 5759.6 5925.2 5980.6 6011.3 6022.1 5784.2 5784.8 5812.8 5814.2 5817.3 5679.8 5761.6 5798.7 5817.2 5819.3 5667.9 5723.3 5727.2 5750.9 5764.3 5790.9 5797.4 5801.7 5802.0 5820.6 5567.8 5666.2 5670.0 5679.2 5698.5 23:54:54 INFO - PROCESS | 3422 | 23:54:54 INFO - PROCESS | 3422 | [#1] ext.html Cycles:180 Average:53076.12 Median:3670.12 stddev:99041.00 (2698.6%) stddev-sans-first:99240.62 23:54:54 INFO - PROCESS | 3422 | Values: 652.3 678.8 680.3 724.6 746.3 33201.8 41041.4 41736.2 41794.8 41863.8 43784.8 44271.0 44426.1 44435.8 44498.1 8060.5 8794.1 8974.9 8975.5 10412.9 10414.0 10538.4 10542.2 10551.0 10554.8 10542.7 10612.5 10613.9 10620.7 10627.5 10522.4 10574.3 10591.5 10591.9 10595.6 10474.4 10586.9 10598.4 10907.2 10914.6 44115.0 44624.6 44638.1 44654.6 44802.0 3833.7 3946.3 4131.7 4150.6 4603.1 34525.7 34931.1 35075.0 35302.5 36397.8 4336.4 4362.6 4404.1 4429.2 4466.4 339096.0 339176.0 339301.0 339314.0 341837.0 39265.4 39691.8 64772.7 65403.3 65459.0 38414.6 38523.2 38612.8 38672.0 38683.8 16059.8 16193.2 16255.9 16265.4 16281.3 14634.3 15201.9 15216.6 15255.6 15264.9 9290.8 9315.9 9369.8 9412.7 9423.6 3550.4 3655.7 3665.6 3674.6 3692.5 1175.0 1221.7 1229.9 1237.7 1279.2 34055.5 34067.5 34181.0 35243.3 35354.6 1245.1 1270.4 1307.6 1322.9 1385.8 17399.0 18004.4 18035.4 18143.3 18151.7 487379.0 490500.0 491950.0 493304.0 494421.0 60926.4 61452.4 61867.0 61970.0 62133.0 1365.8 1492.2 1538.3 1544.6 1624.4 30468.4 31093.0 32248.8 32307.4 32347.5 45230.1 45504.5 45875.0 45881.3 45926.0 250770.0 251766.0 253631.0 254195.0 254558.0 28591.0 29540.7 31230.4 31793.5 31818.5 44919.0 45348.8 45458.0 45833.8 46254.0 41369.6 41392.0 41432.4 41533.8 42600.8 39848.3 39905.8 40047.2 41308.8 41976.8 42058.8 42774.8 43144.0 43447.3 43763.0 36382.3 37363.6 37530.6 37576.4 38435.4 28954.3 29393.2 29450.3 29613.6 29667.4 23:54:54 INFO - PROCESS | 3422 | 23:54:54 INFO - PROCESS | 3422 | [#2] jquery.html Cycles:180 Average:30368.42 Median:12463.66 stddev:90043.35 (722.4%) stddev-sans-first:90267.88 23:54:54 INFO - PROCESS | 3422 | Values: 428.2 429.0 431.7 432.7 440.0 18728.0 18842.7 19539.6 20094.4 20461.1 20054.6 20214.5 20356.0 20524.3 20580.8 5585.4 5726.3 5835.1 5855.0 5855.9 4320.5 5762.9 5798.5 6255.0 6560.9 6507.2 6535.2 6543.0 6547.8 6549.0 6270.0 6335.2 6385.3 6398.1 6398.8 3956.6 5424.8 5657.3 5714.2 5721.3 21873.2 22303.2 22340.4 22358.1 22422.4 2504.9 2601.9 2615.2 2803.3 2900.4 13879.4 14025.2 14139.3 14198.5 14269.2 1997.6 2067.4 2123.1 2146.6 2203.0 78986.6 80044.6 80534.0 81163.0 81909.0 10830.9 10975.9 11131.9 11231.7 11436.4 15294.3 15296.8 15419.6 15421.9 15443.7 8720.0 9006.5 9064.7 9108.1 9147.8 9082.0 9101.1 9122.3 9198.1 9209.9 4968.6 4994.1 5024.9 5089.3 5159.5 1813.1 1951.8 1982.6 2004.4 2071.8 1007.2 1097.3 1104.3 1105.1 1198.8 17913.0 18090.8 18177.7 18419.3 19045.6 1055.2 1056.9 1143.9 1164.8 1199.1 10726.4 10801.3 10823.0 10918.7 10920.9 528131.0 536420.0 544805.0 550123.0 581787.0 87114.0 88241.6 88310.6 88316.6 88354.1 1095.9 1108.8 1116.6 1131.7 1137.2 16856.0 16948.2 16996.3 17116.3 17133.8 37517.8 38172.5 39200.4 40198.4 40531.8 54944.2 55296.7 55629.0 55674.2 55959.7 8034.3 8326.0 8379.7 8408.7 8426.4 11614.4 11740.4 12003.9 12025.0 12254.2 10607.4 10615.3 10809.3 10863.3 10871.3 5201.5 8617.5 10042.5 10353.4 10812.6 10654.6 10849.3 10922.1 10981.5 11064.2 8115.1 8189.6 8193.6 8245.1 8315.3 9580.5 9890.9 10635.5 10689.6 10873.5 23:54:54 INFO - PROCESS | 3422 | 23:54:54 INFO - PROCESS | 3422 | [#3] mootools.html Cycles:180 Average:5785.87 Median:4936.06 stddev:3155.17 (63.9%) stddev-sans-first:3146.71 23:54:54 INFO - PROCESS | 3422 | Values: 1388.1 1556.9 1573.4 1791.4 1927.9 8283.6 8450.5 8473.4 8485.4 8487.4 8340.3 8540.0 8540.3 8545.9 8558.5 2427.3 2448.9 2451.8 2452.8 2453.1 2416.3 2423.7 2455.1 2463.5 2463.6 2394.8 2411.5 2417.3 2444.4 2450.3 2376.9 2419.5 2431.2 2441.5 2444.2 2412.4 2474.2 2488.9 2489.5 2490.3 7523.9 8031.4 8713.7 8749.5 8777.8 5234.5 5296.0 5354.8 5365.4 5370.1 3550.1 3551.2 3623.5 3636.9 3654.8 1206.9 1210.5 1248.4 1271.6 1275.9 11866.9 12253.4 12321.2 12339.3 12372.6 4787.3 4788.3 4818.6 4846.5 4892.0 10503.5 10528.5 10530.2 10545.6 10554.1 5328.4 5396.8 5410.3 5420.8 5424.2 4926.0 4931.4 4935.5 4936.6 4937.0 3796.1 3808.3 3832.1 3837.1 3845.2 1199.4 1201.0 1209.4 1216.1 1216.8 925.5 989.9 1068.8 1072.5 1078.7 6012.8 6125.2 6137.2 6215.0 6240.5 1021.2 1031.4 1054.0 1056.1 1059.2 3689.4 4203.7 4244.4 4261.8 4263.2 10394.9 10472.4 10594.0 10617.0 10634.5 10165.8 10348.1 10351.4 10450.5 10455.0 7976.3 8063.2 8073.3 8081.2 8134.9 5839.6 5910.6 5915.1 6098.9 6114.4 9284.3 9305.0 9378.2 9413.3 9439.7 9161.9 9525.3 9529.3 9733.5 9741.3 7800.0 7846.6 7846.6 7854.0 7926.2 8352.7 8541.0 8560.4 8564.5 8569.3 7525.1 7611.1 7812.1 7855.2 7936.7 7631.0 7658.2 7680.7 7712.5 7752.4 7275.9 7289.1 7294.7 7324.4 7339.3 5213.9 5220.1 5282.3 5355.1 5364.5 5383.0 5395.1 5405.7 5458.0 5476.9 23:54:54 INFO - PROCESS | 3422 | 23:54:54 INFO - PROCESS | 3422 | [#4] prototype.html Cycles:180 Average:5443.60 Median:6153.72 stddev:1643.36 (26.7%) stddev-sans-first:1603.12 23:54:54 INFO - PROCESS | 3422 | Values: 363.1 367.0 367.4 371.4 371.9 6101.8 6105.8 6105.9 6113.5 6139.7 6062.4 6123.0 6123.3 6149.8 6157.7 4486.3 4610.1 4719.2 4721.8 4728.4 4694.7 4724.6 4737.4 4738.6 4745.0 4439.9 4699.4 4700.5 4701.4 4707.5 4496.8 4556.7 4636.9 4653.7 4688.8 4156.9 4162.5 4167.5 4168.8 4170.1 5866.2 5876.3 5890.4 5890.4 5891.9 5498.3 5499.2 5513.2 5515.7 5517.9 6412.0 6418.4 6434.2 6438.7 6451.3 4405.1 4518.9 4552.2 4568.6 4588.3 6662.3 6777.3 6779.4 6785.6 6795.2 4555.4 4561.5 4576.5 4577.5 4578.9 4623.2 4627.8 4630.9 4640.2 4642.4 5328.5 5340.9 5347.4 5351.7 5354.7 6402.8 6451.5 6505.2 6527.9 6530.9 1630.5 1644.6 1653.9 1655.8 1658.5 1034.7 1083.0 1083.4 1087.6 1113.7 6128.1 6214.8 6222.0 6228.1 6241.3 6622.4 6628.1 6637.5 6639.4 6644.8 6205.0 6210.2 6219.7 6226.9 6234.8 3531.6 3571.9 3580.4 3580.9 3581.3 6680.6 6816.5 6940.5 6947.2 6949.2 6919.5 6938.0 6942.4 6949.1 6950.3 6910.8 6971.7 6987.3 6992.7 6997.2 6745.6 6762.8 6771.3 6774.7 6775.2 6555.9 6662.3 6686.5 6686.5 6691.8 6862.6 6888.9 6901.6 6916.3 6919.6 4635.2 4665.0 4672.4 4673.6 4680.5 6800.0 6800.7 6833.1 6844.6 6846.3 6441.6 6553.5 6556.4 6563.3 6579.0 6535.3 6543.8 6563.0 6603.8 6621.0 6441.2 6441.6 6446.2 6447.8 6448.8 6574.3 6576.7 6582.8 6595.1 6595.8 6076.4 6275.7 6365.6 6420.2 6517.3 23:54:54 INFO - PROCESS | 3422 | 23:54:54 INFO - PROCESS | 3422 | [#5] yui.html Cycles:180 Average:15720.82 Median:26126.51 stddev:18302.28 (70.1%) stddev-sans-first:18319.54 23:54:54 INFO - PROCESS | 3422 | Values: 846.8 861.4 928.8 936.3 968.9 14253.5 14353.4 14359.4 14369.8 14954.5 14000.2 14292.0 14346.4 14364.2 14384.1 902.5 902.8 917.8 918.8 919.6 893.7 897.0 899.2 899.7 899.8 959.6 962.1 966.4 967.1 968.7 961.4 962.4 962.7 963.0 963.2 702.0 704.4 705.1 705.9 707.1 14496.9 14503.9 14527.1 14564.9 14610.8 11753.1 12372.3 12590.9 12990.2 13919.9 11454.2 12163.9 12213.1 12300.1 13356.2 4008.9 4033.8 4051.6 4113.6 4120.5 53799.5 54504.0 54811.2 55000.7 58604.1 11564.4 11747.2 11936.3 12023.3 12058.5 20489.6 20671.2 20681.1 20701.6 20783.2 8827.6 8914.2 8931.2 8993.7 9315.0 4961.3 5061.3 5088.5 5123.9 5184.4 3595.2 3655.0 3657.6 3658.0 3664.1 647.2 661.8 663.9 673.4 689.3 681.6 750.6 772.2 803.7 828.7 9181.8 9603.3 9715.4 9878.5 10110.1 662.5 717.3 782.3 784.7 793.1 4484.8 4549.9 4583.7 4594.0 4711.0 67447.0 69608.3 69681.0 69719.3 70254.3 48744.5 50459.7 59333.7 59827.4 60111.7 49945.8 53105.2 53381.7 53753.5 54282.0 8577.1 8967.3 9062.8 9457.5 9568.1 40479.0 40992.0 41706.8 41882.6 42482.9 47542.0 48783.0 49130.0 49196.3 49221.0 11987.6 12435.7 12897.4 12901.7 13122.1 13890.1 14210.7 14449.6 14472.1 14663.6 11949.3 12586.7 13230.5 13510.9 13595.3 12588.7 13104.5 13125.4 13272.0 13442.0 12493.9 12719.4 13558.2 13721.7 14080.9 10481.1 10912.2 10928.9 10957.9 11523.3 11206.8 11282.3 11494.5 11583.8 11753.8 23:54:54 INFO - PROCESS | 3422 | -------- Summary: end -------- 23:54:54 INFO - PROCESS | 3422 | 23:54:54 INFO - TEST-INFO | 3422: exit 0 23:54:54 INFO - TEST-OK | dromaeo_css | took 1111560ms 23:54:54 INFO - TEST-START | kraken 23:54:54 INFO - operating with platform_type : linux_ 23:54:54 INFO - Initialising browser for kraken test... 23:54:54 INFO - TEST-INFO | started process 3621 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfVRnTZ/profile http://localhost:46939/getInfo.html) 23:54:58 INFO - PROCESS | 3621 | __metrics Screen width/height:1600/1200 23:54:58 INFO - PROCESS | 3621 | colorDepth:24 23:54:58 INFO - PROCESS | 3621 | Browser inner width/height: 1024/697 23:54:58 INFO - PROCESS | 3621 | __metrics 23:55:00 ERROR - PROCESS | 3621 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:55:00 INFO - TEST-INFO | 3621: exit 0 23:55:00 INFO - Browser initialized. 23:55:00 INFO - Running cycle 1/1 for kraken test... 23:55:00 INFO - TEST-INFO | started process 3712 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfVRnTZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:55:12 INFO - PROCESS | 3712 | RSS: Main: 139390976 23:55:12 INFO - PROCESS | 3712 | 23:55:14 INFO - PROCESS | 3712 | Cycle 1(1): loaded http://localhost:46939/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46939/tests/kraken/driver.html?testName=audio-beat-detection) 23:55:15 INFO - PROCESS | 3712 | RSS: Main: 197881856 23:55:15 INFO - PROCESS | 3712 | 23:55:18 INFO - PROCESS | 3712 | Cycle 1(1): loaded http://localhost:46939/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46939/tests/kraken/driver.html?testName=audio-dft) 23:55:19 INFO - PROCESS | 3712 | RSS: Main: 185004032 23:55:19 INFO - PROCESS | 3712 | 23:55:21 INFO - PROCESS | 3712 | Cycle 1(1): loaded http://localhost:46939/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46939/tests/kraken/driver.html?testName=audio-fft) 23:55:22 INFO - PROCESS | 3712 | RSS: Main: 274059264 23:55:22 INFO - PROCESS | 3712 | 23:55:24 INFO - PROCESS | 3712 | Cycle 1(1): loaded http://localhost:46939/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46939/tests/kraken/driver.html?testName=audio-oscillator) 23:55:25 INFO - PROCESS | 3712 | RSS: Main: 179941376 23:55:25 INFO - PROCESS | 3712 | 23:55:27 INFO - PROCESS | 3712 | Cycle 1(1): loaded http://localhost:46939/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46939/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:55:27 INFO - PROCESS | 3712 | RSS: Main: 178184192 23:55:27 INFO - PROCESS | 3712 | 23:55:30 INFO - PROCESS | 3712 | Cycle 1(1): loaded http://localhost:46939/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46939/tests/kraken/driver.html?testName=imaging-darkroom) 23:55:31 INFO - PROCESS | 3712 | RSS: Main: 212467712 23:55:31 INFO - PROCESS | 3712 | 23:55:34 INFO - PROCESS | 3712 | Cycle 1(1): loaded http://localhost:46939/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46939/tests/kraken/driver.html?testName=imaging-desaturate) 23:55:35 INFO - PROCESS | 3712 | RSS: Main: 212795392 23:55:35 INFO - PROCESS | 3712 | 23:55:38 INFO - PROCESS | 3712 | Cycle 1(1): loaded http://localhost:46939/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46939/tests/kraken/driver.html?testName=json-parse-financial) 23:55:38 INFO - PROCESS | 3712 | RSS: Main: 212426752 23:55:38 INFO - PROCESS | 3712 | 23:55:40 INFO - PROCESS | 3712 | Cycle 1(1): loaded http://localhost:46939/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46939/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:55:40 INFO - PROCESS | 3712 | RSS: Main: 195588096 23:55:40 INFO - PROCESS | 3712 | 23:55:42 INFO - PROCESS | 3712 | Cycle 1(1): loaded http://localhost:46939/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46939/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:55:43 INFO - PROCESS | 3712 | RSS: Main: 199438336 23:55:43 INFO - PROCESS | 3712 | 23:55:45 INFO - PROCESS | 3712 | Cycle 1(1): loaded http://localhost:46939/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46939/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:55:45 INFO - PROCESS | 3712 | RSS: Main: 209981440 23:55:45 INFO - PROCESS | 3712 | 23:55:48 INFO - PROCESS | 3712 | Cycle 1(1): loaded http://localhost:46939/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46939/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:55:48 INFO - PROCESS | 3712 | RSS: Main: 217817088 23:55:48 INFO - PROCESS | 3712 | 23:55:51 INFO - PROCESS | 3712 | Cycle 1(1): loaded http://localhost:46939/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46939/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:55:51 INFO - PROCESS | 3712 | RSS: Main: 213561344 23:55:51 INFO - PROCESS | 3712 | 23:55:53 INFO - PROCESS | 3712 | Cycle 1(1): loaded http://localhost:46939/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46939/tests/kraken/driver.html?testName=ai-astar) 23:55:53 INFO - PROCESS | 3712 | RSS: Main: 274640896 23:55:53 INFO - PROCESS | 3712 | 23:55:53 INFO - PROCESS | 3712 | __start_tp_report 23:55:53 INFO - PROCESS | 3712 | _x_x_mozilla_page_load 23:55:53 INFO - PROCESS | 3712 | _x_x_mozilla_page_load_details 23:55:53 INFO - PROCESS | 3712 | |i|pagename|runs| 23:55:53 INFO - PROCESS | 3712 | |0;ai-astar;110;110;110;111;111;111;104;110;109;111 23:55:53 INFO - PROCESS | 3712 | |1;audio-beat-detection;154;126;151;177;125;159;148;127;177;131 23:55:53 INFO - PROCESS | 3712 | |2;audio-dft;160;161;161;161;161;162;160;159;158;159 23:55:53 INFO - PROCESS | 3712 | |3;audio-fft;73;73;72;173;76;76;75;74;163;79 23:55:53 INFO - PROCESS | 3712 | |4;audio-oscillator;93;92;159;92;91;91;152;92;91;161 23:55:53 INFO - PROCESS | 3712 | |5;imaging-gaussian-blur;117;116;117;117;116;116;116;116;116;117 23:55:53 INFO - PROCESS | 3712 | |6;imaging-darkroom;145;145;145;146;145;146;145;145;145;145 23:55:53 INFO - PROCESS | 3712 | |7;imaging-desaturate;96;95;95;95;95;96;95;95;95;94 23:55:53 INFO - PROCESS | 3712 | |8;json-parse-financial;54;54;53;56;53;54;55;71;52;52 23:55:53 INFO - PROCESS | 3712 | |9;json-stringify-tinderbox;58;60;57;58;58;59;58;58;58;60 23:55:53 INFO - PROCESS | 3712 | |10;stanford-crypto-aes;72;71;73;73;74;74;73;73;72;72 23:55:53 INFO - PROCESS | 3712 | |11;stanford-crypto-ccm;115;114;115;116;111;122;112;122;131;128 23:55:53 INFO - PROCESS | 3712 | |12;stanford-crypto-pbkdf2;156;157;165;160;157;167;159;156;157;157 23:55:53 INFO - PROCESS | 3712 | |13;stanford-crypto-sha256-iterative;69;68;69;66;67;66;66;66;70;66 23:55:53 INFO - PROCESS | 3712 | __end_tp_report 23:55:53 INFO - PROCESS | 3712 | __start_cc_report 23:55:53 INFO - PROCESS | 3712 | _x_x_mozilla_cycle_collect,1555 23:55:53 INFO - PROCESS | 3712 | __end_cc_report 23:55:53 INFO - PROCESS | 3712 | __startTimestamp1467874553910__endTimestamp 23:55:53 INFO - PROCESS | 3712 | 23:55:53 INFO - PROCESS | 3712 | ------- Summary: start ------- 23:55:53 INFO - PROCESS | 3712 | Number of tests: 14 23:55:53 INFO - PROCESS | 3712 | 23:55:53 INFO - PROCESS | 3712 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.50 stddev:2.11 (1.9%) stddev-sans-first:2.24 23:55:53 INFO - PROCESS | 3712 | Values: 110.0 110.0 110.0 111.0 111.0 111.0 104.0 110.0 109.0 111.0 23:55:53 INFO - PROCESS | 3712 | 23:55:53 INFO - PROCESS | 3712 | [#1] audio-beat-detection Cycles:10 Average:147.50 Median:152.50 stddev:19.97 (13.1%) stddev-sans-first:21.04 23:55:53 INFO - PROCESS | 3712 | Values: 154.0 126.0 151.0 177.0 125.0 159.0 148.0 127.0 177.0 131.0 23:55:53 INFO - PROCESS | 3712 | 23:55:53 INFO - PROCESS | 3712 | [#2] audio-dft Cycles:10 Average:160.20 Median:161.00 stddev:1.23 (0.8%) stddev-sans-first:1.30 23:55:53 INFO - PROCESS | 3712 | Values: 160.0 161.0 161.0 161.0 161.0 162.0 160.0 159.0 158.0 159.0 23:55:53 INFO - PROCESS | 3712 | 23:55:53 INFO - PROCESS | 3712 | [#3] audio-fft Cycles:10 Average:93.40 Median:74.50 stddev:39.44 (52.9%) stddev-sans-first:41.13 23:55:53 INFO - PROCESS | 3712 | Values: 73.0 73.0 72.0 173.0 76.0 76.0 75.0 74.0 163.0 79.0 23:55:53 INFO - PROCESS | 3712 | 23:55:53 INFO - PROCESS | 3712 | [#4] audio-oscillator Cycles:10 Average:111.40 Median:91.50 stddev:31.78 (34.7%) stddev-sans-first:33.00 23:55:53 INFO - PROCESS | 3712 | Values: 93.0 92.0 159.0 92.0 91.0 91.0 152.0 92.0 91.0 161.0 23:55:53 INFO - PROCESS | 3712 | 23:55:53 INFO - PROCESS | 3712 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 23:55:53 INFO - PROCESS | 3712 | Values: 117.0 116.0 117.0 117.0 116.0 116.0 116.0 116.0 116.0 117.0 23:55:53 INFO - PROCESS | 3712 | 23:55:53 INFO - PROCESS | 3712 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 23:55:53 INFO - PROCESS | 3712 | Values: 145.0 145.0 145.0 146.0 145.0 146.0 145.0 145.0 145.0 145.0 23:55:53 INFO - PROCESS | 3712 | 23:55:53 INFO - PROCESS | 3712 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 23:55:53 INFO - PROCESS | 3712 | Values: 96.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 94.0 23:55:53 INFO - PROCESS | 3712 | 23:55:53 INFO - PROCESS | 3712 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:54.00 stddev:5.62 (10.4%) stddev-sans-first:5.94 23:55:53 INFO - PROCESS | 3712 | Values: 54.0 54.0 53.0 56.0 53.0 54.0 55.0 71.0 52.0 52.0 23:55:53 INFO - PROCESS | 3712 | 23:55:53 INFO - PROCESS | 3712 | [#9] json-stringify-tinderbox Cycles:10 Average:58.40 Median:58.00 stddev:0.97 (1.7%) stddev-sans-first:1.01 23:55:53 INFO - PROCESS | 3712 | Values: 58.0 60.0 57.0 58.0 58.0 59.0 58.0 58.0 58.0 60.0 23:55:53 INFO - PROCESS | 3712 | 23:55:53 INFO - PROCESS | 3712 | [#10] stanford-crypto-aes Cycles:10 Average:72.70 Median:73.00 stddev:0.95 (1.3%) stddev-sans-first:0.97 23:55:53 INFO - PROCESS | 3712 | Values: 72.0 71.0 73.0 73.0 74.0 74.0 73.0 73.0 72.0 72.0 23:55:53 INFO - PROCESS | 3712 | 23:55:53 INFO - PROCESS | 3712 | [#11] stanford-crypto-ccm Cycles:10 Average:118.60 Median:119.00 stddev:6.83 (5.7%) stddev-sans-first:7.12 23:55:53 INFO - PROCESS | 3712 | Values: 115.0 114.0 115.0 116.0 111.0 122.0 112.0 122.0 131.0 128.0 23:55:53 INFO - PROCESS | 3712 | 23:55:53 INFO - PROCESS | 3712 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.10 Median:158.00 stddev:3.87 (2.5%) stddev-sans-first:3.94 23:55:53 INFO - PROCESS | 3712 | Values: 156.0 157.0 165.0 160.0 157.0 167.0 159.0 156.0 157.0 157.0 23:55:53 INFO - PROCESS | 3712 | 23:55:53 INFO - PROCESS | 3712 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:1.57 (2.3%) stddev-sans-first:1.54 23:55:53 INFO - PROCESS | 3712 | Values: 69.0 68.0 69.0 66.0 67.0 66.0 66.0 66.0 70.0 66.0 23:55:53 INFO - PROCESS | 3712 | -------- Summary: end -------- 23:55:53 INFO - PROCESS | 3712 | 23:55:54 INFO - TEST-INFO | 3712: exit 0 23:55:54 INFO - TEST-OK | kraken | took 59887ms 23:55:54 INFO - SUITE-END | took 1171s 23:55:55 INFO - Completed test suite (00:19:31) 23:55:55 INFO - javascript benchmark 23:55:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3272.672732726727, 3320.5517255170544, 3328.866845326187, 3340.615829179645, 3369.157710572357, 5455.563554915607, 5477.616566840323, 5483.945160548394, 5497.257870187528, 5500.092484740018, 5457.945420545793, 5463.672179669223, 5472.179173124034, 5484.862878428041, 5502.504774570288, 4934.80260789568, 4940.4318503372215, 5006.22403527452, 5038.697678139305, 5086.923696144542, 4946.208606622941, 5043.36957880265, 5078.238264260353, 5081.949180508203, 5082.771275292602, 4929.605631549485, 4990.87522811929, 4999.850004499871, 5018.146915024437, 5092.388913330406, 5054.267131265964, 5059.013492368989, 5082.2122571001555, 5088.033273677989, 5111.514406131411, 4877.463479017305, 4897.191963326047, 4967.478414766434, 4998.300237966651, 4999.075171093359, 5350.411454739976, 5363.329583802025, 5369.006733754229, 5388.46115388458, 5414.972925135388, 5880.26496687914, 5923.111533270044, 5923.259592550931, 5929.822105336847, 5932.11018347247, 5898.587098903078, 5932.584719069667, 5956.493698035629, 5971.164037034819, 5988.31134419543, 5495.0, 5517.751701173457, 5542.5565954723525, 5543.279373681436, 5557.083081291623, 5848.64908105515, 6052.092186172109, 6063.393660633989, 6071.271447426248, 6077.361877002851, 5731.426857314319, 5816.767329306865, 5819.301683797887, 5822.0, 5832.416758324219, 5889.381614930457, 5899.587028907935, 5914.4381283777975, 5929.703514824328, 5931.970340148272, 5749.8275051748515, 5763.510101641407, 5877.706114694333, 5896.911546326808, 5899.646021238739, 5863.736131874076, 5892.381299963527, 5899.764009439575, 5903.76384944606, 5936.1392598073035, 4558.749268790249, 4565.155446242389, 4573.771311434415, 4574.176648203355, 4597.195490789099, 3983.342748446532, 3986.740861843971, 4048.919021619551, 4079.1841631673783, 4125.23683118624, 5515.917261241085, 5572.749226284827, 5603.607747457639, 5604.663720176803, 5614.719264036864, 5903.970480147572, 5912.054071348563, 5921.289445266596, 5924.0, 5928.4960778334325, 5373.731313434313, 5543.334799823966, 5593.300837395325, 5599.776008959678, 5642.689652069093, 5084.872878178076, 5124.948750512447, 5129.692218466904, 5137.0, 5141.845744627667, 6083.117947897618, 6086.695665216722, 6097.75608975636, 6105.0, 6110.358412366726, 5814.447627475383, 5865.266841644794, 5945.910811337833, 5979.431953964367, 5989.580729348903, 6033.9698301508215, 6066.090086487062, 6067.575269731076, 6072.30168530607, 6074.331823499323, 5783.334916484658, 5807.245058142415, 5810.477057064715, 5813.476787089182, 5822.854428639318, 5759.596828221985, 5925.1704761332585, 5980.581359304807, 6011.308699499614, 6022.066579680157, 5784.2191304175085, 5784.768609255582, 5812.82561523155, 5814.215080964016, 5817.331006934088, 5679.77280908759, 5761.596688231783, 5798.739056742541, 5817.214676018683, 5819.330776960704, 5667.8866422672145, 5723.313202415737, 5727.226824378656, 5750.942490575041, 5764.308283006066, 5790.884182316414, 5797.449242321973, 5801.709914504342, 5802.0, 5820.621659592113, 5567.777288908398, 5666.17840413146, 5669.971650141723, 5679.233303503974, 5698.515626171822], "value": 5446.066823239984, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [652.2531701202124, 678.7726111752563, 680.2585182151455, 724.5978481942523, 746.276112171194, 33201.84188027777, 41041.384379234296, 41736.16527669448, 41794.791026044826, 41863.79068104663, 43784.78107609457, 44271.0, 44426.11147777043, 44435.77782111093, 44498.110037799226, 8060.516369017878, 8794.076621954699, 8974.910250897472, 8975.506347150904, 10412.947935260314, 10414.0, 10538.420386878719, 10542.156627469783, 10550.99765522278, 10554.78890422191, 10542.683719488428, 10612.522436490337, 10613.893861061368, 10620.681379558626, 10627.52176152075, 10522.42126683032, 10574.259801813876, 10591.470426478683, 10591.894081059207, 10595.576176952989, 10474.42390668513, 10586.894131058745, 10598.364098154058, 10907.18196135293, 10914.563417463292, 44115.0, 44624.553754462366, 44638.10723785506, 44654.553454465364, 44802.0, 3833.674137698271, 3946.3488524393442, 4131.731437456586, 4150.626443620058, 4603.125406172817, 34525.6547434525, 34931.126721831904, 35075.0, 35302.470462942816, 36397.818010909774, 4336.3712261722185, 4362.563743625612, 4404.075144219718, 4429.202743506167, 4466.419365482467, 339096.0, 339175.99999999756, 339301.0, 339314.0, 341837.0, 39265.41101883474, 39691.80154099269, 64772.67613661996, 65403.34596654068, 65459.0, 38414.615853841664, 38523.22953540913, 38612.80693596514, 38672.0, 38683.80658096748, 16059.839401606068, 16193.190340482928, 16255.918720406558, 16265.430709925096, 16281.348746050026, 14634.268286585628, 15201.923990379977, 15216.619584510254, 15255.61860953463, 15264.923675381551, 9290.814183716288, 9315.860262096074, 9369.812603748023, 9412.67055653049, 9423.575939082757, 3550.396432606463, 3655.7440979131206, 3665.6151104133683, 3674.6325367463573, 3692.464592634053, 1174.9706257343635, 1221.694576355911, 1229.9200551964093, 1237.672016915518, 1279.2132838304376, 34055.489167662505, 34067.4889876652, 34181.0, 35243.29513409718, 35354.64645353565, 1245.1221888568537, 1270.39021269791, 1307.60118163959, 1322.9140105893086, 1385.7852032934911, 17399.0, 18004.417897437183, 18035.42190807051, 18143.257782169105, 18151.67675315084, 487379.0, 490500.0, 491950.0, 493304.0, 494421.0, 60926.39073609207, 61452.38547614556, 61867.0, 61970.0, 62133.0, 1365.8497565267812, 1492.2091291615461, 1538.3154496249063, 1544.567521094073, 1624.358378440533, 30468.390632186787, 31093.0, 32248.83875580607, 32307.35385292328, 32347.514787277738, 45230.09539809251, 45504.54495455003, 45875.0, 45881.31178032399, 45926.0, 250770.0, 251766.0, 253631.0, 254195.0, 254558.0, 28591.0, 29540.704592953796, 31230.37539249248, 31793.523097154022, 31818.522722158723, 44919.0, 45348.77325613483, 45458.0, 45833.77083114563, 46254.0, 41369.586304137774, 41392.0, 41432.3785143217, 41533.79233103815, 42600.786996064824, 39848.286476707995, 39905.800470997456, 40047.19905601814, 41308.79345603253, 41976.790116049226, 42058.78970605128, 42774.78612606917, 43144.0, 43447.348289775044, 43763.0, 36382.27235455223, 37363.6263637371, 37530.62469375271, 37576.43635345527, 38435.42346864743, 28954.276143095747, 29393.2131949599, 29450.349468547935, 29613.555796662637, 29667.368294743996], "value": 19771.464833347265, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [428.20567846644457, 428.98284068637264, 431.6999685218774, 432.70792215254716, 440.00693704630476, 18728.0, 18842.717359239607, 19539.609207815836, 20094.39716808498, 20461.079251433723, 20054.598908021868, 20214.49463763403, 20356.0, 20524.28165014225, 20580.794192058074, 5585.357683866357, 5726.255586773714, 5835.124731290319, 5854.970725146369, 5855.912161317584, 4320.4599425071865, 5762.9135562966585, 5798.536117110621, 6255.0, 6560.901586476183, 6507.219133703962, 6535.183102112236, 6543.0, 6547.836304092388, 6548.967255163718, 6270.0, 6335.208098987627, 6385.2656944451055, 6398.13625160602, 6398.808035758934, 3956.643902048829, 5424.755885985141, 5657.3494048184575, 5714.200011998323, 5721.284839395075, 21873.234436794795, 22303.219387321366, 22340.441488962744, 22358.10567577295, 22422.439439013993, 2504.887280072383, 2601.8829152688177, 2615.215435369382, 2803.313188268887, 2900.390917907242, 13879.375428105759, 14025.158490490603, 14139.293035348192, 14198.503052393116, 14269.215193164371, 1997.6004799040104, 2067.400453868376, 2123.1189056541516, 2146.61360955028, 2202.9889850550644, 78986.60506697487, 80044.59977700132, 80534.0, 81163.0, 81909.0, 10830.891691083147, 10975.890241097486, 11131.888681113247, 11231.66305010851, 11436.370999595103, 15294.311755971008, 15296.77625789934, 15419.61450963735, 15421.922890385476, 15443.691126177413, 8720.0, 9006.504642244608, 9064.682736104336, 9108.134727200906, 9147.77130571741, 9081.954590227007, 9101.089891010979, 9122.270218382513, 9198.126178013077, 9209.907900921038, 4968.552830245295, 4994.076095922266, 5024.899502009939, 5089.338386009795, 5159.477954003578, 1813.0696618590632, 1951.8145776151243, 1982.6233015726966, 2004.38866145824, 2071.7513898332295, 1007.1640538353149, 1097.3196618096672, 1104.26566333389, 1105.1269497097203, 1198.8321634971112, 17913.0, 18090.819091809175, 18177.72733409, 18419.26322947094, 19045.61908761817, 1055.176961969665, 1056.894310568937, 1143.9142064345208, 1164.772869290497, 1199.0827017331749, 10726.356418614909, 10801.297915635458, 10823.0, 10918.72703182411, 10920.945395272973, 528131.0, 536420.0, 544805.0, 550123.0, 581787.0, 87114.0, 88241.55879220563, 88310.55844720735, 88316.55841720878, 88354.11645883588, 1095.912327013837, 1108.8225883858545, 1116.5757012335423, 1131.7227279316455, 1137.181229514748, 16856.0, 16948.237329319963, 16996.320147194467, 17116.315347385964, 17133.82866171322, 37517.81241093777, 38172.52810249019, 39200.41199381954, 40198.39702404525, 40531.79734101311, 54944.17583736327, 55296.72351638377, 55629.0, 55674.16488752591, 55959.72020139873, 8034.276915077671, 8326.000879894451, 8379.748607541784, 8408.747737567883, 8426.410151289596, 11614.361210133524, 11740.412979350827, 12003.939980300043, 12025.0, 12254.20347677398, 10607.363558186533, 10615.31000484966, 10809.297395669257, 10863.348199108079, 10871.347719136877, 5201.531862132426, 8617.48295102296, 10042.493625956165, 10353.378797272188, 10812.56749730002, 10654.62708805188, 10849.294795838245, 10922.07162391174, 10981.450927453756, 11064.17018723615, 8115.107338192912, 8189.631466583899, 8193.59032048407, 8245.051819040647, 8315.334773218006, 9580.473073980998, 9890.851637225303, 10635.468226588795, 10689.572417103229, 10873.456327183767], "value": 9404.371327495788, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1388.1116085705157, 1556.914369709666, 1573.4492927475385, 1791.3909270847917, 1927.8746881452714, 8283.627236774344, 8450.535220562866, 8473.364497662677, 8485.44844585103, 8487.448315859472, 8340.291075258596, 8540.0, 8540.274076703472, 8545.91454085459, 8558.529280889548, 2427.271818454461, 2448.9142879999204, 2451.7915977141965, 2452.791512721421, 2453.1046168148587, 2416.2871952773885, 2423.684920960273, 2455.067074511683, 2463.470353873917, 2463.6427717980973, 2394.760523947609, 2411.46947671512, 2417.311066346083, 2444.4499987502845, 2450.2649205238445, 2376.881155942196, 2419.5160967806332, 2431.234161239213, 2441.4628781668002, 2444.1934161726585, 2412.4210189554556, 2474.2206205045354, 2488.8631125288102, 2489.4896546207983, 2490.3151633300804, 7523.924760752432, 8031.397645176635, 8713.695020674246, 8749.518776467292, 8777.7805554861, 5234.502722241419, 5295.973520132375, 5354.759035843396, 5365.409804921455, 5370.113931201347, 3550.0769799851964, 3551.183227857581, 3623.474596183565, 3636.890893273206, 3654.817259137059, 1206.9094817888606, 1210.5157936825253, 1248.4194849395076, 1271.5994461744522, 1275.9106862519627, 11866.881331186663, 12253.387330633434, 12321.199122057127, 12339.321337326444, 12372.56696015644, 4787.257975013878, 4788.281757736368, 4818.638602104857, 4846.466888642247, 4891.9755401222765, 10503.52734126966, 10528.473576321307, 10530.210234232463, 10545.578176872992, 10554.050135487689, 5328.3605967284175, 5396.78412863481, 5410.269613602192, 5420.783168673288, 5424.213489044067, 4926.0, 4931.432885218246, 4935.506449355107, 4936.605071594336, 4937.037277730879, 3796.088938654703, 3808.257389808961, 3832.1186127190904, 3837.1174629835295, 3845.2117315950163, 1199.3763243113533, 1200.9579664711869, 1209.3590397089556, 1216.1304667163022, 1216.7748966441059, 925.546482223719, 989.9257555683353, 1068.8450174724621, 1072.5441687282873, 1078.665613659768, 6012.767382686538, 6125.234345706786, 6137.202163718688, 6214.9689251553455, 6240.533474633457, 1021.1779517488345, 1031.4327120083924, 1054.0, 1056.144522936424, 1059.2267644619471, 3689.3543629864666, 4203.70574059819, 4244.384564238168, 4261.829526818955, 4263.232618128766, 10394.896051039394, 10472.371657700562, 10594.0, 10617.0, 10634.521446534924, 10165.796684066425, 10348.068673819393, 10351.378917264989, 10450.529726162342, 10455.0, 7976.282134607914, 8063.19368063189, 8073.31376832964, 8081.191880811989, 8134.877976830352, 5839.562032847469, 5910.556708246812, 5915.112733090071, 6098.878022439438, 6114.449699526886, 9284.3036772241, 9304.95347523258, 9378.249740020918, 9413.341066125306, 9439.669611563562, 9161.908380916106, 9525.285603579621, 9529.285303602119, 9733.464659443798, 9741.318107732392, 7799.961000194962, 7846.568438735696, 7846.646900889587, 7853.960730196312, 7926.247006534601, 8352.665893364197, 8541.0, 8560.357973151915, 8564.486130831921, 8569.271611912807, 7525.096988361432, 7611.086669599684, 7812.101608314889, 7855.214478552099, 7936.722214722457, 7631.046119235096, 7658.234176582298, 7680.69277228927, 7712.498687585289, 7752.3798096153305, 7275.927240727525, 7289.088863892013, 7294.708211671474, 7324.4140468763435, 7339.266073392618, 5213.947860521346, 5220.112580861187, 5282.31329927107, 5355.089634762022, 5364.490373414519, 5383.0, 5395.136778115482, 5405.702686352289, 5457.951394959726, 5476.91784623239], "value": 4708.587330952502, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.11219069375375, 366.9504616876721, 367.4231456613118, 371.4057507987219, 371.9460678201661, 6101.78643747469, 6105.816825495232, 6105.938940610598, 6113.5414843886665, 6139.72371243294, 6062.424069713381, 6123.0, 6123.265208175025, 6149.754009839612, 6157.692115394224, 4486.32705094236, 4610.147122782279, 4719.1977363848055, 4721.7639118044135, 4728.385309909707, 4694.741789201593, 4724.551167639069, 4737.431508219001, 4738.64460165489, 4744.97627511862, 4439.911201775963, 4699.365585645945, 4700.459447163568, 4701.435827700664, 4707.505711900252, 4496.842610508633, 4556.70381425208, 4636.863968327748, 4653.7440440775745, 4688.835890743841, 4156.937645935313, 4162.500499939996, 4167.541570427251, 4168.8332466701295, 4170.124273902484, 5866.178734977107, 5876.324222714357, 5890.381509941437, 5890.440408161217, 5891.882162356729, 5498.340199176125, 5499.175123731432, 5513.173024046385, 5515.7242137892945, 5517.889642207174, 6412.006139048455, 6418.390252925965, 6434.195725534309, 6438.678066096723, 6451.322611125811, 4405.052913623555, 4518.91546028954, 4552.22612155931, 4568.588827005552, 4588.334691469751, 6662.300458451889, 6777.322267773183, 6779.389854913032, 6785.59286442815, 6795.2185498667795, 4555.407796986437, 4561.452625684873, 4576.542345765397, 4577.450705915311, 4578.908421831611, 4623.214053610895, 4627.838025669085, 4630.907381852411, 4640.164770341304, 4642.37327960721, 5328.520433161034, 5340.91988620171, 5347.3583170019065, 5351.705656188869, 5354.732263386815, 6402.775902843378, 6451.451626611791, 6505.219373675094, 6527.934720652733, 6530.934690653127, 1630.4700972184087, 1644.580631938848, 1653.884228104021, 1655.8095818980971, 1658.461000174948, 1034.674077665548, 1083.0, 1083.4257843343041, 1087.6247694545368, 1113.7104352868312, 6128.1114238435175, 6214.751409943642, 6222.0355844844125, 6228.096925945712, 6241.282252540925, 6622.437092847065, 6628.105205797252, 6637.46900247979, 6639.4024537790865, 6644.800655980328, 6205.03821907596, 6210.192674952227, 6219.657918814418, 6226.937730622636, 6234.781782637677, 3531.5762108547137, 3571.8928432147077, 3580.445031020196, 3580.8925732228076, 3581.3374525712825, 6680.632565208863, 6816.488763342769, 6940.514164008471, 6947.166340039228, 6949.200841903245, 6919.515633905679, 6937.9653101735175, 6942.444604431634, 6949.096617439701, 6950.339717726808, 6910.827229319207, 6971.721131154697, 6987.266337034742, 6992.6853291602, 6997.195322537973, 6745.561538499982, 6762.797116086525, 6771.322867713189, 6774.661266936535, 6775.1531058617675, 6555.901661474986, 6662.333766623299, 6686.465082793462, 6686.531942764154, 6691.76578819739, 6862.622555759282, 6888.931110688829, 6901.585904845725, 6916.273791251846, 6919.550229235084, 4635.188841952712, 4665.0, 4672.392588963413, 4673.626109911267, 4680.461746899014, 6799.966000169968, 6800.6599670017295, 6833.111695479754, 6844.623545704835, 6846.3153684633135, 6441.613503189824, 6553.475721942328, 6556.442702370352, 6563.278039415756, 6578.967105164444, 6535.313792051957, 6543.770968016097, 6563.0, 6603.80188594343, 6621.0, 6441.227052753699, 6441.645709485836, 6446.161998940108, 6447.774327898501, 6448.774292899726, 6574.342565743387, 6576.671166441563, 6582.835429114119, 6595.109660196004, 6595.769148079794, 6076.392360763888, 6275.713478736757, 6365.586236894587, 6420.1974753155855, 6517.348265173445], "value": 4914.906157311042, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [846.7883029242689, 861.3539845116163, 928.7770934975606, 936.2697096264914, 968.922486201104, 14253.501127460528, 14353.425862965469, 14359.425622975068, 14369.78445323321, 14954.476593319236, 14000.179976603027, 14292.0, 14346.354414051366, 14364.20996845173, 14384.1369517829, 902.4720538484994, 902.7788191892979, 917.7889085510336, 918.8254231695956, 919.586186216202, 893.6559424621503, 896.9953651909838, 899.1817446124029, 899.6671231644301, 899.8380291547519, 959.5729900194416, 962.0812124421196, 966.3622009473748, 967.1150896929337, 968.7432830299977, 961.4375590279694, 962.3840741925103, 962.74006018375, 963.0177219236375, 963.1572374172634, 702.0382076555101, 704.4082970304969, 705.0517054561607, 705.8694141583824, 707.0702026834696, 14496.855031449655, 14503.854961450355, 14527.128372297697, 14564.85435145656, 14610.780838287434, 11753.059755219647, 12372.257664540157, 12590.874091259153, 12990.22058676473, 13919.930400348036, 11454.198206125575, 12163.878361216452, 12213.145079844415, 12300.077494187972, 13356.19862808225, 4008.8596899108393, 4033.838646454138, 4051.554329023805, 4113.588641135862, 4120.526139493966, 53799.46200538023, 54504.0, 54811.17783233295, 55000.72499637476, 58604.12093818554, 11564.42177891102, 11747.17769756126, 11936.343501107349, 12023.278603283656, 12058.457369418396, 20489.590208195754, 20671.17315307401, 20681.069351879203, 20701.58596828085, 20783.168673253203, 8827.558622069, 8914.242289405343, 8931.240844528158, 8993.685221017233, 9315.0, 4961.305417241589, 5061.31672224245, 5088.491150884956, 5123.948760512421, 5184.403793563789, 3595.2270261893295, 3655.0314166745834, 3657.5976642569294, 3658.0, 3664.0656632558525, 647.1974751308438, 661.8113837556274, 663.9170103737033, 673.4174938678008, 689.2969171445098, 681.6489507903434, 750.6096829648552, 772.1814876231213, 803.7066470738256, 828.6726742936506, 9181.81636367269, 9603.327767056378, 9715.365088248798, 9878.50607469638, 10110.090091891765, 662.5296039811691, 717.3149642091894, 782.2998416417274, 784.6900474312614, 793.1077537770009, 4484.753338566345, 4549.886252843706, 4583.685238954374, 4593.954060459353, 4710.9764451177525, 67447.0, 69608.3039169612, 69681.0, 69719.30280697127, 70254.29745702478, 48744.512554873996, 50459.74770126199, 59333.70333148393, 59827.40172598305, 60111.69944150251, 49945.75027124841, 53105.2034219487, 53381.733091334296, 53753.462465375625, 54282.0, 8577.142285771373, 8967.327450441113, 9062.818743625223, 9457.527123643653, 9568.091031352289, 40479.0, 40992.0, 41706.79146604247, 41882.58117418787, 42482.937926552084, 47542.04915901732, 48783.0, 49130.0, 49196.26205606991, 49221.01557968892, 11987.580434684744, 12435.688229511465, 12897.419616117484, 12901.677458063623, 13122.14706044104, 13890.097143685629, 14210.715785684435, 14449.566513004627, 14472.131672099707, 14663.633409164857, 11949.327485235202, 12586.685332866751, 13230.470781168646, 13510.93244533771, 13595.252261125734, 12588.748225035632, 13104.475820967436, 13125.409356578786, 13272.0, 13442.0, 12493.875061249271, 12719.427625756678, 13558.186508809504, 13721.656958576115, 14080.859191407955, 10481.109105725795, 10912.181586381212, 10928.945355273172, 10957.890421095686, 11523.250988686044, 11206.823283555435, 11282.323060616389, 11494.54021839117, 11583.826242606536, 11753.823692644788], "value": 7192.709830735522, "unit": "score"}], "name": "dromaeo_css", "value": 7432.439354120127, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 110.0, 111.0, 111.0, 111.0, 104.0, 110.0, 109.0, 111.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 126.0, 151.0, 177.0, 125.0, 159.0, 148.0, 127.0, 177.0, 131.0], "value": 147.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 161.0, 161.0, 162.0, 160.0, 159.0, 158.0, 159.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 72.0, 173.0, 76.0, 76.0, 75.0, 74.0, 163.0, 79.0], "value": 93.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 159.0, 92.0, 91.0, 91.0, 152.0, 92.0, 91.0, 161.0], "value": 111.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 116.0, 116.0, 116.0, 116.0, 116.0, 117.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 94.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 56.0, 53.0, 54.0, 55.0, 71.0, 52.0, 52.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 57.0, 58.0, 58.0, 59.0, 58.0, 58.0, 58.0, 60.0], "value": 58.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 73.0, 73.0, 74.0, 74.0, 73.0, 73.0, 72.0, 72.0], "value": 72.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 115.0, 116.0, 111.0, 122.0, 112.0, 122.0, 131.0, 128.0], "value": 118.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 157.0, 165.0, 160.0, 157.0, 167.0, 159.0, 156.0, 157.0, 157.0], "value": 159.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 69.0, 66.0, 67.0, 66.0, 66.0, 66.0, 70.0, 66.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1510.3999999999999, "alertThreshold": 2.0}]} 23:55:55 INFO - Return code: 0 23:55:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:55:55 ERROR - # TBPL SUCCESS # 23:55:55 INFO - Running post-action listener: _resource_record_post_action 23:55:55 INFO - Running post-run listener: _resource_record_post_run 23:55:56 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 7528448; Write bytes: 349261824; Read time: 1360; Write time: 334708 23:55:56 INFO - install - Wall time: 13s; CPU: 13.0%; Read bytes: 0; Write bytes: 4567040; Read time: 0; Write time: 544 23:55:56 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 5767168; Write bytes: 344694784; Read time: 1268; Write time: 334164 23:55:56 INFO - Running post-run listener: _upload_blobber_files 23:55:56 INFO - Blob upload gear active. 23:55:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:55:56 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 23:55:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:55:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:55:56 INFO - (blobuploader) - INFO - Open directory for files ... 23:55:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:55:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:55:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:55:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:55:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:55:57 INFO - (blobuploader) - INFO - Done attempting. 23:55:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:55:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:55:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:55:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:55:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:55:58 INFO - (blobuploader) - INFO - Done attempting. 23:55:58 INFO - (blobuploader) - INFO - Iteration through files over. 23:55:58 INFO - Return code: 0 23:55:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:55:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:55:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/58f2b9d0b6e6906d2689e6c308f747d5920da726af245d90bb74da40cdf3860de83c1176d092d9ce15a325831be281d8870e8afc6f396fb8109a124efdb46f28", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9d802fccf2f18f99c4d55fdd7a14ee302574641795bfe58b09997e8337e6b2d17636d55f1e95789478daf5121fee98b3f120552b61ed6e07d74ffde7a8f6ba84"} 23:55:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:55:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:55:58 INFO - Contents: 23:55:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/58f2b9d0b6e6906d2689e6c308f747d5920da726af245d90bb74da40cdf3860de83c1176d092d9ce15a325831be281d8870e8afc6f396fb8109a124efdb46f28", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9d802fccf2f18f99c4d55fdd7a14ee302574641795bfe58b09997e8337e6b2d17636d55f1e95789478daf5121fee98b3f120552b61ed6e07d74ffde7a8f6ba84"} 23:55:58 INFO - Running post-run listener: copy_logs_to_upload_dir 23:55:58 INFO - Copying logs to upload dir... 23:55:58 INFO - mkdir: /builds/slave/test/build/upload/logs 23:55:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.384335 ========= master_lag: 0.13 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-07-06 23:55:58.240966) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 23:55:58.246593) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1467872611.25231-945648131 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/58f2b9d0b6e6906d2689e6c308f747d5920da726af245d90bb74da40cdf3860de83c1176d092d9ce15a325831be281d8870e8afc6f396fb8109a124efdb46f28", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9d802fccf2f18f99c4d55fdd7a14ee302574641795bfe58b09997e8337e6b2d17636d55f1e95789478daf5121fee98b3f120552b61ed6e07d74ffde7a8f6ba84"} build_url:https://queue.taskcluster.net/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011057 build_url: 'https://queue.taskcluster.net/v1/task/OXzgOna7SRaiRCGl3LTAUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/58f2b9d0b6e6906d2689e6c308f747d5920da726af245d90bb74da40cdf3860de83c1176d092d9ce15a325831be281d8870e8afc6f396fb8109a124efdb46f28", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9d802fccf2f18f99c4d55fdd7a14ee302574641795bfe58b09997e8337e6b2d17636d55f1e95789478daf5121fee98b3f120552b61ed6e07d74ffde7a8f6ba84"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 23:55:58.272370) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 23:55:58.272789) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1467872611.25231-945648131 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004246 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 23:55:58.356000) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 23:55:58.356404) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 23:55:58.356701) ========= ========= Total master_lag: 0.29 =========