builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-030 starttime: 1461258272.36 results: success (0) buildid: 20160421043116 builduid: 6fc5824b2aae4d67b3b5d208c565461c revision: 4e3ad95d689a5beabf3c1f41d958794fe00e3767 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 10:04:32.362554) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 10:04:32.363080) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 10:04:32.363374) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 10:04:32.380223) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 10:04:32.380605) ========= 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=4ac8d263c7293b36a1be1aed000001be-1461258228.916943-2064754446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-21 10:04:32-- 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% 33.1M=0s 2016-04-21 10:04:32 (33.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110120 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 10:04:32.504488) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 10:04:32.504801) ========= 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=4ac8d263c7293b36a1be1aed000001be-1461258228.916943-2064754446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015966 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 10:04:32.554950) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 10:04:32.555345) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4e3ad95d689a5beabf3c1f41d958794fe00e3767 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 4e3ad95d689a5beabf3c1f41d958794fe00e3767 --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=4ac8d263c7293b36a1be1aed000001be-1461258228.916943-2064754446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-21 10:04:32,708 truncating revision to first 12 chars 2016-04-21 10:04:32,708 Setting DEBUG logging. 2016-04-21 10:04:32,708 attempt 1/10 2016-04-21 10:04:32,708 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4e3ad95d689a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-21 10:04:33,011 unpacking tar archive at: mozilla-central-4e3ad95d689a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.576906 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 10:04:33.145096) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 10:04:33.145407) ========= script_repo_revision: 4e3ad95d689a5beabf3c1f41d958794fe00e3767 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 10:04:33.145815) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 10:04:33.146097) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 10:04:33.155245) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-04-21 10:04:33.155629) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4ac8d263c7293b36a1be1aed000001be-1461258228.916943-2064754446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:04:33 INFO - MultiFileLogger online at 20160421 10:04:33 in /builds/slave/test 10:04:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:04:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:04:33 INFO - {'append_to_log': False, 10:04:33 INFO - 'base_work_dir': '/builds/slave/test', 10:04:33 INFO - 'blob_upload_branch': 'Firefox', 10:04:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:04:33 INFO - 'branch': 'Firefox', 10:04:33 INFO - 'buildbot_json_path': 'buildprops.json', 10:04:33 INFO - 'config_files': ('talos/linux_config.py',), 10:04:33 INFO - 'default_actions': ('clobber', 10:04:33 INFO - 'read-buildbot-config', 10:04:33 INFO - 'download-and-extract', 10:04:33 INFO - 'populate-webroot', 10:04:33 INFO - 'create-virtualenv', 10:04:33 INFO - 'install', 10:04:33 INFO - 'run-tests'), 10:04:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:04:33 INFO - 'download_minidump_stackwalk': True, 10:04:33 INFO - 'download_symbols': 'ondemand', 10:04:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:04:33 INFO - 'tooltool.py': '/tools/tooltool.py', 10:04:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:04:33 INFO - '/tools/misc-python/virtualenv.py')}, 10:04:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:04:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:04:33 INFO - 'installer_path': 'installer.exe', 10:04:33 INFO - 'log_level': 'info', 10:04:33 INFO - 'log_name': 'talos', 10:04:33 INFO - 'log_to_console': True, 10:04:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:04:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:04:33 INFO - 'opt_config_files': (), 10:04:33 INFO - 'pip_index': False, 10:04:33 INFO - 'sps_profile': False, 10:04:33 INFO - 'sps_profile_interval': 0, 10:04:33 INFO - 'suite': 'dromaeojs', 10:04:33 INFO - 'system_bits': '32', 10:04:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:04:33 INFO - 'title': 'talos-linux64-ix-030', 10:04:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:04:33 INFO - 'use_talos_json': True, 10:04:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:04:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:04:33 INFO - 'work_dir': 'build'} 10:04:33 INFO - ##### 10:04:33 INFO - ##### Running clobber step. 10:04:33 INFO - ##### 10:04:33 INFO - Running pre-action listener: _resource_record_pre_action 10:04:33 INFO - Running main action method: clobber 10:04:33 INFO - rmtree: /builds/slave/test/build 10:04:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:04:33 INFO - Running post-action listener: _resource_record_post_action 10:04:33 INFO - ##### 10:04:33 INFO - ##### Running read-buildbot-config step. 10:04:33 INFO - ##### 10:04:33 INFO - Running pre-action listener: _resource_record_pre_action 10:04:33 INFO - Running main action method: read_buildbot_config 10:04:33 INFO - Using buildbot properties: 10:04:33 INFO - { 10:04:33 INFO - "project": "", 10:04:33 INFO - "product": "firefox", 10:04:33 INFO - "script_repo_revision": "production", 10:04:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 10:04:33 INFO - "repository": "", 10:04:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 10:04:33 INFO - "buildid": "20160421043116", 10:04:33 INFO - "pgo_build": "True", 10:04:33 INFO - "basedir": "/builds/slave/test", 10:04:33 INFO - "buildnumber": 413, 10:04:33 INFO - "slavename": "talos-linux64-ix-030", 10:04:33 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:04:33 INFO - "platform": "ubuntu64_hw", 10:04:33 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 10:04:33 INFO - "branch": "mozilla-central", 10:04:33 INFO - "repo_path": "mozilla-central", 10:04:33 INFO - "revision": "4e3ad95d689a5beabf3c1f41d958794fe00e3767", 10:04:33 INFO - "stage_platform": "linux64-pgo", 10:04:33 INFO - "builduid": "6fc5824b2aae4d67b3b5d208c565461c", 10:04:33 INFO - "slavebuilddir": "test" 10:04:33 INFO - } 10:04:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/AEOvskxPTPmGIRx_GmE9Aw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 10:04:33 INFO - Running post-action listener: _resource_record_post_action 10:04:33 INFO - ##### 10:04:33 INFO - ##### Running download-and-extract step. 10:04:33 INFO - ##### 10:04:33 INFO - Running pre-action listener: _resource_record_pre_action 10:04:33 INFO - Running main action method: download_and_extract 10:04:33 INFO - mkdir: /builds/slave/test/build/tests 10:04:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:33 INFO - https://queue.taskcluster.net/v1/task/AEOvskxPTPmGIRx_GmE9Aw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:04:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AEOvskxPTPmGIRx_GmE9Aw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:04:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AEOvskxPTPmGIRx_GmE9Aw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:04:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AEOvskxPTPmGIRx_GmE9Aw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:04:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AEOvskxPTPmGIRx_GmE9Aw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:04:34 INFO - Downloaded 1361 bytes. 10:04:34 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:04:34 INFO - Using the following test package requirements: 10:04:34 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 10:04:34 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:04:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:04:34 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:04:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:04:34 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:04:34 INFO - u'jsshell-linux-x86_64.zip'], 10:04:34 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:04:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:04:34 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 10:04:34 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:04:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:04:34 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:04:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:04:34 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:04:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:04:34 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:04:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:04:34 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:04: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')]} 10:04:34 INFO - https://queue.taskcluster.net/v1/task/AEOvskxPTPmGIRx_GmE9Aw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:04:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AEOvskxPTPmGIRx_GmE9Aw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:04:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AEOvskxPTPmGIRx_GmE9Aw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:04:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AEOvskxPTPmGIRx_GmE9Aw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:04:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AEOvskxPTPmGIRx_GmE9Aw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:04:36 INFO - Downloaded 23847466 bytes. 10:04:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:04:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:04:37 INFO - Return code: 0 10:04:37 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:04:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:37 INFO - https://queue.taskcluster.net/v1/task/AEOvskxPTPmGIRx_GmE9Aw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:04:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AEOvskxPTPmGIRx_GmE9Aw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:04:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AEOvskxPTPmGIRx_GmE9Aw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:04:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AEOvskxPTPmGIRx_GmE9Aw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:04:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AEOvskxPTPmGIRx_GmE9Aw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:04:39 INFO - Downloaded 23847466 bytes. 10:04:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:04:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:04:41 INFO - Return code: 0 10:04:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:41 INFO - https://queue.taskcluster.net/v1/task/AEOvskxPTPmGIRx_GmE9Aw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:04:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AEOvskxPTPmGIRx_GmE9Aw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 10:04:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AEOvskxPTPmGIRx_GmE9Aw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 10:04:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AEOvskxPTPmGIRx_GmE9Aw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 10:04:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AEOvskxPTPmGIRx_GmE9Aw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:04:42 INFO - Downloaded 10845952 bytes. 10:04:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:04:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:04:42 INFO - Return code: 0 10:04:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:42 INFO - https://queue.taskcluster.net/v1/task/AEOvskxPTPmGIRx_GmE9Aw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:04:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AEOvskxPTPmGIRx_GmE9Aw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:04:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AEOvskxPTPmGIRx_GmE9Aw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:04:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AEOvskxPTPmGIRx_GmE9Aw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:04:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AEOvskxPTPmGIRx_GmE9Aw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:04:43 INFO - Downloaded 58302246 bytes. 10:04:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AEOvskxPTPmGIRx_GmE9Aw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:04:43 INFO - mkdir: /builds/slave/test/properties 10:04:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:04:43 INFO - Writing to file /builds/slave/test/properties/build_url 10:04:43 INFO - Contents: 10:04:43 INFO - build_url:https://queue.taskcluster.net/v1/task/AEOvskxPTPmGIRx_GmE9Aw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:04:44 INFO - Running post-action listener: _resource_record_post_action 10:04:44 INFO - Running post-action listener: set_extra_try_arguments 10:04:44 INFO - ##### 10:04:44 INFO - ##### Running populate-webroot step. 10:04:44 INFO - ##### 10:04:44 INFO - Running pre-action listener: _resource_record_pre_action 10:04:44 INFO - Running main action method: populate_webroot 10:04:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:04:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:04:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:04:44 INFO - '--tppagecycles', 10:04:44 INFO - '7'], 10:04:44 INFO - 'tests': ['tsvgm']}}, 10:04:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:04:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:04:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:04:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:04:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:04:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:04:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:44 INFO - 'talos_options': ['--disable-e10s'], 10:04:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:04:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:04:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:44 INFO - 'talos_options': ['--disable-e10s'], 10:04:44 INFO - 'tests': ['damp', 'tps']}, 10:04:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:44 INFO - 'tests': ['damp', 'tps']}, 10:04:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:04:44 INFO - 'tests': ['dromaeo_dom']}, 10:04:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:04:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:04:44 INFO - 'tests': ['a11yr', 10:04:44 INFO - 'ts_paint', 10:04:44 INFO - 'tpaint', 10:04:44 INFO - 'sessionrestore', 10:04:44 INFO - 'sessionrestore_no_auto_restore', 10:04:44 INFO - 'tabpaint']}, 10:04:44 INFO - 'other-e10s': {'tests': ['a11yr', 10:04:44 INFO - 'ts_paint', 10:04:44 INFO - 'tpaint', 10:04:44 INFO - 'sessionrestore', 10:04:44 INFO - 'sessionrestore_no_auto_restore', 10:04:44 INFO - 'tabpaint']}, 10:04:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:04:44 INFO - 'ts_paint', 10:04:44 INFO - 'tpaint', 10:04:44 INFO - 'sessionrestore', 10:04:44 INFO - 'sessionrestore_no_auto_restore', 10:04:44 INFO - 'tabpaint']}, 10:04:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:04:44 INFO - 'ts_paint', 10:04:44 INFO - 'tpaint', 10:04:44 INFO - 'sessionrestore', 10:04:44 INFO - 'sessionrestore_no_auto_restore', 10:04:44 INFO - 'tabpaint']}, 10:04:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:04:44 INFO - 'tests': ['a11yr', 10:04:44 INFO - 'ts_paint', 10:04:44 INFO - 'tpaint', 10:04:44 INFO - 'sessionrestore', 10:04:44 INFO - 'sessionrestore_no_auto_restore', 10:04:44 INFO - 'tabpaint']}, 10:04:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:04:44 INFO - 'tests': ['a11yr', 10:04:44 INFO - 'ts_paint', 10:04:44 INFO - 'tpaint', 10:04:44 INFO - 'sessionrestore', 10:04:44 INFO - 'sessionrestore_no_auto_restore', 10:04:44 INFO - 'tabpaint']}, 10:04:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:04:44 INFO - 'tests': ['tsvgx', 10:04:44 INFO - 'tsvgr_opacity', 10:04:44 INFO - 'tart', 10:04:44 INFO - 'tscrollx', 10:04:44 INFO - 'cart']}, 10:04:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:04:44 INFO - 'tsvgr_opacity', 10:04:44 INFO - 'tart', 10:04:44 INFO - 'tscrollx', 10:04:44 INFO - 'cart']}, 10:04:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:44 INFO - 'talos_options': ['--disable-e10s'], 10:04:44 INFO - 'tests': ['tp5o']}, 10:04:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:44 INFO - 'tests': ['tp5o']}, 10:04:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:44 INFO - 'talos_options': ['--disable-e10s', 10:04:44 INFO - '--xperf_path', 10:04:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:04:44 INFO - 'tests': ['tp5n']}, 10:04:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:44 INFO - 'talos_options': ['--xperf_path', 10:04:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:04:44 INFO - 'tests': ['tp5n']}}, 10:04:44 INFO - 'talos.zip': {'path': '', 10:04:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:04:44 INFO - Running post-action listener: _resource_record_post_action 10:04:44 INFO - ##### 10:04:44 INFO - ##### Running create-virtualenv step. 10:04:44 INFO - ##### 10:04:44 INFO - Running pre-action listener: _resource_record_pre_action 10:04:44 INFO - Running main action method: create_virtualenv 10:04:44 INFO - Creating virtualenv /builds/slave/test/build/venv 10:04:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:04:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:04:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:04:44 INFO - Using real prefix '/usr' 10:04:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:04:45 INFO - Installing distribute.............................................................................................................................................................................................done. 10:04:47 INFO - Installing pip.................done. 10:04:47 INFO - Return code: 0 10:04:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:04:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:47 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 0x7f2fef094f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b29a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1741810>, '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 0x1742710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1742ba0>, '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': '4ac8d263c7293b36a1be1aed000001be-1461258228.916943-2064754446', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:04:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:04:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:04:47 INFO - Using env: {'DISPLAY': ':0', 10:04:47 INFO - 'HOME': '/home/cltbld', 10:04:47 INFO - 'LANG': 'en_US.UTF-8', 10:04:47 INFO - 'LANGUAGE': 'en_US:en', 10:04:47 INFO - 'LOGNAME': 'cltbld', 10:04:47 INFO - 'MAIL': '/var/mail/cltbld', 10:04:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:47 INFO - 'MOZ_NO_REMOTE': '1', 10:04:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:47 INFO - 'NO_EM_RESTART': '1', 10:04:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:47 INFO - 'PWD': '/builds/slave/test', 10:04:47 INFO - 'SHELL': '/bin/bash', 10:04:47 INFO - 'SHLVL': '1', 10:04:47 INFO - 'TERM': 'linux', 10:04:47 INFO - 'TMOUT': '86400', 10:04:47 INFO - 'USER': 'cltbld', 10:04:47 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1461258228.916943-2064754446', 10:04:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:47 INFO - '_': '/tools/buildbot/bin/python'} 10:04:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:47 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:04:47 INFO - Cleaning up... 10:04:47 INFO - Return code: 0 10:04:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:04:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:47 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 0x7f2fef094f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b29a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1741810>, '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 0x1742710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1742ba0>, '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': '4ac8d263c7293b36a1be1aed000001be-1461258228.916943-2064754446', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:04:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 10:04:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:04:47 INFO - Using env: {'DISPLAY': ':0', 10:04:47 INFO - 'HOME': '/home/cltbld', 10:04:47 INFO - 'LANG': 'en_US.UTF-8', 10:04:47 INFO - 'LANGUAGE': 'en_US:en', 10:04:47 INFO - 'LOGNAME': 'cltbld', 10:04:47 INFO - 'MAIL': '/var/mail/cltbld', 10:04:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:47 INFO - 'MOZ_NO_REMOTE': '1', 10:04:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:47 INFO - 'NO_EM_RESTART': '1', 10:04:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:47 INFO - 'PWD': '/builds/slave/test', 10:04:47 INFO - 'SHELL': '/bin/bash', 10:04:47 INFO - 'SHLVL': '1', 10:04:47 INFO - 'TERM': 'linux', 10:04:47 INFO - 'TMOUT': '86400', 10:04:47 INFO - 'USER': 'cltbld', 10:04:47 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1461258228.916943-2064754446', 10:04:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:47 INFO - '_': '/tools/buildbot/bin/python'} 10:04:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:47 INFO - Downloading/unpacking psutil>=0.7.1 10:04:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:04:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:04:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:04:49 INFO - Installing collected packages: psutil 10:04:49 INFO - Running setup.py install for psutil 10:04:49 INFO - building 'psutil._psutil_linux' extension 10:04:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:04:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:04:49 INFO - building 'psutil._psutil_posix' extension 10:04:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:04:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:04:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:04:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:04:50 INFO - Successfully installed psutil 10:04:50 INFO - Cleaning up... 10:04:50 INFO - Return code: 0 10:04:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:50 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 0x7f2fef094f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b29a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1741810>, '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 0x1742710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1742ba0>, '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': '4ac8d263c7293b36a1be1aed000001be-1461258228.916943-2064754446', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:04:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:04:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:04:50 INFO - Using env: {'DISPLAY': ':0', 10:04:50 INFO - 'HOME': '/home/cltbld', 10:04:50 INFO - 'LANG': 'en_US.UTF-8', 10:04:50 INFO - 'LANGUAGE': 'en_US:en', 10:04:50 INFO - 'LOGNAME': 'cltbld', 10:04:50 INFO - 'MAIL': '/var/mail/cltbld', 10:04:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:50 INFO - 'MOZ_NO_REMOTE': '1', 10:04:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:50 INFO - 'NO_EM_RESTART': '1', 10:04:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:50 INFO - 'PWD': '/builds/slave/test', 10:04:50 INFO - 'SHELL': '/bin/bash', 10:04:50 INFO - 'SHLVL': '1', 10:04:50 INFO - 'TERM': 'linux', 10:04:50 INFO - 'TMOUT': '86400', 10:04:50 INFO - 'USER': 'cltbld', 10:04:50 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1461258228.916943-2064754446', 10:04:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:50 INFO - '_': '/tools/buildbot/bin/python'} 10:04:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:04: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 10:04: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 10:04: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 10:04: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 10:04: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 10:04: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 10:04:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:04:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:04:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:04:52 INFO - Installing collected packages: mozsystemmonitor 10:04:52 INFO - Running setup.py install for mozsystemmonitor 10:04:52 INFO - Successfully installed mozsystemmonitor 10:04:52 INFO - Cleaning up... 10:04:52 INFO - Return code: 0 10:04:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:04:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:52 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 0x7f2fef094f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b29a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1741810>, '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 0x1742710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1742ba0>, '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': '4ac8d263c7293b36a1be1aed000001be-1461258228.916943-2064754446', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:04:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:04:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:04:52 INFO - Using env: {'DISPLAY': ':0', 10:04:52 INFO - 'HOME': '/home/cltbld', 10:04:52 INFO - 'LANG': 'en_US.UTF-8', 10:04:52 INFO - 'LANGUAGE': 'en_US:en', 10:04:52 INFO - 'LOGNAME': 'cltbld', 10:04:52 INFO - 'MAIL': '/var/mail/cltbld', 10:04:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:52 INFO - 'MOZ_NO_REMOTE': '1', 10:04:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:52 INFO - 'NO_EM_RESTART': '1', 10:04:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:52 INFO - 'PWD': '/builds/slave/test', 10:04:52 INFO - 'SHELL': '/bin/bash', 10:04:52 INFO - 'SHLVL': '1', 10:04:52 INFO - 'TERM': 'linux', 10:04:52 INFO - 'TMOUT': '86400', 10:04:52 INFO - 'USER': 'cltbld', 10:04:52 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1461258228.916943-2064754446', 10:04:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:52 INFO - '_': '/tools/buildbot/bin/python'} 10:04:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:52 INFO - Downloading/unpacking blobuploader==1.2.4 10:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:54 INFO - Downloading blobuploader-1.2.4.tar.gz 10:04:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:04:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:04:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:04:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:55 INFO - Downloading docopt-0.6.1.tar.gz 10:04:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:04:55 INFO - Installing collected packages: blobuploader, requests, docopt 10:04:55 INFO - Running setup.py install for blobuploader 10:04:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:04:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:04:55 INFO - Running setup.py install for requests 10:04:55 INFO - Running setup.py install for docopt 10:04:55 INFO - Successfully installed blobuploader requests docopt 10:04:55 INFO - Cleaning up... 10:04:55 INFO - Return code: 0 10:04:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:04: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')]} 10:04:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04: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')]} 10:04:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2fef094f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b29a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1741810>, '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 0x1742710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1742ba0>, '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': '4ac8d263c7293b36a1be1aed000001be-1461258228.916943-2064754446', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:04:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:04:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:04:55 INFO - Using env: {'DISPLAY': ':0', 10:04:55 INFO - 'HOME': '/home/cltbld', 10:04:55 INFO - 'LANG': 'en_US.UTF-8', 10:04:55 INFO - 'LANGUAGE': 'en_US:en', 10:04:55 INFO - 'LOGNAME': 'cltbld', 10:04:55 INFO - 'MAIL': '/var/mail/cltbld', 10:04:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:55 INFO - 'MOZ_NO_REMOTE': '1', 10:04:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:55 INFO - 'NO_EM_RESTART': '1', 10:04:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:55 INFO - 'PWD': '/builds/slave/test', 10:04:55 INFO - 'SHELL': '/bin/bash', 10:04:55 INFO - 'SHLVL': '1', 10:04:55 INFO - 'TERM': 'linux', 10:04:55 INFO - 'TMOUT': '86400', 10:04:55 INFO - 'USER': 'cltbld', 10:04:55 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1461258228.916943-2064754446', 10:04:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:55 INFO - '_': '/tools/buildbot/bin/python'} 10:04:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:04:56 INFO - Running setup.py (path:/tmp/pip-Sepwcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:04:56 INFO - Running setup.py (path:/tmp/pip-M_2Bbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:04:56 INFO - Running setup.py (path:/tmp/pip-L4i0NG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:04:56 INFO - Running setup.py (path:/tmp/pip-JyiHk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:04:56 INFO - Running setup.py (path:/tmp/pip-VApNWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:04:56 INFO - Running setup.py (path:/tmp/pip-6d24fu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:04:56 INFO - Running setup.py (path:/tmp/pip-SIvc8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:04:56 INFO - Running setup.py (path:/tmp/pip-5dk50O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:04:56 INFO - Running setup.py (path:/tmp/pip-TmU5bO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:04:56 INFO - Running setup.py (path:/tmp/pip-5OMCvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:04:56 INFO - Running setup.py (path:/tmp/pip-A00P7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:04:56 INFO - Running setup.py (path:/tmp/pip-iWRpMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:04:57 INFO - Running setup.py (path:/tmp/pip-e6DEEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:04:57 INFO - Running setup.py (path:/tmp/pip-4Eh48v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:04:57 INFO - Running setup.py (path:/tmp/pip-5krnBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:04:57 INFO - Running setup.py (path:/tmp/pip-Bbu3UQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:04:57 INFO - Running setup.py (path:/tmp/pip-7sD1mi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:04:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:04:57 INFO - Running setup.py install for manifestparser 10:04:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:04:57 INFO - Running setup.py install for mozcrash 10:04:57 INFO - Running setup.py install for mozdebug 10:04:57 INFO - Running setup.py install for mozdevice 10:04:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:04:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:04:57 INFO - Running setup.py install for mozfile 10:04:57 INFO - Running setup.py install for mozhttpd 10:04:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:04:57 INFO - Running setup.py install for mozinfo 10:04:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:04:58 INFO - Running setup.py install for mozInstall 10:04:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:04:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:04:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:04:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:04:58 INFO - Running setup.py install for mozleak 10:04:58 INFO - Running setup.py install for mozlog 10:04:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:04:58 INFO - Running setup.py install for moznetwork 10:04:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:04:58 INFO - Running setup.py install for mozprocess 10:04:58 INFO - Running setup.py install for mozprofile 10:04:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:04:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:04:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:04:58 INFO - Running setup.py install for mozrunner 10:04:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:04:58 INFO - Running setup.py install for mozscreenshot 10:04:58 INFO - Running setup.py install for moztest 10:04:59 INFO - Running setup.py install for mozversion 10:04:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:04:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:04:59 INFO - Cleaning up... 10:04:59 INFO - Return code: 0 10:04:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:04: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')]} 10:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04: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')]} 10:04:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:59 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 0x7f2fef094f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b29a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1741810>, '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 0x1742710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1742ba0>, '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': '4ac8d263c7293b36a1be1aed000001be-1461258228.916943-2064754446', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:04:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:04:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:04:59 INFO - Using env: {'DISPLAY': ':0', 10:04:59 INFO - 'HOME': '/home/cltbld', 10:04:59 INFO - 'LANG': 'en_US.UTF-8', 10:04:59 INFO - 'LANGUAGE': 'en_US:en', 10:04:59 INFO - 'LOGNAME': 'cltbld', 10:04:59 INFO - 'MAIL': '/var/mail/cltbld', 10:04:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:59 INFO - 'MOZ_NO_REMOTE': '1', 10:04:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:59 INFO - 'NO_EM_RESTART': '1', 10:04:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:59 INFO - 'PWD': '/builds/slave/test', 10:04:59 INFO - 'SHELL': '/bin/bash', 10:04:59 INFO - 'SHLVL': '1', 10:04:59 INFO - 'TERM': 'linux', 10:04:59 INFO - 'TMOUT': '86400', 10:04:59 INFO - 'USER': 'cltbld', 10:04:59 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1461258228.916943-2064754446', 10:04:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:59 INFO - '_': '/tools/buildbot/bin/python'} 10:04:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:04:59 INFO - Running setup.py (path:/tmp/pip-iQMZ5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:04:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:04:59 INFO - Running setup.py (path:/tmp/pip-i5NV4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:04:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:04:59 INFO - Running setup.py (path:/tmp/pip-sJARWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:04:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:04:59 INFO - Running setup.py (path:/tmp/pip-eWIlNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:04:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:04:59 INFO - Running setup.py (path:/tmp/pip-Wa6zgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:04:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:04:59 INFO - Running setup.py (path:/tmp/pip-nftpIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:04:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:04:59 INFO - Running setup.py (path:/tmp/pip-b5OYj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:04:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:04:59 INFO - Running setup.py (path:/tmp/pip-_OqWnP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:04:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:04:59 INFO - Running setup.py (path:/tmp/pip-snPqMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:04:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:05:00 INFO - Running setup.py (path:/tmp/pip-d7CTg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:05:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:05:00 INFO - Running setup.py (path:/tmp/pip-dEKKBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:05:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:05:00 INFO - Running setup.py (path:/tmp/pip-IaHwn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:05:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:05:00 INFO - Running setup.py (path:/tmp/pip-3XIDg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:05:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:05:00 INFO - Running setup.py (path:/tmp/pip-XVIeZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:05:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:00 INFO - Running setup.py (path:/tmp/pip-QHQD8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:05:00 INFO - Running setup.py (path:/tmp/pip-nX7N92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:05:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:05:00 INFO - Running setup.py (path:/tmp/pip-EkV_o5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:05:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:05:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:05:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:05:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:05:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:05:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:05:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:05:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:02 INFO - Downloading blessings-1.6.tar.gz 10:05:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:05:02 INFO - Installing collected packages: blessings 10:05:02 INFO - Running setup.py install for blessings 10:05:02 INFO - Successfully installed blessings 10:05:02 INFO - Cleaning up... 10:05:02 INFO - Return code: 0 10:05:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:05:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:05:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:05:02 INFO - Reading from file tmpfile_stdout 10:05:02 INFO - Current package versions: 10:05:02 INFO - argparse == 1.2.1 10:05:02 INFO - blessings == 1.6 10:05:02 INFO - blobuploader == 1.2.4 10:05:02 INFO - docopt == 0.6.1 10:05:02 INFO - manifestparser == 1.1 10:05:02 INFO - mozInstall == 1.12 10:05:02 INFO - mozcrash == 0.17 10:05:02 INFO - mozdebug == 0.1 10:05:02 INFO - mozdevice == 0.48 10:05:02 INFO - mozfile == 1.2 10:05:02 INFO - mozhttpd == 0.7 10:05:02 INFO - mozinfo == 0.9 10:05:02 INFO - mozleak == 0.1 10:05:02 INFO - mozlog == 3.1 10:05:02 INFO - moznetwork == 0.27 10:05:02 INFO - mozprocess == 0.22 10:05:02 INFO - mozprofile == 0.28 10:05:02 INFO - mozrunner == 6.11 10:05:02 INFO - mozscreenshot == 0.1 10:05:02 INFO - mozsystemmonitor == 0.0 10:05:02 INFO - moztest == 0.7 10:05:02 INFO - mozversion == 1.4 10:05:02 INFO - psutil == 3.1.1 10:05:02 INFO - requests == 1.2.3 10:05:02 INFO - wsgiref == 0.1.2 10:05:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2fef094f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b29a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1741810>, '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 0x1742710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1742ba0>, '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': '4ac8d263c7293b36a1be1aed000001be-1461258228.916943-2064754446', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:05:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:05:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:05:02 INFO - Using env: {'DISPLAY': ':0', 10:05:02 INFO - 'HOME': '/home/cltbld', 10:05:02 INFO - 'LANG': 'en_US.UTF-8', 10:05:02 INFO - 'LANGUAGE': 'en_US:en', 10:05:02 INFO - 'LOGNAME': 'cltbld', 10:05:02 INFO - 'MAIL': '/var/mail/cltbld', 10:05:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:02 INFO - 'MOZ_NO_REMOTE': '1', 10:05:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:02 INFO - 'NO_EM_RESTART': '1', 10:05:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:02 INFO - 'PWD': '/builds/slave/test', 10:05:02 INFO - 'SHELL': '/bin/bash', 10:05:02 INFO - 'SHLVL': '1', 10:05:02 INFO - 'TERM': 'linux', 10:05:02 INFO - 'TMOUT': '86400', 10:05:02 INFO - 'USER': 'cltbld', 10:05:02 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1461258228.916943-2064754446', 10:05:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:02 INFO - '_': '/tools/buildbot/bin/python'} 10:05:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:05:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:05:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:05:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:05:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:05:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:05:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:05:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:05:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:05:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:05:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:05:03 INFO - Cleaning up... 10:05:03 INFO - Return code: 0 10:05:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:05:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:03 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 0x7f2fef094f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b29a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1741810>, '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 0x1742710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1742ba0>, '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': '4ac8d263c7293b36a1be1aed000001be-1461258228.916943-2064754446', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:05:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:05:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:05:03 INFO - Using env: {'DISPLAY': ':0', 10:05:03 INFO - 'HOME': '/home/cltbld', 10:05:03 INFO - 'LANG': 'en_US.UTF-8', 10:05:03 INFO - 'LANGUAGE': 'en_US:en', 10:05:03 INFO - 'LOGNAME': 'cltbld', 10:05:03 INFO - 'MAIL': '/var/mail/cltbld', 10:05:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:03 INFO - 'MOZ_NO_REMOTE': '1', 10:05:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:03 INFO - 'NO_EM_RESTART': '1', 10:05:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:03 INFO - 'PWD': '/builds/slave/test', 10:05:03 INFO - 'SHELL': '/bin/bash', 10:05:03 INFO - 'SHLVL': '1', 10:05:03 INFO - 'TERM': 'linux', 10:05:03 INFO - 'TMOUT': '86400', 10:05:03 INFO - 'USER': 'cltbld', 10:05:03 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1461258228.916943-2064754446', 10:05:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:03 INFO - '_': '/tools/buildbot/bin/python'} 10:05:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:03 INFO - Downloading/unpacking jsonschema 10:05:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:05:05 INFO - Downloading/unpacking functools32 (from jsonschema) 10:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:05 INFO - Downloading functools32-3.2.3-2.tar.gz 10:05:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:05:05 INFO - warning: no files found matching '*.txt' 10:05:05 INFO - no previously-included directories found matching 'build' 10:05:05 INFO - no previously-included directories found matching 'dist' 10:05:05 INFO - no previously-included directories found matching '.git*' 10:05:05 INFO - Installing collected packages: jsonschema, functools32 10:05:05 INFO - Running setup.py install for functools32 10:05:05 INFO - warning: no files found matching '*.txt' 10:05:05 INFO - no previously-included directories found matching 'build' 10:05:05 INFO - no previously-included directories found matching 'dist' 10:05:05 INFO - no previously-included directories found matching '.git*' 10:05:05 INFO - Successfully installed jsonschema functools32 10:05:05 INFO - Cleaning up... 10:05:05 INFO - Return code: 0 10:05:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2fef094f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b29a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1741810>, '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 0x1742710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1742ba0>, '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': '4ac8d263c7293b36a1be1aed000001be-1461258228.916943-2064754446', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:05:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:05:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:05:05 INFO - Using env: {'DISPLAY': ':0', 10:05:05 INFO - 'HOME': '/home/cltbld', 10:05:05 INFO - 'LANG': 'en_US.UTF-8', 10:05:05 INFO - 'LANGUAGE': 'en_US:en', 10:05:05 INFO - 'LOGNAME': 'cltbld', 10:05:05 INFO - 'MAIL': '/var/mail/cltbld', 10:05:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:05 INFO - 'MOZ_NO_REMOTE': '1', 10:05:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:05 INFO - 'NO_EM_RESTART': '1', 10:05:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:05 INFO - 'PWD': '/builds/slave/test', 10:05:05 INFO - 'SHELL': '/bin/bash', 10:05:05 INFO - 'SHLVL': '1', 10:05:05 INFO - 'TERM': 'linux', 10:05:05 INFO - 'TMOUT': '86400', 10:05:05 INFO - 'USER': 'cltbld', 10:05:05 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1461258228.916943-2064754446', 10:05:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:05 INFO - '_': '/tools/buildbot/bin/python'} 10:05:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:05 INFO - Downloading/unpacking flake8 10:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:05:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:05:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:05:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:05:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:05:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:05:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:05:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:05:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:05:09 INFO - no previously-included directories found matching 'docs/_build' 10:05:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:05:09 INFO - Running setup.py install for pep8 10:05:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:05:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:05:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:05:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:05:09 INFO - no previously-included directories found matching 'docs/_build' 10:05:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:05:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:05:09 INFO - Cleaning up... 10:05:09 INFO - Return code: 0 10:05:09 INFO - Running post-action listener: _resource_record_post_action 10:05:09 INFO - Running post-action listener: _start_resource_monitoring 10:05:09 INFO - Starting resource monitoring. 10:05:09 INFO - ##### 10:05:09 INFO - ##### Running install step. 10:05:09 INFO - ##### 10:05:09 INFO - Running pre-action listener: _resource_record_pre_action 10:05:09 INFO - Running main action method: install 10:05:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:05:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:05:10 INFO - Reading from file tmpfile_stdout 10:05:10 INFO - Detecting whether we're running mozinstall >=1.0... 10:05:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:05:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:05:10 INFO - Reading from file tmpfile_stdout 10:05:10 INFO - Output received: 10:05:10 INFO - Usage: mozinstall [options] installer 10:05:10 INFO - Options: 10:05:10 INFO - -h, --help show this help message and exit 10:05:10 INFO - -d DEST, --destination=DEST 10:05:10 INFO - Directory to install application into. [default: 10:05:10 INFO - "/builds/slave/test"] 10:05:10 INFO - --app=APP Application being installed. [default: firefox] 10:05:10 INFO - mkdir: /builds/slave/test/build/application 10:05:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:05:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:05:26 INFO - Reading from file tmpfile_stdout 10:05:26 INFO - Output received: 10:05:26 INFO - /builds/slave/test/build/application/firefox/firefox 10:05:26 INFO - Running post-action listener: _resource_record_post_action 10:05:26 INFO - ##### 10:05:26 INFO - ##### Running run-tests step. 10:05:26 INFO - ##### 10:05:26 INFO - Running pre-action listener: _resource_record_pre_action 10:05:26 INFO - Running main action method: run_tests 10:05:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:05:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:05:26 INFO - Python 2.7.3 10:05:26 INFO - Return code: 0 10:05:26 INFO - grabbing minidump binary from tooltool 10:05:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:26 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 0x1741810>, '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 0x1742710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1742ba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:05:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:05:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:05:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:05:26 INFO - Return code: 0 10:05:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:05:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:05:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:05:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:05:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:05:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:05:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:05:27 INFO - Return code: 0 10:05:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AEOvskxPTPmGIRx_GmE9Aw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:05:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AEOvskxPTPmGIRx_GmE9Aw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:05:27 INFO - Using env: {'DISPLAY': ':0', 10:05:27 INFO - 'HOME': '/home/cltbld', 10:05:27 INFO - 'LANG': 'en_US.UTF-8', 10:05:27 INFO - 'LANGUAGE': 'en_US:en', 10:05:27 INFO - 'LOGNAME': 'cltbld', 10:05:27 INFO - 'MAIL': '/var/mail/cltbld', 10:05:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:05:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:05:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:27 INFO - 'MOZ_NO_REMOTE': '1', 10:05:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:05:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:27 INFO - 'NO_EM_RESTART': '1', 10:05:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:27 INFO - 'PWD': '/builds/slave/test', 10:05:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:05:27 INFO - 'SHELL': '/bin/bash', 10:05:27 INFO - 'SHLVL': '1', 10:05:27 INFO - 'TERM': 'linux', 10:05:27 INFO - 'TMOUT': '86400', 10:05:27 INFO - 'USER': 'cltbld', 10:05:27 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1461258228.916943-2064754446', 10:05:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:27 INFO - '_': '/tools/buildbot/bin/python'} 10:05:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AEOvskxPTPmGIRx_GmE9Aw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:05:27 INFO - mozversion application_buildid: 20160421043116 10:05:27 INFO - mozversion application_changeset: 4e3ad95d689a5beabf3c1f41d958794fe00e3767 10:05:27 INFO - mozversion application_display_name: Nightly 10:05:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:05:27 INFO - mozversion application_name: Firefox 10:05:27 INFO - mozversion application_remotingname: firefox 10:05:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:05:27 INFO - mozversion application_vendor: Mozilla 10:05:27 INFO - mozversion application_version: 48.0a1 10:05:27 INFO - mozversion platform_buildid: 20160421043116 10:05:27 INFO - mozversion platform_changeset: 4e3ad95d689a5beabf3c1f41d958794fe00e3767 10:05:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:05:27 INFO - mozversion platform_version: 48.0a1 10:05:27 INFO - using testdate: 1461258327 10:05:27 INFO - actual date: 1461258327 10:05:27 INFO - starting webserver on 'localhost:37890' 10:05:27 INFO - SUITE-START | Running 2 tests 10:05:27 INFO - TEST-START | dromaeo_css 10:05:27 INFO - operating with platform_type : linux_ 10:05:27 INFO - Initialising browser for dromaeo_css test... 10:05:27 INFO - TEST-INFO | started process 6683 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMeZs_G/profile http://localhost:37890/getInfo.html) 10:05:31 INFO - PROCESS | 6683 | __metrics Screen width/height:1600/1200 10:05:31 INFO - PROCESS | 6683 | colorDepth:24 10:05:31 INFO - PROCESS | 6683 | Browser inner width/height: 1024/697 10:05:31 INFO - PROCESS | 6683 | __metrics 10:05:33 ERROR - PROCESS | 6683 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:05:34 INFO - TEST-INFO | 6683: exit 0 10:05:34 INFO - Browser initialized. 10:05:34 INFO - Running cycle 1/1 for dromaeo_css test... 10:05:34 INFO - TEST-INFO | started process 6766 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMeZs_G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:05:46 INFO - PROCESS | 6766 | RSS: Main: 153677824 10:05:46 INFO - PROCESS | 6766 | 10:06:37 INFO - PROCESS | 6766 | 1461258397107 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:08:44 INFO - PROCESS | 6766 | Cycle 1(1): loaded http://localhost:37890/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37890/tests/dromaeo/cssquery-ext.html) 10:08:45 INFO - PROCESS | 6766 | RSS: Main: 256262144 10:08:45 INFO - PROCESS | 6766 | 10:11:47 INFO - PROCESS | 6766 | Cycle 1(1): loaded http://localhost:37890/tests/dromaeo/cssquery-ext.html (next: http://localhost:37890/tests/dromaeo/cssquery-jquery.html) 10:11:48 INFO - PROCESS | 6766 | RSS: Main: 236318720 10:11:48 INFO - PROCESS | 6766 | 10:14:50 INFO - PROCESS | 6766 | Cycle 1(1): loaded http://localhost:37890/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37890/tests/dromaeo/cssquery-mootools.html) 10:14:51 INFO - PROCESS | 6766 | RSS: Main: 238682112 10:14:51 INFO - PROCESS | 6766 | 10:17:52 INFO - PROCESS | 6766 | Cycle 1(1): loaded http://localhost:37890/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37890/tests/dromaeo/cssquery-prototype.html) 10:17:53 INFO - PROCESS | 6766 | RSS: Main: 231206912 10:17:53 INFO - PROCESS | 6766 | 10:20:56 INFO - PROCESS | 6766 | Cycle 1(1): loaded http://localhost:37890/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37890/tests/dromaeo/cssquery-yui.html) 10:20:56 INFO - PROCESS | 6766 | RSS: Main: 225292288 10:20:56 INFO - PROCESS | 6766 | 10:23:59 INFO - PROCESS | 6766 | Cycle 1(1): loaded http://localhost:37890/tests/dromaeo/cssquery-yui.html (next: http://localhost:37890/tests/dromaeo/cssquery-dojo.html) 10:23:59 INFO - PROCESS | 6766 | RSS: Main: 265199616 10:23:59 INFO - PROCESS | 6766 | 10:23:59 INFO - PROCESS | 6766 | __start_tp_report 10:23:59 INFO - PROCESS | 6766 | _x_x_mozilla_page_load 10:23:59 INFO - PROCESS | 6766 | _x_x_mozilla_page_load_details 10:23:59 INFO - PROCESS | 6766 | |i|pagename|runs| 10:23:59 INFO - PROCESS | 6766 | |0;dojo.html;3093.7989030713006;3139.3407384449265;3185.7292130168935;3187.3465939482408;3215.26049008728;5203.531682148606;5253.86865328367;5281.366236051675;5294.205869119624;5315.255864179013;5214.973925130378;5266.7893284268675;5281.471852814717;5291.126964050927;5299.28459657946;4707.199776038065;4764.047190561892;4868.878278043059;4902.338184345122;4908.141075311806;4814.951850481485;4858.805647774085;4890.633202509826;4891.241857512074;4899.265110233458;4712;4755.239161734106;4768.713877167381;4785.066911952188;4812.278158276252;4791.305260737208;4820.30105634681;4821.035792841446;4821.132196204681;4854.587360074398;4702.905941881178;4782.3543821584335;4786.760661966888;4800.375951126366;4816.349792777965;5189.610779191538;5191.0656081905245;5222.556082732972;5276.657017293864;5296.655717378358;5464.316960379952;5476.041692703761;5486.972565137149;5487.2317875497465;5493.176023596453;5525.11598144295;5535.114381698909;5550.611457197998;5567.582431317627;5613.607047506676;5299.099153143975;5310.840674779763;5322.441143679896;5325.0148722486465;5360.088784906575;5745.166950792195;5746.655200687972;5748.137779333133;5748.338941021752;5750;5434.891302174014;5533;5548.861278468071;5561.972190139023;5644.6613203207935;5664.348599910981;5666.603337766317;5667.631603945731;5670.461306175906;5673.461021202979;5613.550915926716;5631.859203519863;5643.915341269884;5648.548116150698;5649.096144616841;5407.351117865881;5556.249906262684;5603.943960560424;5619.325680918316;5673.035583950738;4271.530131685512;4281.443412356373;4288.35674648799;4290.764007979591;4325.329573916048;3837.9040523987123;3866.6326698963553;3880.8059597020037;3894.182221733411;3897.415387691812;5270.868228294246;5313.867153321198;5367.731613419313;5404.32445944257;5414;5550.694711790809;5555.8888822223325;5557.638753481011;5560.972195138998;5563.248961390242;5127.948720512822;5186.688798672092;5210.270562121306;5210.322658054504;5241.659292145999;4721.787519561628;4766.76166191689;4770.570648641569;4820.831270905502;4823.866391398019;5748.48263656273;5785.681787501728;5788.18965344852;5791.942080579224;5795.88408231833;5556.222128902038;5569.610127291051;5611.635243709309;5612.298462692163;5636.126400407943;5800.39095894925;5816.5055970243;5819.82540523785;5823.126531020381;5885.499732522783;5537.031019571478;5546.944530554804;5548.778048878161;5553.055980483408;5557.805476808292;5439.891202175855;5492.066348720807;5587.972060139673;5626.690532020778;5633.352164501135;5540.722963851711;5568.526675232651;5573.052581061311;5575.330960284629;5582.246396736388;5533.916991245215;5565.3599836019375;5566.081596536526;5567.415421380697;5575.275214222125;5214.9478505214465;5299.966506531189;5391.676499410048;5397.865053373697;5512.145617429305;5580.441955804549;5583.190437386637;5586.608937374344;5587.385387607279;5601.663900166003;5440.483154100354;5464.672119672832;5468.589855760913;5480.068388373907;5487.6981766003255 10:23:59 INFO - PROCESS | 6766 | |1;ext.html;605.6154341992836;639.0031550780782;652.9902051469226;666.2371584535704;679.762083270855;31165;31868.36263274736;35951.46072808907;36890.4466433003;36997.07507312312;39182.8040859796;39759.801200993956;39769.204615907736;39812.80093599528;39839;8505.78735531612;8677.435966662148;8702.260307873807;8704.738857834243;8707;7856.803579910491;10175.898241017569;10558.155347572214;10567.630132945349;10570.15438764897;10222.335548189381;10305.175585953144;10305.278630495868;10318.638847640334;10325.225608079425;7874.5668988205625;10123;10174.4912754362;10225.693229203061;10231.999999999964;10122.139618132467;10252.641157559525;10270.435126068063;10282.331648442827;10284.125849302818;35445.645543544495;35929.46105808415;36052.459213111826;36093.45859812105;36105.63894361076;3462.7229821614465;3512.8594856205723;3543.2541126166934;3565.1265439967374;3586.7130629549833;29767.553486697718;30761.692383076108;31683.841580792177;31706.524402133757;32330.676693233003;4287.914241715148;4303.784810759449;4322.394864718942;4362.8036738346855;4379.64962802975;256525;256995;257559;257667;258056.70971645208;54927.450725492236;55649;56031.43968560344;56109.43890561042;56169;59540.404595953485;59860.70069649711;59980.70009649924;62375;65222;14060.578182654537;14147.929260353632;14190.858091418953;14227;14232.28838558068;11217.55129794799;11237.21339506243;11247.718807029889;11252.943735281271;11261.887381126084;19540.70688939667;19845.30541431072;19955.60088798216;20104.49738756543;20182.697259541117;7318.048253942811;7340.816479588053;7631.198724133886;7694.652521325434;7714.9228507715325;896.4621227263721;914.2366124286162;925.9953700231456;930.3022732950287;996.850472429127;28567.714322856504;29915;31509.684903151134;31731.365372692417;31920.361592768015;1030.4487099401933;1033.2818691009827;1063.0857462582173;1091.9508622112023;1175.9941200293945;16491.83508164927;16682.749758753627;16807.243674034697;16894.49316520506;17164.656706865793;184434;186079;186132;186488;186519;52885.47114528805;54699;54752.726236368566;54878.17682734762;54967;1203.9217450865665;1288.3880156925386;1290.2774446310095;1292.5476083370934;1452.7021960498073;29783.404331913673;36363.81818090893;36476.45285320775;36522.452163218106;36881;50431.24353134633;50700.49299506958;51349.48650513597;51498.74250628723;51508.484915150366;334189;336688;338252;338637;338638;24978.375540610905;26634.467310654065;26993.59509607397;27566.724332756417;28464.85767571149;40411.7979410101;40798.38802417907;43188.784056079516;44509.33236001398;45673.54326456693;39008.41487377748;39537.80231098826;40380.59619403886;42140.367894482224;42233;34965.47551786776;36766;36807.81596092109;37722.43416348702;40478.79760601178;38748.612513875625;38846.80576597099;38868;39608.60391396049;40002.59997400105;34902;35756;36130.8193459031;36215.81892090523;36238.275234494635;27885;28015;28067.57898631563;28111.297217569725;28324.575131373458 10:23:59 INFO - PROCESS | 6766 | |2;jquery.html;381.883525524715;394.5521832719864;396.6113209055124;400.9739366941149;406.81489922085456;14046.43814247429;14812.555623331291;17320.393786217486;17994.460166195004;17999.100044997762;14545;14552.563423097297;16480.83519164808;16481.83518164818;16960.067196304197;5442.12925931851;5471.753771080311;5537.833864984037;5628.352739434956;5629.887402251952;5495.0658388073925;5549.472800083986;5579;5593.356763972134;5593.804216852411;4035.3341698619693;5876.618019828718;6126.540509461808;6181.567290289681;6186.907196392058;5900.822975310747;6118.571699981003;6158.876822463548;6164.630122192638;6167;5392.757325920343;5414.269073675043;5432.945670543323;5453.563714902798;5454.863628409282;11915.165938384316;12571.93714031424;12605.621831345074;12637.115401921868;21632;2226.4545186429427;2287.1080278691325;2302.228753367624;2320.2691152287143;2730.344717267861;9210.447373157565;9242.81514369709;9278.582463789146;9699.272554558365;9959.55182016811;1826.9543261418437;1880.548668319607;1894.1381671339507;1962.2347284559035;2128.467883029243;72139;76117;79135.20864791336;80461;81943.59028204822;10140.949295253477;10238.232132590085;10380.221483388776;10499.632512862014;10696.946515267375;14800.407983680532;14872.330745116496;14874.107553546823;14950.925245373703;14960.925195373953;6755.4257888080065;6915.4121899638085;7267.745628902963;7278.526895751759;7346.595937223397;6947.305269473012;6979.30206979298;7098.822529436806;7232.20445750967;7254.347108760237;4252;4312.417823593774;4491.910161796811;4532.524084971031;4569.109023740339;1766.6908291049015;1845.7600511933363;1863.2174486715612;1863.413024897153;1876.249500199931;1014.4927536231884;1020.8264595018865;1025.4923812712755;1103.8730545987314;1111.6109361723331;17765.200565974563;17768.46694599164;17978.37075702344;18066.638667226845;18364.908175459306;976.5898322704481;1014.2697257974247;1031.3708637730979;1031.5718976624767;1064.377339256528;9850.704478865646;10039.146672532917;10152.289339746294;10186.643467478603;10295.794084118275;474124;484805;488285;542045;546396;91624.54187729151;93396;94650.52674736582;95690.52154739182;96382.51808740912;1007.1741172238694;1024.9743756406;1029.9176065914858;1040.245821779219;1042.5152304178594;15711.371545138523;15732.292046858147;15878.52364429069;15930.920345398199;16271.918640406722;24768.380790480383;37915.24169516649;38259.234815304095;38811;39099;37321.440178396806;43660.56339436565;49504.50495495143;50085;50791.74604126956;8072.358393923635;8132.30875375576;8172.959135204286;8310.958445207736;8328.916710833057;8973.012968573583;11847.703807404883;12655.873441265838;12743.426545805276;12756.107072504836;11033.834492482458;11109.778044390992;11364.715882102682;11368.317900925971;11558.537658493902;10417.47912604382;10864.185186110915;10994.780104398027;11056.834147487632;11099.556017759522;11335.659930202108;11485.48315325829;11548;11696.766064678828;11755.471003804678;8270.710525131592;8278.544680042656;8354.62404191825;8410.201030902055;8503.319734421355;8805.64777408922;11150;11425.828612570653;11467.139964502863;11668.533258669897 10:23:59 INFO - PROCESS | 6766 | |3;mootools.html;1358.300475255243;1544.9613759656006;1561.7657351397288;1731.7921849378076;1815.6550255451455;7901.960490197548;8203.179682031794;8217.46586471879;8223.753287401387;8254.215849494296;8043.276105150535;8211.343092552597;8220.260176584121;8231.42380033398;8236.052853921801;1969.1040576537712;2036.3381900882273;2040.2655044184082;2330.0796185506756;2352.3648614873973;2282.805961493275;2357.5049239659693;2360.775726305998;2361.51588924271;2362.9881850590723;2280.623697089978;2286.599845027122;2298.2990187992655;2298.850574712647;2312.0173926081434;2025.3113941260042;2243.8317126215597;2298.6666933294664;2312.479692069288;2316.525112351964;2315.80315673168;2330.5338932213626;2331.1025255276672;2335.019291897407;2337.49743805081;8104.473209241381;8158.592070396457;8171.918280817175;8177.754667359989;8180.141085186029;4815.927761083586;4968.850934471971;4981.402231732215;4989.3264409305;4996.1756310208775;3247.675232476757;3322.833858307075;3433.073070271038;3462.740294477899;3466.861325546975;1075.7687097274124;1083.2363183955372;1086.283053184902;1094.9835752463719;1096.3476731344838;11387.544498220144;11427.48576314068;11438.19932604718;11458.083353331713;11467.942660286646;4381.956180438218;4538.115067561794;4663.463701674283;4665.300204969214;4667.929981050287;9669.129778319984;9670.661526846527;9713.417194968324;9718.61125554984;9730.659426920023;5046.243063540425;5080.898382032413;5082.085224659523;5092.134337162691;5094.974525127351;4103.179364127186;4497.6851620386915;4623.283391074388;4634.050019745944;4667.206574882278;3876.321643712339;3905.824237909301;3966.8214930328204;3985.3822657488136;4009.218202450494;1263.1410640764368;1270.30133426615;1272.8854403103765;1281.1800447713472;1284.0177264392746;977.6578197630772;992.3004281981185;1003.1673710820002;1006.4816619440994;1018.4907546226887;5872.970635146797;5875.559333050039;5944.5838791284195;5993.550483713739;6116.29662588808;450.1065385210355;452.9569690879361;456.18798538601345;459.5794847714304;460.82028009076487;4012.337964235868;4113.239050775616;4134.152498737752;4137.193247316804;4207.26372884744;9745.610175592898;10046.748831279276;10103.343282686601;10136.341137826017;10180.440075795903;10205.693829185137;10344.793104137874;10346.793064138825;10354.5340459678;10363.222758293008;7509.7371591994015;7608.391328693691;7617.209955660415;7660.808479787938;8021.598920053974;5550.639208451437;5648.435156484319;5730.283714535683;5763.538916886723;5802.65184088956;9147.222486088756;9330.766730831783;9364.906350936404;9401.717948461557;9413.81172376535;9130.178283954476;9336.439813610934;9389.577469013775;9392.248620110238;9513.809723805623;7110.57336559808;7122.18094919091;7144.928550714426;7154.391876690332;7172.677229524579;7709.113451953097;7720.498167619086;7801.765947021599;7934.087579928382;7961.16407777175;7269.3094156055095;7405.111386633638;7411.295926886937;7521.811954701177;7534.736284230025;7207.099112610924;7243.7464688735645;7292.270772922665;7358.11702595692;7444.702211911463;6801.523893327618;6834.077399551195;6848.863022739418;6866.896996544956;6867.622280774605;4906.288588154769;4965.82619608312;5070.554891855803;5089.567386772018;5111.821086261963;5003.649744517848;5008.373953255843;5039.0929632665;5058.822941197188;5093.668911520739 10:23:59 INFO - PROCESS | 6766 | |4;prototype.html;331.73295497124803;338.9525466434699;340.3652188668134;343.58769476628055;345.93279732026696;5742.502011624946;5753.856153596157;5813.186153938452;5825.067989121747;5864.413558644133;5678.290213723285;5700.719712115156;5709.343425506068;5712.8857422851515;5735.2544169257935;4194.7483151010965;4229.471316085489;4237.512686041114;4271.1671224111315;4458.71018383804;4402.581754733295;4426.114777044588;4427.402300689398;4451.59935605797;4458.910821783563;4395.428594282739;4400.019991004045;4404.207242696313;4411.316245981878;4424.513303536608;4117;4315.4821421429315;4408.53710360414;4418.425604671372;4427.579379958899;3899.863504777319;3905;3906.960930390688;3924.7841368724708;3926.096997690547;5544.140658197945;5544.251526044013;5548.528375088123;5552.3892371839065;5559.332880054379;4827.686200396963;5042.621803364762;5055.180135151342;5062.215356619693;5073.746312684351;5982.611130276561;6002;6008.699565021731;6021.875015614318;6051.2133422655215;4020.618041286073;4163.333866581363;4216.7259128156875;4229.661627069827;4231;6229.844253893643;6266.686665666744;6276.184096067482;6285.245770507523;6296.275928268262;4267;4267.594578515036;4271.10306835568;4274.572542745701;4278.935815962763;4240.809163587584;4312.288472402081;4331.263685173528;4336.3278691802825;4339.631131353807;4971.875703107379;4991.5258050485145;4994.500549944976;4996.775145118406;5001.974990125026;6030.487408570233;6049.18336024631;6050.152978583002;6059.666718330446;6070.7875224366935;1467.1123969997998;1483.7329280729573;1499.8950073494968;1508.1931166825696;1519.7112548615728;936.091990768953;979.637534112383;990.2424645146468;1004.2969921055291;1005.0954141272766;5722.942770572325;5754.4533269339345;5755.85610359736;5768.836686242659;5810.389909059572;6030.427109424598;6046.3349031606485;6064.4845188158615;6074.75700971965;6085.574009819358;5560.138178582326;5716.142578613241;5733.957559920246;5748.856278592985;5756.395578464201;3233.5796346475277;3241.497567876983;3249.561309223272;3262.60848698153;3274.3942370661503;6123.203983482119;6312.905306420407;6329.208848893888;6330.556861019684;6331.366863313632;6230.968845155745;6241.563090583615;6269;6269.498440124779;6284.994400895835;6332.4934005279465;6357.904631430532;6363.936360636427;6364.045393191059;6388.552801303864;5991.221141251609;6199.814005579839;6228.22147231596;6280;6301;6157;6165.414285642857;6168.290646575701;6174.25908890918;6203.4416902479;6303.810885673437;6490.48076153916;6504.089427480062;6513.1532900722605;6515.12045873801;4265.0616864289805;4269.267668691978;4285.807138678704;4289.914201715886;4302.462192225972;6148.44663980244;6272.090546870587;6297.653629050446;6298.937010630018;6307.24313082433;6119.816405507842;6124.6325220486915;6126.877462450815;6128.50971922254;6133.84665383369;6088.786892458743;6102.847428814315;6107.694615269308;6132.9080063799975;6147.815565533041;5896.764129434775;5971.223740913653;6008.399160083956;6024.156618073385;6033.879322413615;6059;6101.908471372844;6124.203853499017;6134.110553969738;6146.846328841814;5888.852778680567;5892.7642894283745;5973.253343332083;6001.159837622649;6028.4272994065495 10:23:59 INFO - PROCESS | 6766 | |5;yui.html;844.5945945945946;846.8264005878796;849.8725191221316;871.0418539606434;896.2561074308322;14064;14379.71240575188;14411.855881441208;14485.927570362146;14801.629959251024;15481;15544.455944041962;15692.843071569281;15700.450484233053;15742.055476671409;688.8553403785211;811.1482942909921;827.1480375213524;832.7709879783048;837.2883049407985;840.6763396092518;844.1937949258444;844.2654890245495;847.9024912135121;848.0205362805968;870.3559366069095;873.1443185678007;873.4279047224078;873.5021038008338;873.7378786364065;719.7049209823973;738.7303634173514;738.970441182352;852.3138873207066;868.2272777228272;637.9744810207586;638.1257676982517;639.1307821362942;639.5650957349001;639.6226226526326;14303.713925721428;14325.35535900887;14346.49787257441;14352;14365.13809171453;13566.864331356659;13742.312884355742;13831.723365532735;14034.438622455089;14052.508162214273;11760.353180575064;11929.224600400947;12196.695082622917;12213.45039473226;12365.814512782315;3886.203328317688;3930.8231129599235;3938.0942383251727;4043.6158564936286;4048.291548978946;58945;59954.40045599532;60389.69805150946;60450.395496045356;61192;11306.152038597138;11416.257943233662;11526;11532.25040372373;11552.711182220344;19558.21767129299;19966.201351945758;20015.799842001685;20371.287004954756;20453.79546204519;8281.917180828235;8299.751007469786;8431.030431500456;8702.390832641655;8848.557572121368;4744.786484608201;4792.376990991149;4797.280407938837;4836.56470917612;4892.266160075946;3386.068831071475;3463.7530489024434;3469.6877281044826;3470.0804286864;3470.3579837729594;625.1997443272618;631.6052467207995;640.6572483721187;649.8830210562049;651.775137577535;725.3399406540024;752.5071078443628;779.2363483785922;779.9649015794303;786.7757689058591;8514.74455766328;9473.428731345115;9535.761605959906;9540.666076687283;9736.969949337175;547.3322546493272;653.31075715121;669.9765508207189;670.9295523970011;703.6165289917008;4463.308187230984;4492.483364413069;4519.954800451954;4537.591616754508;4636;60050.39949600448;60559.39440605538;60873.39126608766;62677.373226267155;62784.37215627877;52031;52679.47320526822;53472.465275347524;53730.7313463438;53862;47941.28088078681;48113.278300824815;48528;48643;49991;9247.583858726508;9302.627894884128;9464.95267523658;9545.713628591153;9549.188318992963;31574.684253158095;32226.83886580552;32355.19112022218;32621.18447038843;32712.182195445304;40874.59125408708;41412.585874140874;42033.78983105187;43423;45095;11456.312621242752;11505.827412588651;11636.185467017227;11851.762964740485;11889.524419023488;13344.799828002782;13784.241866697428;13891;14589.781153282496;14679.70640587161;10113.165011296913;12683.429245683781;13047.217166970013;13343.66640833987;14099.436022558983;13052.934735326262;13069.346532673519;13298.268595227355;13402.463901444224;13453.730925381633;12213.816792747939;12221.633350999484;12492.375381231084;12739.872601273868;13375.732485350432;10565.101966332948;10624.787504250025;10918.945405272923;11026.50380732885;11054.613088541862;11078.224524283223;11552.711182220512;11777.411129443322;11837.822432663344;11948.701282468008 10:23:59 INFO - PROCESS | 6766 | __end_tp_report 10:23:59 INFO - PROCESS | 6766 | __start_cc_report 10:23:59 INFO - PROCESS | 6766 | _x_x_mozilla_cycle_collect,850 10:23:59 INFO - PROCESS | 6766 | __end_cc_report 10:23:59 INFO - PROCESS | 6766 | __startTimestamp1461259439544__endTimestamp 10:23:59 INFO - PROCESS | 6766 | 10:23:59 INFO - PROCESS | 6766 | ------- Summary: start ------- 10:23:59 INFO - PROCESS | 6766 | Number of tests: 6 10:23:59 INFO - PROCESS | 6766 | 10:23:59 INFO - PROCESS | 6766 | [#0] dojo.html Cycles:165 Average:5225.99 Median:5440.48 stddev:571.10 (10.5%) stddev-sans-first:547.81 10:23:59 INFO - PROCESS | 6766 | Values: 3093.8 3139.3 3185.7 3187.3 3215.3 5203.5 5253.9 5281.4 5294.2 5315.3 5215.0 5266.8 5281.5 5291.1 5299.3 4707.2 4764.0 4868.9 4902.3 4908.1 4815.0 4858.8 4890.6 4891.2 4899.3 4712.0 4755.2 4768.7 4785.1 4812.3 4791.3 4820.3 4821.0 4821.1 4854.6 4702.9 4782.4 4786.8 4800.4 4816.3 5189.6 5191.1 5222.6 5276.7 5296.7 5464.3 5476.0 5487.0 5487.2 5493.2 5525.1 5535.1 5550.6 5567.6 5613.6 5299.1 5310.8 5322.4 5325.0 5360.1 5745.2 5746.7 5748.1 5748.3 5750.0 5434.9 5533.0 5548.9 5562.0 5644.7 5664.3 5666.6 5667.6 5670.5 5673.5 5613.6 5631.9 5643.9 5648.5 5649.1 5407.4 5556.2 5603.9 5619.3 5673.0 4271.5 4281.4 4288.4 4290.8 4325.3 3837.9 3866.6 3880.8 3894.2 3897.4 5270.9 5313.9 5367.7 5404.3 5414.0 5550.7 5555.9 5557.6 5561.0 5563.2 5127.9 5186.7 5210.3 5210.3 5241.7 4721.8 4766.8 4770.6 4820.8 4823.9 5748.5 5785.7 5788.2 5791.9 5795.9 5556.2 5569.6 5611.6 5612.3 5636.1 5800.4 5816.5 5819.8 5823.1 5885.5 5537.0 5546.9 5548.8 5553.1 5557.8 5439.9 5492.1 5588.0 5626.7 5633.4 5540.7 5568.5 5573.1 5575.3 5582.2 5533.9 5565.4 5566.1 5567.4 5575.3 5214.9 5300.0 5391.7 5397.9 5512.1 5580.4 5583.2 5586.6 5587.4 5601.7 5440.5 5464.7 5468.6 5480.1 5487.7 10:23:59 INFO - PROCESS | 6766 | 10:23:59 INFO - PROCESS | 6766 | [#1] ext.html Cycles:180 Average:44222.82 Median:19494.45 stddev:69851.86 (358.3%) stddev-sans-first:69971.03 10:23:59 INFO - PROCESS | 6766 | Values: 605.6 639.0 653.0 666.2 679.8 31165.0 31868.4 35951.5 36890.4 36997.1 39182.8 39759.8 39769.2 39812.8 39839.0 8505.8 8677.4 8702.3 8704.7 8707.0 7856.8 10175.9 10558.2 10567.6 10570.2 10222.3 10305.2 10305.3 10318.6 10325.2 7874.6 10123.0 10174.5 10225.7 10232.0 10122.1 10252.6 10270.4 10282.3 10284.1 35445.6 35929.5 36052.5 36093.5 36105.6 3462.7 3512.9 3543.3 3565.1 3586.7 29767.6 30761.7 31683.8 31706.5 32330.7 4287.9 4303.8 4322.4 4362.8 4379.6 256525.0 256995.0 257559.0 257667.0 258056.7 54927.5 55649.0 56031.4 56109.4 56169.0 59540.4 59860.7 59980.7 62375.0 65222.0 14060.6 14147.9 14190.9 14227.0 14232.3 11217.6 11237.2 11247.7 11252.9 11261.9 19540.7 19845.3 19955.6 20104.5 20182.7 7318.0 7340.8 7631.2 7694.7 7714.9 896.5 914.2 926.0 930.3 996.9 28567.7 29915.0 31509.7 31731.4 31920.4 1030.4 1033.3 1063.1 1092.0 1176.0 16491.8 16682.7 16807.2 16894.5 17164.7 184434.0 186079.0 186132.0 186488.0 186519.0 52885.5 54699.0 54752.7 54878.2 54967.0 1203.9 1288.4 1290.3 1292.5 1452.7 29783.4 36363.8 36476.5 36522.5 36881.0 50431.2 50700.5 51349.5 51498.7 51508.5 334189.0 336688.0 338252.0 338637.0 338638.0 24978.4 26634.5 26993.6 27566.7 28464.9 40411.8 40798.4 43188.8 44509.3 45673.5 39008.4 39537.8 40380.6 42140.4 42233.0 34965.5 36766.0 36807.8 37722.4 40478.8 38748.6 38846.8 38868.0 39608.6 40002.6 34902.0 35756.0 36130.8 36215.8 36238.3 27885.0 28015.0 28067.6 28111.3 28324.6 10:23:59 INFO - PROCESS | 6766 | 10:23:59 INFO - PROCESS | 6766 | [#2] jquery.html Cycles:180 Average:28232.76 Median:13749.36 stddev:83701.97 (608.8%) stddev-sans-first:83910.66 10:23:59 INFO - PROCESS | 6766 | Values: 381.9 394.6 396.6 401.0 406.8 14046.4 14812.6 17320.4 17994.5 17999.1 14545.0 14552.6 16480.8 16481.8 16960.1 5442.1 5471.8 5537.8 5628.4 5629.9 5495.1 5549.5 5579.0 5593.4 5593.8 4035.3 5876.6 6126.5 6181.6 6186.9 5900.8 6118.6 6158.9 6164.6 6167.0 5392.8 5414.3 5432.9 5453.6 5454.9 11915.2 12571.9 12605.6 12637.1 21632.0 2226.5 2287.1 2302.2 2320.3 2730.3 9210.4 9242.8 9278.6 9699.3 9959.6 1827.0 1880.5 1894.1 1962.2 2128.5 72139.0 76117.0 79135.2 80461.0 81943.6 10140.9 10238.2 10380.2 10499.6 10696.9 14800.4 14872.3 14874.1 14950.9 14960.9 6755.4 6915.4 7267.7 7278.5 7346.6 6947.3 6979.3 7098.8 7232.2 7254.3 4252.0 4312.4 4491.9 4532.5 4569.1 1766.7 1845.8 1863.2 1863.4 1876.2 1014.5 1020.8 1025.5 1103.9 1111.6 17765.2 17768.5 17978.4 18066.6 18364.9 976.6 1014.3 1031.4 1031.6 1064.4 9850.7 10039.1 10152.3 10186.6 10295.8 474124.0 484805.0 488285.0 542045.0 546396.0 91624.5 93396.0 94650.5 95690.5 96382.5 1007.2 1025.0 1029.9 1040.2 1042.5 15711.4 15732.3 15878.5 15930.9 16271.9 24768.4 37915.2 38259.2 38811.0 39099.0 37321.4 43660.6 49504.5 50085.0 50791.7 8072.4 8132.3 8173.0 8311.0 8328.9 8973.0 11847.7 12655.9 12743.4 12756.1 11033.8 11109.8 11364.7 11368.3 11558.5 10417.5 10864.2 10994.8 11056.8 11099.6 11335.7 11485.5 11548.0 11696.8 11755.5 8270.7 8278.5 8354.6 8410.2 8503.3 8805.6 11150.0 11425.8 11467.1 11668.5 10:23:59 INFO - PROCESS | 6766 | 10:23:59 INFO - PROCESS | 6766 | [#3] mootools.html Cycles:180 Average:5500.08 Median:4975.13 stddev:3044.25 (61.2%) stddev-sans-first:3036.88 10:23:59 INFO - PROCESS | 6766 | Values: 1358.3 1545.0 1561.8 1731.8 1815.7 7902.0 8203.2 8217.5 8223.8 8254.2 8043.3 8211.3 8220.3 8231.4 8236.1 1969.1 2036.3 2040.3 2330.1 2352.4 2282.8 2357.5 2360.8 2361.5 2363.0 2280.6 2286.6 2298.3 2298.9 2312.0 2025.3 2243.8 2298.7 2312.5 2316.5 2315.8 2330.5 2331.1 2335.0 2337.5 8104.5 8158.6 8171.9 8177.8 8180.1 4815.9 4968.9 4981.4 4989.3 4996.2 3247.7 3322.8 3433.1 3462.7 3466.9 1075.8 1083.2 1086.3 1095.0 1096.3 11387.5 11427.5 11438.2 11458.1 11467.9 4382.0 4538.1 4663.5 4665.3 4667.9 9669.1 9670.7 9713.4 9718.6 9730.7 5046.2 5080.9 5082.1 5092.1 5095.0 4103.2 4497.7 4623.3 4634.1 4667.2 3876.3 3905.8 3966.8 3985.4 4009.2 1263.1 1270.3 1272.9 1281.2 1284.0 977.7 992.3 1003.2 1006.5 1018.5 5873.0 5875.6 5944.6 5993.6 6116.3 450.1 453.0 456.2 459.6 460.8 4012.3 4113.2 4134.2 4137.2 4207.3 9745.6 10046.7 10103.3 10136.3 10180.4 10205.7 10344.8 10346.8 10354.5 10363.2 7509.7 7608.4 7617.2 7660.8 8021.6 5550.6 5648.4 5730.3 5763.5 5802.7 9147.2 9330.8 9364.9 9401.7 9413.8 9130.2 9336.4 9389.6 9392.2 9513.8 7110.6 7122.2 7144.9 7154.4 7172.7 7709.1 7720.5 7801.8 7934.1 7961.2 7269.3 7405.1 7411.3 7521.8 7534.7 7207.1 7243.7 7292.3 7358.1 7444.7 6801.5 6834.1 6848.9 6866.9 6867.6 4906.3 4965.8 5070.6 5089.6 5111.8 5003.6 5008.4 5039.1 5058.8 5093.7 10:23:59 INFO - PROCESS | 6766 | 10:23:59 INFO - PROCESS | 6766 | [#4] prototype.html Cycles:180 Average:5047.52 Median:5756.13 stddev:1521.73 (26.4%) stddev-sans-first:1484.26 10:23:59 INFO - PROCESS | 6766 | Values: 331.7 339.0 340.4 343.6 345.9 5742.5 5753.9 5813.2 5825.1 5864.4 5678.3 5700.7 5709.3 5712.9 5735.3 4194.7 4229.5 4237.5 4271.2 4458.7 4402.6 4426.1 4427.4 4451.6 4458.9 4395.4 4400.0 4404.2 4411.3 4424.5 4117.0 4315.5 4408.5 4418.4 4427.6 3899.9 3905.0 3907.0 3924.8 3926.1 5544.1 5544.3 5548.5 5552.4 5559.3 4827.7 5042.6 5055.2 5062.2 5073.7 5982.6 6002.0 6008.7 6021.9 6051.2 4020.6 4163.3 4216.7 4229.7 4231.0 6229.8 6266.7 6276.2 6285.2 6296.3 4267.0 4267.6 4271.1 4274.6 4278.9 4240.8 4312.3 4331.3 4336.3 4339.6 4971.9 4991.5 4994.5 4996.8 5002.0 6030.5 6049.2 6050.2 6059.7 6070.8 1467.1 1483.7 1499.9 1508.2 1519.7 936.1 979.6 990.2 1004.3 1005.1 5722.9 5754.5 5755.9 5768.8 5810.4 6030.4 6046.3 6064.5 6074.8 6085.6 5560.1 5716.1 5734.0 5748.9 5756.4 3233.6 3241.5 3249.6 3262.6 3274.4 6123.2 6312.9 6329.2 6330.6 6331.4 6231.0 6241.6 6269.0 6269.5 6285.0 6332.5 6357.9 6363.9 6364.0 6388.6 5991.2 6199.8 6228.2 6280.0 6301.0 6157.0 6165.4 6168.3 6174.3 6203.4 6303.8 6490.5 6504.1 6513.2 6515.1 4265.1 4269.3 4285.8 4289.9 4302.5 6148.4 6272.1 6297.7 6298.9 6307.2 6119.8 6124.6 6126.9 6128.5 6133.8 6088.8 6102.8 6107.7 6132.9 6147.8 5896.8 5971.2 6008.4 6024.2 6033.9 6059.0 6101.9 6124.2 6134.1 6146.8 5888.9 5892.8 5973.3 6001.2 6028.4 10:23:59 INFO - PROCESS | 6766 | 10:23:59 INFO - PROCESS | 6766 | [#5] yui.html Cycles:180 Average:14937.65 Median:24793.74 stddev:17003.87 (68.6%) stddev-sans-first:17018.63 10:23:59 INFO - PROCESS | 6766 | Values: 844.6 846.8 849.9 871.0 896.3 14064.0 14379.7 14411.9 14485.9 14801.6 15481.0 15544.5 15692.8 15700.5 15742.1 688.9 811.1 827.1 832.8 837.3 840.7 844.2 844.3 847.9 848.0 870.4 873.1 873.4 873.5 873.7 719.7 738.7 739.0 852.3 868.2 638.0 638.1 639.1 639.6 639.6 14303.7 14325.4 14346.5 14352.0 14365.1 13566.9 13742.3 13831.7 14034.4 14052.5 11760.4 11929.2 12196.7 12213.5 12365.8 3886.2 3930.8 3938.1 4043.6 4048.3 58945.0 59954.4 60389.7 60450.4 61192.0 11306.2 11416.3 11526.0 11532.3 11552.7 19558.2 19966.2 20015.8 20371.3 20453.8 8281.9 8299.8 8431.0 8702.4 8848.6 4744.8 4792.4 4797.3 4836.6 4892.3 3386.1 3463.8 3469.7 3470.1 3470.4 625.2 631.6 640.7 649.9 651.8 725.3 752.5 779.2 780.0 786.8 8514.7 9473.4 9535.8 9540.7 9737.0 547.3 653.3 670.0 670.9 703.6 4463.3 4492.5 4520.0 4537.6 4636.0 60050.4 60559.4 60873.4 62677.4 62784.4 52031.0 52679.5 53472.5 53730.7 53862.0 47941.3 48113.3 48528.0 48643.0 49991.0 9247.6 9302.6 9465.0 9545.7 9549.2 31574.7 32226.8 32355.2 32621.2 32712.2 40874.6 41412.6 42033.8 43423.0 45095.0 11456.3 11505.8 11636.2 11851.8 11889.5 13344.8 13784.2 13891.0 14589.8 14679.7 10113.2 12683.4 13047.2 13343.7 14099.4 13052.9 13069.3 13298.3 13402.5 13453.7 12213.8 12221.6 12492.4 12739.9 13375.7 10565.1 10624.8 10918.9 11026.5 11054.6 11078.2 11552.7 11777.4 11837.8 11948.7 10:23:59 INFO - PROCESS | 6766 | -------- Summary: end -------- 10:23:59 INFO - PROCESS | 6766 | 10:24:00 INFO - TEST-INFO | 6766: exit 0 10:24:00 INFO - TEST-OK | dromaeo_css | took 1112386ms 10:24:00 INFO - TEST-START | kraken 10:24:00 INFO - operating with platform_type : linux_ 10:24:00 INFO - Initialising browser for kraken test... 10:24:00 INFO - TEST-INFO | started process 6957 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVKVldD/profile http://localhost:37890/getInfo.html) 10:24:04 INFO - PROCESS | 6957 | __metrics Screen width/height:1600/1200 10:24:04 INFO - PROCESS | 6957 | colorDepth:24 10:24:04 INFO - PROCESS | 6957 | Browser inner width/height: 1024/697 10:24:04 INFO - PROCESS | 6957 | __metrics 10:24:05 ERROR - PROCESS | 6957 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:24:06 INFO - TEST-INFO | 6957: exit 0 10:24:06 INFO - Browser initialized. 10:24:06 INFO - Running cycle 1/1 for kraken test... 10:24:06 INFO - TEST-INFO | started process 7040 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVKVldD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:24:17 INFO - PROCESS | 7040 | RSS: Main: 153776128 10:24:17 INFO - PROCESS | 7040 | 10:24:20 INFO - PROCESS | 7040 | Cycle 1(1): loaded http://localhost:37890/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37890/tests/kraken/driver.html?testName=audio-beat-detection) 10:24:21 INFO - PROCESS | 7040 | RSS: Main: 207982592 10:24:21 INFO - PROCESS | 7040 | 10:24:23 INFO - PROCESS | 7040 | Cycle 1(1): loaded http://localhost:37890/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37890/tests/kraken/driver.html?testName=audio-dft) 10:24:24 INFO - PROCESS | 7040 | RSS: Main: 193650688 10:24:24 INFO - PROCESS | 7040 | 10:24:27 INFO - PROCESS | 7040 | Cycle 1(1): loaded http://localhost:37890/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37890/tests/kraken/driver.html?testName=audio-fft) 10:24:28 INFO - PROCESS | 7040 | RSS: Main: 263389184 10:24:28 INFO - PROCESS | 7040 | 10:24:30 INFO - PROCESS | 7040 | Cycle 1(1): loaded http://localhost:37890/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37890/tests/kraken/driver.html?testName=audio-oscillator) 10:24:30 INFO - PROCESS | 7040 | RSS: Main: 173056000 10:24:30 INFO - PROCESS | 7040 | 10:24:33 INFO - PROCESS | 7040 | Cycle 1(1): loaded http://localhost:37890/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37890/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:24:33 INFO - PROCESS | 7040 | RSS: Main: 177078272 10:24:33 INFO - PROCESS | 7040 | 10:24:36 INFO - PROCESS | 7040 | Cycle 1(1): loaded http://localhost:37890/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37890/tests/kraken/driver.html?testName=imaging-darkroom) 10:24:37 INFO - PROCESS | 7040 | RSS: Main: 213622784 10:24:37 INFO - PROCESS | 7040 | 10:24:40 INFO - PROCESS | 7040 | Cycle 1(1): loaded http://localhost:37890/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37890/tests/kraken/driver.html?testName=imaging-desaturate) 10:24:41 INFO - PROCESS | 7040 | RSS: Main: 213749760 10:24:41 INFO - PROCESS | 7040 | 10:24:43 INFO - PROCESS | 7040 | Cycle 1(1): loaded http://localhost:37890/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37890/tests/kraken/driver.html?testName=json-parse-financial) 10:24:44 INFO - PROCESS | 7040 | RSS: Main: 214110208 10:24:44 INFO - PROCESS | 7040 | 10:24:46 INFO - PROCESS | 7040 | Cycle 1(1): loaded http://localhost:37890/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37890/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:24:46 INFO - PROCESS | 7040 | RSS: Main: 202674176 10:24:46 INFO - PROCESS | 7040 | 10:24:48 INFO - PROCESS | 7040 | Cycle 1(1): loaded http://localhost:37890/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37890/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:24:48 INFO - PROCESS | 7040 | RSS: Main: 205643776 10:24:48 INFO - PROCESS | 7040 | 10:24:50 INFO - PROCESS | 7040 | Cycle 1(1): loaded http://localhost:37890/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37890/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:24:51 INFO - PROCESS | 7040 | RSS: Main: 217964544 10:24:51 INFO - PROCESS | 7040 | 10:24:54 INFO - PROCESS | 7040 | Cycle 1(1): loaded http://localhost:37890/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37890/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:24:54 INFO - PROCESS | 7040 | RSS: Main: 220561408 10:24:54 INFO - PROCESS | 7040 | 10:24:57 INFO - PROCESS | 7040 | Cycle 1(1): loaded http://localhost:37890/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37890/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:24:58 INFO - PROCESS | 7040 | RSS: Main: 217448448 10:24:58 INFO - PROCESS | 7040 | 10:24:59 INFO - PROCESS | 7040 | Cycle 1(1): loaded http://localhost:37890/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37890/tests/kraken/driver.html?testName=ai-astar) 10:25:00 INFO - PROCESS | 7040 | RSS: Main: 281681920 10:25:00 INFO - PROCESS | 7040 | 10:25:00 INFO - PROCESS | 7040 | __start_tp_report 10:25:00 INFO - PROCESS | 7040 | _x_x_mozilla_page_load 10:25:00 INFO - PROCESS | 7040 | _x_x_mozilla_page_load_details 10:25:00 INFO - PROCESS | 7040 | |i|pagename|runs| 10:25:00 INFO - PROCESS | 7040 | |0;ai-astar;110;111;107;109;112;111;100;111;111;111 10:25:00 INFO - PROCESS | 7040 | |1;audio-beat-detection;150;130;155;182;130;150;155;127;188;127 10:25:00 INFO - PROCESS | 7040 | |2;audio-dft;161;160;161;163;159;161;160;160;161;162 10:25:00 INFO - PROCESS | 7040 | |3;audio-fft;73;81;94;120;76;75;77;125;104;73 10:25:00 INFO - PROCESS | 7040 | |4;audio-oscillator;93;92;146;93;93;92;138;92;93;155 10:25:00 INFO - PROCESS | 7040 | |5;imaging-gaussian-blur;117;117;117;117;117;117;118;118;117;117 10:25:00 INFO - PROCESS | 7040 | |6;imaging-darkroom;145;145;145;146;147;145;144;145;145;145 10:25:00 INFO - PROCESS | 7040 | |7;imaging-desaturate;94;94;95;94;95;95;95;95;94;95 10:25:00 INFO - PROCESS | 7040 | |8;json-parse-financial;58;55;57;55;56;57;58;83;55;55 10:25:00 INFO - PROCESS | 7040 | |9;json-stringify-tinderbox;60;61;61;61;61;61;61;61;61;60 10:25:00 INFO - PROCESS | 7040 | |10;stanford-crypto-aes;76;76;76;81;76;77;76;76;76;78 10:25:00 INFO - PROCESS | 7040 | |11;stanford-crypto-ccm;124;124;122;122;121;124;124;128;207;127 10:25:00 INFO - PROCESS | 7040 | |12;stanford-crypto-pbkdf2;173;163;166;168;165;165;164;165;165;171 10:25:00 INFO - PROCESS | 7040 | |13;stanford-crypto-sha256-iterative;69;70;70;68;68;67;69;68;69;68 10:25:00 INFO - PROCESS | 7040 | __end_tp_report 10:25:00 INFO - PROCESS | 7040 | __start_cc_report 10:25:00 INFO - PROCESS | 7040 | _x_x_mozilla_cycle_collect,1607 10:25:00 INFO - PROCESS | 7040 | __end_cc_report 10:25:00 INFO - PROCESS | 7040 | __startTimestamp1461259500060__endTimestamp 10:25:00 INFO - PROCESS | 7040 | 10:25:00 INFO - PROCESS | 7040 | ------- Summary: start ------- 10:25:00 INFO - PROCESS | 7040 | Number of tests: 14 10:25:00 INFO - PROCESS | 7040 | 10:25:00 INFO - PROCESS | 7040 | [#0] ai-astar Cycles:10 Average:109.30 Median:111.00 stddev:3.56 (3.2%) stddev-sans-first:3.77 10:25:00 INFO - PROCESS | 7040 | Values: 110.0 111.0 107.0 109.0 112.0 111.0 100.0 111.0 111.0 111.0 10:25:00 INFO - PROCESS | 7040 | 10:25:00 INFO - PROCESS | 7040 | [#1] audio-beat-detection Cycles:10 Average:149.40 Median:152.50 stddev:22.04 (14.5%) stddev-sans-first:23.38 10:25:00 INFO - PROCESS | 7040 | Values: 150.0 130.0 155.0 182.0 130.0 150.0 155.0 127.0 188.0 127.0 10:25:00 INFO - PROCESS | 7040 | 10:25:00 INFO - PROCESS | 7040 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.14 (0.7%) stddev-sans-first:1.20 10:25:00 INFO - PROCESS | 7040 | Values: 161.0 160.0 161.0 163.0 159.0 161.0 160.0 160.0 161.0 162.0 10:25:00 INFO - PROCESS | 7040 | 10:25:00 INFO - PROCESS | 7040 | [#3] audio-fft Cycles:10 Average:89.80 Median:75.50 stddev:19.96 (26.4%) stddev-sans-first:20.22 10:25:00 INFO - PROCESS | 7040 | Values: 73.0 81.0 94.0 120.0 76.0 75.0 77.0 125.0 104.0 73.0 10:25:00 INFO - PROCESS | 7040 | 10:25:00 INFO - PROCESS | 7040 | [#4] audio-oscillator Cycles:10 Average:108.70 Median:92.50 stddev:26.28 (28.4%) stddev-sans-first:27.25 10:25:00 INFO - PROCESS | 7040 | Values: 93.0 92.0 146.0 93.0 93.0 92.0 138.0 92.0 93.0 155.0 10:25:00 INFO - PROCESS | 7040 | 10:25:00 INFO - PROCESS | 7040 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:25:00 INFO - PROCESS | 7040 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 118.0 118.0 117.0 117.0 10:25:00 INFO - PROCESS | 7040 | 10:25:00 INFO - PROCESS | 7040 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 10:25:00 INFO - PROCESS | 7040 | Values: 145.0 145.0 145.0 146.0 147.0 145.0 144.0 145.0 145.0 145.0 10:25:00 INFO - PROCESS | 7040 | 10:25:00 INFO - PROCESS | 7040 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 10:25:00 INFO - PROCESS | 7040 | Values: 94.0 94.0 95.0 94.0 95.0 95.0 95.0 95.0 94.0 95.0 10:25:00 INFO - PROCESS | 7040 | 10:25:00 INFO - PROCESS | 7040 | [#8] json-parse-financial Cycles:10 Average:58.90 Median:57.00 stddev:8.56 (15.0%) stddev-sans-first:9.07 10:25:00 INFO - PROCESS | 7040 | Values: 58.0 55.0 57.0 55.0 56.0 57.0 58.0 83.0 55.0 55.0 10:25:00 INFO - PROCESS | 7040 | 10:25:00 INFO - PROCESS | 7040 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.42 (0.7%) stddev-sans-first:0.33 10:25:00 INFO - PROCESS | 7040 | Values: 60.0 61.0 61.0 61.0 61.0 61.0 61.0 61.0 61.0 60.0 10:25:00 INFO - PROCESS | 7040 | 10:25:00 INFO - PROCESS | 7040 | [#10] stanford-crypto-aes Cycles:10 Average:76.80 Median:76.00 stddev:1.62 (2.1%) stddev-sans-first:1.69 10:25:00 INFO - PROCESS | 7040 | Values: 76.0 76.0 76.0 81.0 76.0 77.0 76.0 76.0 76.0 78.0 10:25:00 INFO - PROCESS | 7040 | 10:25:00 INFO - PROCESS | 7040 | [#11] stanford-crypto-ccm Cycles:10 Average:132.30 Median:124.00 stddev:26.34 (21.2%) stddev-sans-first:27.76 10:25:00 INFO - PROCESS | 7040 | Values: 124.0 124.0 122.0 122.0 121.0 124.0 124.0 128.0 207.0 127.0 10:25:00 INFO - PROCESS | 7040 | 10:25:00 INFO - PROCESS | 7040 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.50 Median:165.50 stddev:3.21 (1.9%) stddev-sans-first:2.39 10:25:00 INFO - PROCESS | 7040 | Values: 173.0 163.0 166.0 168.0 165.0 165.0 164.0 165.0 165.0 171.0 10:25:00 INFO - PROCESS | 7040 | 10:25:00 INFO - PROCESS | 7040 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.00 stddev:0.97 (1.4%) stddev-sans-first:1.01 10:25:00 INFO - PROCESS | 7040 | Values: 69.0 70.0 70.0 68.0 68.0 67.0 69.0 68.0 69.0 68.0 10:25:00 INFO - PROCESS | 7040 | -------- Summary: end -------- 10:25:00 INFO - PROCESS | 7040 | 10:25:00 INFO - TEST-INFO | 7040: exit 0 10:25:00 INFO - TEST-OK | kraken | took 60710ms 10:25:00 INFO - SUITE-END | took 1173s 10:25:01 INFO - Completed test suite (00:19:33) 10:25:01 INFO - javascript benchmark 10:25:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3093.7989030713006, 3139.3407384449265, 3185.7292130168935, 3187.3465939482408, 3215.26049008728, 5203.531682148606, 5253.86865328367, 5281.366236051675, 5294.205869119624, 5315.255864179013, 5214.973925130378, 5266.7893284268675, 5281.471852814717, 5291.126964050927, 5299.28459657946, 4707.199776038065, 4764.047190561892, 4868.878278043059, 4902.338184345122, 4908.141075311806, 4814.951850481485, 4858.805647774085, 4890.633202509826, 4891.241857512074, 4899.265110233458, 4712.0, 4755.239161734106, 4768.713877167381, 4785.066911952188, 4812.278158276252, 4791.305260737208, 4820.30105634681, 4821.035792841446, 4821.132196204681, 4854.587360074398, 4702.905941881178, 4782.3543821584335, 4786.760661966888, 4800.375951126366, 4816.349792777965, 5189.610779191538, 5191.0656081905245, 5222.556082732972, 5276.657017293864, 5296.655717378358, 5464.316960379952, 5476.041692703761, 5486.972565137149, 5487.2317875497465, 5493.176023596453, 5525.11598144295, 5535.114381698909, 5550.611457197998, 5567.582431317627, 5613.607047506676, 5299.099153143975, 5310.840674779763, 5322.441143679896, 5325.0148722486465, 5360.088784906575, 5745.166950792195, 5746.655200687972, 5748.137779333133, 5748.338941021752, 5750.0, 5434.891302174014, 5533.0, 5548.861278468071, 5561.972190139023, 5644.6613203207935, 5664.348599910981, 5666.603337766317, 5667.631603945731, 5670.461306175906, 5673.461021202979, 5613.550915926716, 5631.859203519863, 5643.915341269884, 5648.548116150698, 5649.096144616841, 5407.351117865881, 5556.249906262684, 5603.943960560424, 5619.325680918316, 5673.035583950738, 4271.530131685512, 4281.443412356373, 4288.35674648799, 4290.764007979591, 4325.329573916048, 3837.9040523987123, 3866.6326698963553, 3880.8059597020037, 3894.182221733411, 3897.415387691812, 5270.868228294246, 5313.867153321198, 5367.731613419313, 5404.32445944257, 5414.0, 5550.694711790809, 5555.8888822223325, 5557.638753481011, 5560.972195138998, 5563.248961390242, 5127.948720512822, 5186.688798672092, 5210.270562121306, 5210.322658054504, 5241.659292145999, 4721.787519561628, 4766.76166191689, 4770.570648641569, 4820.831270905502, 4823.866391398019, 5748.48263656273, 5785.681787501728, 5788.18965344852, 5791.942080579224, 5795.88408231833, 5556.222128902038, 5569.610127291051, 5611.635243709309, 5612.298462692163, 5636.126400407943, 5800.39095894925, 5816.5055970243, 5819.82540523785, 5823.126531020381, 5885.499732522783, 5537.031019571478, 5546.944530554804, 5548.778048878161, 5553.055980483408, 5557.805476808292, 5439.891202175855, 5492.066348720807, 5587.972060139673, 5626.690532020778, 5633.352164501135, 5540.722963851711, 5568.526675232651, 5573.052581061311, 5575.330960284629, 5582.246396736388, 5533.916991245215, 5565.3599836019375, 5566.081596536526, 5567.415421380697, 5575.275214222125, 5214.9478505214465, 5299.966506531189, 5391.676499410048, 5397.865053373697, 5512.145617429305, 5580.441955804549, 5583.190437386637, 5586.608937374344, 5587.385387607279, 5601.663900166003, 5440.483154100354, 5464.672119672832, 5468.589855760913, 5480.068388373907, 5487.6981766003255], "value": 5189.352546190937, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.6154341992836, 639.0031550780782, 652.9902051469226, 666.2371584535704, 679.762083270855, 31165.0, 31868.36263274736, 35951.46072808907, 36890.4466433003, 36997.07507312312, 39182.8040859796, 39759.801200993956, 39769.204615907736, 39812.80093599528, 39839.0, 8505.78735531612, 8677.435966662148, 8702.260307873807, 8704.738857834243, 8707.0, 7856.803579910491, 10175.898241017569, 10558.155347572214, 10567.630132945349, 10570.15438764897, 10222.335548189381, 10305.175585953144, 10305.278630495868, 10318.638847640334, 10325.225608079425, 7874.5668988205625, 10123.0, 10174.4912754362, 10225.693229203061, 10231.999999999964, 10122.139618132467, 10252.641157559525, 10270.435126068063, 10282.331648442827, 10284.125849302818, 35445.645543544495, 35929.46105808415, 36052.459213111826, 36093.45859812105, 36105.63894361076, 3462.7229821614465, 3512.8594856205723, 3543.2541126166934, 3565.1265439967374, 3586.7130629549833, 29767.553486697718, 30761.692383076108, 31683.841580792177, 31706.524402133757, 32330.676693233003, 4287.914241715148, 4303.784810759449, 4322.394864718942, 4362.8036738346855, 4379.64962802975, 256525.0, 256995.0, 257559.0, 257667.0, 258056.70971645208, 54927.450725492236, 55649.0, 56031.43968560344, 56109.43890561042, 56169.0, 59540.404595953485, 59860.70069649711, 59980.70009649924, 62375.0, 65222.0, 14060.578182654537, 14147.929260353632, 14190.858091418953, 14227.0, 14232.28838558068, 11217.55129794799, 11237.21339506243, 11247.718807029889, 11252.943735281271, 11261.887381126084, 19540.70688939667, 19845.30541431072, 19955.60088798216, 20104.49738756543, 20182.697259541117, 7318.048253942811, 7340.816479588053, 7631.198724133886, 7694.652521325434, 7714.9228507715325, 896.4621227263721, 914.2366124286162, 925.9953700231456, 930.3022732950287, 996.850472429127, 28567.714322856504, 29915.0, 31509.684903151134, 31731.365372692417, 31920.361592768015, 1030.4487099401933, 1033.2818691009827, 1063.0857462582173, 1091.9508622112023, 1175.9941200293945, 16491.83508164927, 16682.749758753627, 16807.243674034697, 16894.49316520506, 17164.656706865793, 184434.0, 186079.0, 186132.0, 186488.0, 186519.0, 52885.47114528805, 54699.0, 54752.726236368566, 54878.17682734762, 54967.0, 1203.9217450865665, 1288.3880156925386, 1290.2774446310095, 1292.5476083370934, 1452.7021960498073, 29783.404331913673, 36363.81818090893, 36476.45285320775, 36522.452163218106, 36881.0, 50431.24353134633, 50700.49299506958, 51349.48650513597, 51498.74250628723, 51508.484915150366, 334189.0, 336688.0, 338252.0, 338637.0, 338638.0, 24978.375540610905, 26634.467310654065, 26993.59509607397, 27566.724332756417, 28464.85767571149, 40411.7979410101, 40798.38802417907, 43188.784056079516, 44509.33236001398, 45673.54326456693, 39008.41487377748, 39537.80231098826, 40380.59619403886, 42140.367894482224, 42233.0, 34965.47551786776, 36766.0, 36807.81596092109, 37722.43416348702, 40478.79760601178, 38748.612513875625, 38846.80576597099, 38868.0, 39608.60391396049, 40002.59997400105, 34902.0, 35756.0, 36130.8193459031, 36215.81892090523, 36238.275234494635, 27885.0, 28015.0, 28067.57898631563, 28111.297217569725, 28324.575131373458], "value": 18857.146310130865, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.883525524715, 394.5521832719864, 396.6113209055124, 400.9739366941149, 406.81489922085456, 14046.43814247429, 14812.555623331291, 17320.393786217486, 17994.460166195004, 17999.100044997762, 14545.0, 14552.563423097297, 16480.83519164808, 16481.83518164818, 16960.067196304197, 5442.12925931851, 5471.753771080311, 5537.833864984037, 5628.352739434956, 5629.887402251952, 5495.0658388073925, 5549.472800083986, 5579.0, 5593.356763972134, 5593.804216852411, 4035.3341698619693, 5876.618019828718, 6126.540509461808, 6181.567290289681, 6186.907196392058, 5900.822975310747, 6118.571699981003, 6158.876822463548, 6164.630122192638, 6167.0, 5392.757325920343, 5414.269073675043, 5432.945670543323, 5453.563714902798, 5454.863628409282, 11915.165938384316, 12571.93714031424, 12605.621831345074, 12637.115401921868, 21632.0, 2226.4545186429427, 2287.1080278691325, 2302.228753367624, 2320.2691152287143, 2730.344717267861, 9210.447373157565, 9242.81514369709, 9278.582463789146, 9699.272554558365, 9959.55182016811, 1826.9543261418437, 1880.548668319607, 1894.1381671339507, 1962.2347284559035, 2128.467883029243, 72139.0, 76117.0, 79135.20864791336, 80461.0, 81943.59028204822, 10140.949295253477, 10238.232132590085, 10380.221483388776, 10499.632512862014, 10696.946515267375, 14800.407983680532, 14872.330745116496, 14874.107553546823, 14950.925245373703, 14960.925195373953, 6755.4257888080065, 6915.4121899638085, 7267.745628902963, 7278.526895751759, 7346.595937223397, 6947.305269473012, 6979.30206979298, 7098.822529436806, 7232.20445750967, 7254.347108760237, 4252.0, 4312.417823593774, 4491.910161796811, 4532.524084971031, 4569.109023740339, 1766.6908291049015, 1845.7600511933363, 1863.2174486715612, 1863.413024897153, 1876.249500199931, 1014.4927536231884, 1020.8264595018865, 1025.4923812712755, 1103.8730545987314, 1111.6109361723331, 17765.200565974563, 17768.46694599164, 17978.37075702344, 18066.638667226845, 18364.908175459306, 976.5898322704481, 1014.2697257974247, 1031.3708637730979, 1031.5718976624767, 1064.377339256528, 9850.704478865646, 10039.146672532917, 10152.289339746294, 10186.643467478603, 10295.794084118275, 474124.0, 484805.0, 488285.0, 542045.0, 546396.0, 91624.54187729151, 93396.0, 94650.52674736582, 95690.52154739182, 96382.51808740912, 1007.1741172238694, 1024.9743756406, 1029.9176065914858, 1040.245821779219, 1042.5152304178594, 15711.371545138523, 15732.292046858147, 15878.52364429069, 15930.920345398199, 16271.918640406722, 24768.380790480383, 37915.24169516649, 38259.234815304095, 38811.0, 39099.0, 37321.440178396806, 43660.56339436565, 49504.50495495143, 50085.0, 50791.74604126956, 8072.358393923635, 8132.30875375576, 8172.959135204286, 8310.958445207736, 8328.916710833057, 8973.012968573583, 11847.703807404883, 12655.873441265838, 12743.426545805276, 12756.107072504836, 11033.834492482458, 11109.778044390992, 11364.715882102682, 11368.317900925971, 11558.537658493902, 10417.47912604382, 10864.185186110915, 10994.780104398027, 11056.834147487632, 11099.556017759522, 11335.659930202108, 11485.48315325829, 11548.0, 11696.766064678828, 11755.471003804678, 8270.710525131592, 8278.544680042656, 8354.62404191825, 8410.201030902055, 8503.319734421355, 8805.64777408922, 11150.0, 11425.828612570653, 11467.139964502863, 11668.533258669897], "value": 8672.617495462862, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1358.300475255243, 1544.9613759656006, 1561.7657351397288, 1731.7921849378076, 1815.6550255451455, 7901.960490197548, 8203.179682031794, 8217.46586471879, 8223.753287401387, 8254.215849494296, 8043.276105150535, 8211.343092552597, 8220.260176584121, 8231.42380033398, 8236.052853921801, 1969.1040576537712, 2036.3381900882273, 2040.2655044184082, 2330.0796185506756, 2352.3648614873973, 2282.805961493275, 2357.5049239659693, 2360.775726305998, 2361.51588924271, 2362.9881850590723, 2280.623697089978, 2286.599845027122, 2298.2990187992655, 2298.850574712647, 2312.0173926081434, 2025.3113941260042, 2243.8317126215597, 2298.6666933294664, 2312.479692069288, 2316.525112351964, 2315.80315673168, 2330.5338932213626, 2331.1025255276672, 2335.019291897407, 2337.49743805081, 8104.473209241381, 8158.592070396457, 8171.918280817175, 8177.754667359989, 8180.141085186029, 4815.927761083586, 4968.850934471971, 4981.402231732215, 4989.3264409305, 4996.1756310208775, 3247.675232476757, 3322.833858307075, 3433.073070271038, 3462.740294477899, 3466.861325546975, 1075.7687097274124, 1083.2363183955372, 1086.283053184902, 1094.9835752463719, 1096.3476731344838, 11387.544498220144, 11427.48576314068, 11438.19932604718, 11458.083353331713, 11467.942660286646, 4381.956180438218, 4538.115067561794, 4663.463701674283, 4665.300204969214, 4667.929981050287, 9669.129778319984, 9670.661526846527, 9713.417194968324, 9718.61125554984, 9730.659426920023, 5046.243063540425, 5080.898382032413, 5082.085224659523, 5092.134337162691, 5094.974525127351, 4103.179364127186, 4497.6851620386915, 4623.283391074388, 4634.050019745944, 4667.206574882278, 3876.321643712339, 3905.824237909301, 3966.8214930328204, 3985.3822657488136, 4009.218202450494, 1263.1410640764368, 1270.30133426615, 1272.8854403103765, 1281.1800447713472, 1284.0177264392746, 977.6578197630772, 992.3004281981185, 1003.1673710820002, 1006.4816619440994, 1018.4907546226887, 5872.970635146797, 5875.559333050039, 5944.5838791284195, 5993.550483713739, 6116.29662588808, 450.1065385210355, 452.9569690879361, 456.18798538601345, 459.5794847714304, 460.82028009076487, 4012.337964235868, 4113.239050775616, 4134.152498737752, 4137.193247316804, 4207.26372884744, 9745.610175592898, 10046.748831279276, 10103.343282686601, 10136.341137826017, 10180.440075795903, 10205.693829185137, 10344.793104137874, 10346.793064138825, 10354.5340459678, 10363.222758293008, 7509.7371591994015, 7608.391328693691, 7617.209955660415, 7660.808479787938, 8021.598920053974, 5550.639208451437, 5648.435156484319, 5730.283714535683, 5763.538916886723, 5802.65184088956, 9147.222486088756, 9330.766730831783, 9364.906350936404, 9401.717948461557, 9413.81172376535, 9130.178283954476, 9336.439813610934, 9389.577469013775, 9392.248620110238, 9513.809723805623, 7110.57336559808, 7122.18094919091, 7144.928550714426, 7154.391876690332, 7172.677229524579, 7709.113451953097, 7720.498167619086, 7801.765947021599, 7934.087579928382, 7961.16407777175, 7269.3094156055095, 7405.111386633638, 7411.295926886937, 7521.811954701177, 7534.736284230025, 7207.099112610924, 7243.7464688735645, 7292.270772922665, 7358.11702595692, 7444.702211911463, 6801.523893327618, 6834.077399551195, 6848.863022739418, 6866.896996544956, 6867.622280774605, 4906.288588154769, 4965.82619608312, 5070.554891855803, 5089.567386772018, 5111.821086261963, 5003.649744517848, 5008.373953255843, 5039.0929632665, 5058.822941197188, 5093.668911520739], "value": 4387.374817142013, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.73295497124803, 338.9525466434699, 340.3652188668134, 343.58769476628055, 345.93279732026696, 5742.502011624946, 5753.856153596157, 5813.186153938452, 5825.067989121747, 5864.413558644133, 5678.290213723285, 5700.719712115156, 5709.343425506068, 5712.8857422851515, 5735.2544169257935, 4194.7483151010965, 4229.471316085489, 4237.512686041114, 4271.1671224111315, 4458.71018383804, 4402.581754733295, 4426.114777044588, 4427.402300689398, 4451.59935605797, 4458.910821783563, 4395.428594282739, 4400.019991004045, 4404.207242696313, 4411.316245981878, 4424.513303536608, 4117.0, 4315.4821421429315, 4408.53710360414, 4418.425604671372, 4427.579379958899, 3899.863504777319, 3905.0, 3906.960930390688, 3924.7841368724708, 3926.096997690547, 5544.140658197945, 5544.251526044013, 5548.528375088123, 5552.3892371839065, 5559.332880054379, 4827.686200396963, 5042.621803364762, 5055.180135151342, 5062.215356619693, 5073.746312684351, 5982.611130276561, 6002.0, 6008.699565021731, 6021.875015614318, 6051.2133422655215, 4020.618041286073, 4163.333866581363, 4216.7259128156875, 4229.661627069827, 4231.0, 6229.844253893643, 6266.686665666744, 6276.184096067482, 6285.245770507523, 6296.275928268262, 4267.0, 4267.594578515036, 4271.10306835568, 4274.572542745701, 4278.935815962763, 4240.809163587584, 4312.288472402081, 4331.263685173528, 4336.3278691802825, 4339.631131353807, 4971.875703107379, 4991.5258050485145, 4994.500549944976, 4996.775145118406, 5001.974990125026, 6030.487408570233, 6049.18336024631, 6050.152978583002, 6059.666718330446, 6070.7875224366935, 1467.1123969997998, 1483.7329280729573, 1499.8950073494968, 1508.1931166825696, 1519.7112548615728, 936.091990768953, 979.637534112383, 990.2424645146468, 1004.2969921055291, 1005.0954141272766, 5722.942770572325, 5754.4533269339345, 5755.85610359736, 5768.836686242659, 5810.389909059572, 6030.427109424598, 6046.3349031606485, 6064.4845188158615, 6074.75700971965, 6085.574009819358, 5560.138178582326, 5716.142578613241, 5733.957559920246, 5748.856278592985, 5756.395578464201, 3233.5796346475277, 3241.497567876983, 3249.561309223272, 3262.60848698153, 3274.3942370661503, 6123.203983482119, 6312.905306420407, 6329.208848893888, 6330.556861019684, 6331.366863313632, 6230.968845155745, 6241.563090583615, 6269.0, 6269.498440124779, 6284.994400895835, 6332.4934005279465, 6357.904631430532, 6363.936360636427, 6364.045393191059, 6388.552801303864, 5991.221141251609, 6199.814005579839, 6228.22147231596, 6280.0, 6301.0, 6157.0, 6165.414285642857, 6168.290646575701, 6174.25908890918, 6203.4416902479, 6303.810885673437, 6490.48076153916, 6504.089427480062, 6513.1532900722605, 6515.12045873801, 4265.0616864289805, 4269.267668691978, 4285.807138678704, 4289.914201715886, 4302.462192225972, 6148.44663980244, 6272.090546870587, 6297.653629050446, 6298.937010630018, 6307.24313082433, 6119.816405507842, 6124.6325220486915, 6126.877462450815, 6128.50971922254, 6133.84665383369, 6088.786892458743, 6102.847428814315, 6107.694615269308, 6132.9080063799975, 6147.815565533041, 5896.764129434775, 5971.223740913653, 6008.399160083956, 6024.156618073385, 6033.879322413615, 6059.0, 6101.908471372844, 6124.203853499017, 6134.110553969738, 6146.846328841814, 5888.852778680567, 5892.7642894283745, 5973.253343332083, 6001.159837622649, 6028.4272994065495], "value": 4554.172410370452, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [844.5945945945946, 846.8264005878796, 849.8725191221316, 871.0418539606434, 896.2561074308322, 14064.0, 14379.71240575188, 14411.855881441208, 14485.927570362146, 14801.629959251024, 15481.0, 15544.455944041962, 15692.843071569281, 15700.450484233053, 15742.055476671409, 688.8553403785211, 811.1482942909921, 827.1480375213524, 832.7709879783048, 837.2883049407985, 840.6763396092518, 844.1937949258444, 844.2654890245495, 847.9024912135121, 848.0205362805968, 870.3559366069095, 873.1443185678007, 873.4279047224078, 873.5021038008338, 873.7378786364065, 719.7049209823973, 738.7303634173514, 738.970441182352, 852.3138873207066, 868.2272777228272, 637.9744810207586, 638.1257676982517, 639.1307821362942, 639.5650957349001, 639.6226226526326, 14303.713925721428, 14325.35535900887, 14346.49787257441, 14352.0, 14365.13809171453, 13566.864331356659, 13742.312884355742, 13831.723365532735, 14034.438622455089, 14052.508162214273, 11760.353180575064, 11929.224600400947, 12196.695082622917, 12213.45039473226, 12365.814512782315, 3886.203328317688, 3930.8231129599235, 3938.0942383251727, 4043.6158564936286, 4048.291548978946, 58945.0, 59954.40045599532, 60389.69805150946, 60450.395496045356, 61192.0, 11306.152038597138, 11416.257943233662, 11526.0, 11532.25040372373, 11552.711182220344, 19558.21767129299, 19966.201351945758, 20015.799842001685, 20371.287004954756, 20453.79546204519, 8281.917180828235, 8299.751007469786, 8431.030431500456, 8702.390832641655, 8848.557572121368, 4744.786484608201, 4792.376990991149, 4797.280407938837, 4836.56470917612, 4892.266160075946, 3386.068831071475, 3463.7530489024434, 3469.6877281044826, 3470.0804286864, 3470.3579837729594, 625.1997443272618, 631.6052467207995, 640.6572483721187, 649.8830210562049, 651.775137577535, 725.3399406540024, 752.5071078443628, 779.2363483785922, 779.9649015794303, 786.7757689058591, 8514.74455766328, 9473.428731345115, 9535.761605959906, 9540.666076687283, 9736.969949337175, 547.3322546493272, 653.31075715121, 669.9765508207189, 670.9295523970011, 703.6165289917008, 4463.308187230984, 4492.483364413069, 4519.954800451954, 4537.591616754508, 4636.0, 60050.39949600448, 60559.39440605538, 60873.39126608766, 62677.373226267155, 62784.37215627877, 52031.0, 52679.47320526822, 53472.465275347524, 53730.7313463438, 53862.0, 47941.28088078681, 48113.278300824815, 48528.0, 48643.0, 49991.0, 9247.583858726508, 9302.627894884128, 9464.95267523658, 9545.713628591153, 9549.188318992963, 31574.684253158095, 32226.83886580552, 32355.19112022218, 32621.18447038843, 32712.182195445304, 40874.59125408708, 41412.585874140874, 42033.78983105187, 43423.0, 45095.0, 11456.312621242752, 11505.827412588651, 11636.185467017227, 11851.762964740485, 11889.524419023488, 13344.799828002782, 13784.241866697428, 13891.0, 14589.781153282496, 14679.70640587161, 10113.165011296913, 12683.429245683781, 13047.217166970013, 13343.66640833987, 14099.436022558983, 13052.934735326262, 13069.346532673519, 13298.268595227355, 13402.463901444224, 13453.730925381633, 12213.816792747939, 12221.633350999484, 12492.375381231084, 12739.872601273868, 13375.732485350432, 10565.101966332948, 10624.787504250025, 10918.945405272923, 11026.50380732885, 11054.613088541862, 11078.224524283223, 11552.711182220512, 11777.411129443322, 11837.822432663344, 11948.701282468008], "value": 6864.242604863127, "unit": "score"}], "name": "dromaeo_css", "value": 6987.652147758181, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 107.0, 109.0, 112.0, 111.0, 100.0, 111.0, 111.0, 111.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 130.0, 155.0, 182.0, 130.0, 150.0, 155.0, 127.0, 188.0, 127.0], "value": 149.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 163.0, 159.0, 161.0, 160.0, 160.0, 161.0, 162.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 81.0, 94.0, 120.0, 76.0, 75.0, 77.0, 125.0, 104.0, 73.0], "value": 89.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 146.0, 93.0, 93.0, 92.0, 138.0, 92.0, 93.0, 155.0], "value": 108.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 146.0, 147.0, 145.0, 144.0, 145.0, 145.0, 145.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 55.0, 57.0, 55.0, 56.0, 57.0, 58.0, 83.0, 55.0, 55.0], "value": 58.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 60.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 81.0, 76.0, 77.0, 76.0, 76.0, 76.0, 78.0], "value": 76.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 124.0, 122.0, 122.0, 121.0, 124.0, 124.0, 128.0, 207.0, 127.0], "value": 132.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 163.0, 166.0, 168.0, 165.0, 165.0, 164.0, 165.0, 165.0, 171.0], "value": 166.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 70.0, 68.0, 68.0, 67.0, 69.0, 68.0, 69.0, 68.0], "value": 68.6, "unit": "score"}], "name": "kraken", "value": 1538.8999999999999, "alertThreshold": 2.0}]} 10:25:01 INFO - Return code: 0 10:25:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:25:01 ERROR - # TBPL SUCCESS # 10:25:01 INFO - Running post-action listener: _resource_record_post_action 10:25:01 INFO - Running post-run listener: _resource_record_post_run 10:25:02 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 12288; Write bytes: 536526848; Read time: 36; Write time: 501904 10:25:02 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244486144; Read time: 0; Write time: 268192 10:25:02 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 12288; Write bytes: 292040704; Read time: 36; Write time: 233712 10:25:02 INFO - Running post-run listener: _upload_blobber_files 10:25:02 INFO - Blob upload gear active. 10:25:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:25:02 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 10:25:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:25:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:25:02 INFO - (blobuploader) - INFO - Open directory for files ... 10:25:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:25:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:25:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:25:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:25:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:25:03 INFO - (blobuploader) - INFO - Done attempting. 10:25:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:25:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:25:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:25:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:25:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:25:04 INFO - (blobuploader) - INFO - Done attempting. 10:25:04 INFO - (blobuploader) - INFO - Iteration through files over. 10:25:04 INFO - Return code: 0 10:25:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:25:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:25:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24fe39ca6aaabc053eb0c516ff2ecccd5fdb984eb83aefc687dd5df9c2b8c2634521b270b823cd7597a60c79a2478d7826759c5cc21cb12bd0a15cf5dc322f03", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d759658e8467cefe6bf889556cd4222aa7b883282a24ee2852ad19e2bbc0687b9126ffdd3cf0b26e081862eefd0e7b379e11cf4b85baae2e832c38ae0bab65b"} 10:25:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:25:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:25:04 INFO - Contents: 10:25:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24fe39ca6aaabc053eb0c516ff2ecccd5fdb984eb83aefc687dd5df9c2b8c2634521b270b823cd7597a60c79a2478d7826759c5cc21cb12bd0a15cf5dc322f03", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d759658e8467cefe6bf889556cd4222aa7b883282a24ee2852ad19e2bbc0687b9126ffdd3cf0b26e081862eefd0e7b379e11cf4b85baae2e832c38ae0bab65b"} 10:25:04 INFO - Running post-run listener: copy_logs_to_upload_dir 10:25:04 INFO - Copying logs to upload dir... 10:25:04 INFO - mkdir: /builds/slave/test/build/upload/logs 10:25:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.343978 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-04-21 10:25:04.529940) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 10:25:04.533522) ========= 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=4ac8d263c7293b36a1be1aed000001be-1461258228.916943-2064754446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24fe39ca6aaabc053eb0c516ff2ecccd5fdb984eb83aefc687dd5df9c2b8c2634521b270b823cd7597a60c79a2478d7826759c5cc21cb12bd0a15cf5dc322f03", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d759658e8467cefe6bf889556cd4222aa7b883282a24ee2852ad19e2bbc0687b9126ffdd3cf0b26e081862eefd0e7b379e11cf4b85baae2e832c38ae0bab65b"} build_url:https://queue.taskcluster.net/v1/task/AEOvskxPTPmGIRx_GmE9Aw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011478 build_url: 'https://queue.taskcluster.net/v1/task/AEOvskxPTPmGIRx_GmE9Aw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24fe39ca6aaabc053eb0c516ff2ecccd5fdb984eb83aefc687dd5df9c2b8c2634521b270b823cd7597a60c79a2478d7826759c5cc21cb12bd0a15cf5dc322f03", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d759658e8467cefe6bf889556cd4222aa7b883282a24ee2852ad19e2bbc0687b9126ffdd3cf0b26e081862eefd0e7b379e11cf4b85baae2e832c38ae0bab65b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 10:25:04.559434) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 10:25:04.559822) ========= 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=4ac8d263c7293b36a1be1aed000001be-1461258228.916943-2064754446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004542 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 10:25:04.644161) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 10:25:04.644560) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 10:25:04.644926) ========= ========= Total master_lag: 0.19 =========