builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-017 starttime: 1463913137.74 results: success (0) buildid: 20160522004024 builduid: 63cd0a1e6ce04fec96e7f8af48c79ac1 revision: 110e5a10dce56ed02e43c58c179e6ac101df216d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-22 03:32:17.738176) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-22 03:32:17.738570) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-22 03:32:17.738876) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-22 03:32:17.769988) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-22 03:32:17.770259) ========= 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=0333a256a5e4f052382dd180000001b1-1463910357.695990-1034311429 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-22 03:32:18-- 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% 25.0M=0s 2016-05-22 03:32:18 (25.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.148310 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-22 03:32:17.936575) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-22 03:32:17.936862) ========= 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=0333a256a5e4f052382dd180000001b1-1463910357.695990-1034311429 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016374 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-22 03:32:17.986560) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-22 03:32:17.987151) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 110e5a10dce56ed02e43c58c179e6ac101df216d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 110e5a10dce56ed02e43c58c179e6ac101df216d --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=0333a256a5e4f052382dd180000001b1-1463910357.695990-1034311429 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-22 03:32:19,062 truncating revision to first 12 chars 2016-05-22 03:32:19,062 Setting DEBUG logging. 2016-05-22 03:32:19,062 attempt 1/10 2016-05-22 03:32:19,063 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/110e5a10dce5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-22 03:32:19,426 unpacking tar archive at: mozilla-aurora-110e5a10dce5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.650113 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-22 03:32:18.650033) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-22 03:32:18.650301) ========= script_repo_revision: 110e5a10dce56ed02e43c58c179e6ac101df216d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-22 03:32:18.650682) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-22 03:32:18.650947) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-22 03:32:18.657123) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-22 03:32:18.657384) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1463910357.695990-1034311429 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:32:19 INFO - MultiFileLogger online at 20160522 03:32:19 in /builds/slave/test 03:32:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:32:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:32:19 INFO - {'append_to_log': False, 03:32:19 INFO - 'base_work_dir': '/builds/slave/test', 03:32:19 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:32:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:32:19 INFO - 'branch': 'Mozilla-Aurora', 03:32:19 INFO - 'buildbot_json_path': 'buildprops.json', 03:32:19 INFO - 'config_files': ('talos/linux_config.py',), 03:32:19 INFO - 'default_actions': ('clobber', 03:32:19 INFO - 'read-buildbot-config', 03:32:19 INFO - 'download-and-extract', 03:32:19 INFO - 'populate-webroot', 03:32:19 INFO - 'create-virtualenv', 03:32:19 INFO - 'install', 03:32:19 INFO - 'run-tests'), 03:32:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:32:19 INFO - 'download_minidump_stackwalk': True, 03:32:19 INFO - 'download_symbols': 'ondemand', 03:32:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:32:19 INFO - 'tooltool.py': '/tools/tooltool.py', 03:32:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:32:19 INFO - '/tools/misc-python/virtualenv.py')}, 03:32:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:32:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:32:19 INFO - 'installer_path': 'installer.exe', 03:32:19 INFO - 'log_level': 'info', 03:32:19 INFO - 'log_name': 'talos', 03:32:19 INFO - 'log_to_console': True, 03:32:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:32:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:32:19 INFO - 'opt_config_files': (), 03:32:19 INFO - 'pip_index': False, 03:32:19 INFO - 'sps_profile': False, 03:32:19 INFO - 'sps_profile_interval': 0, 03:32:19 INFO - 'suite': 'dromaeojs', 03:32:19 INFO - 'system_bits': '32', 03:32:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:32:19 INFO - 'title': 'talos-linux64-ix-017', 03:32:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:32:19 INFO - 'use_talos_json': True, 03:32:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:32:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:32:19 INFO - 'work_dir': 'build'} 03:32:19 INFO - ##### 03:32:19 INFO - ##### Running clobber step. 03:32:19 INFO - ##### 03:32:19 INFO - Running pre-action listener: _resource_record_pre_action 03:32:19 INFO - Running main action method: clobber 03:32:19 INFO - rmtree: /builds/slave/test/build 03:32:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:32:20 INFO - Running post-action listener: _resource_record_post_action 03:32:20 INFO - ##### 03:32:20 INFO - ##### Running read-buildbot-config step. 03:32:20 INFO - ##### 03:32:20 INFO - Running pre-action listener: _resource_record_pre_action 03:32:20 INFO - Running main action method: read_buildbot_config 03:32:20 INFO - Using buildbot properties: 03:32:20 INFO - { 03:32:20 INFO - "project": "", 03:32:20 INFO - "product": "firefox", 03:32:20 INFO - "script_repo_revision": "production", 03:32:20 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:32:20 INFO - "repository": "", 03:32:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:32:20 INFO - "buildid": "20160522004024", 03:32:20 INFO - "stage_platform": "linux64-pgo", 03:32:20 INFO - "basedir": "/builds/slave/test", 03:32:20 INFO - "nightly_build": "True", 03:32:20 INFO - "buildnumber": 249, 03:32:20 INFO - "slavename": "talos-linux64-ix-017", 03:32:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:32:20 INFO - "platform": "ubuntu64_hw", 03:32:20 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:32:20 INFO - "branch": "mozilla-aurora", 03:32:20 INFO - "repo_path": "releases/mozilla-aurora", 03:32:20 INFO - "revision": "110e5a10dce56ed02e43c58c179e6ac101df216d", 03:32:20 INFO - "pgo_build": "True", 03:32:20 INFO - "builduid": "63cd0a1e6ce04fec96e7f8af48c79ac1", 03:32:20 INFO - "slavebuilddir": "test" 03:32:20 INFO - } 03:32:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 03:32:20 INFO - Running post-action listener: _resource_record_post_action 03:32:20 INFO - ##### 03:32:20 INFO - ##### Running download-and-extract step. 03:32:20 INFO - ##### 03:32:20 INFO - Running pre-action listener: _resource_record_pre_action 03:32:20 INFO - Running main action method: download_and_extract 03:32:20 INFO - mkdir: /builds/slave/test/build/tests 03:32:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:20 INFO - https://queue.taskcluster.net/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:32:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:32:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:32:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:32:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:32:27 INFO - Downloaded 1361 bytes. 03:32:27 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:32:27 INFO - Using the following test package requirements: 03:32:27 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:32:27 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:32:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:32:27 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:32:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:32:27 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:32:27 INFO - u'jsshell-linux-x86_64.zip'], 03:32:27 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:32:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:32:27 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:32:27 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:32:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:32:27 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:32:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:32:27 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:32:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:32:27 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:32:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:32:27 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:27 INFO - https://queue.taskcluster.net/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:32:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:32:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:32:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:32:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:32:31 INFO - Downloaded 23813806 bytes. 03:32:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:32:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:32:32 INFO - Return code: 0 03:32:32 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:32:32 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')]} 03:32:32 INFO - https://queue.taskcluster.net/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:32:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:32:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:32:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:32:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:32:33 INFO - Downloaded 23813806 bytes. 03:32:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:32:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:32:34 INFO - Return code: 0 03:32:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:34 INFO - https://queue.taskcluster.net/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:32:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:32:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:32:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:32:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:32:35 INFO - Downloaded 10840145 bytes. 03:32:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:32:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:32:35 INFO - Return code: 0 03:32:35 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')]} 03:32:35 INFO - https://queue.taskcluster.net/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:32:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:32:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:32:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:32:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:32:37 INFO - Downloaded 62733868 bytes. 03:32:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:32:37 INFO - mkdir: /builds/slave/test/properties 03:32:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:32:37 INFO - Writing to file /builds/slave/test/properties/build_url 03:32:37 INFO - Contents: 03:32:37 INFO - build_url:https://queue.taskcluster.net/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:32:40 INFO - Running post-action listener: _resource_record_post_action 03:32:40 INFO - Running post-action listener: set_extra_try_arguments 03:32:40 INFO - ##### 03:32:40 INFO - ##### Running populate-webroot step. 03:32:40 INFO - ##### 03:32:40 INFO - Running pre-action listener: _resource_record_pre_action 03:32:40 INFO - Running main action method: populate_webroot 03:32:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:32:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:32:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:32:40 INFO - '--tppagecycles', 03:32:40 INFO - '7'], 03:32:40 INFO - 'tests': ['tsvgm']}}, 03:32:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:32:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:32:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:32:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:32:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:32:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:32:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:40 INFO - 'talos_options': ['--disable-e10s'], 03:32:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:32:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:32:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:40 INFO - 'talos_options': ['--disable-e10s'], 03:32:40 INFO - 'tests': ['damp', 'tps']}, 03:32:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:40 INFO - 'tests': ['damp', 'tps']}, 03:32:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:32:40 INFO - 'tests': ['dromaeo_dom']}, 03:32:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:32:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:32:40 INFO - 'tests': ['a11yr', 03:32:40 INFO - 'ts_paint', 03:32:40 INFO - 'tpaint', 03:32:40 INFO - 'sessionrestore', 03:32:40 INFO - 'sessionrestore_no_auto_restore', 03:32:40 INFO - 'tabpaint']}, 03:32:40 INFO - 'other-e10s': {'tests': ['a11yr', 03:32:40 INFO - 'ts_paint', 03:32:40 INFO - 'tpaint', 03:32:40 INFO - 'sessionrestore', 03:32:40 INFO - 'sessionrestore_no_auto_restore', 03:32:40 INFO - 'tabpaint']}, 03:32:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:32:40 INFO - 'ts_paint', 03:32:40 INFO - 'tpaint', 03:32:40 INFO - 'sessionrestore', 03:32:40 INFO - 'sessionrestore_no_auto_restore', 03:32:40 INFO - 'tabpaint']}, 03:32:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:32:40 INFO - 'ts_paint', 03:32:40 INFO - 'tpaint', 03:32:40 INFO - 'sessionrestore', 03:32:40 INFO - 'sessionrestore_no_auto_restore', 03:32:40 INFO - 'tabpaint']}, 03:32:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:32:40 INFO - 'tests': ['a11yr', 03:32:40 INFO - 'ts_paint', 03:32:40 INFO - 'tpaint', 03:32:40 INFO - 'sessionrestore', 03:32:40 INFO - 'sessionrestore_no_auto_restore', 03:32:40 INFO - 'tabpaint']}, 03:32:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:32:40 INFO - 'tests': ['a11yr', 03:32:40 INFO - 'ts_paint', 03:32:40 INFO - 'tpaint', 03:32:40 INFO - 'sessionrestore', 03:32:40 INFO - 'sessionrestore_no_auto_restore', 03:32:40 INFO - 'tabpaint']}, 03:32:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:32:40 INFO - 'tests': ['tsvgx', 03:32:40 INFO - 'tsvgr_opacity', 03:32:40 INFO - 'tart', 03:32:40 INFO - 'tscrollx', 03:32:40 INFO - 'cart']}, 03:32:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:32:40 INFO - 'tsvgr_opacity', 03:32:40 INFO - 'tart', 03:32:40 INFO - 'tscrollx', 03:32:40 INFO - 'cart']}, 03:32:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:40 INFO - 'talos_options': ['--disable-e10s'], 03:32:40 INFO - 'tests': ['tp5o']}, 03:32:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:40 INFO - 'tests': ['tp5o']}, 03:32:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:40 INFO - 'talos_options': ['--disable-e10s', 03:32:40 INFO - '--xperf_path', 03:32:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:32:40 INFO - 'tests': ['tp5n']}, 03:32:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:40 INFO - 'talos_options': ['--xperf_path', 03:32:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:32:40 INFO - 'tests': ['tp5n']}}, 03:32:40 INFO - 'talos.zip': {'path': '', 03:32:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:32:40 INFO - Running post-action listener: _resource_record_post_action 03:32:40 INFO - ##### 03:32:40 INFO - ##### Running create-virtualenv step. 03:32:40 INFO - ##### 03:32:40 INFO - Running pre-action listener: _resource_record_pre_action 03:32:40 INFO - Running main action method: create_virtualenv 03:32:40 INFO - Creating virtualenv /builds/slave/test/build/venv 03:32:40 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 03:32:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:32:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:32:40 INFO - Using real prefix '/usr' 03:32:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:32:41 INFO - Installing distribute.............................................................................................................................................................................................done. 03:32:43 INFO - Installing pip.................done. 03:32:43 INFO - Return code: 0 03:32:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:32:43 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')]} 03:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:43 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')]} 03:32:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:43 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 0x7fa86d83ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ef5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287e410>, '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 0x287f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287f7a0>, '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': '0333a256a5e4f052382dd180000001b1-1463910357.695990-1034311429', '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 03:32:43 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 03:32:43 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 03:32:43 INFO - Using env: {'DISPLAY': ':0', 03:32:43 INFO - 'HOME': '/home/cltbld', 03:32:43 INFO - 'LANG': 'en_US.UTF-8', 03:32:43 INFO - 'LANGUAGE': 'en_US:en', 03:32:43 INFO - 'LOGNAME': 'cltbld', 03:32:43 INFO - 'MAIL': '/var/mail/cltbld', 03:32:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:43 INFO - 'MOZ_NO_REMOTE': '1', 03:32:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:43 INFO - 'NO_EM_RESTART': '1', 03:32:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:43 INFO - 'PWD': '/builds/slave/test', 03:32:43 INFO - 'SHELL': '/bin/bash', 03:32:43 INFO - 'SHLVL': '1', 03:32:43 INFO - 'TERM': 'linux', 03:32:43 INFO - 'TMOUT': '86400', 03:32:43 INFO - 'USER': 'cltbld', 03:32:43 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463910357.695990-1034311429', 03:32:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:43 INFO - '_': '/tools/buildbot/bin/python'} 03:32:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:43 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 03:32:43 INFO - Cleaning up... 03:32:43 INFO - Return code: 0 03:32:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:32:43 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')]} 03:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:43 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')]} 03:32:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:43 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 0x7fa86d83ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ef5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287e410>, '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 0x287f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287f7a0>, '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': '0333a256a5e4f052382dd180000001b1-1463910357.695990-1034311429', '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 03:32:43 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 03:32:43 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 03:32:43 INFO - Using env: {'DISPLAY': ':0', 03:32:43 INFO - 'HOME': '/home/cltbld', 03:32:43 INFO - 'LANG': 'en_US.UTF-8', 03:32:43 INFO - 'LANGUAGE': 'en_US:en', 03:32:43 INFO - 'LOGNAME': 'cltbld', 03:32:43 INFO - 'MAIL': '/var/mail/cltbld', 03:32:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:43 INFO - 'MOZ_NO_REMOTE': '1', 03:32:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:43 INFO - 'NO_EM_RESTART': '1', 03:32:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:43 INFO - 'PWD': '/builds/slave/test', 03:32:43 INFO - 'SHELL': '/bin/bash', 03:32:43 INFO - 'SHLVL': '1', 03:32:43 INFO - 'TERM': 'linux', 03:32:43 INFO - 'TMOUT': '86400', 03:32:43 INFO - 'USER': 'cltbld', 03:32:43 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463910357.695990-1034311429', 03:32:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:43 INFO - '_': '/tools/buildbot/bin/python'} 03:32:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:43 INFO - Downloading/unpacking psutil>=0.7.1 03:32:43 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 03:32:43 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 03:32:43 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 03:32:43 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 03:32:43 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 03:32:43 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 03:32:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:32:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:32:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:32:45 INFO - Installing collected packages: psutil 03:32:45 INFO - Running setup.py install for psutil 03:32:45 INFO - building 'psutil._psutil_linux' extension 03:32:45 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 03:32:46 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 03:32:46 INFO - building 'psutil._psutil_posix' extension 03:32:46 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 03:32:46 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 03:32:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:32:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:32:46 INFO - Successfully installed psutil 03:32:46 INFO - Cleaning up... 03:32:46 INFO - Return code: 0 03:32:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:32:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:46 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 0x7fa86d83ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ef5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287e410>, '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 0x287f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287f7a0>, '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': '0333a256a5e4f052382dd180000001b1-1463910357.695990-1034311429', '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 03:32:46 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 03:32:46 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 03:32:46 INFO - Using env: {'DISPLAY': ':0', 03:32:46 INFO - 'HOME': '/home/cltbld', 03:32:46 INFO - 'LANG': 'en_US.UTF-8', 03:32:46 INFO - 'LANGUAGE': 'en_US:en', 03:32:46 INFO - 'LOGNAME': 'cltbld', 03:32:46 INFO - 'MAIL': '/var/mail/cltbld', 03:32:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:46 INFO - 'MOZ_NO_REMOTE': '1', 03:32:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:46 INFO - 'NO_EM_RESTART': '1', 03:32:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:46 INFO - 'PWD': '/builds/slave/test', 03:32:46 INFO - 'SHELL': '/bin/bash', 03:32:46 INFO - 'SHLVL': '1', 03:32:46 INFO - 'TERM': 'linux', 03:32:46 INFO - 'TMOUT': '86400', 03:32:46 INFO - 'USER': 'cltbld', 03:32:46 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463910357.695990-1034311429', 03:32:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:46 INFO - '_': '/tools/buildbot/bin/python'} 03:32:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:32:46 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 03:32:46 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 03:32:46 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 03:32:46 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 03:32:46 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 03:32:46 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 03:32:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:32:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:32:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:32:48 INFO - Installing collected packages: mozsystemmonitor 03:32:48 INFO - Running setup.py install for mozsystemmonitor 03:32:48 INFO - Successfully installed mozsystemmonitor 03:32:48 INFO - Cleaning up... 03:32:48 INFO - Return code: 0 03:32:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:32:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:48 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 0x7fa86d83ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ef5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287e410>, '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 0x287f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287f7a0>, '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': '0333a256a5e4f052382dd180000001b1-1463910357.695990-1034311429', '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 03:32:48 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 03:32:48 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 03:32:48 INFO - Using env: {'DISPLAY': ':0', 03:32:48 INFO - 'HOME': '/home/cltbld', 03:32:48 INFO - 'LANG': 'en_US.UTF-8', 03:32:48 INFO - 'LANGUAGE': 'en_US:en', 03:32:48 INFO - 'LOGNAME': 'cltbld', 03:32:48 INFO - 'MAIL': '/var/mail/cltbld', 03:32:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:48 INFO - 'MOZ_NO_REMOTE': '1', 03:32:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:48 INFO - 'NO_EM_RESTART': '1', 03:32:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:48 INFO - 'PWD': '/builds/slave/test', 03:32:48 INFO - 'SHELL': '/bin/bash', 03:32:48 INFO - 'SHLVL': '1', 03:32:48 INFO - 'TERM': 'linux', 03:32:48 INFO - 'TMOUT': '86400', 03:32:48 INFO - 'USER': 'cltbld', 03:32:48 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463910357.695990-1034311429', 03:32:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:48 INFO - '_': '/tools/buildbot/bin/python'} 03:32:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:48 INFO - Downloading/unpacking blobuploader==1.2.4 03:32:48 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 03:32:48 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 03:32:48 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 03:32:48 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 03:32:48 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 03:32:48 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 03:32:50 INFO - Downloading blobuploader-1.2.4.tar.gz 03:32:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:32:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:32:50 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 03:32:50 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 03:32:50 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 03:32:50 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 03:32:50 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 03:32:50 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 03:32:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:32:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:32: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 03:32: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 03:32: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 03:32: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 03:32: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 03:32: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 03:32:51 INFO - Downloading docopt-0.6.1.tar.gz 03:32:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:32:51 INFO - Installing collected packages: blobuploader, requests, docopt 03:32:51 INFO - Running setup.py install for blobuploader 03:32:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:32:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:32:51 INFO - Running setup.py install for requests 03:32:51 INFO - Running setup.py install for docopt 03:32:52 INFO - Successfully installed blobuploader requests docopt 03:32:52 INFO - Cleaning up... 03:32:52 INFO - Return code: 0 03:32:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:52 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 0x7fa86d83ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ef5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287e410>, '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 0x287f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287f7a0>, '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': '0333a256a5e4f052382dd180000001b1-1463910357.695990-1034311429', '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 03:32:52 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 03:32:52 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 03:32:52 INFO - Using env: {'DISPLAY': ':0', 03:32:52 INFO - 'HOME': '/home/cltbld', 03:32:52 INFO - 'LANG': 'en_US.UTF-8', 03:32:52 INFO - 'LANGUAGE': 'en_US:en', 03:32:52 INFO - 'LOGNAME': 'cltbld', 03:32:52 INFO - 'MAIL': '/var/mail/cltbld', 03:32:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:52 INFO - 'MOZ_NO_REMOTE': '1', 03:32:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:52 INFO - 'NO_EM_RESTART': '1', 03:32:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:52 INFO - 'PWD': '/builds/slave/test', 03:32:52 INFO - 'SHELL': '/bin/bash', 03:32:52 INFO - 'SHLVL': '1', 03:32:52 INFO - 'TERM': 'linux', 03:32:52 INFO - 'TMOUT': '86400', 03:32:52 INFO - 'USER': 'cltbld', 03:32:52 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463910357.695990-1034311429', 03:32:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:52 INFO - '_': '/tools/buildbot/bin/python'} 03:32:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:32:52 INFO - Running setup.py (path:/tmp/pip-PC7lZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:32:52 INFO - Running setup.py (path:/tmp/pip-6ZMyc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:32:52 INFO - Running setup.py (path:/tmp/pip-z4YIQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:32:52 INFO - Running setup.py (path:/tmp/pip-pcF0mX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:32:52 INFO - Running setup.py (path:/tmp/pip-i8IQMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:32:52 INFO - Running setup.py (path:/tmp/pip-aHTDvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:32:52 INFO - Running setup.py (path:/tmp/pip-yGGzbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:32:52 INFO - Running setup.py (path:/tmp/pip-WIscVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:32:52 INFO - Running setup.py (path:/tmp/pip-vhVaPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:32:52 INFO - Running setup.py (path:/tmp/pip-cPrTwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:32:53 INFO - Running setup.py (path:/tmp/pip-E0F7Al-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:32:53 INFO - Running setup.py (path:/tmp/pip-59DkAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:32:53 INFO - Running setup.py (path:/tmp/pip-lNfAy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:32:53 INFO - Running setup.py (path:/tmp/pip-JTrCeG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:53 INFO - Running setup.py (path:/tmp/pip-Brtz1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:32:53 INFO - Running setup.py (path:/tmp/pip-L2mnmY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:32:53 INFO - Running setup.py (path:/tmp/pip-gRAewY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:32:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:32:53 INFO - Running setup.py install for manifestparser 03:32:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:32:53 INFO - Running setup.py install for mozcrash 03:32:53 INFO - Running setup.py install for mozdebug 03:32:53 INFO - Running setup.py install for mozdevice 03:32:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:32:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:32:53 INFO - Running setup.py install for mozfile 03:32:54 INFO - Running setup.py install for mozhttpd 03:32:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:32:54 INFO - Running setup.py install for mozinfo 03:32:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:32:54 INFO - Running setup.py install for mozInstall 03:32:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:32:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:32:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:32:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:32:54 INFO - Running setup.py install for mozleak 03:32:54 INFO - Running setup.py install for mozlog 03:32:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:32:54 INFO - Running setup.py install for moznetwork 03:32:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:32:54 INFO - Running setup.py install for mozprocess 03:32:54 INFO - Running setup.py install for mozprofile 03:32:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:32:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:32:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:32:54 INFO - Running setup.py install for mozrunner 03:32:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:32:55 INFO - Running setup.py install for mozscreenshot 03:32:55 INFO - Running setup.py install for moztest 03:32:55 INFO - Running setup.py install for mozversion 03:32:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:32:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:32:55 INFO - Cleaning up... 03:32:55 INFO - Return code: 0 03:32:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:55 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 0x7fa86d83ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ef5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287e410>, '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 0x287f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287f7a0>, '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': '0333a256a5e4f052382dd180000001b1-1463910357.695990-1034311429', '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 03:32:55 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 03:32:55 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 03:32:55 INFO - Using env: {'DISPLAY': ':0', 03:32:55 INFO - 'HOME': '/home/cltbld', 03:32:55 INFO - 'LANG': 'en_US.UTF-8', 03:32:55 INFO - 'LANGUAGE': 'en_US:en', 03:32:55 INFO - 'LOGNAME': 'cltbld', 03:32:55 INFO - 'MAIL': '/var/mail/cltbld', 03:32:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:55 INFO - 'MOZ_NO_REMOTE': '1', 03:32:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:55 INFO - 'NO_EM_RESTART': '1', 03:32:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:55 INFO - 'PWD': '/builds/slave/test', 03:32:55 INFO - 'SHELL': '/bin/bash', 03:32:55 INFO - 'SHLVL': '1', 03:32:55 INFO - 'TERM': 'linux', 03:32:55 INFO - 'TMOUT': '86400', 03:32:55 INFO - 'USER': 'cltbld', 03:32:55 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463910357.695990-1034311429', 03:32:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:55 INFO - '_': '/tools/buildbot/bin/python'} 03:32:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:32:55 INFO - Running setup.py (path:/tmp/pip-hT5Eqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:32:55 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)) 03:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:32:55 INFO - Running setup.py (path:/tmp/pip-o43gTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:32:55 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)) 03:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:32:55 INFO - Running setup.py (path:/tmp/pip-8ZGAL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:32:55 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)) 03:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:32:55 INFO - Running setup.py (path:/tmp/pip-CYx6U6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:32:55 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)) 03:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:32:55 INFO - Running setup.py (path:/tmp/pip-TzbbJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:32:55 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)) 03:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:32:55 INFO - Running setup.py (path:/tmp/pip-C5w9a4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:32:56 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)) 03:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:32:56 INFO - Running setup.py (path:/tmp/pip-BOc8MR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:32:56 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)) 03:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:32:56 INFO - Running setup.py (path:/tmp/pip-Kb0KEI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:32:56 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)) 03:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:32:56 INFO - Running setup.py (path:/tmp/pip-mZJ7l7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:32:56 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)) 03:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:32:56 INFO - Running setup.py (path:/tmp/pip-MttJQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:32:56 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)) 03:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:32:56 INFO - Running setup.py (path:/tmp/pip-QH8B5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:32:56 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)) 03:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:32:56 INFO - Running setup.py (path:/tmp/pip-2ZDyq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:32:56 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)) 03:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:32:56 INFO - Running setup.py (path:/tmp/pip-imvTQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:32:56 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)) 03:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:32:56 INFO - Running setup.py (path:/tmp/pip-aimNT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:32:56 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)) 03:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:56 INFO - Running setup.py (path:/tmp/pip-DMQVIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:56 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)) 03:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:32:56 INFO - Running setup.py (path:/tmp/pip-5gLnbQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:32:56 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)) 03:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:32:56 INFO - Running setup.py (path:/tmp/pip-y7CXCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:32:56 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)) 03:32:56 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)) 03:32:56 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)) 03:32:56 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)) 03:32:56 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)) 03:32:56 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)) 03:32:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:32: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 03:32: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 03:32: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 03:32: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 03:32: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 03:32: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 03:32:58 INFO - Downloading blessings-1.6.tar.gz 03:32:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:32:58 INFO - Installing collected packages: blessings 03:32:58 INFO - Running setup.py install for blessings 03:32:58 INFO - Successfully installed blessings 03:32:58 INFO - Cleaning up... 03:32:58 INFO - Return code: 0 03:32:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:32:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:32:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:32:59 INFO - Reading from file tmpfile_stdout 03:32:59 INFO - Current package versions: 03:32:59 INFO - argparse == 1.2.1 03:32:59 INFO - blessings == 1.6 03:32:59 INFO - blobuploader == 1.2.4 03:32:59 INFO - docopt == 0.6.1 03:32:59 INFO - manifestparser == 1.1 03:32:59 INFO - mozInstall == 1.12 03:32:59 INFO - mozcrash == 0.17 03:32:59 INFO - mozdebug == 0.1 03:32:59 INFO - mozdevice == 0.48 03:32:59 INFO - mozfile == 1.2 03:32:59 INFO - mozhttpd == 0.7 03:32:59 INFO - mozinfo == 0.9 03:32:59 INFO - mozleak == 0.1 03:32:59 INFO - mozlog == 3.1 03:32:59 INFO - moznetwork == 0.27 03:32:59 INFO - mozprocess == 0.22 03:32:59 INFO - mozprofile == 0.28 03:32:59 INFO - mozrunner == 6.11 03:32:59 INFO - mozscreenshot == 0.1 03:32:59 INFO - mozsystemmonitor == 0.0 03:32:59 INFO - moztest == 0.7 03:32:59 INFO - mozversion == 1.4 03:32:59 INFO - psutil == 3.1.1 03:32:59 INFO - requests == 1.2.3 03:32:59 INFO - wsgiref == 0.1.2 03:32:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:32: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')]} 03:32:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32: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')]} 03:32:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:59 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 0x7fa86d83ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ef5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287e410>, '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 0x287f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287f7a0>, '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': '0333a256a5e4f052382dd180000001b1-1463910357.695990-1034311429', '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 03:32:59 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 03:32:59 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 03:32:59 INFO - Using env: {'DISPLAY': ':0', 03:32:59 INFO - 'HOME': '/home/cltbld', 03:32:59 INFO - 'LANG': 'en_US.UTF-8', 03:32:59 INFO - 'LANGUAGE': 'en_US:en', 03:32:59 INFO - 'LOGNAME': 'cltbld', 03:32:59 INFO - 'MAIL': '/var/mail/cltbld', 03:32:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:59 INFO - 'MOZ_NO_REMOTE': '1', 03:32:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:59 INFO - 'NO_EM_RESTART': '1', 03:32:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:59 INFO - 'PWD': '/builds/slave/test', 03:32:59 INFO - 'SHELL': '/bin/bash', 03:32:59 INFO - 'SHLVL': '1', 03:32:59 INFO - 'TERM': 'linux', 03:32:59 INFO - 'TMOUT': '86400', 03:32:59 INFO - 'USER': 'cltbld', 03:32:59 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463910357.695990-1034311429', 03:32:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:59 INFO - '_': '/tools/buildbot/bin/python'} 03:32:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:59 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)) 03:32:59 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)) 03:32:59 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)) 03:32:59 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)) 03:32:59 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)) 03:32:59 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)) 03:32:59 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)) 03:32:59 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)) 03:32:59 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)) 03:32:59 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)) 03:32:59 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)) 03:32:59 INFO - Cleaning up... 03:32:59 INFO - Return code: 0 03:32:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:32: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')]} 03:32:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32: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')]} 03:32:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:59 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 0x7fa86d83ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ef5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287e410>, '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 0x287f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287f7a0>, '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': '0333a256a5e4f052382dd180000001b1-1463910357.695990-1034311429', '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 03:32:59 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 03:32:59 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 03:32:59 INFO - Using env: {'DISPLAY': ':0', 03:32:59 INFO - 'HOME': '/home/cltbld', 03:32:59 INFO - 'LANG': 'en_US.UTF-8', 03:32:59 INFO - 'LANGUAGE': 'en_US:en', 03:32:59 INFO - 'LOGNAME': 'cltbld', 03:32:59 INFO - 'MAIL': '/var/mail/cltbld', 03:32:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:59 INFO - 'MOZ_NO_REMOTE': '1', 03:32:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:59 INFO - 'NO_EM_RESTART': '1', 03:32:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:59 INFO - 'PWD': '/builds/slave/test', 03:32:59 INFO - 'SHELL': '/bin/bash', 03:32:59 INFO - 'SHLVL': '1', 03:32:59 INFO - 'TERM': 'linux', 03:32:59 INFO - 'TMOUT': '86400', 03:32:59 INFO - 'USER': 'cltbld', 03:32:59 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463910357.695990-1034311429', 03:32:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:59 INFO - '_': '/tools/buildbot/bin/python'} 03:32:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:59 INFO - Downloading/unpacking jsonschema 03:32: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 03:32: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 03:32: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 03:32: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 03:32: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 03:32: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 03:33:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:33:01 INFO - Downloading/unpacking functools32 (from jsonschema) 03:33:01 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 03:33:01 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 03:33:01 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 03:33:01 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 03:33:01 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 03:33:01 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 03:33:01 INFO - Downloading functools32-3.2.3-2.tar.gz 03:33:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:33:01 INFO - warning: no files found matching '*.txt' 03:33:01 INFO - no previously-included directories found matching 'build' 03:33:01 INFO - no previously-included directories found matching 'dist' 03:33:01 INFO - no previously-included directories found matching '.git*' 03:33:01 INFO - Installing collected packages: jsonschema, functools32 03:33:01 INFO - Running setup.py install for functools32 03:33:01 INFO - warning: no files found matching '*.txt' 03:33:01 INFO - no previously-included directories found matching 'build' 03:33:01 INFO - no previously-included directories found matching 'dist' 03:33:01 INFO - no previously-included directories found matching '.git*' 03:33:01 INFO - Successfully installed jsonschema functools32 03:33:01 INFO - Cleaning up... 03:33:01 INFO - Return code: 0 03:33:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:33:01 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')]} 03:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:01 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')]} 03:33:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:01 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 0x7fa86d83ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ef5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287e410>, '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 0x287f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287f7a0>, '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': '0333a256a5e4f052382dd180000001b1-1463910357.695990-1034311429', '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 03:33:01 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 03:33:01 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 03:33:01 INFO - Using env: {'DISPLAY': ':0', 03:33:01 INFO - 'HOME': '/home/cltbld', 03:33:01 INFO - 'LANG': 'en_US.UTF-8', 03:33:01 INFO - 'LANGUAGE': 'en_US:en', 03:33:01 INFO - 'LOGNAME': 'cltbld', 03:33:01 INFO - 'MAIL': '/var/mail/cltbld', 03:33:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:01 INFO - 'MOZ_NO_REMOTE': '1', 03:33:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:01 INFO - 'NO_EM_RESTART': '1', 03:33:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:01 INFO - 'PWD': '/builds/slave/test', 03:33:01 INFO - 'SHELL': '/bin/bash', 03:33:01 INFO - 'SHLVL': '1', 03:33:01 INFO - 'TERM': 'linux', 03:33:01 INFO - 'TMOUT': '86400', 03:33:01 INFO - 'USER': 'cltbld', 03:33:01 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463910357.695990-1034311429', 03:33:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:01 INFO - '_': '/tools/buildbot/bin/python'} 03:33:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:02 INFO - Downloading/unpacking flake8 03:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:33:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:33: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 03:33: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 03:33: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 03:33: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 03:33: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 03:33: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 03:33:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:33:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:33: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 03:33: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 03:33: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 03:33: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 03:33: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 03:33: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 03:33:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:33: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 03:33: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 03:33: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 03:33: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 03:33: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 03:33: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 03:33:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:33:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:33:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:33:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:33:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:33:04 INFO - no previously-included directories found matching 'docs/_build' 03:33:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:33:04 INFO - Running setup.py install for pep8 03:33:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:33:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:33:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:33:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:33:04 INFO - no previously-included directories found matching 'docs/_build' 03:33:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:33:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:33:04 INFO - Cleaning up... 03:33:05 INFO - Return code: 0 03:33:05 INFO - Running post-action listener: _resource_record_post_action 03:33:05 INFO - Running post-action listener: _start_resource_monitoring 03:33:05 INFO - Starting resource monitoring. 03:33:05 INFO - ##### 03:33:05 INFO - ##### Running install step. 03:33:05 INFO - ##### 03:33:05 INFO - Running pre-action listener: _resource_record_pre_action 03:33:05 INFO - Running main action method: install 03:33:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:33:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:33:05 INFO - Reading from file tmpfile_stdout 03:33:05 INFO - Detecting whether we're running mozinstall >=1.0... 03:33:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:33:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:33:05 INFO - Reading from file tmpfile_stdout 03:33:05 INFO - Output received: 03:33:05 INFO - Usage: mozinstall [options] installer 03:33:05 INFO - Options: 03:33:05 INFO - -h, --help show this help message and exit 03:33:05 INFO - -d DEST, --destination=DEST 03:33:05 INFO - Directory to install application into. [default: 03:33:05 INFO - "/builds/slave/test"] 03:33:05 INFO - --app=APP Application being installed. [default: firefox] 03:33:05 INFO - mkdir: /builds/slave/test/build/application 03:33:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:33:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:33:20 INFO - Reading from file tmpfile_stdout 03:33:20 INFO - Output received: 03:33:20 INFO - /builds/slave/test/build/application/firefox/firefox 03:33:20 INFO - Running post-action listener: _resource_record_post_action 03:33:20 INFO - ##### 03:33:20 INFO - ##### Running run-tests step. 03:33:20 INFO - ##### 03:33:20 INFO - Running pre-action listener: _resource_record_pre_action 03:33:20 INFO - Running main action method: run_tests 03:33:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:33:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:33:20 INFO - Python 2.7.3 03:33:20 INFO - Return code: 0 03:33:20 INFO - grabbing minidump binary from tooltool 03:33:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:20 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 0x287e410>, '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 0x287f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287f7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:33:20 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 03:33:20 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 03:33:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:33:21 INFO - Return code: 0 03:33:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:33:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:33:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:33:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:33:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:33:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:33:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:33:21 INFO - Return code: 0 03:33:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 03:33:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 03:33:21 INFO - Using env: {'DISPLAY': ':0', 03:33:21 INFO - 'HOME': '/home/cltbld', 03:33:21 INFO - 'LANG': 'en_US.UTF-8', 03:33:21 INFO - 'LANGUAGE': 'en_US:en', 03:33:21 INFO - 'LOGNAME': 'cltbld', 03:33:21 INFO - 'MAIL': '/var/mail/cltbld', 03:33:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:33:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:33:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:21 INFO - 'MOZ_NO_REMOTE': '1', 03:33:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:33:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:21 INFO - 'NO_EM_RESTART': '1', 03:33:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:21 INFO - 'PWD': '/builds/slave/test', 03:33:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:33:21 INFO - 'SHELL': '/bin/bash', 03:33:21 INFO - 'SHLVL': '1', 03:33:21 INFO - 'TERM': 'linux', 03:33:21 INFO - 'TMOUT': '86400', 03:33:21 INFO - 'USER': 'cltbld', 03:33:21 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463910357.695990-1034311429', 03:33:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:21 INFO - '_': '/tools/buildbot/bin/python'} 03:33:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 03:33:22 INFO - mozversion application_buildid: 20160522004024 03:33:22 INFO - mozversion application_changeset: 110e5a10dce56ed02e43c58c179e6ac101df216d 03:33:22 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:33:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:33:22 INFO - mozversion application_name: Firefox 03:33:22 INFO - mozversion application_remotingname: firefox-dev 03:33:22 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:33:22 INFO - mozversion application_vendor: Mozilla 03:33:22 INFO - mozversion application_version: 48.0a2 03:33:22 INFO - mozversion platform_buildid: 20160522004024 03:33:22 INFO - mozversion platform_changeset: 110e5a10dce56ed02e43c58c179e6ac101df216d 03:33:22 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:33:22 INFO - mozversion platform_version: 48.0a2 03:33:22 INFO - using testdate: 1463913202 03:33:22 INFO - actual date: 1463913202 03:33:22 INFO - starting webserver on 'localhost:57904' 03:33:22 INFO - SUITE-START | Running 2 tests 03:33:22 INFO - TEST-START | dromaeo_css 03:33:22 INFO - operating with platform_type : linux_ 03:33:22 INFO - Initialising browser for dromaeo_css test... 03:33:22 INFO - TEST-INFO | started process 26998 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9I3Tgp/profile http://localhost:57904/getInfo.html) 03:33:25 INFO - PROCESS | 26998 | __metrics Screen width/height:1600/1200 03:33:25 INFO - PROCESS | 26998 | colorDepth:24 03:33:25 INFO - PROCESS | 26998 | Browser inner width/height: 1024/697 03:33:25 INFO - PROCESS | 26998 | __metrics 03:33:26 ERROR - PROCESS | 26998 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:33:27 INFO - TEST-INFO | 26998: exit 0 03:33:27 INFO - Browser initialized. 03:33:27 INFO - Running cycle 1/1 for dromaeo_css test... 03:33:27 INFO - TEST-INFO | started process 27088 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9I3Tgp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:33:39 INFO - PROCESS | 27088 | RSS: Main: 142442496 03:33:39 INFO - PROCESS | 27088 | 03:34:30 INFO - PROCESS | 27088 | 1463913270093 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] 03:36:37 INFO - PROCESS | 27088 | Cycle 1(1): loaded http://localhost:57904/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57904/tests/dromaeo/cssquery-ext.html) 03:36:38 INFO - PROCESS | 27088 | RSS: Main: 250081280 03:36:38 INFO - PROCESS | 27088 | 03:39:40 INFO - PROCESS | 27088 | Cycle 1(1): loaded http://localhost:57904/tests/dromaeo/cssquery-ext.html (next: http://localhost:57904/tests/dromaeo/cssquery-jquery.html) 03:39:41 INFO - PROCESS | 27088 | RSS: Main: 228085760 03:39:41 INFO - PROCESS | 27088 | 03:42:42 INFO - PROCESS | 27088 | Cycle 1(1): loaded http://localhost:57904/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57904/tests/dromaeo/cssquery-mootools.html) 03:42:43 INFO - PROCESS | 27088 | RSS: Main: 220250112 03:42:43 INFO - PROCESS | 27088 | 03:45:45 INFO - PROCESS | 27088 | Cycle 1(1): loaded http://localhost:57904/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57904/tests/dromaeo/cssquery-prototype.html) 03:45:46 INFO - PROCESS | 27088 | RSS: Main: 214331392 03:45:46 INFO - PROCESS | 27088 | 03:48:48 INFO - PROCESS | 27088 | Cycle 1(1): loaded http://localhost:57904/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57904/tests/dromaeo/cssquery-yui.html) 03:48:49 INFO - PROCESS | 27088 | RSS: Main: 214044672 03:48:49 INFO - PROCESS | 27088 | 03:51:51 INFO - PROCESS | 27088 | Cycle 1(1): loaded http://localhost:57904/tests/dromaeo/cssquery-yui.html (next: http://localhost:57904/tests/dromaeo/cssquery-dojo.html) 03:51:51 INFO - PROCESS | 27088 | RSS: Main: 249458688 03:51:51 INFO - PROCESS | 27088 | 03:51:51 INFO - PROCESS | 27088 | __start_tp_report 03:51:51 INFO - PROCESS | 27088 | _x_x_mozilla_page_load 03:51:51 INFO - PROCESS | 27088 | _x_x_mozilla_page_load_details 03:51:51 INFO - PROCESS | 27088 | |i|pagename|runs| 03:51:51 INFO - PROCESS | 27088 | |0;dojo.html;3236.595425571803;3311.933761324772;3325.7006869381757;3347.364000839839;3361.277325375044;5413.02565538203;5413.079776438005;5424.566034717223;5449.918251226235;5452.182172674091;5407.594430417715;5443.319585051869;5453.918191227125;5455.18172274159;5479.780808767655;4803.087413391462;4916.80332786689;4925.802967881298;5015.5486006259425;5065.265536497206;4896.314515967767;4955.132851750947;4966.627502937295;4967;4967.5280848319535;4910.1898186799135;4960.057589058086;4982.153033984213;4996.125678006334;4998.050370429607;4951.529604687585;4968.254761785725;4969;4969.931464735063;4997.725125118117;4813.975930120362;4859;4883.413990321184;4923.852284431437;4933.309336692866;5329.094054010828;5351.973240133813;5390.51485366319;5398.4871437213405;5400.567954563665;5707.571932105067;5708.20085188074;5708.686022268774;5709;5711.485966263015;5773.624714393551;5827.562932780059;5922.3781502942;5957.374475680078;5994.97002514989;5324.627276090714;5386.542143917772;5428.945710542884;5428.972855135738;5431.701256430894;5806.564507661942;5916.763329466773;5922.674252916045;5925.585209035326;5939.198208241918;5638.4925356718095;5724.484796368263;5746.2529871116485;5757.107648314518;5777.913331300034;5698.886022279531;5704.885902282014;5705.229793977843;5707.3721890592005;5714.399988001283;5576.386597474275;5653.23681303027;5680.233168522197;5683.062294721325;5708.657480551097;5829.650220986754;5838.824835254949;5841.41585841421;5842.649441033552;5882.470577648032;4469.843555475542;4480.283154695233;4480.686351955397;4484.551544845554;4505.954940450553;3955.3473676843573;3989.301872172416;4024.859129930497;4060.2894493463527;4062.431259623655;5597.076482380362;5598.776048957996;5618.494335509742;5621.971890140523;5623.5220006299105;5897.970510147422;5911.940880591225;5919.230500034968;5924.822255332347;5926.348101708809;5407.107827208467;5490.478404551641;5577;5588.30146231721;5592.3009623797025;5007.37407824022;5048.3941926969;5050.3182070420025;5050.444451110375;5050.72221027847;6039.667818270037;6041.818745437644;6044.123602077674;6052.334243233241;6060.909086363708;5642.830715078472;5813.651180929158;5909.881802364014;5943.346231914399;5945.405459454193;6050.485708714808;6074.42292982166;6078.878422431615;6085.148079268817;6089.69551522431;5581.190727344593;5731.512821410227;5752.568557358131;5762.6830524319885;5763.538916886555;5770.942290577041;5845.473907348189;5849.268841394825;5850.473457388855;5886.94113058864;5664.688442135722;5667.121596152603;5686.402927692533;5686.658800471985;5707.914381284201;5523.696196709059;5624.578156638187;5645.520130788929;5666.518345940642;5674.319081710221;5582.916256256241;5622.943770562406;5623.943760562342;5626.38109807929;5651.943480565142;5666.914996275142;5702.315722113373;5719.714014299351;5729.197912292366;5730.885382292247;5450.046241907571;5614.775408983595;5622.493975542221;5624.690642014565;5722.055860782924 03:51:51 INFO - PROCESS | 27088 | |1;ext.html;666.8066260784373;676.6954870308363;682.5188242289186;726.2592156000879;746.7983644416009;31846;32661.83669081651;32692.346153076924;32725.509117363228;32726.181845453877;33844.830775846145;40901;41671.374929376085;41689.791551042275;41745;8947.06055864133;9088.818223635524;9095.317851161157;9106.681266155685;9129.589168487433;8504;8876.511791851446;8968.103189681013;8997.460152390844;10806.135509159249;10825.188110891675;10915.454227288643;10916.290441121302;10916.672499825017;10920.617778377758;10775.676729698082;10841.891581084166;10857.294275872082;10857.45712714361;10866.293690910145;8566.528840913747;10528.894711052868;10619.044286014296;10668.946655266674;10717.571297148104;41658.1668366634;41873.37189942153;42057.369139462935;42074.57925420737;42141.57858421407;3652.2330310634798;3695.316366472184;3717.646823551758;3785.734998550103;3842.4812650292133;31491.37017259642;32012.359752805045;32603.347933041205;32617.836910815295;32658.183545411317;4256.5105012923295;4304;4370.715903466296;4389.341598760179;4408.14041261954;319765;320712;322627;322700;323629;68788.6560567194;69925.30074699188;70192.64903675449;70302.29697702957;70346;73364.89952650714;74077.25922740811;74286;74804.62597687086;74805.6259718698;17307.56731081733;17622.383216587357;17636.20637071335;17663.64672706539;17687.20407581662;14012;14168.716625667636;14173.078749881432;14293.714125717635;14300.570982870531;19581.608367832847;21988.89005554962;22076.448088797908;22108.88945555294;22389.440263993205;7996.280334769898;8022.358211343078;8062.355011599058;8284.544350060683;8331.791705207297;1007.2143727892255;1098.423327752936;1110.2672236323988;1147.9655610331704;1150.3672979861044;29675.703242967727;30020.249493762392;30976.845115774726;31491.685083149332;32424.83787581047;1201.5253974679952;1205.3852535207106;1240.138104017717;1241.7516496700696;1250.0499620288465;16293.185340733153;17173.828261717223;17196.656066878593;17286.13569321529;17315.65368692619;491406;495354;495446;495812.2093895291;498242;63913.680431597546;64081;64375;64426.42294308175;64589.35410645927;1302.9153105048142;1441.128117488925;1457.1475686723174;1517.120070359189;1555.416718730476;30378.39243215079;31567.526487102252;33927.66072339245;34168.14579635529;34764.13089672779;53632;54421.55103020294;54440.45559544354;54441;54454.72772636112;384766;387045;387224;387974;389397;28101;31106.377872442878;31451.52822707707;31571.526427103152;31876.5218521727;46897;49201;49467.50532494773;49623.751881240365;50144.498555015445;40747.18505629811;41566.16867662569;41869.371959421245;42015.3697694541;42834.57165428431;41301;41593;42106.578934210265;42221.577784221765;42347.57652423436;43031.569684302754;43244.56755432405;43292.134157316046;43732.78133609312;43860.561394385644;35746.642533575374;36967.81516092402;37311.626883730816;37443.25113497661;38056.80971595124;28804.135875923756;29405.85297073501;29408.11775646734;29414.11757647274;29460.55809162907 03:51:51 INFO - PROCESS | 27088 | |2;jquery.html;422.8224145858739;422.94713160854883;424.7748693192607;426.82286850956854;435.80388825028734;15489;16117.194140292982;16578.41975530855;16581.50255492334;17988.73016904744;16714.916425417858;17045.232964516596;17199.398021069264;17219;17296.135193240352;5620.9437905620825;5749.223854779614;5760.423957604248;5784.56615753818;5786.479216870481;5502.944970550303;5752.395998420168;5771.451712087345;5778.59549831512;5783.421657834204;5759.971200143993;5767.077267637179;5767.625104368223;5781.364049954502;5808.4191580842;5666.405027472118;5684.602077854552;5845.181674565564;5852.356240813507;5853.151293062525;5701.572382071361;5705.74324155414;5708.514776244025;5720.141978703228;5728.169415434739;21828.89085554578;22203.555928881495;23036.53926921469;23106.65340019901;23156.768432315628;2432.7323994360604;2459.8155138364696;2482.987585062081;2628.4348864993926;2841.863254698137;9527.190188833958;9786.168175705074;9942.304038717293;10238.7440313992;10323.483825808755;2006.625932391677;2014.8287395571394;2051.712760213571;2095.172406899266;2112.355731501891;77744.61127694325;78939.60530197312;81427.18572814255;81712;81743;10739.83890241647;11001.906123421504;11007.120549656465;11266.54933802655;11474.139439542068;15913.045217287;15922.363105475883;16083.437079702155;16100.75848862268;16132.838671613368;8577.742667719978;8661.696840610548;8774.210321071007;8840.823183536422;8862.512561809162;8500.489970601784;8512.233898949;8642.351823613255;8649.308055355556;8726.650933962697;4414.602685758297;4487.169873573399;4663.696859704109;4696.03731235096;4804.495527969582;1987.6919077543005;2032.7357443532246;2062.1442101527996;2062.7730949595534;2112.1624186957138;968.3028219681818;1046.2257929132388;1071.8338657508098;1072.3940378462898;1128.8814674459227;18471.90764046198;18518.722219166724;18565.25738970453;18817.623647526972;19168;1058.9788204235872;1069.5561342042965;1077.1113831089383;1085.375908852413;1101.1796211822084;10231.13035391985;10460.372377657364;10551.314164579278;10660.733481663021;10816.188785841094;534982;540370;540403;564063;565985;60821.39178608157;63876.68061659755;89972.10027899768;107941.76174714771;108261;992.6773798515511;1014.4369874719454;1021.2493817044615;1077.3159044007111;1148.7702459508298;16551.91724041372;16746.665066698843;16755.748663770297;16870.072146032086;17485.300587976337;41180.45659734294;41270.58729412667;41356.58643413648;42989.78505107454;43217.783911080245;57181.714091429276;58078.4192158073;58742.41257587369;58935.70532147312;59234.70382648059;8315.501069935823;8420.36847236472;8586.527740974307;8735.301175905784;8862.955685221532;12902.483900644245;13060.477580896657;13065;13139.211647301192;13247.933760331136;7044.753433629799;9856.605735770489;12024.879751202727;12254;12325.691857703629;11846.703832403915;11853.940730296637;11897.583584574499;12127.696807579881;12155.270683759003;6662.000699895055;10624;10849.728756781144;12320.507179712711;12473.376331183586;8377.664893404195;8618.525981071101;8662.220400164015;8778.429402088845;8924.509151996443;12004;12250.938745306217;12582.119251652663;12656.936715316364;12793.49729385552 03:51:51 INFO - PROCESS | 27088 | |3;mootools.html;1481.422245324323;1558.9610259743502;1567.7569976653617;1794.5334213104588;1934.4970307719998;8481.491110533365;8707.172818582241;8707.782305442368;8715.041345452004;8722.520261385622;8580.09908959558;8732.694355697551;8763.167499087576;8776.605052772624;8782.780430489242;1966.4493941696348;2190.507135894427;2263.9660405093937;2268.092762894843;2292.014433793468;2270.5004898922293;2276.9658455123185;2283.817294616435;2284.246198754415;2284.291869520454;2208.591410589046;2271.4434963433982;2276.681264622954;2282.5092605089903;2283.303592404316;2032.410600925737;2213.800757931786;2256.9435764105865;2262.5135595846973;2272.2388000020014;2206.2498750424934;2242.65238887971;2247.9887600562056;2257.593633146033;2261.0729600863733;8555.401121921468;8629.439086459422;8645.610947507377;8649.697260595849;8651.826963460695;5147.408048074444;5274.7626356814035;5285.973570132163;5287.339082614673;5366.651167674088;3346.9665303346897;3399.6940275375086;3442.913927151841;3618.5657721073376;3645.6172101929183;1111.1666250312267;1153.786549488339;1185.2888267039793;1206.993965030178;1216.799228127358;12450.128491005633;12471.625851224479;12474.563390281297;12478.00175985928;12514.499420023189;4611.9392539716055;4684.4378674559275;4767.4517430495935;4771.618270538349;4786.377770889762;10547.050765430995;10589.735256618493;10604.469776511143;10607.84088238677;10633.255672102878;4910.533499317559;5338;5379.65032272901;5399.730013499309;5419.864503387447;4826.686265392738;4912.778924948386;4945.727984960861;4957.157283261854;4973.875653108701;4111.6299533042165;4111.671066314748;4291.592298731615;4344.674149438804;4365.563443655609;1331.6803967047838;1355.1665725578698;1358.945642174302;1364.6793003644136;1365.3855764905634;930.3673502018693;1036.124474818777;1041.6927006533092;1044.0864243786687;1051.3271506235862;5815.476607105296;5861.606229764967;5970;5971.193888824953;6187.412195841388;958.4057884111755;977.5307852230827;979.9265055120752;1099.2580008494235;1142.1091548592112;3987.6211759882763;3999.6600288975183;4019.8995025124023;4096.3855421686985;4111.490975322115;10790.406527640898;11089.55641774336;11137.944310278397;11292.774144517229;11331.490082946288;11031.062359699356;11052.447377631086;11069.667909962714;11132.777344453227;11146.498407571678;8174.713885013996;8236.876446853303;8247.793805154799;8258.8348233035;8272.958635206785;5422.457754224546;5523.475269849358;5665.631733937281;5703.173039909273;5739.139129130664;9393.436393816393;9395.765105872135;9479.431234125974;9629.614815407305;9646.42121472714;9134.954325228331;9218.539073046455;9273.211776999031;9276.02601726836;9305.209057230211;6769.323067693388;7351.522151060164;7580.658870350737;7613.428992825449;7793.220677932388;8254.257116859511;8271.875921861056;8285.627146778288;8311.044229913638;8334.83330333402;7454.329110380092;7655.770326890202;7719.884201737091;7725.459217854921;7766.766996990099;7446.888296675663;7473.290037446434;7529.247075292427;7573.9242607575425;7703.460757746904;7027.859442811013;7058.364747172779;7072.964635176997;7083.574985500886;7104.467164962752;5246.6065045121;5288.656237344714;5402.675839449488;5461.344638643388;5481.808136715355;5089.367461486423;5165.096108180978;5272.367315922113;5356.734677651671;5458.563314934716 03:51:51 INFO - PROCESS | 27088 | |4;prototype.html;347.42501160579235;350.7194244604317;352.62651970574626;353.4627366403067;357.93378225028374;6356.39614236648;6394.0728594353905;6404.967975160118;6409.519286053542;6418.775342863;6304.6532440715855;6325.146105275787;6326.746930122801;6348.650824204667;6350.904736428957;4594.70134441262;4658.464276608182;4703.670743047988;4707.152712511746;4731.810727570893;4717.882052948687;4726.361941137937;4749.7387643679585;4750.16872047392;4776.880577985544;4722.197226471508;4746.335513028179;4746.596539294164;4760.166970780117;4763.61891048717;4593.724376537419;4630.467496237909;4744.098621261949;4754.66717329787;4755.595774359201;4149.294619914622;4151.750894946283;4157.625813676784;4176.227397931362;4195.265828480004;6062.514998800086;6070.57505974582;6075.149479072933;6076.088586711984;6084.421979911901;5545.972270138624;5559.305086864142;5572.3034620672415;5572.721363931828;5582.944170558324;6638.336166383371;6652.833679158011;6654.633995130266;6654.7670831521145;6666;4309.978450107761;4426.092651006568;4468.4414448193975;4673;4674.579287864109;6788.08360871281;6812;6822.215445223813;6846.760363387258;6855.451563874878;4585.12882552314;4588.357629931812;4593.242115050979;4594.035252596992;4598.8620341389815;4646.303054541778;4648.163330600457;4648.883777905512;4653.371794807657;4656.278276867091;5396.217548455452;5404.972975135178;5409.56723462122;5415.783368665288;5416.8104116355735;6481.254655714559;6589.17635295588;6605.405513503808;6607.108040414579;6717.294684058202;1620.2060990114994;1629.4704221128181;1635.5911022244438;1636.5663099278702;1645.2020769926814;1014.6651604970342;1039.6413237433073;1041.4063983529468;1062.0759938853093;1069.0325255643654;6275.3724627537795;6468.741250350027;6536.934630653727;6592.373724496165;6594.835129121714;6944.479164062715;6979.3718565328345;6992.16094068715;6994.615296158659;6994.790156295319;6539.901901471481;6560.475161987029;6565.835854103686;6568.408843204134;6575.408213260829;3720.2001569662652;3755.7183211259266;3763.8118094095184;3769.7738135711943;3774.9433758493647;6990;7254.8911766323545;7261;7267.30960558746;7281.053463049876;7104.289571042855;7141.178764442156;7143.785686429415;7156.856862862818;7157.24848890859;7219.0976127984;7231.529950553302;7231.891521627074;7241.601711905896;7250.238724933912;6934.063901373452;6961.060256865461;6968.4076853465995;6970.128733908262;6977.7208911642965;6714.966425167843;6806.319368063154;6876.621785801629;6886.070380498569;6897.103376561015;7209.35115839577;7229.602371869387;7231.602261875647;7235.312645298688;7239.927600723925;4764.809407623657;4806.639502037431;4816.181249187716;4826.8069277228515;4828.61371090319;6916.170059592881;6917.861642767217;6921.34247246531;6921.446284297345;6932.584044957319;6577.539572229898;6727.93272067273;6758.5269031167345;6771.593704377753;6801.557898736566;6714.52998290115;6752.69612867432;6754.12196414463;6754.493412994143;6756.45948324123;6615.338466153346;6624.271330153776;6630.502712296694;6636.0377745225705;6641.03704962768;6784.626845523544;6794.42247408956;6796.830079248059;6803.863922721419;6811.182658081062;6508.60948343101;6652.83367915806;6653.301403352578;6654.50091243149;6655.134832471941 03:51:51 INFO - PROCESS | 27088 | |5;yui.html;908.3596064774334;910.1535571918114;915.9512358349685;916.1983264643433;950.8573713942908;14696.118232906034;14931;14991.550253492385;15017.549473515784;15025;14076.225807580578;14076.859231407709;14154.858451415483;14190.929045354784;14200.431982720678;769.7267470048137;902.5261737587786;925.564984457304;932.0120672087609;932.7481579973403;916.2852974679727;922.9861552076724;924.7965447601517;925.2413021322518;925.8796356473682;951.3673407184215;960.9663661771839;961.5624890674761;961.5769061612868;962.7641227899139;797.3461761355691;944.2398868910524;957.2150836314225;965.8985806490288;968.3028219681853;710.0946293475808;711.0329951266325;711.9786406407816;714.7498375568562;715.3383120613412;14037.087589306662;14089.929550352183;14103.929480352635;14155.504557340546;14176.362063707054;14549.927250363786;14645.926770366186;15007.099574025593;15333.616659583487;15637.530874073796;11973.880261197364;11996.70008249792;12068.577599784054;12102.394880255952;12140.3322817245;4733.621310295202;4774.331593576902;4813.855584332476;4819.662623616348;4870.293807397908;57412.13881791818;57492.42507574955;57503;57520.71239643775;57738.42261577372;11078.556857725762;11145.219834611662;11254.38100904458;11265.436728163722;11562.826557601642;20370.083346249456;20450.693239601416;20468.590628187652;20470;20508.17967281292;8810.427322224035;8830.86753698695;8850.336224783166;8879.378443508893;9028.322875784343;4950.25746138075;4962.082014827269;4968.8757781055765;5008.373953255843;5039.521245481674;3551.520544726429;3576.6065732769375;3590.4793804898145;3590.838412271454;3593.425051991721;636.678477368935;646.0793369448517;659.172738213539;672.1933679584519;697.9720811167598;710.705057401183;718.6730037832774;729.0449511140423;749.8200431896415;755.3994574313434;8897.73306800797;9137.086291370942;9233.307501937381;9297.209737172416;9464.384814987141;690.413148823506;726.498715886037;755.7317152410925;755.935745461631;781.0549235425086;4333.241682705514;4384.386185933972;4398.362237475548;4410.977945110318;4667.533246675305;59263.40736592579;59310.110348343944;59339.70330148322;59474.10788838171;59482.40517594855;54288;55808.441915580326;56405.43594564002;57137.42862571404;57446.138307925416;49252.75373623109;50962.74518627383;51605;51844.74077629663;51898.48101519012;8530.616122274389;8582.65669373218;8595.269402100641;8664;8766;37095;37840.62159378371;37965.24069518649;38108.428373573865;41646;47368.52631473641;47526;47758.283625746335;47879.28181077217;48929.755351223015;12713.93643031779;12914.354282286036;12968.09223354356;13020;13357;13666.794998074838;14017.880305721283;14040.859591404364;14381.784273236119;14393.136411815325;13117.475300987853;13271.336433178496;13392;13535.390907409386;13573.457061717421;12753.48986040548;13067.281299528617;13210.339483026002;13355;13420.530281440493;12623.558175464183;12912.225266483665;12981.286029268103;13094.476220951055;13179.275139867015;10773.946130269298;11252.66242012741;11269.436528173723;11426.485808138488;11565.248258863146;10981.3960232188;11088.778224435628;11369.43152842338;11433.085353171893;11453.427328633368 03:51:51 INFO - PROCESS | 27088 | __end_tp_report 03:51:51 INFO - PROCESS | 27088 | __start_cc_report 03:51:51 INFO - PROCESS | 27088 | _x_x_mozilla_cycle_collect,851 03:51:51 INFO - PROCESS | 27088 | __end_cc_report 03:51:51 INFO - PROCESS | 27088 | __startTimestamp1463914311659__endTimestamp 03:51:51 INFO - PROCESS | 27088 | 03:51:51 INFO - PROCESS | 27088 | ------- Summary: start ------- 03:51:51 INFO - PROCESS | 27088 | Number of tests: 6 03:51:51 INFO - PROCESS | 27088 | 03:51:51 INFO - PROCESS | 27088 | [#0] dojo.html Cycles:165 Average:5409.74 Median:5623.52 stddev:590.02 (10.5%) stddev-sans-first:566.66 03:51:51 INFO - PROCESS | 27088 | Values: 3236.6 3311.9 3325.7 3347.4 3361.3 5413.0 5413.1 5424.6 5449.9 5452.2 5407.6 5443.3 5453.9 5455.2 5479.8 4803.1 4916.8 4925.8 5015.5 5065.3 4896.3 4955.1 4966.6 4967.0 4967.5 4910.2 4960.1 4982.2 4996.1 4998.1 4951.5 4968.3 4969.0 4969.9 4997.7 4814.0 4859.0 4883.4 4923.9 4933.3 5329.1 5352.0 5390.5 5398.5 5400.6 5707.6 5708.2 5708.7 5709.0 5711.5 5773.6 5827.6 5922.4 5957.4 5995.0 5324.6 5386.5 5428.9 5429.0 5431.7 5806.6 5916.8 5922.7 5925.6 5939.2 5638.5 5724.5 5746.3 5757.1 5777.9 5698.9 5704.9 5705.2 5707.4 5714.4 5576.4 5653.2 5680.2 5683.1 5708.7 5829.7 5838.8 5841.4 5842.6 5882.5 4469.8 4480.3 4480.7 4484.6 4506.0 3955.3 3989.3 4024.9 4060.3 4062.4 5597.1 5598.8 5618.5 5622.0 5623.5 5898.0 5911.9 5919.2 5924.8 5926.3 5407.1 5490.5 5577.0 5588.3 5592.3 5007.4 5048.4 5050.3 5050.4 5050.7 6039.7 6041.8 6044.1 6052.3 6060.9 5642.8 5813.7 5909.9 5943.3 5945.4 6050.5 6074.4 6078.9 6085.1 6089.7 5581.2 5731.5 5752.6 5762.7 5763.5 5770.9 5845.5 5849.3 5850.5 5886.9 5664.7 5667.1 5686.4 5686.7 5707.9 5523.7 5624.6 5645.5 5666.5 5674.3 5582.9 5622.9 5623.9 5626.4 5651.9 5666.9 5702.3 5719.7 5729.2 5730.9 5450.0 5614.8 5622.5 5624.7 5722.1 03:51:51 INFO - PROCESS | 27088 | 03:51:51 INFO - PROCESS | 27088 | [#1] ext.html Cycles:180 Average:58128.96 Median:20514.64 stddev:107680.86 (524.9%) stddev-sans-first:107896.50 03:51:51 INFO - PROCESS | 27088 | Values: 666.8 676.7 682.5 726.3 746.8 31846.0 32661.8 32692.3 32725.5 32726.2 33844.8 40901.0 41671.4 41689.8 41745.0 8947.1 9088.8 9095.3 9106.7 9129.6 8504.0 8876.5 8968.1 8997.5 10806.1 10825.2 10915.5 10916.3 10916.7 10920.6 10775.7 10841.9 10857.3 10857.5 10866.3 8566.5 10528.9 10619.0 10668.9 10717.6 41658.2 41873.4 42057.4 42074.6 42141.6 3652.2 3695.3 3717.6 3785.7 3842.5 31491.4 32012.4 32603.3 32617.8 32658.2 4256.5 4304.0 4370.7 4389.3 4408.1 319765.0 320712.0 322627.0 322700.0 323629.0 68788.7 69925.3 70192.6 70302.3 70346.0 73364.9 74077.3 74286.0 74804.6 74805.6 17307.6 17622.4 17636.2 17663.6 17687.2 14012.0 14168.7 14173.1 14293.7 14300.6 19581.6 21988.9 22076.4 22108.9 22389.4 7996.3 8022.4 8062.4 8284.5 8331.8 1007.2 1098.4 1110.3 1148.0 1150.4 29675.7 30020.2 30976.8 31491.7 32424.8 1201.5 1205.4 1240.1 1241.8 1250.0 16293.2 17173.8 17196.7 17286.1 17315.7 491406.0 495354.0 495446.0 495812.2 498242.0 63913.7 64081.0 64375.0 64426.4 64589.4 1302.9 1441.1 1457.1 1517.1 1555.4 30378.4 31567.5 33927.7 34168.1 34764.1 53632.0 54421.6 54440.5 54441.0 54454.7 384766.0 387045.0 387224.0 387974.0 389397.0 28101.0 31106.4 31451.5 31571.5 31876.5 46897.0 49201.0 49467.5 49623.8 50144.5 40747.2 41566.2 41869.4 42015.4 42834.6 41301.0 41593.0 42106.6 42221.6 42347.6 43031.6 43244.6 43292.1 43732.8 43860.6 35746.6 36967.8 37311.6 37443.3 38056.8 28804.1 29405.9 29408.1 29414.1 29460.6 03:51:51 INFO - PROCESS | 27088 | 03:51:51 INFO - PROCESS | 27088 | [#2] jquery.html Cycles:180 Average:30351.84 Median:2471.40 stddev:90248.56 (3651.7%) stddev-sans-first:90473.75 03:51:51 INFO - PROCESS | 27088 | Values: 422.8 422.9 424.8 426.8 435.8 15489.0 16117.2 16578.4 16581.5 17988.7 16714.9 17045.2 17199.4 17219.0 17296.1 5620.9 5749.2 5760.4 5784.6 5786.5 5502.9 5752.4 5771.5 5778.6 5783.4 5760.0 5767.1 5767.6 5781.4 5808.4 5666.4 5684.6 5845.2 5852.4 5853.2 5701.6 5705.7 5708.5 5720.1 5728.2 21828.9 22203.6 23036.5 23106.7 23156.8 2432.7 2459.8 2483.0 2628.4 2841.9 9527.2 9786.2 9942.3 10238.7 10323.5 2006.6 2014.8 2051.7 2095.2 2112.4 77744.6 78939.6 81427.2 81712.0 81743.0 10739.8 11001.9 11007.1 11266.5 11474.1 15913.0 15922.4 16083.4 16100.8 16132.8 8577.7 8661.7 8774.2 8840.8 8862.5 8500.5 8512.2 8642.4 8649.3 8726.7 4414.6 4487.2 4663.7 4696.0 4804.5 1987.7 2032.7 2062.1 2062.8 2112.2 968.3 1046.2 1071.8 1072.4 1128.9 18471.9 18518.7 18565.3 18817.6 19168.0 1059.0 1069.6 1077.1 1085.4 1101.2 10231.1 10460.4 10551.3 10660.7 10816.2 534982.0 540370.0 540403.0 564063.0 565985.0 60821.4 63876.7 89972.1 107941.8 108261.0 992.7 1014.4 1021.2 1077.3 1148.8 16551.9 16746.7 16755.7 16870.1 17485.3 41180.5 41270.6 41356.6 42989.8 43217.8 57181.7 58078.4 58742.4 58935.7 59234.7 8315.5 8420.4 8586.5 8735.3 8863.0 12902.5 13060.5 13065.0 13139.2 13247.9 7044.8 9856.6 12024.9 12254.0 12325.7 11846.7 11853.9 11897.6 12127.7 12155.3 6662.0 10624.0 10849.7 12320.5 12473.4 8377.7 8618.5 8662.2 8778.4 8924.5 12004.0 12250.9 12582.1 12656.9 12793.5 03:51:51 INFO - PROCESS | 27088 | 03:51:51 INFO - PROCESS | 27088 | [#3] mootools.html Cycles:180 Average:5776.01 Median:4965.52 stddev:3252.39 (65.5%) stddev-sans-first:3245.50 03:51:51 INFO - PROCESS | 27088 | Values: 1481.4 1559.0 1567.8 1794.5 1934.5 8481.5 8707.2 8707.8 8715.0 8722.5 8580.1 8732.7 8763.2 8776.6 8782.8 1966.4 2190.5 2264.0 2268.1 2292.0 2270.5 2277.0 2283.8 2284.2 2284.3 2208.6 2271.4 2276.7 2282.5 2283.3 2032.4 2213.8 2256.9 2262.5 2272.2 2206.2 2242.7 2248.0 2257.6 2261.1 8555.4 8629.4 8645.6 8649.7 8651.8 5147.4 5274.8 5286.0 5287.3 5366.7 3347.0 3399.7 3442.9 3618.6 3645.6 1111.2 1153.8 1185.3 1207.0 1216.8 12450.1 12471.6 12474.6 12478.0 12514.5 4611.9 4684.4 4767.5 4771.6 4786.4 10547.1 10589.7 10604.5 10607.8 10633.3 4910.5 5338.0 5379.7 5399.7 5419.9 4826.7 4912.8 4945.7 4957.2 4973.9 4111.6 4111.7 4291.6 4344.7 4365.6 1331.7 1355.2 1358.9 1364.7 1365.4 930.4 1036.1 1041.7 1044.1 1051.3 5815.5 5861.6 5970.0 5971.2 6187.4 958.4 977.5 979.9 1099.3 1142.1 3987.6 3999.7 4019.9 4096.4 4111.5 10790.4 11089.6 11137.9 11292.8 11331.5 11031.1 11052.4 11069.7 11132.8 11146.5 8174.7 8236.9 8247.8 8258.8 8273.0 5422.5 5523.5 5665.6 5703.2 5739.1 9393.4 9395.8 9479.4 9629.6 9646.4 9135.0 9218.5 9273.2 9276.0 9305.2 6769.3 7351.5 7580.7 7613.4 7793.2 8254.3 8271.9 8285.6 8311.0 8334.8 7454.3 7655.8 7719.9 7725.5 7766.8 7446.9 7473.3 7529.2 7573.9 7703.5 7027.9 7058.4 7073.0 7083.6 7104.5 5246.6 5288.7 5402.7 5461.3 5481.8 5089.4 5165.1 5272.4 5356.7 5458.6 03:51:51 INFO - PROCESS | 27088 | 03:51:51 INFO - PROCESS | 27088 | [#4] prototype.html Cycles:180 Average:5592.69 Median:6443.76 stddev:1725.86 (26.8%) stddev-sans-first:1685.19 03:51:51 INFO - PROCESS | 27088 | Values: 347.4 350.7 352.6 353.5 357.9 6356.4 6394.1 6405.0 6409.5 6418.8 6304.7 6325.1 6326.7 6348.7 6350.9 4594.7 4658.5 4703.7 4707.2 4731.8 4717.9 4726.4 4749.7 4750.2 4776.9 4722.2 4746.3 4746.6 4760.2 4763.6 4593.7 4630.5 4744.1 4754.7 4755.6 4149.3 4151.8 4157.6 4176.2 4195.3 6062.5 6070.6 6075.1 6076.1 6084.4 5546.0 5559.3 5572.3 5572.7 5582.9 6638.3 6652.8 6654.6 6654.8 6666.0 4310.0 4426.1 4468.4 4673.0 4674.6 6788.1 6812.0 6822.2 6846.8 6855.5 4585.1 4588.4 4593.2 4594.0 4598.9 4646.3 4648.2 4648.9 4653.4 4656.3 5396.2 5405.0 5409.6 5415.8 5416.8 6481.3 6589.2 6605.4 6607.1 6717.3 1620.2 1629.5 1635.6 1636.6 1645.2 1014.7 1039.6 1041.4 1062.1 1069.0 6275.4 6468.7 6536.9 6592.4 6594.8 6944.5 6979.4 6992.2 6994.6 6994.8 6539.9 6560.5 6565.8 6568.4 6575.4 3720.2 3755.7 3763.8 3769.8 3774.9 6990.0 7254.9 7261.0 7267.3 7281.1 7104.3 7141.2 7143.8 7156.9 7157.2 7219.1 7231.5 7231.9 7241.6 7250.2 6934.1 6961.1 6968.4 6970.1 6977.7 6715.0 6806.3 6876.6 6886.1 6897.1 7209.4 7229.6 7231.6 7235.3 7239.9 4764.8 4806.6 4816.2 4826.8 4828.6 6916.2 6917.9 6921.3 6921.4 6932.6 6577.5 6727.9 6758.5 6771.6 6801.6 6714.5 6752.7 6754.1 6754.5 6756.5 6615.3 6624.3 6630.5 6636.0 6641.0 6784.6 6794.4 6796.8 6803.9 6811.2 6508.6 6652.8 6653.3 6654.5 6655.1 03:51:51 INFO - PROCESS | 27088 | 03:51:51 INFO - PROCESS | 27088 | [#5] yui.html Cycles:180 Average:15382.20 Median:26346.57 stddev:17432.31 (66.2%) stddev-sans-first:17447.33 03:51:51 INFO - PROCESS | 27088 | Values: 908.4 910.2 916.0 916.2 950.9 14696.1 14931.0 14991.6 15017.5 15025.0 14076.2 14076.9 14154.9 14190.9 14200.4 769.7 902.5 925.6 932.0 932.7 916.3 923.0 924.8 925.2 925.9 951.4 961.0 961.6 961.6 962.8 797.3 944.2 957.2 965.9 968.3 710.1 711.0 712.0 714.7 715.3 14037.1 14089.9 14103.9 14155.5 14176.4 14549.9 14645.9 15007.1 15333.6 15637.5 11973.9 11996.7 12068.6 12102.4 12140.3 4733.6 4774.3 4813.9 4819.7 4870.3 57412.1 57492.4 57503.0 57520.7 57738.4 11078.6 11145.2 11254.4 11265.4 11562.8 20370.1 20450.7 20468.6 20470.0 20508.2 8810.4 8830.9 8850.3 8879.4 9028.3 4950.3 4962.1 4968.9 5008.4 5039.5 3551.5 3576.6 3590.5 3590.8 3593.4 636.7 646.1 659.2 672.2 698.0 710.7 718.7 729.0 749.8 755.4 8897.7 9137.1 9233.3 9297.2 9464.4 690.4 726.5 755.7 755.9 781.1 4333.2 4384.4 4398.4 4411.0 4667.5 59263.4 59310.1 59339.7 59474.1 59482.4 54288.0 55808.4 56405.4 57137.4 57446.1 49252.8 50962.7 51605.0 51844.7 51898.5 8530.6 8582.7 8595.3 8664.0 8766.0 37095.0 37840.6 37965.2 38108.4 41646.0 47368.5 47526.0 47758.3 47879.3 48929.8 12713.9 12914.4 12968.1 13020.0 13357.0 13666.8 14017.9 14040.9 14381.8 14393.1 13117.5 13271.3 13392.0 13535.4 13573.5 12753.5 13067.3 13210.3 13355.0 13420.5 12623.6 12912.2 12981.3 13094.5 13179.3 10773.9 11252.7 11269.4 11426.5 11565.2 10981.4 11088.8 11369.4 11433.1 11453.4 03:51:51 INFO - PROCESS | 27088 | -------- Summary: end -------- 03:51:51 INFO - PROCESS | 27088 | 03:51:52 INFO - TEST-INFO | 27088: exit 0 03:51:52 INFO - TEST-OK | dromaeo_css | took 1110132ms 03:51:52 INFO - TEST-START | kraken 03:51:52 INFO - operating with platform_type : linux_ 03:51:52 INFO - Initialising browser for kraken test... 03:51:52 INFO - TEST-INFO | started process 27282 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNiBtp_/profile http://localhost:57904/getInfo.html) 03:51:55 INFO - PROCESS | 27282 | __metrics Screen width/height:1600/1200 03:51:55 INFO - PROCESS | 27282 | colorDepth:24 03:51:55 INFO - PROCESS | 27282 | Browser inner width/height: 1024/697 03:51:55 INFO - PROCESS | 27282 | __metrics 03:51:56 ERROR - PROCESS | 27282 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:51:57 INFO - TEST-INFO | 27282: exit 0 03:51:57 INFO - Browser initialized. 03:51:57 INFO - Running cycle 1/1 for kraken test... 03:51:57 INFO - TEST-INFO | started process 27372 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNiBtp_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:52:08 INFO - PROCESS | 27372 | RSS: Main: 141602816 03:52:08 INFO - PROCESS | 27372 | 03:52:11 INFO - PROCESS | 27372 | Cycle 1(1): loaded http://localhost:57904/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57904/tests/kraken/driver.html?testName=audio-beat-detection) 03:52:12 INFO - PROCESS | 27372 | RSS: Main: 196796416 03:52:12 INFO - PROCESS | 27372 | 03:52:14 INFO - PROCESS | 27372 | Cycle 1(1): loaded http://localhost:57904/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57904/tests/kraken/driver.html?testName=audio-dft) 03:52:15 INFO - PROCESS | 27372 | RSS: Main: 181850112 03:52:15 INFO - PROCESS | 27372 | 03:52:18 INFO - PROCESS | 27372 | Cycle 1(1): loaded http://localhost:57904/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57904/tests/kraken/driver.html?testName=audio-fft) 03:52:18 INFO - PROCESS | 27372 | RSS: Main: 273502208 03:52:18 INFO - PROCESS | 27372 | 03:52:20 INFO - PROCESS | 27372 | Cycle 1(1): loaded http://localhost:57904/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57904/tests/kraken/driver.html?testName=audio-oscillator) 03:52:21 INFO - PROCESS | 27372 | RSS: Main: 178733056 03:52:21 INFO - PROCESS | 27372 | 03:52:23 INFO - PROCESS | 27372 | Cycle 1(1): loaded http://localhost:57904/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57904/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:52:24 INFO - PROCESS | 27372 | RSS: Main: 177328128 03:52:24 INFO - PROCESS | 27372 | 03:52:27 INFO - PROCESS | 27372 | Cycle 1(1): loaded http://localhost:57904/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57904/tests/kraken/driver.html?testName=imaging-darkroom) 03:52:27 INFO - PROCESS | 27372 | RSS: Main: 212234240 03:52:27 INFO - PROCESS | 27372 | 03:52:31 INFO - PROCESS | 27372 | Cycle 1(1): loaded http://localhost:57904/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57904/tests/kraken/driver.html?testName=imaging-desaturate) 03:52:31 INFO - PROCESS | 27372 | RSS: Main: 213004288 03:52:31 INFO - PROCESS | 27372 | 03:52:34 INFO - PROCESS | 27372 | Cycle 1(1): loaded http://localhost:57904/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57904/tests/kraken/driver.html?testName=json-parse-financial) 03:52:35 INFO - PROCESS | 27372 | RSS: Main: 212307968 03:52:35 INFO - PROCESS | 27372 | 03:52:36 INFO - PROCESS | 27372 | Cycle 1(1): loaded http://localhost:57904/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57904/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:52:37 INFO - PROCESS | 27372 | RSS: Main: 191229952 03:52:37 INFO - PROCESS | 27372 | 03:52:38 INFO - PROCESS | 27372 | Cycle 1(1): loaded http://localhost:57904/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57904/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:52:39 INFO - PROCESS | 27372 | RSS: Main: 196874240 03:52:39 INFO - PROCESS | 27372 | 03:52:41 INFO - PROCESS | 27372 | Cycle 1(1): loaded http://localhost:57904/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57904/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:52:42 INFO - PROCESS | 27372 | RSS: Main: 207265792 03:52:42 INFO - PROCESS | 27372 | 03:52:44 INFO - PROCESS | 27372 | Cycle 1(1): loaded http://localhost:57904/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57904/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:52:45 INFO - PROCESS | 27372 | RSS: Main: 214458368 03:52:45 INFO - PROCESS | 27372 | 03:52:47 INFO - PROCESS | 27372 | Cycle 1(1): loaded http://localhost:57904/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57904/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:52:48 INFO - PROCESS | 27372 | RSS: Main: 210460672 03:52:48 INFO - PROCESS | 27372 | 03:52:50 INFO - PROCESS | 27372 | Cycle 1(1): loaded http://localhost:57904/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57904/tests/kraken/driver.html?testName=ai-astar) 03:52:50 INFO - PROCESS | 27372 | RSS: Main: 274030592 03:52:50 INFO - PROCESS | 27372 | 03:52:50 INFO - PROCESS | 27372 | __start_tp_report 03:52:50 INFO - PROCESS | 27372 | _x_x_mozilla_page_load 03:52:50 INFO - PROCESS | 27372 | _x_x_mozilla_page_load_details 03:52:50 INFO - PROCESS | 27372 | |i|pagename|runs| 03:52:50 INFO - PROCESS | 27372 | |0;ai-astar;111;111;109;111;112;110;106;111;110;111 03:52:50 INFO - PROCESS | 27372 | |1;audio-beat-detection;163;125;156;174;130;150;152;127;191;126 03:52:50 INFO - PROCESS | 27372 | |2;audio-dft;160;162;160;160;161;161;162;161;161;160 03:52:50 INFO - PROCESS | 27372 | |3;audio-fft;76;76;72;180;76;76;76;76;178;75 03:52:50 INFO - PROCESS | 27372 | |4;audio-oscillator;91;91;144;92;92;92;148;91;92;152 03:52:50 INFO - PROCESS | 27372 | |5;imaging-gaussian-blur;116;117;117;117;118;117;117;117;117;117 03:52:50 INFO - PROCESS | 27372 | |6;imaging-darkroom;145;146;145;146;146;145;145;145;146;146 03:52:50 INFO - PROCESS | 27372 | |7;imaging-desaturate;95;95;96;94;95;94;94;94;94;94 03:52:50 INFO - PROCESS | 27372 | |8;json-parse-financial;52;53;54;54;52;55;56;77;53;52 03:52:50 INFO - PROCESS | 27372 | |9;json-stringify-tinderbox;57;59;58;58;58;57;57;57;57;57 03:52:50 INFO - PROCESS | 27372 | |10;stanford-crypto-aes;71;71;72;71;79;73;73;74;75;72 03:52:50 INFO - PROCESS | 27372 | |11;stanford-crypto-ccm;120;124;119;117;115;119;114;113;136;137 03:52:50 INFO - PROCESS | 27372 | |12;stanford-crypto-pbkdf2;159;164;157;163;158;162;164;156;155;155 03:52:50 INFO - PROCESS | 27372 | |13;stanford-crypto-sha256-iterative;68;67;67;66;67;66;65;67;69;62 03:52:50 INFO - PROCESS | 27372 | __end_tp_report 03:52:50 INFO - PROCESS | 27372 | __start_cc_report 03:52:50 INFO - PROCESS | 27372 | _x_x_mozilla_cycle_collect,1604 03:52:50 INFO - PROCESS | 27372 | __end_cc_report 03:52:50 INFO - PROCESS | 27372 | __startTimestamp1463914370442__endTimestamp 03:52:50 INFO - PROCESS | 27372 | 03:52:50 INFO - PROCESS | 27372 | ------- Summary: start ------- 03:52:50 INFO - PROCESS | 27372 | Number of tests: 14 03:52:50 INFO - PROCESS | 27372 | 03:52:50 INFO - PROCESS | 27372 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:1.69 (1.5%) stddev-sans-first:1.76 03:52:50 INFO - PROCESS | 27372 | Values: 111.0 111.0 109.0 111.0 112.0 110.0 106.0 111.0 110.0 111.0 03:52:50 INFO - PROCESS | 27372 | 03:52:50 INFO - PROCESS | 27372 | [#1] audio-beat-detection Cycles:10 Average:149.40 Median:154.00 stddev:22.59 (14.7%) stddev-sans-first:23.42 03:52:50 INFO - PROCESS | 27372 | Values: 163.0 125.0 156.0 174.0 130.0 150.0 152.0 127.0 191.0 126.0 03:52:50 INFO - PROCESS | 27372 | 03:52:50 INFO - PROCESS | 27372 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 03:52:50 INFO - PROCESS | 27372 | Values: 160.0 162.0 160.0 160.0 161.0 161.0 162.0 161.0 161.0 160.0 03:52:50 INFO - PROCESS | 27372 | 03:52:50 INFO - PROCESS | 27372 | [#3] audio-fft Cycles:10 Average:96.10 Median:76.00 stddev:43.71 (57.5%) stddev-sans-first:45.75 03:52:50 INFO - PROCESS | 27372 | Values: 76.0 76.0 72.0 180.0 76.0 76.0 76.0 76.0 178.0 75.0 03:52:50 INFO - PROCESS | 27372 | 03:52:50 INFO - PROCESS | 27372 | [#4] audio-oscillator Cycles:10 Average:108.50 Median:91.50 stddev:27.33 (29.9%) stddev-sans-first:28.24 03:52:50 INFO - PROCESS | 27372 | Values: 91.0 91.0 144.0 92.0 92.0 92.0 148.0 91.0 92.0 152.0 03:52:50 INFO - PROCESS | 27372 | 03:52:50 INFO - PROCESS | 27372 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 03:52:50 INFO - PROCESS | 27372 | Values: 116.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 03:52:50 INFO - PROCESS | 27372 | 03:52:50 INFO - PROCESS | 27372 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 03:52:50 INFO - PROCESS | 27372 | Values: 145.0 146.0 145.0 146.0 146.0 145.0 145.0 145.0 146.0 146.0 03:52:50 INFO - PROCESS | 27372 | 03:52:50 INFO - PROCESS | 27372 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 03:52:50 INFO - PROCESS | 27372 | Values: 95.0 95.0 96.0 94.0 95.0 94.0 94.0 94.0 94.0 94.0 03:52:50 INFO - PROCESS | 27372 | 03:52:50 INFO - PROCESS | 27372 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:54.00 stddev:7.57 (14.0%) stddev-sans-first:7.90 03:52:50 INFO - PROCESS | 27372 | Values: 52.0 53.0 54.0 54.0 52.0 55.0 56.0 77.0 53.0 52.0 03:52:50 INFO - PROCESS | 27372 | 03:52:50 INFO - PROCESS | 27372 | [#9] json-stringify-tinderbox Cycles:10 Average:57.50 Median:57.50 stddev:0.71 (1.2%) stddev-sans-first:0.73 03:52:50 INFO - PROCESS | 27372 | Values: 57.0 59.0 58.0 58.0 58.0 57.0 57.0 57.0 57.0 57.0 03:52:50 INFO - PROCESS | 27372 | 03:52:50 INFO - PROCESS | 27372 | [#10] stanford-crypto-aes Cycles:10 Average:73.10 Median:73.00 stddev:2.47 (3.4%) stddev-sans-first:2.50 03:52:50 INFO - PROCESS | 27372 | Values: 71.0 71.0 72.0 71.0 79.0 73.0 73.0 74.0 75.0 72.0 03:52:50 INFO - PROCESS | 27372 | 03:52:50 INFO - PROCESS | 27372 | [#11] stanford-crypto-ccm Cycles:10 Average:121.40 Median:119.50 stddev:8.58 (7.2%) stddev-sans-first:9.08 03:52:50 INFO - PROCESS | 27372 | Values: 120.0 124.0 119.0 117.0 115.0 119.0 114.0 113.0 136.0 137.0 03:52:50 INFO - PROCESS | 27372 | 03:52:50 INFO - PROCESS | 27372 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.30 Median:160.50 stddev:3.65 (2.3%) stddev-sans-first:3.87 03:52:50 INFO - PROCESS | 27372 | Values: 159.0 164.0 157.0 163.0 158.0 162.0 164.0 156.0 155.0 155.0 03:52:50 INFO - PROCESS | 27372 | 03:52:50 INFO - PROCESS | 27372 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:67.00 stddev:1.90 (2.8%) stddev-sans-first:1.92 03:52:50 INFO - PROCESS | 27372 | Values: 68.0 67.0 67.0 66.0 67.0 66.0 65.0 67.0 69.0 62.0 03:52:50 INFO - PROCESS | 27372 | -------- Summary: end -------- 03:52:50 INFO - PROCESS | 27372 | 03:52:51 INFO - TEST-INFO | 27372: exit 0 03:52:51 INFO - TEST-OK | kraken | took 59074ms 03:52:51 INFO - SUITE-END | took 1169s 03:52:51 INFO - Completed test suite (00:19:29) 03:52:51 INFO - javascript benchmark 03:52:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3236.595425571803, 3311.933761324772, 3325.7006869381757, 3347.364000839839, 3361.277325375044, 5413.02565538203, 5413.079776438005, 5424.566034717223, 5449.918251226235, 5452.182172674091, 5407.594430417715, 5443.319585051869, 5453.918191227125, 5455.18172274159, 5479.780808767655, 4803.087413391462, 4916.80332786689, 4925.802967881298, 5015.5486006259425, 5065.265536497206, 4896.314515967767, 4955.132851750947, 4966.627502937295, 4967.0, 4967.5280848319535, 4910.1898186799135, 4960.057589058086, 4982.153033984213, 4996.125678006334, 4998.050370429607, 4951.529604687585, 4968.254761785725, 4969.0, 4969.931464735063, 4997.725125118117, 4813.975930120362, 4859.0, 4883.413990321184, 4923.852284431437, 4933.309336692866, 5329.094054010828, 5351.973240133813, 5390.51485366319, 5398.4871437213405, 5400.567954563665, 5707.571932105067, 5708.20085188074, 5708.686022268774, 5709.0, 5711.485966263015, 5773.624714393551, 5827.562932780059, 5922.3781502942, 5957.374475680078, 5994.97002514989, 5324.627276090714, 5386.542143917772, 5428.945710542884, 5428.972855135738, 5431.701256430894, 5806.564507661942, 5916.763329466773, 5922.674252916045, 5925.585209035326, 5939.198208241918, 5638.4925356718095, 5724.484796368263, 5746.2529871116485, 5757.107648314518, 5777.913331300034, 5698.886022279531, 5704.885902282014, 5705.229793977843, 5707.3721890592005, 5714.399988001283, 5576.386597474275, 5653.23681303027, 5680.233168522197, 5683.062294721325, 5708.657480551097, 5829.650220986754, 5838.824835254949, 5841.41585841421, 5842.649441033552, 5882.470577648032, 4469.843555475542, 4480.283154695233, 4480.686351955397, 4484.551544845554, 4505.954940450553, 3955.3473676843573, 3989.301872172416, 4024.859129930497, 4060.2894493463527, 4062.431259623655, 5597.076482380362, 5598.776048957996, 5618.494335509742, 5621.971890140523, 5623.5220006299105, 5897.970510147422, 5911.940880591225, 5919.230500034968, 5924.822255332347, 5926.348101708809, 5407.107827208467, 5490.478404551641, 5577.0, 5588.30146231721, 5592.3009623797025, 5007.37407824022, 5048.3941926969, 5050.3182070420025, 5050.444451110375, 5050.72221027847, 6039.667818270037, 6041.818745437644, 6044.123602077674, 6052.334243233241, 6060.909086363708, 5642.830715078472, 5813.651180929158, 5909.881802364014, 5943.346231914399, 5945.405459454193, 6050.485708714808, 6074.42292982166, 6078.878422431615, 6085.148079268817, 6089.69551522431, 5581.190727344593, 5731.512821410227, 5752.568557358131, 5762.6830524319885, 5763.538916886555, 5770.942290577041, 5845.473907348189, 5849.268841394825, 5850.473457388855, 5886.94113058864, 5664.688442135722, 5667.121596152603, 5686.402927692533, 5686.658800471985, 5707.914381284201, 5523.696196709059, 5624.578156638187, 5645.520130788929, 5666.518345940642, 5674.319081710221, 5582.916256256241, 5622.943770562406, 5623.943760562342, 5626.38109807929, 5651.943480565142, 5666.914996275142, 5702.315722113373, 5719.714014299351, 5729.197912292366, 5730.885382292247, 5450.046241907571, 5614.775408983595, 5622.493975542221, 5624.690642014565, 5722.055860782924], "value": 5372.361072886153, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [666.8066260784373, 676.6954870308363, 682.5188242289186, 726.2592156000879, 746.7983644416009, 31846.0, 32661.83669081651, 32692.346153076924, 32725.509117363228, 32726.181845453877, 33844.830775846145, 40901.0, 41671.374929376085, 41689.791551042275, 41745.0, 8947.06055864133, 9088.818223635524, 9095.317851161157, 9106.681266155685, 9129.589168487433, 8504.0, 8876.511791851446, 8968.103189681013, 8997.460152390844, 10806.135509159249, 10825.188110891675, 10915.454227288643, 10916.290441121302, 10916.672499825017, 10920.617778377758, 10775.676729698082, 10841.891581084166, 10857.294275872082, 10857.45712714361, 10866.293690910145, 8566.528840913747, 10528.894711052868, 10619.044286014296, 10668.946655266674, 10717.571297148104, 41658.1668366634, 41873.37189942153, 42057.369139462935, 42074.57925420737, 42141.57858421407, 3652.2330310634798, 3695.316366472184, 3717.646823551758, 3785.734998550103, 3842.4812650292133, 31491.37017259642, 32012.359752805045, 32603.347933041205, 32617.836910815295, 32658.183545411317, 4256.5105012923295, 4304.0, 4370.715903466296, 4389.341598760179, 4408.14041261954, 319765.0, 320712.0, 322627.0, 322700.0, 323629.0, 68788.6560567194, 69925.30074699188, 70192.64903675449, 70302.29697702957, 70346.0, 73364.89952650714, 74077.25922740811, 74286.0, 74804.62597687086, 74805.6259718698, 17307.56731081733, 17622.383216587357, 17636.20637071335, 17663.64672706539, 17687.20407581662, 14012.0, 14168.716625667636, 14173.078749881432, 14293.714125717635, 14300.570982870531, 19581.608367832847, 21988.89005554962, 22076.448088797908, 22108.88945555294, 22389.440263993205, 7996.280334769898, 8022.358211343078, 8062.355011599058, 8284.544350060683, 8331.791705207297, 1007.2143727892255, 1098.423327752936, 1110.2672236323988, 1147.9655610331704, 1150.3672979861044, 29675.703242967727, 30020.249493762392, 30976.845115774726, 31491.685083149332, 32424.83787581047, 1201.5253974679952, 1205.3852535207106, 1240.138104017717, 1241.7516496700696, 1250.0499620288465, 16293.185340733153, 17173.828261717223, 17196.656066878593, 17286.13569321529, 17315.65368692619, 491406.0, 495354.0, 495446.0, 495812.2093895291, 498242.0, 63913.680431597546, 64081.0, 64375.0, 64426.42294308175, 64589.35410645927, 1302.9153105048142, 1441.128117488925, 1457.1475686723174, 1517.120070359189, 1555.416718730476, 30378.39243215079, 31567.526487102252, 33927.66072339245, 34168.14579635529, 34764.13089672779, 53632.0, 54421.55103020294, 54440.45559544354, 54441.0, 54454.72772636112, 384766.0, 387045.0, 387224.0, 387974.0, 389397.0, 28101.0, 31106.377872442878, 31451.52822707707, 31571.526427103152, 31876.5218521727, 46897.0, 49201.0, 49467.50532494773, 49623.751881240365, 50144.498555015445, 40747.18505629811, 41566.16867662569, 41869.371959421245, 42015.3697694541, 42834.57165428431, 41301.0, 41593.0, 42106.578934210265, 42221.577784221765, 42347.57652423436, 43031.569684302754, 43244.56755432405, 43292.134157316046, 43732.78133609312, 43860.561394385644, 35746.642533575374, 36967.81516092402, 37311.626883730816, 37443.25113497661, 38056.80971595124, 28804.135875923756, 29405.85297073501, 29408.11775646734, 29414.11757647274, 29460.55809162907], "value": 21042.00675460681, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [422.8224145858739, 422.94713160854883, 424.7748693192607, 426.82286850956854, 435.80388825028734, 15489.0, 16117.194140292982, 16578.41975530855, 16581.50255492334, 17988.73016904744, 16714.916425417858, 17045.232964516596, 17199.398021069264, 17219.0, 17296.135193240352, 5620.9437905620825, 5749.223854779614, 5760.423957604248, 5784.56615753818, 5786.479216870481, 5502.944970550303, 5752.395998420168, 5771.451712087345, 5778.59549831512, 5783.421657834204, 5759.971200143993, 5767.077267637179, 5767.625104368223, 5781.364049954502, 5808.4191580842, 5666.405027472118, 5684.602077854552, 5845.181674565564, 5852.356240813507, 5853.151293062525, 5701.572382071361, 5705.74324155414, 5708.514776244025, 5720.141978703228, 5728.169415434739, 21828.89085554578, 22203.555928881495, 23036.53926921469, 23106.65340019901, 23156.768432315628, 2432.7323994360604, 2459.8155138364696, 2482.987585062081, 2628.4348864993926, 2841.863254698137, 9527.190188833958, 9786.168175705074, 9942.304038717293, 10238.7440313992, 10323.483825808755, 2006.625932391677, 2014.8287395571394, 2051.712760213571, 2095.172406899266, 2112.355731501891, 77744.61127694325, 78939.60530197312, 81427.18572814255, 81712.0, 81743.0, 10739.83890241647, 11001.906123421504, 11007.120549656465, 11266.54933802655, 11474.139439542068, 15913.045217287, 15922.363105475883, 16083.437079702155, 16100.75848862268, 16132.838671613368, 8577.742667719978, 8661.696840610548, 8774.210321071007, 8840.823183536422, 8862.512561809162, 8500.489970601784, 8512.233898949, 8642.351823613255, 8649.308055355556, 8726.650933962697, 4414.602685758297, 4487.169873573399, 4663.696859704109, 4696.03731235096, 4804.495527969582, 1987.6919077543005, 2032.7357443532246, 2062.1442101527996, 2062.7730949595534, 2112.1624186957138, 968.3028219681818, 1046.2257929132388, 1071.8338657508098, 1072.3940378462898, 1128.8814674459227, 18471.90764046198, 18518.722219166724, 18565.25738970453, 18817.623647526972, 19168.0, 1058.9788204235872, 1069.5561342042965, 1077.1113831089383, 1085.375908852413, 1101.1796211822084, 10231.13035391985, 10460.372377657364, 10551.314164579278, 10660.733481663021, 10816.188785841094, 534982.0, 540370.0, 540403.0, 564063.0, 565985.0, 60821.39178608157, 63876.68061659755, 89972.10027899768, 107941.76174714771, 108261.0, 992.6773798515511, 1014.4369874719454, 1021.2493817044615, 1077.3159044007111, 1148.7702459508298, 16551.91724041372, 16746.665066698843, 16755.748663770297, 16870.072146032086, 17485.300587976337, 41180.45659734294, 41270.58729412667, 41356.58643413648, 42989.78505107454, 43217.783911080245, 57181.714091429276, 58078.4192158073, 58742.41257587369, 58935.70532147312, 59234.70382648059, 8315.501069935823, 8420.36847236472, 8586.527740974307, 8735.301175905784, 8862.955685221532, 12902.483900644245, 13060.477580896657, 13065.0, 13139.211647301192, 13247.933760331136, 7044.753433629799, 9856.605735770489, 12024.879751202727, 12254.0, 12325.691857703629, 11846.703832403915, 11853.940730296637, 11897.583584574499, 12127.696807579881, 12155.270683759003, 6662.000699895055, 10624.0, 10849.728756781144, 12320.507179712711, 12473.376331183586, 8377.664893404195, 8618.525981071101, 8662.220400164015, 8778.429402088845, 8924.509151996443, 12004.0, 12250.938745306217, 12582.119251652663, 12656.936715316364, 12793.49729385552], "value": 9289.359343625843, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1481.422245324323, 1558.9610259743502, 1567.7569976653617, 1794.5334213104588, 1934.4970307719998, 8481.491110533365, 8707.172818582241, 8707.782305442368, 8715.041345452004, 8722.520261385622, 8580.09908959558, 8732.694355697551, 8763.167499087576, 8776.605052772624, 8782.780430489242, 1966.4493941696348, 2190.507135894427, 2263.9660405093937, 2268.092762894843, 2292.014433793468, 2270.5004898922293, 2276.9658455123185, 2283.817294616435, 2284.246198754415, 2284.291869520454, 2208.591410589046, 2271.4434963433982, 2276.681264622954, 2282.5092605089903, 2283.303592404316, 2032.410600925737, 2213.800757931786, 2256.9435764105865, 2262.5135595846973, 2272.2388000020014, 2206.2498750424934, 2242.65238887971, 2247.9887600562056, 2257.593633146033, 2261.0729600863733, 8555.401121921468, 8629.439086459422, 8645.610947507377, 8649.697260595849, 8651.826963460695, 5147.408048074444, 5274.7626356814035, 5285.973570132163, 5287.339082614673, 5366.651167674088, 3346.9665303346897, 3399.6940275375086, 3442.913927151841, 3618.5657721073376, 3645.6172101929183, 1111.1666250312267, 1153.786549488339, 1185.2888267039793, 1206.993965030178, 1216.799228127358, 12450.128491005633, 12471.625851224479, 12474.563390281297, 12478.00175985928, 12514.499420023189, 4611.9392539716055, 4684.4378674559275, 4767.4517430495935, 4771.618270538349, 4786.377770889762, 10547.050765430995, 10589.735256618493, 10604.469776511143, 10607.84088238677, 10633.255672102878, 4910.533499317559, 5338.0, 5379.65032272901, 5399.730013499309, 5419.864503387447, 4826.686265392738, 4912.778924948386, 4945.727984960861, 4957.157283261854, 4973.875653108701, 4111.6299533042165, 4111.671066314748, 4291.592298731615, 4344.674149438804, 4365.563443655609, 1331.6803967047838, 1355.1665725578698, 1358.945642174302, 1364.6793003644136, 1365.3855764905634, 930.3673502018693, 1036.124474818777, 1041.6927006533092, 1044.0864243786687, 1051.3271506235862, 5815.476607105296, 5861.606229764967, 5970.0, 5971.193888824953, 6187.412195841388, 958.4057884111755, 977.5307852230827, 979.9265055120752, 1099.2580008494235, 1142.1091548592112, 3987.6211759882763, 3999.6600288975183, 4019.8995025124023, 4096.3855421686985, 4111.490975322115, 10790.406527640898, 11089.55641774336, 11137.944310278397, 11292.774144517229, 11331.490082946288, 11031.062359699356, 11052.447377631086, 11069.667909962714, 11132.777344453227, 11146.498407571678, 8174.713885013996, 8236.876446853303, 8247.793805154799, 8258.8348233035, 8272.958635206785, 5422.457754224546, 5523.475269849358, 5665.631733937281, 5703.173039909273, 5739.139129130664, 9393.436393816393, 9395.765105872135, 9479.431234125974, 9629.614815407305, 9646.42121472714, 9134.954325228331, 9218.539073046455, 9273.211776999031, 9276.02601726836, 9305.209057230211, 6769.323067693388, 7351.522151060164, 7580.658870350737, 7613.428992825449, 7793.220677932388, 8254.257116859511, 8271.875921861056, 8285.627146778288, 8311.044229913638, 8334.83330333402, 7454.329110380092, 7655.770326890202, 7719.884201737091, 7725.459217854921, 7766.766996990099, 7446.888296675663, 7473.290037446434, 7529.247075292427, 7573.9242607575425, 7703.460757746904, 7027.859442811013, 7058.364747172779, 7072.964635176997, 7083.574985500886, 7104.467164962752, 5246.6065045121, 5288.656237344714, 5402.675839449488, 5461.344638643388, 5481.808136715355, 5089.367461486423, 5165.096108180978, 5272.367315922113, 5356.734677651671, 5458.563314934716], "value": 4656.56265667722, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.42501160579235, 350.7194244604317, 352.62651970574626, 353.4627366403067, 357.93378225028374, 6356.39614236648, 6394.0728594353905, 6404.967975160118, 6409.519286053542, 6418.775342863, 6304.6532440715855, 6325.146105275787, 6326.746930122801, 6348.650824204667, 6350.904736428957, 4594.70134441262, 4658.464276608182, 4703.670743047988, 4707.152712511746, 4731.810727570893, 4717.882052948687, 4726.361941137937, 4749.7387643679585, 4750.16872047392, 4776.880577985544, 4722.197226471508, 4746.335513028179, 4746.596539294164, 4760.166970780117, 4763.61891048717, 4593.724376537419, 4630.467496237909, 4744.098621261949, 4754.66717329787, 4755.595774359201, 4149.294619914622, 4151.750894946283, 4157.625813676784, 4176.227397931362, 4195.265828480004, 6062.514998800086, 6070.57505974582, 6075.149479072933, 6076.088586711984, 6084.421979911901, 5545.972270138624, 5559.305086864142, 5572.3034620672415, 5572.721363931828, 5582.944170558324, 6638.336166383371, 6652.833679158011, 6654.633995130266, 6654.7670831521145, 6666.0, 4309.978450107761, 4426.092651006568, 4468.4414448193975, 4673.0, 4674.579287864109, 6788.08360871281, 6812.0, 6822.215445223813, 6846.760363387258, 6855.451563874878, 4585.12882552314, 4588.357629931812, 4593.242115050979, 4594.035252596992, 4598.8620341389815, 4646.303054541778, 4648.163330600457, 4648.883777905512, 4653.371794807657, 4656.278276867091, 5396.217548455452, 5404.972975135178, 5409.56723462122, 5415.783368665288, 5416.8104116355735, 6481.254655714559, 6589.17635295588, 6605.405513503808, 6607.108040414579, 6717.294684058202, 1620.2060990114994, 1629.4704221128181, 1635.5911022244438, 1636.5663099278702, 1645.2020769926814, 1014.6651604970342, 1039.6413237433073, 1041.4063983529468, 1062.0759938853093, 1069.0325255643654, 6275.3724627537795, 6468.741250350027, 6536.934630653727, 6592.373724496165, 6594.835129121714, 6944.479164062715, 6979.3718565328345, 6992.16094068715, 6994.615296158659, 6994.790156295319, 6539.901901471481, 6560.475161987029, 6565.835854103686, 6568.408843204134, 6575.408213260829, 3720.2001569662652, 3755.7183211259266, 3763.8118094095184, 3769.7738135711943, 3774.9433758493647, 6990.0, 7254.8911766323545, 7261.0, 7267.30960558746, 7281.053463049876, 7104.289571042855, 7141.178764442156, 7143.785686429415, 7156.856862862818, 7157.24848890859, 7219.0976127984, 7231.529950553302, 7231.891521627074, 7241.601711905896, 7250.238724933912, 6934.063901373452, 6961.060256865461, 6968.4076853465995, 6970.128733908262, 6977.7208911642965, 6714.966425167843, 6806.319368063154, 6876.621785801629, 6886.070380498569, 6897.103376561015, 7209.35115839577, 7229.602371869387, 7231.602261875647, 7235.312645298688, 7239.927600723925, 4764.809407623657, 4806.639502037431, 4816.181249187716, 4826.8069277228515, 4828.61371090319, 6916.170059592881, 6917.861642767217, 6921.34247246531, 6921.446284297345, 6932.584044957319, 6577.539572229898, 6727.93272067273, 6758.5269031167345, 6771.593704377753, 6801.557898736566, 6714.52998290115, 6752.69612867432, 6754.12196414463, 6754.493412994143, 6756.45948324123, 6615.338466153346, 6624.271330153776, 6630.502712296694, 6636.0377745225705, 6641.03704962768, 6784.626845523544, 6794.42247408956, 6796.830079248059, 6803.863922721419, 6811.182658081062, 6508.60948343101, 6652.83367915806, 6653.301403352578, 6654.50091243149, 6655.134832471941], "value": 5023.185549878094, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [908.3596064774334, 910.1535571918114, 915.9512358349685, 916.1983264643433, 950.8573713942908, 14696.118232906034, 14931.0, 14991.550253492385, 15017.549473515784, 15025.0, 14076.225807580578, 14076.859231407709, 14154.858451415483, 14190.929045354784, 14200.431982720678, 769.7267470048137, 902.5261737587786, 925.564984457304, 932.0120672087609, 932.7481579973403, 916.2852974679727, 922.9861552076724, 924.7965447601517, 925.2413021322518, 925.8796356473682, 951.3673407184215, 960.9663661771839, 961.5624890674761, 961.5769061612868, 962.7641227899139, 797.3461761355691, 944.2398868910524, 957.2150836314225, 965.8985806490288, 968.3028219681853, 710.0946293475808, 711.0329951266325, 711.9786406407816, 714.7498375568562, 715.3383120613412, 14037.087589306662, 14089.929550352183, 14103.929480352635, 14155.504557340546, 14176.362063707054, 14549.927250363786, 14645.926770366186, 15007.099574025593, 15333.616659583487, 15637.530874073796, 11973.880261197364, 11996.70008249792, 12068.577599784054, 12102.394880255952, 12140.3322817245, 4733.621310295202, 4774.331593576902, 4813.855584332476, 4819.662623616348, 4870.293807397908, 57412.13881791818, 57492.42507574955, 57503.0, 57520.71239643775, 57738.42261577372, 11078.556857725762, 11145.219834611662, 11254.38100904458, 11265.436728163722, 11562.826557601642, 20370.083346249456, 20450.693239601416, 20468.590628187652, 20470.0, 20508.17967281292, 8810.427322224035, 8830.86753698695, 8850.336224783166, 8879.378443508893, 9028.322875784343, 4950.25746138075, 4962.082014827269, 4968.8757781055765, 5008.373953255843, 5039.521245481674, 3551.520544726429, 3576.6065732769375, 3590.4793804898145, 3590.838412271454, 3593.425051991721, 636.678477368935, 646.0793369448517, 659.172738213539, 672.1933679584519, 697.9720811167598, 710.705057401183, 718.6730037832774, 729.0449511140423, 749.8200431896415, 755.3994574313434, 8897.73306800797, 9137.086291370942, 9233.307501937381, 9297.209737172416, 9464.384814987141, 690.413148823506, 726.498715886037, 755.7317152410925, 755.935745461631, 781.0549235425086, 4333.241682705514, 4384.386185933972, 4398.362237475548, 4410.977945110318, 4667.533246675305, 59263.40736592579, 59310.110348343944, 59339.70330148322, 59474.10788838171, 59482.40517594855, 54288.0, 55808.441915580326, 56405.43594564002, 57137.42862571404, 57446.138307925416, 49252.75373623109, 50962.74518627383, 51605.0, 51844.74077629663, 51898.48101519012, 8530.616122274389, 8582.65669373218, 8595.269402100641, 8664.0, 8766.0, 37095.0, 37840.62159378371, 37965.24069518649, 38108.428373573865, 41646.0, 47368.52631473641, 47526.0, 47758.283625746335, 47879.28181077217, 48929.755351223015, 12713.93643031779, 12914.354282286036, 12968.09223354356, 13020.0, 13357.0, 13666.794998074838, 14017.880305721283, 14040.859591404364, 14381.784273236119, 14393.136411815325, 13117.475300987853, 13271.336433178496, 13392.0, 13535.390907409386, 13573.457061717421, 12753.48986040548, 13067.281299528617, 13210.339483026002, 13355.0, 13420.530281440493, 12623.558175464183, 12912.225266483665, 12981.286029268103, 13094.476220951055, 13179.275139867015, 10773.946130269298, 11252.66242012741, 11269.436528173723, 11426.485808138488, 11565.248258863146, 10981.3960232188, 11088.778224435628, 11369.43152842338, 11433.085353171893, 11453.427328633368], "value": 7146.681878446783, "unit": "score"}], "name": "dromaeo_css", "value": 7482.923172350775, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 109.0, 111.0, 112.0, 110.0, 106.0, 111.0, 110.0, 111.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 125.0, 156.0, 174.0, 130.0, 150.0, 152.0, 127.0, 191.0, 126.0], "value": 149.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 160.0, 160.0, 161.0, 161.0, 162.0, 161.0, 161.0, 160.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 72.0, 180.0, 76.0, 76.0, 76.0, 76.0, 178.0, 75.0], "value": 96.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 144.0, 92.0, 92.0, 92.0, 148.0, 91.0, 92.0, 152.0], "value": 108.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 146.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 54.0, 54.0, 52.0, 55.0, 56.0, 77.0, 53.0, 52.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 59.0, 58.0, 58.0, 58.0, 57.0, 57.0, 57.0, 57.0, 57.0], "value": 57.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 72.0, 71.0, 79.0, 73.0, 73.0, 74.0, 75.0, 72.0], "value": 73.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 124.0, 119.0, 117.0, 115.0, 119.0, 114.0, 113.0, 136.0, 137.0], "value": 121.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 164.0, 157.0, 163.0, 158.0, 162.0, 164.0, 156.0, 155.0, 155.0], "value": 159.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 66.0, 67.0, 66.0, 65.0, 67.0, 69.0, 62.0], "value": 66.4, "unit": "score"}], "name": "kraken", "value": 1515.5, "alertThreshold": 2.0}]} 03:52:51 INFO - Return code: 0 03:52:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:52:51 ERROR - # TBPL SUCCESS # 03:52:51 INFO - Running post-action listener: _resource_record_post_action 03:52:51 INFO - Running post-run listener: _resource_record_post_run 03:52:52 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 262144; Write bytes: 448667648; Read time: 12; Write time: 330420 03:52:52 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 207503360; Read time: 0; Write time: 187968 03:52:52 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 262144; Write bytes: 241164288; Read time: 12; Write time: 142452 03:52:52 INFO - Running post-run listener: _upload_blobber_files 03:52:52 INFO - Blob upload gear active. 03:52:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:52:52 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 03:52:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:52:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:52:53 INFO - (blobuploader) - INFO - Open directory for files ... 03:52:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:52:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:52:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:52:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:52:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:52:53 INFO - (blobuploader) - INFO - Done attempting. 03:52:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:52:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:52:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:52:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:52:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:52:54 INFO - (blobuploader) - INFO - Done attempting. 03:52:54 INFO - (blobuploader) - INFO - Iteration through files over. 03:52:54 INFO - Return code: 0 03:52:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:52:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:52:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6751fb853abb28cc227a7e29e3aba4b7c1616ada96d38a2d833ed5c4012fa31c187d52b4311847f326a51c04f3c238ebdcd35d82937950e2a08b9868fdbd7699", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f7331958e04490e0f12d02b79e0a757c60f67a5432c9e2634e15a8f9b5e329d0a67d6ab429c0ab7cf19cc68cfdae5e80479d38e4be5a7d8cafb6b2944f95115b"} 03:52:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:52:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:52:54 INFO - Contents: 03:52:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6751fb853abb28cc227a7e29e3aba4b7c1616ada96d38a2d833ed5c4012fa31c187d52b4311847f326a51c04f3c238ebdcd35d82937950e2a08b9868fdbd7699", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f7331958e04490e0f12d02b79e0a757c60f67a5432c9e2634e15a8f9b5e329d0a67d6ab429c0ab7cf19cc68cfdae5e80479d38e4be5a7d8cafb6b2944f95115b"} 03:52:54 INFO - Running post-run listener: copy_logs_to_upload_dir 03:52:54 INFO - Copying logs to upload dir... 03:52:54 INFO - mkdir: /builds/slave/test/build/upload/logs 03:52:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.232913 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-22 03:52:53.907747) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-22 03:52:53.910993) ========= 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=0333a256a5e4f052382dd180000001b1-1463910357.695990-1034311429 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6751fb853abb28cc227a7e29e3aba4b7c1616ada96d38a2d833ed5c4012fa31c187d52b4311847f326a51c04f3c238ebdcd35d82937950e2a08b9868fdbd7699", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f7331958e04490e0f12d02b79e0a757c60f67a5432c9e2634e15a8f9b5e329d0a67d6ab429c0ab7cf19cc68cfdae5e80479d38e4be5a7d8cafb6b2944f95115b"} build_url:https://queue.taskcluster.net/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011480 build_url: 'https://queue.taskcluster.net/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6751fb853abb28cc227a7e29e3aba4b7c1616ada96d38a2d833ed5c4012fa31c187d52b4311847f326a51c04f3c238ebdcd35d82937950e2a08b9868fdbd7699", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f7331958e04490e0f12d02b79e0a757c60f67a5432c9e2634e15a8f9b5e329d0a67d6ab429c0ab7cf19cc68cfdae5e80479d38e4be5a7d8cafb6b2944f95115b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-22 03:52:53.941354) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-22 03:52:53.942142) ========= 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=0333a256a5e4f052382dd180000001b1-1463910357.695990-1034311429 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004427 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-22 03:52:54.023706) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-22 03:52:54.024032) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-22 03:52:54.024340) ========= ========= Total master_lag: 0.18 =========