builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-051 starttime: 1461416054.0 results: success (0) buildid: 20160423030220 builduid: 2457a9127ed446a2b9165a59ccaf8d25 revision: 37f04460ddb76d6ef4e7c32a8a6b2fbc44cb8776 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-23 05:54:13.998811) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-23 05:54:13.999226) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-23 05:54:13.999790) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-23 05:54:14.016386) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 05:54:14.016673) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1461411049.682967-641148017 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-23 05:54:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.8M=0s 2016-04-23 05:54:14 (42.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120262 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 05:54:14.150585) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 05:54:14.151045) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1461411049.682967-641148017 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017818 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 05:54:14.200222) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 05:54:14.200537) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 37f04460ddb76d6ef4e7c32a8a6b2fbc44cb8776 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 37f04460ddb76d6ef4e7c32a8a6b2fbc44cb8776 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1461411049.682967-641148017 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-23 05:54:14,419 truncating revision to first 12 chars 2016-04-23 05:54:14,419 Setting DEBUG logging. 2016-04-23 05:54:14,419 attempt 1/10 2016-04-23 05:54:14,419 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/37f04460ddb7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-23 05:54:14,715 unpacking tar archive at: mozilla-central-37f04460ddb7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.588690 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 05:54:14.802157) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-23 05:54:14.802599) ========= script_repo_revision: 37f04460ddb76d6ef4e7c32a8a6b2fbc44cb8776 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-23 05:54:14.803033) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-23 05:54:14.803313) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-23 05:54:14.815196) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-04-23 05:54:14.815473) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1461411049.682967-641148017 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:54:15 INFO - MultiFileLogger online at 20160423 05:54:15 in /builds/slave/test 05:54:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:54:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:54:15 INFO - {'append_to_log': False, 05:54:15 INFO - 'base_work_dir': '/builds/slave/test', 05:54:15 INFO - 'blob_upload_branch': 'Firefox', 05:54:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:54:15 INFO - 'branch': 'Firefox', 05:54:15 INFO - 'buildbot_json_path': 'buildprops.json', 05:54:15 INFO - 'config_files': ('talos/linux_config.py',), 05:54:15 INFO - 'default_actions': ('clobber', 05:54:15 INFO - 'read-buildbot-config', 05:54:15 INFO - 'download-and-extract', 05:54:15 INFO - 'populate-webroot', 05:54:15 INFO - 'create-virtualenv', 05:54:15 INFO - 'install', 05:54:15 INFO - 'run-tests'), 05:54:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:54:15 INFO - 'download_minidump_stackwalk': True, 05:54:15 INFO - 'download_symbols': 'ondemand', 05:54:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:54:15 INFO - 'tooltool.py': '/tools/tooltool.py', 05:54:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:54:15 INFO - '/tools/misc-python/virtualenv.py')}, 05:54:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:54:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:54:15 INFO - 'installer_path': 'installer.exe', 05:54:15 INFO - 'log_level': 'info', 05:54:15 INFO - 'log_name': 'talos', 05:54:15 INFO - 'log_to_console': True, 05:54:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:54:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:54:15 INFO - 'opt_config_files': (), 05:54:15 INFO - 'pip_index': False, 05:54:15 INFO - 'sps_profile': False, 05:54:15 INFO - 'sps_profile_interval': 0, 05:54:15 INFO - 'suite': 'dromaeojs', 05:54:15 INFO - 'system_bits': '32', 05:54:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:54:15 INFO - 'title': 'talos-linux64-ix-051', 05:54:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:54:15 INFO - 'use_talos_json': True, 05:54:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:54:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:54:15 INFO - 'work_dir': 'build'} 05:54:15 INFO - ##### 05:54:15 INFO - ##### Running clobber step. 05:54:15 INFO - ##### 05:54:15 INFO - Running pre-action listener: _resource_record_pre_action 05:54:15 INFO - Running main action method: clobber 05:54:15 INFO - rmtree: /builds/slave/test/build 05:54:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:54:16 INFO - Running post-action listener: _resource_record_post_action 05:54:16 INFO - ##### 05:54:16 INFO - ##### Running read-buildbot-config step. 05:54:16 INFO - ##### 05:54:16 INFO - Running pre-action listener: _resource_record_pre_action 05:54:16 INFO - Running main action method: read_buildbot_config 05:54:16 INFO - Using buildbot properties: 05:54:16 INFO - { 05:54:16 INFO - "project": "", 05:54:16 INFO - "product": "firefox", 05:54:16 INFO - "script_repo_revision": "production", 05:54:16 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:54:16 INFO - "repository": "", 05:54:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:54:16 INFO - "buildid": "20160423030220", 05:54:16 INFO - "stage_platform": "linux64-pgo", 05:54:16 INFO - "basedir": "/builds/slave/test", 05:54:16 INFO - "nightly_build": "True", 05:54:16 INFO - "buildnumber": 751, 05:54:16 INFO - "slavename": "talos-linux64-ix-051", 05:54:16 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:54:16 INFO - "platform": "ubuntu64_hw", 05:54:16 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:54:16 INFO - "branch": "mozilla-central", 05:54:16 INFO - "repo_path": "mozilla-central", 05:54:16 INFO - "revision": "37f04460ddb76d6ef4e7c32a8a6b2fbc44cb8776", 05:54:16 INFO - "pgo_build": "True", 05:54:16 INFO - "builduid": "2457a9127ed446a2b9165a59ccaf8d25", 05:54:16 INFO - "slavebuilddir": "test" 05:54:16 INFO - } 05:54:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 05:54:16 INFO - Running post-action listener: _resource_record_post_action 05:54:16 INFO - ##### 05:54:16 INFO - ##### Running download-and-extract step. 05:54:16 INFO - ##### 05:54:16 INFO - Running pre-action listener: _resource_record_pre_action 05:54:16 INFO - Running main action method: download_and_extract 05:54:16 INFO - mkdir: /builds/slave/test/build/tests 05:54: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')]} 05:54:16 INFO - https://queue.taskcluster.net/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:54:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:54:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:54:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:54:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:54:29 INFO - Downloaded 1361 bytes. 05:54:29 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:54:29 INFO - Using the following test package requirements: 05:54:29 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:54:29 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:54:29 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:54:29 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:29 INFO - u'jsshell-linux-x86_64.zip'], 05:54:29 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:54:29 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:54:29 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:54:29 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:54:29 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:54:29 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:54:29 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:54: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')]} 05:54:29 INFO - https://queue.taskcluster.net/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:54:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:54:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:54:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:54:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:54:40 INFO - Downloaded 23858027 bytes. 05:54:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:54:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:54:42 INFO - Return code: 0 05:54:42 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:54:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:42 INFO - https://queue.taskcluster.net/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:54:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:54:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:54:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:54:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:54:43 INFO - Downloaded 23858027 bytes. 05:54:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:54:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:54:44 INFO - Return code: 0 05:54:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:44 INFO - https://queue.taskcluster.net/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:54:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:54:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:54:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:54:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:54:45 INFO - Downloaded 10840145 bytes. 05:54:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:54:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:54:45 INFO - Return code: 0 05:54:45 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')]} 05:54:45 INFO - https://queue.taskcluster.net/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:54:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:54:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:54:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:54:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:54:47 INFO - Downloaded 58376013 bytes. 05:54:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:54:47 INFO - mkdir: /builds/slave/test/properties 05:54:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:54:47 INFO - Writing to file /builds/slave/test/properties/build_url 05:54:47 INFO - Contents: 05:54:47 INFO - build_url:https://queue.taskcluster.net/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:54:48 INFO - Running post-action listener: _resource_record_post_action 05:54:48 INFO - Running post-action listener: set_extra_try_arguments 05:54:48 INFO - ##### 05:54:48 INFO - ##### Running populate-webroot step. 05:54:48 INFO - ##### 05:54:48 INFO - Running pre-action listener: _resource_record_pre_action 05:54:48 INFO - Running main action method: populate_webroot 05:54:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:54:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:54:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:54:48 INFO - '--tppagecycles', 05:54:48 INFO - '7'], 05:54:48 INFO - 'tests': ['tsvgm']}}, 05:54:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:54:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:54:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:54:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:54:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:54:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:54:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:48 INFO - 'talos_options': ['--disable-e10s'], 05:54:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:54:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:54:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:48 INFO - 'talos_options': ['--disable-e10s'], 05:54:48 INFO - 'tests': ['damp', 'tps']}, 05:54:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:48 INFO - 'tests': ['damp', 'tps']}, 05:54:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:54:48 INFO - 'tests': ['dromaeo_dom']}, 05:54:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:54:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:54:48 INFO - 'tests': ['a11yr', 05:54:48 INFO - 'ts_paint', 05:54:48 INFO - 'tpaint', 05:54:48 INFO - 'sessionrestore', 05:54:48 INFO - 'sessionrestore_no_auto_restore', 05:54:48 INFO - 'tabpaint']}, 05:54:48 INFO - 'other-e10s': {'tests': ['a11yr', 05:54:48 INFO - 'ts_paint', 05:54:48 INFO - 'tpaint', 05:54:48 INFO - 'sessionrestore', 05:54:48 INFO - 'sessionrestore_no_auto_restore', 05:54:48 INFO - 'tabpaint']}, 05:54:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:54:48 INFO - 'ts_paint', 05:54:48 INFO - 'tpaint', 05:54:48 INFO - 'sessionrestore', 05:54:48 INFO - 'sessionrestore_no_auto_restore', 05:54:48 INFO - 'tabpaint']}, 05:54:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:54:48 INFO - 'ts_paint', 05:54:48 INFO - 'tpaint', 05:54:48 INFO - 'sessionrestore', 05:54:48 INFO - 'sessionrestore_no_auto_restore', 05:54:48 INFO - 'tabpaint']}, 05:54:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:54:48 INFO - 'tests': ['a11yr', 05:54:48 INFO - 'ts_paint', 05:54:48 INFO - 'tpaint', 05:54:48 INFO - 'sessionrestore', 05:54:48 INFO - 'sessionrestore_no_auto_restore', 05:54:48 INFO - 'tabpaint']}, 05:54:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:54:48 INFO - 'tests': ['a11yr', 05:54:48 INFO - 'ts_paint', 05:54:48 INFO - 'tpaint', 05:54:48 INFO - 'sessionrestore', 05:54:48 INFO - 'sessionrestore_no_auto_restore', 05:54:48 INFO - 'tabpaint']}, 05:54:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:54:48 INFO - 'tests': ['tsvgx', 05:54:48 INFO - 'tsvgr_opacity', 05:54:48 INFO - 'tart', 05:54:48 INFO - 'tscrollx', 05:54:48 INFO - 'cart']}, 05:54:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:54:48 INFO - 'tsvgr_opacity', 05:54:48 INFO - 'tart', 05:54:48 INFO - 'tscrollx', 05:54:48 INFO - 'cart']}, 05:54:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:48 INFO - 'talos_options': ['--disable-e10s'], 05:54:48 INFO - 'tests': ['tp5o']}, 05:54:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:48 INFO - 'tests': ['tp5o']}, 05:54:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:48 INFO - 'talos_options': ['--disable-e10s', 05:54:48 INFO - '--xperf_path', 05:54:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:54:48 INFO - 'tests': ['tp5n']}, 05:54:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:48 INFO - 'talos_options': ['--xperf_path', 05:54:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:54:48 INFO - 'tests': ['tp5n']}}, 05:54:48 INFO - 'talos.zip': {'path': '', 05:54:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:54:48 INFO - Running post-action listener: _resource_record_post_action 05:54:48 INFO - ##### 05:54:48 INFO - ##### Running create-virtualenv step. 05:54:48 INFO - ##### 05:54:48 INFO - Running pre-action listener: _resource_record_pre_action 05:54:48 INFO - Running main action method: create_virtualenv 05:54:48 INFO - Creating virtualenv /builds/slave/test/build/venv 05:54:48 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 05:54:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:54:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:54:48 INFO - Using real prefix '/usr' 05:54:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:54:49 INFO - Installing distribute.............................................................................................................................................................................................done. 05:54:51 INFO - Installing pip.................done. 05:54:51 INFO - Return code: 0 05:54:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:54:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f07fe7bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d729a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e01810>, '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 0x1e02710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e02ba0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461411049.682967-641148017', '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 05:54:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:54:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:54:51 INFO - Using env: {'DISPLAY': ':0', 05:54:51 INFO - 'HOME': '/home/cltbld', 05:54:51 INFO - 'LANG': 'en_US.UTF-8', 05:54:51 INFO - 'LANGUAGE': 'en_US:en', 05:54:51 INFO - 'LOGNAME': 'cltbld', 05:54:51 INFO - 'MAIL': '/var/mail/cltbld', 05:54:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:51 INFO - 'MOZ_NO_REMOTE': '1', 05:54:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:51 INFO - 'NO_EM_RESTART': '1', 05:54:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:51 INFO - 'PWD': '/builds/slave/test', 05:54:51 INFO - 'SHELL': '/bin/bash', 05:54:51 INFO - 'SHLVL': '1', 05:54:51 INFO - 'TERM': 'linux', 05:54:51 INFO - 'TMOUT': '86400', 05:54:51 INFO - 'USER': 'cltbld', 05:54:51 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461411049.682967-641148017', 05:54:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:51 INFO - '_': '/tools/buildbot/bin/python'} 05:54:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:51 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 05:54:51 INFO - Cleaning up... 05:54:51 INFO - Return code: 0 05:54:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:54:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f07fe7bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d729a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e01810>, '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 0x1e02710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e02ba0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461411049.682967-641148017', '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 05:54:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:54:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:54:51 INFO - Using env: {'DISPLAY': ':0', 05:54:51 INFO - 'HOME': '/home/cltbld', 05:54:51 INFO - 'LANG': 'en_US.UTF-8', 05:54:51 INFO - 'LANGUAGE': 'en_US:en', 05:54:51 INFO - 'LOGNAME': 'cltbld', 05:54:51 INFO - 'MAIL': '/var/mail/cltbld', 05:54:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:51 INFO - 'MOZ_NO_REMOTE': '1', 05:54:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:51 INFO - 'NO_EM_RESTART': '1', 05:54:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:51 INFO - 'PWD': '/builds/slave/test', 05:54:51 INFO - 'SHELL': '/bin/bash', 05:54:51 INFO - 'SHLVL': '1', 05:54:51 INFO - 'TERM': 'linux', 05:54:51 INFO - 'TMOUT': '86400', 05:54:51 INFO - 'USER': 'cltbld', 05:54:51 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461411049.682967-641148017', 05:54:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:51 INFO - '_': '/tools/buildbot/bin/python'} 05:54:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:51 INFO - Downloading/unpacking psutil>=0.7.1 05:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:54:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:54:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:54:53 INFO - Installing collected packages: psutil 05:54:53 INFO - Running setup.py install for psutil 05:54:53 INFO - building 'psutil._psutil_linux' extension 05:54:53 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 05:54:53 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 05:54:53 INFO - building 'psutil._psutil_posix' extension 05:54:53 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 05:54:53 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 05:54:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:54:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:54:54 INFO - Successfully installed psutil 05:54:54 INFO - Cleaning up... 05:54:54 INFO - Return code: 0 05:54:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:54:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:54 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 0x7f07fe7bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d729a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e01810>, '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 0x1e02710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e02ba0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461411049.682967-641148017', '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 05:54:54 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 05:54:54 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 05:54:54 INFO - Using env: {'DISPLAY': ':0', 05:54:54 INFO - 'HOME': '/home/cltbld', 05:54:54 INFO - 'LANG': 'en_US.UTF-8', 05:54:54 INFO - 'LANGUAGE': 'en_US:en', 05:54:54 INFO - 'LOGNAME': 'cltbld', 05:54:54 INFO - 'MAIL': '/var/mail/cltbld', 05:54:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:54 INFO - 'MOZ_NO_REMOTE': '1', 05:54:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:54 INFO - 'NO_EM_RESTART': '1', 05:54:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:54 INFO - 'PWD': '/builds/slave/test', 05:54:54 INFO - 'SHELL': '/bin/bash', 05:54:54 INFO - 'SHLVL': '1', 05:54:54 INFO - 'TERM': 'linux', 05:54:54 INFO - 'TMOUT': '86400', 05:54:54 INFO - 'USER': 'cltbld', 05:54:54 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461411049.682967-641148017', 05:54:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:54 INFO - '_': '/tools/buildbot/bin/python'} 05:54:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:54:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:54:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:54:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:54:56 INFO - Installing collected packages: mozsystemmonitor 05:54:56 INFO - Running setup.py install for mozsystemmonitor 05:54:56 INFO - Successfully installed mozsystemmonitor 05:54:56 INFO - Cleaning up... 05:54:56 INFO - Return code: 0 05:54:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:54:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:56 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 0x7f07fe7bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d729a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e01810>, '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 0x1e02710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e02ba0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461411049.682967-641148017', '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 05:54:56 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 05:54:56 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 05:54:56 INFO - Using env: {'DISPLAY': ':0', 05:54:56 INFO - 'HOME': '/home/cltbld', 05:54:56 INFO - 'LANG': 'en_US.UTF-8', 05:54:56 INFO - 'LANGUAGE': 'en_US:en', 05:54:56 INFO - 'LOGNAME': 'cltbld', 05:54:56 INFO - 'MAIL': '/var/mail/cltbld', 05:54:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:56 INFO - 'MOZ_NO_REMOTE': '1', 05:54:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:56 INFO - 'NO_EM_RESTART': '1', 05:54:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:56 INFO - 'PWD': '/builds/slave/test', 05:54:56 INFO - 'SHELL': '/bin/bash', 05:54:56 INFO - 'SHLVL': '1', 05:54:56 INFO - 'TERM': 'linux', 05:54:56 INFO - 'TMOUT': '86400', 05:54:56 INFO - 'USER': 'cltbld', 05:54:56 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461411049.682967-641148017', 05:54:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:56 INFO - '_': '/tools/buildbot/bin/python'} 05:54:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:56 INFO - Downloading/unpacking blobuploader==1.2.4 05:54:56 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 05:54:56 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 05:54:56 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 05:54:56 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 05:54:56 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 05:54:56 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 05:54:58 INFO - Downloading blobuploader-1.2.4.tar.gz 05:54:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:54:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:54:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:59 INFO - Downloading docopt-0.6.1.tar.gz 05:54:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:54:59 INFO - Installing collected packages: blobuploader, requests, docopt 05:54:59 INFO - Running setup.py install for blobuploader 05:54:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:54:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:54:59 INFO - Running setup.py install for requests 05:54:59 INFO - Running setup.py install for docopt 05:54:59 INFO - Successfully installed blobuploader requests docopt 05:54:59 INFO - Cleaning up... 05:54:59 INFO - Return code: 0 05:54:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:54:59 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')]} 05:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:59 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')]} 05:54:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:59 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 0x7f07fe7bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d729a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e01810>, '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 0x1e02710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e02ba0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461411049.682967-641148017', '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 05:54:59 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 05:54:59 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 05:54:59 INFO - Using env: {'DISPLAY': ':0', 05:54:59 INFO - 'HOME': '/home/cltbld', 05:54:59 INFO - 'LANG': 'en_US.UTF-8', 05:54:59 INFO - 'LANGUAGE': 'en_US:en', 05:54:59 INFO - 'LOGNAME': 'cltbld', 05:54:59 INFO - 'MAIL': '/var/mail/cltbld', 05:54:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:59 INFO - 'MOZ_NO_REMOTE': '1', 05:54:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:59 INFO - 'NO_EM_RESTART': '1', 05:54:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:59 INFO - 'PWD': '/builds/slave/test', 05:54:59 INFO - 'SHELL': '/bin/bash', 05:54:59 INFO - 'SHLVL': '1', 05:54:59 INFO - 'TERM': 'linux', 05:54:59 INFO - 'TMOUT': '86400', 05:54:59 INFO - 'USER': 'cltbld', 05:54:59 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461411049.682967-641148017', 05:54:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:59 INFO - '_': '/tools/buildbot/bin/python'} 05:55:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:55:00 INFO - Running setup.py (path:/tmp/pip-0NYhhY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:55:00 INFO - Running setup.py (path:/tmp/pip-qBXtAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:55:00 INFO - Running setup.py (path:/tmp/pip-pSSGc_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:55:00 INFO - Running setup.py (path:/tmp/pip-CCXsVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:55:00 INFO - Running setup.py (path:/tmp/pip-yVv7lu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:55:00 INFO - Running setup.py (path:/tmp/pip-OddXob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:55:00 INFO - Running setup.py (path:/tmp/pip-GKFVH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:55:00 INFO - Running setup.py (path:/tmp/pip-flYEGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:55:00 INFO - Running setup.py (path:/tmp/pip-_x6HUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:55:00 INFO - Running setup.py (path:/tmp/pip-1m1Ghs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:55:00 INFO - Running setup.py (path:/tmp/pip-JPmxlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:55:00 INFO - Running setup.py (path:/tmp/pip-QFta9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:55:00 INFO - Running setup.py (path:/tmp/pip-t6756J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:55:01 INFO - Running setup.py (path:/tmp/pip-ULGFTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:55:01 INFO - Running setup.py (path:/tmp/pip-HOkHHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:55:01 INFO - Running setup.py (path:/tmp/pip-oK566q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:55:01 INFO - Running setup.py (path:/tmp/pip-B_Pt3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:55:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:55:01 INFO - Running setup.py install for manifestparser 05:55:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:55:01 INFO - Running setup.py install for mozcrash 05:55:01 INFO - Running setup.py install for mozdebug 05:55:01 INFO - Running setup.py install for mozdevice 05:55:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:55:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:55:01 INFO - Running setup.py install for mozfile 05:55:01 INFO - Running setup.py install for mozhttpd 05:55:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:55:01 INFO - Running setup.py install for mozinfo 05:55:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:55:02 INFO - Running setup.py install for mozInstall 05:55:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:55:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:55:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:55:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:55:02 INFO - Running setup.py install for mozleak 05:55:02 INFO - Running setup.py install for mozlog 05:55:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:55:02 INFO - Running setup.py install for moznetwork 05:55:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:55:02 INFO - Running setup.py install for mozprocess 05:55:02 INFO - Running setup.py install for mozprofile 05:55:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:55:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:55:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:55:02 INFO - Running setup.py install for mozrunner 05:55:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:55:02 INFO - Running setup.py install for mozscreenshot 05:55:02 INFO - Running setup.py install for moztest 05:55:03 INFO - Running setup.py install for mozversion 05:55:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:55:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:55:03 INFO - Cleaning up... 05:55:03 INFO - Return code: 0 05:55:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:55:03 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')]} 05:55:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:03 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')]} 05:55:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:03 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 0x7f07fe7bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d729a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e01810>, '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 0x1e02710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e02ba0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461411049.682967-641148017', '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 05:55:03 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 05:55:03 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 05:55:03 INFO - Using env: {'DISPLAY': ':0', 05:55:03 INFO - 'HOME': '/home/cltbld', 05:55:03 INFO - 'LANG': 'en_US.UTF-8', 05:55:03 INFO - 'LANGUAGE': 'en_US:en', 05:55:03 INFO - 'LOGNAME': 'cltbld', 05:55:03 INFO - 'MAIL': '/var/mail/cltbld', 05:55:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:03 INFO - 'MOZ_NO_REMOTE': '1', 05:55:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:03 INFO - 'NO_EM_RESTART': '1', 05:55:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:03 INFO - 'PWD': '/builds/slave/test', 05:55:03 INFO - 'SHELL': '/bin/bash', 05:55:03 INFO - 'SHLVL': '1', 05:55:03 INFO - 'TERM': 'linux', 05:55:03 INFO - 'TMOUT': '86400', 05:55:03 INFO - 'USER': 'cltbld', 05:55:03 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461411049.682967-641148017', 05:55:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:03 INFO - '_': '/tools/buildbot/bin/python'} 05:55:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:55:03 INFO - Running setup.py (path:/tmp/pip-yayWTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:55:03 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)) 05:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:55:03 INFO - Running setup.py (path:/tmp/pip-QrQUo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:55:03 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)) 05:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:55:03 INFO - Running setup.py (path:/tmp/pip-IJmOEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:55:03 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)) 05:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:55:03 INFO - Running setup.py (path:/tmp/pip-73OQoL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:55:03 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)) 05:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:55:03 INFO - Running setup.py (path:/tmp/pip-0R8ozM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:55:03 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)) 05:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:55:03 INFO - Running setup.py (path:/tmp/pip-r1SjIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:55:03 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)) 05:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:55:03 INFO - Running setup.py (path:/tmp/pip-1q6Bfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:55:03 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)) 05:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:55:03 INFO - Running setup.py (path:/tmp/pip-oQsiia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:55:03 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)) 05:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:55:03 INFO - Running setup.py (path:/tmp/pip-hdXK64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:55:03 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)) 05:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:55:04 INFO - Running setup.py (path:/tmp/pip-B3TygI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:55:04 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)) 05:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:55:04 INFO - Running setup.py (path:/tmp/pip-EsV75D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:55:04 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)) 05:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:55:04 INFO - Running setup.py (path:/tmp/pip-epQ0NN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:55:04 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)) 05:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:55:04 INFO - Running setup.py (path:/tmp/pip-zZ4DeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:55:04 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)) 05:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:55:04 INFO - Running setup.py (path:/tmp/pip-PjSZA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:55:04 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)) 05:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:55:04 INFO - Running setup.py (path:/tmp/pip-I5LT7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:55:04 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)) 05:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:55:04 INFO - Running setup.py (path:/tmp/pip-fuH_9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:55:04 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)) 05:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:55:04 INFO - Running setup.py (path:/tmp/pip-848G6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:55:04 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)) 05:55:04 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)) 05:55:04 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)) 05:55:04 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)) 05:55:04 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)) 05:55:04 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)) 05:55:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:55:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:06 INFO - Downloading blessings-1.6.tar.gz 05:55:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:55:06 INFO - Installing collected packages: blessings 05:55:06 INFO - Running setup.py install for blessings 05:55:06 INFO - Successfully installed blessings 05:55:06 INFO - Cleaning up... 05:55:06 INFO - Return code: 0 05:55:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:55:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:55:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:55:06 INFO - Reading from file tmpfile_stdout 05:55:06 INFO - Current package versions: 05:55:06 INFO - argparse == 1.2.1 05:55:06 INFO - blessings == 1.6 05:55:06 INFO - blobuploader == 1.2.4 05:55:06 INFO - docopt == 0.6.1 05:55:06 INFO - manifestparser == 1.1 05:55:06 INFO - mozInstall == 1.12 05:55:06 INFO - mozcrash == 0.17 05:55:06 INFO - mozdebug == 0.1 05:55:06 INFO - mozdevice == 0.48 05:55:06 INFO - mozfile == 1.2 05:55:06 INFO - mozhttpd == 0.7 05:55:06 INFO - mozinfo == 0.9 05:55:06 INFO - mozleak == 0.1 05:55:06 INFO - mozlog == 3.1 05:55:06 INFO - moznetwork == 0.27 05:55:06 INFO - mozprocess == 0.22 05:55:06 INFO - mozprofile == 0.28 05:55:06 INFO - mozrunner == 6.11 05:55:06 INFO - mozscreenshot == 0.1 05:55:06 INFO - mozsystemmonitor == 0.0 05:55:06 INFO - moztest == 0.7 05:55:06 INFO - mozversion == 1.4 05:55:06 INFO - psutil == 3.1.1 05:55:06 INFO - requests == 1.2.3 05:55:06 INFO - wsgiref == 0.1.2 05:55:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:55: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')]} 05:55:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55: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')]} 05:55:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:06 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 0x7f07fe7bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d729a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e01810>, '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 0x1e02710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e02ba0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461411049.682967-641148017', '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 05:55:06 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 05:55:06 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 05:55:06 INFO - Using env: {'DISPLAY': ':0', 05:55:06 INFO - 'HOME': '/home/cltbld', 05:55:06 INFO - 'LANG': 'en_US.UTF-8', 05:55:06 INFO - 'LANGUAGE': 'en_US:en', 05:55:06 INFO - 'LOGNAME': 'cltbld', 05:55:06 INFO - 'MAIL': '/var/mail/cltbld', 05:55:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:06 INFO - 'MOZ_NO_REMOTE': '1', 05:55:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:06 INFO - 'NO_EM_RESTART': '1', 05:55:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:06 INFO - 'PWD': '/builds/slave/test', 05:55:06 INFO - 'SHELL': '/bin/bash', 05:55:06 INFO - 'SHLVL': '1', 05:55:06 INFO - 'TERM': 'linux', 05:55:06 INFO - 'TMOUT': '86400', 05:55:06 INFO - 'USER': 'cltbld', 05:55:06 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461411049.682967-641148017', 05:55:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:06 INFO - '_': '/tools/buildbot/bin/python'} 05:55:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:07 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)) 05:55:07 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)) 05:55:07 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)) 05:55:07 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)) 05:55:07 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)) 05:55:07 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)) 05:55:07 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)) 05:55:07 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)) 05:55:07 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)) 05:55:07 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)) 05:55:07 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)) 05:55:07 INFO - Cleaning up... 05:55:07 INFO - Return code: 0 05:55:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:55:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:55:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f07fe7bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d729a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e01810>, '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 0x1e02710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e02ba0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461411049.682967-641148017', '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 05:55:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:55:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:55:07 INFO - Using env: {'DISPLAY': ':0', 05:55:07 INFO - 'HOME': '/home/cltbld', 05:55:07 INFO - 'LANG': 'en_US.UTF-8', 05:55:07 INFO - 'LANGUAGE': 'en_US:en', 05:55:07 INFO - 'LOGNAME': 'cltbld', 05:55:07 INFO - 'MAIL': '/var/mail/cltbld', 05:55:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:07 INFO - 'MOZ_NO_REMOTE': '1', 05:55:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:07 INFO - 'NO_EM_RESTART': '1', 05:55:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:07 INFO - 'PWD': '/builds/slave/test', 05:55:07 INFO - 'SHELL': '/bin/bash', 05:55:07 INFO - 'SHLVL': '1', 05:55:07 INFO - 'TERM': 'linux', 05:55:07 INFO - 'TMOUT': '86400', 05:55:07 INFO - 'USER': 'cltbld', 05:55:07 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461411049.682967-641148017', 05:55:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:07 INFO - '_': '/tools/buildbot/bin/python'} 05:55:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:07 INFO - Downloading/unpacking jsonschema 05:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:55:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:55:09 INFO - Downloading/unpacking functools32 (from jsonschema) 05:55:09 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 05:55:09 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 05:55:09 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 05:55:09 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 05:55:09 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 05:55:09 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 05:55:09 INFO - Downloading functools32-3.2.3-2.tar.gz 05:55:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:55:09 INFO - warning: no files found matching '*.txt' 05:55:09 INFO - no previously-included directories found matching 'build' 05:55:09 INFO - no previously-included directories found matching 'dist' 05:55:09 INFO - no previously-included directories found matching '.git*' 05:55:09 INFO - Installing collected packages: jsonschema, functools32 05:55:09 INFO - Running setup.py install for functools32 05:55:09 INFO - warning: no files found matching '*.txt' 05:55:09 INFO - no previously-included directories found matching 'build' 05:55:09 INFO - no previously-included directories found matching 'dist' 05:55:09 INFO - no previously-included directories found matching '.git*' 05:55:09 INFO - Successfully installed jsonschema functools32 05:55:09 INFO - Cleaning up... 05:55:09 INFO - Return code: 0 05:55:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:55:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:55:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:55:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f07fe7bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d729a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e01810>, '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 0x1e02710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e02ba0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461411049.682967-641148017', '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 05:55:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:55:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:55:09 INFO - Using env: {'DISPLAY': ':0', 05:55:09 INFO - 'HOME': '/home/cltbld', 05:55:09 INFO - 'LANG': 'en_US.UTF-8', 05:55:09 INFO - 'LANGUAGE': 'en_US:en', 05:55:09 INFO - 'LOGNAME': 'cltbld', 05:55:09 INFO - 'MAIL': '/var/mail/cltbld', 05:55:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:09 INFO - 'MOZ_NO_REMOTE': '1', 05:55:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:09 INFO - 'NO_EM_RESTART': '1', 05:55:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:09 INFO - 'PWD': '/builds/slave/test', 05:55:09 INFO - 'SHELL': '/bin/bash', 05:55:09 INFO - 'SHLVL': '1', 05:55:09 INFO - 'TERM': 'linux', 05:55:09 INFO - 'TMOUT': '86400', 05:55:09 INFO - 'USER': 'cltbld', 05:55:09 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461411049.682967-641148017', 05:55:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:09 INFO - '_': '/tools/buildbot/bin/python'} 05:55:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:09 INFO - Downloading/unpacking flake8 05:55:09 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 05:55:09 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 05:55:09 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 05:55:09 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 05:55:09 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 05:55:09 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 05:55:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:55:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:55: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 05:55: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 05:55: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 05:55: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 05:55: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 05:55: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 05:55:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:55:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:55:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:55:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:55:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:55:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:55:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:55:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:55:12 INFO - no previously-included directories found matching 'docs/_build' 05:55:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:55:12 INFO - Running setup.py install for pep8 05:55:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:55:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:55:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:55:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:55:12 INFO - no previously-included directories found matching 'docs/_build' 05:55:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:55:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:55:12 INFO - Cleaning up... 05:55:12 INFO - Return code: 0 05:55:12 INFO - Running post-action listener: _resource_record_post_action 05:55:12 INFO - Running post-action listener: _start_resource_monitoring 05:55:12 INFO - Starting resource monitoring. 05:55:12 INFO - ##### 05:55:12 INFO - ##### Running install step. 05:55:12 INFO - ##### 05:55:12 INFO - Running pre-action listener: _resource_record_pre_action 05:55:12 INFO - Running main action method: install 05:55:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:55:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:55:13 INFO - Reading from file tmpfile_stdout 05:55:13 INFO - Detecting whether we're running mozinstall >=1.0... 05:55:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:55:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:55:13 INFO - Reading from file tmpfile_stdout 05:55:13 INFO - Output received: 05:55:13 INFO - Usage: mozinstall [options] installer 05:55:13 INFO - Options: 05:55:13 INFO - -h, --help show this help message and exit 05:55:13 INFO - -d DEST, --destination=DEST 05:55:13 INFO - Directory to install application into. [default: 05:55:13 INFO - "/builds/slave/test"] 05:55:13 INFO - --app=APP Application being installed. [default: firefox] 05:55:13 INFO - mkdir: /builds/slave/test/build/application 05:55:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:55:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:55:29 INFO - Reading from file tmpfile_stdout 05:55:29 INFO - Output received: 05:55:29 INFO - /builds/slave/test/build/application/firefox/firefox 05:55:29 INFO - Running post-action listener: _resource_record_post_action 05:55:29 INFO - ##### 05:55:29 INFO - ##### Running run-tests step. 05:55:29 INFO - ##### 05:55:29 INFO - Running pre-action listener: _resource_record_pre_action 05:55:29 INFO - Running main action method: run_tests 05:55:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:55:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:55:29 INFO - Python 2.7.3 05:55:29 INFO - Return code: 0 05:55:29 INFO - grabbing minidump binary from tooltool 05:55: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')]} 05:55:29 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 0x1e01810>, '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 0x1e02710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e02ba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:55:29 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 05:55:29 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 05:55:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:55:29 INFO - Return code: 0 05:55:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:55:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:55:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:55:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:55:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:55:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:55:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:55:30 INFO - Return code: 0 05:55:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:55:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:55:30 INFO - Using env: {'DISPLAY': ':0', 05:55:30 INFO - 'HOME': '/home/cltbld', 05:55:30 INFO - 'LANG': 'en_US.UTF-8', 05:55:30 INFO - 'LANGUAGE': 'en_US:en', 05:55:30 INFO - 'LOGNAME': 'cltbld', 05:55:30 INFO - 'MAIL': '/var/mail/cltbld', 05:55:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:55:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:55:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:30 INFO - 'MOZ_NO_REMOTE': '1', 05:55:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:55:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:30 INFO - 'NO_EM_RESTART': '1', 05:55:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:30 INFO - 'PWD': '/builds/slave/test', 05:55:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:55:30 INFO - 'SHELL': '/bin/bash', 05:55:30 INFO - 'SHLVL': '1', 05:55:30 INFO - 'TERM': 'linux', 05:55:30 INFO - 'TMOUT': '86400', 05:55:30 INFO - 'USER': 'cltbld', 05:55:30 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461411049.682967-641148017', 05:55:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:30 INFO - '_': '/tools/buildbot/bin/python'} 05:55:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:55:30 INFO - mozversion application_buildid: 20160423030220 05:55:30 INFO - mozversion application_changeset: 37f04460ddb76d6ef4e7c32a8a6b2fbc44cb8776 05:55:30 INFO - mozversion application_display_name: Nightly 05:55:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:55:30 INFO - mozversion application_name: Firefox 05:55:30 INFO - mozversion application_remotingname: firefox 05:55:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:55:30 INFO - mozversion application_vendor: Mozilla 05:55:30 INFO - mozversion application_version: 48.0a1 05:55:30 INFO - mozversion platform_buildid: 20160423030220 05:55:30 INFO - mozversion platform_changeset: 37f04460ddb76d6ef4e7c32a8a6b2fbc44cb8776 05:55:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:55:30 INFO - mozversion platform_version: 48.0a1 05:55:30 INFO - using testdate: 1461416130 05:55:30 INFO - actual date: 1461416130 05:55:30 INFO - starting webserver on 'localhost:50639' 05:55:30 INFO - SUITE-START | Running 2 tests 05:55:30 INFO - TEST-START | dromaeo_css 05:55:30 INFO - operating with platform_type : linux_ 05:55:30 INFO - Initialising browser for dromaeo_css test... 05:55:30 INFO - TEST-INFO | started process 31719 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9q0gBR/profile http://localhost:50639/getInfo.html) 05:55:34 INFO - PROCESS | 31719 | __metrics Screen width/height:1600/1200 05:55:34 INFO - PROCESS | 31719 | colorDepth:24 05:55:34 INFO - PROCESS | 31719 | Browser inner width/height: 1024/697 05:55:34 INFO - PROCESS | 31719 | __metrics 05:55:35 ERROR - PROCESS | 31719 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:55:36 INFO - TEST-INFO | 31719: exit 0 05:55:36 INFO - Browser initialized. 05:55:36 INFO - Running cycle 1/1 for dromaeo_css test... 05:55:36 INFO - TEST-INFO | started process 31804 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9q0gBR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:55:48 INFO - PROCESS | 31804 | RSS: Main: 153739264 05:55:48 INFO - PROCESS | 31804 | 05:56:39 INFO - PROCESS | 31804 | 1461416199565 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] 05:58:47 INFO - PROCESS | 31804 | Cycle 1(1): loaded http://localhost:50639/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50639/tests/dromaeo/cssquery-ext.html) 05:58:48 INFO - PROCESS | 31804 | RSS: Main: 249552896 05:58:48 INFO - PROCESS | 31804 | 06:01:50 INFO - PROCESS | 31804 | Cycle 1(1): loaded http://localhost:50639/tests/dromaeo/cssquery-ext.html (next: http://localhost:50639/tests/dromaeo/cssquery-jquery.html) 06:01:51 INFO - PROCESS | 31804 | RSS: Main: 227651584 06:01:51 INFO - PROCESS | 31804 | 06:04:52 INFO - PROCESS | 31804 | Cycle 1(1): loaded http://localhost:50639/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50639/tests/dromaeo/cssquery-mootools.html) 06:04:53 INFO - PROCESS | 31804 | RSS: Main: 241491968 06:04:53 INFO - PROCESS | 31804 | 06:07:55 INFO - PROCESS | 31804 | Cycle 1(1): loaded http://localhost:50639/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50639/tests/dromaeo/cssquery-prototype.html) 06:07:56 INFO - PROCESS | 31804 | RSS: Main: 234893312 06:07:56 INFO - PROCESS | 31804 | 06:10:58 INFO - PROCESS | 31804 | Cycle 1(1): loaded http://localhost:50639/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50639/tests/dromaeo/cssquery-yui.html) 06:10:59 INFO - PROCESS | 31804 | RSS: Main: 221540352 06:10:59 INFO - PROCESS | 31804 | 06:14:02 INFO - PROCESS | 31804 | Cycle 1(1): loaded http://localhost:50639/tests/dromaeo/cssquery-yui.html (next: http://localhost:50639/tests/dromaeo/cssquery-dojo.html) 06:14:02 INFO - PROCESS | 31804 | RSS: Main: 278654976 06:14:02 INFO - PROCESS | 31804 | 06:14:02 INFO - PROCESS | 31804 | __start_tp_report 06:14:02 INFO - PROCESS | 31804 | _x_x_mozilla_page_load 06:14:02 INFO - PROCESS | 31804 | _x_x_mozilla_page_load_details 06:14:02 INFO - PROCESS | 31804 | |i|pagename|runs| 06:14:02 INFO - PROCESS | 31804 | |0;dojo.html;3108.766842486814;3146.1977195815066;3186.426443240216;3188.5057816038507;3205.9358812823752;5209.296744939432;5301.681899086047;5319.547838433733;5356.3036805215315;5391.433899440561;5335.893282134355;5355.08963476209;5369.301990741198;5402.189671549259;5421.620486565942;4746.738929358884;4785.353977213083;4869.342638743778;4917.21324588066;4941.061198372297;4860.4896485869;4891.1195984722735;4917.213245880642;4917.557419832215;4931.901361972758;4662.277347011219;4718.764061796914;4805.111054454919;4833.323334733105;4854.514548545152;4821.807127714887;4841.782119804618;4841.8547443576745;4867.2212446008825;4889.119958407486;4733.857984260478;4807.543283388072;4823.927641085386;4827.758612069382;4860.222364421676;5248.396434410015;5289.576833853283;5295.549878260353;5307.548858347045;5365.531855346545;5659.349174844863;5670.461306175906;5706.28671416073;5706.400827913051;5707.800226992035;5558.610897237155;5718.571107166979;5733.741981610796;5758.078707406837;5818.912716309259;5317.973410132925;5318.282031925718;5322.095243808523;5322.813701520467;5331.546818520431;5786.855328616818;5789;5792.739326730307;5799.101139323411;5827.125931110368;5530.059889818741;5573.888522229533;5594.496495315359;5600.439956004367;5646.181303711021;5550.139728342114;5554.91667624986;5555.694436805934;5558.055130627803;5564.610477266633;5548.334199896039;5549.361823390281;5550.86122846924;5551.25058117149;5601.6358936668985;5578.219049333096;5613.242212301287;5641.407652196543;5643.661380317194;5693.601447898607;4329.372241025034;4330.675199360061;4336.089421221515;4346.1090476452255;4385.824567017284;3786.6213378662464;3859;3894.045958740127;3930.194310166409;3935.0752573145287;5302.2046692996355;5382.838514844561;5418.91871621926;5431.321084864392;5432.837014889559;5617.8595535111135;5655.802046928337;5663.32040155184;5672.092465205547;5680.886382272414;5247.527722504993;5299;5335.1730481775385;5353.491418315254;5401.378841433286;4877.317175595419;4910.361652985161;4920.065187614414;4959.107360675113;4959.677620954626;5804.129380592861;5822.475977161991;5826.388229235869;5828.708564571754;5837.474627283565;5476.863078422912;5626;5656.88686226265;5659.179418984307;5720.885582288414;5836.212111365081;5841.240638716939;5867.853303667272;5899.410058994066;5900.734466948912;5580.693061881636;5583.553315734813;5599.972000139973;5620.297462817148;5626.099824028136;5472.069748142746;5679.716014199191;5710.828675139753;5719.542436604978;5726.284214473191;5563.388027316911;5597.3003374578175;5606.915896261641;5634;5658.858528536654;5530.6128570999645;5551.805686800943;5556.472135147154;5561.082421400423;5565.1095824667855;5371.194320851903;5463.808766693147;5485.807996720096;5486.945130548644;5520.392756796829;5601.551875850004;5621.128725047624;5627.071533196977;5632.464915832989;5681.857953551029;5462.8361149165585;5492.780288788404;5504.614676972574;5510.559155267489;5546.112621980464 06:14:02 INFO - PROCESS | 31804 | |1;ext.html;608.6926102318331;648.2998361769289;655.3806652713185;657.4773055420943;662.6090606542139;30107.24731881704;36997;37803.99999999996;38090.8095459523;38107;39693.80153099238;40034;40357.59642403575;40468.39297410541;40512;7711.344535714471;7952.20477952206;8468.322534197281;8673.176048275403;8675.045744968049;10065.547050382715;10534.367937923711;10537.209709271798;10544.47277636119;10545.894541054606;10083.899161008407;10193.490325483734;10193.847092293621;10194;10195.235357348229;8098.068722096946;10185.949070254639;10240.539175737034;10630.096441802456;10630.415327157003;10033.44816035125;10154.238432117621;10168.389896606228;10168.59325626974;10184.694459166238;36283.27433451343;36709.26581468382;36786.448203276705;36790.44814327787;36813.81593092044;3408.812515311657;3434.364642541138;3467.5665541807275;3704.8888533344043;3904.629060239273;31603.841980790177;31841;31988.360232795214;32269.83865080683;33155.6684433155;3744.2885851688093;3848.7883166425836;3904.6876249900224;3905.726599138033;3991.2217117662067;314216;314765;314984;315624;317565.5338956356;55513.444865550824;55596.386234894606;55957.44042559604;56062.71968640131;56063;53384.46615533795;53617.7319113402;53624.19563706547;53700.46299536955;53749;14796.260186990607;15129.167895765619;15172.317245723969;15183.62040948963;15185.772213416807;13062.54281100176;13066.281354525592;13109.410076546388;13135.408906599036;13140.934295328654;15542.145182014872;15652.452164174427;15675.137867417174;15677.764833527506;15785.605359866095;5034.295198672189;5672.319321681424;5848.941510584925;5940.673262970492;6010.609310394811;1048.2243140076441;1090.1170052257696;1096.4791723931069;1104.9337039777638;1201.4173126033866;30941.845290773403;30953.53569696456;31128.377432451678;31435.84282078575;31678.208044799063;1109.2678831970861;1121.9158563107799;1123.7078359626391;1203.9097067719956;1227.8342423772856;14262.3581938813;14905;15111;15236.771448428282;15395;508889;514239;514258;516489;517150;53185.734071329396;53466.198007029925;53486;53598.196027059625;53644.19533706998;1353.3977380065776;1378.572642480814;1405.901586888908;1410.5133728863525;1425.6435891027243;27623.723762762114;28584.857075714488;28711;29569.112926612237;29573.852130739207;46170.53829461662;52961;55147;55216.61958451071;55276.44723552713;358423;358482;361568;362357;364130;24611.63082553727;26844.463110738066;27076.1877143686;27626.5856012164;27673.723262767115;41001.17997639971;42162;42277.78861105675;45207.773961129984;45980.310295346266;38037.61962380341;38108;38147.809260953516;38420.61579384282;38591.42112868253;33684.831575842945;33763.662363377036;34170.31659366749;34190.14524636904;34391.4841277376;37891.62108378991;38008.429873551366;38393.80803095967;39705;40866.38700419555;29760;31491.52762708607;31791.841040794647;31861.68138318587;33688.83155584305;26346.473070538865;26777.8661106701;26916.73083269142;27260.863695681393;28001.859990699915 06:14:02 INFO - PROCESS | 31804 | |2;jquery.html;362.4183185986493;376.29820384982014;386.6520131881306;390.826082393335;399.36700329976986;14849.703005939875;16389.180540972964;16542.751858722113;17665.64668706625;17687.73468397975;16777.496675099766;16915.746263806053;17461.21424535896;17669;17717.1141442928;4940.25896115582;5074.517920797518;5103.311053007834;5104.821331253407;5106.336176297076;5042.268871013701;5089.185730283156;5188.766505507242;5512;5515.7242137893145;5371.704556249405;5484.122540393538;5489.835304940858;5491.670499770026;5510.972445137789;5627.80302689408;5654.46282603152;5655.349634792011;5680.460356266148;5682.460166284196;5296.417394086648;5419.647722897999;5475.123980163195;5478.506934375885;5483.259759932438;12099.879001209963;12617.810732839014;12679.873201268054;12805.10364274501;12835.743285134338;2236.563870045342;2280.213326402405;2393.1504315967927;2409.0965887792077;2555.0163187172884;9820.90179098207;10085.294029417944;10119.89880101197;10126.088652021353;13686.863131368658;1899.9525011874675;1940.640981418428;1955.9608807823906;1983.702444633302;2002.9899850500653;49266.50733492691;65137.67431162861;65680.3431965679;75138.24861751367;76197.61901190458;10161.339512931636;10460.947695261628;10556.419396933088;10659;10776.29954052984;14991.175485348193;15029.849701502844;15056.623584410258;15064.548063558112;15067.773983390258;7952.1650226726515;8135.593220338959;8182.836343273101;8279.62741676626;8296.585170741439;7934.960325198337;7953.920460795433;7991.761277002074;8051.315638170704;8105.513669179868;4534.229181039232;4605.4933957264675;4610.077984403133;4627.768611569408;4644.883877903012;1888.2541396148445;1930.2086144680895;1944.601356721897;1947.0793809286072;1967.4097770668743;429.10317436557744;442.26583870775005;948.4309414351472;1053.3258714422775;1114.2701530497536;10825.188110891715;11075.501602427748;11166.106711463064;11212.719682008015;11376.203665743318;451.69510580358127;455.24202203331083;457.31174582253493;458.45901835834036;479.72176137839966;5730.942690573041;5999.460048595647;6030.7889223876955;6055.666938318347;6106.877862442726;437979;442062;446534.76732616127;506206;525123;93234;95318;95492.52253738687;96273;98369;450.4437020279952;450.5989669194354;450.93461448089846;455.2352048558454;456.21530966737157;10031.899681003388;10100.444475553915;10293.794124117625;10358.533865975898;10401.27191096616;33780;34651.48022779711;35873.28253434969;35977.82011089928;36067.45898811572;52506;52938.73530632322;53008;53947.730261350014;54117.72941135269;4828.7102773833685;4915.4592994771265;7921.683132674629;8086.595670216583;8792.29661627081;10974.890251097706;13413.66465838362;13694.863051369359;13754.174749515061;13907.930460348038;11669;11857.881421186023;11907.46416411281;12051.51793928233;12199.3290369027;11744.58893938708;11838.82241766357;11923.940380298043;12233.69415764613;12245.265284082983;11675.591354302558;11706.648800535997;11733.296002239893;11998.160128790902;12541.31022793755;8452.74641760748;8486.278666313432;8537.274331681876;8662.393632445668;8745.207232517192;11526.366049867001;11789.115816313639;12095.57665481739;12169.20900141488;12181.208221465577 06:14:02 INFO - PROCESS | 31804 | |3;mootools.html;1362.9863701362983;1488.9851101488982;1498.3631956418524;1626.2925627352095;1789.5526118470382;7597.506162099459;7850.528968261894;7856.96071519643;7864.803379915505;7871.9606401967985;7731.265529774662;7867;7869.016372953381;7875.369970402368;7877;1932.3333449959741;1994.2820584589535;1994.3717728915417;2248.325502349297;2278.6582012698063;2300.5168914527967;2346.9530609387803;2361.5985282502015;2366.349253955159;2372.7271363793125;2253.4704344479032;2258.3112150794;2260.977390226093;2265.2524666859895;2314.537092581482;1972.0632699467637;2225.121077174515;2229.375774783063;2239.294622194012;2242.0583354990863;2298.988505057481;2325.9069637214493;2327.464683122891;2329.114936324203;2329.2662811214414;8000.039995200613;8038.236367545074;8042;8055.395845311625;8057.5165490070785;4771.856844294677;4929.433115191763;4941.505849415065;4968.726720030397;4970.527799859007;3132.733717634004;3222.081706713599;3324.2852786650988;3336.5495658086093;3348.5981682198294;1084.8318510630866;1089.1939964426347;1091.8471414002047;1091.867282336361;1111.8109921313396;11163.888361116366;11174;11182.496787644657;11187.608433704863;11207.271527350696;4247.638950689165;4441.911161776747;4478.686491945533;4528.456585209796;4531.252343363374;9611.423314601147;9645.807083858284;9654.806903861883;9655.710328690151;9666.661666841768;5045.394552653705;5057.089723849669;5058.645894787403;5080.314157588752;5080.441151473335;4114.6091121343425;4149.211649786531;4567.429071366079;4668.393108895822;4678.532146785295;3797.5632802228097;3807.447920051577;3906.7851268180525;3912.7456715313983;3923.6468717815533;1249.762545116425;1265.544404014554;1272.739088486858;1274.4710944957924;1286.85201201863;868.7654333329965;957.0859828863419;964.392432767352;990.5740531571349;1017.7913527726798;5580.469855363734;5716.42835716425;5740.512056475163;5819.738111784895;5882.176495290662;410.25333892316297;410.3209188792553;416.1925863824171;420.05487652781244;425.7105168485398;3938.2320447513034;3956.1098752780968;3996.500437445319;4007.859724909614;4049.635532802062;9806.705798826046;10174.593016279267;10257.948710256402;10265.178785697126;10285.691429257135;10095.293329466867;10179.389236645826;10188.337758045704;10216.642417515352;10216.948915255376;7666.118396384376;7711.730089446843;7711.768646940601;7726.536407815549;7739.651715672809;5463.617546771688;5517.36550296721;5604.747786349542;5622.634528755618;5661.943380566142;9211.539423028687;9331.72004839856;9355.06449355059;9359.438433694;9459.243260539279;9218.815623687622;9332.20676242527;9470.763230919281;9499.715008549754;9682.612695492102;6586.703598338182;6968.65156742171;7197.352238298578;7198.596273726573;7203.855922881408;7801.648925798239;7837.1770964047955;7855.175206603224;7881.290683838482;7904.170062143392;6917.827054323682;6968.303169682991;7011.3339232772805;7152.821179470347;7183.8563228736175;7137.321954414322;7234.819129521804;7246.384057355184;7276.744174474662;7305.159906610807;6481.222253329631;6564.9671751640935;6574.0796288520605;6581.177352830896;6581.506387020897;4836.637252206169;4869.318295438712;4892.094962431819;4998.825041123689;5001.899962000667;4728.030753695553;4779;4906.994066216345;4963.503649635008;5066.290719299374 06:14:02 INFO - PROCESS | 31804 | |4;prototype.html;328.15663744177476;329.8087109476504;332.0470250381405;335.70793409733534;336.18307512744036;5726.484616384525;5798.3331916829575;5816.33112192098;5832.6792026438525;5851.2100866383025;5719.571032172583;5742.138679198112;5752.367239603651;5753.194552762617;5753.913691294623;4160.583941605845;4221.282381995053;4436.755978421185;4439.378487011805;4452.7328360298325;4407.338899165119;4426.911461770763;4433.334999750031;4435.62297204738;4445.599896009358;4125.278076336629;4398.098389830077;4415.911681766363;4419.9337009944875;4422.159789639974;4277.422547956017;4401.933970990438;4406.47122345319;4409.096135292258;4424.159409712144;3854.2291541691775;3862.9613703862883;3876.9806150969066;3882;3897;5382.730863456851;5509.338879334466;5536.7231638418325;5546;5551.8889622207735;5058.620603454756;5072.0870243356185;5074.13739664258;5076.746162691888;5090.974545127251;5860.296764388258;5925.259342582177;5928.644281343133;5947.434993675594;5964.7315870785915;3952.288588054149;4246.723962942429;4260.68044896634;4261.718476772868;4271.081717430768;6166.105914642397;6220.87558248837;6232.501399887998;6250.656213908233;6268.623882567015;4153.771542565188;4194.412782210493;4200.432941552851;4200.474940632421;4209.116085621992;4086.978255436141;4231.280682284019;4241.981924338198;4251.872443826628;4255.127698821796;4970.602351811846;4991.47589503097;4992.450830408652;4995.875103122451;5010.3737032870895;6041.72812223451;6049.879002419927;6053.243344581927;6066.848328791727;6108.083787431832;1395.6022533578084;1464.1727424005403;1491.8959969622401;1499.2054211268046;1502.5725560717362;886.7561420609384;981.7741919358588;982.6413359123868;1005.2259759984771;1007.652359935821;5743.396943320975;5743.885122297531;5757.827265182052;5767.8558036049435;5787.681677507778;6151.2618485781095;6160.414760597736;6161.106639537242;6182.6599537025895;6186.969065154645;5597.944020559742;5791.391903850119;5893.587448878623;5900.852478688067;5903.822885313361;3296.7692261541943;3330.633630300665;3333.616634087111;3343.3814744272386;3355.832208389571;6268.623882567061;6469.482441404676;6480.416762491304;6486.902696459557;6489.091527186198;6267.96866015667;6281.748730050838;6355.523335749837;6387.552871299057;6394.904076438857;6105.328413874559;6388.233411990591;6393.1369265148605;6402.135711678957;6407.7757278495965;6183;6199.876002480015;6215.316315205414;6216;6238.438540531374;6154.692265386802;6164.260288765377;6169.2288463942;6199.876002480015;6209.161763162096;6291.955114587869;6373.904391434039;6411.679416029273;6466.159399278064;6469.708863101077;4138.358554424069;4166;4181.741859396014;4203.76879271643;4208.263553878121;6083.452489275986;6248.375162483897;6269.780557680459;6272.341404152498;6294.653794041372;6051.878962420815;6064.211652485149;6067.211262535842;6069.666168360783;6073.878522429438;6018.879622407615;6019.699015049143;6032.306284777307;6042.818715438544;6059.424354686298;5685.289338832646;5805.245318108618;5819.970900145472;5927.970360148344;5975.103734439869;6057.4851137653795;6085.604435711664;6099.969500152471;6114.38856114385;6117.388261173847;5675.489205971482;5935.169076329404;5956.255468066492;5957.970210148921;5965.940340596539 06:14:02 INFO - PROCESS | 31804 | |5;yui.html;750.2609929219719;761.4365369626478;829.6059371798397;835.0008646458655;838.4759525296689;14238.216898070603;14453.783193252097;14505;14518.274086295683;14538.34577444015;13643.249621270827;13922.095063820845;14056.71886562268;14072.507462238824;14088.71822563548;778.579567033801;785.0461689047805;785.6778720724504;788.787027502574;788.858005559002;601.7232073246312;787.3189690917344;796.5738329993454;796.7808852565532;800.5036877136183;834.5743670727942;834.7287131682198;835.8495470815251;839.5718183726314;855.4097672605914;697.849962258117;827.8054657155594;828.0518805967195;832.3715594725974;847.6270441005938;600.9879802403971;601.0683440666993;601.2244204975576;602.5962605054624;610.9419605137505;14341.13953162803;14392.496262630862;14407.567772966722;14469.78295325571;14480.275986200648;12669.429875655618;13267.270300133488;13288.933555332258;13449.529266475627;13532.458701651922;10585.841212381743;10857.3485590864;10872.891271087266;11038.944805276002;11148.832767508413;3759.661630453272;3849.1147036181833;3851.1912498375373;3856.132370216707;3886.4753258310334;57297.71351143218;57325.713371433296;57429.425705742826;57559.71220143914;57595.99999999958;9752.561134748954;9806.166475849634;9850.655227067018;10000;10208.438535880598;18353.63292734138;18360.265589376544;18404.26382944694;18439;18442.170102345426;8045.316148127357;8069.354451643854;8306.293965012921;8380.8742868857;8633.266172375419;4555.544445555418;4564.84023059198;4603.332516785047;4701.318308845267;4728.716277023321;3334.6498617645284;3361.932761344808;3399.6600339965808;3412.590489141319;3421.4183588789965;579.5884921705637;594.5422025040781;595.8916415467228;604.4348534120611;618.2951435363689;760.8440269744689;761.5621017914722;762.4815125714567;775.1550809617544;793.888855560222;8715.864613169813;9424;9524.428534287827;9534.809303813885;9696.563654635418;732.2201855024382;738.7340557399332;758.3819187362282;763.4770182425057;771.086262778598;4178.91642167155;4360.803763830635;4380.496242932104;4413.404190434315;4528.207563676344;54151.72924135354;56021.1596826048;65526;66291.66854165794;66351.66824165944;52624;53484.46515534873;53677.463225367246;54991.725041374535;55800.72099639557;48249;49835.25247121369;50148.24777628339;50969;51035.23447148296;9420.246380289698;9564.713058608253;9616.672204891262;9631.9036809631;9697.5151242439;34001.48997765085;34674.65325346714;34938.30123397569;35183.64816351804;36050;44481.55518444903;47085.76457117692;47485;47594.52405475901;49850.501494986034;12248.081393895316;12261.062519279169;12281.078919081283;12329.69175770577;12408.193467424588;13131.474741010252;13446.99147563917;13776.448942042607;14099.929500352433;14382.35279412408;12880.742385152433;13283.66790830237;13498.055136140376;13796.310184490936;13920.373583188579;12381.62855114348;12794.104412691022;13000.739985200433;13061.542846000344;13299.66750831237;12275.75448491043;12339.197952133083;12829.61511154667;12999.285039322927;13106.565770085357;10256.487175641338;10701.571937122428;10704.411257380918;10778.838317425088;10837;10563.679540057492;10800.189985751258;10829.51267192994;10877.945610271898;10892.61875834342 06:14:02 INFO - PROCESS | 31804 | __end_tp_report 06:14:02 INFO - PROCESS | 31804 | __start_cc_report 06:14:02 INFO - PROCESS | 31804 | _x_x_mozilla_cycle_collect,803 06:14:02 INFO - PROCESS | 31804 | __end_cc_report 06:14:02 INFO - PROCESS | 31804 | __startTimestamp1461417242390__endTimestamp 06:14:02 INFO - PROCESS | 31804 | 06:14:02 INFO - PROCESS | 31804 | ------- Summary: start ------- 06:14:02 INFO - PROCESS | 31804 | Number of tests: 6 06:14:02 INFO - PROCESS | 31804 | 06:14:02 INFO - PROCESS | 31804 | [#0] dojo.html Cycles:165 Average:5275.94 Median:5492.78 stddev:580.44 (10.6%) stddev-sans-first:556.77 06:14:02 INFO - PROCESS | 31804 | Values: 3108.8 3146.2 3186.4 3188.5 3205.9 5209.3 5301.7 5319.5 5356.3 5391.4 5335.9 5355.1 5369.3 5402.2 5421.6 4746.7 4785.4 4869.3 4917.2 4941.1 4860.5 4891.1 4917.2 4917.6 4931.9 4662.3 4718.8 4805.1 4833.3 4854.5 4821.8 4841.8 4841.9 4867.2 4889.1 4733.9 4807.5 4823.9 4827.8 4860.2 5248.4 5289.6 5295.5 5307.5 5365.5 5659.3 5670.5 5706.3 5706.4 5707.8 5558.6 5718.6 5733.7 5758.1 5818.9 5318.0 5318.3 5322.1 5322.8 5331.5 5786.9 5789.0 5792.7 5799.1 5827.1 5530.1 5573.9 5594.5 5600.4 5646.2 5550.1 5554.9 5555.7 5558.1 5564.6 5548.3 5549.4 5550.9 5551.3 5601.6 5578.2 5613.2 5641.4 5643.7 5693.6 4329.4 4330.7 4336.1 4346.1 4385.8 3786.6 3859.0 3894.0 3930.2 3935.1 5302.2 5382.8 5418.9 5431.3 5432.8 5617.9 5655.8 5663.3 5672.1 5680.9 5247.5 5299.0 5335.2 5353.5 5401.4 4877.3 4910.4 4920.1 4959.1 4959.7 5804.1 5822.5 5826.4 5828.7 5837.5 5476.9 5626.0 5656.9 5659.2 5720.9 5836.2 5841.2 5867.9 5899.4 5900.7 5580.7 5583.6 5600.0 5620.3 5626.1 5472.1 5679.7 5710.8 5719.5 5726.3 5563.4 5597.3 5606.9 5634.0 5658.9 5530.6 5551.8 5556.5 5561.1 5565.1 5371.2 5463.8 5485.8 5486.9 5520.4 5601.6 5621.1 5627.1 5632.5 5681.9 5462.8 5492.8 5504.6 5510.6 5546.1 06:14:02 INFO - PROCESS | 31804 | 06:14:02 INFO - PROCESS | 31804 | [#1] ext.html Cycles:180 Average:54925.27 Median:33726.25 stddev:107579.30 (319.0%) stddev-sans-first:107803.79 06:14:02 INFO - PROCESS | 31804 | Values: 608.7 648.3 655.4 657.5 662.6 30107.2 36997.0 37804.0 38090.8 38107.0 39693.8 40034.0 40357.6 40468.4 40512.0 7711.3 7952.2 8468.3 8673.2 8675.0 10065.5 10534.4 10537.2 10544.5 10545.9 10083.9 10193.5 10193.8 10194.0 10195.2 8098.1 10185.9 10240.5 10630.1 10630.4 10033.4 10154.2 10168.4 10168.6 10184.7 36283.3 36709.3 36786.4 36790.4 36813.8 3408.8 3434.4 3467.6 3704.9 3904.6 31603.8 31841.0 31988.4 32269.8 33155.7 3744.3 3848.8 3904.7 3905.7 3991.2 314216.0 314765.0 314984.0 315624.0 317565.5 55513.4 55596.4 55957.4 56062.7 56063.0 53384.5 53617.7 53624.2 53700.5 53749.0 14796.3 15129.2 15172.3 15183.6 15185.8 13062.5 13066.3 13109.4 13135.4 13140.9 15542.1 15652.5 15675.1 15677.8 15785.6 5034.3 5672.3 5848.9 5940.7 6010.6 1048.2 1090.1 1096.5 1104.9 1201.4 30941.8 30953.5 31128.4 31435.8 31678.2 1109.3 1121.9 1123.7 1203.9 1227.8 14262.4 14905.0 15111.0 15236.8 15395.0 508889.0 514239.0 514258.0 516489.0 517150.0 53185.7 53466.2 53486.0 53598.2 53644.2 1353.4 1378.6 1405.9 1410.5 1425.6 27623.7 28584.9 28711.0 29569.1 29573.9 46170.5 52961.0 55147.0 55216.6 55276.4 358423.0 358482.0 361568.0 362357.0 364130.0 24611.6 26844.5 27076.2 27626.6 27673.7 41001.2 42162.0 42277.8 45207.8 45980.3 38037.6 38108.0 38147.8 38420.6 38591.4 33684.8 33763.7 34170.3 34190.1 34391.5 37891.6 38008.4 38393.8 39705.0 40866.4 29760.0 31491.5 31791.8 31861.7 33688.8 26346.5 26777.9 26916.7 27260.9 28001.9 06:14:02 INFO - PROCESS | 31804 | 06:14:02 INFO - PROCESS | 31804 | [#2] jquery.html Cycles:180 Average:26802.63 Median:414.24 stddev:78078.40 (18848.8%) stddev-sans-first:78272.18 06:14:02 INFO - PROCESS | 31804 | Values: 362.4 376.3 386.7 390.8 399.4 14849.7 16389.2 16542.8 17665.6 17687.7 16777.5 16915.7 17461.2 17669.0 17717.1 4940.3 5074.5 5103.3 5104.8 5106.3 5042.3 5089.2 5188.8 5512.0 5515.7 5371.7 5484.1 5489.8 5491.7 5511.0 5627.8 5654.5 5655.3 5680.5 5682.5 5296.4 5419.6 5475.1 5478.5 5483.3 12099.9 12617.8 12679.9 12805.1 12835.7 2236.6 2280.2 2393.2 2409.1 2555.0 9820.9 10085.3 10119.9 10126.1 13686.9 1900.0 1940.6 1956.0 1983.7 2003.0 49266.5 65137.7 65680.3 75138.2 76197.6 10161.3 10460.9 10556.4 10659.0 10776.3 14991.2 15029.8 15056.6 15064.5 15067.8 7952.2 8135.6 8182.8 8279.6 8296.6 7935.0 7953.9 7991.8 8051.3 8105.5 4534.2 4605.5 4610.1 4627.8 4644.9 1888.3 1930.2 1944.6 1947.1 1967.4 429.1 442.3 948.4 1053.3 1114.3 10825.2 11075.5 11166.1 11212.7 11376.2 451.7 455.2 457.3 458.5 479.7 5730.9 5999.5 6030.8 6055.7 6106.9 437979.0 442062.0 446534.8 506206.0 525123.0 93234.0 95318.0 95492.5 96273.0 98369.0 450.4 450.6 450.9 455.2 456.2 10031.9 10100.4 10293.8 10358.5 10401.3 33780.0 34651.5 35873.3 35977.8 36067.5 52506.0 52938.7 53008.0 53947.7 54117.7 4828.7 4915.5 7921.7 8086.6 8792.3 10974.9 13413.7 13694.9 13754.2 13907.9 11669.0 11857.9 11907.5 12051.5 12199.3 11744.6 11838.8 11923.9 12233.7 12245.3 11675.6 11706.6 11733.3 11998.2 12541.3 8452.7 8486.3 8537.3 8662.4 8745.2 11526.4 11789.1 12095.6 12169.2 12181.2 06:14:02 INFO - PROCESS | 31804 | 06:14:02 INFO - PROCESS | 31804 | [#3] mootools.html Cycles:180 Average:5408.76 Median:4899.54 stddev:3017.19 (61.6%) stddev-sans-first:3010.34 06:14:02 INFO - PROCESS | 31804 | Values: 1363.0 1489.0 1498.4 1626.3 1789.6 7597.5 7850.5 7857.0 7864.8 7872.0 7731.3 7867.0 7869.0 7875.4 7877.0 1932.3 1994.3 1994.4 2248.3 2278.7 2300.5 2347.0 2361.6 2366.3 2372.7 2253.5 2258.3 2261.0 2265.3 2314.5 1972.1 2225.1 2229.4 2239.3 2242.1 2299.0 2325.9 2327.5 2329.1 2329.3 8000.0 8038.2 8042.0 8055.4 8057.5 4771.9 4929.4 4941.5 4968.7 4970.5 3132.7 3222.1 3324.3 3336.5 3348.6 1084.8 1089.2 1091.8 1091.9 1111.8 11163.9 11174.0 11182.5 11187.6 11207.3 4247.6 4441.9 4478.7 4528.5 4531.3 9611.4 9645.8 9654.8 9655.7 9666.7 5045.4 5057.1 5058.6 5080.3 5080.4 4114.6 4149.2 4567.4 4668.4 4678.5 3797.6 3807.4 3906.8 3912.7 3923.6 1249.8 1265.5 1272.7 1274.5 1286.9 868.8 957.1 964.4 990.6 1017.8 5580.5 5716.4 5740.5 5819.7 5882.2 410.3 410.3 416.2 420.1 425.7 3938.2 3956.1 3996.5 4007.9 4049.6 9806.7 10174.6 10257.9 10265.2 10285.7 10095.3 10179.4 10188.3 10216.6 10216.9 7666.1 7711.7 7711.8 7726.5 7739.7 5463.6 5517.4 5604.7 5622.6 5661.9 9211.5 9331.7 9355.1 9359.4 9459.2 9218.8 9332.2 9470.8 9499.7 9682.6 6586.7 6968.7 7197.4 7198.6 7203.9 7801.6 7837.2 7855.2 7881.3 7904.2 6917.8 6968.3 7011.3 7152.8 7183.9 7137.3 7234.8 7246.4 7276.7 7305.2 6481.2 6565.0 6574.1 6581.2 6581.5 4836.6 4869.3 4892.1 4998.8 5001.9 4728.0 4779.0 4907.0 4963.5 5066.3 06:14:02 INFO - PROCESS | 31804 | 06:14:02 INFO - PROCESS | 31804 | [#4] prototype.html Cycles:180 Average:5040.00 Median:5789.54 stddev:1524.66 (26.3%) stddev-sans-first:1487.36 06:14:02 INFO - PROCESS | 31804 | Values: 328.2 329.8 332.0 335.7 336.2 5726.5 5798.3 5816.3 5832.7 5851.2 5719.6 5742.1 5752.4 5753.2 5753.9 4160.6 4221.3 4436.8 4439.4 4452.7 4407.3 4426.9 4433.3 4435.6 4445.6 4125.3 4398.1 4415.9 4419.9 4422.2 4277.4 4401.9 4406.5 4409.1 4424.2 3854.2 3863.0 3877.0 3882.0 3897.0 5382.7 5509.3 5536.7 5546.0 5551.9 5058.6 5072.1 5074.1 5076.7 5091.0 5860.3 5925.3 5928.6 5947.4 5964.7 3952.3 4246.7 4260.7 4261.7 4271.1 6166.1 6220.9 6232.5 6250.7 6268.6 4153.8 4194.4 4200.4 4200.5 4209.1 4087.0 4231.3 4242.0 4251.9 4255.1 4970.6 4991.5 4992.5 4995.9 5010.4 6041.7 6049.9 6053.2 6066.8 6108.1 1395.6 1464.2 1491.9 1499.2 1502.6 886.8 981.8 982.6 1005.2 1007.7 5743.4 5743.9 5757.8 5767.9 5787.7 6151.3 6160.4 6161.1 6182.7 6187.0 5597.9 5791.4 5893.6 5900.9 5903.8 3296.8 3330.6 3333.6 3343.4 3355.8 6268.6 6469.5 6480.4 6486.9 6489.1 6268.0 6281.7 6355.5 6387.6 6394.9 6105.3 6388.2 6393.1 6402.1 6407.8 6183.0 6199.9 6215.3 6216.0 6238.4 6154.7 6164.3 6169.2 6199.9 6209.2 6292.0 6373.9 6411.7 6466.2 6469.7 4138.4 4166.0 4181.7 4203.8 4208.3 6083.5 6248.4 6269.8 6272.3 6294.7 6051.9 6064.2 6067.2 6069.7 6073.9 6018.9 6019.7 6032.3 6042.8 6059.4 5685.3 5805.2 5820.0 5928.0 5975.1 6057.5 6085.6 6100.0 6114.4 6117.4 5675.5 5935.2 5956.3 5958.0 5965.9 06:14:02 INFO - PROCESS | 31804 | 06:14:02 INFO - PROCESS | 31804 | [#5] yui.html Cycles:180 Average:14934.66 Median:4652.33 stddev:17325.48 (372.4%) stddev-sans-first:17341.34 06:14:02 INFO - PROCESS | 31804 | Values: 750.3 761.4 829.6 835.0 838.5 14238.2 14453.8 14505.0 14518.3 14538.3 13643.2 13922.1 14056.7 14072.5 14088.7 778.6 785.0 785.7 788.8 788.9 601.7 787.3 796.6 796.8 800.5 834.6 834.7 835.8 839.6 855.4 697.8 827.8 828.1 832.4 847.6 601.0 601.1 601.2 602.6 610.9 14341.1 14392.5 14407.6 14469.8 14480.3 12669.4 13267.3 13288.9 13449.5 13532.5 10585.8 10857.3 10872.9 11038.9 11148.8 3759.7 3849.1 3851.2 3856.1 3886.5 57297.7 57325.7 57429.4 57559.7 57596.0 9752.6 9806.2 9850.7 10000.0 10208.4 18353.6 18360.3 18404.3 18439.0 18442.2 8045.3 8069.4 8306.3 8380.9 8633.3 4555.5 4564.8 4603.3 4701.3 4728.7 3334.6 3361.9 3399.7 3412.6 3421.4 579.6 594.5 595.9 604.4 618.3 760.8 761.6 762.5 775.2 793.9 8715.9 9424.0 9524.4 9534.8 9696.6 732.2 738.7 758.4 763.5 771.1 4178.9 4360.8 4380.5 4413.4 4528.2 54151.7 56021.2 65526.0 66291.7 66351.7 52624.0 53484.5 53677.5 54991.7 55800.7 48249.0 49835.3 50148.2 50969.0 51035.2 9420.2 9564.7 9616.7 9631.9 9697.5 34001.5 34674.7 34938.3 35183.6 36050.0 44481.6 47085.8 47485.0 47594.5 49850.5 12248.1 12261.1 12281.1 12329.7 12408.2 13131.5 13447.0 13776.4 14099.9 14382.4 12880.7 13283.7 13498.1 13796.3 13920.4 12381.6 12794.1 13000.7 13061.5 13299.7 12275.8 12339.2 12829.6 12999.3 13106.6 10256.5 10701.6 10704.4 10778.8 10837.0 10563.7 10800.2 10829.5 10877.9 10892.6 06:14:02 INFO - PROCESS | 31804 | -------- Summary: end -------- 06:14:02 INFO - PROCESS | 31804 | 06:14:03 INFO - TEST-INFO | 31804: exit 0 06:14:03 INFO - TEST-OK | dromaeo_css | took 1112178ms 06:14:03 INFO - TEST-START | kraken 06:14:03 INFO - operating with platform_type : linux_ 06:14:03 INFO - Initialising browser for kraken test... 06:14:03 INFO - TEST-INFO | started process 31991 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW1gHu2/profile http://localhost:50639/getInfo.html) 06:14:06 INFO - PROCESS | 31991 | __metrics Screen width/height:1600/1200 06:14:06 INFO - PROCESS | 31991 | colorDepth:24 06:14:06 INFO - PROCESS | 31991 | Browser inner width/height: 1024/697 06:14:06 INFO - PROCESS | 31991 | __metrics 06:14:07 ERROR - PROCESS | 31991 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:14:08 INFO - TEST-INFO | 31991: exit 0 06:14:08 INFO - Browser initialized. 06:14:08 INFO - Running cycle 1/1 for kraken test... 06:14:08 INFO - TEST-INFO | started process 32072 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW1gHu2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:14:20 INFO - PROCESS | 32072 | RSS: Main: 153919488 06:14:20 INFO - PROCESS | 32072 | 06:14:23 INFO - PROCESS | 32072 | Cycle 1(1): loaded http://localhost:50639/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50639/tests/kraken/driver.html?testName=audio-beat-detection) 06:14:23 INFO - PROCESS | 32072 | RSS: Main: 209047552 06:14:23 INFO - PROCESS | 32072 | 06:14:26 INFO - PROCESS | 32072 | Cycle 1(1): loaded http://localhost:50639/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50639/tests/kraken/driver.html?testName=audio-dft) 06:14:27 INFO - PROCESS | 32072 | RSS: Main: 195653632 06:14:27 INFO - PROCESS | 32072 | 06:14:30 INFO - PROCESS | 32072 | Cycle 1(1): loaded http://localhost:50639/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50639/tests/kraken/driver.html?testName=audio-fft) 06:14:30 INFO - PROCESS | 32072 | RSS: Main: 265609216 06:14:30 INFO - PROCESS | 32072 | 06:14:32 INFO - PROCESS | 32072 | Cycle 1(1): loaded http://localhost:50639/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50639/tests/kraken/driver.html?testName=audio-oscillator) 06:14:33 INFO - PROCESS | 32072 | RSS: Main: 174145536 06:14:33 INFO - PROCESS | 32072 | 06:14:35 INFO - PROCESS | 32072 | Cycle 1(1): loaded http://localhost:50639/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50639/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:14:36 INFO - PROCESS | 32072 | RSS: Main: 178409472 06:14:36 INFO - PROCESS | 32072 | 06:14:39 INFO - PROCESS | 32072 | Cycle 1(1): loaded http://localhost:50639/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50639/tests/kraken/driver.html?testName=imaging-darkroom) 06:14:39 INFO - PROCESS | 32072 | RSS: Main: 213753856 06:14:39 INFO - PROCESS | 32072 | 06:14:43 INFO - PROCESS | 32072 | Cycle 1(1): loaded http://localhost:50639/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50639/tests/kraken/driver.html?testName=imaging-desaturate) 06:14:43 INFO - PROCESS | 32072 | RSS: Main: 214765568 06:14:43 INFO - PROCESS | 32072 | 06:14:46 INFO - PROCESS | 32072 | Cycle 1(1): loaded http://localhost:50639/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50639/tests/kraken/driver.html?testName=json-parse-financial) 06:14:47 INFO - PROCESS | 32072 | RSS: Main: 214687744 06:14:47 INFO - PROCESS | 32072 | 06:14:48 INFO - PROCESS | 32072 | Cycle 1(1): loaded http://localhost:50639/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50639/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:14:49 INFO - PROCESS | 32072 | RSS: Main: 202158080 06:14:49 INFO - PROCESS | 32072 | 06:14:51 INFO - PROCESS | 32072 | Cycle 1(1): loaded http://localhost:50639/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50639/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:14:51 INFO - PROCESS | 32072 | RSS: Main: 204394496 06:14:51 INFO - PROCESS | 32072 | 06:14:53 INFO - PROCESS | 32072 | Cycle 1(1): loaded http://localhost:50639/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50639/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:14:54 INFO - PROCESS | 32072 | RSS: Main: 214544384 06:14:54 INFO - PROCESS | 32072 | 06:14:57 INFO - PROCESS | 32072 | Cycle 1(1): loaded http://localhost:50639/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50639/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:14:57 INFO - PROCESS | 32072 | RSS: Main: 222093312 06:14:57 INFO - PROCESS | 32072 | 06:15:00 INFO - PROCESS | 32072 | Cycle 1(1): loaded http://localhost:50639/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50639/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:15:01 INFO - PROCESS | 32072 | RSS: Main: 219254784 06:15:01 INFO - PROCESS | 32072 | 06:15:02 INFO - PROCESS | 32072 | Cycle 1(1): loaded http://localhost:50639/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50639/tests/kraken/driver.html?testName=ai-astar) 06:15:03 INFO - PROCESS | 32072 | RSS: Main: 282603520 06:15:03 INFO - PROCESS | 32072 | 06:15:03 INFO - PROCESS | 32072 | __start_tp_report 06:15:03 INFO - PROCESS | 32072 | _x_x_mozilla_page_load 06:15:03 INFO - PROCESS | 32072 | _x_x_mozilla_page_load_details 06:15:03 INFO - PROCESS | 32072 | |i|pagename|runs| 06:15:03 INFO - PROCESS | 32072 | |0;ai-astar;111;111;106;111;113;112;100;111;110;110 06:15:03 INFO - PROCESS | 32072 | |1;audio-beat-detection;153;132;155;198;128;155;151;128;177;135 06:15:03 INFO - PROCESS | 32072 | |2;audio-dft;162;161;161;161;160;166;163;162;163;161 06:15:03 INFO - PROCESS | 32072 | |3;audio-fft;75;77;122;124;74;74;73;122;105;72 06:15:03 INFO - PROCESS | 32072 | |4;audio-oscillator;93;92;152;93;92;92;149;94;93;152 06:15:03 INFO - PROCESS | 32072 | |5;imaging-gaussian-blur;117;117;117;117;116;116;116;117;117;117 06:15:03 INFO - PROCESS | 32072 | |6;imaging-darkroom;145;145;146;145;145;145;145;146;146;145 06:15:03 INFO - PROCESS | 32072 | |7;imaging-desaturate;94;94;94;95;94;94;95;95;95;95 06:15:03 INFO - PROCESS | 32072 | |8;json-parse-financial;60;61;59;60;61;58;60;79;57;58 06:15:03 INFO - PROCESS | 32072 | |9;json-stringify-tinderbox;61;62;62;62;62;62;62;62;62;62 06:15:03 INFO - PROCESS | 32072 | |10;stanford-crypto-aes;76;77;77;76;77;78;78;79;77;77 06:15:03 INFO - PROCESS | 32072 | |11;stanford-crypto-ccm;131;128;126;125;126;131;125;138;169;127 06:15:03 INFO - PROCESS | 32072 | |12;stanford-crypto-pbkdf2;171;168;174;173;171;167;165;173;175;173 06:15:03 INFO - PROCESS | 32072 | |13;stanford-crypto-sha256-iterative;70;69;69;69;69;69;71;68;67;70 06:15:03 INFO - PROCESS | 32072 | __end_tp_report 06:15:03 INFO - PROCESS | 32072 | __start_cc_report 06:15:03 INFO - PROCESS | 32072 | _x_x_mozilla_cycle_collect,1636 06:15:03 INFO - PROCESS | 32072 | __end_cc_report 06:15:03 INFO - PROCESS | 32072 | __startTimestamp1461417303024__endTimestamp 06:15:03 INFO - PROCESS | 32072 | 06:15:03 INFO - PROCESS | 32072 | ------- Summary: start ------- 06:15:03 INFO - PROCESS | 32072 | Number of tests: 14 06:15:03 INFO - PROCESS | 32072 | 06:15:03 INFO - PROCESS | 32072 | [#0] ai-astar Cycles:10 Average:109.50 Median:111.00 stddev:3.81 (3.4%) stddev-sans-first:4.00 06:15:03 INFO - PROCESS | 32072 | Values: 111.0 111.0 106.0 111.0 113.0 112.0 100.0 111.0 110.0 110.0 06:15:03 INFO - PROCESS | 32072 | 06:15:03 INFO - PROCESS | 32072 | [#1] audio-beat-detection Cycles:10 Average:151.20 Median:154.00 stddev:22.60 (14.7%) stddev-sans-first:23.96 06:15:03 INFO - PROCESS | 32072 | Values: 153.0 132.0 155.0 198.0 128.0 155.0 151.0 128.0 177.0 135.0 06:15:03 INFO - PROCESS | 32072 | 06:15:03 INFO - PROCESS | 32072 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.70 (1.0%) stddev-sans-first:1.80 06:15:03 INFO - PROCESS | 32072 | Values: 162.0 161.0 161.0 161.0 160.0 166.0 163.0 162.0 163.0 161.0 06:15:03 INFO - PROCESS | 32072 | 06:15:03 INFO - PROCESS | 32072 | [#3] audio-fft Cycles:10 Average:91.80 Median:73.50 stddev:23.37 (31.8%) stddev-sans-first:23.98 06:15:03 INFO - PROCESS | 32072 | Values: 75.0 77.0 122.0 124.0 74.0 74.0 73.0 122.0 105.0 72.0 06:15:03 INFO - PROCESS | 32072 | 06:15:03 INFO - PROCESS | 32072 | [#4] audio-oscillator Cycles:10 Average:110.20 Median:92.50 stddev:28.17 (30.5%) stddev-sans-first:29.19 06:15:03 INFO - PROCESS | 32072 | Values: 93.0 92.0 152.0 93.0 92.0 92.0 149.0 94.0 93.0 152.0 06:15:03 INFO - PROCESS | 32072 | 06:15:03 INFO - PROCESS | 32072 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 06:15:03 INFO - PROCESS | 32072 | Values: 117.0 117.0 117.0 117.0 116.0 116.0 116.0 117.0 117.0 117.0 06:15:03 INFO - PROCESS | 32072 | 06:15:03 INFO - PROCESS | 32072 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 06:15:03 INFO - PROCESS | 32072 | Values: 145.0 145.0 146.0 145.0 145.0 145.0 145.0 146.0 146.0 145.0 06:15:03 INFO - PROCESS | 32072 | 06:15:03 INFO - PROCESS | 32072 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 06:15:03 INFO - PROCESS | 32072 | Values: 94.0 94.0 94.0 95.0 94.0 94.0 95.0 95.0 95.0 95.0 06:15:03 INFO - PROCESS | 32072 | 06:15:03 INFO - PROCESS | 32072 | [#8] json-parse-financial Cycles:10 Average:61.30 Median:60.00 stddev:6.36 (10.6%) stddev-sans-first:6.73 06:15:03 INFO - PROCESS | 32072 | Values: 60.0 61.0 59.0 60.0 61.0 58.0 60.0 79.0 57.0 58.0 06:15:03 INFO - PROCESS | 32072 | 06:15:03 INFO - PROCESS | 32072 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:62.00 stddev:0.32 (0.5%) stddev-sans-first:0.00 06:15:03 INFO - PROCESS | 32072 | Values: 61.0 62.0 62.0 62.0 62.0 62.0 62.0 62.0 62.0 62.0 06:15:03 INFO - PROCESS | 32072 | 06:15:03 INFO - PROCESS | 32072 | [#10] stanford-crypto-aes Cycles:10 Average:77.20 Median:77.00 stddev:0.92 (1.2%) stddev-sans-first:0.87 06:15:03 INFO - PROCESS | 32072 | Values: 76.0 77.0 77.0 76.0 77.0 78.0 78.0 79.0 77.0 77.0 06:15:03 INFO - PROCESS | 32072 | 06:15:03 INFO - PROCESS | 32072 | [#11] stanford-crypto-ccm Cycles:10 Average:132.60 Median:129.50 stddev:13.39 (10.3%) stddev-sans-first:14.19 06:15:03 INFO - PROCESS | 32072 | Values: 131.0 128.0 126.0 125.0 126.0 131.0 125.0 138.0 169.0 127.0 06:15:03 INFO - PROCESS | 32072 | 06:15:03 INFO - PROCESS | 32072 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.00 Median:173.00 stddev:3.30 (1.9%) stddev-sans-first:3.50 06:15:03 INFO - PROCESS | 32072 | Values: 171.0 168.0 174.0 173.0 171.0 167.0 165.0 173.0 175.0 173.0 06:15:03 INFO - PROCESS | 32072 | 06:15:03 INFO - PROCESS | 32072 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.00 stddev:1.10 (1.6%) stddev-sans-first:1.12 06:15:03 INFO - PROCESS | 32072 | Values: 70.0 69.0 69.0 69.0 69.0 69.0 71.0 68.0 67.0 70.0 06:15:03 INFO - PROCESS | 32072 | -------- Summary: end -------- 06:15:03 INFO - PROCESS | 32072 | 06:15:03 INFO - TEST-INFO | 32072: exit 0 06:15:03 INFO - TEST-OK | kraken | took 60810ms 06:15:03 INFO - SUITE-END | took 1172s 06:15:04 INFO - Completed test suite (00:19:33) 06:15:04 INFO - javascript benchmark 06:15:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3108.766842486814, 3146.1977195815066, 3186.426443240216, 3188.5057816038507, 3205.9358812823752, 5209.296744939432, 5301.681899086047, 5319.547838433733, 5356.3036805215315, 5391.433899440561, 5335.893282134355, 5355.08963476209, 5369.301990741198, 5402.189671549259, 5421.620486565942, 4746.738929358884, 4785.353977213083, 4869.342638743778, 4917.21324588066, 4941.061198372297, 4860.4896485869, 4891.1195984722735, 4917.213245880642, 4917.557419832215, 4931.901361972758, 4662.277347011219, 4718.764061796914, 4805.111054454919, 4833.323334733105, 4854.514548545152, 4821.807127714887, 4841.782119804618, 4841.8547443576745, 4867.2212446008825, 4889.119958407486, 4733.857984260478, 4807.543283388072, 4823.927641085386, 4827.758612069382, 4860.222364421676, 5248.396434410015, 5289.576833853283, 5295.549878260353, 5307.548858347045, 5365.531855346545, 5659.349174844863, 5670.461306175906, 5706.28671416073, 5706.400827913051, 5707.800226992035, 5558.610897237155, 5718.571107166979, 5733.741981610796, 5758.078707406837, 5818.912716309259, 5317.973410132925, 5318.282031925718, 5322.095243808523, 5322.813701520467, 5331.546818520431, 5786.855328616818, 5789.0, 5792.739326730307, 5799.101139323411, 5827.125931110368, 5530.059889818741, 5573.888522229533, 5594.496495315359, 5600.439956004367, 5646.181303711021, 5550.139728342114, 5554.91667624986, 5555.694436805934, 5558.055130627803, 5564.610477266633, 5548.334199896039, 5549.361823390281, 5550.86122846924, 5551.25058117149, 5601.6358936668985, 5578.219049333096, 5613.242212301287, 5641.407652196543, 5643.661380317194, 5693.601447898607, 4329.372241025034, 4330.675199360061, 4336.089421221515, 4346.1090476452255, 4385.824567017284, 3786.6213378662464, 3859.0, 3894.045958740127, 3930.194310166409, 3935.0752573145287, 5302.2046692996355, 5382.838514844561, 5418.91871621926, 5431.321084864392, 5432.837014889559, 5617.8595535111135, 5655.802046928337, 5663.32040155184, 5672.092465205547, 5680.886382272414, 5247.527722504993, 5299.0, 5335.1730481775385, 5353.491418315254, 5401.378841433286, 4877.317175595419, 4910.361652985161, 4920.065187614414, 4959.107360675113, 4959.677620954626, 5804.129380592861, 5822.475977161991, 5826.388229235869, 5828.708564571754, 5837.474627283565, 5476.863078422912, 5626.0, 5656.88686226265, 5659.179418984307, 5720.885582288414, 5836.212111365081, 5841.240638716939, 5867.853303667272, 5899.410058994066, 5900.734466948912, 5580.693061881636, 5583.553315734813, 5599.972000139973, 5620.297462817148, 5626.099824028136, 5472.069748142746, 5679.716014199191, 5710.828675139753, 5719.542436604978, 5726.284214473191, 5563.388027316911, 5597.3003374578175, 5606.915896261641, 5634.0, 5658.858528536654, 5530.6128570999645, 5551.805686800943, 5556.472135147154, 5561.082421400423, 5565.1095824667855, 5371.194320851903, 5463.808766693147, 5485.807996720096, 5486.945130548644, 5520.392756796829, 5601.551875850004, 5621.128725047624, 5627.071533196977, 5632.464915832989, 5681.857953551029, 5462.8361149165585, 5492.780288788404, 5504.614676972574, 5510.559155267489, 5546.112621980464], "value": 5238.24504222768, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [608.6926102318331, 648.2998361769289, 655.3806652713185, 657.4773055420943, 662.6090606542139, 30107.24731881704, 36997.0, 37803.99999999996, 38090.8095459523, 38107.0, 39693.80153099238, 40034.0, 40357.59642403575, 40468.39297410541, 40512.0, 7711.344535714471, 7952.20477952206, 8468.322534197281, 8673.176048275403, 8675.045744968049, 10065.547050382715, 10534.367937923711, 10537.209709271798, 10544.47277636119, 10545.894541054606, 10083.899161008407, 10193.490325483734, 10193.847092293621, 10194.0, 10195.235357348229, 8098.068722096946, 10185.949070254639, 10240.539175737034, 10630.096441802456, 10630.415327157003, 10033.44816035125, 10154.238432117621, 10168.389896606228, 10168.59325626974, 10184.694459166238, 36283.27433451343, 36709.26581468382, 36786.448203276705, 36790.44814327787, 36813.81593092044, 3408.812515311657, 3434.364642541138, 3467.5665541807275, 3704.8888533344043, 3904.629060239273, 31603.841980790177, 31841.0, 31988.360232795214, 32269.83865080683, 33155.6684433155, 3744.2885851688093, 3848.7883166425836, 3904.6876249900224, 3905.726599138033, 3991.2217117662067, 314216.0, 314765.0, 314984.0, 315624.0, 317565.5338956356, 55513.444865550824, 55596.386234894606, 55957.44042559604, 56062.71968640131, 56063.0, 53384.46615533795, 53617.7319113402, 53624.19563706547, 53700.46299536955, 53749.0, 14796.260186990607, 15129.167895765619, 15172.317245723969, 15183.62040948963, 15185.772213416807, 13062.54281100176, 13066.281354525592, 13109.410076546388, 13135.408906599036, 13140.934295328654, 15542.145182014872, 15652.452164174427, 15675.137867417174, 15677.764833527506, 15785.605359866095, 5034.295198672189, 5672.319321681424, 5848.941510584925, 5940.673262970492, 6010.609310394811, 1048.2243140076441, 1090.1170052257696, 1096.4791723931069, 1104.9337039777638, 1201.4173126033866, 30941.845290773403, 30953.53569696456, 31128.377432451678, 31435.84282078575, 31678.208044799063, 1109.2678831970861, 1121.9158563107799, 1123.7078359626391, 1203.9097067719956, 1227.8342423772856, 14262.3581938813, 14905.0, 15111.0, 15236.771448428282, 15395.0, 508889.0, 514239.0, 514258.0, 516489.0, 517150.0, 53185.734071329396, 53466.198007029925, 53486.0, 53598.196027059625, 53644.19533706998, 1353.3977380065776, 1378.572642480814, 1405.901586888908, 1410.5133728863525, 1425.6435891027243, 27623.723762762114, 28584.857075714488, 28711.0, 29569.112926612237, 29573.852130739207, 46170.53829461662, 52961.0, 55147.0, 55216.61958451071, 55276.44723552713, 358423.0, 358482.0, 361568.0, 362357.0, 364130.0, 24611.63082553727, 26844.463110738066, 27076.1877143686, 27626.5856012164, 27673.723262767115, 41001.17997639971, 42162.0, 42277.78861105675, 45207.773961129984, 45980.310295346266, 38037.61962380341, 38108.0, 38147.809260953516, 38420.61579384282, 38591.42112868253, 33684.831575842945, 33763.662363377036, 34170.31659366749, 34190.14524636904, 34391.4841277376, 37891.62108378991, 38008.429873551366, 38393.80803095967, 39705.0, 40866.38700419555, 29760.0, 31491.52762708607, 31791.841040794647, 31861.68138318587, 33688.83155584305, 26346.473070538865, 26777.8661106701, 26916.73083269142, 27260.863695681393, 28001.859990699915], "value": 19163.165511783012, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.4183185986493, 376.29820384982014, 386.6520131881306, 390.826082393335, 399.36700329976986, 14849.703005939875, 16389.180540972964, 16542.751858722113, 17665.64668706625, 17687.73468397975, 16777.496675099766, 16915.746263806053, 17461.21424535896, 17669.0, 17717.1141442928, 4940.25896115582, 5074.517920797518, 5103.311053007834, 5104.821331253407, 5106.336176297076, 5042.268871013701, 5089.185730283156, 5188.766505507242, 5512.0, 5515.7242137893145, 5371.704556249405, 5484.122540393538, 5489.835304940858, 5491.670499770026, 5510.972445137789, 5627.80302689408, 5654.46282603152, 5655.349634792011, 5680.460356266148, 5682.460166284196, 5296.417394086648, 5419.647722897999, 5475.123980163195, 5478.506934375885, 5483.259759932438, 12099.879001209963, 12617.810732839014, 12679.873201268054, 12805.10364274501, 12835.743285134338, 2236.563870045342, 2280.213326402405, 2393.1504315967927, 2409.0965887792077, 2555.0163187172884, 9820.90179098207, 10085.294029417944, 10119.89880101197, 10126.088652021353, 13686.863131368658, 1899.9525011874675, 1940.640981418428, 1955.9608807823906, 1983.702444633302, 2002.9899850500653, 49266.50733492691, 65137.67431162861, 65680.3431965679, 75138.24861751367, 76197.61901190458, 10161.339512931636, 10460.947695261628, 10556.419396933088, 10659.0, 10776.29954052984, 14991.175485348193, 15029.849701502844, 15056.623584410258, 15064.548063558112, 15067.773983390258, 7952.1650226726515, 8135.593220338959, 8182.836343273101, 8279.62741676626, 8296.585170741439, 7934.960325198337, 7953.920460795433, 7991.761277002074, 8051.315638170704, 8105.513669179868, 4534.229181039232, 4605.4933957264675, 4610.077984403133, 4627.768611569408, 4644.883877903012, 1888.2541396148445, 1930.2086144680895, 1944.601356721897, 1947.0793809286072, 1967.4097770668743, 429.10317436557744, 442.26583870775005, 948.4309414351472, 1053.3258714422775, 1114.2701530497536, 10825.188110891715, 11075.501602427748, 11166.106711463064, 11212.719682008015, 11376.203665743318, 451.69510580358127, 455.24202203331083, 457.31174582253493, 458.45901835834036, 479.72176137839966, 5730.942690573041, 5999.460048595647, 6030.7889223876955, 6055.666938318347, 6106.877862442726, 437979.0, 442062.0, 446534.76732616127, 506206.0, 525123.0, 93234.0, 95318.0, 95492.52253738687, 96273.0, 98369.0, 450.4437020279952, 450.5989669194354, 450.93461448089846, 455.2352048558454, 456.21530966737157, 10031.899681003388, 10100.444475553915, 10293.794124117625, 10358.533865975898, 10401.27191096616, 33780.0, 34651.48022779711, 35873.28253434969, 35977.82011089928, 36067.45898811572, 52506.0, 52938.73530632322, 53008.0, 53947.730261350014, 54117.72941135269, 4828.7102773833685, 4915.4592994771265, 7921.683132674629, 8086.595670216583, 8792.29661627081, 10974.890251097706, 13413.66465838362, 13694.863051369359, 13754.174749515061, 13907.930460348038, 11669.0, 11857.881421186023, 11907.46416411281, 12051.51793928233, 12199.3290369027, 11744.58893938708, 11838.82241766357, 11923.940380298043, 12233.69415764613, 12245.265284082983, 11675.591354302558, 11706.648800535997, 11733.296002239893, 11998.160128790902, 12541.31022793755, 8452.74641760748, 8486.278666313432, 8537.274331681876, 8662.393632445668, 8745.207232517192, 11526.366049867001, 11789.115816313639, 12095.57665481739, 12169.20900141488, 12181.208221465577], "value": 7978.634108963678, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1362.9863701362983, 1488.9851101488982, 1498.3631956418524, 1626.2925627352095, 1789.5526118470382, 7597.506162099459, 7850.528968261894, 7856.96071519643, 7864.803379915505, 7871.9606401967985, 7731.265529774662, 7867.0, 7869.016372953381, 7875.369970402368, 7877.0, 1932.3333449959741, 1994.2820584589535, 1994.3717728915417, 2248.325502349297, 2278.6582012698063, 2300.5168914527967, 2346.9530609387803, 2361.5985282502015, 2366.349253955159, 2372.7271363793125, 2253.4704344479032, 2258.3112150794, 2260.977390226093, 2265.2524666859895, 2314.537092581482, 1972.0632699467637, 2225.121077174515, 2229.375774783063, 2239.294622194012, 2242.0583354990863, 2298.988505057481, 2325.9069637214493, 2327.464683122891, 2329.114936324203, 2329.2662811214414, 8000.039995200613, 8038.236367545074, 8042.0, 8055.395845311625, 8057.5165490070785, 4771.856844294677, 4929.433115191763, 4941.505849415065, 4968.726720030397, 4970.527799859007, 3132.733717634004, 3222.081706713599, 3324.2852786650988, 3336.5495658086093, 3348.5981682198294, 1084.8318510630866, 1089.1939964426347, 1091.8471414002047, 1091.867282336361, 1111.8109921313396, 11163.888361116366, 11174.0, 11182.496787644657, 11187.608433704863, 11207.271527350696, 4247.638950689165, 4441.911161776747, 4478.686491945533, 4528.456585209796, 4531.252343363374, 9611.423314601147, 9645.807083858284, 9654.806903861883, 9655.710328690151, 9666.661666841768, 5045.394552653705, 5057.089723849669, 5058.645894787403, 5080.314157588752, 5080.441151473335, 4114.6091121343425, 4149.211649786531, 4567.429071366079, 4668.393108895822, 4678.532146785295, 3797.5632802228097, 3807.447920051577, 3906.7851268180525, 3912.7456715313983, 3923.6468717815533, 1249.762545116425, 1265.544404014554, 1272.739088486858, 1274.4710944957924, 1286.85201201863, 868.7654333329965, 957.0859828863419, 964.392432767352, 990.5740531571349, 1017.7913527726798, 5580.469855363734, 5716.42835716425, 5740.512056475163, 5819.738111784895, 5882.176495290662, 410.25333892316297, 410.3209188792553, 416.1925863824171, 420.05487652781244, 425.7105168485398, 3938.2320447513034, 3956.1098752780968, 3996.500437445319, 4007.859724909614, 4049.635532802062, 9806.705798826046, 10174.593016279267, 10257.948710256402, 10265.178785697126, 10285.691429257135, 10095.293329466867, 10179.389236645826, 10188.337758045704, 10216.642417515352, 10216.948915255376, 7666.118396384376, 7711.730089446843, 7711.768646940601, 7726.536407815549, 7739.651715672809, 5463.617546771688, 5517.36550296721, 5604.747786349542, 5622.634528755618, 5661.943380566142, 9211.539423028687, 9331.72004839856, 9355.06449355059, 9359.438433694, 9459.243260539279, 9218.815623687622, 9332.20676242527, 9470.763230919281, 9499.715008549754, 9682.612695492102, 6586.703598338182, 6968.65156742171, 7197.352238298578, 7198.596273726573, 7203.855922881408, 7801.648925798239, 7837.1770964047955, 7855.175206603224, 7881.290683838482, 7904.170062143392, 6917.827054323682, 6968.303169682991, 7011.3339232772805, 7152.821179470347, 7183.8563228736175, 7137.321954414322, 7234.819129521804, 7246.384057355184, 7276.744174474662, 7305.159906610807, 6481.222253329631, 6564.9671751640935, 6574.0796288520605, 6581.177352830896, 6581.506387020897, 4836.637252206169, 4869.318295438712, 4892.094962431819, 4998.825041123689, 5001.899962000667, 4728.030753695553, 4779.0, 4906.994066216345, 4963.503649635008, 5066.290719299374], "value": 4301.333218478625, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.15663744177476, 329.8087109476504, 332.0470250381405, 335.70793409733534, 336.18307512744036, 5726.484616384525, 5798.3331916829575, 5816.33112192098, 5832.6792026438525, 5851.2100866383025, 5719.571032172583, 5742.138679198112, 5752.367239603651, 5753.194552762617, 5753.913691294623, 4160.583941605845, 4221.282381995053, 4436.755978421185, 4439.378487011805, 4452.7328360298325, 4407.338899165119, 4426.911461770763, 4433.334999750031, 4435.62297204738, 4445.599896009358, 4125.278076336629, 4398.098389830077, 4415.911681766363, 4419.9337009944875, 4422.159789639974, 4277.422547956017, 4401.933970990438, 4406.47122345319, 4409.096135292258, 4424.159409712144, 3854.2291541691775, 3862.9613703862883, 3876.9806150969066, 3882.0, 3897.0, 5382.730863456851, 5509.338879334466, 5536.7231638418325, 5546.0, 5551.8889622207735, 5058.620603454756, 5072.0870243356185, 5074.13739664258, 5076.746162691888, 5090.974545127251, 5860.296764388258, 5925.259342582177, 5928.644281343133, 5947.434993675594, 5964.7315870785915, 3952.288588054149, 4246.723962942429, 4260.68044896634, 4261.718476772868, 4271.081717430768, 6166.105914642397, 6220.87558248837, 6232.501399887998, 6250.656213908233, 6268.623882567015, 4153.771542565188, 4194.412782210493, 4200.432941552851, 4200.474940632421, 4209.116085621992, 4086.978255436141, 4231.280682284019, 4241.981924338198, 4251.872443826628, 4255.127698821796, 4970.602351811846, 4991.47589503097, 4992.450830408652, 4995.875103122451, 5010.3737032870895, 6041.72812223451, 6049.879002419927, 6053.243344581927, 6066.848328791727, 6108.083787431832, 1395.6022533578084, 1464.1727424005403, 1491.8959969622401, 1499.2054211268046, 1502.5725560717362, 886.7561420609384, 981.7741919358588, 982.6413359123868, 1005.2259759984771, 1007.652359935821, 5743.396943320975, 5743.885122297531, 5757.827265182052, 5767.8558036049435, 5787.681677507778, 6151.2618485781095, 6160.414760597736, 6161.106639537242, 6182.6599537025895, 6186.969065154645, 5597.944020559742, 5791.391903850119, 5893.587448878623, 5900.852478688067, 5903.822885313361, 3296.7692261541943, 3330.633630300665, 3333.616634087111, 3343.3814744272386, 3355.832208389571, 6268.623882567061, 6469.482441404676, 6480.416762491304, 6486.902696459557, 6489.091527186198, 6267.96866015667, 6281.748730050838, 6355.523335749837, 6387.552871299057, 6394.904076438857, 6105.328413874559, 6388.233411990591, 6393.1369265148605, 6402.135711678957, 6407.7757278495965, 6183.0, 6199.876002480015, 6215.316315205414, 6216.0, 6238.438540531374, 6154.692265386802, 6164.260288765377, 6169.2288463942, 6199.876002480015, 6209.161763162096, 6291.955114587869, 6373.904391434039, 6411.679416029273, 6466.159399278064, 6469.708863101077, 4138.358554424069, 4166.0, 4181.741859396014, 4203.76879271643, 4208.263553878121, 6083.452489275986, 6248.375162483897, 6269.780557680459, 6272.341404152498, 6294.653794041372, 6051.878962420815, 6064.211652485149, 6067.211262535842, 6069.666168360783, 6073.878522429438, 6018.879622407615, 6019.699015049143, 6032.306284777307, 6042.818715438544, 6059.424354686298, 5685.289338832646, 5805.245318108618, 5819.970900145472, 5927.970360148344, 5975.103734439869, 6057.4851137653795, 6085.604435711664, 6099.969500152471, 6114.38856114385, 6117.388261173847, 5675.489205971482, 5935.169076329404, 5956.255468066492, 5957.970210148921, 5965.940340596539], "value": 4542.376000546305, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [750.2609929219719, 761.4365369626478, 829.6059371798397, 835.0008646458655, 838.4759525296689, 14238.216898070603, 14453.783193252097, 14505.0, 14518.274086295683, 14538.34577444015, 13643.249621270827, 13922.095063820845, 14056.71886562268, 14072.507462238824, 14088.71822563548, 778.579567033801, 785.0461689047805, 785.6778720724504, 788.787027502574, 788.858005559002, 601.7232073246312, 787.3189690917344, 796.5738329993454, 796.7808852565532, 800.5036877136183, 834.5743670727942, 834.7287131682198, 835.8495470815251, 839.5718183726314, 855.4097672605914, 697.849962258117, 827.8054657155594, 828.0518805967195, 832.3715594725974, 847.6270441005938, 600.9879802403971, 601.0683440666993, 601.2244204975576, 602.5962605054624, 610.9419605137505, 14341.13953162803, 14392.496262630862, 14407.567772966722, 14469.78295325571, 14480.275986200648, 12669.429875655618, 13267.270300133488, 13288.933555332258, 13449.529266475627, 13532.458701651922, 10585.841212381743, 10857.3485590864, 10872.891271087266, 11038.944805276002, 11148.832767508413, 3759.661630453272, 3849.1147036181833, 3851.1912498375373, 3856.132370216707, 3886.4753258310334, 57297.71351143218, 57325.713371433296, 57429.425705742826, 57559.71220143914, 57595.99999999958, 9752.561134748954, 9806.166475849634, 9850.655227067018, 10000.0, 10208.438535880598, 18353.63292734138, 18360.265589376544, 18404.26382944694, 18439.0, 18442.170102345426, 8045.316148127357, 8069.354451643854, 8306.293965012921, 8380.8742868857, 8633.266172375419, 4555.544445555418, 4564.84023059198, 4603.332516785047, 4701.318308845267, 4728.716277023321, 3334.6498617645284, 3361.932761344808, 3399.6600339965808, 3412.590489141319, 3421.4183588789965, 579.5884921705637, 594.5422025040781, 595.8916415467228, 604.4348534120611, 618.2951435363689, 760.8440269744689, 761.5621017914722, 762.4815125714567, 775.1550809617544, 793.888855560222, 8715.864613169813, 9424.0, 9524.428534287827, 9534.809303813885, 9696.563654635418, 732.2201855024382, 738.7340557399332, 758.3819187362282, 763.4770182425057, 771.086262778598, 4178.91642167155, 4360.803763830635, 4380.496242932104, 4413.404190434315, 4528.207563676344, 54151.72924135354, 56021.1596826048, 65526.0, 66291.66854165794, 66351.66824165944, 52624.0, 53484.46515534873, 53677.463225367246, 54991.725041374535, 55800.72099639557, 48249.0, 49835.25247121369, 50148.24777628339, 50969.0, 51035.23447148296, 9420.246380289698, 9564.713058608253, 9616.672204891262, 9631.9036809631, 9697.5151242439, 34001.48997765085, 34674.65325346714, 34938.30123397569, 35183.64816351804, 36050.0, 44481.55518444903, 47085.76457117692, 47485.0, 47594.52405475901, 49850.501494986034, 12248.081393895316, 12261.062519279169, 12281.078919081283, 12329.69175770577, 12408.193467424588, 13131.474741010252, 13446.99147563917, 13776.448942042607, 14099.929500352433, 14382.35279412408, 12880.742385152433, 13283.66790830237, 13498.055136140376, 13796.310184490936, 13920.373583188579, 12381.62855114348, 12794.104412691022, 13000.739985200433, 13061.542846000344, 13299.66750831237, 12275.75448491043, 12339.197952133083, 12829.61511154667, 12999.285039322927, 13106.565770085357, 10256.487175641338, 10701.571937122428, 10704.411257380918, 10778.838317425088, 10837.0, 10563.679540057492, 10800.189985751258, 10829.51267192994, 10877.945610271898, 10892.61875834342], "value": 6746.54005044617, "unit": "score"}], "name": "dromaeo_css", "value": 6874.880170756947, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 106.0, 111.0, 113.0, 112.0, 100.0, 111.0, 110.0, 110.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 132.0, 155.0, 198.0, 128.0, 155.0, 151.0, 128.0, 177.0, 135.0], "value": 151.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 161.0, 160.0, 166.0, 163.0, 162.0, 163.0, 161.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 122.0, 124.0, 74.0, 74.0, 73.0, 122.0, 105.0, 72.0], "value": 91.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 152.0, 93.0, 92.0, 92.0, 149.0, 94.0, 93.0, 152.0], "value": 110.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0], "value": 116.7, "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, 146.0, 145.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 59.0, 60.0, 61.0, 58.0, 60.0, 79.0, 57.0, 58.0], "value": 61.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 76.0, 77.0, 78.0, 78.0, 79.0, 77.0, 77.0], "value": 77.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 128.0, 126.0, 125.0, 126.0, 131.0, 125.0, 138.0, 169.0, 127.0], "value": 132.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 168.0, 174.0, 173.0, 171.0, 167.0, 165.0, 173.0, 175.0, 173.0], "value": 171.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 69.0, 69.0, 69.0, 69.0, 71.0, 68.0, 67.0, 70.0], "value": 69.1, "unit": "score"}], "name": "kraken", "value": 1554.3, "alertThreshold": 2.0}]} 06:15:04 INFO - Return code: 0 06:15:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:15:04 ERROR - # TBPL SUCCESS # 06:15:04 INFO - Running post-action listener: _resource_record_post_action 06:15:04 INFO - Running post-run listener: _resource_record_post_run 06:15:05 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 536981504; Read time: 12; Write time: 478572 06:15:05 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244637696; Read time: 0; Write time: 260532 06:15:05 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292343808; Read time: 12; Write time: 218040 06:15:05 INFO - Running post-run listener: _upload_blobber_files 06:15:05 INFO - Blob upload gear active. 06:15:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:15:05 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 06:15:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:15:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:15:05 INFO - (blobuploader) - INFO - Open directory for files ... 06:15:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:15:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:15:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:15:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:15:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:15:06 INFO - (blobuploader) - INFO - Done attempting. 06:15:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:15:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:15:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:15:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:15:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:15:07 INFO - (blobuploader) - INFO - Done attempting. 06:15:07 INFO - (blobuploader) - INFO - Iteration through files over. 06:15:07 INFO - Return code: 0 06:15:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:15:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:15:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7064f8a579e5f83475fa9a2f311f4ae48ecf7e25cb10ab81c9285c7735bab3ce62e4b160c063fce64daf3a67e0c02a5ee20e44399f68d1092249b858a62ad47", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db713ed60cc5e948bbdfc91e4d23d8a1028e808a49cb5fa76263bc60666d9dbc7cc0c0405bdf11744955d8bcf2effe20ed2ceca28365cbbc332a2bb1b8170c1d"} 06:15:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:15:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:15:07 INFO - Contents: 06:15:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7064f8a579e5f83475fa9a2f311f4ae48ecf7e25cb10ab81c9285c7735bab3ce62e4b160c063fce64daf3a67e0c02a5ee20e44399f68d1092249b858a62ad47", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db713ed60cc5e948bbdfc91e4d23d8a1028e808a49cb5fa76263bc60666d9dbc7cc0c0405bdf11744955d8bcf2effe20ed2ceca28365cbbc332a2bb1b8170c1d"} 06:15:07 INFO - Running post-run listener: copy_logs_to_upload_dir 06:15:07 INFO - Copying logs to upload dir... 06:15:07 INFO - mkdir: /builds/slave/test/build/upload/logs 06:15:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.545861 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-04-23 06:15:07.370729) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-23 06:15:07.374119) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1461411049.682967-641148017 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7064f8a579e5f83475fa9a2f311f4ae48ecf7e25cb10ab81c9285c7735bab3ce62e4b160c063fce64daf3a67e0c02a5ee20e44399f68d1092249b858a62ad47", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db713ed60cc5e948bbdfc91e4d23d8a1028e808a49cb5fa76263bc60666d9dbc7cc0c0405bdf11744955d8bcf2effe20ed2ceca28365cbbc332a2bb1b8170c1d"} build_url:https://queue.taskcluster.net/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011211 build_url: 'https://queue.taskcluster.net/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7064f8a579e5f83475fa9a2f311f4ae48ecf7e25cb10ab81c9285c7735bab3ce62e4b160c063fce64daf3a67e0c02a5ee20e44399f68d1092249b858a62ad47", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db713ed60cc5e948bbdfc91e4d23d8a1028e808a49cb5fa76263bc60666d9dbc7cc0c0405bdf11744955d8bcf2effe20ed2ceca28365cbbc332a2bb1b8170c1d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-23 06:15:07.398708) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 06:15:07.399021) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1461411049.682967-641148017 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004442 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 06:15:07.480580) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-23 06:15:07.480922) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-23 06:15:07.481225) ========= ========= Total master_lag: 0.16 =========