builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-015 starttime: 1463507504.07 results: success (0) buildid: 20160517004009 builduid: ef91a013044b49f4abd91345e579e6b6 revision: 17724486e1591858eea09dc327475a25883854a4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 10:51:44.068506) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 10:51:44.068951) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 10:51:44.069267) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 10:51:44.115161) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 10:51:44.115451) ========= 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=20e666a3d4cfbb71505a330e000001b4-1463506662.305083-604910210 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-17 10:51:44-- 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% 46.0M=0s 2016-05-17 10:51:44 (46.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114753 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 10:51:44.251755) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 10:51:44.252073) ========= 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=20e666a3d4cfbb71505a330e000001b4-1463506662.305083-604910210 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017176 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 10:51:44.302504) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 10:51:44.302865) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 17724486e1591858eea09dc327475a25883854a4 --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-aurora --rev 17724486e1591858eea09dc327475a25883854a4 --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=20e666a3d4cfbb71505a330e000001b4-1463506662.305083-604910210 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-17 10:51:44,790 truncating revision to first 12 chars 2016-05-17 10:51:44,790 Setting DEBUG logging. 2016-05-17 10:51:44,791 attempt 1/10 2016-05-17 10:51:44,791 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/17724486e159?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-17 10:51:45,157 unpacking tar archive at: mozilla-aurora-17724486e159/testing/mozharness/ program finished with exit code 0 elapsedTime=0.661265 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 10:51:44.982091) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 10:51:44.982936) ========= script_repo_revision: 17724486e1591858eea09dc327475a25883854a4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 10:51:44.983958) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 10:51:44.984278) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 10:51:44.994916) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-05-17 10:51:44.995499) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=20e666a3d4cfbb71505a330e000001b4-1463506662.305083-604910210 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:51:45 INFO - MultiFileLogger online at 20160517 10:51:45 in /builds/slave/test 10:51:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 10:51:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:51:45 INFO - {'append_to_log': False, 10:51:45 INFO - 'base_work_dir': '/builds/slave/test', 10:51:45 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:51:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:51:45 INFO - 'branch': 'Mozilla-Aurora', 10:51:45 INFO - 'buildbot_json_path': 'buildprops.json', 10:51:45 INFO - 'config_files': ('talos/linux_config.py',), 10:51:45 INFO - 'default_actions': ('clobber', 10:51:45 INFO - 'read-buildbot-config', 10:51:45 INFO - 'download-and-extract', 10:51:45 INFO - 'populate-webroot', 10:51:45 INFO - 'create-virtualenv', 10:51:45 INFO - 'install', 10:51:45 INFO - 'run-tests'), 10:51:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:51:45 INFO - 'download_minidump_stackwalk': True, 10:51:45 INFO - 'download_symbols': 'ondemand', 10:51:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:51:45 INFO - 'tooltool.py': '/tools/tooltool.py', 10:51:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:51:45 INFO - '/tools/misc-python/virtualenv.py')}, 10:51:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:51:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:51:45 INFO - 'installer_path': 'installer.exe', 10:51:45 INFO - 'log_level': 'info', 10:51:45 INFO - 'log_name': 'talos', 10:51:45 INFO - 'log_to_console': True, 10:51:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:51:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:51:45 INFO - 'opt_config_files': (), 10:51:45 INFO - 'pip_index': False, 10:51:45 INFO - 'sps_profile': False, 10:51:45 INFO - 'sps_profile_interval': 0, 10:51:45 INFO - 'suite': 'dromaeojs', 10:51:45 INFO - 'system_bits': '32', 10:51:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:51:45 INFO - 'title': 'talos-linux64-ix-015', 10:51:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:51:45 INFO - 'use_talos_json': True, 10:51:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:51:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:51:45 INFO - 'work_dir': 'build'} 10:51:45 INFO - ##### 10:51:45 INFO - ##### Running clobber step. 10:51:45 INFO - ##### 10:51:45 INFO - Running pre-action listener: _resource_record_pre_action 10:51:45 INFO - Running main action method: clobber 10:51:45 INFO - rmtree: /builds/slave/test/build 10:51:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:51:46 INFO - Running post-action listener: _resource_record_post_action 10:51:46 INFO - ##### 10:51:46 INFO - ##### Running read-buildbot-config step. 10:51:46 INFO - ##### 10:51:46 INFO - Running pre-action listener: _resource_record_pre_action 10:51:46 INFO - Running main action method: read_buildbot_config 10:51:46 INFO - Using buildbot properties: 10:51:46 INFO - { 10:51:46 INFO - "project": "", 10:51:46 INFO - "product": "firefox", 10:51:46 INFO - "script_repo_revision": "production", 10:51:46 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 10:51:46 INFO - "repository": "", 10:51:46 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 10:51:46 INFO - "buildid": "20160517004009", 10:51:46 INFO - "stage_platform": "linux64-pgo", 10:51:46 INFO - "basedir": "/builds/slave/test", 10:51:46 INFO - "nightly_build": "True", 10:51:46 INFO - "buildnumber": 508, 10:51:46 INFO - "slavename": "talos-linux64-ix-015", 10:51:46 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:51:46 INFO - "platform": "ubuntu64_hw", 10:51:46 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 10:51:46 INFO - "branch": "mozilla-aurora", 10:51:46 INFO - "repo_path": "releases/mozilla-aurora", 10:51:46 INFO - "revision": "17724486e1591858eea09dc327475a25883854a4", 10:51:46 INFO - "pgo_build": "True", 10:51:46 INFO - "builduid": "ef91a013044b49f4abd91345e579e6b6", 10:51:46 INFO - "slavebuilddir": "test" 10:51:46 INFO - } 10:51:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 10:51:46 INFO - Running post-action listener: _resource_record_post_action 10:51:46 INFO - ##### 10:51:46 INFO - ##### Running download-and-extract step. 10:51:46 INFO - ##### 10:51:46 INFO - Running pre-action listener: _resource_record_pre_action 10:51:46 INFO - Running main action method: download_and_extract 10:51:46 INFO - mkdir: /builds/slave/test/build/tests 10:51:46 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')]} 10:51:46 INFO - https://queue.taskcluster.net/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:51:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 10:51:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 10:51:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 10:51:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:51:49 INFO - Downloaded 1361 bytes. 10:51:49 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 10:51:49 INFO - Using the following test package requirements: 10:51:49 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 10:51:49 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:51:49 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 10:51:49 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:51:49 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 10:51:49 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:51:49 INFO - u'jsshell-linux-x86_64.zip'], 10:51:49 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:51:49 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 10:51:49 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 10:51:49 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:51:49 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 10:51:49 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:51:49 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 10:51:49 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:51:49 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 10:51:49 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:51:49 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 10:51:49 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:51: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')]} 10:51:49 INFO - https://queue.taskcluster.net/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:51:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:51:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:51:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:51:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:51:51 INFO - Downloaded 23813806 bytes. 10:51:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:51:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:51:52 INFO - Return code: 0 10:51:52 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:51:52 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')]} 10:51:52 INFO - https://queue.taskcluster.net/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:51:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:51:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:51:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:51:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:52:03 INFO - Downloaded 23813806 bytes. 10:52:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:52:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:52:04 INFO - Return code: 0 10:52:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:04 INFO - https://queue.taskcluster.net/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:52:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 10:52:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 10:52:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 10:52:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:52:06 INFO - Downloaded 10840145 bytes. 10:52:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:52:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:52:06 INFO - Return code: 0 10:52:06 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')]} 10:52:06 INFO - https://queue.taskcluster.net/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:52:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:52:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:52:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:52:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:52:07 INFO - Downloaded 62686410 bytes. 10:52:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:52:07 INFO - mkdir: /builds/slave/test/properties 10:52:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:52:07 INFO - Writing to file /builds/slave/test/properties/build_url 10:52:07 INFO - Contents: 10:52:07 INFO - build_url:https://queue.taskcluster.net/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:52:08 INFO - Running post-action listener: _resource_record_post_action 10:52:08 INFO - Running post-action listener: set_extra_try_arguments 10:52:08 INFO - ##### 10:52:08 INFO - ##### Running populate-webroot step. 10:52:08 INFO - ##### 10:52:08 INFO - Running pre-action listener: _resource_record_pre_action 10:52:08 INFO - Running main action method: populate_webroot 10:52:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:52:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:52:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:52:08 INFO - '--tppagecycles', 10:52:08 INFO - '7'], 10:52:08 INFO - 'tests': ['tsvgm']}}, 10:52:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:52:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:52:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:52:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:52:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:52:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:52:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:08 INFO - 'talos_options': ['--disable-e10s'], 10:52:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:52:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:52:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:08 INFO - 'talos_options': ['--disable-e10s'], 10:52:08 INFO - 'tests': ['damp', 'tps']}, 10:52:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:08 INFO - 'tests': ['damp', 'tps']}, 10:52:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:52:08 INFO - 'tests': ['dromaeo_dom']}, 10:52:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:52:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:52:08 INFO - 'tests': ['a11yr', 10:52:08 INFO - 'ts_paint', 10:52:08 INFO - 'tpaint', 10:52:08 INFO - 'sessionrestore', 10:52:08 INFO - 'sessionrestore_no_auto_restore', 10:52:08 INFO - 'tabpaint']}, 10:52:08 INFO - 'other-e10s': {'tests': ['a11yr', 10:52:08 INFO - 'ts_paint', 10:52:08 INFO - 'tpaint', 10:52:08 INFO - 'sessionrestore', 10:52:08 INFO - 'sessionrestore_no_auto_restore', 10:52:08 INFO - 'tabpaint']}, 10:52:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:52:08 INFO - 'ts_paint', 10:52:08 INFO - 'tpaint', 10:52:08 INFO - 'sessionrestore', 10:52:08 INFO - 'sessionrestore_no_auto_restore', 10:52:08 INFO - 'tabpaint']}, 10:52:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:52:08 INFO - 'ts_paint', 10:52:08 INFO - 'tpaint', 10:52:08 INFO - 'sessionrestore', 10:52:08 INFO - 'sessionrestore_no_auto_restore', 10:52:08 INFO - 'tabpaint']}, 10:52:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:52:08 INFO - 'tests': ['a11yr', 10:52:08 INFO - 'ts_paint', 10:52:08 INFO - 'tpaint', 10:52:08 INFO - 'sessionrestore', 10:52:08 INFO - 'sessionrestore_no_auto_restore', 10:52:08 INFO - 'tabpaint']}, 10:52:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:52:08 INFO - 'tests': ['a11yr', 10:52:08 INFO - 'ts_paint', 10:52:08 INFO - 'tpaint', 10:52:08 INFO - 'sessionrestore', 10:52:08 INFO - 'sessionrestore_no_auto_restore', 10:52:08 INFO - 'tabpaint']}, 10:52:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:52:08 INFO - 'tests': ['tsvgx', 10:52:08 INFO - 'tsvgr_opacity', 10:52:08 INFO - 'tart', 10:52:08 INFO - 'tscrollx', 10:52:08 INFO - 'cart']}, 10:52:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:52:08 INFO - 'tsvgr_opacity', 10:52:08 INFO - 'tart', 10:52:08 INFO - 'tscrollx', 10:52:08 INFO - 'cart']}, 10:52:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:08 INFO - 'talos_options': ['--disable-e10s'], 10:52:08 INFO - 'tests': ['tp5o']}, 10:52:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:08 INFO - 'tests': ['tp5o']}, 10:52:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:08 INFO - 'talos_options': ['--disable-e10s', 10:52:08 INFO - '--xperf_path', 10:52:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:52:08 INFO - 'tests': ['tp5n']}, 10:52:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:08 INFO - 'talos_options': ['--xperf_path', 10:52:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:52:08 INFO - 'tests': ['tp5n']}}, 10:52:08 INFO - 'talos.zip': {'path': '', 10:52:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:52:08 INFO - Running post-action listener: _resource_record_post_action 10:52:08 INFO - ##### 10:52:08 INFO - ##### Running create-virtualenv step. 10:52:08 INFO - ##### 10:52:08 INFO - Running pre-action listener: _resource_record_pre_action 10:52:08 INFO - Running main action method: create_virtualenv 10:52:08 INFO - Creating virtualenv /builds/slave/test/build/venv 10:52:08 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 10:52:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:52:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:52:08 INFO - Using real prefix '/usr' 10:52:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:52:09 INFO - Installing distribute.............................................................................................................................................................................................done. 10:52:11 INFO - Installing pip.................done. 10:52:11 INFO - Return code: 0 10:52:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:52:11 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')]} 10:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:11 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')]} 10:52:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:11 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 0x7fbb5dcc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x159f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f9410>, '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 0x16fa310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16fa7a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1463506662.305083-604910210', '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 10:52:11 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 10:52:11 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 10:52:11 INFO - Using env: {'DISPLAY': ':0', 10:52:11 INFO - 'HOME': '/home/cltbld', 10:52:11 INFO - 'LANG': 'en_US.UTF-8', 10:52:11 INFO - 'LANGUAGE': 'en_US:en', 10:52:11 INFO - 'LOGNAME': 'cltbld', 10:52:11 INFO - 'MAIL': '/var/mail/cltbld', 10:52:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:11 INFO - 'MOZ_NO_REMOTE': '1', 10:52:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:11 INFO - 'NO_EM_RESTART': '1', 10:52:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:11 INFO - 'PWD': '/builds/slave/test', 10:52:11 INFO - 'SHELL': '/bin/bash', 10:52:11 INFO - 'SHLVL': '1', 10:52:11 INFO - 'TERM': 'linux', 10:52:11 INFO - 'TMOUT': '86400', 10:52:11 INFO - 'USER': 'cltbld', 10:52:11 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1463506662.305083-604910210', 10:52:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:11 INFO - '_': '/tools/buildbot/bin/python'} 10:52:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:11 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 10:52:11 INFO - Cleaning up... 10:52:11 INFO - Return code: 0 10:52:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:52:11 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')]} 10:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:11 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')]} 10:52:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:11 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 0x7fbb5dcc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x159f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f9410>, '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 0x16fa310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16fa7a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1463506662.305083-604910210', '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 10:52:11 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 10:52:11 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 10:52:11 INFO - Using env: {'DISPLAY': ':0', 10:52:11 INFO - 'HOME': '/home/cltbld', 10:52:11 INFO - 'LANG': 'en_US.UTF-8', 10:52:11 INFO - 'LANGUAGE': 'en_US:en', 10:52:11 INFO - 'LOGNAME': 'cltbld', 10:52:11 INFO - 'MAIL': '/var/mail/cltbld', 10:52:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:11 INFO - 'MOZ_NO_REMOTE': '1', 10:52:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:11 INFO - 'NO_EM_RESTART': '1', 10:52:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:11 INFO - 'PWD': '/builds/slave/test', 10:52:11 INFO - 'SHELL': '/bin/bash', 10:52:11 INFO - 'SHLVL': '1', 10:52:11 INFO - 'TERM': 'linux', 10:52:11 INFO - 'TMOUT': '86400', 10:52:11 INFO - 'USER': 'cltbld', 10:52:11 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1463506662.305083-604910210', 10:52:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:11 INFO - '_': '/tools/buildbot/bin/python'} 10:52:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:11 INFO - Downloading/unpacking psutil>=0.7.1 10:52:11 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 10:52:11 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 10:52:11 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 10:52:11 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 10:52:11 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 10:52:11 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 10:52:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:52:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:52:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:52:13 INFO - Installing collected packages: psutil 10:52:13 INFO - Running setup.py install for psutil 10:52:13 INFO - building 'psutil._psutil_linux' extension 10:52:13 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 10:52:13 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 10:52:14 INFO - building 'psutil._psutil_posix' extension 10:52:14 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 10:52:14 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 10:52:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:52:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:52:14 INFO - Successfully installed psutil 10:52:14 INFO - Cleaning up... 10:52:14 INFO - Return code: 0 10:52:14 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:52:14 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')]} 10:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:14 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')]} 10:52:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:14 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 0x7fbb5dcc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x159f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f9410>, '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 0x16fa310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16fa7a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1463506662.305083-604910210', '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 10:52:14 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 10:52:14 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 10:52:14 INFO - Using env: {'DISPLAY': ':0', 10:52:14 INFO - 'HOME': '/home/cltbld', 10:52:14 INFO - 'LANG': 'en_US.UTF-8', 10:52:14 INFO - 'LANGUAGE': 'en_US:en', 10:52:14 INFO - 'LOGNAME': 'cltbld', 10:52:14 INFO - 'MAIL': '/var/mail/cltbld', 10:52:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:14 INFO - 'MOZ_NO_REMOTE': '1', 10:52:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:14 INFO - 'NO_EM_RESTART': '1', 10:52:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:14 INFO - 'PWD': '/builds/slave/test', 10:52:14 INFO - 'SHELL': '/bin/bash', 10:52:14 INFO - 'SHLVL': '1', 10:52:14 INFO - 'TERM': 'linux', 10:52:14 INFO - 'TMOUT': '86400', 10:52:14 INFO - 'USER': 'cltbld', 10:52:14 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1463506662.305083-604910210', 10:52:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:14 INFO - '_': '/tools/buildbot/bin/python'} 10:52:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:14 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:52:14 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 10:52:14 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 10:52:14 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 10:52:14 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 10:52:14 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 10:52:14 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 10:52:16 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:52:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:52:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:52:16 INFO - Installing collected packages: mozsystemmonitor 10:52:16 INFO - Running setup.py install for mozsystemmonitor 10:52:16 INFO - Successfully installed mozsystemmonitor 10:52:16 INFO - Cleaning up... 10:52:16 INFO - Return code: 0 10:52:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:52:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:16 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 0x7fbb5dcc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x159f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f9410>, '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 0x16fa310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16fa7a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1463506662.305083-604910210', '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 10:52:16 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 10:52:16 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 10:52:16 INFO - Using env: {'DISPLAY': ':0', 10:52:16 INFO - 'HOME': '/home/cltbld', 10:52:16 INFO - 'LANG': 'en_US.UTF-8', 10:52:16 INFO - 'LANGUAGE': 'en_US:en', 10:52:16 INFO - 'LOGNAME': 'cltbld', 10:52:16 INFO - 'MAIL': '/var/mail/cltbld', 10:52:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:16 INFO - 'MOZ_NO_REMOTE': '1', 10:52:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:16 INFO - 'NO_EM_RESTART': '1', 10:52:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:16 INFO - 'PWD': '/builds/slave/test', 10:52:16 INFO - 'SHELL': '/bin/bash', 10:52:16 INFO - 'SHLVL': '1', 10:52:16 INFO - 'TERM': 'linux', 10:52:16 INFO - 'TMOUT': '86400', 10:52:16 INFO - 'USER': 'cltbld', 10:52:16 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1463506662.305083-604910210', 10:52:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:16 INFO - '_': '/tools/buildbot/bin/python'} 10:52:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:16 INFO - Downloading/unpacking blobuploader==1.2.4 10:52:16 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 10:52:16 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 10:52:16 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 10:52:16 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 10:52:16 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 10:52:16 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 10:52:18 INFO - Downloading blobuploader-1.2.4.tar.gz 10:52:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:52:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:52:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:52:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:52:19 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 10:52:19 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 10:52:19 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 10:52:19 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 10:52:19 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 10:52:19 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 10:52:19 INFO - Downloading docopt-0.6.1.tar.gz 10:52:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:52:19 INFO - Installing collected packages: blobuploader, requests, docopt 10:52:19 INFO - Running setup.py install for blobuploader 10:52:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:52:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:52:19 INFO - Running setup.py install for requests 10:52:19 INFO - Running setup.py install for docopt 10:52:19 INFO - Successfully installed blobuploader requests docopt 10:52:19 INFO - Cleaning up... 10:52:20 INFO - Return code: 0 10:52:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:52:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:20 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 0x7fbb5dcc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x159f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f9410>, '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 0x16fa310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16fa7a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1463506662.305083-604910210', '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 10:52:20 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 10:52:20 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 10:52:20 INFO - Using env: {'DISPLAY': ':0', 10:52:20 INFO - 'HOME': '/home/cltbld', 10:52:20 INFO - 'LANG': 'en_US.UTF-8', 10:52:20 INFO - 'LANGUAGE': 'en_US:en', 10:52:20 INFO - 'LOGNAME': 'cltbld', 10:52:20 INFO - 'MAIL': '/var/mail/cltbld', 10:52:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:20 INFO - 'MOZ_NO_REMOTE': '1', 10:52:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:20 INFO - 'NO_EM_RESTART': '1', 10:52:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:20 INFO - 'PWD': '/builds/slave/test', 10:52:20 INFO - 'SHELL': '/bin/bash', 10:52:20 INFO - 'SHLVL': '1', 10:52:20 INFO - 'TERM': 'linux', 10:52:20 INFO - 'TMOUT': '86400', 10:52:20 INFO - 'USER': 'cltbld', 10:52:20 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1463506662.305083-604910210', 10:52:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:20 INFO - '_': '/tools/buildbot/bin/python'} 10:52:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:52:20 INFO - Running setup.py (path:/tmp/pip-7Ebysg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:52:20 INFO - Running setup.py (path:/tmp/pip-OBarZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:52:20 INFO - Running setup.py (path:/tmp/pip-L7asvk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:52:20 INFO - Running setup.py (path:/tmp/pip-jT2pWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:52:20 INFO - Running setup.py (path:/tmp/pip-hBy4AH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:52:20 INFO - Running setup.py (path:/tmp/pip-U1Ebzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:52:20 INFO - Running setup.py (path:/tmp/pip-NIHdpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:52:20 INFO - Running setup.py (path:/tmp/pip-uZkEqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:52:20 INFO - Running setup.py (path:/tmp/pip-ctK1wR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:52:20 INFO - Running setup.py (path:/tmp/pip-El0pnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:52:20 INFO - Running setup.py (path:/tmp/pip-9ZX7zA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:52:21 INFO - Running setup.py (path:/tmp/pip-KOuB3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:52:21 INFO - Running setup.py (path:/tmp/pip-oXScom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:52:21 INFO - Running setup.py (path:/tmp/pip-QfnUwj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:52:21 INFO - Running setup.py (path:/tmp/pip-sWbHxx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:52:21 INFO - Running setup.py (path:/tmp/pip-Jb7_Qd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:52:21 INFO - Running setup.py (path:/tmp/pip-9MR4I4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:52:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:52:21 INFO - Running setup.py install for manifestparser 10:52:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:52:21 INFO - Running setup.py install for mozcrash 10:52:21 INFO - Running setup.py install for mozdebug 10:52:21 INFO - Running setup.py install for mozdevice 10:52:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:52:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:52:21 INFO - Running setup.py install for mozfile 10:52:22 INFO - Running setup.py install for mozhttpd 10:52:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:52:22 INFO - Running setup.py install for mozinfo 10:52:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:52:22 INFO - Running setup.py install for mozInstall 10:52:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:52:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:52:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:52:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:52:22 INFO - Running setup.py install for mozleak 10:52:22 INFO - Running setup.py install for mozlog 10:52:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:52:22 INFO - Running setup.py install for moznetwork 10:52:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:52:22 INFO - Running setup.py install for mozprocess 10:52:22 INFO - Running setup.py install for mozprofile 10:52:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:52:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:52:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:52:22 INFO - Running setup.py install for mozrunner 10:52:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:52:22 INFO - Running setup.py install for mozscreenshot 10:52:23 INFO - Running setup.py install for moztest 10:52:23 INFO - Running setup.py install for mozversion 10:52:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:52:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:52:23 INFO - Cleaning up... 10:52:23 INFO - Return code: 0 10:52:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:52:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:23 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 0x7fbb5dcc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x159f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f9410>, '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 0x16fa310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16fa7a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1463506662.305083-604910210', '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 10:52:23 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 10:52:23 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 10:52:23 INFO - Using env: {'DISPLAY': ':0', 10:52:23 INFO - 'HOME': '/home/cltbld', 10:52:23 INFO - 'LANG': 'en_US.UTF-8', 10:52:23 INFO - 'LANGUAGE': 'en_US:en', 10:52:23 INFO - 'LOGNAME': 'cltbld', 10:52:23 INFO - 'MAIL': '/var/mail/cltbld', 10:52:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:23 INFO - 'MOZ_NO_REMOTE': '1', 10:52:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:23 INFO - 'NO_EM_RESTART': '1', 10:52:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:23 INFO - 'PWD': '/builds/slave/test', 10:52:23 INFO - 'SHELL': '/bin/bash', 10:52:23 INFO - 'SHLVL': '1', 10:52:23 INFO - 'TERM': 'linux', 10:52:23 INFO - 'TMOUT': '86400', 10:52:23 INFO - 'USER': 'cltbld', 10:52:23 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1463506662.305083-604910210', 10:52:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:23 INFO - '_': '/tools/buildbot/bin/python'} 10:52:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:52:23 INFO - Running setup.py (path:/tmp/pip-iGJUUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:52:23 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)) 10:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:52:23 INFO - Running setup.py (path:/tmp/pip-vqDCuM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:52:23 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)) 10:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:52:23 INFO - Running setup.py (path:/tmp/pip-FmGS5u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:52:23 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)) 10:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:52:23 INFO - Running setup.py (path:/tmp/pip-N4kAfJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:52:23 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)) 10:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:52:23 INFO - Running setup.py (path:/tmp/pip-zO957o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:52:23 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)) 10:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:52:23 INFO - Running setup.py (path:/tmp/pip-W5weke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:52:23 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)) 10:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:52:23 INFO - Running setup.py (path:/tmp/pip-bzm61n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:52:24 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)) 10:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:52:24 INFO - Running setup.py (path:/tmp/pip-D3_8h6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:52:24 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)) 10:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:52:24 INFO - Running setup.py (path:/tmp/pip-e9zBJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:52:24 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)) 10:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:52:24 INFO - Running setup.py (path:/tmp/pip-7OniXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:52:24 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)) 10:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:52:24 INFO - Running setup.py (path:/tmp/pip-gQC2Y3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:52:24 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)) 10:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:52:24 INFO - Running setup.py (path:/tmp/pip-T9Pj56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:52:24 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)) 10:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:52:24 INFO - Running setup.py (path:/tmp/pip-mJ4Mgh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:52:24 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)) 10:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:52:24 INFO - Running setup.py (path:/tmp/pip-YEvcZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:52:24 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)) 10:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:52:24 INFO - Running setup.py (path:/tmp/pip-GgmPed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:52:24 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)) 10:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:52:24 INFO - Running setup.py (path:/tmp/pip-vR34gg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:52:24 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)) 10:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:52:24 INFO - Running setup.py (path:/tmp/pip-2tniso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:52:24 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)) 10:52:24 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)) 10:52:24 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)) 10:52:24 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)) 10:52:24 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)) 10:52:24 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)) 10:52:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:52:24 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 10:52:24 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 10:52:24 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 10:52:24 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 10:52:24 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 10:52:24 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 10:52:26 INFO - Downloading blessings-1.6.tar.gz 10:52:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:52:26 INFO - Installing collected packages: blessings 10:52:26 INFO - Running setup.py install for blessings 10:52:26 INFO - Successfully installed blessings 10:52:26 INFO - Cleaning up... 10:52:26 INFO - Return code: 0 10:52:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:52:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:52:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:52:27 INFO - Reading from file tmpfile_stdout 10:52:27 INFO - Current package versions: 10:52:27 INFO - argparse == 1.2.1 10:52:27 INFO - blessings == 1.6 10:52:27 INFO - blobuploader == 1.2.4 10:52:27 INFO - docopt == 0.6.1 10:52:27 INFO - manifestparser == 1.1 10:52:27 INFO - mozInstall == 1.12 10:52:27 INFO - mozcrash == 0.17 10:52:27 INFO - mozdebug == 0.1 10:52:27 INFO - mozdevice == 0.48 10:52:27 INFO - mozfile == 1.2 10:52:27 INFO - mozhttpd == 0.7 10:52:27 INFO - mozinfo == 0.9 10:52:27 INFO - mozleak == 0.1 10:52:27 INFO - mozlog == 3.1 10:52:27 INFO - moznetwork == 0.27 10:52:27 INFO - mozprocess == 0.22 10:52:27 INFO - mozprofile == 0.28 10:52:27 INFO - mozrunner == 6.11 10:52:27 INFO - mozscreenshot == 0.1 10:52:27 INFO - mozsystemmonitor == 0.0 10:52:27 INFO - moztest == 0.7 10:52:27 INFO - mozversion == 1.4 10:52:27 INFO - psutil == 3.1.1 10:52:27 INFO - requests == 1.2.3 10:52:27 INFO - wsgiref == 0.1.2 10:52:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:52:27 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')]} 10:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:27 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')]} 10:52:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:27 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 0x7fbb5dcc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x159f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f9410>, '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 0x16fa310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16fa7a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1463506662.305083-604910210', '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 10:52:27 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 10:52:27 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 10:52:27 INFO - Using env: {'DISPLAY': ':0', 10:52:27 INFO - 'HOME': '/home/cltbld', 10:52:27 INFO - 'LANG': 'en_US.UTF-8', 10:52:27 INFO - 'LANGUAGE': 'en_US:en', 10:52:27 INFO - 'LOGNAME': 'cltbld', 10:52:27 INFO - 'MAIL': '/var/mail/cltbld', 10:52:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:27 INFO - 'MOZ_NO_REMOTE': '1', 10:52:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:27 INFO - 'NO_EM_RESTART': '1', 10:52:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:27 INFO - 'PWD': '/builds/slave/test', 10:52:27 INFO - 'SHELL': '/bin/bash', 10:52:27 INFO - 'SHLVL': '1', 10:52:27 INFO - 'TERM': 'linux', 10:52:27 INFO - 'TMOUT': '86400', 10:52:27 INFO - 'USER': 'cltbld', 10:52:27 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1463506662.305083-604910210', 10:52:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:27 INFO - '_': '/tools/buildbot/bin/python'} 10:52:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:27 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)) 10:52:27 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)) 10:52:27 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)) 10:52:27 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)) 10:52:27 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)) 10:52:27 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)) 10:52:27 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)) 10:52:27 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)) 10:52:27 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)) 10:52:27 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)) 10:52:27 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)) 10:52:27 INFO - Cleaning up... 10:52:27 INFO - Return code: 0 10:52:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:52:27 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')]} 10:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:27 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')]} 10:52:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:27 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 0x7fbb5dcc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x159f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f9410>, '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 0x16fa310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16fa7a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1463506662.305083-604910210', '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 10:52:27 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 10:52:27 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 10:52:27 INFO - Using env: {'DISPLAY': ':0', 10:52:27 INFO - 'HOME': '/home/cltbld', 10:52:27 INFO - 'LANG': 'en_US.UTF-8', 10:52:27 INFO - 'LANGUAGE': 'en_US:en', 10:52:27 INFO - 'LOGNAME': 'cltbld', 10:52:27 INFO - 'MAIL': '/var/mail/cltbld', 10:52:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:27 INFO - 'MOZ_NO_REMOTE': '1', 10:52:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:27 INFO - 'NO_EM_RESTART': '1', 10:52:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:27 INFO - 'PWD': '/builds/slave/test', 10:52:27 INFO - 'SHELL': '/bin/bash', 10:52:27 INFO - 'SHLVL': '1', 10:52:27 INFO - 'TERM': 'linux', 10:52:27 INFO - 'TMOUT': '86400', 10:52:27 INFO - 'USER': 'cltbld', 10:52:27 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1463506662.305083-604910210', 10:52:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:27 INFO - '_': '/tools/buildbot/bin/python'} 10:52:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:27 INFO - Downloading/unpacking jsonschema 10:52:27 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 10:52:27 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 10:52:27 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 10:52:27 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 10:52:27 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 10:52:27 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 10:52:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:52:29 INFO - Downloading/unpacking functools32 (from jsonschema) 10:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:29 INFO - Downloading functools32-3.2.3-2.tar.gz 10:52:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:52:29 INFO - warning: no files found matching '*.txt' 10:52:29 INFO - no previously-included directories found matching 'build' 10:52:29 INFO - no previously-included directories found matching 'dist' 10:52:29 INFO - no previously-included directories found matching '.git*' 10:52:29 INFO - Installing collected packages: jsonschema, functools32 10:52:29 INFO - Running setup.py install for functools32 10:52:29 INFO - warning: no files found matching '*.txt' 10:52:29 INFO - no previously-included directories found matching 'build' 10:52:29 INFO - no previously-included directories found matching 'dist' 10:52:29 INFO - no previously-included directories found matching '.git*' 10:52:29 INFO - Successfully installed jsonschema functools32 10:52:29 INFO - Cleaning up... 10:52:29 INFO - Return code: 0 10:52:29 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:52:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb5dcc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x159f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f9410>, '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 0x16fa310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16fa7a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1463506662.305083-604910210', '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 10:52:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:52:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:52:29 INFO - Using env: {'DISPLAY': ':0', 10:52:29 INFO - 'HOME': '/home/cltbld', 10:52:29 INFO - 'LANG': 'en_US.UTF-8', 10:52:29 INFO - 'LANGUAGE': 'en_US:en', 10:52:29 INFO - 'LOGNAME': 'cltbld', 10:52:29 INFO - 'MAIL': '/var/mail/cltbld', 10:52:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:29 INFO - 'MOZ_NO_REMOTE': '1', 10:52:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:29 INFO - 'NO_EM_RESTART': '1', 10:52:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:29 INFO - 'PWD': '/builds/slave/test', 10:52:29 INFO - 'SHELL': '/bin/bash', 10:52:29 INFO - 'SHLVL': '1', 10:52:29 INFO - 'TERM': 'linux', 10:52:29 INFO - 'TMOUT': '86400', 10:52:29 INFO - 'USER': 'cltbld', 10:52:29 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1463506662.305083-604910210', 10:52:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:29 INFO - '_': '/tools/buildbot/bin/python'} 10:52:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:30 INFO - Downloading/unpacking flake8 10:52:30 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 10:52:30 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 10:52:30 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 10:52:30 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 10:52:30 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 10:52:30 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 10:52:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:52:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:52:32 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 10:52:32 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 10:52:32 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 10:52:32 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 10:52:32 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 10:52:32 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 10:52:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:52:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:52:32 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 10:52:32 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 10:52:32 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 10:52:32 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 10:52:32 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 10:52:32 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 10:52:32 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:52:32 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 10:52:32 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 10:52:32 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 10:52:32 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 10:52:32 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 10:52:32 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 10:52:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:52:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:52:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:52:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:52:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:52:32 INFO - no previously-included directories found matching 'docs/_build' 10:52:32 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:52:32 INFO - Running setup.py install for pep8 10:52:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:52:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:52:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:52:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:52:32 INFO - no previously-included directories found matching 'docs/_build' 10:52:32 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:52:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:52:32 INFO - Cleaning up... 10:52:33 INFO - Return code: 0 10:52:33 INFO - Running post-action listener: _resource_record_post_action 10:52:33 INFO - Running post-action listener: _start_resource_monitoring 10:52:33 INFO - Starting resource monitoring. 10:52:33 INFO - ##### 10:52:33 INFO - ##### Running install step. 10:52:33 INFO - ##### 10:52:33 INFO - Running pre-action listener: _resource_record_pre_action 10:52:33 INFO - Running main action method: install 10:52:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:52:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:52:33 INFO - Reading from file tmpfile_stdout 10:52:33 INFO - Detecting whether we're running mozinstall >=1.0... 10:52:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:52:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:52:33 INFO - Reading from file tmpfile_stdout 10:52:33 INFO - Output received: 10:52:33 INFO - Usage: mozinstall [options] installer 10:52:33 INFO - Options: 10:52:33 INFO - -h, --help show this help message and exit 10:52:33 INFO - -d DEST, --destination=DEST 10:52:33 INFO - Directory to install application into. [default: 10:52:33 INFO - "/builds/slave/test"] 10:52:33 INFO - --app=APP Application being installed. [default: firefox] 10:52:33 INFO - mkdir: /builds/slave/test/build/application 10:52:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:52:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:52:48 INFO - Reading from file tmpfile_stdout 10:52:48 INFO - Output received: 10:52:48 INFO - /builds/slave/test/build/application/firefox/firefox 10:52:48 INFO - Running post-action listener: _resource_record_post_action 10:52:48 INFO - ##### 10:52:48 INFO - ##### Running run-tests step. 10:52:48 INFO - ##### 10:52:48 INFO - Running pre-action listener: _resource_record_pre_action 10:52:48 INFO - Running main action method: run_tests 10:52:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:52:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:52:48 INFO - Python 2.7.3 10:52:48 INFO - Return code: 0 10:52:48 INFO - grabbing minidump binary from tooltool 10:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:48 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 0x16f9410>, '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 0x16fa310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16fa7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:52:48 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 10:52:48 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 10:52:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:52:49 INFO - Return code: 0 10:52:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:52:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:52:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:52:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:52:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:52:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:52:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:52:49 INFO - Return code: 0 10:52:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 10:52:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --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 10:52:49 INFO - Using env: {'DISPLAY': ':0', 10:52:49 INFO - 'HOME': '/home/cltbld', 10:52:49 INFO - 'LANG': 'en_US.UTF-8', 10:52:49 INFO - 'LANGUAGE': 'en_US:en', 10:52:49 INFO - 'LOGNAME': 'cltbld', 10:52:49 INFO - 'MAIL': '/var/mail/cltbld', 10:52:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:52:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:52:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:49 INFO - 'MOZ_NO_REMOTE': '1', 10:52:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:52:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:49 INFO - 'NO_EM_RESTART': '1', 10:52:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:49 INFO - 'PWD': '/builds/slave/test', 10:52:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:52:49 INFO - 'SHELL': '/bin/bash', 10:52:49 INFO - 'SHLVL': '1', 10:52:49 INFO - 'TERM': 'linux', 10:52:49 INFO - 'TMOUT': '86400', 10:52:49 INFO - 'USER': 'cltbld', 10:52:49 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1463506662.305083-604910210', 10:52:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:49 INFO - '_': '/tools/buildbot/bin/python'} 10:52:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 10:52:50 INFO - mozversion application_buildid: 20160517004009 10:52:50 INFO - mozversion application_changeset: 17724486e1591858eea09dc327475a25883854a4 10:52:50 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:52:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:52:50 INFO - mozversion application_name: Firefox 10:52:50 INFO - mozversion application_remotingname: firefox-dev 10:52:50 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:52:50 INFO - mozversion application_vendor: Mozilla 10:52:50 INFO - mozversion application_version: 48.0a2 10:52:50 INFO - mozversion platform_buildid: 20160517004009 10:52:50 INFO - mozversion platform_changeset: 17724486e1591858eea09dc327475a25883854a4 10:52:50 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:52:50 INFO - mozversion platform_version: 48.0a2 10:52:50 INFO - using testdate: 1463507570 10:52:50 INFO - actual date: 1463507570 10:52:50 INFO - starting webserver on 'localhost:32847' 10:52:50 INFO - SUITE-START | Running 2 tests 10:52:50 INFO - TEST-START | dromaeo_css 10:52:50 INFO - operating with platform_type : linux_ 10:52:50 INFO - Initialising browser for dromaeo_css test... 10:52:50 INFO - TEST-INFO | started process 24912 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbo_9xD/profile http://localhost:32847/getInfo.html) 10:52:53 INFO - PROCESS | 24912 | __metrics Screen width/height:1600/1200 10:52:53 INFO - PROCESS | 24912 | colorDepth:24 10:52:53 INFO - PROCESS | 24912 | Browser inner width/height: 1024/697 10:52:53 INFO - PROCESS | 24912 | __metrics 10:52:54 ERROR - PROCESS | 24912 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:52:55 INFO - TEST-INFO | 24912: exit 0 10:52:55 INFO - Browser initialized. 10:52:55 INFO - Running cycle 1/1 for dromaeo_css test... 10:52:55 INFO - TEST-INFO | started process 25007 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbo_9xD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:53:07 INFO - PROCESS | 25007 | RSS: Main: 142450688 10:53:07 INFO - PROCESS | 25007 | 10:53:58 INFO - PROCESS | 25007 | 1463507638633 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] 10:56:06 INFO - PROCESS | 25007 | Cycle 1(1): loaded http://localhost:32847/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32847/tests/dromaeo/cssquery-ext.html) 10:56:07 INFO - PROCESS | 25007 | RSS: Main: 250662912 10:56:07 INFO - PROCESS | 25007 | 10:59:09 INFO - PROCESS | 25007 | Cycle 1(1): loaded http://localhost:32847/tests/dromaeo/cssquery-ext.html (next: http://localhost:32847/tests/dromaeo/cssquery-jquery.html) 10:59:09 INFO - PROCESS | 25007 | RSS: Main: 219639808 10:59:09 INFO - PROCESS | 25007 | 11:02:11 INFO - PROCESS | 25007 | Cycle 1(1): loaded http://localhost:32847/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32847/tests/dromaeo/cssquery-mootools.html) 11:02:12 INFO - PROCESS | 25007 | RSS: Main: 215363584 11:02:12 INFO - PROCESS | 25007 | 11:05:14 INFO - PROCESS | 25007 | Cycle 1(1): loaded http://localhost:32847/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32847/tests/dromaeo/cssquery-prototype.html) 11:05:14 INFO - PROCESS | 25007 | RSS: Main: 212414464 11:05:14 INFO - PROCESS | 25007 | 11:08:17 INFO - PROCESS | 25007 | Cycle 1(1): loaded http://localhost:32847/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32847/tests/dromaeo/cssquery-yui.html) 11:08:17 INFO - PROCESS | 25007 | RSS: Main: 210567168 11:08:17 INFO - PROCESS | 25007 | 11:11:20 INFO - PROCESS | 25007 | Cycle 1(1): loaded http://localhost:32847/tests/dromaeo/cssquery-yui.html (next: http://localhost:32847/tests/dromaeo/cssquery-dojo.html) 11:11:20 INFO - PROCESS | 25007 | RSS: Main: 253202432 11:11:20 INFO - PROCESS | 25007 | 11:11:20 INFO - PROCESS | 25007 | __start_tp_report 11:11:20 INFO - PROCESS | 25007 | _x_x_mozilla_page_load 11:11:20 INFO - PROCESS | 25007 | _x_x_mozilla_page_load_details 11:11:20 INFO - PROCESS | 25007 | |i|pagename|runs| 11:11:20 INFO - PROCESS | 25007 | |0;dojo.html;3315.320359326338;3379.5944486661606;3385.830708464576;3430.845611947462;3444.2422667013248;5650.6892120933335;5666.490015898568;5669.319681638209;5683.3464151622575;5689.431056894314;5661.745221465034;5694.914576281349;5709.743061562229;5711.885762284752;5713.371529131792;4886.242632391967;5080.212567052104;5153.3815942087;5237.109691352479;5241.659292145999;5075.796968121271;5127.871803204913;5134.0758663440565;5135.537801597856;5139.717315547643;5074.188129899217;5115.565176959963;5125.461826508219;5151.0728068947765;5162.045021670984;5066.417362003362;5116.974415127937;5125.103106956268;5134.948650513485;5147.510986456281;4974.253861920704;4985.052839960396;4993.475685053089;5017.272495488134;5082.3138876251605;5467.097928841737;5498.477644623755;5501.14732216507;5526.226328314039;5536.058869992111;5994.7901823436405;6029.577929544934;6031.1254868044325;6039.063945088475;6044.335123136451;6013.609115407485;6053.061775424816;6093.116498107794;6128.080787881853;6139.737467782881;5499.972500137474;5542.196381524737;5555.861103472405;5575.581831362623;5607.607467477278;5982.670953097534;6052.415848962862;6083;6087.360827113178;6101.694915254219;5870.559708021916;5933.3473317934995;5940.435658612425;5943.762249509971;5945.970270148708;6023.066424704178;6038.064100064497;6045.093236014633;6050.54620903434;6052.213212282375;5893.6463812171405;5955.7617695292565;5967.492763115097;5973.253343332083;5976.193213916153;5918.644881307136;5919.3192782829665;5925.822225333247;5928.970355148197;5960;4501.662375321798;4502.977485112553;4522.253828118323;4526.185286648369;4536.274196128604;4020.2361551305157;4074.694397920168;4081.3265811140827;4105.609967053125;4131.153113611763;5600.775968961278;5624.634398764149;5631.746571404296;5651.886962260732;5722.599418040697;6013.4888534474185;6035.969820150959;6040.365761595057;6049.032154855202;6063.878722425527;5589.832305030855;5641.069223578145;5676.801311954062;5713.857153571194;5719.170720245541;5191.195364718475;5197.220416937414;5198.610104242197;5199.142141546602;5202.297689811827;6199.752009919643;6251.374862513803;6275.246970363585;6283.59156654816;6308.085327627468;5956.047032474957;6019.097135429545;6069.757209711562;6132.9386706134155;6136;6218.689065546795;6237.906431403623;6264.185655864891;6292.811215663537;6294.685265736786;5910.143029260819;5923.49650279731;5929.347771745191;5933.2880054393745;5955.493783028318;5877.353491115889;5924.052151655715;6007.12896629995;6039.4262545058145;6055.212822333068;5838.795642152504;5896.380880007709;5897.292324921037;5903;5929.0513517836935;5800.6809625471005;5842.853928651818;5867;5884.235049443716;5890.352061273171;5765.827025189251;5871.1486834407915;5871.295444546682;5875.148103525051;5883.735231914488;5839.124131380157;5856.033754430471;5865.061590145556;5869.647821130746;5883.558733094949;5525.889482210253;5716.971415142898;5721;5758.712064396847;5807.216025836627 11:11:20 INFO - PROCESS | 25007 | |1;ext.html;667.2660073918688;669.7957123077459;684.8322161070538;685.55781520919;755.2598453515558;34164;39560.60439395609;40059.399109013386;40251.59748402515;40361.798191009;43688.12623747523;44375.55624443755;44475.77762111185;44527.55472445275;44535.55464445354;8283.751487455385;8735.606897689604;8906;8908.331875109361;10366.948165259164;10344.172466202686;10456.94771526145;10459.633912813053;10473.528691208914;10479.84280235797;10517.73705657361;10620.57517699295;10622.150227981743;10623.043926046654;10626.840597391045;10474.109700675452;10546.36721796687;10549.789004219949;10553.788924221511;10556.577736890515;10387.792244155075;10854.782904341948;10856.077233435168;10863.022327990519;10872.293300935415;34782.82608586941;39365.80317098396;44242;44736.55263447356;44740.3288950666;3622.836972336225;3673.338799016176;3702.8889133325774;3750.7556013595968;3757.887263382103;33917.321653567036;33927.830360848035;33936.49095263573;33982.83008584966;34351;4522.299043648207;4596.954030459686;4622.1911165546235;4689.718616882964;4788.664793464459;324178;326051;327159;327350;329821.3508932464;40556.1888762229;41243.58756412457;41434;65970;66828.6658566704;40238.59761402407;40451.797741011105;40640.79679601583;40708.18583628311;40726.79636601857;14364.209968451836;14389.64025899361;14412.855871441361;14480.493182738554;15540.222988850512;13200.801987970188;13358.265295408846;13371.732565348639;13376.130551514121;13376.264305463099;9554.808903822024;9564.426134431957;9622.51887405627;9657.22742180624;9730.95134524337;3726.5900750917376;3758.4550240215017;3763.8870833875026;3776.962230377716;3832.7700337979254;1141.90864730823;1175.418168006842;1227.6869398303375;1238.5231685801032;1279.7248591552675;33458.330833383196;33876.830615847255;34231.828840856135;34807.4778878317;35066.474002889976;1186.3415804228737;1221.248931906871;1221.5602383142239;1227.6010296653624;1229.244014930829;17772.200250988735;18291.81708182928;18294.176762045474;18296.63406731858;18339.908300458414;890039;907931;908203;908338;909982;63136.684316578125;63975;63987;64230.67884660547;64319.356806432275;1464.4288727396324;1511.5465360391838;1577.2192764581605;1618.4659062509108;1647.448104884877;33201.83399082989;33907.321853563284;34658.48012279868;34682.47976280307;34888;50911.74544127404;51229.7438512805;51490.9999999985;51532.227016595534;51666.741666291426;300517;301613;301754;301774;302100;28318;31308.217294567818;31642.525362119126;31732.04803855888;31950.68049319477;45218.77390613026;47992;48217.276740849615;48418.273725893436;49517.50482495273;39892.800535997136;40305.38620169628;40733.79633101816;41273.79363103165;41828.3725744108;38661.80669096637;39023.21953560856;39363;39384;39689.40465892956;41754.37368439415;42449.151016980104;42607.573924261604;42773.35839962465;42909.57090429056;34139.14652133716;35248.64751352556;35264.647353527165;35850.4622430669;36739.44890826586;28670.283242919093;28743.425131497672;29085;29344;30390.69609303967 11:11:20 INFO - PROCESS | 25007 | |2;jquery.html;423.9943597978927;434.72829481574007;437.5755517148365;442.3188290033349;447.8566858605246;18415.44753657389;18739.063046847656;19223.231070757152;19280.553958453103;19411.22355105796;15522;16609.584760380996;19793.20827166915;19869;19895.30366437175;5571.331440227178;5626.915596266059;5788.71056447178;6044.2746870375395;6069.78755743549;5780.5953583248975;5784.30588329399;5794.841031793637;5821.941780582182;5822.737976791054;4138.52406973199;4294.162638285536;5615.606907516475;5800.941990580103;5814.360420353758;5719.170720245583;5726.427357264281;5744.482996530291;5768.913466298009;5770.451807078321;5675.432456754292;5956.37458066901;5969.641821490681;5969.731362088716;5970.194023806774;14733.263336833115;15047.398104075824;17684.734728979074;24907.252782416555;25073.373165670822;2477.7398373170736;2524.3184340228036;2565.7305982871717;2740.725927407263;3202.871885124592;10560;10607.522661480252;10883.18376121794;11044;11104.389258590774;1959.3142400159973;2042.6323261812868;2088.0708084902226;2089.498520355119;2146.538494223734;78689;79312.6034369836;80893.59553202255;81767.59116204441;82521;11071.391073490875;11254.099672026217;11425.542978280942;11555.422228888521;11713.882861171449;16987.830121698626;17020;17051.31794728222;17140.571485712957;17154.742678859828;8620.612072456754;8967.192952634294;9020.278377729766;9039.728808135635;9075;8338.124496927856;8360.372972027122;8397.95801020991;8419.410641255176;8778.473291602397;5110.48895110486;5137.537621614073;5163.483651634881;5185.792568297301;5249.343832020997;1870.6071724937644;1999.2502811445709;2078.3349328214827;2148.2051640892655;2152.7093842331396;994.9104580587637;1101.5703875488566;1124.9043831274432;1139.401814047615;1201.4561288744096;18225.81774182241;19601.21595136207;20291.492712682008;20705.58588828215;21257.468563286042;1034.7102811212872;1082.832161015044;1089.629525961177;1149.0864762513654;1164.1792536262085;10949.781004379867;11444.370559619134;11459.140564457699;11512.827307590225;11748;517293;517593;520845;537255;546216;96479.51760241154;101100;101664;101728;101885;1141.560499207811;1146.1174895330716;1151.6314779270554;1166.702490864841;1182.3497076607832;18208.726869097238;18246.908765456086;18455.169517371483;18458.07709614487;18741.437756867315;41648.79175604103;41697.1660566793;41853.79073104615;41866.790666047695;43784.34323485214;59008.40991590201;62043;62180.689096554226;62347.6882615584;62366;8758.781030474289;8832.470051796912;9009.459432434074;9148.588313526041;9225.21585665226;13373.598792036255;13572.1856688599;13875.653108672364;14098.083624564371;14108.2945852709;6959.512834101564;11521.251118677259;11558.075353971493;11959.641210763692;12125.029997599995;11213.55145794159;11278.661640150809;11373.374464404536;11570.495835541662;11635.301881886775;9045.59294831721;10141.884392716944;11753.47109380097;11995;12066.457009434422;8787.077356877437;8852.29181665478;8891.374386942362;9027.864582031407;9117.77205569866;9048.954755226181;11504.25222360544;12398.070144739;12463.688407789878;12583.622491325275 11:11:20 INFO - PROCESS | 25007 | |3;mootools.html;1436.324927284176;1566.819815721192;1573.1347758732695;1777.9111044447775;1882.5670095877947;8361.456505327156;8607.827843443127;8613.095624959384;8617.138286171388;8626.137386261387;8504.532250726208;8604.268637165833;8640.481571105722;8658.220760131588;8663;2196.2642514757495;2245.0346351069034;2423.151896836111;2444.633305004255;2480.875956202192;2497.300755788373;2517.0812653381568;2517.5216708825355;2518.874056297187;2519.4457219411793;2401.4836810085826;2481.7146028206716;2495.800335973118;2499.5875680512786;2502.78726308264;2141.0472339808794;2400.6519054737055;2414.37226321156;2456.312232574882;2460.483298507316;2344.55453463843;2356.1164563288767;2371.5731168389684;2380.262118743178;2380.797632201265;8569.357298202598;8627.65489380424;8645.178708022728;8659.263962563127;8664.566771661455;5048.242763585492;5127.948720512784;5144.768485418128;5149.30484384607;5152.948470515322;3509.4735789631504;3581.1763294442426;3620.2216523447323;3633.8364773585254;3655.25067361193;1168.3048586091263;1178.8054970929873;1222.358261912494;1251.474380760083;1265.4811527273773;12540.996720262267;12566;12566.497340106385;12568.685782855411;12604.369781510888;4758.168105279492;4840.830570930071;4869.099216644932;4884.780184891689;4894.681845680019;10415.16678665705;10500.369977801203;10510.421926794099;10539.10417614496;10558.155347572176;5322.361316642027;5331.973340133274;5336.599755018389;5338.119210330329;5343.492368225013;4183.5398106208295;4669.906601867943;4701.200795864643;4757.26262429324;4770;4240;4283.357496375506;4293.2057569349145;4408.867733967986;4421.314696222091;1357.3077730357588;1387.7571425000585;1393.533166389271;1400.4958215042577;1400.544822932551;858.8791626926795;971.1065819446127;1042.781015986636;1058.8782290036745;1071.7910007548453;5948.464638182498;6018.15745795589;6025.969870150621;6173.135760993465;6239.937600624026;473.17431082760805;485.5120603793236;499.9525045120708;502.5125628140698;506.95944324453956;4233.470816147981;4236.6187043166265;4247.957520424818;4254.170436764863;4257.148570285894;10703.357798531957;11063.391513466837;11096.944515277371;11164.888351116548;11176.105911527058;10946.890531094747;10955.452227388758;10982.341059536293;10985.450727463594;10989.505472253608;7928.246816552418;8141.348692104618;8347.707830225912;8387.874181887277;8392.664293428317;5873.177755114202;5997.760089596542;6004.819855404345;6025.758969641165;6057.697115144313;9157.633694652406;9574.617015319309;9585.329026968046;9608.567614457506;9832.213422926292;9786.363886347364;9991.550380233053;10012.39925604437;10135.7466063349;10161.593536258466;6882.931170688429;7173.892391614026;7217.855642887008;7378.778636640909;7392.297731715478;8205.466644668077;8218.096009439076;8231.42380033392;8268.958655206685;8277.130901255523;7443.702251909863;7641.503302285334;7656.80857978555;7686.07767067933;7795.961020194863;7517.173110957681;7532.623368831646;7574.469787115069;7661.233876612294;7700.422468314787;7043.647817608997;7060.152781666233;7071.9292807073325;7083.5041547091205;7102.573845569283;5116.9744151279;5243.187305967581;5341.893162136657;5421.430749771375;5425.13197888336;4904.607631389552;5004.3494345734825;5016.021875734197;5019.297298378303;5070.138076526926 11:11:20 INFO - PROCESS | 25007 | |4;prototype.html;366.4302010373868;368.8248082160974;370.2724147051046;372.0791042170628;378.39079082676886;6239.7816076437275;6254.374562543743;6267.937320626792;6273.466755325797;6313.684315784204;6042.667653279068;6270.216222972129;6278.68606569672;6282.748690052393;6284.434400903918;4762.166620841347;4807.495213002637;4811.158047341702;4828.937633720576;4848.854534363974;4809.1343558159515;4824.517548245165;4828.806847726104;4842.539958703936;4852.539008794159;4615.307703844416;4719.528047195287;4789.760511974388;4798.328234047236;4808.302796094564;4717.410323709536;4735.905281894343;4742.549457801503;4748.169070412664;4759.785809638557;4239.194553034913;4272.46594175728;4286.39990401344;4290.785460726983;4292.12011537634;6086.786962456337;6095.055266433666;6101.0848372744;6101.176341193926;6110.633361998294;5678.545716342683;5682.147677848315;5692.288463942007;5692.743826527816;5695.202671625976;6522.608643481406;6640.601563906181;6676.899846502306;6685.030670552791;6694.93305066948;4751.429828420577;4770.499097594738;4770.856874293777;4784.425868895755;4785.569298763128;7000.474964377692;7001.894971575431;7002.579845209253;7005.579665220103;7015.89476157858;4883.780229889663;4887.315775791392;4891.461939186686;4894.412670479494;4896.3389942358035;4955.207166853286;4956.405231372259;4956.430010548761;4964;4964.578010869044;5525;5660.95272374612;5663.584103974006;5668.659880407189;5676.205331253628;6755.425788807908;6758.391744742997;6778.118844550276;6800.387965083068;6809.114815074107;1735.7569940208382;1761.9823801761818;1764.9029303388436;1768.6904791661407;1770.9993853472747;1102.729831191347;1177.4466000979696;1196.252342286071;1203.518592562982;1203.807390817465;6377.23473183221;6403.551751377358;6406.519511036691;6425.550211485244;6433.453156481752;6842.965785171043;6843.247242803288;6845.520813543004;6847.075644787989;6852.6231057292325;6395.6482393468805;6412.807615771534;6413.839654008594;6414.839629009312;6419.967900160469;3654.232611151635;3672.1003354178397;3682.723795715332;3696.4085746280466;3702.333579955634;7191.3887319578425;7209.170945341248;7242.23956484572;7290.4167666586545;7329;7210.819729506699;7215.927840721525;7219.241979592067;7221.277872212737;7222.927770722225;7219;7292.635368231568;7306.196318404971;7312.415006799443;7320.304571065741;6896.655167241718;7020.7893763187185;7020.824479388056;7033.366996970297;7041.049458323266;6895.620740859301;6902.206246281541;6918.411934985583;6921.377076063179;6928.099347085048;7259.6007219603425;7271.781846544613;7273.745418910313;7282.854342913218;7290.380317673057;4749.572538471554;4776.713397196179;4779.426468823764;4794.352762377174;4800.687955282895;6850.0752398425575;6986.231514533296;6991.8951215730785;6996.950457431426;7006.894896576454;6837.760678376233;6840.110785597841;6841.589504629738;6843.897341539781;6844.247132815287;6745.3591908768585;6778.4916131289365;6790.932090679227;6804.319568043156;6824.7952561423235;6668.099806526056;6671.099401580918;6687.164104486939;6694.096296999843;6698.832529186614;6721.663916804238;6801.761938332134;6839;6850.0752398425575;6862.210845752603;6434.517411194272;6540.117084193763;6672.366125218096;6685.53201275906;6707.966460167668 11:11:20 INFO - PROCESS | 25007 | |5;yui.html;773.7310810271155;786.5420560747664;797.2067792546417;804.6700852650418;807.5033854179678;14885.181315027668;15076.547703568896;15192.772108418383;15193.088414695127;15268.236588170588;14484.710305793878;14551.126932384064;14559.927200363984;14568.271586420664;14569.854301456982;756.7427074794568;869.4609342207824;872.8254349130168;881.6429346114834;885.9424137431047;895.2211575928951;897.4884315939917;899.5727029660924;899.8785164002842;900.2213085680904;932.7108596335158;938.0291398402654;938.6761567259284;940.4498368454463;940.8447606145012;779.5478622398995;902.1114202510522;926.1433174313732;932.6828878181417;933.5752232734089;678.6165816313817;680.1566058087985;680.496432639843;681.2574294019543;682.494953734238;14682.339294731762;14690.4858329959;14694.265286735726;14706.70586588273;14738.0420272683;13944.372503237379;14055.859441405557;14303.356348964322;14365;14421.855781442262;11463.197576169672;11838.112141589416;12053.276803391824;12285.324307163102;12383.442745076492;4678.883027924295;4691.601213896823;4706.035262771124;4711.104890070876;4752.667313288071;60107;60367;60502.69748651273;60516.39483605196;60517.39482605162;10640.414777187174;10928.235023548434;11111.277766945122;11118.888811111947;11387.08903287735;20959.895200524206;20984.580308393746;21013.579728405348;21128;21149.577008459746;8565.657373705106;8672;8861.867071993925;8928.68749593774;9056.547172641342;4864.36763220779;4908.631852610997;4935.333729946411;5040.697558146523;5117.02776472469;3739.9252014959548;3741.6819570336284;3793.1655035892613;3795.7342985990717;3804.9429258561145;672.3746915368754;675.7128220506265;722.7687140115113;728.3481284250672;733.5305404541098;787.252110495032;814.5682788122305;832.4755404095381;841.3647695989489;842.3345557010016;9234.215091717278;9768.072033156981;9846.950765246127;9890.20878329732;9960.053794889474;754.2344520311888;783.0907830907786;783.6081959020489;802.967881284742;803.8344400619126;4382.145481631115;4447.955520444819;4517.322401639781;4584.9541504585195;4631.235846085358;67148.3285167142;67354;67891.32108678948;67917.66041169762;68217.31782682109;54843.45156548463;58793.11810322849;59541;59790.40209597848;59899.70050149722;50877.745611271705;52247;53050.73474632602;53208;53245.733771330895;9028.729138125867;9068.365214434927;9212.124848139416;9226.492542910204;9286.396384235004;40200.798996004836;40284.59715402926;40545.797271013456;40909;41027.1794564113;47194.76402617965;47328.05343893172;48571;48662.27006594833;48717.26924096212;12358.62924112278;12442;12735.363231838557;12875.562040318136;13031.804522931974;13255.536056237985;13519.459221631025;13799.931000344934;13935.30323483842;15454.150021748912;12703.047271454492;13586.592402227949;13655.180689158682;13792.586222413343;13915.791263131263;13297.66755831112;13394.062415630813;13593.453120091088;13639.863601364257;13963.511277105252;12598.433070512032;12732.427040783372;12823.93588032054;12863;13300.135491193041;11246.212765106364;11277.436128193722;11384.48769805344;11625.302481851117;11650.53397864076;11282.789075886336;11455.484503197209;11523.827142593036;11846.881531184577;11847.703807404883 11:11:20 INFO - PROCESS | 25007 | __end_tp_report 11:11:20 INFO - PROCESS | 25007 | __start_cc_report 11:11:20 INFO - PROCESS | 25007 | _x_x_mozilla_cycle_collect,829 11:11:20 INFO - PROCESS | 25007 | __end_cc_report 11:11:20 INFO - PROCESS | 25007 | __startTimestamp1463508680593__endTimestamp 11:11:20 INFO - PROCESS | 25007 | 11:11:20 INFO - PROCESS | 25007 | ------- Summary: start ------- 11:11:20 INFO - PROCESS | 25007 | Number of tests: 6 11:11:20 INFO - PROCESS | 25007 | 11:11:20 INFO - PROCESS | 25007 | [#0] dojo.html Cycles:165 Average:5580.95 Median:5838.80 stddev:626.29 (10.7%) stddev-sans-first:602.46 11:11:20 INFO - PROCESS | 25007 | Values: 3315.3 3379.6 3385.8 3430.8 3444.2 5650.7 5666.5 5669.3 5683.3 5689.4 5661.7 5694.9 5709.7 5711.9 5713.4 4886.2 5080.2 5153.4 5237.1 5241.7 5075.8 5127.9 5134.1 5135.5 5139.7 5074.2 5115.6 5125.5 5151.1 5162.0 5066.4 5117.0 5125.1 5134.9 5147.5 4974.3 4985.1 4993.5 5017.3 5082.3 5467.1 5498.5 5501.1 5526.2 5536.1 5994.8 6029.6 6031.1 6039.1 6044.3 6013.6 6053.1 6093.1 6128.1 6139.7 5500.0 5542.2 5555.9 5575.6 5607.6 5982.7 6052.4 6083.0 6087.4 6101.7 5870.6 5933.3 5940.4 5943.8 5946.0 6023.1 6038.1 6045.1 6050.5 6052.2 5893.6 5955.8 5967.5 5973.3 5976.2 5918.6 5919.3 5925.8 5929.0 5960.0 4501.7 4503.0 4522.3 4526.2 4536.3 4020.2 4074.7 4081.3 4105.6 4131.2 5600.8 5624.6 5631.7 5651.9 5722.6 6013.5 6036.0 6040.4 6049.0 6063.9 5589.8 5641.1 5676.8 5713.9 5719.2 5191.2 5197.2 5198.6 5199.1 5202.3 6199.8 6251.4 6275.2 6283.6 6308.1 5956.0 6019.1 6069.8 6132.9 6136.0 6218.7 6237.9 6264.2 6292.8 6294.7 5910.1 5923.5 5929.3 5933.3 5955.5 5877.4 5924.1 6007.1 6039.4 6055.2 5838.8 5896.4 5897.3 5903.0 5929.1 5800.7 5842.9 5867.0 5884.2 5890.4 5765.8 5871.1 5871.3 5875.1 5883.7 5839.1 5856.0 5865.1 5869.6 5883.6 5525.9 5717.0 5721.0 5758.7 5807.2 11:11:20 INFO - PROCESS | 25007 | 11:11:20 INFO - PROCESS | 25007 | [#1] ext.html Cycles:180 Average:65495.80 Median:35557.55 stddev:158020.13 (444.4%) stddev-sans-first:158388.45 11:11:20 INFO - PROCESS | 25007 | Values: 667.3 669.8 684.8 685.6 755.3 34164.0 39560.6 40059.4 40251.6 40361.8 43688.1 44375.6 44475.8 44527.6 44535.6 8283.8 8735.6 8906.0 8908.3 10366.9 10344.2 10456.9 10459.6 10473.5 10479.8 10517.7 10620.6 10622.2 10623.0 10626.8 10474.1 10546.4 10549.8 10553.8 10556.6 10387.8 10854.8 10856.1 10863.0 10872.3 34782.8 39365.8 44242.0 44736.6 44740.3 3622.8 3673.3 3702.9 3750.8 3757.9 33917.3 33927.8 33936.5 33982.8 34351.0 4522.3 4597.0 4622.2 4689.7 4788.7 324178.0 326051.0 327159.0 327350.0 329821.4 40556.2 41243.6 41434.0 65970.0 66828.7 40238.6 40451.8 40640.8 40708.2 40726.8 14364.2 14389.6 14412.9 14480.5 15540.2 13200.8 13358.3 13371.7 13376.1 13376.3 9554.8 9564.4 9622.5 9657.2 9731.0 3726.6 3758.5 3763.9 3777.0 3832.8 1141.9 1175.4 1227.7 1238.5 1279.7 33458.3 33876.8 34231.8 34807.5 35066.5 1186.3 1221.2 1221.6 1227.6 1229.2 17772.2 18291.8 18294.2 18296.6 18339.9 890039.0 907931.0 908203.0 908338.0 909982.0 63136.7 63975.0 63987.0 64230.7 64319.4 1464.4 1511.5 1577.2 1618.5 1647.4 33201.8 33907.3 34658.5 34682.5 34888.0 50911.7 51229.7 51491.0 51532.2 51666.7 300517.0 301613.0 301754.0 301774.0 302100.0 28318.0 31308.2 31642.5 31732.0 31950.7 45218.8 47992.0 48217.3 48418.3 49517.5 39892.8 40305.4 40733.8 41273.8 41828.4 38661.8 39023.2 39363.0 39384.0 39689.4 41754.4 42449.2 42607.6 42773.4 42909.6 34139.1 35248.6 35264.6 35850.5 36739.4 28670.3 28743.4 29085.0 29344.0 30390.7 11:11:20 INFO - PROCESS | 25007 | 11:11:20 INFO - PROCESS | 25007 | [#2] jquery.html Cycles:180 Average:30472.48 Median:2147.37 stddev:87046.15 (4053.6%) stddev-sans-first:87261.10 11:11:20 INFO - PROCESS | 25007 | Values: 424.0 434.7 437.6 442.3 447.9 18415.4 18739.1 19223.2 19280.6 19411.2 15522.0 16609.6 19793.2 19869.0 19895.3 5571.3 5626.9 5788.7 6044.3 6069.8 5780.6 5784.3 5794.8 5821.9 5822.7 4138.5 4294.2 5615.6 5800.9 5814.4 5719.2 5726.4 5744.5 5768.9 5770.5 5675.4 5956.4 5969.6 5969.7 5970.2 14733.3 15047.4 17684.7 24907.3 25073.4 2477.7 2524.3 2565.7 2740.7 3202.9 10560.0 10607.5 10883.2 11044.0 11104.4 1959.3 2042.6 2088.1 2089.5 2146.5 78689.0 79312.6 80893.6 81767.6 82521.0 11071.4 11254.1 11425.5 11555.4 11713.9 16987.8 17020.0 17051.3 17140.6 17154.7 8620.6 8967.2 9020.3 9039.7 9075.0 8338.1 8360.4 8398.0 8419.4 8778.5 5110.5 5137.5 5163.5 5185.8 5249.3 1870.6 1999.3 2078.3 2148.2 2152.7 994.9 1101.6 1124.9 1139.4 1201.5 18225.8 19601.2 20291.5 20705.6 21257.5 1034.7 1082.8 1089.6 1149.1 1164.2 10949.8 11444.4 11459.1 11512.8 11748.0 517293.0 517593.0 520845.0 537255.0 546216.0 96479.5 101100.0 101664.0 101728.0 101885.0 1141.6 1146.1 1151.6 1166.7 1182.3 18208.7 18246.9 18455.2 18458.1 18741.4 41648.8 41697.2 41853.8 41866.8 43784.3 59008.4 62043.0 62180.7 62347.7 62366.0 8758.8 8832.5 9009.5 9148.6 9225.2 13373.6 13572.2 13875.7 14098.1 14108.3 6959.5 11521.3 11558.1 11959.6 12125.0 11213.6 11278.7 11373.4 11570.5 11635.3 9045.6 10141.9 11753.5 11995.0 12066.5 8787.1 8852.3 8891.4 9027.9 9117.8 9049.0 11504.3 12398.1 12463.7 12583.6 11:11:20 INFO - PROCESS | 25007 | 11:11:20 INFO - PROCESS | 25007 | [#3] mootools.html Cycles:180 Average:5799.83 Median:4876.94 stddev:3256.41 (66.8%) stddev-sans-first:3249.04 11:11:20 INFO - PROCESS | 25007 | Values: 1436.3 1566.8 1573.1 1777.9 1882.6 8361.5 8607.8 8613.1 8617.1 8626.1 8504.5 8604.3 8640.5 8658.2 8663.0 2196.3 2245.0 2423.2 2444.6 2480.9 2497.3 2517.1 2517.5 2518.9 2519.4 2401.5 2481.7 2495.8 2499.6 2502.8 2141.0 2400.7 2414.4 2456.3 2460.5 2344.6 2356.1 2371.6 2380.3 2380.8 8569.4 8627.7 8645.2 8659.3 8664.6 5048.2 5127.9 5144.8 5149.3 5152.9 3509.5 3581.2 3620.2 3633.8 3655.3 1168.3 1178.8 1222.4 1251.5 1265.5 12541.0 12566.0 12566.5 12568.7 12604.4 4758.2 4840.8 4869.1 4884.8 4894.7 10415.2 10500.4 10510.4 10539.1 10558.2 5322.4 5332.0 5336.6 5338.1 5343.5 4183.5 4669.9 4701.2 4757.3 4770.0 4240.0 4283.4 4293.2 4408.9 4421.3 1357.3 1387.8 1393.5 1400.5 1400.5 858.9 971.1 1042.8 1058.9 1071.8 5948.5 6018.2 6026.0 6173.1 6239.9 473.2 485.5 500.0 502.5 507.0 4233.5 4236.6 4248.0 4254.2 4257.1 10703.4 11063.4 11096.9 11164.9 11176.1 10946.9 10955.5 10982.3 10985.5 10989.5 7928.2 8141.3 8347.7 8387.9 8392.7 5873.2 5997.8 6004.8 6025.8 6057.7 9157.6 9574.6 9585.3 9608.6 9832.2 9786.4 9991.6 10012.4 10135.7 10161.6 6882.9 7173.9 7217.9 7378.8 7392.3 8205.5 8218.1 8231.4 8269.0 8277.1 7443.7 7641.5 7656.8 7686.1 7796.0 7517.2 7532.6 7574.5 7661.2 7700.4 7043.6 7060.2 7071.9 7083.5 7102.6 5117.0 5243.2 5341.9 5421.4 5425.1 4904.6 5004.3 5016.0 5019.3 5070.1 11:11:20 INFO - PROCESS | 25007 | 11:11:20 INFO - PROCESS | 25007 | [#4] prototype.html Cycles:180 Average:5652.19 Median:6386.44 stddev:1701.20 (26.6%) stddev-sans-first:1659.06 11:11:20 INFO - PROCESS | 25007 | Values: 366.4 368.8 370.3 372.1 378.4 6239.8 6254.4 6267.9 6273.5 6313.7 6042.7 6270.2 6278.7 6282.7 6284.4 4762.2 4807.5 4811.2 4828.9 4848.9 4809.1 4824.5 4828.8 4842.5 4852.5 4615.3 4719.5 4789.8 4798.3 4808.3 4717.4 4735.9 4742.5 4748.2 4759.8 4239.2 4272.5 4286.4 4290.8 4292.1 6086.8 6095.1 6101.1 6101.2 6110.6 5678.5 5682.1 5692.3 5692.7 5695.2 6522.6 6640.6 6676.9 6685.0 6694.9 4751.4 4770.5 4770.9 4784.4 4785.6 7000.5 7001.9 7002.6 7005.6 7015.9 4883.8 4887.3 4891.5 4894.4 4896.3 4955.2 4956.4 4956.4 4964.0 4964.6 5525.0 5661.0 5663.6 5668.7 5676.2 6755.4 6758.4 6778.1 6800.4 6809.1 1735.8 1762.0 1764.9 1768.7 1771.0 1102.7 1177.4 1196.3 1203.5 1203.8 6377.2 6403.6 6406.5 6425.6 6433.5 6843.0 6843.2 6845.5 6847.1 6852.6 6395.6 6412.8 6413.8 6414.8 6420.0 3654.2 3672.1 3682.7 3696.4 3702.3 7191.4 7209.2 7242.2 7290.4 7329.0 7210.8 7215.9 7219.2 7221.3 7222.9 7219.0 7292.6 7306.2 7312.4 7320.3 6896.7 7020.8 7020.8 7033.4 7041.0 6895.6 6902.2 6918.4 6921.4 6928.1 7259.6 7271.8 7273.7 7282.9 7290.4 4749.6 4776.7 4779.4 4794.4 4800.7 6850.1 6986.2 6991.9 6997.0 7006.9 6837.8 6840.1 6841.6 6843.9 6844.2 6745.4 6778.5 6790.9 6804.3 6824.8 6668.1 6671.1 6687.2 6694.1 6698.8 6721.7 6801.8 6839.0 6850.1 6862.2 6434.5 6540.1 6672.4 6685.5 6708.0 11:11:20 INFO - PROCESS | 25007 | 11:11:20 INFO - PROCESS | 25007 | [#5] yui.html Cycles:180 Average:15925.60 Median:26040.36 stddev:18555.32 (71.3%) stddev-sans-first:18572.49 11:11:20 INFO - PROCESS | 25007 | Values: 773.7 786.5 797.2 804.7 807.5 14885.2 15076.5 15192.8 15193.1 15268.2 14484.7 14551.1 14559.9 14568.3 14569.9 756.7 869.5 872.8 881.6 885.9 895.2 897.5 899.6 899.9 900.2 932.7 938.0 938.7 940.4 940.8 779.5 902.1 926.1 932.7 933.6 678.6 680.2 680.5 681.3 682.5 14682.3 14690.5 14694.3 14706.7 14738.0 13944.4 14055.9 14303.4 14365.0 14421.9 11463.2 11838.1 12053.3 12285.3 12383.4 4678.9 4691.6 4706.0 4711.1 4752.7 60107.0 60367.0 60502.7 60516.4 60517.4 10640.4 10928.2 11111.3 11118.9 11387.1 20959.9 20984.6 21013.6 21128.0 21149.6 8565.7 8672.0 8861.9 8928.7 9056.5 4864.4 4908.6 4935.3 5040.7 5117.0 3739.9 3741.7 3793.2 3795.7 3804.9 672.4 675.7 722.8 728.3 733.5 787.3 814.6 832.5 841.4 842.3 9234.2 9768.1 9847.0 9890.2 9960.1 754.2 783.1 783.6 803.0 803.8 4382.1 4448.0 4517.3 4585.0 4631.2 67148.3 67354.0 67891.3 67917.7 68217.3 54843.5 58793.1 59541.0 59790.4 59899.7 50877.7 52247.0 53050.7 53208.0 53245.7 9028.7 9068.4 9212.1 9226.5 9286.4 40200.8 40284.6 40545.8 40909.0 41027.2 47194.8 47328.1 48571.0 48662.3 48717.3 12358.6 12442.0 12735.4 12875.6 13031.8 13255.5 13519.5 13799.9 13935.3 15454.2 12703.0 13586.6 13655.2 13792.6 13915.8 13297.7 13394.1 13593.5 13639.9 13963.5 12598.4 12732.4 12823.9 12863.0 13300.1 11246.2 11277.4 11384.5 11625.3 11650.5 11282.8 11455.5 11523.8 11846.9 11847.7 11:11:20 INFO - PROCESS | 25007 | -------- Summary: end -------- 11:11:20 INFO - PROCESS | 25007 | 11:11:21 INFO - TEST-INFO | 25007: exit 0 11:11:21 INFO - TEST-OK | dromaeo_css | took 1111053ms 11:11:21 INFO - TEST-START | kraken 11:11:21 INFO - operating with platform_type : linux_ 11:11:21 INFO - Initialising browser for kraken test... 11:11:21 INFO - TEST-INFO | started process 25193 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp967YM6/profile http://localhost:32847/getInfo.html) 11:11:24 INFO - PROCESS | 25193 | __metrics Screen width/height:1600/1200 11:11:24 INFO - PROCESS | 25193 | colorDepth:24 11:11:24 INFO - PROCESS | 25193 | Browser inner width/height: 1024/697 11:11:24 INFO - PROCESS | 25193 | __metrics 11:11:25 ERROR - PROCESS | 25193 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:11:26 INFO - TEST-INFO | 25193: exit 0 11:11:26 INFO - Browser initialized. 11:11:26 INFO - Running cycle 1/1 for kraken test... 11:11:26 INFO - TEST-INFO | started process 25284 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp967YM6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:11:38 INFO - PROCESS | 25284 | RSS: Main: 142249984 11:11:38 INFO - PROCESS | 25284 | 11:11:40 INFO - PROCESS | 25284 | Cycle 1(1): loaded http://localhost:32847/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32847/tests/kraken/driver.html?testName=audio-beat-detection) 11:11:41 INFO - PROCESS | 25284 | RSS: Main: 197980160 11:11:41 INFO - PROCESS | 25284 | 11:11:44 INFO - PROCESS | 25284 | Cycle 1(1): loaded http://localhost:32847/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32847/tests/kraken/driver.html?testName=audio-dft) 11:11:44 INFO - PROCESS | 25284 | RSS: Main: 183234560 11:11:44 INFO - PROCESS | 25284 | 11:11:47 INFO - PROCESS | 25284 | Cycle 1(1): loaded http://localhost:32847/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32847/tests/kraken/driver.html?testName=audio-fft) 11:11:48 INFO - PROCESS | 25284 | RSS: Main: 273911808 11:11:48 INFO - PROCESS | 25284 | 11:11:50 INFO - PROCESS | 25284 | Cycle 1(1): loaded http://localhost:32847/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32847/tests/kraken/driver.html?testName=audio-oscillator) 11:11:50 INFO - PROCESS | 25284 | RSS: Main: 179052544 11:11:50 INFO - PROCESS | 25284 | 11:11:53 INFO - PROCESS | 25284 | Cycle 1(1): loaded http://localhost:32847/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32847/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:11:53 INFO - PROCESS | 25284 | RSS: Main: 177999872 11:11:53 INFO - PROCESS | 25284 | 11:11:56 INFO - PROCESS | 25284 | Cycle 1(1): loaded http://localhost:32847/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32847/tests/kraken/driver.html?testName=imaging-darkroom) 11:11:57 INFO - PROCESS | 25284 | RSS: Main: 212844544 11:11:57 INFO - PROCESS | 25284 | 11:12:00 INFO - PROCESS | 25284 | Cycle 1(1): loaded http://localhost:32847/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32847/tests/kraken/driver.html?testName=imaging-desaturate) 11:12:01 INFO - PROCESS | 25284 | RSS: Main: 213413888 11:12:01 INFO - PROCESS | 25284 | 11:12:03 INFO - PROCESS | 25284 | Cycle 1(1): loaded http://localhost:32847/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32847/tests/kraken/driver.html?testName=json-parse-financial) 11:12:04 INFO - PROCESS | 25284 | RSS: Main: 212717568 11:12:04 INFO - PROCESS | 25284 | 11:12:06 INFO - PROCESS | 25284 | Cycle 1(1): loaded http://localhost:32847/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32847/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:12:06 INFO - PROCESS | 25284 | RSS: Main: 191901696 11:12:06 INFO - PROCESS | 25284 | 11:12:08 INFO - PROCESS | 25284 | Cycle 1(1): loaded http://localhost:32847/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32847/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:12:08 INFO - PROCESS | 25284 | RSS: Main: 196132864 11:12:08 INFO - PROCESS | 25284 | 11:12:10 INFO - PROCESS | 25284 | Cycle 1(1): loaded http://localhost:32847/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32847/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:12:11 INFO - PROCESS | 25284 | RSS: Main: 210366464 11:12:11 INFO - PROCESS | 25284 | 11:12:13 INFO - PROCESS | 25284 | Cycle 1(1): loaded http://localhost:32847/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32847/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:12:14 INFO - PROCESS | 25284 | RSS: Main: 213024768 11:12:14 INFO - PROCESS | 25284 | 11:12:17 INFO - PROCESS | 25284 | Cycle 1(1): loaded http://localhost:32847/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32847/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:12:17 INFO - PROCESS | 25284 | RSS: Main: 210362368 11:12:17 INFO - PROCESS | 25284 | 11:12:19 INFO - PROCESS | 25284 | Cycle 1(1): loaded http://localhost:32847/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32847/tests/kraken/driver.html?testName=ai-astar) 11:12:19 INFO - PROCESS | 25284 | RSS: Main: 273547264 11:12:19 INFO - PROCESS | 25284 | 11:12:19 INFO - PROCESS | 25284 | __start_tp_report 11:12:19 INFO - PROCESS | 25284 | _x_x_mozilla_page_load 11:12:19 INFO - PROCESS | 25284 | _x_x_mozilla_page_load_details 11:12:19 INFO - PROCESS | 25284 | |i|pagename|runs| 11:12:19 INFO - PROCESS | 25284 | |0;ai-astar;111;110;110;109;110;113;104;110;109;109 11:12:19 INFO - PROCESS | 25284 | |1;audio-beat-detection;153;126;152;178;131;157;164;128;203;134 11:12:19 INFO - PROCESS | 25284 | |2;audio-dft;162;162;162;165;162;162;160;161;162;160 11:12:19 INFO - PROCESS | 25284 | |3;audio-fft;75;77;77;189;77;77;77;86;169;73 11:12:19 INFO - PROCESS | 25284 | |4;audio-oscillator;92;93;154;93;93;93;153;92;92;147 11:12:19 INFO - PROCESS | 25284 | |5;imaging-gaussian-blur;116;117;117;116;117;116;117;116;117;117 11:12:19 INFO - PROCESS | 25284 | |6;imaging-darkroom;145;145;146;145;145;145;145;146;145;145 11:12:19 INFO - PROCESS | 25284 | |7;imaging-desaturate;94;95;94;94;97;95;95;94;94;94 11:12:19 INFO - PROCESS | 25284 | |8;json-parse-financial;54;56;54;54;54;56;56;74;53;52 11:12:19 INFO - PROCESS | 25284 | |9;json-stringify-tinderbox;58;59;58;58;58;58;58;58;58;59 11:12:19 INFO - PROCESS | 25284 | |10;stanford-crypto-aes;74;73;72;74;73;74;74;74;81;73 11:12:19 INFO - PROCESS | 25284 | |11;stanford-crypto-ccm;113;114;114;114;112;114;120;115;163;126 11:12:19 INFO - PROCESS | 25284 | |12;stanford-crypto-pbkdf2;158;161;165;158;158;167;160;159;156;169 11:12:19 INFO - PROCESS | 25284 | |13;stanford-crypto-sha256-iterative;66;69;69;68;66;66;69;66;67;65 11:12:19 INFO - PROCESS | 25284 | __end_tp_report 11:12:19 INFO - PROCESS | 25284 | __start_cc_report 11:12:19 INFO - PROCESS | 25284 | _x_x_mozilla_cycle_collect,1600 11:12:19 INFO - PROCESS | 25284 | __end_cc_report 11:12:19 INFO - PROCESS | 25284 | __startTimestamp1463508739800__endTimestamp 11:12:19 INFO - PROCESS | 25284 | 11:12:19 INFO - PROCESS | 25284 | ------- Summary: start ------- 11:12:19 INFO - PROCESS | 25284 | Number of tests: 14 11:12:19 INFO - PROCESS | 25284 | 11:12:19 INFO - PROCESS | 25284 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.00 stddev:2.27 (2.1%) stddev-sans-first:2.35 11:12:19 INFO - PROCESS | 25284 | Values: 111.0 110.0 110.0 109.0 110.0 113.0 104.0 110.0 109.0 109.0 11:12:19 INFO - PROCESS | 25284 | 11:12:19 INFO - PROCESS | 25284 | [#1] audio-beat-detection Cycles:10 Average:152.60 Median:155.00 stddev:24.63 (15.9%) stddev-sans-first:26.13 11:12:19 INFO - PROCESS | 25284 | Values: 153.0 126.0 152.0 178.0 131.0 157.0 164.0 128.0 203.0 134.0 11:12:19 INFO - PROCESS | 25284 | 11:12:19 INFO - PROCESS | 25284 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.40 (0.9%) stddev-sans-first:1.48 11:12:19 INFO - PROCESS | 25284 | Values: 162.0 162.0 162.0 165.0 162.0 162.0 160.0 161.0 162.0 160.0 11:12:19 INFO - PROCESS | 25284 | 11:12:19 INFO - PROCESS | 25284 | [#3] audio-fft Cycles:10 Average:97.70 Median:77.00 stddev:43.24 (56.2%) stddev-sans-first:45.07 11:12:19 INFO - PROCESS | 25284 | Values: 75.0 77.0 77.0 189.0 77.0 77.0 77.0 86.0 169.0 73.0 11:12:19 INFO - PROCESS | 25284 | 11:12:19 INFO - PROCESS | 25284 | [#4] audio-oscillator Cycles:10 Average:110.20 Median:92.50 stddev:28.44 (30.8%) stddev-sans-first:29.40 11:12:19 INFO - PROCESS | 25284 | Values: 92.0 93.0 154.0 93.0 93.0 93.0 153.0 92.0 92.0 147.0 11:12:19 INFO - PROCESS | 25284 | 11:12:19 INFO - PROCESS | 25284 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 11:12:19 INFO - PROCESS | 25284 | Values: 116.0 117.0 117.0 116.0 117.0 116.0 117.0 116.0 117.0 117.0 11:12:19 INFO - PROCESS | 25284 | 11:12:19 INFO - PROCESS | 25284 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 11:12:19 INFO - PROCESS | 25284 | Values: 145.0 145.0 146.0 145.0 145.0 145.0 145.0 146.0 145.0 145.0 11:12:19 INFO - PROCESS | 25284 | 11:12:19 INFO - PROCESS | 25284 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:94.50 stddev:0.97 (1.0%) stddev-sans-first:1.00 11:12:19 INFO - PROCESS | 25284 | Values: 94.0 95.0 94.0 94.0 97.0 95.0 95.0 94.0 94.0 94.0 11:12:19 INFO - PROCESS | 25284 | 11:12:19 INFO - PROCESS | 25284 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:55.00 stddev:6.36 (11.6%) stddev-sans-first:6.69 11:12:19 INFO - PROCESS | 25284 | Values: 54.0 56.0 54.0 54.0 54.0 56.0 56.0 74.0 53.0 52.0 11:12:19 INFO - PROCESS | 25284 | 11:12:19 INFO - PROCESS | 25284 | [#9] json-stringify-tinderbox Cycles:10 Average:58.20 Median:58.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 11:12:19 INFO - PROCESS | 25284 | Values: 58.0 59.0 58.0 58.0 58.0 58.0 58.0 58.0 58.0 59.0 11:12:19 INFO - PROCESS | 25284 | 11:12:19 INFO - PROCESS | 25284 | [#10] stanford-crypto-aes Cycles:10 Average:74.20 Median:74.00 stddev:2.49 (3.4%) stddev-sans-first:2.64 11:12:19 INFO - PROCESS | 25284 | Values: 74.0 73.0 72.0 74.0 73.0 74.0 74.0 74.0 81.0 73.0 11:12:19 INFO - PROCESS | 25284 | 11:12:19 INFO - PROCESS | 25284 | [#11] stanford-crypto-ccm Cycles:10 Average:120.50 Median:114.50 stddev:15.51 (13.5%) stddev-sans-first:16.21 11:12:19 INFO - PROCESS | 25284 | Values: 113.0 114.0 114.0 114.0 112.0 114.0 120.0 115.0 163.0 126.0 11:12:19 INFO - PROCESS | 25284 | 11:12:19 INFO - PROCESS | 25284 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.10 Median:160.50 stddev:4.38 (2.7%) stddev-sans-first:4.50 11:12:19 INFO - PROCESS | 25284 | Values: 158.0 161.0 165.0 158.0 158.0 167.0 160.0 159.0 156.0 169.0 11:12:19 INFO - PROCESS | 25284 | 11:12:19 INFO - PROCESS | 25284 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.50 stddev:1.52 (2.3%) stddev-sans-first:1.56 11:12:19 INFO - PROCESS | 25284 | Values: 66.0 69.0 69.0 68.0 66.0 66.0 69.0 66.0 67.0 65.0 11:12:19 INFO - PROCESS | 25284 | -------- Summary: end -------- 11:12:19 INFO - PROCESS | 25284 | 11:12:20 INFO - TEST-INFO | 25284: exit 0 11:12:20 INFO - TEST-OK | kraken | took 59530ms 11:12:20 INFO - SUITE-END | took 1170s 11:12:20 INFO - Completed test suite (00:19:30) 11:12:20 INFO - javascript benchmark 11:12:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3315.320359326338, 3379.5944486661606, 3385.830708464576, 3430.845611947462, 3444.2422667013248, 5650.6892120933335, 5666.490015898568, 5669.319681638209, 5683.3464151622575, 5689.431056894314, 5661.745221465034, 5694.914576281349, 5709.743061562229, 5711.885762284752, 5713.371529131792, 4886.242632391967, 5080.212567052104, 5153.3815942087, 5237.109691352479, 5241.659292145999, 5075.796968121271, 5127.871803204913, 5134.0758663440565, 5135.537801597856, 5139.717315547643, 5074.188129899217, 5115.565176959963, 5125.461826508219, 5151.0728068947765, 5162.045021670984, 5066.417362003362, 5116.974415127937, 5125.103106956268, 5134.948650513485, 5147.510986456281, 4974.253861920704, 4985.052839960396, 4993.475685053089, 5017.272495488134, 5082.3138876251605, 5467.097928841737, 5498.477644623755, 5501.14732216507, 5526.226328314039, 5536.058869992111, 5994.7901823436405, 6029.577929544934, 6031.1254868044325, 6039.063945088475, 6044.335123136451, 6013.609115407485, 6053.061775424816, 6093.116498107794, 6128.080787881853, 6139.737467782881, 5499.972500137474, 5542.196381524737, 5555.861103472405, 5575.581831362623, 5607.607467477278, 5982.670953097534, 6052.415848962862, 6083.0, 6087.360827113178, 6101.694915254219, 5870.559708021916, 5933.3473317934995, 5940.435658612425, 5943.762249509971, 5945.970270148708, 6023.066424704178, 6038.064100064497, 6045.093236014633, 6050.54620903434, 6052.213212282375, 5893.6463812171405, 5955.7617695292565, 5967.492763115097, 5973.253343332083, 5976.193213916153, 5918.644881307136, 5919.3192782829665, 5925.822225333247, 5928.970355148197, 5960.0, 4501.662375321798, 4502.977485112553, 4522.253828118323, 4526.185286648369, 4536.274196128604, 4020.2361551305157, 4074.694397920168, 4081.3265811140827, 4105.609967053125, 4131.153113611763, 5600.775968961278, 5624.634398764149, 5631.746571404296, 5651.886962260732, 5722.599418040697, 6013.4888534474185, 6035.969820150959, 6040.365761595057, 6049.032154855202, 6063.878722425527, 5589.832305030855, 5641.069223578145, 5676.801311954062, 5713.857153571194, 5719.170720245541, 5191.195364718475, 5197.220416937414, 5198.610104242197, 5199.142141546602, 5202.297689811827, 6199.752009919643, 6251.374862513803, 6275.246970363585, 6283.59156654816, 6308.085327627468, 5956.047032474957, 6019.097135429545, 6069.757209711562, 6132.9386706134155, 6136.0, 6218.689065546795, 6237.906431403623, 6264.185655864891, 6292.811215663537, 6294.685265736786, 5910.143029260819, 5923.49650279731, 5929.347771745191, 5933.2880054393745, 5955.493783028318, 5877.353491115889, 5924.052151655715, 6007.12896629995, 6039.4262545058145, 6055.212822333068, 5838.795642152504, 5896.380880007709, 5897.292324921037, 5903.0, 5929.0513517836935, 5800.6809625471005, 5842.853928651818, 5867.0, 5884.235049443716, 5890.352061273171, 5765.827025189251, 5871.1486834407915, 5871.295444546682, 5875.148103525051, 5883.735231914488, 5839.124131380157, 5856.033754430471, 5865.061590145556, 5869.647821130746, 5883.558733094949, 5525.889482210253, 5716.971415142898, 5721.0, 5758.712064396847, 5807.216025836627], "value": 5539.920810255583, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [667.2660073918688, 669.7957123077459, 684.8322161070538, 685.55781520919, 755.2598453515558, 34164.0, 39560.60439395609, 40059.399109013386, 40251.59748402515, 40361.798191009, 43688.12623747523, 44375.55624443755, 44475.77762111185, 44527.55472445275, 44535.55464445354, 8283.751487455385, 8735.606897689604, 8906.0, 8908.331875109361, 10366.948165259164, 10344.172466202686, 10456.94771526145, 10459.633912813053, 10473.528691208914, 10479.84280235797, 10517.73705657361, 10620.57517699295, 10622.150227981743, 10623.043926046654, 10626.840597391045, 10474.109700675452, 10546.36721796687, 10549.789004219949, 10553.788924221511, 10556.577736890515, 10387.792244155075, 10854.782904341948, 10856.077233435168, 10863.022327990519, 10872.293300935415, 34782.82608586941, 39365.80317098396, 44242.0, 44736.55263447356, 44740.3288950666, 3622.836972336225, 3673.338799016176, 3702.8889133325774, 3750.7556013595968, 3757.887263382103, 33917.321653567036, 33927.830360848035, 33936.49095263573, 33982.83008584966, 34351.0, 4522.299043648207, 4596.954030459686, 4622.1911165546235, 4689.718616882964, 4788.664793464459, 324178.0, 326051.0, 327159.0, 327350.0, 329821.3508932464, 40556.1888762229, 41243.58756412457, 41434.0, 65970.0, 66828.6658566704, 40238.59761402407, 40451.797741011105, 40640.79679601583, 40708.18583628311, 40726.79636601857, 14364.209968451836, 14389.64025899361, 14412.855871441361, 14480.493182738554, 15540.222988850512, 13200.801987970188, 13358.265295408846, 13371.732565348639, 13376.130551514121, 13376.264305463099, 9554.808903822024, 9564.426134431957, 9622.51887405627, 9657.22742180624, 9730.95134524337, 3726.5900750917376, 3758.4550240215017, 3763.8870833875026, 3776.962230377716, 3832.7700337979254, 1141.90864730823, 1175.418168006842, 1227.6869398303375, 1238.5231685801032, 1279.7248591552675, 33458.330833383196, 33876.830615847255, 34231.828840856135, 34807.4778878317, 35066.474002889976, 1186.3415804228737, 1221.248931906871, 1221.5602383142239, 1227.6010296653624, 1229.244014930829, 17772.200250988735, 18291.81708182928, 18294.176762045474, 18296.63406731858, 18339.908300458414, 890039.0, 907931.0, 908203.0, 908338.0, 909982.0, 63136.684316578125, 63975.0, 63987.0, 64230.67884660547, 64319.356806432275, 1464.4288727396324, 1511.5465360391838, 1577.2192764581605, 1618.4659062509108, 1647.448104884877, 33201.83399082989, 33907.321853563284, 34658.48012279868, 34682.47976280307, 34888.0, 50911.74544127404, 51229.7438512805, 51490.9999999985, 51532.227016595534, 51666.741666291426, 300517.0, 301613.0, 301754.0, 301774.0, 302100.0, 28318.0, 31308.217294567818, 31642.525362119126, 31732.04803855888, 31950.68049319477, 45218.77390613026, 47992.0, 48217.276740849615, 48418.273725893436, 49517.50482495273, 39892.800535997136, 40305.38620169628, 40733.79633101816, 41273.79363103165, 41828.3725744108, 38661.80669096637, 39023.21953560856, 39363.0, 39384.0, 39689.40465892956, 41754.37368439415, 42449.151016980104, 42607.573924261604, 42773.35839962465, 42909.57090429056, 34139.14652133716, 35248.64751352556, 35264.647353527165, 35850.4622430669, 36739.44890826586, 28670.283242919093, 28743.425131497672, 29085.0, 29344.0, 30390.69609303967], "value": 20038.461341757422, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [423.9943597978927, 434.72829481574007, 437.5755517148365, 442.3188290033349, 447.8566858605246, 18415.44753657389, 18739.063046847656, 19223.231070757152, 19280.553958453103, 19411.22355105796, 15522.0, 16609.584760380996, 19793.20827166915, 19869.0, 19895.30366437175, 5571.331440227178, 5626.915596266059, 5788.71056447178, 6044.2746870375395, 6069.78755743549, 5780.5953583248975, 5784.30588329399, 5794.841031793637, 5821.941780582182, 5822.737976791054, 4138.52406973199, 4294.162638285536, 5615.606907516475, 5800.941990580103, 5814.360420353758, 5719.170720245583, 5726.427357264281, 5744.482996530291, 5768.913466298009, 5770.451807078321, 5675.432456754292, 5956.37458066901, 5969.641821490681, 5969.731362088716, 5970.194023806774, 14733.263336833115, 15047.398104075824, 17684.734728979074, 24907.252782416555, 25073.373165670822, 2477.7398373170736, 2524.3184340228036, 2565.7305982871717, 2740.725927407263, 3202.871885124592, 10560.0, 10607.522661480252, 10883.18376121794, 11044.0, 11104.389258590774, 1959.3142400159973, 2042.6323261812868, 2088.0708084902226, 2089.498520355119, 2146.538494223734, 78689.0, 79312.6034369836, 80893.59553202255, 81767.59116204441, 82521.0, 11071.391073490875, 11254.099672026217, 11425.542978280942, 11555.422228888521, 11713.882861171449, 16987.830121698626, 17020.0, 17051.31794728222, 17140.571485712957, 17154.742678859828, 8620.612072456754, 8967.192952634294, 9020.278377729766, 9039.728808135635, 9075.0, 8338.124496927856, 8360.372972027122, 8397.95801020991, 8419.410641255176, 8778.473291602397, 5110.48895110486, 5137.537621614073, 5163.483651634881, 5185.792568297301, 5249.343832020997, 1870.6071724937644, 1999.2502811445709, 2078.3349328214827, 2148.2051640892655, 2152.7093842331396, 994.9104580587637, 1101.5703875488566, 1124.9043831274432, 1139.401814047615, 1201.4561288744096, 18225.81774182241, 19601.21595136207, 20291.492712682008, 20705.58588828215, 21257.468563286042, 1034.7102811212872, 1082.832161015044, 1089.629525961177, 1149.0864762513654, 1164.1792536262085, 10949.781004379867, 11444.370559619134, 11459.140564457699, 11512.827307590225, 11748.0, 517293.0, 517593.0, 520845.0, 537255.0, 546216.0, 96479.51760241154, 101100.0, 101664.0, 101728.0, 101885.0, 1141.560499207811, 1146.1174895330716, 1151.6314779270554, 1166.702490864841, 1182.3497076607832, 18208.726869097238, 18246.908765456086, 18455.169517371483, 18458.07709614487, 18741.437756867315, 41648.79175604103, 41697.1660566793, 41853.79073104615, 41866.790666047695, 43784.34323485214, 59008.40991590201, 62043.0, 62180.689096554226, 62347.6882615584, 62366.0, 8758.781030474289, 8832.470051796912, 9009.459432434074, 9148.588313526041, 9225.21585665226, 13373.598792036255, 13572.1856688599, 13875.653108672364, 14098.083624564371, 14108.2945852709, 6959.512834101564, 11521.251118677259, 11558.075353971493, 11959.641210763692, 12125.029997599995, 11213.55145794159, 11278.661640150809, 11373.374464404536, 11570.495835541662, 11635.301881886775, 9045.59294831721, 10141.884392716944, 11753.47109380097, 11995.0, 12066.457009434422, 8787.077356877437, 8852.29181665478, 8891.374386942362, 9027.864582031407, 9117.77205569866, 9048.954755226181, 11504.25222360544, 12398.070144739, 12463.688407789878, 12583.622491325275], "value": 9553.674845358308, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1436.324927284176, 1566.819815721192, 1573.1347758732695, 1777.9111044447775, 1882.5670095877947, 8361.456505327156, 8607.827843443127, 8613.095624959384, 8617.138286171388, 8626.137386261387, 8504.532250726208, 8604.268637165833, 8640.481571105722, 8658.220760131588, 8663.0, 2196.2642514757495, 2245.0346351069034, 2423.151896836111, 2444.633305004255, 2480.875956202192, 2497.300755788373, 2517.0812653381568, 2517.5216708825355, 2518.874056297187, 2519.4457219411793, 2401.4836810085826, 2481.7146028206716, 2495.800335973118, 2499.5875680512786, 2502.78726308264, 2141.0472339808794, 2400.6519054737055, 2414.37226321156, 2456.312232574882, 2460.483298507316, 2344.55453463843, 2356.1164563288767, 2371.5731168389684, 2380.262118743178, 2380.797632201265, 8569.357298202598, 8627.65489380424, 8645.178708022728, 8659.263962563127, 8664.566771661455, 5048.242763585492, 5127.948720512784, 5144.768485418128, 5149.30484384607, 5152.948470515322, 3509.4735789631504, 3581.1763294442426, 3620.2216523447323, 3633.8364773585254, 3655.25067361193, 1168.3048586091263, 1178.8054970929873, 1222.358261912494, 1251.474380760083, 1265.4811527273773, 12540.996720262267, 12566.0, 12566.497340106385, 12568.685782855411, 12604.369781510888, 4758.168105279492, 4840.830570930071, 4869.099216644932, 4884.780184891689, 4894.681845680019, 10415.16678665705, 10500.369977801203, 10510.421926794099, 10539.10417614496, 10558.155347572176, 5322.361316642027, 5331.973340133274, 5336.599755018389, 5338.119210330329, 5343.492368225013, 4183.5398106208295, 4669.906601867943, 4701.200795864643, 4757.26262429324, 4770.0, 4240.0, 4283.357496375506, 4293.2057569349145, 4408.867733967986, 4421.314696222091, 1357.3077730357588, 1387.7571425000585, 1393.533166389271, 1400.4958215042577, 1400.544822932551, 858.8791626926795, 971.1065819446127, 1042.781015986636, 1058.8782290036745, 1071.7910007548453, 5948.464638182498, 6018.15745795589, 6025.969870150621, 6173.135760993465, 6239.937600624026, 473.17431082760805, 485.5120603793236, 499.9525045120708, 502.5125628140698, 506.95944324453956, 4233.470816147981, 4236.6187043166265, 4247.957520424818, 4254.170436764863, 4257.148570285894, 10703.357798531957, 11063.391513466837, 11096.944515277371, 11164.888351116548, 11176.105911527058, 10946.890531094747, 10955.452227388758, 10982.341059536293, 10985.450727463594, 10989.505472253608, 7928.246816552418, 8141.348692104618, 8347.707830225912, 8387.874181887277, 8392.664293428317, 5873.177755114202, 5997.760089596542, 6004.819855404345, 6025.758969641165, 6057.697115144313, 9157.633694652406, 9574.617015319309, 9585.329026968046, 9608.567614457506, 9832.213422926292, 9786.363886347364, 9991.550380233053, 10012.39925604437, 10135.7466063349, 10161.593536258466, 6882.931170688429, 7173.892391614026, 7217.855642887008, 7378.778636640909, 7392.297731715478, 8205.466644668077, 8218.096009439076, 8231.42380033392, 8268.958655206685, 8277.130901255523, 7443.702251909863, 7641.503302285334, 7656.80857978555, 7686.07767067933, 7795.961020194863, 7517.173110957681, 7532.623368831646, 7574.469787115069, 7661.233876612294, 7700.422468314787, 7043.647817608997, 7060.152781666233, 7071.9292807073325, 7083.5041547091205, 7102.573845569283, 5116.9744151279, 5243.187305967581, 5341.893162136657, 5421.430749771375, 5425.13197888336, 4904.607631389552, 5004.3494345734825, 5016.021875734197, 5019.297298378303, 5070.138076526926], "value": 4624.311241964863, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.4302010373868, 368.8248082160974, 370.2724147051046, 372.0791042170628, 378.39079082676886, 6239.7816076437275, 6254.374562543743, 6267.937320626792, 6273.466755325797, 6313.684315784204, 6042.667653279068, 6270.216222972129, 6278.68606569672, 6282.748690052393, 6284.434400903918, 4762.166620841347, 4807.495213002637, 4811.158047341702, 4828.937633720576, 4848.854534363974, 4809.1343558159515, 4824.517548245165, 4828.806847726104, 4842.539958703936, 4852.539008794159, 4615.307703844416, 4719.528047195287, 4789.760511974388, 4798.328234047236, 4808.302796094564, 4717.410323709536, 4735.905281894343, 4742.549457801503, 4748.169070412664, 4759.785809638557, 4239.194553034913, 4272.46594175728, 4286.39990401344, 4290.785460726983, 4292.12011537634, 6086.786962456337, 6095.055266433666, 6101.0848372744, 6101.176341193926, 6110.633361998294, 5678.545716342683, 5682.147677848315, 5692.288463942007, 5692.743826527816, 5695.202671625976, 6522.608643481406, 6640.601563906181, 6676.899846502306, 6685.030670552791, 6694.93305066948, 4751.429828420577, 4770.499097594738, 4770.856874293777, 4784.425868895755, 4785.569298763128, 7000.474964377692, 7001.894971575431, 7002.579845209253, 7005.579665220103, 7015.89476157858, 4883.780229889663, 4887.315775791392, 4891.461939186686, 4894.412670479494, 4896.3389942358035, 4955.207166853286, 4956.405231372259, 4956.430010548761, 4964.0, 4964.578010869044, 5525.0, 5660.95272374612, 5663.584103974006, 5668.659880407189, 5676.205331253628, 6755.425788807908, 6758.391744742997, 6778.118844550276, 6800.387965083068, 6809.114815074107, 1735.7569940208382, 1761.9823801761818, 1764.9029303388436, 1768.6904791661407, 1770.9993853472747, 1102.729831191347, 1177.4466000979696, 1196.252342286071, 1203.518592562982, 1203.807390817465, 6377.23473183221, 6403.551751377358, 6406.519511036691, 6425.550211485244, 6433.453156481752, 6842.965785171043, 6843.247242803288, 6845.520813543004, 6847.075644787989, 6852.6231057292325, 6395.6482393468805, 6412.807615771534, 6413.839654008594, 6414.839629009312, 6419.967900160469, 3654.232611151635, 3672.1003354178397, 3682.723795715332, 3696.4085746280466, 3702.333579955634, 7191.3887319578425, 7209.170945341248, 7242.23956484572, 7290.4167666586545, 7329.0, 7210.819729506699, 7215.927840721525, 7219.241979592067, 7221.277872212737, 7222.927770722225, 7219.0, 7292.635368231568, 7306.196318404971, 7312.415006799443, 7320.304571065741, 6896.655167241718, 7020.7893763187185, 7020.824479388056, 7033.366996970297, 7041.049458323266, 6895.620740859301, 6902.206246281541, 6918.411934985583, 6921.377076063179, 6928.099347085048, 7259.6007219603425, 7271.781846544613, 7273.745418910313, 7282.854342913218, 7290.380317673057, 4749.572538471554, 4776.713397196179, 4779.426468823764, 4794.352762377174, 4800.687955282895, 6850.0752398425575, 6986.231514533296, 6991.8951215730785, 6996.950457431426, 7006.894896576454, 6837.760678376233, 6840.110785597841, 6841.589504629738, 6843.897341539781, 6844.247132815287, 6745.3591908768585, 6778.4916131289365, 6790.932090679227, 6804.319568043156, 6824.7952561423235, 6668.099806526056, 6671.099401580918, 6687.164104486939, 6694.096296999843, 6698.832529186614, 6721.663916804238, 6801.761938332134, 6839.0, 6850.0752398425575, 6862.210845752603, 6434.517411194272, 6540.117084193763, 6672.366125218096, 6685.53201275906, 6707.966460167668], "value": 5107.111096169574, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [773.7310810271155, 786.5420560747664, 797.2067792546417, 804.6700852650418, 807.5033854179678, 14885.181315027668, 15076.547703568896, 15192.772108418383, 15193.088414695127, 15268.236588170588, 14484.710305793878, 14551.126932384064, 14559.927200363984, 14568.271586420664, 14569.854301456982, 756.7427074794568, 869.4609342207824, 872.8254349130168, 881.6429346114834, 885.9424137431047, 895.2211575928951, 897.4884315939917, 899.5727029660924, 899.8785164002842, 900.2213085680904, 932.7108596335158, 938.0291398402654, 938.6761567259284, 940.4498368454463, 940.8447606145012, 779.5478622398995, 902.1114202510522, 926.1433174313732, 932.6828878181417, 933.5752232734089, 678.6165816313817, 680.1566058087985, 680.496432639843, 681.2574294019543, 682.494953734238, 14682.339294731762, 14690.4858329959, 14694.265286735726, 14706.70586588273, 14738.0420272683, 13944.372503237379, 14055.859441405557, 14303.356348964322, 14365.0, 14421.855781442262, 11463.197576169672, 11838.112141589416, 12053.276803391824, 12285.324307163102, 12383.442745076492, 4678.883027924295, 4691.601213896823, 4706.035262771124, 4711.104890070876, 4752.667313288071, 60107.0, 60367.0, 60502.69748651273, 60516.39483605196, 60517.39482605162, 10640.414777187174, 10928.235023548434, 11111.277766945122, 11118.888811111947, 11387.08903287735, 20959.895200524206, 20984.580308393746, 21013.579728405348, 21128.0, 21149.577008459746, 8565.657373705106, 8672.0, 8861.867071993925, 8928.68749593774, 9056.547172641342, 4864.36763220779, 4908.631852610997, 4935.333729946411, 5040.697558146523, 5117.02776472469, 3739.9252014959548, 3741.6819570336284, 3793.1655035892613, 3795.7342985990717, 3804.9429258561145, 672.3746915368754, 675.7128220506265, 722.7687140115113, 728.3481284250672, 733.5305404541098, 787.252110495032, 814.5682788122305, 832.4755404095381, 841.3647695989489, 842.3345557010016, 9234.215091717278, 9768.072033156981, 9846.950765246127, 9890.20878329732, 9960.053794889474, 754.2344520311888, 783.0907830907786, 783.6081959020489, 802.967881284742, 803.8344400619126, 4382.145481631115, 4447.955520444819, 4517.322401639781, 4584.9541504585195, 4631.235846085358, 67148.3285167142, 67354.0, 67891.32108678948, 67917.66041169762, 68217.31782682109, 54843.45156548463, 58793.11810322849, 59541.0, 59790.40209597848, 59899.70050149722, 50877.745611271705, 52247.0, 53050.73474632602, 53208.0, 53245.733771330895, 9028.729138125867, 9068.365214434927, 9212.124848139416, 9226.492542910204, 9286.396384235004, 40200.798996004836, 40284.59715402926, 40545.797271013456, 40909.0, 41027.1794564113, 47194.76402617965, 47328.05343893172, 48571.0, 48662.27006594833, 48717.26924096212, 12358.62924112278, 12442.0, 12735.363231838557, 12875.562040318136, 13031.804522931974, 13255.536056237985, 13519.459221631025, 13799.931000344934, 13935.30323483842, 15454.150021748912, 12703.047271454492, 13586.592402227949, 13655.180689158682, 13792.586222413343, 13915.791263131263, 13297.66755831112, 13394.062415630813, 13593.453120091088, 13639.863601364257, 13963.511277105252, 12598.433070512032, 12732.427040783372, 12823.93588032054, 12863.0, 13300.135491193041, 11246.212765106364, 11277.436128193722, 11384.48769805344, 11625.302481851117, 11650.53397864076, 11282.789075886336, 11455.484503197209, 11523.827142593036, 11846.881531184577, 11847.703807404883], "value": 7237.622799523093, "unit": "score"}], "name": "dromaeo_css", "value": 7523.139812843995, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 110.0, 110.0, 109.0, 110.0, 113.0, 104.0, 110.0, 109.0, 109.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 126.0, 152.0, 178.0, 131.0, 157.0, 164.0, 128.0, 203.0, 134.0], "value": 152.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 165.0, 162.0, 162.0, 160.0, 161.0, 162.0, 160.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 77.0, 189.0, 77.0, 77.0, 77.0, 86.0, 169.0, 73.0], "value": 97.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 154.0, 93.0, 93.0, 93.0, 153.0, 92.0, 92.0, 147.0], "value": 110.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 97.0, 95.0, 95.0, 94.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 54.0, 54.0, 54.0, 56.0, 56.0, 74.0, 53.0, 52.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 58.0, 58.0, 58.0, 58.0, 58.0, 58.0, 59.0], "value": 58.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 72.0, 74.0, 73.0, 74.0, 74.0, 74.0, 81.0, 73.0], "value": 74.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 114.0, 112.0, 114.0, 120.0, 115.0, 163.0, 126.0], "value": 120.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 161.0, 165.0, 158.0, 158.0, 167.0, 160.0, 159.0, 156.0, 169.0], "value": 161.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 69.0, 68.0, 66.0, 66.0, 69.0, 66.0, 67.0, 65.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1525.6000000000001, "alertThreshold": 2.0}]} 11:12:21 INFO - Return code: 0 11:12:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:12:21 ERROR - # TBPL SUCCESS # 11:12:21 INFO - Running post-action listener: _resource_record_post_action 11:12:21 INFO - Running post-run listener: _resource_record_post_run 11:12:22 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 274432; Write bytes: 488976384; Read time: 260; Write time: 402088 11:12:22 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 248655872; Read time: 32; Write time: 235740 11:12:22 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 270336; Write bytes: 240320512; Read time: 228; Write time: 166348 11:12:22 INFO - Running post-run listener: _upload_blobber_files 11:12:22 INFO - Blob upload gear active. 11:12:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:12:22 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 11:12:22 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:12:22 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:12:22 INFO - (blobuploader) - INFO - Open directory for files ... 11:12:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:12:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:12:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:12:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:12:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:12:23 INFO - (blobuploader) - INFO - Done attempting. 11:12:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:12:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:12:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:12:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:12:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:12:24 INFO - (blobuploader) - INFO - Done attempting. 11:12:24 INFO - (blobuploader) - INFO - Iteration through files over. 11:12:24 INFO - Return code: 0 11:12:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:12:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:12:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bb6bb261c557e31416927934362862d0da9f737c7e1e14669639df638f2cd80e544bd817ada207c2ecfd44783b8b66154fa16a42a8805e5f9de22ef0d53ca630", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3769f3d3334dbe70c5319bd03eec47b94852dda6b63841be9e83f90e2b79418515c86f0cc30b586262db1698a84a17a438a7be1ba50b8c637a2321738eba23c4"} 11:12:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:12:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:12:24 INFO - Contents: 11:12:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bb6bb261c557e31416927934362862d0da9f737c7e1e14669639df638f2cd80e544bd817ada207c2ecfd44783b8b66154fa16a42a8805e5f9de22ef0d53ca630", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3769f3d3334dbe70c5319bd03eec47b94852dda6b63841be9e83f90e2b79418515c86f0cc30b586262db1698a84a17a438a7be1ba50b8c637a2321738eba23c4"} 11:12:24 INFO - Running post-run listener: copy_logs_to_upload_dir 11:12:24 INFO - Copying logs to upload dir... 11:12:24 INFO - mkdir: /builds/slave/test/build/upload/logs 11:12:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.793705 ========= master_lag: 2.12 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-05-17 11:12:25.911011) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 11:12:25.918157) ========= 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=20e666a3d4cfbb71505a330e000001b4-1463506662.305083-604910210 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-Aurora/sha512/bb6bb261c557e31416927934362862d0da9f737c7e1e14669639df638f2cd80e544bd817ada207c2ecfd44783b8b66154fa16a42a8805e5f9de22ef0d53ca630", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3769f3d3334dbe70c5319bd03eec47b94852dda6b63841be9e83f90e2b79418515c86f0cc30b586262db1698a84a17a438a7be1ba50b8c637a2321738eba23c4"} build_url:https://queue.taskcluster.net/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010154 build_url: 'https://queue.taskcluster.net/v1/task/A695xu61QTWpu79ZWgbJBA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bb6bb261c557e31416927934362862d0da9f737c7e1e14669639df638f2cd80e544bd817ada207c2ecfd44783b8b66154fa16a42a8805e5f9de22ef0d53ca630", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3769f3d3334dbe70c5319bd03eec47b94852dda6b63841be9e83f90e2b79418515c86f0cc30b586262db1698a84a17a438a7be1ba50b8c637a2321738eba23c4"}' ========= master_lag: 0.46 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 11:12:26.383571) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-05-17 11:12:26.383995) ========= 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=20e666a3d4cfbb71505a330e000001b4-1463506662.305083-604910210 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004563 ========= master_lag: 1.83 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-05-17 11:12:28.217354) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 11:12:28.217660) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 11:12:28.382699) ========= ========= Total master_lag: 4.48 =========