builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-026 starttime: 1461234016.02 results: success (0) buildid: 20160421004015 builduid: f5477824316040afb8baf30e22588afd revision: d9fdbad8f079c7801abdef70df2cad93efcce797 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 03:20:16.018426) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 03:20:16.018892) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 03:20:16.019357) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 03:20:16.038047) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 03:20:16.038626) ========= 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=41bf3e9aed84707956354da8000001c5-1461231333.215978-111066485 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-21 03:20:16-- 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% 22.8M=0.001s 2016-04-21 03:20:16 (22.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121131 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 03:20:16.173457) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 03:20:16.173746) ========= 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=41bf3e9aed84707956354da8000001c5-1461231333.215978-111066485 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014115 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 03:20:16.225711) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-21 03:20:16.226055) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d9fdbad8f079c7801abdef70df2cad93efcce797 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d9fdbad8f079c7801abdef70df2cad93efcce797 --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=41bf3e9aed84707956354da8000001c5-1461231333.215978-111066485 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-21 03:20:16,632 truncating revision to first 12 chars 2016-04-21 03:20:16,632 Setting DEBUG logging. 2016-04-21 03:20:16,632 attempt 1/10 2016-04-21 03:20:16,633 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d9fdbad8f079?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-21 03:20:18,218 unpacking tar archive at: mozilla-aurora-d9fdbad8f079/testing/mozharness/ program finished with exit code 0 elapsedTime=1.926699 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-21 03:20:18.165722) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 03:20:18.166040) ========= script_repo_revision: d9fdbad8f079c7801abdef70df2cad93efcce797 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 03:20:18.166444) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 03:20:18.166711) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 03:20:18.176349) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-04-21 03:20:18.176681) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1461231333.215978-111066485 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:20:18 INFO - MultiFileLogger online at 20160421 03:20:18 in /builds/slave/test 03:20:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:20:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:20:18 INFO - {'append_to_log': False, 03:20:18 INFO - 'base_work_dir': '/builds/slave/test', 03:20:18 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:20:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:20:18 INFO - 'branch': 'Mozilla-Aurora', 03:20:18 INFO - 'buildbot_json_path': 'buildprops.json', 03:20:18 INFO - 'config_files': ('talos/linux_config.py',), 03:20:18 INFO - 'default_actions': ('clobber', 03:20:18 INFO - 'read-buildbot-config', 03:20:18 INFO - 'download-and-extract', 03:20:18 INFO - 'populate-webroot', 03:20:18 INFO - 'create-virtualenv', 03:20:18 INFO - 'install', 03:20:18 INFO - 'run-tests'), 03:20:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:20:18 INFO - 'download_minidump_stackwalk': True, 03:20:18 INFO - 'download_symbols': 'ondemand', 03:20:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:20:18 INFO - 'tooltool.py': '/tools/tooltool.py', 03:20:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:20:18 INFO - '/tools/misc-python/virtualenv.py')}, 03:20:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:20:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:20:18 INFO - 'installer_path': 'installer.exe', 03:20:18 INFO - 'log_level': 'info', 03:20:18 INFO - 'log_name': 'talos', 03:20:18 INFO - 'log_to_console': True, 03:20:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:20:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:20:18 INFO - 'opt_config_files': (), 03:20:18 INFO - 'pip_index': False, 03:20:18 INFO - 'sps_profile': False, 03:20:18 INFO - 'sps_profile_interval': 0, 03:20:18 INFO - 'suite': 'dromaeojs', 03:20:18 INFO - 'system_bits': '32', 03:20:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:20:18 INFO - 'title': 'talos-linux64-ix-026', 03:20:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:20:18 INFO - 'use_talos_json': True, 03:20:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:20:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:20:18 INFO - 'work_dir': 'build'} 03:20:18 INFO - ##### 03:20:18 INFO - ##### Running clobber step. 03:20:18 INFO - ##### 03:20:18 INFO - Running pre-action listener: _resource_record_pre_action 03:20:18 INFO - Running main action method: clobber 03:20:18 INFO - rmtree: /builds/slave/test/build 03:20:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:20:19 INFO - Running post-action listener: _resource_record_post_action 03:20:19 INFO - ##### 03:20:19 INFO - ##### Running read-buildbot-config step. 03:20:19 INFO - ##### 03:20:19 INFO - Running pre-action listener: _resource_record_pre_action 03:20:19 INFO - Running main action method: read_buildbot_config 03:20:19 INFO - Using buildbot properties: 03:20:19 INFO - { 03:20:19 INFO - "project": "", 03:20:19 INFO - "product": "firefox", 03:20:19 INFO - "script_repo_revision": "production", 03:20:19 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:20:19 INFO - "repository": "", 03:20:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:20:19 INFO - "buildid": "20160421004015", 03:20:19 INFO - "stage_platform": "linux64-pgo", 03:20:19 INFO - "basedir": "/builds/slave/test", 03:20:19 INFO - "nightly_build": "True", 03:20:19 INFO - "buildnumber": 272, 03:20:19 INFO - "slavename": "talos-linux64-ix-026", 03:20:19 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:20:19 INFO - "platform": "ubuntu64_hw", 03:20:19 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:20:19 INFO - "branch": "mozilla-aurora", 03:20:19 INFO - "repo_path": "releases/mozilla-aurora", 03:20:19 INFO - "revision": "d9fdbad8f079c7801abdef70df2cad93efcce797", 03:20:19 INFO - "pgo_build": "True", 03:20:19 INFO - "builduid": "f5477824316040afb8baf30e22588afd", 03:20:19 INFO - "slavebuilddir": "test" 03:20:19 INFO - } 03:20:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/H88g_4wJTBOfzYgxq1_d6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 03:20:19 INFO - Running post-action listener: _resource_record_post_action 03:20:19 INFO - ##### 03:20:19 INFO - ##### Running download-and-extract step. 03:20:19 INFO - ##### 03:20:19 INFO - Running pre-action listener: _resource_record_pre_action 03:20:19 INFO - Running main action method: download_and_extract 03:20:19 INFO - mkdir: /builds/slave/test/build/tests 03:20:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:20:19 INFO - https://queue.taskcluster.net/v1/task/H88g_4wJTBOfzYgxq1_d6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:20:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H88g_4wJTBOfzYgxq1_d6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:20:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H88g_4wJTBOfzYgxq1_d6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:20:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H88g_4wJTBOfzYgxq1_d6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:20:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H88g_4wJTBOfzYgxq1_d6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:20:20 INFO - Downloaded 1448 bytes. 03:20:20 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:20:20 INFO - Using the following test package requirements: 03:20:20 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:20:20 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:20:20 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:20:20 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:20:20 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:20:20 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:20:20 INFO - u'jsshell-linux-x86_64.zip'], 03:20:20 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:20:20 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:20:20 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:20:20 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:20:20 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:20:20 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:20:20 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:20:20 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:20:20 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:20:20 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:20:20 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:20:20 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:20:20 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:20:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:20:20 INFO - https://queue.taskcluster.net/v1/task/H88g_4wJTBOfzYgxq1_d6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:20:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H88g_4wJTBOfzYgxq1_d6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:20:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H88g_4wJTBOfzYgxq1_d6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:20:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H88g_4wJTBOfzYgxq1_d6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:20:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H88g_4wJTBOfzYgxq1_d6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:20:21 INFO - Downloaded 23355715 bytes. 03:20:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:20:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:20:22 INFO - Return code: 0 03:20:22 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:20:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:20:22 INFO - https://queue.taskcluster.net/v1/task/H88g_4wJTBOfzYgxq1_d6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:20:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H88g_4wJTBOfzYgxq1_d6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:20:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H88g_4wJTBOfzYgxq1_d6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:20:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H88g_4wJTBOfzYgxq1_d6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:20:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H88g_4wJTBOfzYgxq1_d6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:20:29 INFO - Downloaded 23355715 bytes. 03:20:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:20:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:20:31 INFO - Return code: 0 03:20:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:20:31 INFO - https://queue.taskcluster.net/v1/task/H88g_4wJTBOfzYgxq1_d6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:20:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H88g_4wJTBOfzYgxq1_d6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 03:20:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H88g_4wJTBOfzYgxq1_d6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 03:20:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H88g_4wJTBOfzYgxq1_d6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 03:20:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H88g_4wJTBOfzYgxq1_d6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:20:32 INFO - Downloaded 10845198 bytes. 03:20:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:20:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:20:32 INFO - Return code: 0 03:20:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:20:32 INFO - https://queue.taskcluster.net/v1/task/H88g_4wJTBOfzYgxq1_d6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:20:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H88g_4wJTBOfzYgxq1_d6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:20:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H88g_4wJTBOfzYgxq1_d6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:20:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H88g_4wJTBOfzYgxq1_d6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:20:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H88g_4wJTBOfzYgxq1_d6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:20:33 INFO - Downloaded 60612533 bytes. 03:20:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H88g_4wJTBOfzYgxq1_d6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:20:33 INFO - mkdir: /builds/slave/test/properties 03:20:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:20:33 INFO - Writing to file /builds/slave/test/properties/build_url 03:20:33 INFO - Contents: 03:20:33 INFO - build_url:https://queue.taskcluster.net/v1/task/H88g_4wJTBOfzYgxq1_d6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:20:34 INFO - Running post-action listener: _resource_record_post_action 03:20:34 INFO - Running post-action listener: set_extra_try_arguments 03:20:34 INFO - ##### 03:20:34 INFO - ##### Running populate-webroot step. 03:20:34 INFO - ##### 03:20:34 INFO - Running pre-action listener: _resource_record_pre_action 03:20:34 INFO - Running main action method: populate_webroot 03:20:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:20:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:20:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:20:34 INFO - '--tppagecycles', 03:20:34 INFO - '7'], 03:20:34 INFO - 'tests': ['tsvgm']}}, 03:20:34 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:20:34 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:20:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:20:34 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 03:20:34 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:20:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:20:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:20:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:20:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:20:34 INFO - 'talos_options': ['--e10s'], 03:20:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:20:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:20:34 INFO - 'tests': ['damp', 'tps']}, 03:20:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:20:34 INFO - 'talos_options': ['--e10s'], 03:20:34 INFO - 'tests': ['damp', 'tps']}, 03:20:34 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:20:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:20:34 INFO - 'other': {'tests': ['a11yr', 03:20:34 INFO - 'ts_paint', 03:20:34 INFO - 'tpaint', 03:20:34 INFO - 'sessionrestore', 03:20:34 INFO - 'sessionrestore_no_auto_restore', 03:20:34 INFO - 'tabpaint']}, 03:20:34 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:20:34 INFO - 'tests': ['a11yr', 03:20:34 INFO - 'ts_paint', 03:20:34 INFO - 'tpaint', 03:20:34 INFO - 'sessionrestore', 03:20:34 INFO - 'sessionrestore_no_auto_restore', 03:20:34 INFO - 'tabpaint']}, 03:20:34 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:20:34 INFO - 'tests': ['a11yr', 03:20:34 INFO - 'ts_paint', 03:20:34 INFO - 'tpaint', 03:20:34 INFO - 'sessionrestore', 03:20:34 INFO - 'sessionrestore_no_auto_restore', 03:20:34 INFO - 'tabpaint']}, 03:20:34 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:20:34 INFO - 'tests': ['a11yr', 03:20:34 INFO - 'ts_paint', 03:20:34 INFO - 'tpaint', 03:20:34 INFO - 'sessionrestore', 03:20:34 INFO - 'sessionrestore_no_auto_restore', 03:20:34 INFO - 'tabpaint']}, 03:20:34 INFO - 'other_l64': {'tests': ['a11yr', 03:20:34 INFO - 'ts_paint', 03:20:34 INFO - 'tpaint', 03:20:34 INFO - 'sessionrestore', 03:20:34 INFO - 'sessionrestore_no_auto_restore', 03:20:34 INFO - 'tabpaint']}, 03:20:34 INFO - 'other_nol64': {'tests': ['a11yr', 03:20:34 INFO - 'ts_paint', 03:20:34 INFO - 'tpaint', 03:20:34 INFO - 'sessionrestore', 03:20:34 INFO - 'sessionrestore_no_auto_restore', 03:20:34 INFO - 'tabpaint']}, 03:20:34 INFO - 'svgr': {'tests': ['tsvgx', 03:20:34 INFO - 'tsvgr_opacity', 03:20:34 INFO - 'tart', 03:20:34 INFO - 'tscrollx', 03:20:34 INFO - 'cart']}, 03:20:34 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:20:34 INFO - 'tests': ['tsvgx', 03:20:34 INFO - 'tsvgr_opacity', 03:20:34 INFO - 'tart', 03:20:34 INFO - 'tscrollx', 03:20:34 INFO - 'cart']}, 03:20:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:20:34 INFO - 'tests': ['tp5o']}, 03:20:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:20:34 INFO - 'talos_options': ['--e10s'], 03:20:34 INFO - 'tests': ['tp5o']}, 03:20:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:20:34 INFO - 'talos_options': ['--xperf_path', 03:20:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:20:34 INFO - 'tests': ['tp5n']}, 03:20:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:20:34 INFO - 'talos_options': ['--e10s', 03:20:34 INFO - '--xperf_path', 03:20:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:20:34 INFO - 'tests': ['tp5n']}}, 03:20:34 INFO - 'talos.zip': {'path': '', 03:20:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:20:34 INFO - Running post-action listener: _resource_record_post_action 03:20:34 INFO - ##### 03:20:34 INFO - ##### Running create-virtualenv step. 03:20:34 INFO - ##### 03:20:34 INFO - Running pre-action listener: _resource_record_pre_action 03:20:34 INFO - Running main action method: create_virtualenv 03:20:34 INFO - Creating virtualenv /builds/slave/test/build/venv 03:20:34 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:20:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:20:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:20:34 INFO - Using real prefix '/usr' 03:20:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:20:35 INFO - Installing distribute.............................................................................................................................................................................................done. 03:20:37 INFO - Installing pip.................done. 03:20:37 INFO - Return code: 0 03:20:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:20: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')]} 03:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20: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')]} 03:20:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:37 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 0x7f17da272f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11eb410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127a160>, '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 0x127b060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127b4f0>, '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': '41bf3e9aed84707956354da8000001c5-1461231333.215978-111066485', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:20:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:20:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:20:37 INFO - Using env: {'DISPLAY': ':0', 03:20:37 INFO - 'HOME': '/home/cltbld', 03:20:37 INFO - 'LANG': 'en_US.UTF-8', 03:20:37 INFO - 'LANGUAGE': 'en_US:en', 03:20:37 INFO - 'LOGNAME': 'cltbld', 03:20:37 INFO - 'MAIL': '/var/mail/cltbld', 03:20:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:37 INFO - 'MOZ_NO_REMOTE': '1', 03:20:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:37 INFO - 'NO_EM_RESTART': '1', 03:20:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:37 INFO - 'PWD': '/builds/slave/test', 03:20:37 INFO - 'SHELL': '/bin/bash', 03:20:37 INFO - 'SHLVL': '1', 03:20:37 INFO - 'TERM': 'linux', 03:20:37 INFO - 'TMOUT': '86400', 03:20:37 INFO - 'USER': 'cltbld', 03:20:37 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461231333.215978-111066485', 03:20:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:37 INFO - '_': '/tools/buildbot/bin/python'} 03:20:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:37 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:20:37 INFO - Cleaning up... 03:20:37 INFO - Return code: 0 03:20:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:20: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')]} 03:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20: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')]} 03:20:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:37 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 0x7f17da272f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11eb410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127a160>, '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 0x127b060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127b4f0>, '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': '41bf3e9aed84707956354da8000001c5-1461231333.215978-111066485', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:20:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:20:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:20:37 INFO - Using env: {'DISPLAY': ':0', 03:20:37 INFO - 'HOME': '/home/cltbld', 03:20:37 INFO - 'LANG': 'en_US.UTF-8', 03:20:37 INFO - 'LANGUAGE': 'en_US:en', 03:20:37 INFO - 'LOGNAME': 'cltbld', 03:20:37 INFO - 'MAIL': '/var/mail/cltbld', 03:20:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:37 INFO - 'MOZ_NO_REMOTE': '1', 03:20:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:37 INFO - 'NO_EM_RESTART': '1', 03:20:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:37 INFO - 'PWD': '/builds/slave/test', 03:20:37 INFO - 'SHELL': '/bin/bash', 03:20:37 INFO - 'SHLVL': '1', 03:20:37 INFO - 'TERM': 'linux', 03:20:37 INFO - 'TMOUT': '86400', 03:20:37 INFO - 'USER': 'cltbld', 03:20:37 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461231333.215978-111066485', 03:20:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:37 INFO - '_': '/tools/buildbot/bin/python'} 03:20:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:37 INFO - Downloading/unpacking psutil>=0.7.1 03:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:20:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:20:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:20:39 INFO - Installing collected packages: psutil 03:20:39 INFO - Running setup.py install for psutil 03:20:39 INFO - building 'psutil._psutil_linux' extension 03:20:39 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:20:39 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:20:39 INFO - building 'psutil._psutil_posix' extension 03:20:39 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:20:39 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:20:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:20:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:20:40 INFO - Successfully installed psutil 03:20:40 INFO - Cleaning up... 03:20:40 INFO - Return code: 0 03:20:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:20:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:20:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:40 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 0x7f17da272f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11eb410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127a160>, '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 0x127b060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127b4f0>, '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': '41bf3e9aed84707956354da8000001c5-1461231333.215978-111066485', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:20:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:20:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:20:40 INFO - Using env: {'DISPLAY': ':0', 03:20:40 INFO - 'HOME': '/home/cltbld', 03:20:40 INFO - 'LANG': 'en_US.UTF-8', 03:20:40 INFO - 'LANGUAGE': 'en_US:en', 03:20:40 INFO - 'LOGNAME': 'cltbld', 03:20:40 INFO - 'MAIL': '/var/mail/cltbld', 03:20:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:40 INFO - 'MOZ_NO_REMOTE': '1', 03:20:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:40 INFO - 'NO_EM_RESTART': '1', 03:20:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:40 INFO - 'PWD': '/builds/slave/test', 03:20:40 INFO - 'SHELL': '/bin/bash', 03:20:40 INFO - 'SHLVL': '1', 03:20:40 INFO - 'TERM': 'linux', 03:20:40 INFO - 'TMOUT': '86400', 03:20:40 INFO - 'USER': 'cltbld', 03:20:40 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461231333.215978-111066485', 03:20:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:40 INFO - '_': '/tools/buildbot/bin/python'} 03:20:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:20:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:20:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:20:42 INFO - Installing collected packages: mozsystemmonitor 03:20:42 INFO - Running setup.py install for mozsystemmonitor 03:20:42 INFO - Successfully installed mozsystemmonitor 03:20:42 INFO - Cleaning up... 03:20:42 INFO - Return code: 0 03:20:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:20: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')]} 03:20:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20: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')]} 03:20:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:42 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 0x7f17da272f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11eb410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127a160>, '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 0x127b060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127b4f0>, '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': '41bf3e9aed84707956354da8000001c5-1461231333.215978-111066485', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:20:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:20:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:20:42 INFO - Using env: {'DISPLAY': ':0', 03:20:42 INFO - 'HOME': '/home/cltbld', 03:20:42 INFO - 'LANG': 'en_US.UTF-8', 03:20:42 INFO - 'LANGUAGE': 'en_US:en', 03:20:42 INFO - 'LOGNAME': 'cltbld', 03:20:42 INFO - 'MAIL': '/var/mail/cltbld', 03:20:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:42 INFO - 'MOZ_NO_REMOTE': '1', 03:20:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:42 INFO - 'NO_EM_RESTART': '1', 03:20:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:42 INFO - 'PWD': '/builds/slave/test', 03:20:42 INFO - 'SHELL': '/bin/bash', 03:20:42 INFO - 'SHLVL': '1', 03:20:42 INFO - 'TERM': 'linux', 03:20:42 INFO - 'TMOUT': '86400', 03:20:42 INFO - 'USER': 'cltbld', 03:20:42 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461231333.215978-111066485', 03:20:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:42 INFO - '_': '/tools/buildbot/bin/python'} 03:20:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:42 INFO - Downloading/unpacking blobuploader==1.2.4 03:20:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:44 INFO - Downloading blobuploader-1.2.4.tar.gz 03:20:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:20:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:20:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:20:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:20:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:45 INFO - Downloading docopt-0.6.1.tar.gz 03:20:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:20:45 INFO - Installing collected packages: blobuploader, requests, docopt 03:20:45 INFO - Running setup.py install for blobuploader 03:20:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:20:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:20:45 INFO - Running setup.py install for requests 03:20:45 INFO - Running setup.py install for docopt 03:20:45 INFO - Successfully installed blobuploader requests docopt 03:20:45 INFO - Cleaning up... 03:20:45 INFO - Return code: 0 03:20:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:20:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:20:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:20:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:45 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 0x7f17da272f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11eb410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127a160>, '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 0x127b060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127b4f0>, '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': '41bf3e9aed84707956354da8000001c5-1461231333.215978-111066485', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:20:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:20:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:20:45 INFO - Using env: {'DISPLAY': ':0', 03:20:45 INFO - 'HOME': '/home/cltbld', 03:20:45 INFO - 'LANG': 'en_US.UTF-8', 03:20:45 INFO - 'LANGUAGE': 'en_US:en', 03:20:45 INFO - 'LOGNAME': 'cltbld', 03:20:45 INFO - 'MAIL': '/var/mail/cltbld', 03:20:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:45 INFO - 'MOZ_NO_REMOTE': '1', 03:20:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:45 INFO - 'NO_EM_RESTART': '1', 03:20:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:45 INFO - 'PWD': '/builds/slave/test', 03:20:45 INFO - 'SHELL': '/bin/bash', 03:20:45 INFO - 'SHLVL': '1', 03:20:45 INFO - 'TERM': 'linux', 03:20:45 INFO - 'TMOUT': '86400', 03:20:45 INFO - 'USER': 'cltbld', 03:20:45 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461231333.215978-111066485', 03:20:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:45 INFO - '_': '/tools/buildbot/bin/python'} 03:20:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:20:46 INFO - Running setup.py (path:/tmp/pip-ZxLwCw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:20:46 INFO - Running setup.py (path:/tmp/pip-Z3GnlA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:20:46 INFO - Running setup.py (path:/tmp/pip-eR6_lY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:20:46 INFO - Running setup.py (path:/tmp/pip-keX7kV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:20:46 INFO - Running setup.py (path:/tmp/pip-wQUHCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:20:46 INFO - Running setup.py (path:/tmp/pip-rzQEV4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:20:46 INFO - Running setup.py (path:/tmp/pip-8W8C6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:20:46 INFO - Running setup.py (path:/tmp/pip-GWzzIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:20:46 INFO - Running setup.py (path:/tmp/pip-OdO1QS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:20:46 INFO - Running setup.py (path:/tmp/pip-1n_YEr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:20:46 INFO - Running setup.py (path:/tmp/pip-S9jF8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:20:46 INFO - Running setup.py (path:/tmp/pip-NAbSqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:20:46 INFO - Running setup.py (path:/tmp/pip-1EehWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:20:47 INFO - Running setup.py (path:/tmp/pip-hoz7Di-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:20:47 INFO - Running setup.py (path:/tmp/pip-Z6sNp3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:20:47 INFO - Running setup.py (path:/tmp/pip-PUaCx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:20:47 INFO - Running setup.py (path:/tmp/pip-4kb_m5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:20:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:20:47 INFO - Running setup.py install for manifestparser 03:20:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:20:47 INFO - Running setup.py install for mozcrash 03:20:47 INFO - Running setup.py install for mozdebug 03:20:47 INFO - Running setup.py install for mozdevice 03:20:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:20:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:20:47 INFO - Running setup.py install for mozfile 03:20:47 INFO - Running setup.py install for mozhttpd 03:20:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:20:47 INFO - Running setup.py install for mozinfo 03:20:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:20:48 INFO - Running setup.py install for mozInstall 03:20:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:20:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:20:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:20:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:20:48 INFO - Running setup.py install for mozleak 03:20:48 INFO - Running setup.py install for mozlog 03:20:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:20:48 INFO - Running setup.py install for moznetwork 03:20:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:20:48 INFO - Running setup.py install for mozprocess 03:20:48 INFO - Running setup.py install for mozprofile 03:20:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:20:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:20:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:20:48 INFO - Running setup.py install for mozrunner 03:20:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:20:48 INFO - Running setup.py install for mozscreenshot 03:20:48 INFO - Running setup.py install for moztest 03:20:48 INFO - Running setup.py install for mozversion 03:20:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:20:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:20:49 INFO - Cleaning up... 03:20:49 INFO - Return code: 0 03:20:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:20:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:20:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:20:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:49 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 0x7f17da272f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11eb410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127a160>, '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 0x127b060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127b4f0>, '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': '41bf3e9aed84707956354da8000001c5-1461231333.215978-111066485', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:20:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:20:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:20:49 INFO - Using env: {'DISPLAY': ':0', 03:20:49 INFO - 'HOME': '/home/cltbld', 03:20:49 INFO - 'LANG': 'en_US.UTF-8', 03:20:49 INFO - 'LANGUAGE': 'en_US:en', 03:20:49 INFO - 'LOGNAME': 'cltbld', 03:20:49 INFO - 'MAIL': '/var/mail/cltbld', 03:20:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:49 INFO - 'MOZ_NO_REMOTE': '1', 03:20:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:49 INFO - 'NO_EM_RESTART': '1', 03:20:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:49 INFO - 'PWD': '/builds/slave/test', 03:20:49 INFO - 'SHELL': '/bin/bash', 03:20:49 INFO - 'SHLVL': '1', 03:20:49 INFO - 'TERM': 'linux', 03:20:49 INFO - 'TMOUT': '86400', 03:20:49 INFO - 'USER': 'cltbld', 03:20:49 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461231333.215978-111066485', 03:20:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:49 INFO - '_': '/tools/buildbot/bin/python'} 03:20:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:20:49 INFO - Running setup.py (path:/tmp/pip-qdZdU2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:20:49 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:20:49 INFO - Running setup.py (path:/tmp/pip-fjVgSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:20:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:20:49 INFO - Running setup.py (path:/tmp/pip-rfiQPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:20:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:20:49 INFO - Running setup.py (path:/tmp/pip-rXAUXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:20:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:20:49 INFO - Running setup.py (path:/tmp/pip-7QIb86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:20:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:20:49 INFO - Running setup.py (path:/tmp/pip-q6gabT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:20:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:20:49 INFO - Running setup.py (path:/tmp/pip-3Xu6tM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:20:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:20:49 INFO - Running setup.py (path:/tmp/pip-kjTfsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:20:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:20:49 INFO - Running setup.py (path:/tmp/pip-dA64uf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:20:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:20:49 INFO - Running setup.py (path:/tmp/pip-KhOTBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:20:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:20:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:20:50 INFO - Running setup.py (path:/tmp/pip-njytQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:20:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:20:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:20:50 INFO - Running setup.py (path:/tmp/pip-gAJtMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:20:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:20:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:20:50 INFO - Running setup.py (path:/tmp/pip-uOxnec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:20:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:20:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:20:50 INFO - Running setup.py (path:/tmp/pip-362Kmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:20:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:20:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:20:50 INFO - Running setup.py (path:/tmp/pip-CpTlT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:20:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:20:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:20:50 INFO - Running setup.py (path:/tmp/pip-DKt55e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:20:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:20:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:20:50 INFO - Running setup.py (path:/tmp/pip-vDnoYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:20:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:20:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:20:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:20:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:20:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:20:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:20:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:52 INFO - Downloading blessings-1.6.tar.gz 03:20:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:20:52 INFO - Installing collected packages: blessings 03:20:52 INFO - Running setup.py install for blessings 03:20:52 INFO - Successfully installed blessings 03:20:52 INFO - Cleaning up... 03:20:52 INFO - Return code: 0 03:20:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:20:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:20:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:20:52 INFO - Reading from file tmpfile_stdout 03:20:52 INFO - Current package versions: 03:20:52 INFO - argparse == 1.2.1 03:20:52 INFO - blessings == 1.6 03:20:52 INFO - blobuploader == 1.2.4 03:20:52 INFO - docopt == 0.6.1 03:20:52 INFO - manifestparser == 1.1 03:20:52 INFO - mozInstall == 1.12 03:20:52 INFO - mozcrash == 0.17 03:20:52 INFO - mozdebug == 0.1 03:20:52 INFO - mozdevice == 0.48 03:20:52 INFO - mozfile == 1.2 03:20:52 INFO - mozhttpd == 0.7 03:20:52 INFO - mozinfo == 0.9 03:20:52 INFO - mozleak == 0.1 03:20:52 INFO - mozlog == 3.1 03:20:52 INFO - moznetwork == 0.27 03:20:52 INFO - mozprocess == 0.22 03:20:52 INFO - mozprofile == 0.28 03:20:52 INFO - mozrunner == 6.11 03:20:52 INFO - mozscreenshot == 0.1 03:20:52 INFO - mozsystemmonitor == 0.0 03:20:52 INFO - moztest == 0.7 03:20:52 INFO - mozversion == 1.4 03:20:52 INFO - psutil == 3.1.1 03:20:52 INFO - requests == 1.2.3 03:20:52 INFO - wsgiref == 0.1.2 03:20:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:20:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:20:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:52 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 0x7f17da272f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11eb410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127a160>, '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 0x127b060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127b4f0>, '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': '41bf3e9aed84707956354da8000001c5-1461231333.215978-111066485', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:20:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:20:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:20:52 INFO - Using env: {'DISPLAY': ':0', 03:20:52 INFO - 'HOME': '/home/cltbld', 03:20:52 INFO - 'LANG': 'en_US.UTF-8', 03:20:52 INFO - 'LANGUAGE': 'en_US:en', 03:20:52 INFO - 'LOGNAME': 'cltbld', 03:20:52 INFO - 'MAIL': '/var/mail/cltbld', 03:20:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:52 INFO - 'MOZ_NO_REMOTE': '1', 03:20:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:52 INFO - 'NO_EM_RESTART': '1', 03:20:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:52 INFO - 'PWD': '/builds/slave/test', 03:20:52 INFO - 'SHELL': '/bin/bash', 03:20:52 INFO - 'SHLVL': '1', 03:20:52 INFO - 'TERM': 'linux', 03:20:52 INFO - 'TMOUT': '86400', 03:20:52 INFO - 'USER': 'cltbld', 03:20:52 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461231333.215978-111066485', 03:20:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:52 INFO - '_': '/tools/buildbot/bin/python'} 03:20:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:20:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:20:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:20:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:20:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:20:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:20:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:20:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:20:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:20:53 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:20:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:20:53 INFO - Cleaning up... 03:20:53 INFO - Return code: 0 03:20:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:20:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:20:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:53 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 0x7f17da272f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11eb410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127a160>, '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 0x127b060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127b4f0>, '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': '41bf3e9aed84707956354da8000001c5-1461231333.215978-111066485', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:20:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:20:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:20:53 INFO - Using env: {'DISPLAY': ':0', 03:20:53 INFO - 'HOME': '/home/cltbld', 03:20:53 INFO - 'LANG': 'en_US.UTF-8', 03:20:53 INFO - 'LANGUAGE': 'en_US:en', 03:20:53 INFO - 'LOGNAME': 'cltbld', 03:20:53 INFO - 'MAIL': '/var/mail/cltbld', 03:20:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:53 INFO - 'MOZ_NO_REMOTE': '1', 03:20:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:53 INFO - 'NO_EM_RESTART': '1', 03:20:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:53 INFO - 'PWD': '/builds/slave/test', 03:20:53 INFO - 'SHELL': '/bin/bash', 03:20:53 INFO - 'SHLVL': '1', 03:20:53 INFO - 'TERM': 'linux', 03:20:53 INFO - 'TMOUT': '86400', 03:20:53 INFO - 'USER': 'cltbld', 03:20:53 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461231333.215978-111066485', 03:20:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:53 INFO - '_': '/tools/buildbot/bin/python'} 03:20:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:53 INFO - Downloading/unpacking jsonschema 03:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:20:55 INFO - Downloading/unpacking functools32 (from jsonschema) 03:20: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 03:20: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 03:20: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 03:20: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 03:20: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 03:20: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 03:20:55 INFO - Downloading functools32-3.2.3-2.tar.gz 03:20:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:20:55 INFO - warning: no files found matching '*.txt' 03:20:55 INFO - no previously-included directories found matching 'build' 03:20:55 INFO - no previously-included directories found matching 'dist' 03:20:55 INFO - no previously-included directories found matching '.git*' 03:20:55 INFO - Installing collected packages: jsonschema, functools32 03:20:55 INFO - Running setup.py install for functools32 03:20:55 INFO - warning: no files found matching '*.txt' 03:20:55 INFO - no previously-included directories found matching 'build' 03:20:55 INFO - no previously-included directories found matching 'dist' 03:20:55 INFO - no previously-included directories found matching '.git*' 03:20:55 INFO - Successfully installed jsonschema functools32 03:20:55 INFO - Cleaning up... 03:20:55 INFO - Return code: 0 03:20:55 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:20:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:20:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:55 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 0x7f17da272f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11eb410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127a160>, '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 0x127b060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127b4f0>, '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': '41bf3e9aed84707956354da8000001c5-1461231333.215978-111066485', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:20:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:20:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:20:55 INFO - Using env: {'DISPLAY': ':0', 03:20:55 INFO - 'HOME': '/home/cltbld', 03:20:55 INFO - 'LANG': 'en_US.UTF-8', 03:20:55 INFO - 'LANGUAGE': 'en_US:en', 03:20:55 INFO - 'LOGNAME': 'cltbld', 03:20:55 INFO - 'MAIL': '/var/mail/cltbld', 03:20:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:55 INFO - 'MOZ_NO_REMOTE': '1', 03:20:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:55 INFO - 'NO_EM_RESTART': '1', 03:20:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:55 INFO - 'PWD': '/builds/slave/test', 03:20:55 INFO - 'SHELL': '/bin/bash', 03:20:55 INFO - 'SHLVL': '1', 03:20:55 INFO - 'TERM': 'linux', 03:20:55 INFO - 'TMOUT': '86400', 03:20:55 INFO - 'USER': 'cltbld', 03:20:55 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461231333.215978-111066485', 03:20:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:55 INFO - '_': '/tools/buildbot/bin/python'} 03:20:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:55 INFO - Downloading/unpacking flake8 03:20: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 03:20: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 03:20: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 03:20: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 03:20: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 03:20: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 03:20:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:20:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:20:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:20:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:20:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:20:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:20:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:20:58 INFO - no previously-included directories found matching 'docs/_build' 03:20:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:20:58 INFO - Running setup.py install for pep8 03:20:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:20:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:20:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:20:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:20:58 INFO - no previously-included directories found matching 'docs/_build' 03:20:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:20:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:20:58 INFO - Cleaning up... 03:20:58 INFO - Return code: 0 03:20:58 INFO - Running post-action listener: _resource_record_post_action 03:20:58 INFO - Running post-action listener: _start_resource_monitoring 03:20:58 INFO - Starting resource monitoring. 03:20:58 INFO - ##### 03:20:58 INFO - ##### Running install step. 03:20:58 INFO - ##### 03:20:58 INFO - Running pre-action listener: _resource_record_pre_action 03:20:58 INFO - Running main action method: install 03:20:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:20:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:20:58 INFO - Reading from file tmpfile_stdout 03:20:58 INFO - Detecting whether we're running mozinstall >=1.0... 03:20:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:20:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:20:58 INFO - Reading from file tmpfile_stdout 03:20:58 INFO - Output received: 03:20:58 INFO - Usage: mozinstall [options] installer 03:20:58 INFO - Options: 03:20:58 INFO - -h, --help show this help message and exit 03:20:58 INFO - -d DEST, --destination=DEST 03:20:58 INFO - Directory to install application into. [default: 03:20:58 INFO - "/builds/slave/test"] 03:20:58 INFO - --app=APP Application being installed. [default: firefox] 03:20:58 INFO - mkdir: /builds/slave/test/build/application 03:20:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:20:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:21:14 INFO - Reading from file tmpfile_stdout 03:21:14 INFO - Output received: 03:21:14 INFO - /builds/slave/test/build/application/firefox/firefox 03:21:14 INFO - Running post-action listener: _resource_record_post_action 03:21:14 INFO - ##### 03:21:14 INFO - ##### Running run-tests step. 03:21:14 INFO - ##### 03:21:14 INFO - Running pre-action listener: _resource_record_pre_action 03:21:14 INFO - Running main action method: run_tests 03:21:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:21:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:21:14 INFO - Python 2.7.3 03:21:14 INFO - Return code: 0 03:21:14 INFO - grabbing minidump binary from tooltool 03:21:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:14 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 0x127a160>, '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 0x127b060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127b4f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:21:14 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:21:14 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:21:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:21:14 INFO - Return code: 0 03:21:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:21:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:21:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:21:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:21:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:21:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:21:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:21:15 INFO - Return code: 0 03:21:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H88g_4wJTBOfzYgxq1_d6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:21:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/H88g_4wJTBOfzYgxq1_d6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:21:15 INFO - Using env: {'DISPLAY': ':0', 03:21:15 INFO - 'HOME': '/home/cltbld', 03:21:15 INFO - 'LANG': 'en_US.UTF-8', 03:21:15 INFO - 'LANGUAGE': 'en_US:en', 03:21:15 INFO - 'LOGNAME': 'cltbld', 03:21:15 INFO - 'MAIL': '/var/mail/cltbld', 03:21:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:21:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:21:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:15 INFO - 'MOZ_NO_REMOTE': '1', 03:21:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:21:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:15 INFO - 'NO_EM_RESTART': '1', 03:21:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:15 INFO - 'PWD': '/builds/slave/test', 03:21:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:21:15 INFO - 'SHELL': '/bin/bash', 03:21:15 INFO - 'SHLVL': '1', 03:21:15 INFO - 'TERM': 'linux', 03:21:15 INFO - 'TMOUT': '86400', 03:21:15 INFO - 'USER': 'cltbld', 03:21:15 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461231333.215978-111066485', 03:21:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:15 INFO - '_': '/tools/buildbot/bin/python'} 03:21:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H88g_4wJTBOfzYgxq1_d6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:21:15 INFO - mozversion application_buildid: 20160421004015 03:21:15 INFO - mozversion application_changeset: d9fdbad8f079c7801abdef70df2cad93efcce797 03:21:15 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:21:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:21:15 INFO - mozversion application_name: Firefox 03:21:15 INFO - mozversion application_remotingname: firefox-dev 03:21:15 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:21:15 INFO - mozversion application_vendor: Mozilla 03:21:15 INFO - mozversion application_version: 47.0a2 03:21:15 INFO - mozversion platform_buildid: 20160421004015 03:21:15 INFO - mozversion platform_changeset: d9fdbad8f079c7801abdef70df2cad93efcce797 03:21:15 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:21:15 INFO - mozversion platform_version: 47.0a2 03:21:15 INFO - using testdate: 1461234075 03:21:15 INFO - actual date: 1461234075 03:21:15 INFO - starting webserver on 'localhost:35771' 03:21:15 INFO - SUITE-START | Running 2 tests 03:21:15 INFO - TEST-START | dromaeo_css 03:21:15 INFO - operating with platform_type : linux_ 03:21:15 INFO - Initialising browser for dromaeo_css test... 03:21:15 INFO - TEST-INFO | started process 24411 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQfcvK2/profile http://localhost:35771/getInfo.html) 03:21:19 INFO - PROCESS | 24411 | __metrics Screen width/height:1600/1200 03:21:19 INFO - PROCESS | 24411 | colorDepth:24 03:21:19 INFO - PROCESS | 24411 | Browser inner width/height: 1024/697 03:21:19 INFO - PROCESS | 24411 | __metrics 03:21:20 INFO - PROCESS | 24411 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:21:21 INFO - TEST-INFO | 24411: exit 0 03:21:21 INFO - Browser initialized. 03:21:21 INFO - Running cycle 1/1 for dromaeo_css test... 03:21:21 INFO - TEST-INFO | started process 24499 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQfcvK2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:21:32 INFO - PROCESS | 24499 | RSS: Main: 141824000 03:21:32 INFO - PROCESS | 24499 | 03:22:24 INFO - PROCESS | 24499 | 1461234144239 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:24:31 INFO - PROCESS | 24499 | Cycle 1(1): loaded http://localhost:35771/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35771/tests/dromaeo/cssquery-ext.html) 03:24:32 INFO - PROCESS | 24499 | RSS: Main: 256634880 03:24:32 INFO - PROCESS | 24499 | 03:27:34 INFO - PROCESS | 24499 | Cycle 1(1): loaded http://localhost:35771/tests/dromaeo/cssquery-ext.html (next: http://localhost:35771/tests/dromaeo/cssquery-jquery.html) 03:27:35 INFO - PROCESS | 24499 | RSS: Main: 217485312 03:27:35 INFO - PROCESS | 24499 | 03:30:37 INFO - PROCESS | 24499 | Cycle 1(1): loaded http://localhost:35771/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35771/tests/dromaeo/cssquery-mootools.html) 03:30:37 INFO - PROCESS | 24499 | RSS: Main: 219262976 03:30:37 INFO - PROCESS | 24499 | 03:33:39 INFO - PROCESS | 24499 | Cycle 1(1): loaded http://localhost:35771/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35771/tests/dromaeo/cssquery-prototype.html) 03:33:40 INFO - PROCESS | 24499 | RSS: Main: 206663680 03:33:40 INFO - PROCESS | 24499 | 03:36:42 INFO - PROCESS | 24499 | Cycle 1(1): loaded http://localhost:35771/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35771/tests/dromaeo/cssquery-yui.html) 03:36:43 INFO - PROCESS | 24499 | RSS: Main: 205221888 03:36:43 INFO - PROCESS | 24499 | 03:39:45 INFO - PROCESS | 24499 | Cycle 1(1): loaded http://localhost:35771/tests/dromaeo/cssquery-yui.html (next: http://localhost:35771/tests/dromaeo/cssquery-dojo.html) 03:39:45 INFO - PROCESS | 24499 | RSS: Main: 252272640 03:39:45 INFO - PROCESS | 24499 | 03:39:45 INFO - PROCESS | 24499 | __start_tp_report 03:39:45 INFO - PROCESS | 24499 | _x_x_mozilla_page_load 03:39:45 INFO - PROCESS | 24499 | _x_x_mozilla_page_load_details 03:39:45 INFO - PROCESS | 24499 | |i|pagename|runs| 03:39:45 INFO - PROCESS | 24499 | |0;dojo.html;3297.9340413191735;3347.9163020924457;3368.7810292330996;3370.4438767603347;3407.403704351738;5435.021696094701;5440.3743569489525;5450.809221677242;5482.2873026506495;5483.780648774049;5436.75534600943;5440.047991601474;5465.344158700961;5467.562594992401;5468.9726551367285;4795.304680821297;4951.826686065989;4972.328735620699;5030.6981581105065;5064.417591976933;4884.5848102911295;4912.975435122838;4935;4967.329410529586;4978.427480839696;4899;4937.160682683934;4953.504649535035;4965.478624744404;4972.602191824663;4993.251012348141;4994.55049045584;5014.974925125388;5021.121303771862;5035.723035233061;4827;4848.127337079324;4936.777844996984;4938.851834444937;4961.9751901240625;5241.528262456397;5243.580513558906;5256.763445644955;5260.710660913648;5294.311739473844;5665.830025099253;5750.683712395817;5805.970970145165;5810.099434587646;5810.21562089121;5871.500922421556;5887.911681324784;5893.557983151238;5936.851578710523;5941.524678025791;5500.147477141049;5502.862428439241;5505.174223866372;5507.311586051704;5507.366652834935;5833.7374818133285;5965.433283838029;5983.611065280743;6038.154658347835;6044.697765111727;5783.971080144573;5787.479126878601;5791.594588378857;5796.449337312949;5803.419658034247;5858.355580886099;5886.646801191857;5887.35239123696;5888.087346461305;5888.676122813286;5639.774409023593;5788.82633520995;5823.912641310384;5872.677002764889;5901.144334071536;5840.620359676607;5845.269341332333;5857.560682948796;5865.530757539386;5867.765289388377;4392.582704643054;4429.047754732748;4434.623057040188;4445.26653102241;4458.353538736865;3862.1117143057254;3924.784136872442;3976.1451287973223;3994.560598334181;4017.116234428421;5537.861553461195;5556.944430555724;5565.1095824667855;5578.609497335147;5581.358143813432;5737.311522617312;5894.970525147347;5898.351181370046;5907.054871220584;5912.852178695481;5420.783168673288;5470.972645136749;5506.91739623906;5530.668159910338;5561.63849349791;5036.345275114285;5053.191489361684;5054.620903432184;5057.949420505822;5086.0845047891735;5938.8218353449465;5951.613145145551;6063.151158837766;6063.939360606426;6066.545009124245;5822.446867547492;5841.386654401226;5841.824745257649;5844.590878638454;5850.268716410449;5945.40545945402;5970.552208584287;5991.430814072656;6004.639721616717;6007.849803754766;5601.467860553241;5678.034734095297;5738.340090889435;5762.2221000164445;5766.452187042224;5857.824265272048;5865.882682346414;5881.676507792113;5886.352501224947;5887.941120588739;5728.828135155952;5729.197912292366;5730.627509211888;5740.138979152994;5745.224394706828;5559.138333558305;5673.659580425187;5726.255586773693;5773.3072031356505;5803.883922321615;5663.943360566342;5664.122061080374;5687.43125687428;5689;5700.942990570207;5776.451237132465;5798.275215598051;5808.825735227781;5815.302163740378;5816.098504731774;5427.077396842626;5435.402105768283;5533.446655334435;5600.69196194197;5662.03745363281 03:39:45 INFO - PROCESS | 24499 | |1;ext.html;531.7128750474744;572.2932178759235;607.3137354789087;615.4399496458224;628.8836565235431;38500.037499062506;39206.21587568247;39331.606683933154;39406.40890386643;39428.80285598572;42351.57648423515;42821.785891070576;42872.78563607178;42906;42918.14163716724;8738.126187381275;8952.418092823978;8953.05992870749;8962.462252264851;8965.282777377794;8844.73465796024;8976.775580610505;8985.23625491834;8986.460812351248;8990.55047247635;9165.725028249164;9233.307501937348;9258.814823703522;9268;9268.536573171348;9135.17783399494;9217.493037882914;9224.723258302229;9227;9227.123423274777;8983.730488085368;9070.909290907139;9079;9086.091390860927;9109.362344635878;43109.35335969963;43632.56367436317;43739.56260437387;43758.56241437577;43786;2687.7984151188543;3769.491118698968;3950.5654378018394;4255.63827074699;4502.032063106448;29081;29243.41513169746;29286.121416357542;29438.85280573605;29992.85003574968;3956.9802150989062;3981.0843505993785;3994.6005399460114;4031.314676505001;4224.556421575752;248983;251131;251228;251467;252174;57627.71186144126;62144;62704;65114;66255.33744662492;58716.412835871946;58762.41237587569;58943;59173.40826591765;59232.70383648141;18518.259269629063;18522.629547408975;18675.71986420205;18755.718664220047;18763.90618046901;14132.576022719335;14202.218877961604;14204.147751134966;14212.502562410473;14213.928930355281;20714.48213794667;20966.475838103863;21148.682769758467;21171;21285.148594056063;7062.364387205176;7193.460490463236;7264.309890560388;7264.854702906018;7714.922850771421;1011.3527342500805;1018.5721996761378;1060.6499855047816;1074.188987314588;1120.3669926491507;29879;30200.24499387489;30576;30655.2336191597;30887.69112308893;1108.6895669212633;1116.2855772305732;1138.2203190814153;1166.4401087478059;1195.121585634558;15601.297941592655;15786;15927.920360398355;16222.26999784989;16265.59336016609;323000;326909;327267;328570;328648;56659;56969.43030569724;57067.42932570621;57103.14345284824;57190;1286.6461723026243;1347.3936728472227;1437.5615437291517;1456.0899437851342;1462.5612316305278;27295;28957;28969.420611588073;29266;29923.850380747957;45732.31401529046;46055.078898422515;46069.30896036629;46090.308645369674;46093;213798;214655;214718;215459;276129;49302.50697492979;49662;50246;51088.74455627698;51095;45920;46041;46632;47417.28874066961;47730;37780.244395112495;38024.80987595044;38213.808930955165;38310.42534362042;38376.232475350895;40342.19315613613;40737.1852562953;41523.7923810379;41636;42662.78668606637;42763.78618106889;43151.784241078596;43576;43610.34584481299;44246;37997;38007.619923800405;38204.42693359546;38712.2257554853;39119.2176156481;28094.43811123725;28991;29221.707782921898;29345.119646410643;29411 03:39:45 INFO - PROCESS | 24499 | |2;jquery.html;354.09175464932446;361.9402798538241;361.95475565554295;369.4661214544982;370.16343064673833;17772.911135444338;18349.44951651451;19271;19547.511312217168;19663.410097697055;18130.728039079393;18288;18901;18996;19073.904630476827;5534.695591742453;5662.348829884554;5674;5683.914741278863;5722.313322401317;4255.87232383029;5605.439456054382;5895.675737834439;6144.938550614482;6187.690615469209;6127.417895299939;6130.386961303856;6141.600795948271;6146.231721034871;6163.445289923906;5959.672218028007;6012.9398706013035;6084.026555751058;6084.908726369108;6092.208012958309;3812;5167.4057483389515;5407.83776486706;5419.241306217133;5459.727013649302;21693.783062169336;22210.11159553616;22285.220017299478;22448.775512244832;22564.43588910274;2485.5898776701824;2712.199901029201;2844.431113777253;2933.897313594014;3136.8902088427026;13534.526291579847;13864.237466939314;13952.651183720387;14333.42666293347;14396.712065758626;1909.5417099896065;1952.3557226115347;1955.9902200489048;1971.2804826238464;1975.4172519106755;62613;63820.68089659522;64052.67973660149;64218.6789066061;64311;9104.954475227714;9912.107910288109;10222.744431389126;10240.590376384862;10409.167266618653;14382.712345753027;14495.420183192555;14656.853431465548;14670.486532971296;14693.55919322422;8210.712625058213;8317.95841020791;8318.542480163527;8371.539565323845;8567.700130495403;8387.580620968927;8448.32413406926;8486.957565212135;8496.915030849612;8497.575121244037;4585.839495617637;4633.9536604634195;4636.327732478839;4703.388559487314;4780.593649539758;1780.5500972833183;1835.3209312554172;1849.9291176646702;1937.3800383877306;1981.6631172700675;897.6499165325529;985.1429256546706;997.5710444508786;1039.3919557059055;1080.0927221134284;16917.661646766996;17837.732434013502;17975.370862019765;18213.037895302645;18226.908865455855;955.6273053509137;995.3778888194878;1017.1455976979225;1037.972407316766;1074.8878453838245;10115.735533058367;10348.5343159558;10381.273310868317;10401.167906567456;10521.84217236742;386786;391430;402065;418986;420551;75180.24819751842;75817.6209118951;76788.61605692048;78531;80096.19903800887;1020.3214862116757;1025.2259544044348;1039.0492699180315;1043.2540733375522;1043.3062013760916;16053.357865685242;16055.598610034842;16162.111083890499;16187.919060404623;16221.432249871197;34272.143196420286;35229.295414092085;35486;35525.644743552235;36247.818760906026;48782;48840.2673959898;49344.50655493399;49550.50449495459;49563.752181238866;7966.322862556747;8295.668173273243;8303.335733141455;8375.916240837758;8419.536925469158;13133.080684352004;13618.523351682643;13620.250886201355;13702.725945481234;13745.312734363442;11872.109591780823;11876.703082423008;11922.701932451759;11985.460654270404;12172.269663819845;11574.537018519164;11768.352740599006;11879.22785018971;11921.582744603897;11993.040556755264;11818.881811182122;11999.1600587958;12074.93962530217;12280.570180043656;12460.68848278764;8292.87560686578;8297.419180657296;8360.916390836013;8387.412881098264;8450.028246751703;8825.426347287406;11826.526938922347;11984.940075299568;12049.578264761041;12256.448459819152 03:39:45 INFO - PROCESS | 24499 | |3;mootools.html;1464.8608382203688;1607.4373969110811;1614.9677006459867;1868.4674867662718;1968.5472341361478;7795.961020194898;8108.837823243539;8115.715949941753;8122.675092996288;8125.34997200224;8103.554304513249;8124.065732440757;8151.673933042671;8198.91801081989;8213.54825484598;2016.596680663873;2313.652952057188;2380.928572142834;2411.4574220800355;2413.54142712884;2383.1420688552107;2394.317619478449;2394.8323617346705;2399.256230568529;2400.423898264413;2325.1745630301252;2339.7426283108844;2370.715514138306;2374.4301367671806;2374.750651181618;2312.4912519245822;2344.3553022918663;2354.446705024318;2380.5833979053596;2381;2324.2213858357472;2336.1356298169617;2345.319857241398;2357.823163262762;2358.1274928276475;8261.38039647029;8348.248657620783;8358.164183581594;8364.37267204956;8367.539785311805;4983.426905905795;5156.690598564098;5160.200168973777;5167.715775632339;5171.50870667286;3145.874165033396;3150.5116706910467;3203.1511649412923;3212.357528494287;3235.6117265928006;1003.618624922532;1017.2116609627524;1045.717656232813;1057.799018186542;1073.8711354637414;11497.425128743529;11519.36643484608;11534.942325288404;11536.538538458452;11549.76900461986;4320.308750599889;4371.628411584988;4431.246688063037;4513.413256276729;4515.2324104902245;9718.562664680107;9759.463229522302;9762.707118786306;9779.706608801747;9792.804143917081;5110.718910459886;5147.819826306061;5159.664621799571;5165.974170129125;5166.741662916915;4011.13760541485;4526.185286648435;4535.546445355438;4597.7011494252765;4625.560571745679;3784.905377365533;3829.291581057513;3852.8651497198025;3874.7093967952515;3875.476810630585;1221.5968730318973;1251.6432816647211;1251.8247445357658;1252.8684488128797;1265.367316341829;1249.6563445052684;1266.5060626355728;1290.3354772292278;1520.7946927164912;1523.223156190351;7805.219478052263;7954.84090318202;7970.681172753025;7976.760697179094;7983.800404989922;509.4726957598941;510.3340141115879;513.2609042978099;514.9588032957355;525.8475042237785;6073.574849760563;6088.238970128734;6124.724387402578;6164.907526387108;6178.104174894615;9821.558029888673;10039.4478303694;10138.138258248131;10142.695719128438;10147.9492602538;9557.092076252746;9794.853077203705;9830.950845245728;9932.950335248277;9947.05502977216;7820.413468989735;7826.491278066907;7827.45207835446;7919.445638805229;7924.48490848093;7507.099148102263;7557.886631700419;7557.962210188914;7579.658915348933;7588.051493563305;8663.913360866563;8709.390342676204;8809.955950220208;8896.421732587361;8912.019677835304;9029.593668284811;9077.500737459239;9214.216791572791;9243;9250.537473126182;6203.16257305258;6384.712687928962;6915.343042411164;7028.824279393056;7104.147502299757;7815.2184781523665;7819.882701759364;7864.84270314602;7878.330341921001;7879.84240315202;6891.310868913069;7030.789076327718;7064.858702826017;7143.749968751069;7162.104736907887;7190.712371505081;7201.243869393638;7203.71185152588;7275.381592564691;7286.307800758919;7258.455615828729;7455.254474552501;7461.589612571361;7476;7479.065116860393;6802.897956530557;6888.380045795702;6899.206591242071;6899.75850845218;6902.102726645504;6825.522213445011;6839.62382068991;6847.417969472651;6852.074969879002;6915.93084069173 03:39:45 INFO - PROCESS | 24499 | |4;prototype.html;326.088582412158;328.11245580704184;328.25486146447565;337.8496569026783;342.8731369393325;5972.0444728843395;5999.640021598701;6016.548758843082;6058.303295121063;6075.997460419031;5938.88122237556;5958.731857066432;5960.4039596040375;5969.343372229051;5971.820845374646;4419.88950276244;4523.660725445605;4566.246569316058;4620.953790462103;4652.6743127981135;4601.7238965662;4611.5619016193405;4611.746353950532;4618.376519169903;4622.838200662961;4566.429196350457;4574.61115805157;4579.748113853737;4591.334256532801;4593.862184134481;4395.208862404766;4478.171538265431;4552.248878934972;4559.293309537027;4586.610138138262;4036.555978842325;4041.1311568012725;4041.2321658884716;4051.0075031617444;4061.248668996245;5622.128570071604;5625.5218306444;5634.802781902655;5635.549156067505;5636.0982242841355;5309.681419114865;5318.149096144598;5321.707306098163;5322.3879253885525;5322.92015619766;6257.405546473124;6258.780942666985;6264.123022776815;6266.154069200691;6267.310595834455;4215.662746980234;4345;4382.583654552813;4462.352958820953;4467.932981005288;6491.675416229217;6512.185976752906;6540.34596540347;6553.246376666697;6555.344465553454;4403.53762854902;4406.140802543473;4409.831394680412;4412.029353542215;4419.558044195619;4461;4468.972136408579;4470.195364834361;4471.932921006188;4472.306792447176;5196.1166601677805;5203.297554830126;5203.635745497854;5210.088234559013;5213.713245771519;6092.817215483543;6310.716017779211;6315.242170939517;6315.305316415191;6366.554341196072;1566.7806507089017;1567.6551158745058;1575.2517554161682;1576.5506830553238;1579.5577238373273;989.44096585429;1026.2251999740297;1060.4326685223368;1082.3397727386289;1126.2791813239533;5974.761009559569;5985.281766188085;5987.072003839412;5992.58051936369;6003.159557661844;6327.841803954938;6376.29860715321;6376.936230637727;6386.584871983307;6434.0670602763275;6040.848978775566;6047.365026672224;6053.606515576474;6065.090236464477;6065.727042283108;3424.383610950003;3455.8444869980913;3459.498372735939;3462.584489861182;3468.9826550867083;6496.837579060467;6632.96683516589;6638.933610663831;6650.900236496456;6662.83342916431;6557.278699343068;6570.080188773575;6587.044878492592;6588.670566471753;6597.934020659828;6651.135352404156;6652.201735791736;6655.767048153195;6658.167729033871;6661.866762664719;6386.90419643715;6389.616623002635;6402;6406.0390941359165;6407.3592640737415;6239.906401404073;6331.430171284606;6338.809835704937;6345.111684364285;6467.676616169267;6735.326467353421;6762.763303284361;6767.289434609492;6771.221309549464;6777.864442711019;4476.4180656514445;4502.257127573914;4502.549745025472;4511.481179664381;4512.458504979423;6506.707198175999;6519.511036672174;6527.902081468686;6536.6731663415685;6539.836504087436;6340.65126418033;6345.111684364285;6349.523785716182;6350.460210882126;6363.5545511813725;6151.6924153793025;6344.27040890285;6365.204349456318;6369.172007638977;6389.2971773105855;6218.968905155445;6263.467605253422;6263.78076767311;6273.905891411724;6274.46667033289;6389.648569328546;6427.1002059710745;6428.742850285937;6435.678216089271;6442.130312407765;5995.670238136944;6060.151578779062;6222.097795819672;6235.75056997715;6246.718897649525 03:39:45 INFO - PROCESS | 24499 | |5;yui.html;736.7863319637305;737.4248086492538;796.788850954497;797.9521228726277;878.3675753457509;13502.932485337571;13708.931455342708;13709.177449353047;13721.970852186088;13734.862651373483;12490.313032783193;12831.743365132692;12990;13157.079004469668;13168.670783230424;776.6311002273903;925.0564424287223;940.4827344960279;940.8635747816562;961.0581630002566;937.4796987671839;938.0994245524305;939.9248060155205;940.1585580905086;946.8769060022188;983.2183414185704;983.4492684096929;983.7393090830935;984.2372161574801;986.1962500562055;812.995935020324;951.1059603972278;971.1647982734843;977.9657711980046;979.8089372572351;718.3140101203338;719.8488317453341;721.2102747491489;721.6860665610476;723.9239879812649;13181.209127452383;13200.6699832504;13220.669483262995;13221.206727596375;13241.139325943783;13644.658883527893;14042.36809343582;14070.92964535181;14311.141331520039;14369.419363869965;11168.944155279252;11192.496337664743;11222;11354.034907032912;11454;3946.980265098685;3996.0609256824623;3997.6601988830985;4004.159126583421;4010.3382941814566;50610.746946265404;50917.236241456405;53641.1953820693;54141.45858541404;54231.72884135554;11086.390248536247;11120.165987550967;11212;11229.943850280697;11613.76772464563;20336.186552537732;20409.591808163754;20422.59154816895;20477.488062798548;20510.79489205089;7702.768916932501;7787.155055067442;7842.333401660922;7955;8103.918960810316;4380.518143004267;4403.119376124788;4454.487733910577;4483.50681425043;4541.750203738826;3271.7382609391193;3294.275259442919;3295.950560741591;3297.884574039897;3298.901032969015;536.4099490560352;547.7343488408119;569.9316082070178;590.8670549126498;592.1946153231602;580.8693044065052;606.0333767640606;609.9024156134997;713.3508507258474;726.9563826170447;7910.327622152066;8276.751697449086;8401.495910245405;8610.182032706884;8696.347773916981;572.7594410347664;680.1905732178791;680.5585136681335;708.2174197511675;710.5701050864257;3826.426036094608;3889.183271513014;3911.471951286597;3969.146633473817;4082.1223436960604;57017.71491142518;57151.714241428526;57526.424735752946;57745.13382299269;58124;49427.258591121164;50780.23829642558;51698.96602068013;52363.47636523586;52409.73795131;44651.10697786026;45209.321860172124;45866.541334586895;45883.770581146884;46436;8861.689840855539;8914.300500602043;8918.063603321558;8988.910110899069;9053.230475409664;34832.78085267003;35462.29075418529;35469.290614187055;35669.82165089262;36789;40555;41423.58576414197;43459.34810977775;43876.56123438725;44240.77879610581;11749.060075194135;11895.977236951001;11899.107566932342;12113.091518136;12417.875821242033;13115.475380984653;13287.800682989957;13364;13466.663333416744;13557;11324.830127548259;12041.09691773103;12437;12568;12604.306763128116;12143.574974875837;12332.630021099381;12341.876581234432;12654.620361389174;12711.110222284351;11175.552977880794;11180.217384782987;11209.831852522055;11856.70358241051;12743.235405875677;10145.239107066853;10266.948665256627;10303.793924121326;10562.31344962575;10758.73103172427;8721.040685524715;9002.684906028258;9153.130452606993;9179.036201198778;9194.448333100036 03:39:45 INFO - PROCESS | 24499 | __end_tp_report 03:39:45 INFO - PROCESS | 24499 | __start_cc_report 03:39:45 INFO - PROCESS | 24499 | _x_x_mozilla_cycle_collect,908 03:39:45 INFO - PROCESS | 24499 | __end_cc_report 03:39:45 INFO - PROCESS | 24499 | __startTimestamp1461235185657__endTimestamp 03:39:45 INFO - PROCESS | 24499 | 03:39:45 INFO - PROCESS | 24499 | ------- Summary: start ------- 03:39:45 INFO - PROCESS | 24499 | Number of tests: 6 03:39:45 INFO - PROCESS | 24499 | 03:39:45 INFO - PROCESS | 24499 | [#0] dojo.html Cycles:165 Average:5425.43 Median:5662.04 stddev:600.96 (10.6%) stddev-sans-first:579.16 03:39:45 INFO - PROCESS | 24499 | Values: 3297.9 3347.9 3368.8 3370.4 3407.4 5435.0 5440.4 5450.8 5482.3 5483.8 5436.8 5440.0 5465.3 5467.6 5469.0 4795.3 4951.8 4972.3 5030.7 5064.4 4884.6 4913.0 4935.0 4967.3 4978.4 4899.0 4937.2 4953.5 4965.5 4972.6 4993.3 4994.6 5015.0 5021.1 5035.7 4827.0 4848.1 4936.8 4938.9 4962.0 5241.5 5243.6 5256.8 5260.7 5294.3 5665.8 5750.7 5806.0 5810.1 5810.2 5871.5 5887.9 5893.6 5936.9 5941.5 5500.1 5502.9 5505.2 5507.3 5507.4 5833.7 5965.4 5983.6 6038.2 6044.7 5784.0 5787.5 5791.6 5796.4 5803.4 5858.4 5886.6 5887.4 5888.1 5888.7 5639.8 5788.8 5823.9 5872.7 5901.1 5840.6 5845.3 5857.6 5865.5 5867.8 4392.6 4429.0 4434.6 4445.3 4458.4 3862.1 3924.8 3976.1 3994.6 4017.1 5537.9 5556.9 5565.1 5578.6 5581.4 5737.3 5895.0 5898.4 5907.1 5912.9 5420.8 5471.0 5506.9 5530.7 5561.6 5036.3 5053.2 5054.6 5057.9 5086.1 5938.8 5951.6 6063.2 6063.9 6066.5 5822.4 5841.4 5841.8 5844.6 5850.3 5945.4 5970.6 5991.4 6004.6 6007.8 5601.5 5678.0 5738.3 5762.2 5766.5 5857.8 5865.9 5881.7 5886.4 5887.9 5728.8 5729.2 5730.6 5740.1 5745.2 5559.1 5673.7 5726.3 5773.3 5803.9 5663.9 5664.1 5687.4 5689.0 5700.9 5776.5 5798.3 5808.8 5815.3 5816.1 5427.1 5435.4 5533.4 5600.7 5662.0 03:39:45 INFO - PROCESS | 24499 | 03:39:45 INFO - PROCESS | 24499 | [#1] ext.html Cycles:180 Average:46274.80 Median:4012.96 stddev:70789.59 (1764.0%) stddev-sans-first:70904.85 03:39:45 INFO - PROCESS | 24499 | Values: 531.7 572.3 607.3 615.4 628.9 38500.0 39206.2 39331.6 39406.4 39428.8 42351.6 42821.8 42872.8 42906.0 42918.1 8738.1 8952.4 8953.1 8962.5 8965.3 8844.7 8976.8 8985.2 8986.5 8990.6 9165.7 9233.3 9258.8 9268.0 9268.5 9135.2 9217.5 9224.7 9227.0 9227.1 8983.7 9070.9 9079.0 9086.1 9109.4 43109.4 43632.6 43739.6 43758.6 43786.0 2687.8 3769.5 3950.6 4255.6 4502.0 29081.0 29243.4 29286.1 29438.9 29992.9 3957.0 3981.1 3994.6 4031.3 4224.6 248983.0 251131.0 251228.0 251467.0 252174.0 57627.7 62144.0 62704.0 65114.0 66255.3 58716.4 58762.4 58943.0 59173.4 59232.7 18518.3 18522.6 18675.7 18755.7 18763.9 14132.6 14202.2 14204.1 14212.5 14213.9 20714.5 20966.5 21148.7 21171.0 21285.1 7062.4 7193.5 7264.3 7264.9 7714.9 1011.4 1018.6 1060.6 1074.2 1120.4 29879.0 30200.2 30576.0 30655.2 30887.7 1108.7 1116.3 1138.2 1166.4 1195.1 15601.3 15786.0 15927.9 16222.3 16265.6 323000.0 326909.0 327267.0 328570.0 328648.0 56659.0 56969.4 57067.4 57103.1 57190.0 1286.6 1347.4 1437.6 1456.1 1462.6 27295.0 28957.0 28969.4 29266.0 29923.9 45732.3 46055.1 46069.3 46090.3 46093.0 213798.0 214655.0 214718.0 215459.0 276129.0 49302.5 49662.0 50246.0 51088.7 51095.0 45920.0 46041.0 46632.0 47417.3 47730.0 37780.2 38024.8 38213.8 38310.4 38376.2 40342.2 40737.2 41523.8 41636.0 42662.8 42763.8 43151.8 43576.0 43610.3 44246.0 37997.0 38007.6 38204.4 38712.2 39119.2 28094.4 28991.0 29221.7 29345.1 29411.0 03:39:45 INFO - PROCESS | 24499 | 03:39:45 INFO - PROCESS | 24499 | [#2] jquery.html Cycles:180 Average:25275.78 Median:3035.39 stddev:66375.76 (2186.7%) stddev-sans-first:66535.59 03:39:45 INFO - PROCESS | 24499 | Values: 354.1 361.9 362.0 369.5 370.2 17772.9 18349.4 19271.0 19547.5 19663.4 18130.7 18288.0 18901.0 18996.0 19073.9 5534.7 5662.3 5674.0 5683.9 5722.3 4255.9 5605.4 5895.7 6144.9 6187.7 6127.4 6130.4 6141.6 6146.2 6163.4 5959.7 6012.9 6084.0 6084.9 6092.2 3812.0 5167.4 5407.8 5419.2 5459.7 21693.8 22210.1 22285.2 22448.8 22564.4 2485.6 2712.2 2844.4 2933.9 3136.9 13534.5 13864.2 13952.7 14333.4 14396.7 1909.5 1952.4 1956.0 1971.3 1975.4 62613.0 63820.7 64052.7 64218.7 64311.0 9105.0 9912.1 10222.7 10240.6 10409.2 14382.7 14495.4 14656.9 14670.5 14693.6 8210.7 8318.0 8318.5 8371.5 8567.7 8387.6 8448.3 8487.0 8496.9 8497.6 4585.8 4634.0 4636.3 4703.4 4780.6 1780.6 1835.3 1849.9 1937.4 1981.7 897.6 985.1 997.6 1039.4 1080.1 16917.7 17837.7 17975.4 18213.0 18226.9 955.6 995.4 1017.1 1038.0 1074.9 10115.7 10348.5 10381.3 10401.2 10521.8 386786.0 391430.0 402065.0 418986.0 420551.0 75180.2 75817.6 76788.6 78531.0 80096.2 1020.3 1025.2 1039.0 1043.3 1043.3 16053.4 16055.6 16162.1 16187.9 16221.4 34272.1 35229.3 35486.0 35525.6 36247.8 48782.0 48840.3 49344.5 49550.5 49563.8 7966.3 8295.7 8303.3 8375.9 8419.5 13133.1 13618.5 13620.3 13702.7 13745.3 11872.1 11876.7 11922.7 11985.5 12172.3 11574.5 11768.4 11879.2 11921.6 11993.0 11818.9 11999.2 12074.9 12280.6 12460.7 8292.9 8297.4 8360.9 8387.4 8450.0 8825.4 11826.5 11984.9 12049.6 12256.4 03:39:45 INFO - PROCESS | 24499 | 03:39:45 INFO - PROCESS | 24499 | [#3] mootools.html Cycles:180 Average:5750.72 Median:6106.48 stddev:3028.87 (49.6%) stddev-sans-first:3020.24 03:39:45 INFO - PROCESS | 24499 | Values: 1464.9 1607.4 1615.0 1868.5 1968.5 7796.0 8108.8 8115.7 8122.7 8125.3 8103.6 8124.1 8151.7 8198.9 8213.5 2016.6 2313.7 2380.9 2411.5 2413.5 2383.1 2394.3 2394.8 2399.3 2400.4 2325.2 2339.7 2370.7 2374.4 2374.8 2312.5 2344.4 2354.4 2380.6 2381.0 2324.2 2336.1 2345.3 2357.8 2358.1 8261.4 8348.2 8358.2 8364.4 8367.5 4983.4 5156.7 5160.2 5167.7 5171.5 3145.9 3150.5 3203.2 3212.4 3235.6 1003.6 1017.2 1045.7 1057.8 1073.9 11497.4 11519.4 11534.9 11536.5 11549.8 4320.3 4371.6 4431.2 4513.4 4515.2 9718.6 9759.5 9762.7 9779.7 9792.8 5110.7 5147.8 5159.7 5166.0 5166.7 4011.1 4526.2 4535.5 4597.7 4625.6 3784.9 3829.3 3852.9 3874.7 3875.5 1221.6 1251.6 1251.8 1252.9 1265.4 1249.7 1266.5 1290.3 1520.8 1523.2 7805.2 7954.8 7970.7 7976.8 7983.8 509.5 510.3 513.3 515.0 525.8 6073.6 6088.2 6124.7 6164.9 6178.1 9821.6 10039.4 10138.1 10142.7 10147.9 9557.1 9794.9 9831.0 9933.0 9947.1 7820.4 7826.5 7827.5 7919.4 7924.5 7507.1 7557.9 7558.0 7579.7 7588.1 8663.9 8709.4 8810.0 8896.4 8912.0 9029.6 9077.5 9214.2 9243.0 9250.5 6203.2 6384.7 6915.3 7028.8 7104.1 7815.2 7819.9 7864.8 7878.3 7879.8 6891.3 7030.8 7064.9 7143.7 7162.1 7190.7 7201.2 7203.7 7275.4 7286.3 7258.5 7455.3 7461.6 7476.0 7479.1 6802.9 6888.4 6899.2 6899.8 6902.1 6825.5 6839.6 6847.4 6852.1 6915.9 03:39:45 INFO - PROCESS | 24499 | 03:39:45 INFO - PROCESS | 24499 | [#4] prototype.html Cycles:180 Average:5264.27 Median:6001.40 stddev:1582.06 (26.4%) stddev-sans-first:1542.47 03:39:45 INFO - PROCESS | 24499 | Values: 326.1 328.1 328.3 337.8 342.9 5972.0 5999.6 6016.5 6058.3 6076.0 5938.9 5958.7 5960.4 5969.3 5971.8 4419.9 4523.7 4566.2 4621.0 4652.7 4601.7 4611.6 4611.7 4618.4 4622.8 4566.4 4574.6 4579.7 4591.3 4593.9 4395.2 4478.2 4552.2 4559.3 4586.6 4036.6 4041.1 4041.2 4051.0 4061.2 5622.1 5625.5 5634.8 5635.5 5636.1 5309.7 5318.1 5321.7 5322.4 5322.9 6257.4 6258.8 6264.1 6266.2 6267.3 4215.7 4345.0 4382.6 4462.4 4467.9 6491.7 6512.2 6540.3 6553.2 6555.3 4403.5 4406.1 4409.8 4412.0 4419.6 4461.0 4469.0 4470.2 4471.9 4472.3 5196.1 5203.3 5203.6 5210.1 5213.7 6092.8 6310.7 6315.2 6315.3 6366.6 1566.8 1567.7 1575.3 1576.6 1579.6 989.4 1026.2 1060.4 1082.3 1126.3 5974.8 5985.3 5987.1 5992.6 6003.2 6327.8 6376.3 6376.9 6386.6 6434.1 6040.8 6047.4 6053.6 6065.1 6065.7 3424.4 3455.8 3459.5 3462.6 3469.0 6496.8 6633.0 6638.9 6650.9 6662.8 6557.3 6570.1 6587.0 6588.7 6597.9 6651.1 6652.2 6655.8 6658.2 6661.9 6386.9 6389.6 6402.0 6406.0 6407.4 6239.9 6331.4 6338.8 6345.1 6467.7 6735.3 6762.8 6767.3 6771.2 6777.9 4476.4 4502.3 4502.5 4511.5 4512.5 6506.7 6519.5 6527.9 6536.7 6539.8 6340.7 6345.1 6349.5 6350.5 6363.6 6151.7 6344.3 6365.2 6369.2 6389.3 6219.0 6263.5 6263.8 6273.9 6274.5 6389.6 6427.1 6428.7 6435.7 6442.1 5995.7 6060.2 6222.1 6235.8 6246.7 03:39:45 INFO - PROCESS | 24499 | 03:39:45 INFO - PROCESS | 24499 | [#5] yui.html Cycles:180 Average:14209.10 Median:24321.95 stddev:16088.49 (66.1%) stddev-sans-first:16101.81 03:39:45 INFO - PROCESS | 24499 | Values: 736.8 737.4 796.8 798.0 878.4 13502.9 13708.9 13709.2 13722.0 13734.9 12490.3 12831.7 12990.0 13157.1 13168.7 776.6 925.1 940.5 940.9 961.1 937.5 938.1 939.9 940.2 946.9 983.2 983.4 983.7 984.2 986.2 813.0 951.1 971.2 978.0 979.8 718.3 719.8 721.2 721.7 723.9 13181.2 13200.7 13220.7 13221.2 13241.1 13644.7 14042.4 14070.9 14311.1 14369.4 11168.9 11192.5 11222.0 11354.0 11454.0 3947.0 3996.1 3997.7 4004.2 4010.3 50610.7 50917.2 53641.2 54141.5 54231.7 11086.4 11120.2 11212.0 11229.9 11613.8 20336.2 20409.6 20422.6 20477.5 20510.8 7702.8 7787.2 7842.3 7955.0 8103.9 4380.5 4403.1 4454.5 4483.5 4541.8 3271.7 3294.3 3296.0 3297.9 3298.9 536.4 547.7 569.9 590.9 592.2 580.9 606.0 609.9 713.4 727.0 7910.3 8276.8 8401.5 8610.2 8696.3 572.8 680.2 680.6 708.2 710.6 3826.4 3889.2 3911.5 3969.1 4082.1 57017.7 57151.7 57526.4 57745.1 58124.0 49427.3 50780.2 51699.0 52363.5 52409.7 44651.1 45209.3 45866.5 45883.8 46436.0 8861.7 8914.3 8918.1 8988.9 9053.2 34832.8 35462.3 35469.3 35669.8 36789.0 40555.0 41423.6 43459.3 43876.6 44240.8 11749.1 11896.0 11899.1 12113.1 12417.9 13115.5 13287.8 13364.0 13466.7 13557.0 11324.8 12041.1 12437.0 12568.0 12604.3 12143.6 12332.6 12341.9 12654.6 12711.1 11175.6 11180.2 11209.8 11856.7 12743.2 10145.2 10266.9 10303.8 10562.3 10758.7 8721.0 9002.7 9153.1 9179.0 9194.4 03:39:45 INFO - PROCESS | 24499 | -------- Summary: end -------- 03:39:45 INFO - PROCESS | 24499 | 03:39:46 INFO - TEST-INFO | 24499: exit 0 03:39:46 INFO - TEST-OK | dromaeo_css | took 1110806ms 03:39:46 INFO - TEST-START | kraken 03:39:46 INFO - operating with platform_type : linux_ 03:39:46 INFO - Initialising browser for kraken test... 03:39:46 INFO - TEST-INFO | started process 24693 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptrH5SP/profile http://localhost:35771/getInfo.html) 03:39:49 INFO - PROCESS | 24693 | __metrics Screen width/height:1600/1200 03:39:49 INFO - PROCESS | 24693 | colorDepth:24 03:39:49 INFO - PROCESS | 24693 | Browser inner width/height: 1024/697 03:39:49 INFO - PROCESS | 24693 | __metrics 03:39:51 INFO - PROCESS | 24693 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:39:51 INFO - TEST-INFO | 24693: exit 0 03:39:51 INFO - Browser initialized. 03:39:51 INFO - Running cycle 1/1 for kraken test... 03:39:51 INFO - TEST-INFO | started process 24780 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptrH5SP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:40:03 INFO - PROCESS | 24780 | RSS: Main: 142176256 03:40:03 INFO - PROCESS | 24780 | 03:40:06 INFO - PROCESS | 24780 | Cycle 1(1): loaded http://localhost:35771/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35771/tests/kraken/driver.html?testName=audio-beat-detection) 03:40:06 INFO - PROCESS | 24780 | RSS: Main: 176951296 03:40:06 INFO - PROCESS | 24780 | 03:40:09 INFO - PROCESS | 24780 | Cycle 1(1): loaded http://localhost:35771/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35771/tests/kraken/driver.html?testName=audio-dft) 03:40:10 INFO - PROCESS | 24780 | RSS: Main: 175898624 03:40:10 INFO - PROCESS | 24780 | 03:40:12 INFO - PROCESS | 24780 | Cycle 1(1): loaded http://localhost:35771/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35771/tests/kraken/driver.html?testName=audio-fft) 03:40:13 INFO - PROCESS | 24780 | RSS: Main: 174186496 03:40:13 INFO - PROCESS | 24780 | 03:40:15 INFO - PROCESS | 24780 | Cycle 1(1): loaded http://localhost:35771/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35771/tests/kraken/driver.html?testName=audio-oscillator) 03:40:16 INFO - PROCESS | 24780 | RSS: Main: 174391296 03:40:16 INFO - PROCESS | 24780 | 03:40:18 INFO - PROCESS | 24780 | Cycle 1(1): loaded http://localhost:35771/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35771/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:40:18 INFO - PROCESS | 24780 | RSS: Main: 172064768 03:40:18 INFO - PROCESS | 24780 | 03:40:21 INFO - PROCESS | 24780 | Cycle 1(1): loaded http://localhost:35771/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35771/tests/kraken/driver.html?testName=imaging-darkroom) 03:40:22 INFO - PROCESS | 24780 | RSS: Main: 172085248 03:40:22 INFO - PROCESS | 24780 | 03:40:25 INFO - PROCESS | 24780 | Cycle 1(1): loaded http://localhost:35771/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35771/tests/kraken/driver.html?testName=imaging-desaturate) 03:40:26 INFO - PROCESS | 24780 | RSS: Main: 172994560 03:40:26 INFO - PROCESS | 24780 | 03:40:29 INFO - PROCESS | 24780 | Cycle 1(1): loaded http://localhost:35771/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35771/tests/kraken/driver.html?testName=json-parse-financial) 03:40:29 INFO - PROCESS | 24780 | RSS: Main: 173985792 03:40:29 INFO - PROCESS | 24780 | 03:40:31 INFO - PROCESS | 24780 | Cycle 1(1): loaded http://localhost:35771/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35771/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:40:31 INFO - PROCESS | 24780 | RSS: Main: 178036736 03:40:31 INFO - PROCESS | 24780 | 03:40:33 INFO - PROCESS | 24780 | Cycle 1(1): loaded http://localhost:35771/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35771/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:40:34 INFO - PROCESS | 24780 | RSS: Main: 175177728 03:40:34 INFO - PROCESS | 24780 | 03:40:36 INFO - PROCESS | 24780 | Cycle 1(1): loaded http://localhost:35771/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35771/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:40:36 INFO - PROCESS | 24780 | RSS: Main: 181567488 03:40:36 INFO - PROCESS | 24780 | 03:40:39 INFO - PROCESS | 24780 | Cycle 1(1): loaded http://localhost:35771/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35771/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:40:39 INFO - PROCESS | 24780 | RSS: Main: 187351040 03:40:39 INFO - PROCESS | 24780 | 03:40:42 INFO - PROCESS | 24780 | Cycle 1(1): loaded http://localhost:35771/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35771/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:40:42 INFO - PROCESS | 24780 | RSS: Main: 187568128 03:40:42 INFO - PROCESS | 24780 | 03:40:44 INFO - PROCESS | 24780 | Cycle 1(1): loaded http://localhost:35771/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35771/tests/kraken/driver.html?testName=ai-astar) 03:40:44 INFO - PROCESS | 24780 | RSS: Main: 249438208 03:40:44 INFO - PROCESS | 24780 | 03:40:44 INFO - PROCESS | 24780 | __start_tp_report 03:40:44 INFO - PROCESS | 24780 | _x_x_mozilla_page_load 03:40:44 INFO - PROCESS | 24780 | _x_x_mozilla_page_load_details 03:40:44 INFO - PROCESS | 24780 | |i|pagename|runs| 03:40:44 INFO - PROCESS | 24780 | |0;ai-astar;110;113;107;111;112;112;102;110;112;110 03:40:44 INFO - PROCESS | 24780 | |1;audio-beat-detection;151;130;151;170;130;156;168;131;182;128 03:40:44 INFO - PROCESS | 24780 | |2;audio-dft;163;162;162;160;161;160;162;163;160;160 03:40:44 INFO - PROCESS | 24780 | |3;audio-fft;76;76;77;163;76;76;75;76;179;75 03:40:44 INFO - PROCESS | 24780 | |4;audio-oscillator;93;93;146;93;94;92;140;93;93;139 03:40:44 INFO - PROCESS | 24780 | |5;imaging-gaussian-blur;117;117;116;116;117;116;117;116;116;117 03:40:44 INFO - PROCESS | 24780 | |6;imaging-darkroom;146;145;145;146;146;145;146;145;146;145 03:40:44 INFO - PROCESS | 24780 | |7;imaging-desaturate;96;96;96;96;96;96;96;96;97;96 03:40:44 INFO - PROCESS | 24780 | |8;json-parse-financial;53;54;54;58;56;55;56;54;54;52 03:40:44 INFO - PROCESS | 24780 | |9;json-stringify-tinderbox;66;65;66;68;65;65;65;65;64;65 03:40:44 INFO - PROCESS | 24780 | |10;stanford-crypto-aes;77;78;80;78;79;80;79;81;79;80 03:40:44 INFO - PROCESS | 24780 | |11;stanford-crypto-ccm;112;112;112;114;116;113;111;122;111;118 03:40:44 INFO - PROCESS | 24780 | |12;stanford-crypto-pbkdf2;149;138;147;141;145;136;144;136;143;145 03:40:44 INFO - PROCESS | 24780 | |13;stanford-crypto-sha256-iterative;69;72;71;68;65;68;70;70;66;66 03:40:44 INFO - PROCESS | 24780 | __end_tp_report 03:40:44 INFO - PROCESS | 24780 | __start_cc_report 03:40:44 INFO - PROCESS | 24780 | _x_x_mozilla_cycle_collect,1079 03:40:44 INFO - PROCESS | 24780 | __end_cc_report 03:40:44 INFO - PROCESS | 24780 | __startTimestamp1461235244682__endTimestamp 03:40:44 INFO - PROCESS | 24780 | 03:40:44 INFO - PROCESS | 24780 | ------- Summary: start ------- 03:40:44 INFO - PROCESS | 24780 | Number of tests: 14 03:40:44 INFO - PROCESS | 24780 | 03:40:44 INFO - PROCESS | 24780 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.50 stddev:3.25 (2.9%) stddev-sans-first:3.44 03:40:44 INFO - PROCESS | 24780 | Values: 110.0 113.0 107.0 111.0 112.0 112.0 102.0 110.0 112.0 110.0 03:40:44 INFO - PROCESS | 24780 | 03:40:44 INFO - PROCESS | 24780 | [#1] audio-beat-detection Cycles:10 Average:149.70 Median:153.50 stddev:19.52 (12.7%) stddev-sans-first:20.70 03:40:44 INFO - PROCESS | 24780 | Values: 151.0 130.0 151.0 170.0 130.0 156.0 168.0 131.0 182.0 128.0 03:40:44 INFO - PROCESS | 24780 | 03:40:44 INFO - PROCESS | 24780 | [#2] audio-dft Cycles:10 Average:161.30 Median:162.00 stddev:1.25 (0.8%) stddev-sans-first:1.17 03:40:44 INFO - PROCESS | 24780 | Values: 163.0 162.0 162.0 160.0 161.0 160.0 162.0 163.0 160.0 160.0 03:40:44 INFO - PROCESS | 24780 | 03:40:44 INFO - PROCESS | 24780 | [#3] audio-fft Cycles:10 Average:94.90 Median:76.00 stddev:40.29 (53.0%) stddev-sans-first:42.15 03:40:44 INFO - PROCESS | 24780 | Values: 76.0 76.0 77.0 163.0 76.0 76.0 75.0 76.0 179.0 75.0 03:40:44 INFO - PROCESS | 24780 | 03:40:44 INFO - PROCESS | 24780 | [#4] audio-oscillator Cycles:10 Average:107.60 Median:93.00 stddev:23.58 (25.4%) stddev-sans-first:24.41 03:40:44 INFO - PROCESS | 24780 | Values: 93.0 93.0 146.0 93.0 94.0 92.0 140.0 93.0 93.0 139.0 03:40:44 INFO - PROCESS | 24780 | 03:40:44 INFO - PROCESS | 24780 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 03:40:44 INFO - PROCESS | 24780 | Values: 117.0 117.0 116.0 116.0 117.0 116.0 117.0 116.0 116.0 117.0 03:40:44 INFO - PROCESS | 24780 | 03:40:44 INFO - PROCESS | 24780 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 03:40:44 INFO - PROCESS | 24780 | Values: 146.0 145.0 145.0 146.0 146.0 145.0 146.0 145.0 146.0 145.0 03:40:44 INFO - PROCESS | 24780 | 03:40:44 INFO - PROCESS | 24780 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 03:40:44 INFO - PROCESS | 24780 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 97.0 96.0 03:40:44 INFO - PROCESS | 24780 | 03:40:44 INFO - PROCESS | 24780 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:54.50 stddev:1.71 (3.1%) stddev-sans-first:1.72 03:40:44 INFO - PROCESS | 24780 | Values: 53.0 54.0 54.0 58.0 56.0 55.0 56.0 54.0 54.0 52.0 03:40:44 INFO - PROCESS | 24780 | 03:40:44 INFO - PROCESS | 24780 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.00 stddev:1.07 (1.7%) stddev-sans-first:1.12 03:40:44 INFO - PROCESS | 24780 | Values: 66.0 65.0 66.0 68.0 65.0 65.0 65.0 65.0 64.0 65.0 03:40:44 INFO - PROCESS | 24780 | 03:40:44 INFO - PROCESS | 24780 | [#10] stanford-crypto-aes Cycles:10 Average:79.10 Median:79.50 stddev:1.20 (1.5%) stddev-sans-first:1.00 03:40:44 INFO - PROCESS | 24780 | Values: 77.0 78.0 80.0 78.0 79.0 80.0 79.0 81.0 79.0 80.0 03:40:44 INFO - PROCESS | 24780 | 03:40:44 INFO - PROCESS | 24780 | [#11] stanford-crypto-ccm Cycles:10 Average:114.10 Median:113.50 stddev:3.57 (3.1%) stddev-sans-first:3.71 03:40:44 INFO - PROCESS | 24780 | Values: 112.0 112.0 112.0 114.0 116.0 113.0 111.0 122.0 111.0 118.0 03:40:44 INFO - PROCESS | 24780 | 03:40:44 INFO - PROCESS | 24780 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.40 Median:144.50 stddev:4.53 (3.1%) stddev-sans-first:4.12 03:40:44 INFO - PROCESS | 24780 | Values: 149.0 138.0 147.0 141.0 145.0 136.0 144.0 136.0 143.0 145.0 03:40:44 INFO - PROCESS | 24780 | 03:40:44 INFO - PROCESS | 24780 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.50 stddev:2.32 (3.3%) stddev-sans-first:2.46 03:40:44 INFO - PROCESS | 24780 | Values: 69.0 72.0 71.0 68.0 65.0 68.0 70.0 70.0 66.0 66.0 03:40:44 INFO - PROCESS | 24780 | -------- Summary: end -------- 03:40:44 INFO - PROCESS | 24780 | 03:40:45 INFO - TEST-INFO | 24780: exit 0 03:40:45 INFO - TEST-OK | kraken | took 59325ms 03:40:45 INFO - SUITE-END | took 1170s 03:40:45 INFO - Completed test suite (00:19:30) 03:40:45 INFO - javascript benchmark 03:40:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3297.9340413191735, 3347.9163020924457, 3368.7810292330996, 3370.4438767603347, 3407.403704351738, 5435.021696094701, 5440.3743569489525, 5450.809221677242, 5482.2873026506495, 5483.780648774049, 5436.75534600943, 5440.047991601474, 5465.344158700961, 5467.562594992401, 5468.9726551367285, 4795.304680821297, 4951.826686065989, 4972.328735620699, 5030.6981581105065, 5064.417591976933, 4884.5848102911295, 4912.975435122838, 4935.0, 4967.329410529586, 4978.427480839696, 4899.0, 4937.160682683934, 4953.504649535035, 4965.478624744404, 4972.602191824663, 4993.251012348141, 4994.55049045584, 5014.974925125388, 5021.121303771862, 5035.723035233061, 4827.0, 4848.127337079324, 4936.777844996984, 4938.851834444937, 4961.9751901240625, 5241.528262456397, 5243.580513558906, 5256.763445644955, 5260.710660913648, 5294.311739473844, 5665.830025099253, 5750.683712395817, 5805.970970145165, 5810.099434587646, 5810.21562089121, 5871.500922421556, 5887.911681324784, 5893.557983151238, 5936.851578710523, 5941.524678025791, 5500.147477141049, 5502.862428439241, 5505.174223866372, 5507.311586051704, 5507.366652834935, 5833.7374818133285, 5965.433283838029, 5983.611065280743, 6038.154658347835, 6044.697765111727, 5783.971080144573, 5787.479126878601, 5791.594588378857, 5796.449337312949, 5803.419658034247, 5858.355580886099, 5886.646801191857, 5887.35239123696, 5888.087346461305, 5888.676122813286, 5639.774409023593, 5788.82633520995, 5823.912641310384, 5872.677002764889, 5901.144334071536, 5840.620359676607, 5845.269341332333, 5857.560682948796, 5865.530757539386, 5867.765289388377, 4392.582704643054, 4429.047754732748, 4434.623057040188, 4445.26653102241, 4458.353538736865, 3862.1117143057254, 3924.784136872442, 3976.1451287973223, 3994.560598334181, 4017.116234428421, 5537.861553461195, 5556.944430555724, 5565.1095824667855, 5578.609497335147, 5581.358143813432, 5737.311522617312, 5894.970525147347, 5898.351181370046, 5907.054871220584, 5912.852178695481, 5420.783168673288, 5470.972645136749, 5506.91739623906, 5530.668159910338, 5561.63849349791, 5036.345275114285, 5053.191489361684, 5054.620903432184, 5057.949420505822, 5086.0845047891735, 5938.8218353449465, 5951.613145145551, 6063.151158837766, 6063.939360606426, 6066.545009124245, 5822.446867547492, 5841.386654401226, 5841.824745257649, 5844.590878638454, 5850.268716410449, 5945.40545945402, 5970.552208584287, 5991.430814072656, 6004.639721616717, 6007.849803754766, 5601.467860553241, 5678.034734095297, 5738.340090889435, 5762.2221000164445, 5766.452187042224, 5857.824265272048, 5865.882682346414, 5881.676507792113, 5886.352501224947, 5887.941120588739, 5728.828135155952, 5729.197912292366, 5730.627509211888, 5740.138979152994, 5745.224394706828, 5559.138333558305, 5673.659580425187, 5726.255586773693, 5773.3072031356505, 5803.883922321615, 5663.943360566342, 5664.122061080374, 5687.43125687428, 5689.0, 5700.942990570207, 5776.451237132465, 5798.275215598051, 5808.825735227781, 5815.302163740378, 5816.098504731774, 5427.077396842626, 5435.402105768283, 5533.446655334435, 5600.69196194197, 5662.03745363281], "unit": "score", "name": "dojo.html", "value": 5386.859833916459}, {"lowerIsBetter": false, "replicates": [531.7128750474744, 572.2932178759235, 607.3137354789087, 615.4399496458224, 628.8836565235431, 38500.037499062506, 39206.21587568247, 39331.606683933154, 39406.40890386643, 39428.80285598572, 42351.57648423515, 42821.785891070576, 42872.78563607178, 42906.0, 42918.14163716724, 8738.126187381275, 8952.418092823978, 8953.05992870749, 8962.462252264851, 8965.282777377794, 8844.73465796024, 8976.775580610505, 8985.23625491834, 8986.460812351248, 8990.55047247635, 9165.725028249164, 9233.307501937348, 9258.814823703522, 9268.0, 9268.536573171348, 9135.17783399494, 9217.493037882914, 9224.723258302229, 9227.0, 9227.123423274777, 8983.730488085368, 9070.909290907139, 9079.0, 9086.091390860927, 9109.362344635878, 43109.35335969963, 43632.56367436317, 43739.56260437387, 43758.56241437577, 43786.0, 2687.7984151188543, 3769.491118698968, 3950.5654378018394, 4255.63827074699, 4502.032063106448, 29081.0, 29243.41513169746, 29286.121416357542, 29438.85280573605, 29992.85003574968, 3956.9802150989062, 3981.0843505993785, 3994.6005399460114, 4031.314676505001, 4224.556421575752, 248983.0, 251131.0, 251228.0, 251467.0, 252174.0, 57627.71186144126, 62144.0, 62704.0, 65114.0, 66255.33744662492, 58716.412835871946, 58762.41237587569, 58943.0, 59173.40826591765, 59232.70383648141, 18518.259269629063, 18522.629547408975, 18675.71986420205, 18755.718664220047, 18763.90618046901, 14132.576022719335, 14202.218877961604, 14204.147751134966, 14212.502562410473, 14213.928930355281, 20714.48213794667, 20966.475838103863, 21148.682769758467, 21171.0, 21285.148594056063, 7062.364387205176, 7193.460490463236, 7264.309890560388, 7264.854702906018, 7714.922850771421, 1011.3527342500805, 1018.5721996761378, 1060.6499855047816, 1074.188987314588, 1120.3669926491507, 29879.0, 30200.24499387489, 30576.0, 30655.2336191597, 30887.69112308893, 1108.6895669212633, 1116.2855772305732, 1138.2203190814153, 1166.4401087478059, 1195.121585634558, 15601.297941592655, 15786.0, 15927.920360398355, 16222.26999784989, 16265.59336016609, 323000.0, 326909.0, 327267.0, 328570.0, 328648.0, 56659.0, 56969.43030569724, 57067.42932570621, 57103.14345284824, 57190.0, 1286.6461723026243, 1347.3936728472227, 1437.5615437291517, 1456.0899437851342, 1462.5612316305278, 27295.0, 28957.0, 28969.420611588073, 29266.0, 29923.850380747957, 45732.31401529046, 46055.078898422515, 46069.30896036629, 46090.308645369674, 46093.0, 213798.0, 214655.0, 214718.0, 215459.0, 276129.0, 49302.50697492979, 49662.0, 50246.0, 51088.74455627698, 51095.0, 45920.0, 46041.0, 46632.0, 47417.28874066961, 47730.0, 37780.244395112495, 38024.80987595044, 38213.808930955165, 38310.42534362042, 38376.232475350895, 40342.19315613613, 40737.1852562953, 41523.7923810379, 41636.0, 42662.78668606637, 42763.78618106889, 43151.784241078596, 43576.0, 43610.34584481299, 44246.0, 37997.0, 38007.619923800405, 38204.42693359546, 38712.2257554853, 39119.2176156481, 28094.43811123725, 28991.0, 29221.707782921898, 29345.119646410643, 29411.0], "unit": "score", "name": "ext.html", "value": 19675.394981667658}, {"lowerIsBetter": false, "replicates": [354.09175464932446, 361.9402798538241, 361.95475565554295, 369.4661214544982, 370.16343064673833, 17772.911135444338, 18349.44951651451, 19271.0, 19547.511312217168, 19663.410097697055, 18130.728039079393, 18288.0, 18901.0, 18996.0, 19073.904630476827, 5534.695591742453, 5662.348829884554, 5674.0, 5683.914741278863, 5722.313322401317, 4255.87232383029, 5605.439456054382, 5895.675737834439, 6144.938550614482, 6187.690615469209, 6127.417895299939, 6130.386961303856, 6141.600795948271, 6146.231721034871, 6163.445289923906, 5959.672218028007, 6012.9398706013035, 6084.026555751058, 6084.908726369108, 6092.208012958309, 3812.0, 5167.4057483389515, 5407.83776486706, 5419.241306217133, 5459.727013649302, 21693.783062169336, 22210.11159553616, 22285.220017299478, 22448.775512244832, 22564.43588910274, 2485.5898776701824, 2712.199901029201, 2844.431113777253, 2933.897313594014, 3136.8902088427026, 13534.526291579847, 13864.237466939314, 13952.651183720387, 14333.42666293347, 14396.712065758626, 1909.5417099896065, 1952.3557226115347, 1955.9902200489048, 1971.2804826238464, 1975.4172519106755, 62613.0, 63820.68089659522, 64052.67973660149, 64218.6789066061, 64311.0, 9104.954475227714, 9912.107910288109, 10222.744431389126, 10240.590376384862, 10409.167266618653, 14382.712345753027, 14495.420183192555, 14656.853431465548, 14670.486532971296, 14693.55919322422, 8210.712625058213, 8317.95841020791, 8318.542480163527, 8371.539565323845, 8567.700130495403, 8387.580620968927, 8448.32413406926, 8486.957565212135, 8496.915030849612, 8497.575121244037, 4585.839495617637, 4633.9536604634195, 4636.327732478839, 4703.388559487314, 4780.593649539758, 1780.5500972833183, 1835.3209312554172, 1849.9291176646702, 1937.3800383877306, 1981.6631172700675, 897.6499165325529, 985.1429256546706, 997.5710444508786, 1039.3919557059055, 1080.0927221134284, 16917.661646766996, 17837.732434013502, 17975.370862019765, 18213.037895302645, 18226.908865455855, 955.6273053509137, 995.3778888194878, 1017.1455976979225, 1037.972407316766, 1074.8878453838245, 10115.735533058367, 10348.5343159558, 10381.273310868317, 10401.167906567456, 10521.84217236742, 386786.0, 391430.0, 402065.0, 418986.0, 420551.0, 75180.24819751842, 75817.6209118951, 76788.61605692048, 78531.0, 80096.19903800887, 1020.3214862116757, 1025.2259544044348, 1039.0492699180315, 1043.2540733375522, 1043.3062013760916, 16053.357865685242, 16055.598610034842, 16162.111083890499, 16187.919060404623, 16221.432249871197, 34272.143196420286, 35229.295414092085, 35486.0, 35525.644743552235, 36247.818760906026, 48782.0, 48840.2673959898, 49344.50655493399, 49550.50449495459, 49563.752181238866, 7966.322862556747, 8295.668173273243, 8303.335733141455, 8375.916240837758, 8419.536925469158, 13133.080684352004, 13618.523351682643, 13620.250886201355, 13702.725945481234, 13745.312734363442, 11872.109591780823, 11876.703082423008, 11922.701932451759, 11985.460654270404, 12172.269663819845, 11574.537018519164, 11768.352740599006, 11879.22785018971, 11921.582744603897, 11993.040556755264, 11818.881811182122, 11999.1600587958, 12074.93962530217, 12280.570180043656, 12460.68848278764, 8292.87560686578, 8297.419180657296, 8360.916390836013, 8387.412881098264, 8450.028246751703, 8825.426347287406, 11826.526938922347, 11984.940075299568, 12049.578264761041, 12256.448459819152], "unit": "score", "name": "jquery.html", "value": 9013.124159786668}, {"lowerIsBetter": false, "replicates": [1464.8608382203688, 1607.4373969110811, 1614.9677006459867, 1868.4674867662718, 1968.5472341361478, 7795.961020194898, 8108.837823243539, 8115.715949941753, 8122.675092996288, 8125.34997200224, 8103.554304513249, 8124.065732440757, 8151.673933042671, 8198.91801081989, 8213.54825484598, 2016.596680663873, 2313.652952057188, 2380.928572142834, 2411.4574220800355, 2413.54142712884, 2383.1420688552107, 2394.317619478449, 2394.8323617346705, 2399.256230568529, 2400.423898264413, 2325.1745630301252, 2339.7426283108844, 2370.715514138306, 2374.4301367671806, 2374.750651181618, 2312.4912519245822, 2344.3553022918663, 2354.446705024318, 2380.5833979053596, 2381.0, 2324.2213858357472, 2336.1356298169617, 2345.319857241398, 2357.823163262762, 2358.1274928276475, 8261.38039647029, 8348.248657620783, 8358.164183581594, 8364.37267204956, 8367.539785311805, 4983.426905905795, 5156.690598564098, 5160.200168973777, 5167.715775632339, 5171.50870667286, 3145.874165033396, 3150.5116706910467, 3203.1511649412923, 3212.357528494287, 3235.6117265928006, 1003.618624922532, 1017.2116609627524, 1045.717656232813, 1057.799018186542, 1073.8711354637414, 11497.425128743529, 11519.36643484608, 11534.942325288404, 11536.538538458452, 11549.76900461986, 4320.308750599889, 4371.628411584988, 4431.246688063037, 4513.413256276729, 4515.2324104902245, 9718.562664680107, 9759.463229522302, 9762.707118786306, 9779.706608801747, 9792.804143917081, 5110.718910459886, 5147.819826306061, 5159.664621799571, 5165.974170129125, 5166.741662916915, 4011.13760541485, 4526.185286648435, 4535.546445355438, 4597.7011494252765, 4625.560571745679, 3784.905377365533, 3829.291581057513, 3852.8651497198025, 3874.7093967952515, 3875.476810630585, 1221.5968730318973, 1251.6432816647211, 1251.8247445357658, 1252.8684488128797, 1265.367316341829, 1249.6563445052684, 1266.5060626355728, 1290.3354772292278, 1520.7946927164912, 1523.223156190351, 7805.219478052263, 7954.84090318202, 7970.681172753025, 7976.760697179094, 7983.800404989922, 509.4726957598941, 510.3340141115879, 513.2609042978099, 514.9588032957355, 525.8475042237785, 6073.574849760563, 6088.238970128734, 6124.724387402578, 6164.907526387108, 6178.104174894615, 9821.558029888673, 10039.4478303694, 10138.138258248131, 10142.695719128438, 10147.9492602538, 9557.092076252746, 9794.853077203705, 9830.950845245728, 9932.950335248277, 9947.05502977216, 7820.413468989735, 7826.491278066907, 7827.45207835446, 7919.445638805229, 7924.48490848093, 7507.099148102263, 7557.886631700419, 7557.962210188914, 7579.658915348933, 7588.051493563305, 8663.913360866563, 8709.390342676204, 8809.955950220208, 8896.421732587361, 8912.019677835304, 9029.593668284811, 9077.500737459239, 9214.216791572791, 9243.0, 9250.537473126182, 6203.16257305258, 6384.712687928962, 6915.343042411164, 7028.824279393056, 7104.147502299757, 7815.2184781523665, 7819.882701759364, 7864.84270314602, 7878.330341921001, 7879.84240315202, 6891.310868913069, 7030.789076327718, 7064.858702826017, 7143.749968751069, 7162.104736907887, 7190.712371505081, 7201.243869393638, 7203.71185152588, 7275.381592564691, 7286.307800758919, 7258.455615828729, 7455.254474552501, 7461.589612571361, 7476.0, 7479.065116860393, 6802.897956530557, 6888.380045795702, 6899.206591242071, 6899.75850845218, 6902.102726645504, 6825.522213445011, 6839.62382068991, 6847.417969472651, 6852.074969879002, 6915.93084069173], "unit": "score", "name": "mootools.html", "value": 4636.87103198793}, {"lowerIsBetter": false, "replicates": [326.088582412158, 328.11245580704184, 328.25486146447565, 337.8496569026783, 342.8731369393325, 5972.0444728843395, 5999.640021598701, 6016.548758843082, 6058.303295121063, 6075.997460419031, 5938.88122237556, 5958.731857066432, 5960.4039596040375, 5969.343372229051, 5971.820845374646, 4419.88950276244, 4523.660725445605, 4566.246569316058, 4620.953790462103, 4652.6743127981135, 4601.7238965662, 4611.5619016193405, 4611.746353950532, 4618.376519169903, 4622.838200662961, 4566.429196350457, 4574.61115805157, 4579.748113853737, 4591.334256532801, 4593.862184134481, 4395.208862404766, 4478.171538265431, 4552.248878934972, 4559.293309537027, 4586.610138138262, 4036.555978842325, 4041.1311568012725, 4041.2321658884716, 4051.0075031617444, 4061.248668996245, 5622.128570071604, 5625.5218306444, 5634.802781902655, 5635.549156067505, 5636.0982242841355, 5309.681419114865, 5318.149096144598, 5321.707306098163, 5322.3879253885525, 5322.92015619766, 6257.405546473124, 6258.780942666985, 6264.123022776815, 6266.154069200691, 6267.310595834455, 4215.662746980234, 4345.0, 4382.583654552813, 4462.352958820953, 4467.932981005288, 6491.675416229217, 6512.185976752906, 6540.34596540347, 6553.246376666697, 6555.344465553454, 4403.53762854902, 4406.140802543473, 4409.831394680412, 4412.029353542215, 4419.558044195619, 4461.0, 4468.972136408579, 4470.195364834361, 4471.932921006188, 4472.306792447176, 5196.1166601677805, 5203.297554830126, 5203.635745497854, 5210.088234559013, 5213.713245771519, 6092.817215483543, 6310.716017779211, 6315.242170939517, 6315.305316415191, 6366.554341196072, 1566.7806507089017, 1567.6551158745058, 1575.2517554161682, 1576.5506830553238, 1579.5577238373273, 989.44096585429, 1026.2251999740297, 1060.4326685223368, 1082.3397727386289, 1126.2791813239533, 5974.761009559569, 5985.281766188085, 5987.072003839412, 5992.58051936369, 6003.159557661844, 6327.841803954938, 6376.29860715321, 6376.936230637727, 6386.584871983307, 6434.0670602763275, 6040.848978775566, 6047.365026672224, 6053.606515576474, 6065.090236464477, 6065.727042283108, 3424.383610950003, 3455.8444869980913, 3459.498372735939, 3462.584489861182, 3468.9826550867083, 6496.837579060467, 6632.96683516589, 6638.933610663831, 6650.900236496456, 6662.83342916431, 6557.278699343068, 6570.080188773575, 6587.044878492592, 6588.670566471753, 6597.934020659828, 6651.135352404156, 6652.201735791736, 6655.767048153195, 6658.167729033871, 6661.866762664719, 6386.90419643715, 6389.616623002635, 6402.0, 6406.0390941359165, 6407.3592640737415, 6239.906401404073, 6331.430171284606, 6338.809835704937, 6345.111684364285, 6467.676616169267, 6735.326467353421, 6762.763303284361, 6767.289434609492, 6771.221309549464, 6777.864442711019, 4476.4180656514445, 4502.257127573914, 4502.549745025472, 4511.481179664381, 4512.458504979423, 6506.707198175999, 6519.511036672174, 6527.902081468686, 6536.6731663415685, 6539.836504087436, 6340.65126418033, 6345.111684364285, 6349.523785716182, 6350.460210882126, 6363.5545511813725, 6151.6924153793025, 6344.27040890285, 6365.204349456318, 6369.172007638977, 6389.2971773105855, 6218.968905155445, 6263.467605253422, 6263.78076767311, 6273.905891411724, 6274.46667033289, 6389.648569328546, 6427.1002059710745, 6428.742850285937, 6435.678216089271, 6442.130312407765, 5995.670238136944, 6060.151578779062, 6222.097795819672, 6235.75056997715, 6246.718897649525], "unit": "score", "name": "prototype.html", "value": 4746.987732299781}, {"lowerIsBetter": false, "replicates": [736.7863319637305, 737.4248086492538, 796.788850954497, 797.9521228726277, 878.3675753457509, 13502.932485337571, 13708.931455342708, 13709.177449353047, 13721.970852186088, 13734.862651373483, 12490.313032783193, 12831.743365132692, 12990.0, 13157.079004469668, 13168.670783230424, 776.6311002273903, 925.0564424287223, 940.4827344960279, 940.8635747816562, 961.0581630002566, 937.4796987671839, 938.0994245524305, 939.9248060155205, 940.1585580905086, 946.8769060022188, 983.2183414185704, 983.4492684096929, 983.7393090830935, 984.2372161574801, 986.1962500562055, 812.995935020324, 951.1059603972278, 971.1647982734843, 977.9657711980046, 979.8089372572351, 718.3140101203338, 719.8488317453341, 721.2102747491489, 721.6860665610476, 723.9239879812649, 13181.209127452383, 13200.6699832504, 13220.669483262995, 13221.206727596375, 13241.139325943783, 13644.658883527893, 14042.36809343582, 14070.92964535181, 14311.141331520039, 14369.419363869965, 11168.944155279252, 11192.496337664743, 11222.0, 11354.034907032912, 11454.0, 3946.980265098685, 3996.0609256824623, 3997.6601988830985, 4004.159126583421, 4010.3382941814566, 50610.746946265404, 50917.236241456405, 53641.1953820693, 54141.45858541404, 54231.72884135554, 11086.390248536247, 11120.165987550967, 11212.0, 11229.943850280697, 11613.76772464563, 20336.186552537732, 20409.591808163754, 20422.59154816895, 20477.488062798548, 20510.79489205089, 7702.768916932501, 7787.155055067442, 7842.333401660922, 7955.0, 8103.918960810316, 4380.518143004267, 4403.119376124788, 4454.487733910577, 4483.50681425043, 4541.750203738826, 3271.7382609391193, 3294.275259442919, 3295.950560741591, 3297.884574039897, 3298.901032969015, 536.4099490560352, 547.7343488408119, 569.9316082070178, 590.8670549126498, 592.1946153231602, 580.8693044065052, 606.0333767640606, 609.9024156134997, 713.3508507258474, 726.9563826170447, 7910.327622152066, 8276.751697449086, 8401.495910245405, 8610.182032706884, 8696.347773916981, 572.7594410347664, 680.1905732178791, 680.5585136681335, 708.2174197511675, 710.5701050864257, 3826.426036094608, 3889.183271513014, 3911.471951286597, 3969.146633473817, 4082.1223436960604, 57017.71491142518, 57151.714241428526, 57526.424735752946, 57745.13382299269, 58124.0, 49427.258591121164, 50780.23829642558, 51698.96602068013, 52363.47636523586, 52409.73795131, 44651.10697786026, 45209.321860172124, 45866.541334586895, 45883.770581146884, 46436.0, 8861.689840855539, 8914.300500602043, 8918.063603321558, 8988.910110899069, 9053.230475409664, 34832.78085267003, 35462.29075418529, 35469.290614187055, 35669.82165089262, 36789.0, 40555.0, 41423.58576414197, 43459.34810977775, 43876.56123438725, 44240.77879610581, 11749.060075194135, 11895.977236951001, 11899.107566932342, 12113.091518136, 12417.875821242033, 13115.475380984653, 13287.800682989957, 13364.0, 13466.663333416744, 13557.0, 11324.830127548259, 12041.09691773103, 12437.0, 12568.0, 12604.306763128116, 12143.574974875837, 12332.630021099381, 12341.876581234432, 12654.620361389174, 12711.110222284351, 11175.552977880794, 11180.217384782987, 11209.831852522055, 11856.70358241051, 12743.235405875677, 10145.239107066853, 10266.948665256627, 10303.793924121326, 10562.31344962575, 10758.73103172427, 8721.040685524715, 9002.684906028258, 9153.130452606993, 9179.036201198778, 9194.448333100036], "unit": "score", "name": "yui.html", "value": 6629.057840046714}], "name": "dromaeo_css", "value": 7200.7574124181665}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 113.0, 107.0, 111.0, 112.0, 112.0, 102.0, 110.0, 112.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.9}, {"lowerIsBetter": true, "replicates": [151.0, 130.0, 151.0, 170.0, 130.0, 156.0, 168.0, 131.0, 182.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 149.7}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 162.0, 160.0, 161.0, 160.0, 162.0, 163.0, 160.0, 160.0], "unit": "score", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [76.0, 76.0, 77.0, 163.0, 76.0, 76.0, 75.0, 76.0, 179.0, 75.0], "unit": "score", "name": "audio-fft", "value": 94.9}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 146.0, 93.0, 94.0, 92.0, 140.0, 93.0, 93.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 107.6}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.5}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [53.0, 54.0, 54.0, 58.0, 56.0, 55.0, 56.0, 54.0, 54.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 54.6}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 66.0, 68.0, 65.0, 65.0, 65.0, 65.0, 64.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.4}, {"lowerIsBetter": true, "replicates": [77.0, 78.0, 80.0, 78.0, 79.0, 80.0, 79.0, 81.0, 79.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.1}, {"lowerIsBetter": true, "replicates": [112.0, 112.0, 112.0, 114.0, 116.0, 113.0, 111.0, 122.0, 111.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 114.1}, {"lowerIsBetter": true, "replicates": [149.0, 138.0, 147.0, 141.0, 145.0, 136.0, 144.0, 136.0, 143.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.4}, {"lowerIsBetter": true, "replicates": [69.0, 72.0, 71.0, 68.0, 65.0, 68.0, 70.0, 70.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.5}], "name": "kraken", "value": 1505.6000000000001}]} 03:40:45 INFO - Return code: 0 03:40:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:40:45 INFO - # TBPL SUCCESS # 03:40:45 INFO - Running post-action listener: _resource_record_post_action 03:40:45 INFO - Running post-run listener: _resource_record_post_run 03:40:47 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 499867648; Read time: 12; Write time: 337424 03:40:47 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 245121024; Read time: 0; Write time: 218100 03:40:47 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 254746624; Read time: 12; Write time: 119324 03:40:47 INFO - Running post-run listener: _upload_blobber_files 03:40:47 INFO - Blob upload gear active. 03:40:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:40:47 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:40:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:40:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:40:47 INFO - (blobuploader) - INFO - Open directory for files ... 03:40:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:40:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:40:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:40:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:40:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:40:48 INFO - (blobuploader) - INFO - Done attempting. 03:40:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:40:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:40:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:40:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:40:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:40:49 INFO - (blobuploader) - INFO - Done attempting. 03:40:49 INFO - (blobuploader) - INFO - Iteration through files over. 03:40:49 INFO - Return code: 0 03:40:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:40:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:40:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/90bcd6bc45f83dc3fe866ff81c8dacd0eea4dfd5c1529ea5722aba82ae167fd75a9b6139a152869c2b188aef59677d66147cb79108cffae9fca5d31984b1fb46", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7bd1f8947317977bb40da35561e501125ff2de04214cb7951144b4a656bd2db524557d9ec1b0812a27a4c5c9c6360d5540a3da3e3b5cf24870b467960385b226"} 03:40:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:40:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:40:49 INFO - Contents: 03:40:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/90bcd6bc45f83dc3fe866ff81c8dacd0eea4dfd5c1529ea5722aba82ae167fd75a9b6139a152869c2b188aef59677d66147cb79108cffae9fca5d31984b1fb46", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7bd1f8947317977bb40da35561e501125ff2de04214cb7951144b4a656bd2db524557d9ec1b0812a27a4c5c9c6360d5540a3da3e3b5cf24870b467960385b226"} 03:40:49 INFO - Running post-run listener: copy_logs_to_upload_dir 03:40:49 INFO - Copying logs to upload dir... 03:40:49 INFO - mkdir: /builds/slave/test/build/upload/logs 03:40:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.539688 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-04-21 03:40:48.734552) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 03:40:48.738424) ========= 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=41bf3e9aed84707956354da8000001c5-1461231333.215978-111066485 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/90bcd6bc45f83dc3fe866ff81c8dacd0eea4dfd5c1529ea5722aba82ae167fd75a9b6139a152869c2b188aef59677d66147cb79108cffae9fca5d31984b1fb46", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7bd1f8947317977bb40da35561e501125ff2de04214cb7951144b4a656bd2db524557d9ec1b0812a27a4c5c9c6360d5540a3da3e3b5cf24870b467960385b226"} build_url:https://queue.taskcluster.net/v1/task/H88g_4wJTBOfzYgxq1_d6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011316 build_url: 'https://queue.taskcluster.net/v1/task/H88g_4wJTBOfzYgxq1_d6Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/90bcd6bc45f83dc3fe866ff81c8dacd0eea4dfd5c1529ea5722aba82ae167fd75a9b6139a152869c2b188aef59677d66147cb79108cffae9fca5d31984b1fb46", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7bd1f8947317977bb40da35561e501125ff2de04214cb7951144b4a656bd2db524557d9ec1b0812a27a4c5c9c6360d5540a3da3e3b5cf24870b467960385b226"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 03:40:48.765845) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 03:40:48.766432) ========= 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=41bf3e9aed84707956354da8000001c5-1461231333.215978-111066485 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004418 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 03:40:48.851059) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 03:40:48.851368) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 03:40:48.851677) ========= ========= Total master_lag: 0.18 =========