builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-055 starttime: 1461767440.84 results: success (0) buildid: 20160427071020 builduid: c68ab51b35d04f3eb59d2ae2ec182e95 revision: ed934827bebaeee8a1aeb1726a3af1021d2a8364 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 07:30:40.839650) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 07:30:40.841271) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 07:30:40.841573) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 07:30:40.858295) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 07:30:40.858720) ========= 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=82e07478c745e68b1fe4678a000001bc-1461766961.877596-1673116342 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-27 07:30:41-- 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% 82.8M=0s 2016-04-27 07:30:41 (82.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.080213 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 07:30:40.953920) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 07:30:40.954225) ========= 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=82e07478c745e68b1fe4678a000001bc-1461766961.877596-1673116342 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021034 ========= master_lag: 0.24 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 07:30:41.210403) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 07:30:41.210778) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ed934827bebaeee8a1aeb1726a3af1021d2a8364 --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 ed934827bebaeee8a1aeb1726a3af1021d2a8364 --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=82e07478c745e68b1fe4678a000001bc-1461766961.877596-1673116342 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-27 07:30:41,749 truncating revision to first 12 chars 2016-04-27 07:30:41,750 Setting DEBUG logging. 2016-04-27 07:30:41,750 attempt 1/10 2016-04-27 07:30:41,750 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ed934827beba?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-27 07:30:42,036 unpacking tar archive at: fx-team-ed934827beba/testing/mozharness/ program finished with exit code 0 elapsedTime=0.571640 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 07:30:41.800185) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 07:30:41.800451) ========= script_repo_revision: ed934827bebaeee8a1aeb1726a3af1021d2a8364 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 07:30:41.800819) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 07:30:41.801176) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 07:30:41.810506) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-04-27 07:30:41.810789) ========= /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=82e07478c745e68b1fe4678a000001bc-1461766961.877596-1673116342 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:30:42 INFO - MultiFileLogger online at 20160427 07:30:42 in /builds/slave/test 07:30:42 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 07:30:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:30:42 INFO - {'append_to_log': False, 07:30:42 INFO - 'base_work_dir': '/builds/slave/test', 07:30:42 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:30:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:30:42 INFO - 'branch': 'Fx-Team-Non-PGO', 07:30:42 INFO - 'buildbot_json_path': 'buildprops.json', 07:30:42 INFO - 'config_files': ('talos/linux_config.py',), 07:30:42 INFO - 'default_actions': ('clobber', 07:30:42 INFO - 'read-buildbot-config', 07:30:42 INFO - 'download-and-extract', 07:30:42 INFO - 'populate-webroot', 07:30:42 INFO - 'create-virtualenv', 07:30:42 INFO - 'install', 07:30:42 INFO - 'run-tests'), 07:30:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:30:42 INFO - 'download_minidump_stackwalk': True, 07:30:42 INFO - 'download_symbols': 'ondemand', 07:30:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:30:42 INFO - 'tooltool.py': '/tools/tooltool.py', 07:30:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:30:42 INFO - '/tools/misc-python/virtualenv.py')}, 07:30:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:30:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:30:42 INFO - 'installer_path': 'installer.exe', 07:30:42 INFO - 'log_level': 'info', 07:30:42 INFO - 'log_name': 'talos', 07:30:42 INFO - 'log_to_console': True, 07:30:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:30:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:30:42 INFO - 'opt_config_files': (), 07:30:42 INFO - 'pip_index': False, 07:30:42 INFO - 'sps_profile': False, 07:30:42 INFO - 'sps_profile_interval': 0, 07:30:42 INFO - 'suite': 'dromaeojs', 07:30:42 INFO - 'system_bits': '32', 07:30:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:30:42 INFO - 'title': 'talos-linux64-ix-055', 07:30:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:30:42 INFO - 'use_talos_json': True, 07:30:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:30:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:30:42 INFO - 'work_dir': 'build'} 07:30:42 INFO - ##### 07:30:42 INFO - ##### Running clobber step. 07:30:42 INFO - ##### 07:30:42 INFO - Running pre-action listener: _resource_record_pre_action 07:30:42 INFO - Running main action method: clobber 07:30:42 INFO - rmtree: /builds/slave/test/build 07:30:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:30:42 INFO - Running post-action listener: _resource_record_post_action 07:30:42 INFO - ##### 07:30:42 INFO - ##### Running read-buildbot-config step. 07:30:42 INFO - ##### 07:30:42 INFO - Running pre-action listener: _resource_record_pre_action 07:30:42 INFO - Running main action method: read_buildbot_config 07:30:42 INFO - Using buildbot properties: 07:30:42 INFO - { 07:30:42 INFO - "project": "", 07:30:42 INFO - "product": "firefox", 07:30:42 INFO - "script_repo_revision": "production", 07:30:42 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 07:30:42 INFO - "repository": "", 07:30:42 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 07:30:42 INFO - "buildid": "20160427071020", 07:30:42 INFO - "pgo_build": "False", 07:30:42 INFO - "basedir": "/builds/slave/test", 07:30:42 INFO - "buildnumber": 2900, 07:30:42 INFO - "slavename": "talos-linux64-ix-055", 07:30:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:30:42 INFO - "platform": "ubuntu64_hw", 07:30:42 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:30:42 INFO - "branch": "fx-team", 07:30:42 INFO - "repo_path": "integration/fx-team", 07:30:42 INFO - "revision": "ed934827bebaeee8a1aeb1726a3af1021d2a8364", 07:30:42 INFO - "stage_platform": "linux64", 07:30:42 INFO - "builduid": "c68ab51b35d04f3eb59d2ae2ec182e95", 07:30:42 INFO - "slavebuilddir": "test" 07:30:42 INFO - } 07:30:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/JNpWz5iKRZqd5ze4Ucr82g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 07:30:42 INFO - Running post-action listener: _resource_record_post_action 07:30:42 INFO - ##### 07:30:42 INFO - ##### Running download-and-extract step. 07:30:42 INFO - ##### 07:30:42 INFO - Running pre-action listener: _resource_record_pre_action 07:30:42 INFO - Running main action method: download_and_extract 07:30:42 INFO - mkdir: /builds/slave/test/build/tests 07:30:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:30:42 INFO - https://queue.taskcluster.net/v1/task/JNpWz5iKRZqd5ze4Ucr82g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:30:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JNpWz5iKRZqd5ze4Ucr82g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:30:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JNpWz5iKRZqd5ze4Ucr82g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:30:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JNpWz5iKRZqd5ze4Ucr82g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:30:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JNpWz5iKRZqd5ze4Ucr82g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:30:46 INFO - Downloaded 1361 bytes. 07:30:46 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:30:46 INFO - Using the following test package requirements: 07:30:46 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:30:46 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:30:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:30:46 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:30:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:30:46 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:30:46 INFO - u'jsshell-linux-x86_64.zip'], 07:30:46 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:30:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:30:46 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:30:46 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:30:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:30:46 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:30:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:30:46 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:30:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:30:46 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:30:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:30:46 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:30: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')]} 07:30:46 INFO - https://queue.taskcluster.net/v1/task/JNpWz5iKRZqd5ze4Ucr82g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:30:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JNpWz5iKRZqd5ze4Ucr82g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:30:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JNpWz5iKRZqd5ze4Ucr82g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:30:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JNpWz5iKRZqd5ze4Ucr82g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:30:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JNpWz5iKRZqd5ze4Ucr82g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:30:50 INFO - Downloaded 22294896 bytes. 07:30:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:30:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:30:51 INFO - Return code: 0 07:30:51 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:30:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:30:51 INFO - https://queue.taskcluster.net/v1/task/JNpWz5iKRZqd5ze4Ucr82g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:30:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JNpWz5iKRZqd5ze4Ucr82g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:30:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JNpWz5iKRZqd5ze4Ucr82g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:30:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JNpWz5iKRZqd5ze4Ucr82g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:30:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JNpWz5iKRZqd5ze4Ucr82g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:31:08 INFO - Downloaded 22294896 bytes. 07:31:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:31:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:31:09 INFO - Return code: 0 07:31:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:31:09 INFO - https://queue.taskcluster.net/v1/task/JNpWz5iKRZqd5ze4Ucr82g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:31:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JNpWz5iKRZqd5ze4Ucr82g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:31:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JNpWz5iKRZqd5ze4Ucr82g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:31:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JNpWz5iKRZqd5ze4Ucr82g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:31:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JNpWz5iKRZqd5ze4Ucr82g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:31:10 INFO - Downloaded 10840145 bytes. 07:31:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:31:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:31:11 INFO - Return code: 0 07:31:11 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')]} 07:31:11 INFO - https://queue.taskcluster.net/v1/task/JNpWz5iKRZqd5ze4Ucr82g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:31:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JNpWz5iKRZqd5ze4Ucr82g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:31:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JNpWz5iKRZqd5ze4Ucr82g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:31:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JNpWz5iKRZqd5ze4Ucr82g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:31:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JNpWz5iKRZqd5ze4Ucr82g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:31:14 INFO - Downloaded 54815054 bytes. 07:31:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JNpWz5iKRZqd5ze4Ucr82g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:31:14 INFO - mkdir: /builds/slave/test/properties 07:31:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:31:14 INFO - Writing to file /builds/slave/test/properties/build_url 07:31:14 INFO - Contents: 07:31:14 INFO - build_url:https://queue.taskcluster.net/v1/task/JNpWz5iKRZqd5ze4Ucr82g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:31:14 INFO - Running post-action listener: _resource_record_post_action 07:31:14 INFO - Running post-action listener: set_extra_try_arguments 07:31:14 INFO - ##### 07:31:14 INFO - ##### Running populate-webroot step. 07:31:14 INFO - ##### 07:31:14 INFO - Running pre-action listener: _resource_record_pre_action 07:31:14 INFO - Running main action method: populate_webroot 07:31:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:31:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:31:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:31:14 INFO - '--tppagecycles', 07:31:14 INFO - '7'], 07:31:14 INFO - 'tests': ['tsvgm']}}, 07:31:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:31:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:31:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:31:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:31:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:31:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:31:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:31:14 INFO - 'talos_options': ['--disable-e10s'], 07:31:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:31:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:31:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:31:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:31:14 INFO - 'talos_options': ['--disable-e10s'], 07:31:14 INFO - 'tests': ['damp', 'tps']}, 07:31:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:31:14 INFO - 'tests': ['damp', 'tps']}, 07:31:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:31:14 INFO - 'tests': ['dromaeo_dom']}, 07:31:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:31:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:31:14 INFO - 'tests': ['a11yr', 07:31:14 INFO - 'ts_paint', 07:31:14 INFO - 'tpaint', 07:31:14 INFO - 'sessionrestore', 07:31:14 INFO - 'sessionrestore_no_auto_restore', 07:31:14 INFO - 'tabpaint']}, 07:31:14 INFO - 'other-e10s': {'tests': ['a11yr', 07:31:14 INFO - 'ts_paint', 07:31:14 INFO - 'tpaint', 07:31:14 INFO - 'sessionrestore', 07:31:14 INFO - 'sessionrestore_no_auto_restore', 07:31:14 INFO - 'tabpaint']}, 07:31:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:31:14 INFO - 'ts_paint', 07:31:14 INFO - 'tpaint', 07:31:14 INFO - 'sessionrestore', 07:31:14 INFO - 'sessionrestore_no_auto_restore', 07:31:14 INFO - 'tabpaint']}, 07:31:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:31:14 INFO - 'ts_paint', 07:31:14 INFO - 'tpaint', 07:31:14 INFO - 'sessionrestore', 07:31:14 INFO - 'sessionrestore_no_auto_restore', 07:31:14 INFO - 'tabpaint']}, 07:31:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:31:14 INFO - 'tests': ['a11yr', 07:31:14 INFO - 'ts_paint', 07:31:14 INFO - 'tpaint', 07:31:14 INFO - 'sessionrestore', 07:31:14 INFO - 'sessionrestore_no_auto_restore', 07:31:14 INFO - 'tabpaint']}, 07:31:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:31:14 INFO - 'tests': ['a11yr', 07:31:14 INFO - 'ts_paint', 07:31:14 INFO - 'tpaint', 07:31:14 INFO - 'sessionrestore', 07:31:14 INFO - 'sessionrestore_no_auto_restore', 07:31:14 INFO - 'tabpaint']}, 07:31:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:31:14 INFO - 'tests': ['tsvgx', 07:31:14 INFO - 'tsvgr_opacity', 07:31:14 INFO - 'tart', 07:31:14 INFO - 'tscrollx', 07:31:14 INFO - 'cart']}, 07:31:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:31:14 INFO - 'tsvgr_opacity', 07:31:14 INFO - 'tart', 07:31:14 INFO - 'tscrollx', 07:31:14 INFO - 'cart']}, 07:31:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:31:14 INFO - 'talos_options': ['--disable-e10s'], 07:31:14 INFO - 'tests': ['tp5o']}, 07:31:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:31:14 INFO - 'tests': ['tp5o']}, 07:31:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:31:14 INFO - 'talos_options': ['--disable-e10s', 07:31:14 INFO - '--xperf_path', 07:31:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:31:14 INFO - 'tests': ['tp5n']}, 07:31:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:31:14 INFO - 'talos_options': ['--xperf_path', 07:31:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:31:14 INFO - 'tests': ['tp5n']}}, 07:31:14 INFO - 'talos.zip': {'path': '', 07:31:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:31:14 INFO - Running post-action listener: _resource_record_post_action 07:31:14 INFO - ##### 07:31:14 INFO - ##### Running create-virtualenv step. 07:31:14 INFO - ##### 07:31:14 INFO - Running pre-action listener: _resource_record_pre_action 07:31:14 INFO - Running main action method: create_virtualenv 07:31:14 INFO - Creating virtualenv /builds/slave/test/build/venv 07:31:14 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 07:31:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:31:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:31:15 INFO - Using real prefix '/usr' 07:31:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:31:15 INFO - Installing distribute.............................................................................................................................................................................................done. 07:31:17 INFO - Installing pip.................done. 07:31:17 INFO - Return code: 0 07:31:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:31: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')]} 07:31:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31: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')]} 07:31:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:17 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 0x7f62879f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18945a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1923410>, '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 0x1924310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19247a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461766961.877596-1673116342', '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 07:31:17 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 07:31:17 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 07:31:17 INFO - Using env: {'DISPLAY': ':0', 07:31:17 INFO - 'HOME': '/home/cltbld', 07:31:17 INFO - 'LANG': 'en_US.UTF-8', 07:31:17 INFO - 'LANGUAGE': 'en_US:en', 07:31:17 INFO - 'LOGNAME': 'cltbld', 07:31:17 INFO - 'MAIL': '/var/mail/cltbld', 07:31:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:17 INFO - 'MOZ_NO_REMOTE': '1', 07:31:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:31:17 INFO - 'NO_EM_RESTART': '1', 07:31:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:31:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:17 INFO - 'PWD': '/builds/slave/test', 07:31:17 INFO - 'SHELL': '/bin/bash', 07:31:17 INFO - 'SHLVL': '1', 07:31:17 INFO - 'TERM': 'linux', 07:31:17 INFO - 'TMOUT': '86400', 07:31:17 INFO - 'USER': 'cltbld', 07:31:17 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461766961.877596-1673116342', 07:31:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:17 INFO - '_': '/tools/buildbot/bin/python'} 07:31:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:17 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 07:31:17 INFO - Cleaning up... 07:31:17 INFO - Return code: 0 07:31:17 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:31: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')]} 07:31:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31: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')]} 07:31:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:17 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 0x7f62879f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18945a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1923410>, '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 0x1924310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19247a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461766961.877596-1673116342', '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 07:31:17 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 07:31:17 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 07:31:17 INFO - Using env: {'DISPLAY': ':0', 07:31:17 INFO - 'HOME': '/home/cltbld', 07:31:17 INFO - 'LANG': 'en_US.UTF-8', 07:31:17 INFO - 'LANGUAGE': 'en_US:en', 07:31:17 INFO - 'LOGNAME': 'cltbld', 07:31:17 INFO - 'MAIL': '/var/mail/cltbld', 07:31:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:17 INFO - 'MOZ_NO_REMOTE': '1', 07:31:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:31:17 INFO - 'NO_EM_RESTART': '1', 07:31:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:31:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:17 INFO - 'PWD': '/builds/slave/test', 07:31:17 INFO - 'SHELL': '/bin/bash', 07:31:17 INFO - 'SHLVL': '1', 07:31:17 INFO - 'TERM': 'linux', 07:31:17 INFO - 'TMOUT': '86400', 07:31:17 INFO - 'USER': 'cltbld', 07:31:17 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461766961.877596-1673116342', 07:31:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:17 INFO - '_': '/tools/buildbot/bin/python'} 07:31:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:17 INFO - Downloading/unpacking psutil>=0.7.1 07:31:17 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 07:31:17 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 07:31:17 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 07:31:17 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 07:31:17 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 07:31:17 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 07:31:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:31:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:31:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:31:19 INFO - Installing collected packages: psutil 07:31:19 INFO - Running setup.py install for psutil 07:31:19 INFO - building 'psutil._psutil_linux' extension 07:31:19 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 07:31:20 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 07:31:20 INFO - building 'psutil._psutil_posix' extension 07:31:20 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 07:31:20 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 07:31:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:31:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:31:20 INFO - Successfully installed psutil 07:31:20 INFO - Cleaning up... 07:31:20 INFO - Return code: 0 07:31:20 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:31:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:31:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:31:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:20 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 0x7f62879f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18945a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1923410>, '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 0x1924310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19247a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461766961.877596-1673116342', '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 07:31:20 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 07:31:20 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 07:31:20 INFO - Using env: {'DISPLAY': ':0', 07:31:20 INFO - 'HOME': '/home/cltbld', 07:31:20 INFO - 'LANG': 'en_US.UTF-8', 07:31:20 INFO - 'LANGUAGE': 'en_US:en', 07:31:20 INFO - 'LOGNAME': 'cltbld', 07:31:20 INFO - 'MAIL': '/var/mail/cltbld', 07:31:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:20 INFO - 'MOZ_NO_REMOTE': '1', 07:31:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:31:20 INFO - 'NO_EM_RESTART': '1', 07:31:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:31:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:20 INFO - 'PWD': '/builds/slave/test', 07:31:20 INFO - 'SHELL': '/bin/bash', 07:31:20 INFO - 'SHLVL': '1', 07:31:20 INFO - 'TERM': 'linux', 07:31:20 INFO - 'TMOUT': '86400', 07:31:20 INFO - 'USER': 'cltbld', 07:31:20 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461766961.877596-1673116342', 07:31:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:20 INFO - '_': '/tools/buildbot/bin/python'} 07:31:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:20 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:31:20 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 07:31:20 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 07:31:20 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 07:31:20 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 07:31:20 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 07:31:20 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 07:31:22 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:31:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:31:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:31:22 INFO - Installing collected packages: mozsystemmonitor 07:31:22 INFO - Running setup.py install for mozsystemmonitor 07:31:22 INFO - Successfully installed mozsystemmonitor 07:31:22 INFO - Cleaning up... 07:31:22 INFO - Return code: 0 07:31:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:31: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')]} 07:31:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31: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')]} 07:31:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:22 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 0x7f62879f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18945a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1923410>, '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 0x1924310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19247a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461766961.877596-1673116342', '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 07:31:22 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 07:31:22 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 07:31:22 INFO - Using env: {'DISPLAY': ':0', 07:31:22 INFO - 'HOME': '/home/cltbld', 07:31:22 INFO - 'LANG': 'en_US.UTF-8', 07:31:22 INFO - 'LANGUAGE': 'en_US:en', 07:31:22 INFO - 'LOGNAME': 'cltbld', 07:31:22 INFO - 'MAIL': '/var/mail/cltbld', 07:31:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:22 INFO - 'MOZ_NO_REMOTE': '1', 07:31:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:31:22 INFO - 'NO_EM_RESTART': '1', 07:31:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:31:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:22 INFO - 'PWD': '/builds/slave/test', 07:31:22 INFO - 'SHELL': '/bin/bash', 07:31:22 INFO - 'SHLVL': '1', 07:31:22 INFO - 'TERM': 'linux', 07:31:22 INFO - 'TMOUT': '86400', 07:31:22 INFO - 'USER': 'cltbld', 07:31:22 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461766961.877596-1673116342', 07:31:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:22 INFO - '_': '/tools/buildbot/bin/python'} 07:31:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:22 INFO - Downloading/unpacking blobuploader==1.2.4 07:31:22 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 07:31:22 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 07:31:22 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 07:31:22 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 07:31:22 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 07:31:22 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 07:31:24 INFO - Downloading blobuploader-1.2.4.tar.gz 07:31:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:31:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:31:24 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 07:31:24 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 07:31:24 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 07:31:24 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 07:31:24 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 07:31:24 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 07:31:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:31:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:31:25 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 07:31:25 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 07:31:25 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 07:31:25 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 07:31:25 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 07:31:25 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 07:31:25 INFO - Downloading docopt-0.6.1.tar.gz 07:31:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:31:25 INFO - Installing collected packages: blobuploader, requests, docopt 07:31:25 INFO - Running setup.py install for blobuploader 07:31:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:31:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:31:25 INFO - Running setup.py install for requests 07:31:25 INFO - Running setup.py install for docopt 07:31:26 INFO - Successfully installed blobuploader requests docopt 07:31:26 INFO - Cleaning up... 07:31:26 INFO - Return code: 0 07:31:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:31:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:31:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:31:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:26 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 0x7f62879f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18945a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1923410>, '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 0x1924310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19247a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461766961.877596-1673116342', '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 07:31:26 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 07:31:26 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 07:31:26 INFO - Using env: {'DISPLAY': ':0', 07:31:26 INFO - 'HOME': '/home/cltbld', 07:31:26 INFO - 'LANG': 'en_US.UTF-8', 07:31:26 INFO - 'LANGUAGE': 'en_US:en', 07:31:26 INFO - 'LOGNAME': 'cltbld', 07:31:26 INFO - 'MAIL': '/var/mail/cltbld', 07:31:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:26 INFO - 'MOZ_NO_REMOTE': '1', 07:31:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:31:26 INFO - 'NO_EM_RESTART': '1', 07:31:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:31:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:26 INFO - 'PWD': '/builds/slave/test', 07:31:26 INFO - 'SHELL': '/bin/bash', 07:31:26 INFO - 'SHLVL': '1', 07:31:26 INFO - 'TERM': 'linux', 07:31:26 INFO - 'TMOUT': '86400', 07:31:26 INFO - 'USER': 'cltbld', 07:31:26 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461766961.877596-1673116342', 07:31:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:26 INFO - '_': '/tools/buildbot/bin/python'} 07:31:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:31:26 INFO - Running setup.py (path:/tmp/pip-737bOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:31:26 INFO - Running setup.py (path:/tmp/pip-ucrx1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:31:26 INFO - Running setup.py (path:/tmp/pip-NPQS1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:31:26 INFO - Running setup.py (path:/tmp/pip-agL7H3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:31:26 INFO - Running setup.py (path:/tmp/pip-EIzZbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:31:26 INFO - Running setup.py (path:/tmp/pip-m0RF40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:31:26 INFO - Running setup.py (path:/tmp/pip-qNVf3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:31:26 INFO - Running setup.py (path:/tmp/pip-ZcjH0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:31:26 INFO - Running setup.py (path:/tmp/pip-IfJTAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:31:26 INFO - Running setup.py (path:/tmp/pip-Lb3lVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:31:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:31:27 INFO - Running setup.py (path:/tmp/pip-nnmcGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:31:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:31:27 INFO - Running setup.py (path:/tmp/pip-E7fpmy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:31:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:31:27 INFO - Running setup.py (path:/tmp/pip-6Efd1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:31:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:31:27 INFO - Running setup.py (path:/tmp/pip-d3IR0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:31:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:31:27 INFO - Running setup.py (path:/tmp/pip-c_2A68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:31:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:31:27 INFO - Running setup.py (path:/tmp/pip-STLT5Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:31:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:31:27 INFO - Running setup.py (path:/tmp/pip-RyAJMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:31:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:31:27 INFO - Running setup.py install for manifestparser 07:31:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:31:27 INFO - Running setup.py install for mozcrash 07:31:27 INFO - Running setup.py install for mozdebug 07:31:27 INFO - Running setup.py install for mozdevice 07:31:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:31:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:31:27 INFO - Running setup.py install for mozfile 07:31:28 INFO - Running setup.py install for mozhttpd 07:31:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:31:28 INFO - Running setup.py install for mozinfo 07:31:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:31:28 INFO - Running setup.py install for mozInstall 07:31:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:31:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:31:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:31:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:31:28 INFO - Running setup.py install for mozleak 07:31:28 INFO - Running setup.py install for mozlog 07:31:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:31:28 INFO - Running setup.py install for moznetwork 07:31:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:31:28 INFO - Running setup.py install for mozprocess 07:31:28 INFO - Running setup.py install for mozprofile 07:31:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:31:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:31:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:31:28 INFO - Running setup.py install for mozrunner 07:31:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:31:29 INFO - Running setup.py install for mozscreenshot 07:31:29 INFO - Running setup.py install for moztest 07:31:29 INFO - Running setup.py install for mozversion 07:31:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:31:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:31:29 INFO - Cleaning up... 07:31:29 INFO - Return code: 0 07:31:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:31: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')]} 07:31:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31: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')]} 07:31:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:29 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 0x7f62879f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18945a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1923410>, '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 0x1924310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19247a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461766961.877596-1673116342', '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 07:31:29 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 07:31:29 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 07:31:29 INFO - Using env: {'DISPLAY': ':0', 07:31:29 INFO - 'HOME': '/home/cltbld', 07:31:29 INFO - 'LANG': 'en_US.UTF-8', 07:31:29 INFO - 'LANGUAGE': 'en_US:en', 07:31:29 INFO - 'LOGNAME': 'cltbld', 07:31:29 INFO - 'MAIL': '/var/mail/cltbld', 07:31:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:29 INFO - 'MOZ_NO_REMOTE': '1', 07:31:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:31:29 INFO - 'NO_EM_RESTART': '1', 07:31:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:31:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:29 INFO - 'PWD': '/builds/slave/test', 07:31:29 INFO - 'SHELL': '/bin/bash', 07:31:29 INFO - 'SHLVL': '1', 07:31:29 INFO - 'TERM': 'linux', 07:31:29 INFO - 'TMOUT': '86400', 07:31:29 INFO - 'USER': 'cltbld', 07:31:29 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461766961.877596-1673116342', 07:31:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:29 INFO - '_': '/tools/buildbot/bin/python'} 07:31:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:31:29 INFO - Running setup.py (path:/tmp/pip-8oGlbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:31:29 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)) 07:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:31:29 INFO - Running setup.py (path:/tmp/pip-mp7aq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:31:29 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)) 07:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:31:29 INFO - Running setup.py (path:/tmp/pip-dC_Xrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:31:29 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)) 07:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:31:29 INFO - Running setup.py (path:/tmp/pip-5pWeXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:31:29 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)) 07:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:31:29 INFO - Running setup.py (path:/tmp/pip-CtZzP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:31:29 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)) 07:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:31:29 INFO - Running setup.py (path:/tmp/pip-1xper7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:31:29 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)) 07:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:31:29 INFO - Running setup.py (path:/tmp/pip-MiE3Hd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:31:30 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)) 07:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:31:30 INFO - Running setup.py (path:/tmp/pip-cg7EBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:31:30 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)) 07:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:31:30 INFO - Running setup.py (path:/tmp/pip-OpCOYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:31:30 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)) 07:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:31:30 INFO - Running setup.py (path:/tmp/pip-rl_biX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:31:30 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)) 07:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:31:30 INFO - Running setup.py (path:/tmp/pip-VBvfi_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:31:30 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)) 07:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:31:30 INFO - Running setup.py (path:/tmp/pip-lLRh_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:31:30 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)) 07:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:31:30 INFO - Running setup.py (path:/tmp/pip-gmIqkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:31:30 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)) 07:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:31:30 INFO - Running setup.py (path:/tmp/pip-RnzErK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:31:30 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)) 07:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:31:30 INFO - Running setup.py (path:/tmp/pip-wNJMMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:31:30 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)) 07:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:31:30 INFO - Running setup.py (path:/tmp/pip-pZhleY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:31:30 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)) 07:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:31:30 INFO - Running setup.py (path:/tmp/pip-faUeIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:31:30 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)) 07:31:30 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)) 07:31:30 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)) 07:31:30 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)) 07:31:30 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)) 07:31:30 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)) 07:31:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:31:30 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 07:31:30 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 07:31:30 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 07:31:30 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 07:31:30 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 07:31:30 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 07:31:32 INFO - Downloading blessings-1.6.tar.gz 07:31:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:31:32 INFO - Installing collected packages: blessings 07:31:32 INFO - Running setup.py install for blessings 07:31:32 INFO - Successfully installed blessings 07:31:32 INFO - Cleaning up... 07:31:32 INFO - Return code: 0 07:31:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:31:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:31:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:31:33 INFO - Reading from file tmpfile_stdout 07:31:33 INFO - Current package versions: 07:31:33 INFO - argparse == 1.2.1 07:31:33 INFO - blessings == 1.6 07:31:33 INFO - blobuploader == 1.2.4 07:31:33 INFO - docopt == 0.6.1 07:31:33 INFO - manifestparser == 1.1 07:31:33 INFO - mozInstall == 1.12 07:31:33 INFO - mozcrash == 0.17 07:31:33 INFO - mozdebug == 0.1 07:31:33 INFO - mozdevice == 0.48 07:31:33 INFO - mozfile == 1.2 07:31:33 INFO - mozhttpd == 0.7 07:31:33 INFO - mozinfo == 0.9 07:31:33 INFO - mozleak == 0.1 07:31:33 INFO - mozlog == 3.1 07:31:33 INFO - moznetwork == 0.27 07:31:33 INFO - mozprocess == 0.22 07:31:33 INFO - mozprofile == 0.28 07:31:33 INFO - mozrunner == 6.11 07:31:33 INFO - mozscreenshot == 0.1 07:31:33 INFO - mozsystemmonitor == 0.0 07:31:33 INFO - moztest == 0.7 07:31:33 INFO - mozversion == 1.4 07:31:33 INFO - psutil == 3.1.1 07:31:33 INFO - requests == 1.2.3 07:31:33 INFO - wsgiref == 0.1.2 07:31:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:31:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:31:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:33 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 0x7f62879f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18945a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1923410>, '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 0x1924310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19247a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461766961.877596-1673116342', '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 07:31:33 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 07:31:33 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 07:31:33 INFO - Using env: {'DISPLAY': ':0', 07:31:33 INFO - 'HOME': '/home/cltbld', 07:31:33 INFO - 'LANG': 'en_US.UTF-8', 07:31:33 INFO - 'LANGUAGE': 'en_US:en', 07:31:33 INFO - 'LOGNAME': 'cltbld', 07:31:33 INFO - 'MAIL': '/var/mail/cltbld', 07:31:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:33 INFO - 'MOZ_NO_REMOTE': '1', 07:31:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:31:33 INFO - 'NO_EM_RESTART': '1', 07:31:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:31:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:33 INFO - 'PWD': '/builds/slave/test', 07:31:33 INFO - 'SHELL': '/bin/bash', 07:31:33 INFO - 'SHLVL': '1', 07:31:33 INFO - 'TERM': 'linux', 07:31:33 INFO - 'TMOUT': '86400', 07:31:33 INFO - 'USER': 'cltbld', 07:31:33 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461766961.877596-1673116342', 07:31:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:33 INFO - '_': '/tools/buildbot/bin/python'} 07:31:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:33 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)) 07:31:33 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)) 07:31:33 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)) 07:31:33 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)) 07:31:33 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)) 07:31:33 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)) 07:31:33 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)) 07:31:33 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)) 07:31:33 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)) 07:31:33 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)) 07:31:33 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)) 07:31:33 INFO - Cleaning up... 07:31:33 INFO - Return code: 0 07:31:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:31:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:31:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:33 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 0x7f62879f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18945a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1923410>, '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 0x1924310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19247a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461766961.877596-1673116342', '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 07:31:33 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 07:31:33 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 07:31:33 INFO - Using env: {'DISPLAY': ':0', 07:31:33 INFO - 'HOME': '/home/cltbld', 07:31:33 INFO - 'LANG': 'en_US.UTF-8', 07:31:33 INFO - 'LANGUAGE': 'en_US:en', 07:31:33 INFO - 'LOGNAME': 'cltbld', 07:31:33 INFO - 'MAIL': '/var/mail/cltbld', 07:31:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:33 INFO - 'MOZ_NO_REMOTE': '1', 07:31:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:31:33 INFO - 'NO_EM_RESTART': '1', 07:31:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:31:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:33 INFO - 'PWD': '/builds/slave/test', 07:31:33 INFO - 'SHELL': '/bin/bash', 07:31:33 INFO - 'SHLVL': '1', 07:31:33 INFO - 'TERM': 'linux', 07:31:33 INFO - 'TMOUT': '86400', 07:31:33 INFO - 'USER': 'cltbld', 07:31:33 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461766961.877596-1673116342', 07:31:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:33 INFO - '_': '/tools/buildbot/bin/python'} 07:31:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:33 INFO - Downloading/unpacking jsonschema 07:31:33 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 07:31:33 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 07:31:33 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 07:31:33 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 07:31:33 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 07:31:33 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 07:31:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:31:35 INFO - Downloading/unpacking functools32 (from jsonschema) 07:31:35 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 07:31:35 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 07:31:35 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 07:31:35 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 07:31:35 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 07:31:35 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 07:31:35 INFO - Downloading functools32-3.2.3-2.tar.gz 07:31:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:31:35 INFO - warning: no files found matching '*.txt' 07:31:35 INFO - no previously-included directories found matching 'build' 07:31:35 INFO - no previously-included directories found matching 'dist' 07:31:35 INFO - no previously-included directories found matching '.git*' 07:31:35 INFO - Installing collected packages: jsonschema, functools32 07:31:35 INFO - Running setup.py install for functools32 07:31:35 INFO - warning: no files found matching '*.txt' 07:31:35 INFO - no previously-included directories found matching 'build' 07:31:35 INFO - no previously-included directories found matching 'dist' 07:31:35 INFO - no previously-included directories found matching '.git*' 07:31:35 INFO - Successfully installed jsonschema functools32 07:31:35 INFO - Cleaning up... 07:31:35 INFO - Return code: 0 07:31:35 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:31: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')]} 07:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31: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')]} 07:31:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f62879f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18945a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1923410>, '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 0x1924310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19247a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461766961.877596-1673116342', '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 07:31: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', 'flake8'] in /builds/slave/test/build 07:31: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 flake8 07:31:35 INFO - Using env: {'DISPLAY': ':0', 07:31:35 INFO - 'HOME': '/home/cltbld', 07:31:35 INFO - 'LANG': 'en_US.UTF-8', 07:31:35 INFO - 'LANGUAGE': 'en_US:en', 07:31:35 INFO - 'LOGNAME': 'cltbld', 07:31:35 INFO - 'MAIL': '/var/mail/cltbld', 07:31:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:35 INFO - 'MOZ_NO_REMOTE': '1', 07:31:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:31:35 INFO - 'NO_EM_RESTART': '1', 07:31:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:31:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:35 INFO - 'PWD': '/builds/slave/test', 07:31:35 INFO - 'SHELL': '/bin/bash', 07:31:35 INFO - 'SHLVL': '1', 07:31:35 INFO - 'TERM': 'linux', 07:31:35 INFO - 'TMOUT': '86400', 07:31:35 INFO - 'USER': 'cltbld', 07:31:35 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461766961.877596-1673116342', 07:31:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:35 INFO - '_': '/tools/buildbot/bin/python'} 07:31:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:36 INFO - Downloading/unpacking flake8 07:31: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 07:31: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 07:31: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 07:31: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 07:31: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 07:31: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 07:31:37 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:31:37 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:31:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:31:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:31:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:31:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:31:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:31:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:31:38 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 07:31:38 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 07:31:38 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 07:31:38 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 07:31:38 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 07:31:38 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 07:31:38 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:31:38 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 07:31:38 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 07:31:38 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 07:31:38 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 07:31:38 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 07:31:38 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 07:31:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:31:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:31:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:31:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:31:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:31:38 INFO - no previously-included directories found matching 'docs/_build' 07:31:38 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:31:38 INFO - Running setup.py install for pep8 07:31:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:31:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:31:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:31:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:31:38 INFO - no previously-included directories found matching 'docs/_build' 07:31:38 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:31:38 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:31:38 INFO - Cleaning up... 07:31:38 INFO - Return code: 0 07:31:38 INFO - Running post-action listener: _resource_record_post_action 07:31:38 INFO - Running post-action listener: _start_resource_monitoring 07:31:38 INFO - Starting resource monitoring. 07:31:38 INFO - ##### 07:31:38 INFO - ##### Running install step. 07:31:38 INFO - ##### 07:31:38 INFO - Running pre-action listener: _resource_record_pre_action 07:31:38 INFO - Running main action method: install 07:31:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:31:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:31:39 INFO - Reading from file tmpfile_stdout 07:31:39 INFO - Detecting whether we're running mozinstall >=1.0... 07:31:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:31:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:31:39 INFO - Reading from file tmpfile_stdout 07:31:39 INFO - Output received: 07:31:39 INFO - Usage: mozinstall [options] installer 07:31:39 INFO - Options: 07:31:39 INFO - -h, --help show this help message and exit 07:31:39 INFO - -d DEST, --destination=DEST 07:31:39 INFO - Directory to install application into. [default: 07:31:39 INFO - "/builds/slave/test"] 07:31:39 INFO - --app=APP Application being installed. [default: firefox] 07:31:39 INFO - mkdir: /builds/slave/test/build/application 07:31:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:31:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:31:54 INFO - Reading from file tmpfile_stdout 07:31:54 INFO - Output received: 07:31:54 INFO - /builds/slave/test/build/application/firefox/firefox 07:31:54 INFO - Running post-action listener: _resource_record_post_action 07:31:54 INFO - ##### 07:31:54 INFO - ##### Running run-tests step. 07:31:54 INFO - ##### 07:31:54 INFO - Running pre-action listener: _resource_record_pre_action 07:31:54 INFO - Running main action method: run_tests 07:31:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:31:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:31:54 INFO - Python 2.7.3 07:31:54 INFO - Return code: 0 07:31:54 INFO - grabbing minidump binary from tooltool 07:31: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')]} 07:31:54 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 0x1923410>, '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 0x1924310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19247a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:31:54 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 07:31:54 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 07:31:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:31:55 INFO - Return code: 0 07:31:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:31:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:31:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:31:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:31:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:31:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:31:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:31:55 INFO - Return code: 0 07:31:55 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/JNpWz5iKRZqd5ze4Ucr82g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 07:31:55 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/JNpWz5iKRZqd5ze4Ucr82g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --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 07:31:55 INFO - Using env: {'DISPLAY': ':0', 07:31:55 INFO - 'HOME': '/home/cltbld', 07:31:55 INFO - 'LANG': 'en_US.UTF-8', 07:31:55 INFO - 'LANGUAGE': 'en_US:en', 07:31:55 INFO - 'LOGNAME': 'cltbld', 07:31:55 INFO - 'MAIL': '/var/mail/cltbld', 07:31:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:31:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:31:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:55 INFO - 'MOZ_NO_REMOTE': '1', 07:31:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:31:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:31:55 INFO - 'NO_EM_RESTART': '1', 07:31:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:31:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:55 INFO - 'PWD': '/builds/slave/test', 07:31:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:31:55 INFO - 'SHELL': '/bin/bash', 07:31:55 INFO - 'SHLVL': '1', 07:31:55 INFO - 'TERM': 'linux', 07:31:55 INFO - 'TMOUT': '86400', 07:31:55 INFO - 'USER': 'cltbld', 07:31:55 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461766961.877596-1673116342', 07:31:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:55 INFO - '_': '/tools/buildbot/bin/python'} 07:31:55 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/JNpWz5iKRZqd5ze4Ucr82g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 07:31:56 INFO - mozversion application_buildid: 20160427071020 07:31:56 INFO - mozversion application_changeset: ed934827bebaeee8a1aeb1726a3af1021d2a8364 07:31:56 INFO - mozversion application_display_name: Nightly 07:31:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:31:56 INFO - mozversion application_name: Firefox 07:31:56 INFO - mozversion application_remotingname: firefox 07:31:56 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:31:56 INFO - mozversion application_vendor: Mozilla 07:31:56 INFO - mozversion application_version: 49.0a1 07:31:56 INFO - mozversion platform_buildid: 20160427071020 07:31:56 INFO - mozversion platform_changeset: ed934827bebaeee8a1aeb1726a3af1021d2a8364 07:31:56 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:31:56 INFO - mozversion platform_version: 49.0a1 07:31:56 INFO - using testdate: 1461767516 07:31:56 INFO - actual date: 1461767516 07:31:56 INFO - starting webserver on 'localhost:46220' 07:31:56 INFO - SUITE-START | Running 2 tests 07:31:56 INFO - TEST-START | dromaeo_css 07:31:56 INFO - operating with platform_type : linux_ 07:31:56 INFO - Initialising browser for dromaeo_css test... 07:31:56 INFO - TEST-INFO | started process 27206 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEO4Bkj/profile http://localhost:46220/getInfo.html) 07:32:00 INFO - PROCESS | 27206 | __metrics Screen width/height:1600/1200 07:32:00 INFO - PROCESS | 27206 | colorDepth:24 07:32:00 INFO - PROCESS | 27206 | Browser inner width/height: 1024/697 07:32:00 INFO - PROCESS | 27206 | __metrics 07:32:01 ERROR - PROCESS | 27206 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:32:02 INFO - TEST-INFO | 27206: exit 0 07:32:02 INFO - Browser initialized. 07:32:02 INFO - Running cycle 1/1 for dromaeo_css test... 07:32:02 INFO - TEST-INFO | started process 27284 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEO4Bkj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:32:14 INFO - PROCESS | 27284 | RSS: Main: 156360704 07:32:14 INFO - PROCESS | 27284 | 07:33:05 INFO - PROCESS | 27284 | 1461767585742 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] 07:35:17 INFO - PROCESS | 27284 | Cycle 1(1): loaded http://localhost:46220/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46220/tests/dromaeo/cssquery-ext.html) 07:35:18 INFO - PROCESS | 27284 | RSS: Main: 273629184 07:35:18 INFO - PROCESS | 27284 | 07:38:21 INFO - PROCESS | 27284 | Cycle 1(1): loaded http://localhost:46220/tests/dromaeo/cssquery-ext.html (next: http://localhost:46220/tests/dromaeo/cssquery-jquery.html) 07:38:21 INFO - PROCESS | 27284 | RSS: Main: 231759872 07:38:21 INFO - PROCESS | 27284 | 07:41:23 INFO - PROCESS | 27284 | Cycle 1(1): loaded http://localhost:46220/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46220/tests/dromaeo/cssquery-mootools.html) 07:41:24 INFO - PROCESS | 27284 | RSS: Main: 235409408 07:41:24 INFO - PROCESS | 27284 | 07:44:26 INFO - PROCESS | 27284 | Cycle 1(1): loaded http://localhost:46220/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46220/tests/dromaeo/cssquery-prototype.html) 07:44:26 INFO - PROCESS | 27284 | RSS: Main: 231907328 07:44:26 INFO - PROCESS | 27284 | 07:47:29 INFO - PROCESS | 27284 | Cycle 1(1): loaded http://localhost:46220/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46220/tests/dromaeo/cssquery-yui.html) 07:47:30 INFO - PROCESS | 27284 | RSS: Main: 214929408 07:47:30 INFO - PROCESS | 27284 | 07:50:33 INFO - PROCESS | 27284 | Cycle 1(1): loaded http://localhost:46220/tests/dromaeo/cssquery-yui.html (next: http://localhost:46220/tests/dromaeo/cssquery-dojo.html) 07:50:33 INFO - PROCESS | 27284 | RSS: Main: 319586304 07:50:33 INFO - PROCESS | 27284 | 07:50:33 INFO - PROCESS | 27284 | __start_tp_report 07:50:33 INFO - PROCESS | 27284 | _x_x_mozilla_page_load 07:50:33 INFO - PROCESS | 27284 | _x_x_mozilla_page_load_details 07:50:33 INFO - PROCESS | 27284 | |i|pagename|runs| 07:50:33 INFO - PROCESS | 27284 | |0;dojo.html;2622.056059818465;2667.9733202667967;2690.5829596412555;2708.7697545708625;2724.3189202699327;4614.815407383709;4704.411948506437;4727.8345257915935;4766.594839438643;4787.473377928425;4755.239161734124;4775.856724298276;4805.927911081328;4808.7595620218935;4822.927656085153;4248.107897341562;4347.152305300468;4389.736615803046;4443.733375997434;4546.408966834323;4457.910841783162;4486;4503.964088259702;4504.234280172379;4522.118186953546;4241.512226094008;4279.293916503773;4322.373255877911;4328.870133895956;4421.513633500296;4333.328334108187;4372.650187984954;4378.321360189176;4401.6698747594055;4422.226110430662;4276.401303817468;4299.828006879721;4313.82744690212;4315.611594956437;4353.020570371673;4539.251023581105;4582.931256031162;4639.072185562901;4663.860084197446;4740.051989602093;4979.45226025137;4979.626528010377;4991.725455099968;4992.176290911995;5028.145215313405;4998.200287953946;5030.748462576893;5036.395632524084;5042.193249080166;5085.974570127126;4648.581627653527;4684.859454216379;4754.21555443348;4810.95189048112;4822.300766388924;5150.948490515047;5157.896842063138;5182.067227899014;5182.119039763249;5187.04039752647;4959.727215003138;4966.453690094087;4969.254611808257;4969.726665033458;5001.974990125099;4812.927806082912;4989.850304490871;5119.820806271837;5156.767945442464;5163.4062082860955;4986.526280003394;4997.525235102659;5002.499750024968;5006.799728010911;5055.241713742968;4773.737444440589;4978.65149439543;4978.975105124451;4980.8754781130765;5018.523240292239;4145.958540414617;4171.416001759756;4206.20082184384;4251.957480425156;4265.658747300208;3713.3872910969926;3718.2749363873786;3720.311742327624;3728.179800443898;3757.9436308455397;4322.675799315001;4407.625351845129;4409.140217657526;4411.514733379326;4447.644188464915;5024.070546948753;5113.616478764033;5132.153194722829;5135.640505164677;5136.743162841843;4381.737095774264;4386.451693538308;4401.075774087413;4405.625521830616;4451.888702782391;4529.682922195415;4529.886752831139;4539.7049191802425;4545.38637283969;4593.058423023273;4649.18639238132;4780.1873681474235;4811.9518804811505;4851.733154676526;4861.416630004422;5058.696478211172;5064.215046667772;5069.69581825077;5074.543291103819;5111.897762044812;4663;4782.808687652455;4825.662203645711;4826.758662066813;4888.706677599355;4998.400191976986;5008.148614735576;5035.370578677665;5054.140796064751;5066.898662026665;4969.751512424292;4973.254011898244;4984.22744474607;4998.725070121178;5005.424376196784;4789.760511974457;4857.271409288635;4871.658983871095;4888.657793954531;4904.558589726942;4862.781174847069;4879.121758083437;4902.411710594752;4923.335349727741;4925.729084900365;4791.664583479123;4800.231962885921;4815.7351345676325;4821.252705830602;4821.566059054702;4838.637102217418;4903.877403064952;4907.288443175791;4942.579880710036;4956.826511072095;4797.616190704805;4813.663043586916;4822.300766388924;4867.050925069578;4868.196747536616 07:50:33 INFO - PROCESS | 27284 | |1;ext.html;578.7164289498147;610.5817515002224;615.2125279642057;628.4061561824075;631.3055638797326;26014.219573412804;32208.67791322086;33166.66833331666;33325.500117498195;33893.83053084737;35061.12347191321;35280.64719352806;35513;35625.82187089067;35644;6971.128608923885;7489.887651685215;7680.961595192016;7695.115061767884;7701.537907725555;9387.718368448923;9642.614295428175;9661.130498255156;9661.275404344668;9666.75833104171;9491.430514169171;9660.855087173699;9665.516724163763;9665.565049572751;9676.95161524195;9421.340506164572;9508.334416590842;9508.524573771283;9518.23854091678;9533.761655958588;9543.47510886901;9655.951720241424;9672;9975.152112070411;9982.201423886072;33749.49375759366;34112.82943585266;34205.31589368199;34283;34343.656563434546;3187.7449804015623;3215;3255.811628755511;3386.2888793353427;3400.6429324920773;27024.59463108055;27289;27621.30946726328;27739.86130069357;28280;3458.654134586546;3485.5468789057513;3507.9473807892646;3510.5436293281964;3531.6644918732677;178942.36874603239;179030.10484947622;179630;179771;180425;49189.508104918496;49743.50256497461;50071;50190;50207.74896125496;52906.206406903926;53001;53222.467775322526;53349.1997620036;53542.732286338316;14172.078814877;14810.92594537042;14819.851801482062;14820.110793352433;14845.777313340308;10925.836112458319;11047.447627618587;11085.390303533222;11115.110791136689;11120.888791112147;16120.596985075232;16997.91501042487;17039.659206815795;17058.74411883823;17101.91449042747;6452.548321617535;6491.094413655466;6515.381038801306;6581.506387020897;6617.007448882706;868.4268382867403;935.3546053223254;971.4754032822196;986.4032260482448;996.4419924842111;26083.379181474393;26971.595426068623;27146.321341966213;27266.182014539594;27336.31659208496;1007.2646967713611;1039.6725031615017;1062.729004103964;1077.2674581284803;1110.9945499322964;13964.301784910916;14097.36561854719;14392.208428536322;14448.277586120652;14504.274786260856;196627;203855;204515;204614;256291;45129.548704512534;45910.31134532985;46112.7694361526;46169;46206.30690539644;1178.6817559259123;1212.090931801149;1228.5085965613825;1240.0017985521743;1260.294235228275;24173.516529668956;26237;26509.33726656772;26555.60166597464;26611;36172.27655446823;36843.81578092092;36999.07502312356;37012.44481332728;37025;247910;255458;255461;255686;256137;32309;32961;32997;33556.16109597182;35080.47379289262;38343.42484862785;38491.42262866003;38498;39066;39355.212895742494;32905.67094329122;33668.83165584156;34300.82849585836;34338.48492272568;34742.47886281657;33700.49449258214;34105.829470852485;34109.317813644084;34169.145771355914;34448;33116.668833312324;33514.664853351154;33561.664383355856;33721.32557348888;33960.320793584484;29771.70228297776;29899.402011959202;30415.847920761138;30536.236594085327;30705.692943071175;23376.026075566853;23501.529969400857;23973.763541921617;23994.76005239995;24046 07:50:33 INFO - PROCESS | 27284 | |2;jquery.html;386.1504689682699;386.42036944583134;388.6911744239217;397.3344647715077;404.3631280732845;15588.298526566303;15997.84002159978;16180.676386472263;16195.028298302095;16196.514104576867;15285.082895026306;15793;16019.279132439038;16033.599160021005;16079.83920160798;5033.697978121324;5117.411497677759;5135.35808023997;5162.22566615007;5180.507851754077;5052.646314757969;5106.514881086291;5127.102757017507;5145.614078944075;5148.433672296044;4954.801807927696;5078.339815823938;5088.771005304751;5096.337476128098;5120.052790233819;4882.340883980671;5059.595232381419;5098.286239926413;5135.152699804527;5143.305653736773;4603.171429142753;4603.309503574457;4604.470485894131;4609.516000819933;4625.259958406638;19001.429957101172;19224.231030758754;19405.708914366296;19598.510037249183;19620;1925.749652545174;1987.9403617891487;2100.411884672294;2578.690557133137;2582.5609646360163;11255.66233013011;11789.646310610695;12223.877761222362;12450.377481125908;12765.297908615023;1705.218047140741;1788.97316540252;1830.5515148788631;1908.9809101908943;1948.39599724086;59687.70156149235;60187.69906150441;60484.395156048755;60778;63391.36608633901;9825.361351512129;9982.201423886072;10047.447390393452;10146.492675366202;10166.542505587266;13669.726605468033;13897.79153312701;13904.235267060409;13943.16341019542;13945.233012184224;7031.367176954099;7234.602096884617;7325.2308507607;7384.2246564111065;7434.628268586549;6917.412019978358;6955.617441040791;7016.649167541603;7099.290070992963;7109.289071092952;4293.892652683708;4433.623142032899;4476.7090139140855;4502.482214545369;4548.135854187693;1799.5321216483808;1872.6348362069539;1877.333546590968;1879.4643526594855;1897.5351038995534;858.695163217049;927.8051609162017;946.6923249943795;974.3666616699202;992.6773798515367;15104.622384440258;15314.387424503118;15773.526794196192;16015;16174;925.3938670171049;930.6649606141783;934.7149119518476;973.3767496596745;991.8363470027509;8716.302695784321;8831.425957312755;9070.591823367964;9228.400153990104;9295.163435290857;380713;389713;392596;395237;404997;68667;69080.6545967267;70250.64874675593;70500.64749676219;72046.279537205;917.9173874351206;921.7695576105973;923.1968187676764;928.6378312458147;933.6078846884325;14424;14550.781738274147;14676.41294348214;14691.971561990558;14866.405343786128;31160;31958.84020579882;32105.35789284248;32132;32293.838530807196;43938;45376.31935521036;45389.31916021196;45473.545264546934;45692.573057021524;7419.4806363554035;7458.962705186439;7476.102867655916;7537.095548534211;7649.273319034683;8355.665773368997;10948.781024379627;10969.945150274198;11057.530114504816;11164.832527511931;9220.216281616138;9429;9568.521573921136;9826.65606703762;9959.800803984024;9587.280953928344;9782.608695652094;9826.508674566387;9893.50532473359;10030.448325341884;9727.416355018722;9923.900760992297;9962.900370996487;10000.349977251455;10031.147352475122;7343.302386273295;7546;7574.5833979129475;7582.469227154046;7600.46796724224;8675.522846243517;8733.694320698745;8888.24449921738;8900.510471924106;9268.443893366419 07:50:33 INFO - PROCESS | 27284 | |3;mootools.html;1206.0773508266184;1422.061439449963;1459.5475402625186;1586.3337398292715;1760.3877840059047;6285;7210.603416812073;7380.114386273642;7392.852142957145;7397.075365579302;7148.463865210104;7291.708331666727;7299.94150848128;7307.415406767459;7307.451941104412;2149.752778430481;2170.023489429755;2170.4899348653053;2171.6633921742155;2173.369722780392;2148.871067735933;2161.502854343502;2210.193279452996;2210.602091623507;2226.677131815886;2199.7580266170708;2200.284907405092;2213;2214.202886960693;2235.865848049114;2099.086897199715;2101.432613194444;2104.747430308365;2107.2729908181727;2113.397681660719;2111.356036408895;2141.218455263833;2152.7954844289766;2153.375521098895;2153.558520503293;7156.856862862714;7337.046183996046;7361.742339018108;7373.668184931691;7401.925980740178;4456.866294011184;4610.838620648261;4634.165850146972;4635.791389387486;4637.072585482883;2878.150945471091;2907.069737683942;2929.824210547374;2930.8388038657863;2972.583838262645;918.1277786103228;928.8235235305337;930.9534523273809;934.7429456899339;964.252704154286;9551.0926461986;9894.060064293952;9929.3545919515;9938.801223975552;9947.25395595326;4072.470578824793;4163.063310755117;4223.450951376363;4238.237117318912;4244.596763307481;7922.286994170552;7950.681972721142;7957.641906114239;7965.800854978556;7969.681212751425;4425.269830477935;4574.519675434098;4574.83988060423;4575.10785396851;4575.839845605387;3619.6380361963593;4060.0864805418546;4169.770662613585;4174.582541745862;4251.80866860992;3312.569365982407;3323.4516304809918;3362.596488421405;3367.6295607483157;3402.795832250073;1013.3058854684565;1102.2780079048237;1105.3478447715886;1108.2851560743275;1110.3448965110624;779.9961000194962;784.5488843914771;821.0557858462815;837.2757564706485;844.1052484366469;4931.334269873521;5095.414027386824;5134.589232861362;5148.099082660519;5156.097682905552;827.6937533112787;865.4634126841398;899.572702966099;915.6154415145655;932.06327640722;3208.4545627242956;3262.918427039343;3270.084376374619;3290.9835450822593;3341.732661387132;8383.580820958927;9032.187103160615;9186.77033074165;9311.90688093124;9312.953435232916;9127.087291270953;9153.81692366149;9154.908450915538;9195.448273103635;9240.399374040666;6567.6059436433015;6916.51584389098;6983.685734141975;6989.965050174716;6999.755008574675;5029.899402012013;5090.745462726923;5103.387593488805;5206.386020333557;5260.658057226268;8192.631331590212;8334.791630209293;8373.95813020931;8445.746627601182;8453.830923381622;8197.71308004217;8356.080831108451;8367.748967530984;8389;8460.873086903579;5432.348118225838;6104.38956104386;6127.20346354971;6152.415520525722;6234.812955611339;7287;7375.299346562068;7380.151282602569;7382.44631652639;7384.52000619958;6383.361663833765;6700.46396288286;6747.831304217238;6754.054432379569;6808.148981377328;5995.650978529796;6559.6064236144075;6564.702354176;6704.932950670431;6736.865262694817;5989.790357337647;6033.487153591994;6059.727312271047;6060.303065147565;6064.423879731418;4213.620774130343;4332.696711230184;4376.649868010488;4442.155990361821;4475.686701930834;4231.936520952249;4470.575295346936;4486.439195100613;4487.596116349544;4497.100579883971 07:50:33 INFO - PROCESS | 27284 | |4;prototype.html;296.73294035368167;306.1473795479587;317.19907234233557;320.0733875430629;323.22426177174776;4535.795889184987;4672.976635116824;4675.158471475133;4749.3350930869665;4752.334673145762;4529.34324522944;4675.532446755323;4690.812367505304;4696.365990591269;4717.410323709536;3772.170122573036;3774.811259437031;3779.2252588219485;3782.8865134046023;3793.3172029034763;3587.6950459211;3630.818459077049;3768.6419790119894;3777.6411240932066;3795.430685397185;3725.143217060078;3727.366347720894;3737.8878633641034;3759.830807613664;3783.1109689223013;3713.8885833425043;3743.363628183202;3753.1555400035045;3770.3024940386117;3780.3762379207396;3365.5793025871767;3366.8148251846137;3373;3376.7805092669146;3389.3560223557447;4431.645468362523;4473.405424853577;4508.399518171035;4518.480374756912;4522.479914809806;4254.361845723135;4268.615824575803;4275.572442755731;4284.357346398034;4288.914221715549;4878.951025529528;4918.434380046305;4918.827841025547;4929.8028078876805;4939.851164743348;3558.1282585766394;3651.7443778935485;3659.2864391443677;3668.404244153775;3695.7228207884245;5112.41207261166;5150.227465880111;5183.144781111112;5188.429272779991;5191.32512773337;3733.3280009598534;3752.155764952918;3759.3045286622064;3768.66212494566;3769.302679004338;3797.981010094987;3810.1998580298446;3810.904727381838;3811.3901775715754;3818.4463252828186;4073.1853629274265;4264.488261408651;4270.722403043855;4272;4284.485861696617;4865.318855360252;4888.9755551222015;4896.706197628154;4919.163742163769;4923.236898280772;1299.707565797688;1334.6329759316072;1372.1081297156927;1380.2960490149894;1392.7562676531566;951.5004622573205;955.8470644696815;966.7534778631544;968.801395713877;970.5147426286857;4663.766811659471;4666.976665116653;4672.08894265615;4678.2280923647895;4681.7659117044695;5408.323959505062;5416.106342453451;5419.891602167934;5426.810061647823;5428.511433970962;4266.104118135227;4648.349231107648;4661.254199328091;4665.113628410591;4669.369635099286;2910.4324656691742;2919.7664186865;2925.575791510219;2928.853557322125;2931.589577459157;5193.480651934852;5195.168772996378;5226.189940559219;5233.842984710464;5240.554552862973;5366.570674346043;5632.04255276604;5632.831015069554;5643.5767317451355;5647.858803529863;5170.5346518813485;5209.635325527177;5213.087709650872;5243.161094224905;5264.52619264268;5502.0921547945745;5525.751341189736;5528.087865502308;5528.281323427928;5528.751206195811;4805.327254184347;5031.144705400164;5033.47148549397;5077.847664570068;5390.056740070394;4882.145624515767;4883.316335713074;4914.410270767531;4918.827841025547;4927.728974906415;3606.549181352331;3627.3652110881017;3628.020434482622;3629.891103266906;3649.062504683755;4921.655484116221;4931.161702510653;5155.716435596079;5155.871103222449;5160.716160611202;4897.877553061059;4974.403071631427;4982.800687972585;4991.376077990251;5006.1739812930455;4942;4952.579030782424;4954.603631709527;4982.227754698028;4995.8001679932395;4843.6557284680475;4872.342233798392;4914.36113305268;4916.631252656137;4950.183219768698;4982.451930287593;4998.900021999612;5021.397432308147;5036.909682481729;5038.060346766448;4945.530174633404;4945.901081978413;4950.45544990058;4953.356063711694;4982.252662100714 07:50:33 INFO - PROCESS | 27284 | |5;yui.html;724.4638967164298;753.4989232160611;766.934810541104;769.9422543309253;771.5949126708474;13330.866691333084;13710.93144534276;13784.517541886036;13800.861991380083;13801.930990345047;13635.863641363609;13718.314084295795;13739.450421983109;13742.450301987934;13823.723525529484;639.2361128451503;789.6683392974965;810.7689308547051;818.3575892924056;818.8771684247351;817.6892780743309;819.4468733604793;819.983600327993;820.958952052395;821.4906757810166;843.1105184030845;851.6210286422545;851.6508231625035;851.7189327521903;852.1393392673383;661.8345413646589;816.3102178659024;834.9707760228393;839.6641343462603;843.5360551696542;615.6398506873485;615.9199304090439;617.0127795527121;617.3702823120392;617.6109051297653;12755.872441275562;12795.360231988363;12806.679833004157;12820.03849711266;12834.743305133938;11446.484908179153;11737.295762254207;11928.522859085626;12077.57728479499;12276.693082672915;9236.815263694689;9361.110694484014;9402.811943761155;9412.482313472756;9695.22438204949;3231.9676803232137;3266.5590145330552;3362.8654853806065;3386.7967921924765;3393.558837351153;39115.60884391148;39329.213415731814;39551.40672889909;39638.405423918666;40007.3998890014;9155.633774649074;9165.404248723811;9362;9561.474118923526;9562.61749530025;15815.841841581438;15817;15817.604559885865;15824.76262856058;15849.207539622972;6304.779332723424;6396.2964073951825;6427.935720642734;6438.806835794933;6439.066335381437;3548.27260411615;3584.4802503636824;3620.5836328821997;3645.5989841117457;3658.213484100931;2792.176307989148;2830.1933948824485;2839.063109173968;2843.758280546135;2845.7865660075577;477.0149640991342;533.3466503533141;558.5922276738004;573.2232824522712;575.4073304496376;467.96256299495957;586.0330454749698;615.7444660465857;623.7789700209188;630.4137152448267;7285.70857165718;7349.77950661481;7378.778636640909;7499.21258267885;7672.884906726404;559.3986464550625;566.7477972302369;589.4154134121821;589.4665327878276;600.942910423509;3312.801231926044;3493.5409767594256;3507.5440192774777;3547.9645203547634;3607.098225443639;53373.199402009;55169.72415137979;55561.72219138959;55685.721571391885;55772.16341754877;46138.769306153255;48162.759186203846;48475.75762121167;48866;50092.49907500878;44090.33864492035;44225.77887110544;44339.778301108934;45390.54609453929;46105.7694711531;6955.791326260221;7108;7118.60847653384;7119.288071192839;7186.496945213785;28626.427471450872;28886;29377.706222938352;29547.704522955355;29736;35724.28551429009;38239.661611843454;39769.60230397659;40009;40016.59983400245;9897.604095836086;9941.602335906482;10010.599576016877;10093.394396336244;10352.844707329245;10740.409277489813;10865.348079115278;10894.128469722562;11082.944585277022;11125.44372781374;9701.611935522782;9830;10175.08424241792;10309.948450258;10618.309809862334;10069.798604027732;10291.176705863363;10307.742306442398;10376.636817711344;10841.891581084405;9135.817283654156;9241.861372079558;9364.765880853032;9395.342326037111;9401.294902882175;8279;8308.459950103224;8370.707025254087;8541.615627296911;8726.956365218133;7918.762437126896;8085;8200.466969646954;8200.712975045844;8292.419530632798 07:50:33 INFO - PROCESS | 27284 | __end_tp_report 07:50:33 INFO - PROCESS | 27284 | __start_cc_report 07:50:33 INFO - PROCESS | 27284 | _x_x_mozilla_cycle_collect,1084 07:50:33 INFO - PROCESS | 27284 | __end_cc_report 07:50:33 INFO - PROCESS | 27284 | __startTimestamp1461768633461__endTimestamp 07:50:33 INFO - PROCESS | 27284 | 07:50:33 INFO - PROCESS | 27284 | ------- Summary: start ------- 07:50:33 INFO - PROCESS | 27284 | Number of tests: 6 07:50:33 INFO - PROCESS | 27284 | 07:50:33 INFO - PROCESS | 27284 | [#0] dojo.html Cycles:165 Average:4668.28 Median:4811.95 stddev:477.85 (9.9%) stddev-sans-first:451.55 07:50:33 INFO - PROCESS | 27284 | Values: 2622.1 2668.0 2690.6 2708.8 2724.3 4614.8 4704.4 4727.8 4766.6 4787.5 4755.2 4775.9 4805.9 4808.8 4822.9 4248.1 4347.2 4389.7 4443.7 4546.4 4457.9 4486.0 4504.0 4504.2 4522.1 4241.5 4279.3 4322.4 4328.9 4421.5 4333.3 4372.7 4378.3 4401.7 4422.2 4276.4 4299.8 4313.8 4315.6 4353.0 4539.3 4582.9 4639.1 4663.9 4740.1 4979.5 4979.6 4991.7 4992.2 5028.1 4998.2 5030.7 5036.4 5042.2 5086.0 4648.6 4684.9 4754.2 4811.0 4822.3 5150.9 5157.9 5182.1 5182.1 5187.0 4959.7 4966.5 4969.3 4969.7 5002.0 4812.9 4989.9 5119.8 5156.8 5163.4 4986.5 4997.5 5002.5 5006.8 5055.2 4773.7 4978.7 4979.0 4980.9 5018.5 4146.0 4171.4 4206.2 4252.0 4265.7 3713.4 3718.3 3720.3 3728.2 3757.9 4322.7 4407.6 4409.1 4411.5 4447.6 5024.1 5113.6 5132.2 5135.6 5136.7 4381.7 4386.5 4401.1 4405.6 4451.9 4529.7 4529.9 4539.7 4545.4 4593.1 4649.2 4780.2 4812.0 4851.7 4861.4 5058.7 5064.2 5069.7 5074.5 5111.9 4663.0 4782.8 4825.7 4826.8 4888.7 4998.4 5008.1 5035.4 5054.1 5066.9 4969.8 4973.3 4984.2 4998.7 5005.4 4789.8 4857.3 4871.7 4888.7 4904.6 4862.8 4879.1 4902.4 4923.3 4925.7 4791.7 4800.2 4815.7 4821.3 4821.6 4838.6 4903.9 4907.3 4942.6 4956.8 4797.6 4813.7 4822.3 4867.1 4868.2 07:50:33 INFO - PROCESS | 27284 | 07:50:33 INFO - PROCESS | 27284 | [#1] ext.html Cycles:180 Average:37845.75 Median:33927.08 stddev:56539.46 (166.6%) stddev-sans-first:56628.83 07:50:33 INFO - PROCESS | 27284 | Values: 578.7 610.6 615.2 628.4 631.3 26014.2 32208.7 33166.7 33325.5 33893.8 35061.1 35280.6 35513.0 35625.8 35644.0 6971.1 7489.9 7681.0 7695.1 7701.5 9387.7 9642.6 9661.1 9661.3 9666.8 9491.4 9660.9 9665.5 9665.6 9677.0 9421.3 9508.3 9508.5 9518.2 9533.8 9543.5 9656.0 9672.0 9975.2 9982.2 33749.5 34112.8 34205.3 34283.0 34343.7 3187.7 3215.0 3255.8 3386.3 3400.6 27024.6 27289.0 27621.3 27739.9 28280.0 3458.7 3485.5 3507.9 3510.5 3531.7 178942.4 179030.1 179630.0 179771.0 180425.0 49189.5 49743.5 50071.0 50190.0 50207.7 52906.2 53001.0 53222.5 53349.2 53542.7 14172.1 14810.9 14819.9 14820.1 14845.8 10925.8 11047.4 11085.4 11115.1 11120.9 16120.6 16997.9 17039.7 17058.7 17101.9 6452.5 6491.1 6515.4 6581.5 6617.0 868.4 935.4 971.5 986.4 996.4 26083.4 26971.6 27146.3 27266.2 27336.3 1007.3 1039.7 1062.7 1077.3 1111.0 13964.3 14097.4 14392.2 14448.3 14504.3 196627.0 203855.0 204515.0 204614.0 256291.0 45129.5 45910.3 46112.8 46169.0 46206.3 1178.7 1212.1 1228.5 1240.0 1260.3 24173.5 26237.0 26509.3 26555.6 26611.0 36172.3 36843.8 36999.1 37012.4 37025.0 247910.0 255458.0 255461.0 255686.0 256137.0 32309.0 32961.0 32997.0 33556.2 35080.5 38343.4 38491.4 38498.0 39066.0 39355.2 32905.7 33668.8 34300.8 34338.5 34742.5 33700.5 34105.8 34109.3 34169.1 34448.0 33116.7 33514.7 33561.7 33721.3 33960.3 29771.7 29899.4 30415.8 30536.2 30705.7 23376.0 23501.5 23973.8 23994.8 24046.0 07:50:33 INFO - PROCESS | 27284 | 07:50:33 INFO - PROCESS | 27284 | [#2] jquery.html Cycles:180 Average:23445.22 Median:4918.57 stddev:64482.29 (1311.0%) stddev-sans-first:64639.93 07:50:33 INFO - PROCESS | 27284 | Values: 386.2 386.4 388.7 397.3 404.4 15588.3 15997.8 16180.7 16195.0 16196.5 15285.1 15793.0 16019.3 16033.6 16079.8 5033.7 5117.4 5135.4 5162.2 5180.5 5052.6 5106.5 5127.1 5145.6 5148.4 4954.8 5078.3 5088.8 5096.3 5120.1 4882.3 5059.6 5098.3 5135.2 5143.3 4603.2 4603.3 4604.5 4609.5 4625.3 19001.4 19224.2 19405.7 19598.5 19620.0 1925.7 1987.9 2100.4 2578.7 2582.6 11255.7 11789.6 12223.9 12450.4 12765.3 1705.2 1789.0 1830.6 1909.0 1948.4 59687.7 60187.7 60484.4 60778.0 63391.4 9825.4 9982.2 10047.4 10146.5 10166.5 13669.7 13897.8 13904.2 13943.2 13945.2 7031.4 7234.6 7325.2 7384.2 7434.6 6917.4 6955.6 7016.6 7099.3 7109.3 4293.9 4433.6 4476.7 4502.5 4548.1 1799.5 1872.6 1877.3 1879.5 1897.5 858.7 927.8 946.7 974.4 992.7 15104.6 15314.4 15773.5 16015.0 16174.0 925.4 930.7 934.7 973.4 991.8 8716.3 8831.4 9070.6 9228.4 9295.2 380713.0 389713.0 392596.0 395237.0 404997.0 68667.0 69080.7 70250.6 70500.6 72046.3 917.9 921.8 923.2 928.6 933.6 14424.0 14550.8 14676.4 14692.0 14866.4 31160.0 31958.8 32105.4 32132.0 32293.8 43938.0 45376.3 45389.3 45473.5 45692.6 7419.5 7459.0 7476.1 7537.1 7649.3 8355.7 10948.8 10969.9 11057.5 11164.8 9220.2 9429.0 9568.5 9826.7 9959.8 9587.3 9782.6 9826.5 9893.5 10030.4 9727.4 9923.9 9962.9 10000.3 10031.1 7343.3 7546.0 7574.6 7582.5 7600.5 8675.5 8733.7 8888.2 8900.5 9268.4 07:50:33 INFO - PROCESS | 27284 | 07:50:33 INFO - PROCESS | 27284 | [#3] mootools.html Cycles:180 Average:4887.97 Median:5711.07 stddev:2652.27 (46.4%) stddev-sans-first:2645.27 07:50:33 INFO - PROCESS | 27284 | Values: 1206.1 1422.1 1459.5 1586.3 1760.4 6285.0 7210.6 7380.1 7392.9 7397.1 7148.5 7291.7 7299.9 7307.4 7307.5 2149.8 2170.0 2170.5 2171.7 2173.4 2148.9 2161.5 2210.2 2210.6 2226.7 2199.8 2200.3 2213.0 2214.2 2235.9 2099.1 2101.4 2104.7 2107.3 2113.4 2111.4 2141.2 2152.8 2153.4 2153.6 7156.9 7337.0 7361.7 7373.7 7401.9 4456.9 4610.8 4634.2 4635.8 4637.1 2878.2 2907.1 2929.8 2930.8 2972.6 918.1 928.8 931.0 934.7 964.3 9551.1 9894.1 9929.4 9938.8 9947.3 4072.5 4163.1 4223.5 4238.2 4244.6 7922.3 7950.7 7957.6 7965.8 7969.7 4425.3 4574.5 4574.8 4575.1 4575.8 3619.6 4060.1 4169.8 4174.6 4251.8 3312.6 3323.5 3362.6 3367.6 3402.8 1013.3 1102.3 1105.3 1108.3 1110.3 780.0 784.5 821.1 837.3 844.1 4931.3 5095.4 5134.6 5148.1 5156.1 827.7 865.5 899.6 915.6 932.1 3208.5 3262.9 3270.1 3291.0 3341.7 8383.6 9032.2 9186.8 9311.9 9313.0 9127.1 9153.8 9154.9 9195.4 9240.4 6567.6 6916.5 6983.7 6990.0 6999.8 5029.9 5090.7 5103.4 5206.4 5260.7 8192.6 8334.8 8374.0 8445.7 8453.8 8197.7 8356.1 8367.7 8389.0 8460.9 5432.3 6104.4 6127.2 6152.4 6234.8 7287.0 7375.3 7380.2 7382.4 7384.5 6383.4 6700.5 6747.8 6754.1 6808.1 5995.7 6559.6 6564.7 6704.9 6736.9 5989.8 6033.5 6059.7 6060.3 6064.4 4213.6 4332.7 4376.6 4442.2 4475.7 4231.9 4470.6 4486.4 4487.6 4497.1 07:50:33 INFO - PROCESS | 27284 | 07:50:33 INFO - PROCESS | 27284 | [#4] prototype.html Cycles:180 Average:4226.21 Median:4693.59 stddev:1215.16 (25.9%) stddev-sans-first:1182.24 07:50:33 INFO - PROCESS | 27284 | Values: 296.7 306.1 317.2 320.1 323.2 4535.8 4673.0 4675.2 4749.3 4752.3 4529.3 4675.5 4690.8 4696.4 4717.4 3772.2 3774.8 3779.2 3782.9 3793.3 3587.7 3630.8 3768.6 3777.6 3795.4 3725.1 3727.4 3737.9 3759.8 3783.1 3713.9 3743.4 3753.2 3770.3 3780.4 3365.6 3366.8 3373.0 3376.8 3389.4 4431.6 4473.4 4508.4 4518.5 4522.5 4254.4 4268.6 4275.6 4284.4 4288.9 4879.0 4918.4 4918.8 4929.8 4939.9 3558.1 3651.7 3659.3 3668.4 3695.7 5112.4 5150.2 5183.1 5188.4 5191.3 3733.3 3752.2 3759.3 3768.7 3769.3 3798.0 3810.2 3810.9 3811.4 3818.4 4073.2 4264.5 4270.7 4272.0 4284.5 4865.3 4889.0 4896.7 4919.2 4923.2 1299.7 1334.6 1372.1 1380.3 1392.8 951.5 955.8 966.8 968.8 970.5 4663.8 4667.0 4672.1 4678.2 4681.8 5408.3 5416.1 5419.9 5426.8 5428.5 4266.1 4648.3 4661.3 4665.1 4669.4 2910.4 2919.8 2925.6 2928.9 2931.6 5193.5 5195.2 5226.2 5233.8 5240.6 5366.6 5632.0 5632.8 5643.6 5647.9 5170.5 5209.6 5213.1 5243.2 5264.5 5502.1 5525.8 5528.1 5528.3 5528.8 4805.3 5031.1 5033.5 5077.8 5390.1 4882.1 4883.3 4914.4 4918.8 4927.7 3606.5 3627.4 3628.0 3629.9 3649.1 4921.7 4931.2 5155.7 5155.9 5160.7 4897.9 4974.4 4982.8 4991.4 5006.2 4942.0 4952.6 4954.6 4982.2 4995.8 4843.7 4872.3 4914.4 4916.6 4950.2 4982.5 4998.9 5021.4 5036.9 5038.1 4945.5 4945.9 4950.5 4953.4 4982.3 07:50:33 INFO - PROCESS | 27284 | 07:50:33 INFO - PROCESS | 27284 | [#5] yui.html Cycles:180 Average:12512.58 Median:55365.72 stddev:14601.51 (26.4%) stddev-sans-first:14615.63 07:50:33 INFO - PROCESS | 27284 | Values: 724.5 753.5 766.9 769.9 771.6 13330.9 13710.9 13784.5 13800.9 13801.9 13635.9 13718.3 13739.5 13742.5 13823.7 639.2 789.7 810.8 818.4 818.9 817.7 819.4 820.0 821.0 821.5 843.1 851.6 851.7 851.7 852.1 661.8 816.3 835.0 839.7 843.5 615.6 615.9 617.0 617.4 617.6 12755.9 12795.4 12806.7 12820.0 12834.7 11446.5 11737.3 11928.5 12077.6 12276.7 9236.8 9361.1 9402.8 9412.5 9695.2 3232.0 3266.6 3362.9 3386.8 3393.6 39115.6 39329.2 39551.4 39638.4 40007.4 9155.6 9165.4 9362.0 9561.5 9562.6 15815.8 15817.0 15817.6 15824.8 15849.2 6304.8 6396.3 6427.9 6438.8 6439.1 3548.3 3584.5 3620.6 3645.6 3658.2 2792.2 2830.2 2839.1 2843.8 2845.8 477.0 533.3 558.6 573.2 575.4 468.0 586.0 615.7 623.8 630.4 7285.7 7349.8 7378.8 7499.2 7672.9 559.4 566.7 589.4 589.5 600.9 3312.8 3493.5 3507.5 3548.0 3607.1 53373.2 55169.7 55561.7 55685.7 55772.2 46138.8 48162.8 48475.8 48866.0 50092.5 44090.3 44225.8 44339.8 45390.5 46105.8 6955.8 7108.0 7118.6 7119.3 7186.5 28626.4 28886.0 29377.7 29547.7 29736.0 35724.3 38239.7 39769.6 40009.0 40016.6 9897.6 9941.6 10010.6 10093.4 10352.8 10740.4 10865.3 10894.1 11082.9 11125.4 9701.6 9830.0 10175.1 10309.9 10618.3 10069.8 10291.2 10307.7 10376.6 10841.9 9135.8 9241.9 9364.8 9395.3 9401.3 8279.0 8308.5 8370.7 8541.6 8727.0 7918.8 8085.0 8200.5 8200.7 8292.4 07:50:33 INFO - PROCESS | 27284 | -------- Summary: end -------- 07:50:33 INFO - PROCESS | 27284 | 07:50:34 INFO - TEST-INFO | 27284: exit 0 07:50:34 INFO - TEST-OK | dromaeo_css | took 1118032ms 07:50:34 INFO - TEST-START | kraken 07:50:34 INFO - operating with platform_type : linux_ 07:50:34 INFO - Initialising browser for kraken test... 07:50:34 INFO - TEST-INFO | started process 27493 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp67lVfz/profile http://localhost:46220/getInfo.html) 07:50:38 INFO - PROCESS | 27493 | __metrics Screen width/height:1600/1200 07:50:38 INFO - PROCESS | 27493 | colorDepth:24 07:50:38 INFO - PROCESS | 27493 | Browser inner width/height: 1024/697 07:50:38 INFO - PROCESS | 27493 | __metrics 07:50:39 ERROR - PROCESS | 27493 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:50:40 INFO - TEST-INFO | 27493: exit 0 07:50:40 INFO - Browser initialized. 07:50:40 INFO - Running cycle 1/1 for kraken test... 07:50:40 INFO - TEST-INFO | started process 27573 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp67lVfz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:50:52 INFO - PROCESS | 27573 | RSS: Main: 156811264 07:50:52 INFO - PROCESS | 27573 | 07:50:54 INFO - PROCESS | 27573 | Cycle 1(1): loaded http://localhost:46220/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46220/tests/kraken/driver.html?testName=audio-beat-detection) 07:50:55 INFO - PROCESS | 27573 | RSS: Main: 211480576 07:50:55 INFO - PROCESS | 27573 | 07:50:58 INFO - PROCESS | 27573 | Cycle 1(1): loaded http://localhost:46220/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46220/tests/kraken/driver.html?testName=audio-dft) 07:50:59 INFO - PROCESS | 27573 | RSS: Main: 196923392 07:50:59 INFO - PROCESS | 27573 | 07:51:02 INFO - PROCESS | 27573 | Cycle 1(1): loaded http://localhost:46220/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46220/tests/kraken/driver.html?testName=audio-fft) 07:51:03 INFO - PROCESS | 27573 | RSS: Main: 267436032 07:51:03 INFO - PROCESS | 27573 | 07:51:05 INFO - PROCESS | 27573 | Cycle 1(1): loaded http://localhost:46220/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46220/tests/kraken/driver.html?testName=audio-oscillator) 07:51:05 INFO - PROCESS | 27573 | RSS: Main: 174931968 07:51:05 INFO - PROCESS | 27573 | 07:51:08 INFO - PROCESS | 27573 | Cycle 1(1): loaded http://localhost:46220/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46220/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:51:08 INFO - PROCESS | 27573 | RSS: Main: 179281920 07:51:08 INFO - PROCESS | 27573 | 07:51:11 INFO - PROCESS | 27573 | Cycle 1(1): loaded http://localhost:46220/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46220/tests/kraken/driver.html?testName=imaging-darkroom) 07:51:12 INFO - PROCESS | 27573 | RSS: Main: 215822336 07:51:12 INFO - PROCESS | 27573 | 07:51:15 INFO - PROCESS | 27573 | Cycle 1(1): loaded http://localhost:46220/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46220/tests/kraken/driver.html?testName=imaging-desaturate) 07:51:16 INFO - PROCESS | 27573 | RSS: Main: 216715264 07:51:16 INFO - PROCESS | 27573 | 07:51:19 INFO - PROCESS | 27573 | Cycle 1(1): loaded http://localhost:46220/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46220/tests/kraken/driver.html?testName=json-parse-financial) 07:51:20 INFO - PROCESS | 27573 | RSS: Main: 216592384 07:51:20 INFO - PROCESS | 27573 | 07:51:21 INFO - PROCESS | 27573 | Cycle 1(1): loaded http://localhost:46220/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46220/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:51:22 INFO - PROCESS | 27573 | RSS: Main: 203923456 07:51:22 INFO - PROCESS | 27573 | 07:51:24 INFO - PROCESS | 27573 | Cycle 1(1): loaded http://localhost:46220/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46220/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:51:24 INFO - PROCESS | 27573 | RSS: Main: 204611584 07:51:24 INFO - PROCESS | 27573 | 07:51:26 INFO - PROCESS | 27573 | Cycle 1(1): loaded http://localhost:46220/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46220/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:51:27 INFO - PROCESS | 27573 | RSS: Main: 217718784 07:51:27 INFO - PROCESS | 27573 | 07:51:30 INFO - PROCESS | 27573 | Cycle 1(1): loaded http://localhost:46220/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46220/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:51:31 INFO - PROCESS | 27573 | RSS: Main: 226476032 07:51:31 INFO - PROCESS | 27573 | 07:51:34 INFO - PROCESS | 27573 | Cycle 1(1): loaded http://localhost:46220/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46220/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:51:35 INFO - PROCESS | 27573 | RSS: Main: 222183424 07:51:35 INFO - PROCESS | 27573 | 07:51:37 INFO - PROCESS | 27573 | Cycle 1(1): loaded http://localhost:46220/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46220/tests/kraken/driver.html?testName=ai-astar) 07:51:37 INFO - PROCESS | 27573 | RSS: Main: 285364224 07:51:37 INFO - PROCESS | 27573 | 07:51:37 INFO - PROCESS | 27573 | __start_tp_report 07:51:37 INFO - PROCESS | 27573 | _x_x_mozilla_page_load 07:51:37 INFO - PROCESS | 27573 | _x_x_mozilla_page_load_details 07:51:37 INFO - PROCESS | 27573 | |i|pagename|runs| 07:51:37 INFO - PROCESS | 27573 | |0;ai-astar;112;112;108;111;112;114;101;113;113;115 07:51:37 INFO - PROCESS | 27573 | |1;audio-beat-detection;161;144;158;194;137;158;154;132;194;141 07:51:37 INFO - PROCESS | 27573 | |2;audio-dft;160;160;160;162;161;161;161;162;162;162 07:51:37 INFO - PROCESS | 27573 | |3;audio-fft;74;77;125;114;76;74;73;116;102;76 07:51:37 INFO - PROCESS | 27573 | |4;audio-oscillator;95;95;147;101;95;94;139;94;94;139 07:51:37 INFO - PROCESS | 27573 | |5;imaging-gaussian-blur;117;117;117;117;118;117;117;117;117;117 07:51:37 INFO - PROCESS | 27573 | |6;imaging-darkroom;147;146;146;146;145;146;147;147;147;147 07:51:37 INFO - PROCESS | 27573 | |7;imaging-desaturate;95;95;94;95;95;94;94;95;95;94 07:51:37 INFO - PROCESS | 27573 | |8;json-parse-financial;63;64;64;63;64;64;65;82;61;61 07:51:37 INFO - PROCESS | 27573 | |9;json-stringify-tinderbox;63;64;64;64;64;63;64;63;64;64 07:51:37 INFO - PROCESS | 27573 | |10;stanford-crypto-aes;88;79;80;79;80;80;81;79;81;80 07:51:37 INFO - PROCESS | 27573 | |11;stanford-crypto-ccm;143;136;135;136;137;135;136;134;172;135 07:51:37 INFO - PROCESS | 27573 | |12;stanford-crypto-pbkdf2;217;216;216;217;221;223;214;226;217;217 07:51:37 INFO - PROCESS | 27573 | |13;stanford-crypto-sha256-iterative;76;76;76;75;75;75;78;75;75;72 07:51:37 INFO - PROCESS | 27573 | __end_tp_report 07:51:37 INFO - PROCESS | 27573 | __start_cc_report 07:51:37 INFO - PROCESS | 27573 | _x_x_mozilla_cycle_collect,1909 07:51:37 INFO - PROCESS | 27573 | __end_cc_report 07:51:37 INFO - PROCESS | 27573 | __startTimestamp1461768697266__endTimestamp 07:51:37 INFO - PROCESS | 27573 | 07:51:37 INFO - PROCESS | 27573 | ------- Summary: start ------- 07:51:37 INFO - PROCESS | 27573 | Number of tests: 14 07:51:37 INFO - PROCESS | 27573 | 07:51:37 INFO - PROCESS | 27573 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.50 stddev:4.01 (3.6%) stddev-sans-first:4.24 07:51:37 INFO - PROCESS | 27573 | Values: 112.0 112.0 108.0 111.0 112.0 114.0 101.0 113.0 113.0 115.0 07:51:37 INFO - PROCESS | 27573 | 07:51:37 INFO - PROCESS | 27573 | [#1] audio-beat-detection Cycles:10 Average:157.30 Median:158.00 stddev:21.64 (13.7%) stddev-sans-first:22.91 07:51:37 INFO - PROCESS | 27573 | Values: 161.0 144.0 158.0 194.0 137.0 158.0 154.0 132.0 194.0 141.0 07:51:37 INFO - PROCESS | 27573 | 07:51:37 INFO - PROCESS | 27573 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:0.88 (0.5%) stddev-sans-first:0.83 07:51:37 INFO - PROCESS | 27573 | Values: 160.0 160.0 160.0 162.0 161.0 161.0 161.0 162.0 162.0 162.0 07:51:37 INFO - PROCESS | 27573 | 07:51:37 INFO - PROCESS | 27573 | [#3] audio-fft Cycles:10 Average:90.70 Median:74.00 stddev:21.02 (28.4%) stddev-sans-first:21.41 07:51:37 INFO - PROCESS | 27573 | Values: 74.0 77.0 125.0 114.0 76.0 74.0 73.0 116.0 102.0 76.0 07:51:37 INFO - PROCESS | 27573 | 07:51:37 INFO - PROCESS | 27573 | [#4] audio-oscillator Cycles:10 Average:109.30 Median:94.00 stddev:22.53 (24.0%) stddev-sans-first:23.30 07:51:37 INFO - PROCESS | 27573 | Values: 95.0 95.0 147.0 101.0 95.0 94.0 139.0 94.0 94.0 139.0 07:51:37 INFO - PROCESS | 27573 | 07:51:37 INFO - PROCESS | 27573 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 07:51:37 INFO - PROCESS | 27573 | Values: 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 07:51:37 INFO - PROCESS | 27573 | 07:51:37 INFO - PROCESS | 27573 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 07:51:37 INFO - PROCESS | 27573 | Values: 147.0 146.0 146.0 146.0 145.0 146.0 147.0 147.0 147.0 147.0 07:51:37 INFO - PROCESS | 27573 | 07:51:37 INFO - PROCESS | 27573 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 07:51:37 INFO - PROCESS | 27573 | Values: 95.0 95.0 94.0 95.0 95.0 94.0 94.0 95.0 95.0 94.0 07:51:37 INFO - PROCESS | 27573 | 07:51:37 INFO - PROCESS | 27573 | [#8] json-parse-financial Cycles:10 Average:65.10 Median:64.00 stddev:6.08 (9.5%) stddev-sans-first:6.40 07:51:37 INFO - PROCESS | 27573 | Values: 63.0 64.0 64.0 63.0 64.0 64.0 65.0 82.0 61.0 61.0 07:51:37 INFO - PROCESS | 27573 | 07:51:37 INFO - PROCESS | 27573 | [#9] json-stringify-tinderbox Cycles:10 Average:63.70 Median:64.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 07:51:37 INFO - PROCESS | 27573 | Values: 63.0 64.0 64.0 64.0 64.0 63.0 64.0 63.0 64.0 64.0 07:51:37 INFO - PROCESS | 27573 | 07:51:37 INFO - PROCESS | 27573 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:80.00 stddev:2.67 (3.3%) stddev-sans-first:0.78 07:51:37 INFO - PROCESS | 27573 | Values: 88.0 79.0 80.0 79.0 80.0 80.0 81.0 79.0 81.0 80.0 07:51:37 INFO - PROCESS | 27573 | 07:51:37 INFO - PROCESS | 27573 | [#11] stanford-crypto-ccm Cycles:10 Average:139.90 Median:136.00 stddev:11.55 (8.5%) stddev-sans-first:12.20 07:51:37 INFO - PROCESS | 27573 | Values: 143.0 136.0 135.0 136.0 137.0 135.0 136.0 134.0 172.0 135.0 07:51:37 INFO - PROCESS | 27573 | 07:51:37 INFO - PROCESS | 27573 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:218.40 Median:217.00 stddev:3.72 (1.7%) stddev-sans-first:3.91 07:51:37 INFO - PROCESS | 27573 | Values: 217.0 216.0 216.0 217.0 221.0 223.0 214.0 226.0 217.0 217.0 07:51:37 INFO - PROCESS | 27573 | 07:51:37 INFO - PROCESS | 27573 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.30 Median:75.50 stddev:1.49 (2.0%) stddev-sans-first:1.56 07:51:37 INFO - PROCESS | 27573 | Values: 76.0 76.0 76.0 75.0 75.0 75.0 78.0 75.0 75.0 72.0 07:51:37 INFO - PROCESS | 27573 | -------- Summary: end -------- 07:51:37 INFO - PROCESS | 27573 | 07:51:38 INFO - TEST-INFO | 27573: exit 0 07:51:38 INFO - TEST-OK | kraken | took 64003ms 07:51:38 INFO - SUITE-END | took 1182s 07:51:38 INFO - Completed test suite (00:19:42) 07:51:38 INFO - javascript benchmark 07:51:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2622.056059818465, 2667.9733202667967, 2690.5829596412555, 2708.7697545708625, 2724.3189202699327, 4614.815407383709, 4704.411948506437, 4727.8345257915935, 4766.594839438643, 4787.473377928425, 4755.239161734124, 4775.856724298276, 4805.927911081328, 4808.7595620218935, 4822.927656085153, 4248.107897341562, 4347.152305300468, 4389.736615803046, 4443.733375997434, 4546.408966834323, 4457.910841783162, 4486.0, 4503.964088259702, 4504.234280172379, 4522.118186953546, 4241.512226094008, 4279.293916503773, 4322.373255877911, 4328.870133895956, 4421.513633500296, 4333.328334108187, 4372.650187984954, 4378.321360189176, 4401.6698747594055, 4422.226110430662, 4276.401303817468, 4299.828006879721, 4313.82744690212, 4315.611594956437, 4353.020570371673, 4539.251023581105, 4582.931256031162, 4639.072185562901, 4663.860084197446, 4740.051989602093, 4979.45226025137, 4979.626528010377, 4991.725455099968, 4992.176290911995, 5028.145215313405, 4998.200287953946, 5030.748462576893, 5036.395632524084, 5042.193249080166, 5085.974570127126, 4648.581627653527, 4684.859454216379, 4754.21555443348, 4810.95189048112, 4822.300766388924, 5150.948490515047, 5157.896842063138, 5182.067227899014, 5182.119039763249, 5187.04039752647, 4959.727215003138, 4966.453690094087, 4969.254611808257, 4969.726665033458, 5001.974990125099, 4812.927806082912, 4989.850304490871, 5119.820806271837, 5156.767945442464, 5163.4062082860955, 4986.526280003394, 4997.525235102659, 5002.499750024968, 5006.799728010911, 5055.241713742968, 4773.737444440589, 4978.65149439543, 4978.975105124451, 4980.8754781130765, 5018.523240292239, 4145.958540414617, 4171.416001759756, 4206.20082184384, 4251.957480425156, 4265.658747300208, 3713.3872910969926, 3718.2749363873786, 3720.311742327624, 3728.179800443898, 3757.9436308455397, 4322.675799315001, 4407.625351845129, 4409.140217657526, 4411.514733379326, 4447.644188464915, 5024.070546948753, 5113.616478764033, 5132.153194722829, 5135.640505164677, 5136.743162841843, 4381.737095774264, 4386.451693538308, 4401.075774087413, 4405.625521830616, 4451.888702782391, 4529.682922195415, 4529.886752831139, 4539.7049191802425, 4545.38637283969, 4593.058423023273, 4649.18639238132, 4780.1873681474235, 4811.9518804811505, 4851.733154676526, 4861.416630004422, 5058.696478211172, 5064.215046667772, 5069.69581825077, 5074.543291103819, 5111.897762044812, 4663.0, 4782.808687652455, 4825.662203645711, 4826.758662066813, 4888.706677599355, 4998.400191976986, 5008.148614735576, 5035.370578677665, 5054.140796064751, 5066.898662026665, 4969.751512424292, 4973.254011898244, 4984.22744474607, 4998.725070121178, 5005.424376196784, 4789.760511974457, 4857.271409288635, 4871.658983871095, 4888.657793954531, 4904.558589726942, 4862.781174847069, 4879.121758083437, 4902.411710594752, 4923.335349727741, 4925.729084900365, 4791.664583479123, 4800.231962885921, 4815.7351345676325, 4821.252705830602, 4821.566059054702, 4838.637102217418, 4903.877403064952, 4907.288443175791, 4942.579880710036, 4956.826511072095, 4797.616190704805, 4813.663043586916, 4822.300766388924, 4867.050925069578, 4868.196747536616], "value": 4638.632932138327, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.7164289498147, 610.5817515002224, 615.2125279642057, 628.4061561824075, 631.3055638797326, 26014.219573412804, 32208.67791322086, 33166.66833331666, 33325.500117498195, 33893.83053084737, 35061.12347191321, 35280.64719352806, 35513.0, 35625.82187089067, 35644.0, 6971.128608923885, 7489.887651685215, 7680.961595192016, 7695.115061767884, 7701.537907725555, 9387.718368448923, 9642.614295428175, 9661.130498255156, 9661.275404344668, 9666.75833104171, 9491.430514169171, 9660.855087173699, 9665.516724163763, 9665.565049572751, 9676.95161524195, 9421.340506164572, 9508.334416590842, 9508.524573771283, 9518.23854091678, 9533.761655958588, 9543.47510886901, 9655.951720241424, 9672.0, 9975.152112070411, 9982.201423886072, 33749.49375759366, 34112.82943585266, 34205.31589368199, 34283.0, 34343.656563434546, 3187.7449804015623, 3215.0, 3255.811628755511, 3386.2888793353427, 3400.6429324920773, 27024.59463108055, 27289.0, 27621.30946726328, 27739.86130069357, 28280.0, 3458.654134586546, 3485.5468789057513, 3507.9473807892646, 3510.5436293281964, 3531.6644918732677, 178942.36874603239, 179030.10484947622, 179630.0, 179771.0, 180425.0, 49189.508104918496, 49743.50256497461, 50071.0, 50190.0, 50207.74896125496, 52906.206406903926, 53001.0, 53222.467775322526, 53349.1997620036, 53542.732286338316, 14172.078814877, 14810.92594537042, 14819.851801482062, 14820.110793352433, 14845.777313340308, 10925.836112458319, 11047.447627618587, 11085.390303533222, 11115.110791136689, 11120.888791112147, 16120.596985075232, 16997.91501042487, 17039.659206815795, 17058.74411883823, 17101.91449042747, 6452.548321617535, 6491.094413655466, 6515.381038801306, 6581.506387020897, 6617.007448882706, 868.4268382867403, 935.3546053223254, 971.4754032822196, 986.4032260482448, 996.4419924842111, 26083.379181474393, 26971.595426068623, 27146.321341966213, 27266.182014539594, 27336.31659208496, 1007.2646967713611, 1039.6725031615017, 1062.729004103964, 1077.2674581284803, 1110.9945499322964, 13964.301784910916, 14097.36561854719, 14392.208428536322, 14448.277586120652, 14504.274786260856, 196627.0, 203855.0, 204515.0, 204614.0, 256291.0, 45129.548704512534, 45910.31134532985, 46112.7694361526, 46169.0, 46206.30690539644, 1178.6817559259123, 1212.090931801149, 1228.5085965613825, 1240.0017985521743, 1260.294235228275, 24173.516529668956, 26237.0, 26509.33726656772, 26555.60166597464, 26611.0, 36172.27655446823, 36843.81578092092, 36999.07502312356, 37012.44481332728, 37025.0, 247910.0, 255458.0, 255461.0, 255686.0, 256137.0, 32309.0, 32961.0, 32997.0, 33556.16109597182, 35080.47379289262, 38343.42484862785, 38491.42262866003, 38498.0, 39066.0, 39355.212895742494, 32905.67094329122, 33668.83165584156, 34300.82849585836, 34338.48492272568, 34742.47886281657, 33700.49449258214, 34105.829470852485, 34109.317813644084, 34169.145771355914, 34448.0, 33116.668833312324, 33514.664853351154, 33561.664383355856, 33721.32557348888, 33960.320793584484, 29771.70228297776, 29899.402011959202, 30415.847920761138, 30536.236594085327, 30705.692943071175, 23376.026075566853, 23501.529969400857, 23973.763541921617, 23994.76005239995, 24046.0], "value": 16925.782156036006, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.1504689682699, 386.42036944583134, 388.6911744239217, 397.3344647715077, 404.3631280732845, 15588.298526566303, 15997.84002159978, 16180.676386472263, 16195.028298302095, 16196.514104576867, 15285.082895026306, 15793.0, 16019.279132439038, 16033.599160021005, 16079.83920160798, 5033.697978121324, 5117.411497677759, 5135.35808023997, 5162.22566615007, 5180.507851754077, 5052.646314757969, 5106.514881086291, 5127.102757017507, 5145.614078944075, 5148.433672296044, 4954.801807927696, 5078.339815823938, 5088.771005304751, 5096.337476128098, 5120.052790233819, 4882.340883980671, 5059.595232381419, 5098.286239926413, 5135.152699804527, 5143.305653736773, 4603.171429142753, 4603.309503574457, 4604.470485894131, 4609.516000819933, 4625.259958406638, 19001.429957101172, 19224.231030758754, 19405.708914366296, 19598.510037249183, 19620.0, 1925.749652545174, 1987.9403617891487, 2100.411884672294, 2578.690557133137, 2582.5609646360163, 11255.66233013011, 11789.646310610695, 12223.877761222362, 12450.377481125908, 12765.297908615023, 1705.218047140741, 1788.97316540252, 1830.5515148788631, 1908.9809101908943, 1948.39599724086, 59687.70156149235, 60187.69906150441, 60484.395156048755, 60778.0, 63391.36608633901, 9825.361351512129, 9982.201423886072, 10047.447390393452, 10146.492675366202, 10166.542505587266, 13669.726605468033, 13897.79153312701, 13904.235267060409, 13943.16341019542, 13945.233012184224, 7031.367176954099, 7234.602096884617, 7325.2308507607, 7384.2246564111065, 7434.628268586549, 6917.412019978358, 6955.617441040791, 7016.649167541603, 7099.290070992963, 7109.289071092952, 4293.892652683708, 4433.623142032899, 4476.7090139140855, 4502.482214545369, 4548.135854187693, 1799.5321216483808, 1872.6348362069539, 1877.333546590968, 1879.4643526594855, 1897.5351038995534, 858.695163217049, 927.8051609162017, 946.6923249943795, 974.3666616699202, 992.6773798515367, 15104.622384440258, 15314.387424503118, 15773.526794196192, 16015.0, 16174.0, 925.3938670171049, 930.6649606141783, 934.7149119518476, 973.3767496596745, 991.8363470027509, 8716.302695784321, 8831.425957312755, 9070.591823367964, 9228.400153990104, 9295.163435290857, 380713.0, 389713.0, 392596.0, 395237.0, 404997.0, 68667.0, 69080.6545967267, 70250.64874675593, 70500.64749676219, 72046.279537205, 917.9173874351206, 921.7695576105973, 923.1968187676764, 928.6378312458147, 933.6078846884325, 14424.0, 14550.781738274147, 14676.41294348214, 14691.971561990558, 14866.405343786128, 31160.0, 31958.84020579882, 32105.35789284248, 32132.0, 32293.838530807196, 43938.0, 45376.31935521036, 45389.31916021196, 45473.545264546934, 45692.573057021524, 7419.4806363554035, 7458.962705186439, 7476.102867655916, 7537.095548534211, 7649.273319034683, 8355.665773368997, 10948.781024379627, 10969.945150274198, 11057.530114504816, 11164.832527511931, 9220.216281616138, 9429.0, 9568.521573921136, 9826.65606703762, 9959.800803984024, 9587.280953928344, 9782.608695652094, 9826.508674566387, 9893.50532473359, 10030.448325341884, 9727.416355018722, 9923.900760992297, 9962.900370996487, 10000.349977251455, 10031.147352475122, 7343.302386273295, 7546.0, 7574.5833979129475, 7582.469227154046, 7600.46796724224, 8675.522846243517, 8733.694320698745, 8888.24449921738, 8900.510471924106, 9268.443893366419], "value": 8024.4169218870375, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1206.0773508266184, 1422.061439449963, 1459.5475402625186, 1586.3337398292715, 1760.3877840059047, 6285.0, 7210.603416812073, 7380.114386273642, 7392.852142957145, 7397.075365579302, 7148.463865210104, 7291.708331666727, 7299.94150848128, 7307.415406767459, 7307.451941104412, 2149.752778430481, 2170.023489429755, 2170.4899348653053, 2171.6633921742155, 2173.369722780392, 2148.871067735933, 2161.502854343502, 2210.193279452996, 2210.602091623507, 2226.677131815886, 2199.7580266170708, 2200.284907405092, 2213.0, 2214.202886960693, 2235.865848049114, 2099.086897199715, 2101.432613194444, 2104.747430308365, 2107.2729908181727, 2113.397681660719, 2111.356036408895, 2141.218455263833, 2152.7954844289766, 2153.375521098895, 2153.558520503293, 7156.856862862714, 7337.046183996046, 7361.742339018108, 7373.668184931691, 7401.925980740178, 4456.866294011184, 4610.838620648261, 4634.165850146972, 4635.791389387486, 4637.072585482883, 2878.150945471091, 2907.069737683942, 2929.824210547374, 2930.8388038657863, 2972.583838262645, 918.1277786103228, 928.8235235305337, 930.9534523273809, 934.7429456899339, 964.252704154286, 9551.0926461986, 9894.060064293952, 9929.3545919515, 9938.801223975552, 9947.25395595326, 4072.470578824793, 4163.063310755117, 4223.450951376363, 4238.237117318912, 4244.596763307481, 7922.286994170552, 7950.681972721142, 7957.641906114239, 7965.800854978556, 7969.681212751425, 4425.269830477935, 4574.519675434098, 4574.83988060423, 4575.10785396851, 4575.839845605387, 3619.6380361963593, 4060.0864805418546, 4169.770662613585, 4174.582541745862, 4251.80866860992, 3312.569365982407, 3323.4516304809918, 3362.596488421405, 3367.6295607483157, 3402.795832250073, 1013.3058854684565, 1102.2780079048237, 1105.3478447715886, 1108.2851560743275, 1110.3448965110624, 779.9961000194962, 784.5488843914771, 821.0557858462815, 837.2757564706485, 844.1052484366469, 4931.334269873521, 5095.414027386824, 5134.589232861362, 5148.099082660519, 5156.097682905552, 827.6937533112787, 865.4634126841398, 899.572702966099, 915.6154415145655, 932.06327640722, 3208.4545627242956, 3262.918427039343, 3270.084376374619, 3290.9835450822593, 3341.732661387132, 8383.580820958927, 9032.187103160615, 9186.77033074165, 9311.90688093124, 9312.953435232916, 9127.087291270953, 9153.81692366149, 9154.908450915538, 9195.448273103635, 9240.399374040666, 6567.6059436433015, 6916.51584389098, 6983.685734141975, 6989.965050174716, 6999.755008574675, 5029.899402012013, 5090.745462726923, 5103.387593488805, 5206.386020333557, 5260.658057226268, 8192.631331590212, 8334.791630209293, 8373.95813020931, 8445.746627601182, 8453.830923381622, 8197.71308004217, 8356.080831108451, 8367.748967530984, 8389.0, 8460.873086903579, 5432.348118225838, 6104.38956104386, 6127.20346354971, 6152.415520525722, 6234.812955611339, 7287.0, 7375.299346562068, 7380.151282602569, 7382.44631652639, 7384.52000619958, 6383.361663833765, 6700.46396288286, 6747.831304217238, 6754.054432379569, 6808.148981377328, 5995.650978529796, 6559.6064236144075, 6564.702354176, 6704.932950670431, 6736.865262694817, 5989.790357337647, 6033.487153591994, 6059.727312271047, 6060.303065147565, 6064.423879731418, 4213.620774130343, 4332.696711230184, 4376.649868010488, 4442.155990361821, 4475.686701930834, 4231.936520952249, 4470.575295346936, 4486.439195100613, 4487.596116349544, 4497.100579883971], "value": 3985.6322509530974, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.73294035368167, 306.1473795479587, 317.19907234233557, 320.0733875430629, 323.22426177174776, 4535.795889184987, 4672.976635116824, 4675.158471475133, 4749.3350930869665, 4752.334673145762, 4529.34324522944, 4675.532446755323, 4690.812367505304, 4696.365990591269, 4717.410323709536, 3772.170122573036, 3774.811259437031, 3779.2252588219485, 3782.8865134046023, 3793.3172029034763, 3587.6950459211, 3630.818459077049, 3768.6419790119894, 3777.6411240932066, 3795.430685397185, 3725.143217060078, 3727.366347720894, 3737.8878633641034, 3759.830807613664, 3783.1109689223013, 3713.8885833425043, 3743.363628183202, 3753.1555400035045, 3770.3024940386117, 3780.3762379207396, 3365.5793025871767, 3366.8148251846137, 3373.0, 3376.7805092669146, 3389.3560223557447, 4431.645468362523, 4473.405424853577, 4508.399518171035, 4518.480374756912, 4522.479914809806, 4254.361845723135, 4268.615824575803, 4275.572442755731, 4284.357346398034, 4288.914221715549, 4878.951025529528, 4918.434380046305, 4918.827841025547, 4929.8028078876805, 4939.851164743348, 3558.1282585766394, 3651.7443778935485, 3659.2864391443677, 3668.404244153775, 3695.7228207884245, 5112.41207261166, 5150.227465880111, 5183.144781111112, 5188.429272779991, 5191.32512773337, 3733.3280009598534, 3752.155764952918, 3759.3045286622064, 3768.66212494566, 3769.302679004338, 3797.981010094987, 3810.1998580298446, 3810.904727381838, 3811.3901775715754, 3818.4463252828186, 4073.1853629274265, 4264.488261408651, 4270.722403043855, 4272.0, 4284.485861696617, 4865.318855360252, 4888.9755551222015, 4896.706197628154, 4919.163742163769, 4923.236898280772, 1299.707565797688, 1334.6329759316072, 1372.1081297156927, 1380.2960490149894, 1392.7562676531566, 951.5004622573205, 955.8470644696815, 966.7534778631544, 968.801395713877, 970.5147426286857, 4663.766811659471, 4666.976665116653, 4672.08894265615, 4678.2280923647895, 4681.7659117044695, 5408.323959505062, 5416.106342453451, 5419.891602167934, 5426.810061647823, 5428.511433970962, 4266.104118135227, 4648.349231107648, 4661.254199328091, 4665.113628410591, 4669.369635099286, 2910.4324656691742, 2919.7664186865, 2925.575791510219, 2928.853557322125, 2931.589577459157, 5193.480651934852, 5195.168772996378, 5226.189940559219, 5233.842984710464, 5240.554552862973, 5366.570674346043, 5632.04255276604, 5632.831015069554, 5643.5767317451355, 5647.858803529863, 5170.5346518813485, 5209.635325527177, 5213.087709650872, 5243.161094224905, 5264.52619264268, 5502.0921547945745, 5525.751341189736, 5528.087865502308, 5528.281323427928, 5528.751206195811, 4805.327254184347, 5031.144705400164, 5033.47148549397, 5077.847664570068, 5390.056740070394, 4882.145624515767, 4883.316335713074, 4914.410270767531, 4918.827841025547, 4927.728974906415, 3606.549181352331, 3627.3652110881017, 3628.020434482622, 3629.891103266906, 3649.062504683755, 4921.655484116221, 4931.161702510653, 5155.716435596079, 5155.871103222449, 5160.716160611202, 4897.877553061059, 4974.403071631427, 4982.800687972585, 4991.376077990251, 5006.1739812930455, 4942.0, 4952.579030782424, 4954.603631709527, 4982.227754698028, 4995.8001679932395, 4843.6557284680475, 4872.342233798392, 4914.36113305268, 4916.631252656137, 4950.183219768698, 4982.451930287593, 4998.900021999612, 5021.397432308147, 5036.909682481729, 5038.060346766448, 4945.530174633404, 4945.901081978413, 4950.45544990058, 4953.356063711694, 4982.252662100714], "value": 3852.985764055418, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [724.4638967164298, 753.4989232160611, 766.934810541104, 769.9422543309253, 771.5949126708474, 13330.866691333084, 13710.93144534276, 13784.517541886036, 13800.861991380083, 13801.930990345047, 13635.863641363609, 13718.314084295795, 13739.450421983109, 13742.450301987934, 13823.723525529484, 639.2361128451503, 789.6683392974965, 810.7689308547051, 818.3575892924056, 818.8771684247351, 817.6892780743309, 819.4468733604793, 819.983600327993, 820.958952052395, 821.4906757810166, 843.1105184030845, 851.6210286422545, 851.6508231625035, 851.7189327521903, 852.1393392673383, 661.8345413646589, 816.3102178659024, 834.9707760228393, 839.6641343462603, 843.5360551696542, 615.6398506873485, 615.9199304090439, 617.0127795527121, 617.3702823120392, 617.6109051297653, 12755.872441275562, 12795.360231988363, 12806.679833004157, 12820.03849711266, 12834.743305133938, 11446.484908179153, 11737.295762254207, 11928.522859085626, 12077.57728479499, 12276.693082672915, 9236.815263694689, 9361.110694484014, 9402.811943761155, 9412.482313472756, 9695.22438204949, 3231.9676803232137, 3266.5590145330552, 3362.8654853806065, 3386.7967921924765, 3393.558837351153, 39115.60884391148, 39329.213415731814, 39551.40672889909, 39638.405423918666, 40007.3998890014, 9155.633774649074, 9165.404248723811, 9362.0, 9561.474118923526, 9562.61749530025, 15815.841841581438, 15817.0, 15817.604559885865, 15824.76262856058, 15849.207539622972, 6304.779332723424, 6396.2964073951825, 6427.935720642734, 6438.806835794933, 6439.066335381437, 3548.27260411615, 3584.4802503636824, 3620.5836328821997, 3645.5989841117457, 3658.213484100931, 2792.176307989148, 2830.1933948824485, 2839.063109173968, 2843.758280546135, 2845.7865660075577, 477.0149640991342, 533.3466503533141, 558.5922276738004, 573.2232824522712, 575.4073304496376, 467.96256299495957, 586.0330454749698, 615.7444660465857, 623.7789700209188, 630.4137152448267, 7285.70857165718, 7349.77950661481, 7378.778636640909, 7499.21258267885, 7672.884906726404, 559.3986464550625, 566.7477972302369, 589.4154134121821, 589.4665327878276, 600.942910423509, 3312.801231926044, 3493.5409767594256, 3507.5440192774777, 3547.9645203547634, 3607.098225443639, 53373.199402009, 55169.72415137979, 55561.72219138959, 55685.721571391885, 55772.16341754877, 46138.769306153255, 48162.759186203846, 48475.75762121167, 48866.0, 50092.49907500878, 44090.33864492035, 44225.77887110544, 44339.778301108934, 45390.54609453929, 46105.7694711531, 6955.791326260221, 7108.0, 7118.60847653384, 7119.288071192839, 7186.496945213785, 28626.427471450872, 28886.0, 29377.706222938352, 29547.704522955355, 29736.0, 35724.28551429009, 38239.661611843454, 39769.60230397659, 40009.0, 40016.59983400245, 9897.604095836086, 9941.602335906482, 10010.599576016877, 10093.394396336244, 10352.844707329245, 10740.409277489813, 10865.348079115278, 10894.128469722562, 11082.944585277022, 11125.44372781374, 9701.611935522782, 9830.0, 10175.08424241792, 10309.948450258, 10618.309809862334, 10069.798604027732, 10291.176705863363, 10307.742306442398, 10376.636817711344, 10841.891581084405, 9135.817283654156, 9241.861372079558, 9364.765880853032, 9395.342326037111, 9401.294902882175, 8279.0, 8308.459950103224, 8370.707025254087, 8541.615627296911, 8726.956365218133, 7918.762437126896, 8085.0, 8200.466969646954, 8200.712975045844, 8292.419530632798], "value": 5761.192728006698, "unit": "score"}], "name": "dromaeo_css", "value": 6180.657639971992, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 108.0, 111.0, 112.0, 114.0, 101.0, 113.0, 113.0, 115.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 144.0, 158.0, 194.0, 137.0, 158.0, 154.0, 132.0, 194.0, 141.0], "value": 157.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 162.0, 161.0, 161.0, 161.0, 162.0, 162.0, 162.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 125.0, 114.0, 76.0, 74.0, 73.0, 116.0, 102.0, 76.0], "value": 90.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 147.0, 101.0, 95.0, 94.0, 139.0, 94.0, 94.0, 139.0], "value": 109.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.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": [147.0, 146.0, 146.0, 146.0, 145.0, 146.0, 147.0, 147.0, 147.0, 147.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 63.0, 64.0, 64.0, 65.0, 82.0, 61.0, 61.0], "value": 65.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 64.0, 64.0, 63.0, 64.0, 63.0, 64.0, 64.0], "value": 63.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 79.0, 80.0, 79.0, 80.0, 80.0, 81.0, 79.0, 81.0, 80.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 136.0, 135.0, 136.0, 137.0, 135.0, 136.0, 134.0, 172.0, 135.0], "value": 139.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [217.0, 216.0, 216.0, 217.0, 221.0, 223.0, 214.0, 226.0, 217.0, 217.0], "value": 218.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 75.0, 75.0, 75.0, 78.0, 75.0, 75.0, 72.0], "value": 75.3, "unit": "score"}], "name": "kraken", "value": 1630.7000000000003, "alertThreshold": 2.0}]} 07:51:38 INFO - Return code: 0 07:51:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:51:38 ERROR - # TBPL SUCCESS # 07:51:38 INFO - Running post-action listener: _resource_record_post_action 07:51:38 INFO - Running post-run listener: _resource_record_post_run 07:51:39 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 2318336; Write bytes: 520663040; Read time: 1016; Write time: 382060 07:51:39 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 240914432; Read time: 0; Write time: 235076 07:51:39 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 2318336; Write bytes: 279748608; Read time: 1016; Write time: 146984 07:51:39 INFO - Running post-run listener: _upload_blobber_files 07:51:39 INFO - Blob upload gear active. 07:51:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:51:39 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 07:51:39 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'] 07:51:39 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 07:51:40 INFO - (blobuploader) - INFO - Open directory for files ... 07:51:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:51:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:51:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:51:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:51:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:51:40 INFO - (blobuploader) - INFO - Done attempting. 07:51:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:51:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:51:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:51:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:51:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:51:41 INFO - (blobuploader) - INFO - Done attempting. 07:51:41 INFO - (blobuploader) - INFO - Iteration through files over. 07:51:41 INFO - Return code: 0 07:51:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:51:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:51:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/41a1801e809c2b66be9d39d81896b1dd973adfbda66a5ce8c19a383da6e6566413d27dabb03310302da5670c6d5c816a8eefe03321510398367979a0f2d5dc22", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1eaa06469f13341550d4d23fa596d3d76cd78bc96049a90b39ff90d8c5c86a47f9293ba0be7f0b6e2fc18ba4891d0714c7cf877a2da9b08d9f06f5169ee5990a"} 07:51:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:51:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:51:41 INFO - Contents: 07:51:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/41a1801e809c2b66be9d39d81896b1dd973adfbda66a5ce8c19a383da6e6566413d27dabb03310302da5670c6d5c816a8eefe03321510398367979a0f2d5dc22", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1eaa06469f13341550d4d23fa596d3d76cd78bc96049a90b39ff90d8c5c86a47f9293ba0be7f0b6e2fc18ba4891d0714c7cf877a2da9b08d9f06f5169ee5990a"} 07:51:41 INFO - Running post-run listener: copy_logs_to_upload_dir 07:51:41 INFO - Copying logs to upload dir... 07:51:41 INFO - mkdir: /builds/slave/test/build/upload/logs 07:51:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.490761 ========= master_lag: 2.48 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-04-27 07:51:43.781325) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 07:51:43.785143) ========= 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=82e07478c745e68b1fe4678a000001bc-1461766961.877596-1673116342 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/41a1801e809c2b66be9d39d81896b1dd973adfbda66a5ce8c19a383da6e6566413d27dabb03310302da5670c6d5c816a8eefe03321510398367979a0f2d5dc22", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1eaa06469f13341550d4d23fa596d3d76cd78bc96049a90b39ff90d8c5c86a47f9293ba0be7f0b6e2fc18ba4891d0714c7cf877a2da9b08d9f06f5169ee5990a"} build_url:https://queue.taskcluster.net/v1/task/JNpWz5iKRZqd5ze4Ucr82g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009946 build_url: 'https://queue.taskcluster.net/v1/task/JNpWz5iKRZqd5ze4Ucr82g/artifacts/public/build/firefox-49.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/41a1801e809c2b66be9d39d81896b1dd973adfbda66a5ce8c19a383da6e6566413d27dabb03310302da5670c6d5c816a8eefe03321510398367979a0f2d5dc22", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1eaa06469f13341550d4d23fa596d3d76cd78bc96049a90b39ff90d8c5c86a47f9293ba0be7f0b6e2fc18ba4891d0714c7cf877a2da9b08d9f06f5169ee5990a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 07:51:43.806268) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 07:51:43.806588) ========= 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=82e07478c745e68b1fe4678a000001bc-1461766961.877596-1673116342 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004449 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 07:51:43.855600) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 07:51:43.855937) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 07:51:43.856236) ========= ========= Total master_lag: 2.80 =========