builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-033 starttime: 1460868375.61 results: success (0) buildid: 20160416205825 builduid: 0ddae6f200f847d093934f1b01a4fb11 revision: 8997f9366f6be67b5ac4c7f2708969549dd29875 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-16 21:46:15.606093) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-16 21:46:15.606668) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-16 21:46:15.606985) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-16 21:46:15.724531) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 21:46:15.724812) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1460864793.673689-597899995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-16 21:46:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.9M=0s 2016-04-16 21:46:15 (37.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.161367 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 21:46:15.931599) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 21:46:15.931919) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1460864793.673689-597899995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016295 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 21:46:15.981059) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 21:46:15.981484) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8997f9366f6be67b5ac4c7f2708969549dd29875 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 8997f9366f6be67b5ac4c7f2708969549dd29875 --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=edae0fb5fee9fb758e8af6d3000002a4-1460864793.673689-597899995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-16 21:46:15,993 truncating revision to first 12 chars 2016-04-16 21:46:15,993 Setting DEBUG logging. 2016-04-16 21:46:15,993 attempt 1/10 2016-04-16 21:46:15,993 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8997f9366f6b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-16 21:46:16,271 unpacking tar archive at: fx-team-8997f9366f6b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.552796 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 21:46:16.547309) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-16 21:46:16.547619) ========= script_repo_revision: 8997f9366f6be67b5ac4c7f2708969549dd29875 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-16 21:46:16.548048) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-16 21:46:16.548312) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-16 21:46:16.556482) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-04-16 21:46:16.556789) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=edae0fb5fee9fb758e8af6d3000002a4-1460864793.673689-597899995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:46:16 INFO - MultiFileLogger online at 20160416 21:46:16 in /builds/slave/test 21:46:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 21:46:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:46:16 INFO - {'append_to_log': False, 21:46:16 INFO - 'base_work_dir': '/builds/slave/test', 21:46:16 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 21:46:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:46:16 INFO - 'branch': 'Fx-Team-Non-PGO', 21:46:16 INFO - 'buildbot_json_path': 'buildprops.json', 21:46:16 INFO - 'config_files': ('talos/linux_config.py',), 21:46:16 INFO - 'default_actions': ('clobber', 21:46:16 INFO - 'read-buildbot-config', 21:46:16 INFO - 'download-and-extract', 21:46:16 INFO - 'populate-webroot', 21:46:16 INFO - 'create-virtualenv', 21:46:16 INFO - 'install', 21:46:16 INFO - 'run-tests'), 21:46:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:46:16 INFO - 'download_minidump_stackwalk': True, 21:46:16 INFO - 'download_symbols': 'ondemand', 21:46:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:46:16 INFO - 'tooltool.py': '/tools/tooltool.py', 21:46:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:46:16 INFO - '/tools/misc-python/virtualenv.py')}, 21:46:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:46:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:46:16 INFO - 'installer_path': 'installer.exe', 21:46:16 INFO - 'log_level': 'info', 21:46:16 INFO - 'log_name': 'talos', 21:46:16 INFO - 'log_to_console': True, 21:46:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:46:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:46:16 INFO - 'opt_config_files': (), 21:46:16 INFO - 'pip_index': False, 21:46:16 INFO - 'sps_profile': False, 21:46:16 INFO - 'sps_profile_interval': 0, 21:46:16 INFO - 'suite': 'dromaeojs', 21:46:16 INFO - 'system_bits': '32', 21:46:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:46:16 INFO - 'title': 'talos-linux64-ix-033', 21:46:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:46:16 INFO - 'use_talos_json': True, 21:46:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:46:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:46:16 INFO - 'work_dir': 'build'} 21:46:16 INFO - ##### 21:46:16 INFO - ##### Running clobber step. 21:46:16 INFO - ##### 21:46:16 INFO - Running pre-action listener: _resource_record_pre_action 21:46:16 INFO - Running main action method: clobber 21:46:16 INFO - rmtree: /builds/slave/test/build 21:46:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:46:17 INFO - Running post-action listener: _resource_record_post_action 21:46:17 INFO - ##### 21:46:17 INFO - ##### Running read-buildbot-config step. 21:46:17 INFO - ##### 21:46:17 INFO - Running pre-action listener: _resource_record_pre_action 21:46:17 INFO - Running main action method: read_buildbot_config 21:46:17 INFO - Using buildbot properties: 21:46:17 INFO - { 21:46:17 INFO - "project": "", 21:46:17 INFO - "product": "firefox", 21:46:17 INFO - "script_repo_revision": "production", 21:46:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 21:46:17 INFO - "repository": "", 21:46:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 21:46:17 INFO - "buildid": "20160416205825", 21:46:17 INFO - "pgo_build": "False", 21:46:17 INFO - "basedir": "/builds/slave/test", 21:46:17 INFO - "buildnumber": 1571, 21:46:17 INFO - "slavename": "talos-linux64-ix-033", 21:46:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:46:17 INFO - "platform": "ubuntu64_hw", 21:46:17 INFO - "scheduler": "tests-fx-team-linux64-talos", 21:46:17 INFO - "branch": "fx-team", 21:46:17 INFO - "repo_path": "integration/fx-team", 21:46:17 INFO - "revision": "8997f9366f6be67b5ac4c7f2708969549dd29875", 21:46:17 INFO - "stage_platform": "linux64", 21:46:17 INFO - "builduid": "0ddae6f200f847d093934f1b01a4fb11", 21:46:17 INFO - "slavebuilddir": "test" 21:46:17 INFO - } 21:46:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/ItEmY08LT0qOSumJOEWNXA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 21:46:17 INFO - Running post-action listener: _resource_record_post_action 21:46:17 INFO - ##### 21:46:17 INFO - ##### Running download-and-extract step. 21:46:17 INFO - ##### 21:46:17 INFO - Running pre-action listener: _resource_record_pre_action 21:46:17 INFO - Running main action method: download_and_extract 21:46:17 INFO - mkdir: /builds/slave/test/build/tests 21:46:17 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')]} 21:46:17 INFO - https://queue.taskcluster.net/v1/task/ItEmY08LT0qOSumJOEWNXA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:46:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItEmY08LT0qOSumJOEWNXA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 21:46:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItEmY08LT0qOSumJOEWNXA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 21:46:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItEmY08LT0qOSumJOEWNXA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 21:46:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItEmY08LT0qOSumJOEWNXA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:46:18 INFO - Downloaded 1361 bytes. 21:46:18 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 21:46:18 INFO - Using the following test package requirements: 21:46:18 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 21:46:18 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:46:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:46:18 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:46:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:46:18 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:46:18 INFO - u'jsshell-linux-x86_64.zip'], 21:46:18 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:46:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:46:18 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 21:46:18 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:46:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:46:18 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:46:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:46:18 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:46:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:46:18 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:46:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:46:18 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:46:18 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')]} 21:46:18 INFO - https://queue.taskcluster.net/v1/task/ItEmY08LT0qOSumJOEWNXA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:46:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItEmY08LT0qOSumJOEWNXA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:46:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItEmY08LT0qOSumJOEWNXA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:46:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItEmY08LT0qOSumJOEWNXA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:46:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItEmY08LT0qOSumJOEWNXA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:46:21 INFO - Downloaded 22203703 bytes. 21:46:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:46:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 21:46:22 INFO - Return code: 0 21:46:22 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:46: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')]} 21:46:22 INFO - https://queue.taskcluster.net/v1/task/ItEmY08LT0qOSumJOEWNXA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:46:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItEmY08LT0qOSumJOEWNXA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:46:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItEmY08LT0qOSumJOEWNXA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:46:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItEmY08LT0qOSumJOEWNXA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:46:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItEmY08LT0qOSumJOEWNXA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:46:27 INFO - Downloaded 22203703 bytes. 21:46:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:46:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 21:46:29 INFO - Return code: 0 21:46:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:29 INFO - https://queue.taskcluster.net/v1/task/ItEmY08LT0qOSumJOEWNXA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:46:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItEmY08LT0qOSumJOEWNXA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 21:46:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItEmY08LT0qOSumJOEWNXA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 21:46:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItEmY08LT0qOSumJOEWNXA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 21:46:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItEmY08LT0qOSumJOEWNXA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:46:30 INFO - Downloaded 10841076 bytes. 21:46:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:46:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 21:46:30 INFO - Return code: 0 21:46:30 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')]} 21:46:30 INFO - https://queue.taskcluster.net/v1/task/ItEmY08LT0qOSumJOEWNXA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:46:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItEmY08LT0qOSumJOEWNXA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:46:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItEmY08LT0qOSumJOEWNXA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:46:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItEmY08LT0qOSumJOEWNXA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:46:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ItEmY08LT0qOSumJOEWNXA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:46:31 INFO - Downloaded 54448753 bytes. 21:46:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ItEmY08LT0qOSumJOEWNXA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:46:31 INFO - mkdir: /builds/slave/test/properties 21:46:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:46:31 INFO - Writing to file /builds/slave/test/properties/build_url 21:46:31 INFO - Contents: 21:46:31 INFO - build_url:https://queue.taskcluster.net/v1/task/ItEmY08LT0qOSumJOEWNXA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:46:32 INFO - Running post-action listener: _resource_record_post_action 21:46:32 INFO - Running post-action listener: set_extra_try_arguments 21:46:32 INFO - ##### 21:46:32 INFO - ##### Running populate-webroot step. 21:46:32 INFO - ##### 21:46:32 INFO - Running pre-action listener: _resource_record_pre_action 21:46:32 INFO - Running main action method: populate_webroot 21:46:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:46:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:46:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:46:32 INFO - '--tppagecycles', 21:46:32 INFO - '7'], 21:46:32 INFO - 'tests': ['tsvgm']}}, 21:46:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:46:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:46:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:46:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:46:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:46:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:46:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:32 INFO - 'talos_options': ['--disable-e10s'], 21:46:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:46:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:46:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:32 INFO - 'talos_options': ['--disable-e10s'], 21:46:32 INFO - 'tests': ['damp', 'tps']}, 21:46:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:32 INFO - 'tests': ['damp', 'tps']}, 21:46:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:46:32 INFO - 'tests': ['dromaeo_dom']}, 21:46:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:46:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:46:32 INFO - 'tests': ['a11yr', 21:46:32 INFO - 'ts_paint', 21:46:32 INFO - 'tpaint', 21:46:32 INFO - 'sessionrestore', 21:46:32 INFO - 'sessionrestore_no_auto_restore', 21:46:32 INFO - 'tabpaint']}, 21:46:32 INFO - 'other-e10s': {'tests': ['a11yr', 21:46:32 INFO - 'ts_paint', 21:46:32 INFO - 'tpaint', 21:46:32 INFO - 'sessionrestore', 21:46:32 INFO - 'sessionrestore_no_auto_restore', 21:46:32 INFO - 'tabpaint']}, 21:46:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:46:32 INFO - 'ts_paint', 21:46:32 INFO - 'tpaint', 21:46:32 INFO - 'sessionrestore', 21:46:32 INFO - 'sessionrestore_no_auto_restore', 21:46:32 INFO - 'tabpaint']}, 21:46:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:46:32 INFO - 'ts_paint', 21:46:32 INFO - 'tpaint', 21:46:32 INFO - 'sessionrestore', 21:46:32 INFO - 'sessionrestore_no_auto_restore', 21:46:32 INFO - 'tabpaint']}, 21:46:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:46:32 INFO - 'tests': ['a11yr', 21:46:32 INFO - 'ts_paint', 21:46:32 INFO - 'tpaint', 21:46:32 INFO - 'sessionrestore', 21:46:32 INFO - 'sessionrestore_no_auto_restore', 21:46:32 INFO - 'tabpaint']}, 21:46:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:46:32 INFO - 'tests': ['a11yr', 21:46:32 INFO - 'ts_paint', 21:46:32 INFO - 'tpaint', 21:46:32 INFO - 'sessionrestore', 21:46:32 INFO - 'sessionrestore_no_auto_restore', 21:46:32 INFO - 'tabpaint']}, 21:46:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:46:32 INFO - 'tests': ['tsvgx', 21:46:32 INFO - 'tsvgr_opacity', 21:46:32 INFO - 'tart', 21:46:32 INFO - 'tscrollx', 21:46:32 INFO - 'cart']}, 21:46:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:46:32 INFO - 'tsvgr_opacity', 21:46:32 INFO - 'tart', 21:46:32 INFO - 'tscrollx', 21:46:32 INFO - 'cart']}, 21:46:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:32 INFO - 'talos_options': ['--disable-e10s'], 21:46:32 INFO - 'tests': ['tp5o']}, 21:46:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:32 INFO - 'tests': ['tp5o']}, 21:46:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:32 INFO - 'talos_options': ['--disable-e10s', 21:46:32 INFO - '--xperf_path', 21:46:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:46:32 INFO - 'tests': ['tp5n']}, 21:46:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:32 INFO - 'talos_options': ['--xperf_path', 21:46:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:46:32 INFO - 'tests': ['tp5n']}}, 21:46:32 INFO - 'talos.zip': {'path': '', 21:46:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:46:32 INFO - Running post-action listener: _resource_record_post_action 21:46:32 INFO - ##### 21:46:32 INFO - ##### Running create-virtualenv step. 21:46:32 INFO - ##### 21:46:32 INFO - Running pre-action listener: _resource_record_pre_action 21:46:32 INFO - Running main action method: create_virtualenv 21:46:32 INFO - Creating virtualenv /builds/slave/test/build/venv 21:46:32 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 21:46:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:46:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:46:32 INFO - Using real prefix '/usr' 21:46:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:46:33 INFO - Installing distribute.............................................................................................................................................................................................done. 21:46:35 INFO - Installing pip.................done. 21:46:35 INFO - Return code: 0 21:46:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:46:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:35 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 0x7feae35f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16235a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b2410>, '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 0x16b3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b37a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1460864793.673689-597899995', '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 21:46:35 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 21:46:35 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 21:46:35 INFO - Using env: {'DISPLAY': ':0', 21:46:35 INFO - 'HOME': '/home/cltbld', 21:46:35 INFO - 'LANG': 'en_US.UTF-8', 21:46:35 INFO - 'LANGUAGE': 'en_US:en', 21:46:35 INFO - 'LOGNAME': 'cltbld', 21:46:35 INFO - 'MAIL': '/var/mail/cltbld', 21:46:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:35 INFO - 'MOZ_NO_REMOTE': '1', 21:46:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:35 INFO - 'NO_EM_RESTART': '1', 21:46:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:35 INFO - 'PWD': '/builds/slave/test', 21:46:35 INFO - 'SHELL': '/bin/bash', 21:46:35 INFO - 'SHLVL': '1', 21:46:35 INFO - 'TERM': 'linux', 21:46:35 INFO - 'TMOUT': '86400', 21:46:35 INFO - 'USER': 'cltbld', 21:46:35 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1460864793.673689-597899995', 21:46:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:35 INFO - '_': '/tools/buildbot/bin/python'} 21:46:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:36 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 21:46:36 INFO - Cleaning up... 21:46:36 INFO - Return code: 0 21:46:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 21:46:36 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')]} 21:46:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:36 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')]} 21:46:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:36 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 0x7feae35f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16235a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b2410>, '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 0x16b3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b37a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1460864793.673689-597899995', '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 21:46:36 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 21:46:36 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 21:46:36 INFO - Using env: {'DISPLAY': ':0', 21:46:36 INFO - 'HOME': '/home/cltbld', 21:46:36 INFO - 'LANG': 'en_US.UTF-8', 21:46:36 INFO - 'LANGUAGE': 'en_US:en', 21:46:36 INFO - 'LOGNAME': 'cltbld', 21:46:36 INFO - 'MAIL': '/var/mail/cltbld', 21:46:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:36 INFO - 'MOZ_NO_REMOTE': '1', 21:46:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:36 INFO - 'NO_EM_RESTART': '1', 21:46:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:36 INFO - 'PWD': '/builds/slave/test', 21:46:36 INFO - 'SHELL': '/bin/bash', 21:46:36 INFO - 'SHLVL': '1', 21:46:36 INFO - 'TERM': 'linux', 21:46:36 INFO - 'TMOUT': '86400', 21:46:36 INFO - 'USER': 'cltbld', 21:46:36 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1460864793.673689-597899995', 21:46:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:36 INFO - '_': '/tools/buildbot/bin/python'} 21:46:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:36 INFO - Downloading/unpacking psutil>=0.7.1 21:46:36 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 21:46:36 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 21:46:36 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 21:46:36 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 21:46:36 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 21:46:36 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 21:46:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:46:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:46:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:46:38 INFO - Installing collected packages: psutil 21:46:38 INFO - Running setup.py install for psutil 21:46:38 INFO - building 'psutil._psutil_linux' extension 21:46:38 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 21:46: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 21:46:40 INFO - building 'psutil._psutil_posix' extension 21:46:40 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 21:46:40 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 21:46:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:46:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:46:40 INFO - Successfully installed psutil 21:46:40 INFO - Cleaning up... 21:46:40 INFO - Return code: 0 21:46:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 21:46: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')]} 21:46:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46: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')]} 21:46:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:41 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 0x7feae35f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16235a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b2410>, '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 0x16b3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b37a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1460864793.673689-597899995', '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 21:46:41 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 21:46:41 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 21:46:41 INFO - Using env: {'DISPLAY': ':0', 21:46:41 INFO - 'HOME': '/home/cltbld', 21:46:41 INFO - 'LANG': 'en_US.UTF-8', 21:46:41 INFO - 'LANGUAGE': 'en_US:en', 21:46:41 INFO - 'LOGNAME': 'cltbld', 21:46:41 INFO - 'MAIL': '/var/mail/cltbld', 21:46:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:41 INFO - 'MOZ_NO_REMOTE': '1', 21:46:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:41 INFO - 'NO_EM_RESTART': '1', 21:46:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:41 INFO - 'PWD': '/builds/slave/test', 21:46:41 INFO - 'SHELL': '/bin/bash', 21:46:41 INFO - 'SHLVL': '1', 21:46:41 INFO - 'TERM': 'linux', 21:46:41 INFO - 'TMOUT': '86400', 21:46:41 INFO - 'USER': 'cltbld', 21:46:41 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1460864793.673689-597899995', 21:46:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:41 INFO - '_': '/tools/buildbot/bin/python'} 21:46:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:46:41 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 21:46:41 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 21:46:41 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 21:46:41 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 21:46:41 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 21:46:41 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 21:46:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:46:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:46:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:46:43 INFO - Installing collected packages: mozsystemmonitor 21:46:43 INFO - Running setup.py install for mozsystemmonitor 21:46:43 INFO - Successfully installed mozsystemmonitor 21:46:43 INFO - Cleaning up... 21:46:43 INFO - Return code: 0 21:46:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:46:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7feae35f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16235a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b2410>, '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 0x16b3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b37a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1460864793.673689-597899995', '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 21:46:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:46:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:46:43 INFO - Using env: {'DISPLAY': ':0', 21:46:43 INFO - 'HOME': '/home/cltbld', 21:46:43 INFO - 'LANG': 'en_US.UTF-8', 21:46:43 INFO - 'LANGUAGE': 'en_US:en', 21:46:43 INFO - 'LOGNAME': 'cltbld', 21:46:43 INFO - 'MAIL': '/var/mail/cltbld', 21:46:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:43 INFO - 'MOZ_NO_REMOTE': '1', 21:46:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:43 INFO - 'NO_EM_RESTART': '1', 21:46:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:43 INFO - 'PWD': '/builds/slave/test', 21:46:43 INFO - 'SHELL': '/bin/bash', 21:46:43 INFO - 'SHLVL': '1', 21:46:43 INFO - 'TERM': 'linux', 21:46:43 INFO - 'TMOUT': '86400', 21:46:43 INFO - 'USER': 'cltbld', 21:46:43 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1460864793.673689-597899995', 21:46:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:43 INFO - '_': '/tools/buildbot/bin/python'} 21:46:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:43 INFO - Downloading/unpacking blobuploader==1.2.4 21:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:45 INFO - Downloading blobuploader-1.2.4.tar.gz 21:46:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:46:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:46:45 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 21:46:45 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 21:46:45 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 21:46:45 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 21:46:45 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 21:46:45 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 21:46:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:46:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:46:45 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 21:46:45 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 21:46:45 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 21:46:45 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 21:46:45 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 21:46:45 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 21:46:46 INFO - Downloading docopt-0.6.1.tar.gz 21:46:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:46:46 INFO - Installing collected packages: blobuploader, requests, docopt 21:46:46 INFO - Running setup.py install for blobuploader 21:46:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:46:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:46:46 INFO - Running setup.py install for requests 21:46:46 INFO - Running setup.py install for docopt 21:46:46 INFO - Successfully installed blobuploader requests docopt 21:46:46 INFO - Cleaning up... 21:46:46 INFO - Return code: 0 21:46:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:46:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:46 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 0x7feae35f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16235a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b2410>, '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 0x16b3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b37a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1460864793.673689-597899995', '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 21:46:46 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 21:46:46 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 21:46:46 INFO - Using env: {'DISPLAY': ':0', 21:46:46 INFO - 'HOME': '/home/cltbld', 21:46:46 INFO - 'LANG': 'en_US.UTF-8', 21:46:46 INFO - 'LANGUAGE': 'en_US:en', 21:46:46 INFO - 'LOGNAME': 'cltbld', 21:46:46 INFO - 'MAIL': '/var/mail/cltbld', 21:46:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:46 INFO - 'MOZ_NO_REMOTE': '1', 21:46:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:46 INFO - 'NO_EM_RESTART': '1', 21:46:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:46 INFO - 'PWD': '/builds/slave/test', 21:46:46 INFO - 'SHELL': '/bin/bash', 21:46:46 INFO - 'SHLVL': '1', 21:46:46 INFO - 'TERM': 'linux', 21:46:46 INFO - 'TMOUT': '86400', 21:46:46 INFO - 'USER': 'cltbld', 21:46:46 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1460864793.673689-597899995', 21:46:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:46 INFO - '_': '/tools/buildbot/bin/python'} 21:46:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:46:46 INFO - Running setup.py (path:/tmp/pip-0FdOdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:46:47 INFO - Running setup.py (path:/tmp/pip-BcNPo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:46:47 INFO - Running setup.py (path:/tmp/pip-d5kys7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:46:47 INFO - Running setup.py (path:/tmp/pip-Th5S3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:46:47 INFO - Running setup.py (path:/tmp/pip-7ZG_CM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:46:47 INFO - Running setup.py (path:/tmp/pip-MAsUEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:46:47 INFO - Running setup.py (path:/tmp/pip-2p5iql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:46:47 INFO - Running setup.py (path:/tmp/pip-u9bnrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:46:47 INFO - Running setup.py (path:/tmp/pip-tfgjMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:46:47 INFO - Running setup.py (path:/tmp/pip-c9npt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:46:47 INFO - Running setup.py (path:/tmp/pip-woBuLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:46:47 INFO - Running setup.py (path:/tmp/pip-spGAhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:46:47 INFO - Running setup.py (path:/tmp/pip-41zh2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:46:47 INFO - Running setup.py (path:/tmp/pip-wcF4Er-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:46:48 INFO - Running setup.py (path:/tmp/pip-Q5UWJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:46:48 INFO - Running setup.py (path:/tmp/pip-HaN6nU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:46:48 INFO - Running setup.py (path:/tmp/pip-zFMZrq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:46:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:46:48 INFO - Running setup.py install for manifestparser 21:46:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:46:48 INFO - Running setup.py install for mozcrash 21:46:48 INFO - Running setup.py install for mozdebug 21:46:48 INFO - Running setup.py install for mozdevice 21:46:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:46:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:46:48 INFO - Running setup.py install for mozfile 21:46:48 INFO - Running setup.py install for mozhttpd 21:46:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:46:48 INFO - Running setup.py install for mozinfo 21:46:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:46:48 INFO - Running setup.py install for mozInstall 21:46:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:46:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:46:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:46:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:46:49 INFO - Running setup.py install for mozleak 21:46:49 INFO - Running setup.py install for mozlog 21:46:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:46:49 INFO - Running setup.py install for moznetwork 21:46:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:46:49 INFO - Running setup.py install for mozprocess 21:46:49 INFO - Running setup.py install for mozprofile 21:46:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:46:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:46:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:46:49 INFO - Running setup.py install for mozrunner 21:46:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:46:49 INFO - Running setup.py install for mozscreenshot 21:46:49 INFO - Running setup.py install for moztest 21:46:49 INFO - Running setup.py install for mozversion 21:46:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:46:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:46:49 INFO - Cleaning up... 21:46:50 INFO - Return code: 0 21:46:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:46:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:50 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 0x7feae35f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16235a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b2410>, '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 0x16b3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b37a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1460864793.673689-597899995', '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 21:46:50 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 21:46:50 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 21:46:50 INFO - Using env: {'DISPLAY': ':0', 21:46:50 INFO - 'HOME': '/home/cltbld', 21:46:50 INFO - 'LANG': 'en_US.UTF-8', 21:46:50 INFO - 'LANGUAGE': 'en_US:en', 21:46:50 INFO - 'LOGNAME': 'cltbld', 21:46:50 INFO - 'MAIL': '/var/mail/cltbld', 21:46:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:50 INFO - 'MOZ_NO_REMOTE': '1', 21:46:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:50 INFO - 'NO_EM_RESTART': '1', 21:46:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:50 INFO - 'PWD': '/builds/slave/test', 21:46:50 INFO - 'SHELL': '/bin/bash', 21:46:50 INFO - 'SHLVL': '1', 21:46:50 INFO - 'TERM': 'linux', 21:46:50 INFO - 'TMOUT': '86400', 21:46:50 INFO - 'USER': 'cltbld', 21:46:50 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1460864793.673689-597899995', 21:46:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:50 INFO - '_': '/tools/buildbot/bin/python'} 21:46:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:46:50 INFO - Running setup.py (path:/tmp/pip-wTZ2YH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:46:50 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)) 21:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:46:50 INFO - Running setup.py (path:/tmp/pip-lP0K47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:46:50 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)) 21:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:46:50 INFO - Running setup.py (path:/tmp/pip-HxCIa9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:46:50 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)) 21:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:46:50 INFO - Running setup.py (path:/tmp/pip-eFDc0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:46:50 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)) 21:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:46:50 INFO - Running setup.py (path:/tmp/pip-k0N9e8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:46:50 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)) 21:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:46:50 INFO - Running setup.py (path:/tmp/pip-GhJVV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:46:50 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)) 21:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:46:50 INFO - Running setup.py (path:/tmp/pip-6Ppc0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:46:50 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)) 21:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:46:50 INFO - Running setup.py (path:/tmp/pip-jNH9tc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:46:50 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)) 21:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:46:50 INFO - Running setup.py (path:/tmp/pip-gps_Ii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:46:50 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)) 21:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:46:50 INFO - Running setup.py (path:/tmp/pip-JTnKns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:46: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)) 21:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:46:50 INFO - Running setup.py (path:/tmp/pip-88KDxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:46:51 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)) 21:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:46:51 INFO - Running setup.py (path:/tmp/pip-6vsHjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:46:51 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)) 21:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:46:51 INFO - Running setup.py (path:/tmp/pip-GuTcxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:46:51 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)) 21:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:46:51 INFO - Running setup.py (path:/tmp/pip-Cwxq9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:46:51 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)) 21:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:46:51 INFO - Running setup.py (path:/tmp/pip-6ncJP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:46:51 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)) 21:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:46:51 INFO - Running setup.py (path:/tmp/pip-u3sSQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:46:51 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)) 21:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:46:51 INFO - Running setup.py (path:/tmp/pip-ewlNjB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:46:51 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)) 21:46:51 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)) 21:46:51 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)) 21:46:51 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)) 21:46:51 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)) 21:46:51 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)) 21:46:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:53 INFO - Downloading blessings-1.6.tar.gz 21:46:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:46:53 INFO - Installing collected packages: blessings 21:46:53 INFO - Running setup.py install for blessings 21:46:53 INFO - Successfully installed blessings 21:46:53 INFO - Cleaning up... 21:46:53 INFO - Return code: 0 21:46:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:46:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:46:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:46:53 INFO - Reading from file tmpfile_stdout 21:46:53 INFO - Current package versions: 21:46:53 INFO - argparse == 1.2.1 21:46:53 INFO - blessings == 1.6 21:46:53 INFO - blobuploader == 1.2.4 21:46:53 INFO - docopt == 0.6.1 21:46:53 INFO - manifestparser == 1.1 21:46:53 INFO - mozInstall == 1.12 21:46:53 INFO - mozcrash == 0.17 21:46:53 INFO - mozdebug == 0.1 21:46:53 INFO - mozdevice == 0.48 21:46:53 INFO - mozfile == 1.2 21:46:53 INFO - mozhttpd == 0.7 21:46:53 INFO - mozinfo == 0.9 21:46:53 INFO - mozleak == 0.1 21:46:53 INFO - mozlog == 3.1 21:46:53 INFO - moznetwork == 0.27 21:46:53 INFO - mozprocess == 0.22 21:46:53 INFO - mozprofile == 0.28 21:46:53 INFO - mozrunner == 6.11 21:46:53 INFO - mozscreenshot == 0.1 21:46:53 INFO - mozsystemmonitor == 0.0 21:46:53 INFO - moztest == 0.7 21:46:53 INFO - mozversion == 1.4 21:46:53 INFO - psutil == 3.1.1 21:46:53 INFO - requests == 1.2.3 21:46:53 INFO - wsgiref == 0.1.2 21:46:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:46: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')]} 21:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46: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')]} 21:46:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:53 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 0x7feae35f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16235a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b2410>, '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 0x16b3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b37a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1460864793.673689-597899995', '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 21:46:53 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 21:46:53 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 21:46:53 INFO - Using env: {'DISPLAY': ':0', 21:46:53 INFO - 'HOME': '/home/cltbld', 21:46:53 INFO - 'LANG': 'en_US.UTF-8', 21:46:53 INFO - 'LANGUAGE': 'en_US:en', 21:46:53 INFO - 'LOGNAME': 'cltbld', 21:46:53 INFO - 'MAIL': '/var/mail/cltbld', 21:46:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:53 INFO - 'MOZ_NO_REMOTE': '1', 21:46:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:53 INFO - 'NO_EM_RESTART': '1', 21:46:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:53 INFO - 'PWD': '/builds/slave/test', 21:46:53 INFO - 'SHELL': '/bin/bash', 21:46:53 INFO - 'SHLVL': '1', 21:46:53 INFO - 'TERM': 'linux', 21:46:53 INFO - 'TMOUT': '86400', 21:46:53 INFO - 'USER': 'cltbld', 21:46:53 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1460864793.673689-597899995', 21:46:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:53 INFO - '_': '/tools/buildbot/bin/python'} 21:46:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:54 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)) 21:46:54 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)) 21:46:54 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)) 21:46:54 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)) 21:46:54 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)) 21:46:54 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)) 21:46:54 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)) 21:46:54 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)) 21:46:54 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)) 21:46:54 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)) 21:46:54 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)) 21:46:54 INFO - Cleaning up... 21:46:54 INFO - Return code: 0 21:46:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feae35f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16235a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b2410>, '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 0x16b3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b37a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1460864793.673689-597899995', '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 21:46:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:46:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:46:54 INFO - Using env: {'DISPLAY': ':0', 21:46:54 INFO - 'HOME': '/home/cltbld', 21:46:54 INFO - 'LANG': 'en_US.UTF-8', 21:46:54 INFO - 'LANGUAGE': 'en_US:en', 21:46:54 INFO - 'LOGNAME': 'cltbld', 21:46:54 INFO - 'MAIL': '/var/mail/cltbld', 21:46:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:54 INFO - 'MOZ_NO_REMOTE': '1', 21:46:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:54 INFO - 'NO_EM_RESTART': '1', 21:46:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:54 INFO - 'PWD': '/builds/slave/test', 21:46:54 INFO - 'SHELL': '/bin/bash', 21:46:54 INFO - 'SHLVL': '1', 21:46:54 INFO - 'TERM': 'linux', 21:46:54 INFO - 'TMOUT': '86400', 21:46:54 INFO - 'USER': 'cltbld', 21:46:54 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1460864793.673689-597899995', 21:46:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:54 INFO - '_': '/tools/buildbot/bin/python'} 21:46:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:54 INFO - Downloading/unpacking jsonschema 21:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:46:56 INFO - Downloading/unpacking functools32 (from jsonschema) 21:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:56 INFO - Downloading functools32-3.2.3-2.tar.gz 21:46:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:46:56 INFO - warning: no files found matching '*.txt' 21:46:56 INFO - no previously-included directories found matching 'build' 21:46:56 INFO - no previously-included directories found matching 'dist' 21:46:56 INFO - no previously-included directories found matching '.git*' 21:46:56 INFO - Installing collected packages: jsonschema, functools32 21:46:56 INFO - Running setup.py install for functools32 21:46:56 INFO - warning: no files found matching '*.txt' 21:46:56 INFO - no previously-included directories found matching 'build' 21:46:56 INFO - no previously-included directories found matching 'dist' 21:46:56 INFO - no previously-included directories found matching '.git*' 21:46:56 INFO - Successfully installed jsonschema functools32 21:46:56 INFO - Cleaning up... 21:46:56 INFO - Return code: 0 21:46:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 21:46:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feae35f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16235a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b2410>, '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 0x16b3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b37a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1460864793.673689-597899995', '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 21:46:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 21:46:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 21:46:56 INFO - Using env: {'DISPLAY': ':0', 21:46:56 INFO - 'HOME': '/home/cltbld', 21:46:56 INFO - 'LANG': 'en_US.UTF-8', 21:46:56 INFO - 'LANGUAGE': 'en_US:en', 21:46:56 INFO - 'LOGNAME': 'cltbld', 21:46:56 INFO - 'MAIL': '/var/mail/cltbld', 21:46:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:56 INFO - 'MOZ_NO_REMOTE': '1', 21:46:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:56 INFO - 'NO_EM_RESTART': '1', 21:46:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:56 INFO - 'PWD': '/builds/slave/test', 21:46:56 INFO - 'SHELL': '/bin/bash', 21:46:56 INFO - 'SHLVL': '1', 21:46:56 INFO - 'TERM': 'linux', 21:46:56 INFO - 'TMOUT': '86400', 21:46:56 INFO - 'USER': 'cltbld', 21:46:56 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1460864793.673689-597899995', 21:46:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:56 INFO - '_': '/tools/buildbot/bin/python'} 21:46:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:56 INFO - Downloading/unpacking flake8 21:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:46:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:46: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 21:46: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 21:46: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 21:46: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 21:46: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 21:46: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 21:46:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:46:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:46: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 21:46: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 21:46: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 21:46: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 21:46: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 21:46: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 21:46:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 21:46:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:46:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:46:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:46:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:46:59 INFO - no previously-included directories found matching 'docs/_build' 21:46:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:46:59 INFO - Running setup.py install for pep8 21:46:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:46:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:46:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:46:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:46:59 INFO - no previously-included directories found matching 'docs/_build' 21:46:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 21:46:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:46:59 INFO - Cleaning up... 21:46:59 INFO - Return code: 0 21:46:59 INFO - Running post-action listener: _resource_record_post_action 21:46:59 INFO - Running post-action listener: _start_resource_monitoring 21:46:59 INFO - Starting resource monitoring. 21:46:59 INFO - ##### 21:46:59 INFO - ##### Running install step. 21:46:59 INFO - ##### 21:46:59 INFO - Running pre-action listener: _resource_record_pre_action 21:46:59 INFO - Running main action method: install 21:46:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:46:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:46:59 INFO - Reading from file tmpfile_stdout 21:46:59 INFO - Detecting whether we're running mozinstall >=1.0... 21:46:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:46:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:47:00 INFO - Reading from file tmpfile_stdout 21:47:00 INFO - Output received: 21:47:00 INFO - Usage: mozinstall [options] installer 21:47:00 INFO - Options: 21:47:00 INFO - -h, --help show this help message and exit 21:47:00 INFO - -d DEST, --destination=DEST 21:47:00 INFO - Directory to install application into. [default: 21:47:00 INFO - "/builds/slave/test"] 21:47:00 INFO - --app=APP Application being installed. [default: firefox] 21:47:00 INFO - mkdir: /builds/slave/test/build/application 21:47:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:47:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:47:15 INFO - Reading from file tmpfile_stdout 21:47:15 INFO - Output received: 21:47:15 INFO - /builds/slave/test/build/application/firefox/firefox 21:47:15 INFO - Running post-action listener: _resource_record_post_action 21:47:15 INFO - ##### 21:47:15 INFO - ##### Running run-tests step. 21:47:15 INFO - ##### 21:47:15 INFO - Running pre-action listener: _resource_record_pre_action 21:47:15 INFO - Running main action method: run_tests 21:47:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:47:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:47:15 INFO - Python 2.7.3 21:47:15 INFO - Return code: 0 21:47:15 INFO - grabbing minidump binary from tooltool 21:47:15 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')]} 21:47:15 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 0x16b2410>, '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 0x16b3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b37a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:47:15 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 21:47:15 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 21:47:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:47:16 INFO - Return code: 0 21:47:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:47:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:47:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:47:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:47:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:47:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 21:47:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 21:47:17 INFO - Return code: 0 21:47:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ItEmY08LT0qOSumJOEWNXA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 21:47:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ItEmY08LT0qOSumJOEWNXA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --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 21:47:17 INFO - Using env: {'DISPLAY': ':0', 21:47:17 INFO - 'HOME': '/home/cltbld', 21:47:17 INFO - 'LANG': 'en_US.UTF-8', 21:47:17 INFO - 'LANGUAGE': 'en_US:en', 21:47:17 INFO - 'LOGNAME': 'cltbld', 21:47:17 INFO - 'MAIL': '/var/mail/cltbld', 21:47:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:47:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:47:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:17 INFO - 'MOZ_NO_REMOTE': '1', 21:47:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:47:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:47:17 INFO - 'NO_EM_RESTART': '1', 21:47:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:47:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:17 INFO - 'PWD': '/builds/slave/test', 21:47:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:47:17 INFO - 'SHELL': '/bin/bash', 21:47:17 INFO - 'SHLVL': '1', 21:47:17 INFO - 'TERM': 'linux', 21:47:17 INFO - 'TMOUT': '86400', 21:47:17 INFO - 'USER': 'cltbld', 21:47:17 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1460864793.673689-597899995', 21:47:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:17 INFO - '_': '/tools/buildbot/bin/python'} 21:47:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ItEmY08LT0qOSumJOEWNXA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 21:47:17 INFO - mozversion application_buildid: 20160416205825 21:47:17 INFO - mozversion application_changeset: 8997f9366f6be67b5ac4c7f2708969549dd29875 21:47:17 INFO - mozversion application_display_name: Nightly 21:47:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:47:17 INFO - mozversion application_name: Firefox 21:47:17 INFO - mozversion application_remotingname: firefox 21:47:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:47:17 INFO - mozversion application_vendor: Mozilla 21:47:17 INFO - mozversion application_version: 48.0a1 21:47:17 INFO - mozversion platform_buildid: 20160416205825 21:47:17 INFO - mozversion platform_changeset: 8997f9366f6be67b5ac4c7f2708969549dd29875 21:47:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:47:17 INFO - mozversion platform_version: 48.0a1 21:47:17 INFO - using testdate: 1460868437 21:47:17 INFO - actual date: 1460868437 21:47:17 INFO - starting webserver on 'localhost:42370' 21:47:17 INFO - SUITE-START | Running 2 tests 21:47:17 INFO - TEST-START | dromaeo_css 21:47:17 INFO - operating with platform_type : linux_ 21:47:17 INFO - Initialising browser for dromaeo_css test... 21:47:17 INFO - TEST-INFO | started process 3310 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNb5X1f/profile http://localhost:42370/getInfo.html) 21:47:22 INFO - PROCESS | 3310 | __metrics Screen width/height:1600/1200 21:47:22 INFO - PROCESS | 3310 | colorDepth:24 21:47:22 INFO - PROCESS | 3310 | Browser inner width/height: 1024/697 21:47:22 INFO - PROCESS | 3310 | __metrics 21:47:24 ERROR - PROCESS | 3310 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 21:47:25 INFO - TEST-INFO | 3310: exit 0 21:47:25 INFO - Browser initialized. 21:47:25 INFO - Running cycle 1/1 for dromaeo_css test... 21:47:25 INFO - TEST-INFO | started process 3394 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNb5X1f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:47:37 INFO - PROCESS | 3394 | RSS: Main: 154427392 21:47:37 INFO - PROCESS | 3394 | 21:48:28 INFO - PROCESS | 3394 | 1460868508654 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] 21:50:40 INFO - PROCESS | 3394 | Cycle 1(1): loaded http://localhost:42370/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42370/tests/dromaeo/cssquery-ext.html) 21:50:41 INFO - PROCESS | 3394 | RSS: Main: 238977024 21:50:41 INFO - PROCESS | 3394 | 21:53:43 INFO - PROCESS | 3394 | Cycle 1(1): loaded http://localhost:42370/tests/dromaeo/cssquery-ext.html (next: http://localhost:42370/tests/dromaeo/cssquery-jquery.html) 21:53:44 INFO - PROCESS | 3394 | RSS: Main: 235520000 21:53:44 INFO - PROCESS | 3394 | 21:56:46 INFO - PROCESS | 3394 | Cycle 1(1): loaded http://localhost:42370/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42370/tests/dromaeo/cssquery-mootools.html) 21:56:47 INFO - PROCESS | 3394 | RSS: Main: 236359680 21:56:47 INFO - PROCESS | 3394 | 21:59:49 INFO - PROCESS | 3394 | Cycle 1(1): loaded http://localhost:42370/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42370/tests/dromaeo/cssquery-prototype.html) 21:59:49 INFO - PROCESS | 3394 | RSS: Main: 229281792 21:59:49 INFO - PROCESS | 3394 | 22:02:52 INFO - PROCESS | 3394 | Cycle 1(1): loaded http://localhost:42370/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42370/tests/dromaeo/cssquery-yui.html) 22:02:53 INFO - PROCESS | 3394 | RSS: Main: 219668480 22:02:53 INFO - PROCESS | 3394 | 22:05:56 INFO - PROCESS | 3394 | Cycle 1(1): loaded http://localhost:42370/tests/dromaeo/cssquery-yui.html (next: http://localhost:42370/tests/dromaeo/cssquery-dojo.html) 22:05:56 INFO - PROCESS | 3394 | RSS: Main: 254558208 22:05:56 INFO - PROCESS | 3394 | 22:05:56 INFO - PROCESS | 3394 | __start_tp_report 22:05:56 INFO - PROCESS | 3394 | _x_x_mozilla_page_load 22:05:56 INFO - PROCESS | 3394 | _x_x_mozilla_page_load_details 22:05:56 INFO - PROCESS | 3394 | |i|pagename|runs| 22:05:56 INFO - PROCESS | 3394 | |0;dojo.html;2594.221733479956;2657.614645876349;2660.7206243344435;2679.1560658392605;2693.2189664997145;4562.703424277428;4601.263797792354;4631.35161077449;4641.118187544364;4652.511486293941;4680.485146633868;4696.506866778982;4731.290306454025;4807.543283388081;4809.687370320936;4269.316909294514;4281.079567892894;4356.128774245164;4386;4462.821487140511;4375.387445757597;4413.0732546165345;4426.535213802553;4428.689991700582;4458.197524445599;4129.15352352767;4226.788660566959;4239.27932251518;4266.4240327556;4298.935515967263;4255.468066491689;4288.76411797351;4297.763623000734;4305.526392096866;4354.847580334705;4267.347315210385;4286.464191976003;4294.26997410441;4312.310030395153;4321.222180007598;4427.114577084564;4558.817647294104;4598.517155698637;4641.559051890065;4652.744099074584;4977.253411988195;4992.575631071363;4992.650514463989;5009.699418034893;5048.116579598555;4821.975890120562;5024.422191447957;5030.647854650176;5039.92440113395;5041.823536176253;4628.560286772751;4682.976585117052;4687.039156972813;4723.126221648971;4732.976335118371;5101.362329708786;5132.640715149903;5134.101532231844;5137.743112844343;5191.195364718475;4609.055143695535;4915.238138088531;4919.409670839522;4923.606111511071;4932.975335123373;4968.577670898014;4973.90052198954;4989.077020751172;5021.372328458942;5038.496150385005;4916.606671466274;4936.259561065869;4955.4301255356095;4955.529224723718;4999.400071991385;4747.738874361874;4860.708357498562;4927.90144197114;4928.162212423897;4967.428745694219;4206.978965105155;4212.49450065994;4220.155968806251;4236.830526778895;4237.957620423818;3673.6142705015586;3705.518282623296;3710.9814450927574;3731.832067556912;3751.174741556853;4145.17096580685;4219.810108545123;4274.935875961863;4282.550332215135;4370.082282720664;5023.447420783711;5048.343715316985;5049.495050494995;5052.141136006888;5057.241413787961;4314.482262128565;4316.2446571849805;4317.654587632982;4339.132173565299;4366.934495982563;4364.5635436456105;4470.932936005963;4482.193205223026;4513.300438432048;4559.680822342404;4720.339152518719;4720.433547974265;4735.905281894412;4751.382320298339;4779.3070004848405;5008.724520151281;5014.52362025607;5022.096022715946;5024.145895197752;5075.0357432087785;4609.423822022247;4720.598749106364;4742.739149346819;4746.477887432448;4793.23308270675;4899.877503062452;4911.950880491149;4940.061388336205;4946.1838796599595;4993.076280888047;4782.760861956818;4963.776630051729;4988.775505102207;5005.599552035756;5066.341375621146;4792.496787837227;4854.053459575349;4867.951320486892;4890.951090489049;4911.7298548580175;4758.428988521399;4799.688020278671;4810.062037902575;4813.9037219256115;4853.878653033561;4619.86140415788;4729.266963620645;4746.311784791255;4791.544803243686;4792;4872.317875497362;4896.4124305083615;4899.485554016919;4904.215325547895;4946.604271658187;4779.904401912012;4779.928301075417;4791.113643975876;4794.089123066607;4839.927401089057 22:05:56 INFO - PROCESS | 3394 | |1;ext.html;580.9273840769904;593.350281441821;602.4547784255249;619.2135987296134;623.2645478335565;26793.4641307174;27059.458810823773;27118.372897626108;27484.725152748466;27492;27362.315942101457;34010.48984265232;35157.2968540629;35245;35279.64720352796;7577.090749110114;7750.961245193795;7753.379729621617;7754.06951165858;7755.612219389036;7492.100947886262;7566.546007239584;7660.195679453661;9729.659461918834;10155.593776248941;9785.951070244639;9923.057309555617;9926.9503652482;9928.205743540535;9929.90070099297;9615.42307461551;9668.323217374787;9745.269104817096;9754.561044753003;9761.707148785583;7281.854362912765;9566.712998610054;9575.664851730156;9970.351927124713;9980.800383992351;34269.657303426895;34881.47677784835;35007.29985400278;35133.6486635133;35152.824235878914;3199.2961548459302;3232.6120865496055;3238.2875767331147;3260.136063943057;3567.2384346922054;26760.19719408421;27066.323341916413;27395.08234423591;27468.17595472139;27580.586291205647;3461.44616861301;3502.141975216088;3536.840842162083;3558.5195998540385;3587.587427445851;231792;234389.7646652962;236969.81515092487;238607;239183;53214.73392633012;53600.19599706007;53680;53680;53693;56196.71901640548;56402.871942560916;56425.43574564202;56443.35566443405;56493;14847.70304593902;15322.846771532364;15346.846531534766;15388.153651549048;15391.153486558347;11545.307281563133;11586.652400428;11609.593664221711;11618.6514404568;11623.302601843916;13612.591622251348;14224.217668028357;15234.619134521505;16196.514104576881;16271.349146034026;5809.738561764731;5990.64056156632;6159.353267906895;6220.564560480723;6220.688965551704;933.5192375926404;985.3595163143871;995.4918298777358;999.9700008999741;1014.60937539048;28605;28627.2843178918;28867.42265154685;29138.708612914023;29227.123186304445;980.9792964863949;1003.9548220330103;1011.3780025284544;1058.222206678091;1073.7315671082229;14933.477328293458;15397.538073857802;15399.92200545951;15473;15657.451989180325;336957;339959;340639;341632;341673;42909;47472.62636868212;49110.508894911305;49170.75414622904;49195.754021229666;1148.5807680196667;1253.7304479536942;1256.447163248168;1260.9243445393306;1282.0897163014179;24880.75119248784;25609.871950640874;27895.964555622282;28239.29401764972;28252.43495130127;40354.1929161421;40637.39043914403;40950.18099637931;41107.7944610275;41190.1761964765;248317;250080;250186;250360;250618;34058.65941340654;34128.48807267943;35059.47410788891;35122;35136;33003.504947426285;35012.64987350094;36161.095972600895;36666.45000325051;40793.79603101966;30083.398332033674;30837.537436938015;31198.22004449907;31458.213544661565;32120;33656.32687346288;33888.83055584805;34092.31815363729;34370.48444273288;34625.48061779025;34113.31773364469;34331.485027724106;34642.48036279508;35152.12119697028;35550.288994220486;30568.401685856952;31035;31362.215944600655;31399;31414.842925785226;23819.523609527365;24525.877370613034;24539;24650.506989859743;24724 22:05:56 INFO - PROCESS | 3394 | |2;jquery.html;354.7623092528006;382.70722896983796;386.2892278208097;386.43387437404203;399.04229848363923;12262.509499620015;15492;16044.518664440086;16183.109928953903;16217.513474595751;15251.500807261857;15666.373345066184;16203.918980405111;16750.413735519258;16750.58123546912;4480.587097733912;5088.287639730441;5181;5240.240165176047;5252.474752524755;3663.120850995755;5635.154726790973;5960.701964901759;5970.104484327342;5980.700964951757;5671.914921276184;5923.466887980081;5923.703814809264;5945.405459454063;5947.434993675594;5972;5993.220881285449;6015.127806468081;6027.758889644409;6028.698565071751;4957.380327459067;5129.615278854101;5140.203268493389;5278.155495120763;5287;19615;19888.303909363247;19986;20077;20145.697814532792;1898.0984032584413;1899.164367678217;1938.9515262118418;2001.7097520859393;2004.0280463975107;12751.298678572675;12885.355732213351;12900.290484023375;12949.611511654666;13351.933240333736;1840.6962851129547;1878.8496920246484;1887.6696578098915;1905.9237630494763;1906.8093190680959;64578.67710661464;64936.67531662359;65587;66425;66758;9482;9576.95211523952;9606.135447809731;9711.611535538499;9871.901280987242;13433.798493022612;13626.591202263948;13642.931785341209;13656.863431365558;13674.93162534201;7248.528845625123;7298.197198308182;7393.519421237603;7457.755876193873;7496.175420703718;6958.860822783516;7002.3697867192195;7033.788986330418;7042.718291268292;7120.430365570742;5989.970050149721;6091.299500557404;6159.384061593805;6223.315435302204;6330.778422755181;1626.6014826367616;1727.3263427263378;1800.7839059312705;1823.0981793734893;1833.7432759413693;911.4986757283467;977.8630991661173;1008.7982403519326;1016.3749294184023;1042.166266986408;15626.45307414235;15978.76031859523;16028.919855400649;16985.757995555057;17255.137243137793;880.0715245416147;884.1644645809777;893.6827426263583;896.5875697179371;897.6902968475865;9020.14308640678;9056.909430905738;9192.586333615003;9284.907150928539;9318.161365477004;297787;303094;420945;424434;424857;79443.60278198573;81231;82313;82535.17464825395;82802.58598707088;978.4422878958925;990.7721224118493;1002.7192386131894;1006.8540061691014;1009.8586197932295;14682.069954099921;14916.776248356065;15230.923845380703;15235.695286094438;15350.23248837576;34337.828310858284;34457.827710862286;34549.827250863586;34925.47611785876;35061.29877402489;47330;48134.277985830944;49760;49779;49888;7272.23641517633;7311.744088956861;7314.122305323395;7420.6289685516585;7451.031365922396;9382.903641798326;10478.37129772216;10582;10770.784584308114;10908.127349811837;9225.21585665226;9439.905600944177;9513.33406661527;9530.761730956781;9602.231821454126;9078.182963533314;9090.13643703847;9219.677311294072;9401;9661.372010819556;9092.22716069115;9429.62281508732;9590.712278631652;9830.164436023018;9938.602455901972;6998.6850591724515;7240.8913866290995;7318.743843965436;7341.706331746884;7456.7762967111075;8866.689665861664;9397.859032114387;9527.546540043279;9601;9705.854412183682 22:05:56 INFO - PROCESS | 3394 | |3;mootools.html;1147.6327575175947;1403.522802247236;1465.311303687267;1565.9608509787254;1758.5691505581126;7539.095308562966;7775.222477752222;7805.531668099911;7805.960970195149;7811.765647030584;7562.810929726759;7732.574708391036;7741.57421341826;7745.690172393111;7757.922420775791;2160.7407111146686;2176.662617294314;2186.30038387716;2190.37574291327;2191.7041199438113;2166.523364859728;2199.417154454071;2204.856684315522;2223.5886361023263;2225.9777402226014;2197;2203.856749311298;2210.8673479591275;2211.7677643847405;2258.9322320330334;2137.4122116417952;2137.850350475467;2148.4414052346424;2149.2262785397243;2150.731158605174;2147.2591955775233;2188.059134572133;2190.2772085212;2191.4411824984527;2191.605511008018;7629.427792915498;7802.843943121163;7836.059672839238;7847.293743563049;7883.8029049273655;4666.39336886206;4797.40032495938;4798.880027999293;4802.639802014828;4815.614750819961;3061.6479104902774;3074.108508532523;3129.405412971528;3131.85906634202;3149.8582563784685;922.5710044829186;934.2059249637822;960.279790157382;965.4014511003153;999.5951639585979;10794.78410431787;10795.514201860935;10877.07544858688;10893.455327233685;10947.671569852917;4151.315033019579;4194.979025104855;4237.216115018731;4310.89222769427;4315.956840431619;8660.13398660129;8686.695965641173;8708.390412671179;8713.344464551716;8722.127787221354;4587.220172570671;4629.074185162981;4629.398178236875;4632.235681112578;4634.21218392874;3751.4747935289083;3960.108975480494;4253.106847561985;4263.59495847894;4317.050248945227;3497.755157138976;3502.1069627244888;3511.9122021949656;3529.3823580873245;3641.9453708194396;1078.9082927951056;1079.3955384984433;1082.815921293382;1083.2796190533206;1095.8191898336686;764.9923500764921;804.7867315161487;881.8104107616894;908.3913777768779;921.074320308086;5369.3556773187465;5526.613137080446;5664.575156863251;5742.913856292159;5951.315598706205;943.7499062748377;950.695777351241;964.064857088623;1009.9397229651576;1019.1846522781744;3726.571444283888;3744.513213282256;3766.886993390203;3835.328817456934;3975.582563830814;9368.203702685212;9628.518574071268;9719.125278724949;9761.36551124189;9790.06994335537;9655.420674759536;9662.08210220028;9668.661596844076;9670.081342272473;9707.854382184272;7267.236940121317;7409.147947985943;7432.033835601445;7438.888416673754;7442.479026468095;5545.833624991256;5551.500364967173;5552.555795536428;5571.3871474137;5770.740316685843;8862.246709029805;9011.369204155646;9188.908110918805;9198.080191980749;9206.493642849708;8471.364647651328;8850.247728943112;8937;8938.10618938101;9174.357794954289;6201.224846894138;6701.899471508029;6936.445084393337;6947.305269473012;6961.477889158435;7391.1869694334655;7395.852082958419;7437;7439;7477.4765766398;6632.767853125118;6858;6898.8620227594165;6951.9652401739695;7028.191757947901;6377.426031657174;6444.097826304415;6536.7712130075215;6564;6574.934250657432;6386.16979792624;6395;6466.482681385572;6530.314316996837;6551;4830.951690483191;4977.950220497749;4978.153713868724;5028.798848046184;5081.4918508148885;4867.5132486751045;4898.118338699069;4898.21628539432;4940.407151141886;4943.950560494349 22:05:56 INFO - PROCESS | 3394 | |4;prototype.html;312.07936587068156;315.67958522100065;323.15656137481153;323.79762648344786;326.45645001073217;4940.8023679052885;5082.08522465956;5084.0594490019375;5128.923066154006;5175.275461435397;4866.878328041801;5032.4967503249745;5066;5066.923996140061;5093.643444958845;4020.376841589551;4044.716869819114;4045.2314060328445;4050;4062.1361939832495;3774.886753397389;3876.282887665777;4053.9189216215805;4054.6958978076764;4064.5732198119217;3859.8456061757497;3964.425158352037;3970.2655008823317;4008.879733607982;4025.1547175093265;3974.9006274843073;3994.940075898878;4004.3593025116134;4023.718339716221;4030.8387664493384;3568.928621427583;3574.517440145573;3584.551931008624;3584.7132229421845;3591.838367273479;4798.328234047236;4860.1737704590305;4880.048390563841;4886.438059623153;4889.144399730033;4589.931151032737;4595.586397224266;4601.102784956935;4611.354410382549;4612.215923293048;5341.6527925685095;5347.278117454132;5353.9196912046355;5357;5362.624616276862;3786.905327366838;3826.521684789401;3897.4543563901075;3904.7657140571373;3904.809033244859;5591.776328946838;5603.943960560383;5606.187102870102;5607.971960140173;5615.241942337773;4011.8194681239415;4020.075382662004;4021.3967904814513;4021.8190181441905;4021.959780402217;3985.242803867256;4067.91864162721;4072.063425412172;4079.6124368184974;4087.959120408758;4563.155816174019;4585.197590421662;4592.494825569184;4600.332951722048;4607.9078418431445;5334.67991920486;5338.156527300338;5362.3565172178805;5373.2746079278795;5382.730863456812;1339.8459177194552;1368.555219553629;1403.8175037245094;1419.8296204455532;1421.9217943013234;959.7408699651055;967.1827305926481;982.4056445850158;988.4859872866069;991.5736233419699;4621.953780462152;4643.535646435329;4669.299605059268;4677.924077462203;4689.320048592935;5440.129579267298;5449.809256676077;5454.3454785426;5466;5479.616426850162;4514.345419914094;4649.140343862482;4655.883602909955;4659.743714095689;4665.346851440801;2908.1130255271923;2928.531434970437;2928.853557322125;2939.808912420686;2943.9116826495238;5179.896402071938;5197.064528384927;5208.817691380784;5212.817551385683;5213.296205012275;5386.730663466811;5589.329280486287;5613.7193140342815;5614.101743721067;5637.718114094361;5154.845354639367;5162.141629013552;5170.793168273227;5171.63798534099;5184.170532714747;5443.59173062014;5478.616496845342;5483.464629903633;5484.502707779582;5502.889942201214;5239.066122971149;5352.798053527962;5378.327709036371;5399.730013499231;5402.027635025576;5156.5616922562;5169.431362550041;5175.8095638002715;5177.326947496801;5178.482151784791;4002;4006.4991876015497;4008.559058503504;4012.5586185518987;4013.337799263089;5232.7645255964335;5370.865728356823;5373.650712703662;5465.535429488538;5469.15228139639;5200.583953283804;5359.3032905722;5364.3830959440165;5368.516833485005;5377.435369286325;5316.441773613715;5339.279197308314;5351.929614077278;5355.598330125178;5357.812476563302;4789.0125597876495;5028.421731500778;5226.477352264743;5273.34083239595;5310.230016647642;5357.678539287655;5368.221607866915;5388.595855310789;5394.838154855361;5413.648112872651;5230.424653288212;5259.684418934876;5272.657277277118;5287.391949925808;5302.70835104073 22:05:56 INFO - PROCESS | 3394 | |5;yui.html;769.361430013089;774.4269240761838;789.1358961936677;793.2107552984785;807.2129673568272;11820.468078936447;12059.4573244204;12081;12084;12101.697457563554;12312.692182695437;12343.938280308608;12344.506219751222;12360.629181124557;12364.567240146596;642.8135840606219;783.1385475976438;803.3613277444431;814.340384288728;821.1337039423406;805.0540614777613;809.0695699945052;811.6550466051934;813.1096449387911;813.6785969542027;851.676362982069;858.2747578296361;860.0968982568278;860.2257967828941;860.9182127697859;675.4528831646358;818.9672413103468;841.2849078283472;842.296682270305;843.4770442325797;619.7087368936593;620.1937481274371;621.5338496127904;621.6953692690595;622.315453001699;12792.232466052066;12817.295048772314;12830.358482075859;12832.80750788739;12840.165389249669;12288;12572.245665260023;12663.873361266362;12885.162464439874;12972.481100755958;10193.694189174337;10341.9482902585;10409.68770936873;10409.739756506147;10424.843627345595;3357.2781851901714;3431.6396778338167;3440.776349537272;3450.8447119879665;3516.4373700207843;46414.999999999665;46486;46744.298835517155;46818.5318146821;46824.5317546827;9908.65319713821;10164.847527287096;10246.6413675521;10276.948615256875;10293.433861137559;18171.63656726858;18360.265589376275;18398.540036499195;18404.723929141073;18431.07844607764;6777.72889084441;6785.423239024738;6848.965755171292;6855.07456493377;7073.186583542958;3736.4021756518828;3809.276237514863;3826.598207188205;3851.807409629507;3875.767453952772;2919.6496420429685;3007.188059224041;3015.1406849048353;3016.1856298799203;3016.6832482589452;443.8318812600406;541.4639506888152;554.8807006493623;556.1629747230473;573.761888816145;613.2640831002815;657.3623585122424;660.7026837922954;663.741140955028;667.7796327212009;7652.349550288177;7697.422028484148;7932.524048557105;8185.95907020473;8194.139615340422;595.4700316718124;602.57518449493;619.1301221783401;620.3393386043939;624.2041397218583;3772.641599048086;3835.463035175078;3877.86427475037;3898.629630185128;3906.9609303907164;51213;52398.344531893956;52458.21312680313;52577.211341829905;52607.47392526102;47464.7626761864;47491.762541187076;48248.7587562067;48329.27506087411;49214;37189.81405092957;38453.80773096173;43492.78253608775;43744.125117497475;44043.55956440459;8193.221643943816;8344.290735287326;8360.331173506227;8395;8479.576021199038;26868.865655671598;27124.1862744118;27606.309842254104;27670;27864.303392415353;34503.309933801684;36920.26159476742;37311.81344093262;38657.613423865405;39174.21651566896;10806.596701649176;10881.129509639051;10936.070434013198;10946.452677366258;11118.722031949266;11617.5352985883;11653.59212427561;11750.823737643772;12109.75780484403;12539.435725392197;11091;11307.886921131012;11363.659090227306;11626;11934.4032798358;10945.726356841144;11000.669979900616;11393.316401015965;11495.367754773568;11576;11153.888461115284;11167.218294719292;11220.831687524531;11654.125940554322;11985.400729963641;9373.768414541206;9478.668246611336;9711.708648740549;9852.458114803754;10001.649942251986;9574.521273936414;9880.802383952137;9891.901080989099;9925.205983521157;9997.20022398192 22:05:56 INFO - PROCESS | 3394 | __end_tp_report 22:05:56 INFO - PROCESS | 3394 | __start_cc_report 22:05:56 INFO - PROCESS | 3394 | _x_x_mozilla_cycle_collect,854 22:05:56 INFO - PROCESS | 3394 | __end_cc_report 22:05:56 INFO - PROCESS | 3394 | __startTimestamp1460869556335__endTimestamp 22:05:56 INFO - PROCESS | 3394 | 22:05:56 INFO - PROCESS | 3394 | ------- Summary: start ------- 22:05:56 INFO - PROCESS | 3394 | Number of tests: 6 22:05:56 INFO - PROCESS | 3394 | 22:05:56 INFO - PROCESS | 3394 | [#0] dojo.html Cycles:165 Average:4614.26 Median:4746.31 stddev:474.82 (10.0%) stddev-sans-first:449.05 22:05:56 INFO - PROCESS | 3394 | Values: 2594.2 2657.6 2660.7 2679.2 2693.2 4562.7 4601.3 4631.4 4641.1 4652.5 4680.5 4696.5 4731.3 4807.5 4809.7 4269.3 4281.1 4356.1 4386.0 4462.8 4375.4 4413.1 4426.5 4428.7 4458.2 4129.2 4226.8 4239.3 4266.4 4298.9 4255.5 4288.8 4297.8 4305.5 4354.8 4267.3 4286.5 4294.3 4312.3 4321.2 4427.1 4558.8 4598.5 4641.6 4652.7 4977.3 4992.6 4992.7 5009.7 5048.1 4822.0 5024.4 5030.6 5039.9 5041.8 4628.6 4683.0 4687.0 4723.1 4733.0 5101.4 5132.6 5134.1 5137.7 5191.2 4609.1 4915.2 4919.4 4923.6 4933.0 4968.6 4973.9 4989.1 5021.4 5038.5 4916.6 4936.3 4955.4 4955.5 4999.4 4747.7 4860.7 4927.9 4928.2 4967.4 4207.0 4212.5 4220.2 4236.8 4238.0 3673.6 3705.5 3711.0 3731.8 3751.2 4145.2 4219.8 4274.9 4282.6 4370.1 5023.4 5048.3 5049.5 5052.1 5057.2 4314.5 4316.2 4317.7 4339.1 4366.9 4364.6 4470.9 4482.2 4513.3 4559.7 4720.3 4720.4 4735.9 4751.4 4779.3 5008.7 5014.5 5022.1 5024.1 5075.0 4609.4 4720.6 4742.7 4746.5 4793.2 4899.9 4912.0 4940.1 4946.2 4993.1 4782.8 4963.8 4988.8 5005.6 5066.3 4792.5 4854.1 4868.0 4891.0 4911.7 4758.4 4799.7 4810.1 4813.9 4853.9 4619.9 4729.3 4746.3 4791.5 4792.0 4872.3 4896.4 4899.5 4904.2 4946.6 4779.9 4779.9 4791.1 4794.1 4839.9 22:05:56 INFO - PROCESS | 3394 | 22:05:56 INFO - PROCESS | 3394 | [#1] ext.html Cycles:180 Average:43032.04 Median:34120.90 stddev:73125.88 (214.3%) stddev-sans-first:73261.55 22:05:56 INFO - PROCESS | 3394 | Values: 580.9 593.4 602.5 619.2 623.3 26793.5 27059.5 27118.4 27484.7 27492.0 27362.3 34010.5 35157.3 35245.0 35279.6 7577.1 7751.0 7753.4 7754.1 7755.6 7492.1 7566.5 7660.2 9729.7 10155.6 9786.0 9923.1 9927.0 9928.2 9929.9 9615.4 9668.3 9745.3 9754.6 9761.7 7281.9 9566.7 9575.7 9970.4 9980.8 34269.7 34881.5 35007.3 35133.6 35152.8 3199.3 3232.6 3238.3 3260.1 3567.2 26760.2 27066.3 27395.1 27468.2 27580.6 3461.4 3502.1 3536.8 3558.5 3587.6 231792.0 234389.8 236969.8 238607.0 239183.0 53214.7 53600.2 53680.0 53680.0 53693.0 56196.7 56402.9 56425.4 56443.4 56493.0 14847.7 15322.8 15346.8 15388.2 15391.2 11545.3 11586.7 11609.6 11618.7 11623.3 13612.6 14224.2 15234.6 16196.5 16271.3 5809.7 5990.6 6159.4 6220.6 6220.7 933.5 985.4 995.5 1000.0 1014.6 28605.0 28627.3 28867.4 29138.7 29227.1 981.0 1004.0 1011.4 1058.2 1073.7 14933.5 15397.5 15399.9 15473.0 15657.5 336957.0 339959.0 340639.0 341632.0 341673.0 42909.0 47472.6 49110.5 49170.8 49195.8 1148.6 1253.7 1256.4 1260.9 1282.1 24880.8 25609.9 27896.0 28239.3 28252.4 40354.2 40637.4 40950.2 41107.8 41190.2 248317.0 250080.0 250186.0 250360.0 250618.0 34058.7 34128.5 35059.5 35122.0 35136.0 33003.5 35012.6 36161.1 36666.5 40793.8 30083.4 30837.5 31198.2 31458.2 32120.0 33656.3 33888.8 34092.3 34370.5 34625.5 34113.3 34331.5 34642.5 35152.1 35550.3 30568.4 31035.0 31362.2 31399.0 31414.8 23819.5 24525.9 24539.0 24650.5 24724.0 22:05:56 INFO - PROCESS | 3394 | 22:05:56 INFO - PROCESS | 3394 | [#2] jquery.html Cycles:180 Average:23697.68 Median:5461.08 stddev:62723.27 (1148.6%) stddev-sans-first:62874.74 22:05:56 INFO - PROCESS | 3394 | Values: 354.8 382.7 386.3 386.4 399.0 12262.5 15492.0 16044.5 16183.1 16217.5 15251.5 15666.4 16203.9 16750.4 16750.6 4480.6 5088.3 5181.0 5240.2 5252.5 3663.1 5635.2 5960.7 5970.1 5980.7 5671.9 5923.5 5923.7 5945.4 5947.4 5972.0 5993.2 6015.1 6027.8 6028.7 4957.4 5129.6 5140.2 5278.2 5287.0 19615.0 19888.3 19986.0 20077.0 20145.7 1898.1 1899.2 1939.0 2001.7 2004.0 12751.3 12885.4 12900.3 12949.6 13351.9 1840.7 1878.8 1887.7 1905.9 1906.8 64578.7 64936.7 65587.0 66425.0 66758.0 9482.0 9577.0 9606.1 9711.6 9871.9 13433.8 13626.6 13642.9 13656.9 13674.9 7248.5 7298.2 7393.5 7457.8 7496.2 6958.9 7002.4 7033.8 7042.7 7120.4 5990.0 6091.3 6159.4 6223.3 6330.8 1626.6 1727.3 1800.8 1823.1 1833.7 911.5 977.9 1008.8 1016.4 1042.2 15626.5 15978.8 16028.9 16985.8 17255.1 880.1 884.2 893.7 896.6 897.7 9020.1 9056.9 9192.6 9284.9 9318.2 297787.0 303094.0 420945.0 424434.0 424857.0 79443.6 81231.0 82313.0 82535.2 82802.6 978.4 990.8 1002.7 1006.9 1009.9 14682.1 14916.8 15230.9 15235.7 15350.2 34337.8 34457.8 34549.8 34925.5 35061.3 47330.0 48134.3 49760.0 49779.0 49888.0 7272.2 7311.7 7314.1 7420.6 7451.0 9382.9 10478.4 10582.0 10770.8 10908.1 9225.2 9439.9 9513.3 9530.8 9602.2 9078.2 9090.1 9219.7 9401.0 9661.4 9092.2 9429.6 9590.7 9830.2 9938.6 6998.7 7240.9 7318.7 7341.7 7456.8 8866.7 9397.9 9527.5 9601.0 9705.9 22:05:56 INFO - PROCESS | 3394 | 22:05:56 INFO - PROCESS | 3394 | [#3] mootools.html Cycles:180 Average:5198.30 Median:5552.03 stddev:2866.80 (51.6%) stddev-sans-first:2858.67 22:05:56 INFO - PROCESS | 3394 | Values: 1147.6 1403.5 1465.3 1566.0 1758.6 7539.1 7775.2 7805.5 7806.0 7811.8 7562.8 7732.6 7741.6 7745.7 7757.9 2160.7 2176.7 2186.3 2190.4 2191.7 2166.5 2199.4 2204.9 2223.6 2226.0 2197.0 2203.9 2210.9 2211.8 2258.9 2137.4 2137.9 2148.4 2149.2 2150.7 2147.3 2188.1 2190.3 2191.4 2191.6 7629.4 7802.8 7836.1 7847.3 7883.8 4666.4 4797.4 4798.9 4802.6 4815.6 3061.6 3074.1 3129.4 3131.9 3149.9 922.6 934.2 960.3 965.4 999.6 10794.8 10795.5 10877.1 10893.5 10947.7 4151.3 4195.0 4237.2 4310.9 4316.0 8660.1 8686.7 8708.4 8713.3 8722.1 4587.2 4629.1 4629.4 4632.2 4634.2 3751.5 3960.1 4253.1 4263.6 4317.1 3497.8 3502.1 3511.9 3529.4 3641.9 1078.9 1079.4 1082.8 1083.3 1095.8 765.0 804.8 881.8 908.4 921.1 5369.4 5526.6 5664.6 5742.9 5951.3 943.7 950.7 964.1 1009.9 1019.2 3726.6 3744.5 3766.9 3835.3 3975.6 9368.2 9628.5 9719.1 9761.4 9790.1 9655.4 9662.1 9668.7 9670.1 9707.9 7267.2 7409.1 7432.0 7438.9 7442.5 5545.8 5551.5 5552.6 5571.4 5770.7 8862.2 9011.4 9188.9 9198.1 9206.5 8471.4 8850.2 8937.0 8938.1 9174.4 6201.2 6701.9 6936.4 6947.3 6961.5 7391.2 7395.9 7437.0 7439.0 7477.5 6632.8 6858.0 6898.9 6952.0 7028.2 6377.4 6444.1 6536.8 6564.0 6574.9 6386.2 6395.0 6466.5 6530.3 6551.0 4831.0 4978.0 4978.2 5028.8 5081.5 4867.5 4898.1 4898.2 4940.4 4944.0 22:05:56 INFO - PROCESS | 3394 | 22:05:56 INFO - PROCESS | 3394 | [#4] prototype.html Cycles:180 Average:4448.38 Median:5066.46 stddev:1267.80 (25.0%) stddev-sans-first:1232.76 22:05:56 INFO - PROCESS | 3394 | Values: 312.1 315.7 323.2 323.8 326.5 4940.8 5082.1 5084.1 5128.9 5175.3 4866.9 5032.5 5066.0 5066.9 5093.6 4020.4 4044.7 4045.2 4050.0 4062.1 3774.9 3876.3 4053.9 4054.7 4064.6 3859.8 3964.4 3970.3 4008.9 4025.2 3974.9 3994.9 4004.4 4023.7 4030.8 3568.9 3574.5 3584.6 3584.7 3591.8 4798.3 4860.2 4880.0 4886.4 4889.1 4589.9 4595.6 4601.1 4611.4 4612.2 5341.7 5347.3 5353.9 5357.0 5362.6 3786.9 3826.5 3897.5 3904.8 3904.8 5591.8 5603.9 5606.2 5608.0 5615.2 4011.8 4020.1 4021.4 4021.8 4022.0 3985.2 4067.9 4072.1 4079.6 4088.0 4563.2 4585.2 4592.5 4600.3 4607.9 5334.7 5338.2 5362.4 5373.3 5382.7 1339.8 1368.6 1403.8 1419.8 1421.9 959.7 967.2 982.4 988.5 991.6 4622.0 4643.5 4669.3 4677.9 4689.3 5440.1 5449.8 5454.3 5466.0 5479.6 4514.3 4649.1 4655.9 4659.7 4665.3 2908.1 2928.5 2928.9 2939.8 2943.9 5179.9 5197.1 5208.8 5212.8 5213.3 5386.7 5589.3 5613.7 5614.1 5637.7 5154.8 5162.1 5170.8 5171.6 5184.2 5443.6 5478.6 5483.5 5484.5 5502.9 5239.1 5352.8 5378.3 5399.7 5402.0 5156.6 5169.4 5175.8 5177.3 5178.5 4002.0 4006.5 4008.6 4012.6 4013.3 5232.8 5370.9 5373.7 5465.5 5469.2 5200.6 5359.3 5364.4 5368.5 5377.4 5316.4 5339.3 5351.9 5355.6 5357.8 4789.0 5028.4 5226.5 5273.3 5310.2 5357.7 5368.2 5388.6 5394.8 5413.6 5230.4 5259.7 5272.7 5287.4 5302.7 22:05:56 INFO - PROCESS | 3394 | 22:05:56 INFO - PROCESS | 3394 | [#5] yui.html Cycles:180 Average:12840.48 Median:21540.59 stddev:14384.19 (66.8%) stddev-sans-first:14395.98 22:05:56 INFO - PROCESS | 3394 | Values: 769.4 774.4 789.1 793.2 807.2 11820.5 12059.5 12081.0 12084.0 12101.7 12312.7 12343.9 12344.5 12360.6 12364.6 642.8 783.1 803.4 814.3 821.1 805.1 809.1 811.7 813.1 813.7 851.7 858.3 860.1 860.2 860.9 675.5 819.0 841.3 842.3 843.5 619.7 620.2 621.5 621.7 622.3 12792.2 12817.3 12830.4 12832.8 12840.2 12288.0 12572.2 12663.9 12885.2 12972.5 10193.7 10341.9 10409.7 10409.7 10424.8 3357.3 3431.6 3440.8 3450.8 3516.4 46415.0 46486.0 46744.3 46818.5 46824.5 9908.7 10164.8 10246.6 10276.9 10293.4 18171.6 18360.3 18398.5 18404.7 18431.1 6777.7 6785.4 6849.0 6855.1 7073.2 3736.4 3809.3 3826.6 3851.8 3875.8 2919.6 3007.2 3015.1 3016.2 3016.7 443.8 541.5 554.9 556.2 573.8 613.3 657.4 660.7 663.7 667.8 7652.3 7697.4 7932.5 8186.0 8194.1 595.5 602.6 619.1 620.3 624.2 3772.6 3835.5 3877.9 3898.6 3907.0 51213.0 52398.3 52458.2 52577.2 52607.5 47464.8 47491.8 48248.8 48329.3 49214.0 37189.8 38453.8 43492.8 43744.1 44043.6 8193.2 8344.3 8360.3 8395.0 8479.6 26868.9 27124.2 27606.3 27670.0 27864.3 34503.3 36920.3 37311.8 38657.6 39174.2 10806.6 10881.1 10936.1 10946.5 11118.7 11617.5 11653.6 11750.8 12109.8 12539.4 11091.0 11307.9 11363.7 11626.0 11934.4 10945.7 11000.7 11393.3 11495.4 11576.0 11153.9 11167.2 11220.8 11654.1 11985.4 9373.8 9478.7 9711.7 9852.5 10001.6 9574.5 9880.8 9891.9 9925.2 9997.2 22:05:56 INFO - PROCESS | 3394 | -------- Summary: end -------- 22:05:56 INFO - PROCESS | 3394 | 22:05:57 INFO - TEST-INFO | 3394: exit 0 22:05:57 INFO - TEST-OK | dromaeo_css | took 1119778ms 22:05:57 INFO - TEST-START | kraken 22:05:57 INFO - operating with platform_type : linux_ 22:05:57 INFO - Initialising browser for kraken test... 22:05:57 INFO - TEST-INFO | started process 3573 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqf8GyD/profile http://localhost:42370/getInfo.html) 22:06:01 INFO - PROCESS | 3573 | __metrics Screen width/height:1600/1200 22:06:01 INFO - PROCESS | 3573 | colorDepth:24 22:06:01 INFO - PROCESS | 3573 | Browser inner width/height: 1024/697 22:06:01 INFO - PROCESS | 3573 | __metrics 22:06:03 ERROR - PROCESS | 3573 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:06:03 INFO - TEST-INFO | 3573: exit 0 22:06:03 INFO - Browser initialized. 22:06:03 INFO - Running cycle 1/1 for kraken test... 22:06:03 INFO - TEST-INFO | started process 3655 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqf8GyD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:06:15 INFO - PROCESS | 3655 | RSS: Main: 154836992 22:06:15 INFO - PROCESS | 3655 | 22:06:18 INFO - PROCESS | 3655 | Cycle 1(1): loaded http://localhost:42370/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42370/tests/kraken/driver.html?testName=audio-beat-detection) 22:06:19 INFO - PROCESS | 3655 | RSS: Main: 209940480 22:06:19 INFO - PROCESS | 3655 | 22:06:22 INFO - PROCESS | 3655 | Cycle 1(1): loaded http://localhost:42370/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42370/tests/kraken/driver.html?testName=audio-dft) 22:06:22 INFO - PROCESS | 3655 | RSS: Main: 195170304 22:06:22 INFO - PROCESS | 3655 | 22:06:26 INFO - PROCESS | 3655 | Cycle 1(1): loaded http://localhost:42370/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42370/tests/kraken/driver.html?testName=audio-fft) 22:06:26 INFO - PROCESS | 3655 | RSS: Main: 265981952 22:06:26 INFO - PROCESS | 3655 | 22:06:28 INFO - PROCESS | 3655 | Cycle 1(1): loaded http://localhost:42370/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42370/tests/kraken/driver.html?testName=audio-oscillator) 22:06:29 INFO - PROCESS | 3655 | RSS: Main: 174493696 22:06:29 INFO - PROCESS | 3655 | 22:06:31 INFO - PROCESS | 3655 | Cycle 1(1): loaded http://localhost:42370/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42370/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:06:32 INFO - PROCESS | 3655 | RSS: Main: 178692096 22:06:32 INFO - PROCESS | 3655 | 22:06:35 INFO - PROCESS | 3655 | Cycle 1(1): loaded http://localhost:42370/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42370/tests/kraken/driver.html?testName=imaging-darkroom) 22:06:36 INFO - PROCESS | 3655 | RSS: Main: 214163456 22:06:36 INFO - PROCESS | 3655 | 22:06:39 INFO - PROCESS | 3655 | Cycle 1(1): loaded http://localhost:42370/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42370/tests/kraken/driver.html?testName=imaging-desaturate) 22:06:40 INFO - PROCESS | 3655 | RSS: Main: 214986752 22:06:40 INFO - PROCESS | 3655 | 22:06:42 INFO - PROCESS | 3655 | Cycle 1(1): loaded http://localhost:42370/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42370/tests/kraken/driver.html?testName=json-parse-financial) 22:06:43 INFO - PROCESS | 3655 | RSS: Main: 215162880 22:06:43 INFO - PROCESS | 3655 | 22:06:45 INFO - PROCESS | 3655 | Cycle 1(1): loaded http://localhost:42370/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42370/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:06:45 INFO - PROCESS | 3655 | RSS: Main: 203464704 22:06:45 INFO - PROCESS | 3655 | 22:06:47 INFO - PROCESS | 3655 | Cycle 1(1): loaded http://localhost:42370/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42370/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:06:48 INFO - PROCESS | 3655 | RSS: Main: 203849728 22:06:48 INFO - PROCESS | 3655 | 22:06:50 INFO - PROCESS | 3655 | Cycle 1(1): loaded http://localhost:42370/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42370/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:06:51 INFO - PROCESS | 3655 | RSS: Main: 218796032 22:06:51 INFO - PROCESS | 3655 | 22:06:53 INFO - PROCESS | 3655 | Cycle 1(1): loaded http://localhost:42370/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42370/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:06:54 INFO - PROCESS | 3655 | RSS: Main: 223838208 22:06:54 INFO - PROCESS | 3655 | 22:06:57 INFO - PROCESS | 3655 | Cycle 1(1): loaded http://localhost:42370/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42370/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:06:58 INFO - PROCESS | 3655 | RSS: Main: 217894912 22:06:58 INFO - PROCESS | 3655 | 22:07:00 INFO - PROCESS | 3655 | Cycle 1(1): loaded http://localhost:42370/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42370/tests/kraken/driver.html?testName=ai-astar) 22:07:00 INFO - PROCESS | 3655 | RSS: Main: 280330240 22:07:00 INFO - PROCESS | 3655 | 22:07:00 INFO - PROCESS | 3655 | __start_tp_report 22:07:00 INFO - PROCESS | 3655 | _x_x_mozilla_page_load 22:07:00 INFO - PROCESS | 3655 | _x_x_mozilla_page_load_details 22:07:00 INFO - PROCESS | 3655 | |i|pagename|runs| 22:07:00 INFO - PROCESS | 3655 | |0;ai-astar;112;113;107;111;114;113;101;114;111;113 22:07:00 INFO - PROCESS | 3655 | |1;audio-beat-detection;158;134;162;178;133;157;155;133;199;141 22:07:00 INFO - PROCESS | 3655 | |2;audio-dft;161;161;162;161;164;162;163;161;160;161 22:07:00 INFO - PROCESS | 3655 | |3;audio-fft;73;77;98;109;75;75;74;115;98;74 22:07:00 INFO - PROCESS | 3655 | |4;audio-oscillator;94;95;150;95;95;95;144;95;94;142 22:07:00 INFO - PROCESS | 3655 | |5;imaging-gaussian-blur;118;117;117;117;117;117;117;117;117;117 22:07:00 INFO - PROCESS | 3655 | |6;imaging-darkroom;146;146;146;147;146;145;146;146;146;146 22:07:00 INFO - PROCESS | 3655 | |7;imaging-desaturate;95;94;95;94;95;94;94;95;95;95 22:07:00 INFO - PROCESS | 3655 | |8;json-parse-financial;65;66;66;65;65;65;65;85;62;64 22:07:00 INFO - PROCESS | 3655 | |9;json-stringify-tinderbox;64;64;64;64;64;64;63;65;65;64 22:07:00 INFO - PROCESS | 3655 | |10;stanford-crypto-aes;79;79;79;79;81;80;79;80;80;79 22:07:00 INFO - PROCESS | 3655 | |11;stanford-crypto-ccm;141;135;135;133;136;133;141;133;166;133 22:07:00 INFO - PROCESS | 3655 | |12;stanford-crypto-pbkdf2;176;194;181;176;182;182;174;173;176;174 22:07:00 INFO - PROCESS | 3655 | |13;stanford-crypto-sha256-iterative;74;76;74;73;72;71;73;70;73;73 22:07:00 INFO - PROCESS | 3655 | __end_tp_report 22:07:00 INFO - PROCESS | 3655 | __start_cc_report 22:07:00 INFO - PROCESS | 3655 | _x_x_mozilla_cycle_collect,1896 22:07:00 INFO - PROCESS | 3655 | __end_cc_report 22:07:00 INFO - PROCESS | 3655 | __startTimestamp1460869620784__endTimestamp 22:07:00 INFO - PROCESS | 3655 | 22:07:00 INFO - PROCESS | 3655 | ------- Summary: start ------- 22:07:00 INFO - PROCESS | 3655 | Number of tests: 14 22:07:00 INFO - PROCESS | 3655 | 22:07:00 INFO - PROCESS | 3655 | [#0] ai-astar Cycles:10 Average:110.90 Median:113.00 stddev:4.04 (3.6%) stddev-sans-first:4.27 22:07:00 INFO - PROCESS | 3655 | Values: 112.0 113.0 107.0 111.0 114.0 113.0 101.0 114.0 111.0 113.0 22:07:00 INFO - PROCESS | 3655 | 22:07:00 INFO - PROCESS | 3655 | [#1] audio-beat-detection Cycles:10 Average:155.00 Median:157.50 stddev:21.43 (13.6%) stddev-sans-first:22.70 22:07:00 INFO - PROCESS | 3655 | Values: 158.0 134.0 162.0 178.0 133.0 157.0 155.0 133.0 199.0 141.0 22:07:00 INFO - PROCESS | 3655 | 22:07:00 INFO - PROCESS | 3655 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.50 stddev:1.17 (0.7%) stddev-sans-first:1.22 22:07:00 INFO - PROCESS | 3655 | Values: 161.0 161.0 162.0 161.0 164.0 162.0 163.0 161.0 160.0 161.0 22:07:00 INFO - PROCESS | 3655 | 22:07:00 INFO - PROCESS | 3655 | [#3] audio-fft Cycles:10 Average:86.80 Median:75.00 stddev:16.44 (21.9%) stddev-sans-first:16.66 22:07:00 INFO - PROCESS | 3655 | Values: 73.0 77.0 98.0 109.0 75.0 75.0 74.0 115.0 98.0 74.0 22:07:00 INFO - PROCESS | 3655 | 22:07:00 INFO - PROCESS | 3655 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:95.00 stddev:24.53 (25.8%) stddev-sans-first:25.34 22:07:00 INFO - PROCESS | 3655 | Values: 94.0 95.0 150.0 95.0 95.0 95.0 144.0 95.0 94.0 142.0 22:07:00 INFO - PROCESS | 3655 | 22:07:00 INFO - PROCESS | 3655 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 22:07:00 INFO - PROCESS | 3655 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 22:07:00 INFO - PROCESS | 3655 | 22:07:00 INFO - PROCESS | 3655 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 22:07:00 INFO - PROCESS | 3655 | Values: 146.0 146.0 146.0 147.0 146.0 145.0 146.0 146.0 146.0 146.0 22:07:00 INFO - PROCESS | 3655 | 22:07:00 INFO - PROCESS | 3655 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 22:07:00 INFO - PROCESS | 3655 | Values: 95.0 94.0 95.0 94.0 95.0 94.0 94.0 95.0 95.0 95.0 22:07:00 INFO - PROCESS | 3655 | 22:07:00 INFO - PROCESS | 3655 | [#8] json-parse-financial Cycles:10 Average:66.80 Median:65.00 stddev:6.49 (10.0%) stddev-sans-first:6.86 22:07:00 INFO - PROCESS | 3655 | Values: 65.0 66.0 66.0 65.0 65.0 65.0 65.0 85.0 62.0 64.0 22:07:00 INFO - PROCESS | 3655 | 22:07:00 INFO - PROCESS | 3655 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 22:07:00 INFO - PROCESS | 3655 | Values: 64.0 64.0 64.0 64.0 64.0 64.0 63.0 65.0 65.0 64.0 22:07:00 INFO - PROCESS | 3655 | 22:07:00 INFO - PROCESS | 3655 | [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:79.50 stddev:0.71 (0.9%) stddev-sans-first:0.73 22:07:00 INFO - PROCESS | 3655 | Values: 79.0 79.0 79.0 79.0 81.0 80.0 79.0 80.0 80.0 79.0 22:07:00 INFO - PROCESS | 3655 | 22:07:00 INFO - PROCESS | 3655 | [#11] stanford-crypto-ccm Cycles:10 Average:138.60 Median:135.50 stddev:10.11 (7.5%) stddev-sans-first:10.69 22:07:00 INFO - PROCESS | 3655 | Values: 141.0 135.0 135.0 133.0 136.0 133.0 141.0 133.0 166.0 133.0 22:07:00 INFO - PROCESS | 3655 | 22:07:00 INFO - PROCESS | 3655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.80 Median:178.50 stddev:6.32 (3.5%) stddev-sans-first:6.62 22:07:00 INFO - PROCESS | 3655 | Values: 176.0 194.0 181.0 176.0 182.0 182.0 174.0 173.0 176.0 174.0 22:07:00 INFO - PROCESS | 3655 | 22:07:00 INFO - PROCESS | 3655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.90 Median:73.00 stddev:1.66 (2.3%) stddev-sans-first:1.72 22:07:00 INFO - PROCESS | 3655 | Values: 74.0 76.0 74.0 73.0 72.0 71.0 73.0 70.0 73.0 73.0 22:07:00 INFO - PROCESS | 3655 | -------- Summary: end -------- 22:07:00 INFO - PROCESS | 3655 | 22:07:01 INFO - TEST-INFO | 3655: exit 0 22:07:01 INFO - TEST-OK | kraken | took 64709ms 22:07:01 INFO - SUITE-END | took 1184s 22:07:01 INFO - Completed test suite (00:19:44) 22:07:01 INFO - javascript benchmark 22:07:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2594.221733479956, 2657.614645876349, 2660.7206243344435, 2679.1560658392605, 2693.2189664997145, 4562.703424277428, 4601.263797792354, 4631.35161077449, 4641.118187544364, 4652.511486293941, 4680.485146633868, 4696.506866778982, 4731.290306454025, 4807.543283388081, 4809.687370320936, 4269.316909294514, 4281.079567892894, 4356.128774245164, 4386.0, 4462.821487140511, 4375.387445757597, 4413.0732546165345, 4426.535213802553, 4428.689991700582, 4458.197524445599, 4129.15352352767, 4226.788660566959, 4239.27932251518, 4266.4240327556, 4298.935515967263, 4255.468066491689, 4288.76411797351, 4297.763623000734, 4305.526392096866, 4354.847580334705, 4267.347315210385, 4286.464191976003, 4294.26997410441, 4312.310030395153, 4321.222180007598, 4427.114577084564, 4558.817647294104, 4598.517155698637, 4641.559051890065, 4652.744099074584, 4977.253411988195, 4992.575631071363, 4992.650514463989, 5009.699418034893, 5048.116579598555, 4821.975890120562, 5024.422191447957, 5030.647854650176, 5039.92440113395, 5041.823536176253, 4628.560286772751, 4682.976585117052, 4687.039156972813, 4723.126221648971, 4732.976335118371, 5101.362329708786, 5132.640715149903, 5134.101532231844, 5137.743112844343, 5191.195364718475, 4609.055143695535, 4915.238138088531, 4919.409670839522, 4923.606111511071, 4932.975335123373, 4968.577670898014, 4973.90052198954, 4989.077020751172, 5021.372328458942, 5038.496150385005, 4916.606671466274, 4936.259561065869, 4955.4301255356095, 4955.529224723718, 4999.400071991385, 4747.738874361874, 4860.708357498562, 4927.90144197114, 4928.162212423897, 4967.428745694219, 4206.978965105155, 4212.49450065994, 4220.155968806251, 4236.830526778895, 4237.957620423818, 3673.6142705015586, 3705.518282623296, 3710.9814450927574, 3731.832067556912, 3751.174741556853, 4145.17096580685, 4219.810108545123, 4274.935875961863, 4282.550332215135, 4370.082282720664, 5023.447420783711, 5048.343715316985, 5049.495050494995, 5052.141136006888, 5057.241413787961, 4314.482262128565, 4316.2446571849805, 4317.654587632982, 4339.132173565299, 4366.934495982563, 4364.5635436456105, 4470.932936005963, 4482.193205223026, 4513.300438432048, 4559.680822342404, 4720.339152518719, 4720.433547974265, 4735.905281894412, 4751.382320298339, 4779.3070004848405, 5008.724520151281, 5014.52362025607, 5022.096022715946, 5024.145895197752, 5075.0357432087785, 4609.423822022247, 4720.598749106364, 4742.739149346819, 4746.477887432448, 4793.23308270675, 4899.877503062452, 4911.950880491149, 4940.061388336205, 4946.1838796599595, 4993.076280888047, 4782.760861956818, 4963.776630051729, 4988.775505102207, 5005.599552035756, 5066.341375621146, 4792.496787837227, 4854.053459575349, 4867.951320486892, 4890.951090489049, 4911.7298548580175, 4758.428988521399, 4799.688020278671, 4810.062037902575, 4813.9037219256115, 4853.878653033561, 4619.86140415788, 4729.266963620645, 4746.311784791255, 4791.544803243686, 4792.0, 4872.317875497362, 4896.4124305083615, 4899.485554016919, 4904.215325547895, 4946.604271658187, 4779.904401912012, 4779.928301075417, 4791.113643975876, 4794.089123066607, 4839.927401089057], "value": 4584.841299308552, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.9273840769904, 593.350281441821, 602.4547784255249, 619.2135987296134, 623.2645478335565, 26793.4641307174, 27059.458810823773, 27118.372897626108, 27484.725152748466, 27492.0, 27362.315942101457, 34010.48984265232, 35157.2968540629, 35245.0, 35279.64720352796, 7577.090749110114, 7750.961245193795, 7753.379729621617, 7754.06951165858, 7755.612219389036, 7492.100947886262, 7566.546007239584, 7660.195679453661, 9729.659461918834, 10155.593776248941, 9785.951070244639, 9923.057309555617, 9926.9503652482, 9928.205743540535, 9929.90070099297, 9615.42307461551, 9668.323217374787, 9745.269104817096, 9754.561044753003, 9761.707148785583, 7281.854362912765, 9566.712998610054, 9575.664851730156, 9970.351927124713, 9980.800383992351, 34269.657303426895, 34881.47677784835, 35007.29985400278, 35133.6486635133, 35152.824235878914, 3199.2961548459302, 3232.6120865496055, 3238.2875767331147, 3260.136063943057, 3567.2384346922054, 26760.19719408421, 27066.323341916413, 27395.08234423591, 27468.17595472139, 27580.586291205647, 3461.44616861301, 3502.141975216088, 3536.840842162083, 3558.5195998540385, 3587.587427445851, 231792.0, 234389.7646652962, 236969.81515092487, 238607.0, 239183.0, 53214.73392633012, 53600.19599706007, 53680.0, 53680.0, 53693.0, 56196.71901640548, 56402.871942560916, 56425.43574564202, 56443.35566443405, 56493.0, 14847.70304593902, 15322.846771532364, 15346.846531534766, 15388.153651549048, 15391.153486558347, 11545.307281563133, 11586.652400428, 11609.593664221711, 11618.6514404568, 11623.302601843916, 13612.591622251348, 14224.217668028357, 15234.619134521505, 16196.514104576881, 16271.349146034026, 5809.738561764731, 5990.64056156632, 6159.353267906895, 6220.564560480723, 6220.688965551704, 933.5192375926404, 985.3595163143871, 995.4918298777358, 999.9700008999741, 1014.60937539048, 28605.0, 28627.2843178918, 28867.42265154685, 29138.708612914023, 29227.123186304445, 980.9792964863949, 1003.9548220330103, 1011.3780025284544, 1058.222206678091, 1073.7315671082229, 14933.477328293458, 15397.538073857802, 15399.92200545951, 15473.0, 15657.451989180325, 336957.0, 339959.0, 340639.0, 341632.0, 341673.0, 42909.0, 47472.62636868212, 49110.508894911305, 49170.75414622904, 49195.754021229666, 1148.5807680196667, 1253.7304479536942, 1256.447163248168, 1260.9243445393306, 1282.0897163014179, 24880.75119248784, 25609.871950640874, 27895.964555622282, 28239.29401764972, 28252.43495130127, 40354.1929161421, 40637.39043914403, 40950.18099637931, 41107.7944610275, 41190.1761964765, 248317.0, 250080.0, 250186.0, 250360.0, 250618.0, 34058.65941340654, 34128.48807267943, 35059.47410788891, 35122.0, 35136.0, 33003.504947426285, 35012.64987350094, 36161.095972600895, 36666.45000325051, 40793.79603101966, 30083.398332033674, 30837.537436938015, 31198.22004449907, 31458.213544661565, 32120.0, 33656.32687346288, 33888.83055584805, 34092.31815363729, 34370.48444273288, 34625.48061779025, 34113.31773364469, 34331.485027724106, 34642.48036279508, 35152.12119697028, 35550.288994220486, 30568.401685856952, 31035.0, 31362.215944600655, 31399.0, 31414.842925785226, 23819.523609527365, 24525.877370613034, 24539.0, 24650.506989859743, 24724.0], "value": 17292.23575456, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.7623092528006, 382.70722896983796, 386.2892278208097, 386.43387437404203, 399.04229848363923, 12262.509499620015, 15492.0, 16044.518664440086, 16183.109928953903, 16217.513474595751, 15251.500807261857, 15666.373345066184, 16203.918980405111, 16750.413735519258, 16750.58123546912, 4480.587097733912, 5088.287639730441, 5181.0, 5240.240165176047, 5252.474752524755, 3663.120850995755, 5635.154726790973, 5960.701964901759, 5970.104484327342, 5980.700964951757, 5671.914921276184, 5923.466887980081, 5923.703814809264, 5945.405459454063, 5947.434993675594, 5972.0, 5993.220881285449, 6015.127806468081, 6027.758889644409, 6028.698565071751, 4957.380327459067, 5129.615278854101, 5140.203268493389, 5278.155495120763, 5287.0, 19615.0, 19888.303909363247, 19986.0, 20077.0, 20145.697814532792, 1898.0984032584413, 1899.164367678217, 1938.9515262118418, 2001.7097520859393, 2004.0280463975107, 12751.298678572675, 12885.355732213351, 12900.290484023375, 12949.611511654666, 13351.933240333736, 1840.6962851129547, 1878.8496920246484, 1887.6696578098915, 1905.9237630494763, 1906.8093190680959, 64578.67710661464, 64936.67531662359, 65587.0, 66425.0, 66758.0, 9482.0, 9576.95211523952, 9606.135447809731, 9711.611535538499, 9871.901280987242, 13433.798493022612, 13626.591202263948, 13642.931785341209, 13656.863431365558, 13674.93162534201, 7248.528845625123, 7298.197198308182, 7393.519421237603, 7457.755876193873, 7496.175420703718, 6958.860822783516, 7002.3697867192195, 7033.788986330418, 7042.718291268292, 7120.430365570742, 5989.970050149721, 6091.299500557404, 6159.384061593805, 6223.315435302204, 6330.778422755181, 1626.6014826367616, 1727.3263427263378, 1800.7839059312705, 1823.0981793734893, 1833.7432759413693, 911.4986757283467, 977.8630991661173, 1008.7982403519326, 1016.3749294184023, 1042.166266986408, 15626.45307414235, 15978.76031859523, 16028.919855400649, 16985.757995555057, 17255.137243137793, 880.0715245416147, 884.1644645809777, 893.6827426263583, 896.5875697179371, 897.6902968475865, 9020.14308640678, 9056.909430905738, 9192.586333615003, 9284.907150928539, 9318.161365477004, 297787.0, 303094.0, 420945.0, 424434.0, 424857.0, 79443.60278198573, 81231.0, 82313.0, 82535.17464825395, 82802.58598707088, 978.4422878958925, 990.7721224118493, 1002.7192386131894, 1006.8540061691014, 1009.8586197932295, 14682.069954099921, 14916.776248356065, 15230.923845380703, 15235.695286094438, 15350.23248837576, 34337.828310858284, 34457.827710862286, 34549.827250863586, 34925.47611785876, 35061.29877402489, 47330.0, 48134.277985830944, 49760.0, 49779.0, 49888.0, 7272.23641517633, 7311.744088956861, 7314.122305323395, 7420.6289685516585, 7451.031365922396, 9382.903641798326, 10478.37129772216, 10582.0, 10770.784584308114, 10908.127349811837, 9225.21585665226, 9439.905600944177, 9513.33406661527, 9530.761730956781, 9602.231821454126, 9078.182963533314, 9090.13643703847, 9219.677311294072, 9401.0, 9661.372010819556, 9092.22716069115, 9429.62281508732, 9590.712278631652, 9830.164436023018, 9938.602455901972, 6998.6850591724515, 7240.8913866290995, 7318.743843965436, 7341.706331746884, 7456.7762967111075, 8866.689665861664, 9397.859032114387, 9527.546540043279, 9601.0, 9705.854412183682], "value": 8253.409508106852, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1147.6327575175947, 1403.522802247236, 1465.311303687267, 1565.9608509787254, 1758.5691505581126, 7539.095308562966, 7775.222477752222, 7805.531668099911, 7805.960970195149, 7811.765647030584, 7562.810929726759, 7732.574708391036, 7741.57421341826, 7745.690172393111, 7757.922420775791, 2160.7407111146686, 2176.662617294314, 2186.30038387716, 2190.37574291327, 2191.7041199438113, 2166.523364859728, 2199.417154454071, 2204.856684315522, 2223.5886361023263, 2225.9777402226014, 2197.0, 2203.856749311298, 2210.8673479591275, 2211.7677643847405, 2258.9322320330334, 2137.4122116417952, 2137.850350475467, 2148.4414052346424, 2149.2262785397243, 2150.731158605174, 2147.2591955775233, 2188.059134572133, 2190.2772085212, 2191.4411824984527, 2191.605511008018, 7629.427792915498, 7802.843943121163, 7836.059672839238, 7847.293743563049, 7883.8029049273655, 4666.39336886206, 4797.40032495938, 4798.880027999293, 4802.639802014828, 4815.614750819961, 3061.6479104902774, 3074.108508532523, 3129.405412971528, 3131.85906634202, 3149.8582563784685, 922.5710044829186, 934.2059249637822, 960.279790157382, 965.4014511003153, 999.5951639585979, 10794.78410431787, 10795.514201860935, 10877.07544858688, 10893.455327233685, 10947.671569852917, 4151.315033019579, 4194.979025104855, 4237.216115018731, 4310.89222769427, 4315.956840431619, 8660.13398660129, 8686.695965641173, 8708.390412671179, 8713.344464551716, 8722.127787221354, 4587.220172570671, 4629.074185162981, 4629.398178236875, 4632.235681112578, 4634.21218392874, 3751.4747935289083, 3960.108975480494, 4253.106847561985, 4263.59495847894, 4317.050248945227, 3497.755157138976, 3502.1069627244888, 3511.9122021949656, 3529.3823580873245, 3641.9453708194396, 1078.9082927951056, 1079.3955384984433, 1082.815921293382, 1083.2796190533206, 1095.8191898336686, 764.9923500764921, 804.7867315161487, 881.8104107616894, 908.3913777768779, 921.074320308086, 5369.3556773187465, 5526.613137080446, 5664.575156863251, 5742.913856292159, 5951.315598706205, 943.7499062748377, 950.695777351241, 964.064857088623, 1009.9397229651576, 1019.1846522781744, 3726.571444283888, 3744.513213282256, 3766.886993390203, 3835.328817456934, 3975.582563830814, 9368.203702685212, 9628.518574071268, 9719.125278724949, 9761.36551124189, 9790.06994335537, 9655.420674759536, 9662.08210220028, 9668.661596844076, 9670.081342272473, 9707.854382184272, 7267.236940121317, 7409.147947985943, 7432.033835601445, 7438.888416673754, 7442.479026468095, 5545.833624991256, 5551.500364967173, 5552.555795536428, 5571.3871474137, 5770.740316685843, 8862.246709029805, 9011.369204155646, 9188.908110918805, 9198.080191980749, 9206.493642849708, 8471.364647651328, 8850.247728943112, 8937.0, 8938.10618938101, 9174.357794954289, 6201.224846894138, 6701.899471508029, 6936.445084393337, 6947.305269473012, 6961.477889158435, 7391.1869694334655, 7395.852082958419, 7437.0, 7439.0, 7477.4765766398, 6632.767853125118, 6858.0, 6898.8620227594165, 6951.9652401739695, 7028.191757947901, 6377.426031657174, 6444.097826304415, 6536.7712130075215, 6564.0, 6574.934250657432, 6386.16979792624, 6395.0, 6466.482681385572, 6530.314316996837, 6551.0, 4830.951690483191, 4977.950220497749, 4978.153713868724, 5028.798848046184, 5081.4918508148885, 4867.5132486751045, 4898.118338699069, 4898.21628539432, 4940.407151141886, 4943.950560494349], "value": 4203.683763597587, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.07936587068156, 315.67958522100065, 323.15656137481153, 323.79762648344786, 326.45645001073217, 4940.8023679052885, 5082.08522465956, 5084.0594490019375, 5128.923066154006, 5175.275461435397, 4866.878328041801, 5032.4967503249745, 5066.0, 5066.923996140061, 5093.643444958845, 4020.376841589551, 4044.716869819114, 4045.2314060328445, 4050.0, 4062.1361939832495, 3774.886753397389, 3876.282887665777, 4053.9189216215805, 4054.6958978076764, 4064.5732198119217, 3859.8456061757497, 3964.425158352037, 3970.2655008823317, 4008.879733607982, 4025.1547175093265, 3974.9006274843073, 3994.940075898878, 4004.3593025116134, 4023.718339716221, 4030.8387664493384, 3568.928621427583, 3574.517440145573, 3584.551931008624, 3584.7132229421845, 3591.838367273479, 4798.328234047236, 4860.1737704590305, 4880.048390563841, 4886.438059623153, 4889.144399730033, 4589.931151032737, 4595.586397224266, 4601.102784956935, 4611.354410382549, 4612.215923293048, 5341.6527925685095, 5347.278117454132, 5353.9196912046355, 5357.0, 5362.624616276862, 3786.905327366838, 3826.521684789401, 3897.4543563901075, 3904.7657140571373, 3904.809033244859, 5591.776328946838, 5603.943960560383, 5606.187102870102, 5607.971960140173, 5615.241942337773, 4011.8194681239415, 4020.075382662004, 4021.3967904814513, 4021.8190181441905, 4021.959780402217, 3985.242803867256, 4067.91864162721, 4072.063425412172, 4079.6124368184974, 4087.959120408758, 4563.155816174019, 4585.197590421662, 4592.494825569184, 4600.332951722048, 4607.9078418431445, 5334.67991920486, 5338.156527300338, 5362.3565172178805, 5373.2746079278795, 5382.730863456812, 1339.8459177194552, 1368.555219553629, 1403.8175037245094, 1419.8296204455532, 1421.9217943013234, 959.7408699651055, 967.1827305926481, 982.4056445850158, 988.4859872866069, 991.5736233419699, 4621.953780462152, 4643.535646435329, 4669.299605059268, 4677.924077462203, 4689.320048592935, 5440.129579267298, 5449.809256676077, 5454.3454785426, 5466.0, 5479.616426850162, 4514.345419914094, 4649.140343862482, 4655.883602909955, 4659.743714095689, 4665.346851440801, 2908.1130255271923, 2928.531434970437, 2928.853557322125, 2939.808912420686, 2943.9116826495238, 5179.896402071938, 5197.064528384927, 5208.817691380784, 5212.817551385683, 5213.296205012275, 5386.730663466811, 5589.329280486287, 5613.7193140342815, 5614.101743721067, 5637.718114094361, 5154.845354639367, 5162.141629013552, 5170.793168273227, 5171.63798534099, 5184.170532714747, 5443.59173062014, 5478.616496845342, 5483.464629903633, 5484.502707779582, 5502.889942201214, 5239.066122971149, 5352.798053527962, 5378.327709036371, 5399.730013499231, 5402.027635025576, 5156.5616922562, 5169.431362550041, 5175.8095638002715, 5177.326947496801, 5178.482151784791, 4002.0, 4006.4991876015497, 4008.559058503504, 4012.5586185518987, 4013.337799263089, 5232.7645255964335, 5370.865728356823, 5373.650712703662, 5465.535429488538, 5469.15228139639, 5200.583953283804, 5359.3032905722, 5364.3830959440165, 5368.516833485005, 5377.435369286325, 5316.441773613715, 5339.279197308314, 5351.929614077278, 5355.598330125178, 5357.812476563302, 4789.0125597876495, 5028.421731500778, 5226.477352264743, 5273.34083239595, 5310.230016647642, 5357.678539287655, 5368.221607866915, 5388.595855310789, 5394.838154855361, 5413.648112872651, 5230.424653288212, 5259.684418934876, 5272.657277277118, 5287.391949925808, 5302.70835104073], "value": 4050.614627673222, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [769.361430013089, 774.4269240761838, 789.1358961936677, 793.2107552984785, 807.2129673568272, 11820.468078936447, 12059.4573244204, 12081.0, 12084.0, 12101.697457563554, 12312.692182695437, 12343.938280308608, 12344.506219751222, 12360.629181124557, 12364.567240146596, 642.8135840606219, 783.1385475976438, 803.3613277444431, 814.340384288728, 821.1337039423406, 805.0540614777613, 809.0695699945052, 811.6550466051934, 813.1096449387911, 813.6785969542027, 851.676362982069, 858.2747578296361, 860.0968982568278, 860.2257967828941, 860.9182127697859, 675.4528831646358, 818.9672413103468, 841.2849078283472, 842.296682270305, 843.4770442325797, 619.7087368936593, 620.1937481274371, 621.5338496127904, 621.6953692690595, 622.315453001699, 12792.232466052066, 12817.295048772314, 12830.358482075859, 12832.80750788739, 12840.165389249669, 12288.0, 12572.245665260023, 12663.873361266362, 12885.162464439874, 12972.481100755958, 10193.694189174337, 10341.9482902585, 10409.68770936873, 10409.739756506147, 10424.843627345595, 3357.2781851901714, 3431.6396778338167, 3440.776349537272, 3450.8447119879665, 3516.4373700207843, 46414.999999999665, 46486.0, 46744.298835517155, 46818.5318146821, 46824.5317546827, 9908.65319713821, 10164.847527287096, 10246.6413675521, 10276.948615256875, 10293.433861137559, 18171.63656726858, 18360.265589376275, 18398.540036499195, 18404.723929141073, 18431.07844607764, 6777.72889084441, 6785.423239024738, 6848.965755171292, 6855.07456493377, 7073.186583542958, 3736.4021756518828, 3809.276237514863, 3826.598207188205, 3851.807409629507, 3875.767453952772, 2919.6496420429685, 3007.188059224041, 3015.1406849048353, 3016.1856298799203, 3016.6832482589452, 443.8318812600406, 541.4639506888152, 554.8807006493623, 556.1629747230473, 573.761888816145, 613.2640831002815, 657.3623585122424, 660.7026837922954, 663.741140955028, 667.7796327212009, 7652.349550288177, 7697.422028484148, 7932.524048557105, 8185.95907020473, 8194.139615340422, 595.4700316718124, 602.57518449493, 619.1301221783401, 620.3393386043939, 624.2041397218583, 3772.641599048086, 3835.463035175078, 3877.86427475037, 3898.629630185128, 3906.9609303907164, 51213.0, 52398.344531893956, 52458.21312680313, 52577.211341829905, 52607.47392526102, 47464.7626761864, 47491.762541187076, 48248.7587562067, 48329.27506087411, 49214.0, 37189.81405092957, 38453.80773096173, 43492.78253608775, 43744.125117497475, 44043.55956440459, 8193.221643943816, 8344.290735287326, 8360.331173506227, 8395.0, 8479.576021199038, 26868.865655671598, 27124.1862744118, 27606.309842254104, 27670.0, 27864.303392415353, 34503.309933801684, 36920.26159476742, 37311.81344093262, 38657.613423865405, 39174.21651566896, 10806.596701649176, 10881.129509639051, 10936.070434013198, 10946.452677366258, 11118.722031949266, 11617.5352985883, 11653.59212427561, 11750.823737643772, 12109.75780484403, 12539.435725392197, 11091.0, 11307.886921131012, 11363.659090227306, 11626.0, 11934.4032798358, 10945.726356841144, 11000.669979900616, 11393.316401015965, 11495.367754773568, 11576.0, 11153.888461115284, 11167.218294719292, 11220.831687524531, 11654.125940554322, 11985.400729963641, 9373.768414541206, 9478.668246611336, 9711.708648740549, 9852.458114803754, 10001.649942251986, 9574.521273936414, 9880.802383952137, 9891.901080989099, 9925.205983521157, 9997.20022398192], "value": 6044.508938897548, "unit": "score"}], "name": "dromaeo_css", "value": 6378.636561916197, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 107.0, 111.0, 114.0, 113.0, 101.0, 114.0, 111.0, 113.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 134.0, 162.0, 178.0, 133.0, 157.0, 155.0, 133.0, 199.0, 141.0], "value": 155.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 161.0, 164.0, 162.0, 163.0, 161.0, 160.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 77.0, 98.0, 109.0, 75.0, 75.0, 74.0, 115.0, 98.0, 74.0], "value": 86.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 150.0, 95.0, 95.0, 95.0, 144.0, 95.0, 94.0, 142.0], "value": 109.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 65.0, 65.0, 65.0, 65.0, 85.0, 62.0, 64.0], "value": 66.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 63.0, 65.0, 65.0, 64.0], "value": 64.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 79.0, 79.0, 81.0, 80.0, 79.0, 80.0, 80.0, 79.0], "value": 79.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 135.0, 135.0, 133.0, 136.0, 133.0, 141.0, 133.0, 166.0, 133.0], "value": 138.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 194.0, 181.0, 176.0, 182.0, 182.0, 174.0, 173.0, 176.0, 174.0], "value": 178.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 74.0, 73.0, 72.0, 71.0, 73.0, 70.0, 73.0, 73.0], "value": 72.9, "unit": "score"}], "name": "kraken", "value": 1582.6, "alertThreshold": 2.0}]} 22:07:02 INFO - Return code: 0 22:07:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:07:02 ERROR - # TBPL SUCCESS # 22:07:02 INFO - Running post-action listener: _resource_record_post_action 22:07:02 INFO - Running post-run listener: _resource_record_post_run 22:07:03 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 7811072; Write bytes: 441122816; Read time: 2760; Write time: 769280 22:07:03 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 10944512; Read time: 0; Write time: 18340 22:07:03 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 7811072; Write bytes: 384995328; Read time: 2760; Write time: 713240 22:07:03 INFO - Running post-run listener: _upload_blobber_files 22:07:03 INFO - Blob upload gear active. 22:07:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:07:03 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 22:07:03 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:07:03 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:07:03 INFO - (blobuploader) - INFO - Open directory for files ... 22:07:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:07:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:07:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:07:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:07:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:07:04 INFO - (blobuploader) - INFO - Done attempting. 22:07:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:07:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:07:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:07:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:07:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:07:05 INFO - (blobuploader) - INFO - Done attempting. 22:07:05 INFO - (blobuploader) - INFO - Iteration through files over. 22:07:05 INFO - Return code: 0 22:07:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:07:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:07:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/576ff24e2cce85f20ca7191945a0127823f947fbd73367f2fd8d852d0628ed52543c569da25570b3d325ea8456c90470bbe3d26db25b0178fa004f97df3a9d71", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b8222b365c37e4b0ae69e8a4d9a8823e17e0a5431f35f5a65c3ed1ee1aa3ca79e4e74e2ab369284e5994455000c5dd8dc28354cf237c5ab39a891e45efaa6ab0"} 22:07:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:07:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:07:05 INFO - Contents: 22:07:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/576ff24e2cce85f20ca7191945a0127823f947fbd73367f2fd8d852d0628ed52543c569da25570b3d325ea8456c90470bbe3d26db25b0178fa004f97df3a9d71", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b8222b365c37e4b0ae69e8a4d9a8823e17e0a5431f35f5a65c3ed1ee1aa3ca79e4e74e2ab369284e5994455000c5dd8dc28354cf237c5ab39a891e45efaa6ab0"} 22:07:05 INFO - Running post-run listener: copy_logs_to_upload_dir 22:07:05 INFO - Copying logs to upload dir... 22:07:05 INFO - mkdir: /builds/slave/test/build/upload/logs 22:07:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.743829 ========= master_lag: 10.70 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-04-16 22:07:16.003405) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-16 22:07:16.007532) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1460864793.673689-597899995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/576ff24e2cce85f20ca7191945a0127823f947fbd73367f2fd8d852d0628ed52543c569da25570b3d325ea8456c90470bbe3d26db25b0178fa004f97df3a9d71", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b8222b365c37e4b0ae69e8a4d9a8823e17e0a5431f35f5a65c3ed1ee1aa3ca79e4e74e2ab369284e5994455000c5dd8dc28354cf237c5ab39a891e45efaa6ab0"} build_url:https://queue.taskcluster.net/v1/task/ItEmY08LT0qOSumJOEWNXA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009731 build_url: 'https://queue.taskcluster.net/v1/task/ItEmY08LT0qOSumJOEWNXA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/576ff24e2cce85f20ca7191945a0127823f947fbd73367f2fd8d852d0628ed52543c569da25570b3d325ea8456c90470bbe3d26db25b0178fa004f97df3a9d71", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b8222b365c37e4b0ae69e8a4d9a8823e17e0a5431f35f5a65c3ed1ee1aa3ca79e4e74e2ab369284e5994455000c5dd8dc28354cf237c5ab39a891e45efaa6ab0"}' ========= master_lag: 0.16 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-16 22:07:16.177914) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 22:07:16.182276) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1460864793.673689-597899995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004466 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 22:07:16.208557) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-16 22:07:16.208848) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-16 22:07:16.213905) ========= ========= Total master_lag: 10.98 =========