builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-061 starttime: 1470266534.31 results: success (0) buildid: 20160803154221 builduid: a257a70cee554b39bbbaf79189679514 revision: 69b0f784a9a21369d3aba9c467c953dce81b1e59 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-03 16:22:14.316151) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-03 16:22:14.316727) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-03 16:22:14.317046) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-03 16:22:14.333237) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 16:22:14.333630) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1470266330.304297-1829036138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-03 16:22:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2016-08-03 16:22:14 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119015 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 16:22:14.474686) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 16:22:14.475038) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1470266330.304297-1829036138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014138 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 16:22:14.526205) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-03 16:22:14.526640) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 69b0f784a9a21369d3aba9c467c953dce81b1e59 --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 69b0f784a9a21369d3aba9c467c953dce81b1e59 --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=516f8d7ca085b4d087ab0a71000001a4-1470266330.304297-1829036138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-03 16:22:14,999 truncating revision to first 12 chars 2016-08-03 16:22:14,999 Setting DEBUG logging. 2016-08-03 16:22:14,999 attempt 1/10 2016-08-03 16:22:14,999 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/69b0f784a9a2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-03 16:22:16,317 unpacking tar archive at: fx-team-69b0f784a9a2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.662254 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-03 16:22:16.203383) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-03 16:22:16.203938) ========= script_repo_revision: 69b0f784a9a21369d3aba9c467c953dce81b1e59 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-03 16:22:16.204594) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-03 16:22:16.205078) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-03 16:22:16.216515) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-08-03 16:22:16.216978) ========= /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=516f8d7ca085b4d087ab0a71000001a4-1470266330.304297-1829036138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:22:16 INFO - MultiFileLogger online at 20160803 16:22:16 in /builds/slave/test 16:22:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 16:22:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:22:16 INFO - {'append_to_log': False, 16:22:16 INFO - 'base_work_dir': '/builds/slave/test', 16:22:16 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 16:22:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:22:16 INFO - 'branch': 'Fx-Team-Non-PGO', 16:22:16 INFO - 'buildbot_json_path': 'buildprops.json', 16:22:16 INFO - 'config_files': ('talos/linux_config.py',), 16:22:16 INFO - 'default_actions': ('clobber', 16:22:16 INFO - 'read-buildbot-config', 16:22:16 INFO - 'download-and-extract', 16:22:16 INFO - 'populate-webroot', 16:22:16 INFO - 'create-virtualenv', 16:22:16 INFO - 'install', 16:22:16 INFO - 'run-tests'), 16:22:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:22:16 INFO - 'download_minidump_stackwalk': True, 16:22:16 INFO - 'download_symbols': 'ondemand', 16:22:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:22:16 INFO - 'tooltool.py': '/tools/tooltool.py', 16:22:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:22:16 INFO - '/tools/misc-python/virtualenv.py')}, 16:22:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:22:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:22:16 INFO - 'installer_path': 'installer.exe', 16:22:16 INFO - 'log_level': 'info', 16:22:16 INFO - 'log_name': 'talos', 16:22:16 INFO - 'log_to_console': True, 16:22:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:22:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:22:16 INFO - 'opt_config_files': (), 16:22:16 INFO - 'pip_index': False, 16:22:16 INFO - 'sps_profile': False, 16:22:16 INFO - 'sps_profile_interval': 0, 16:22:16 INFO - 'suite': 'dromaeojs', 16:22:16 INFO - 'system_bits': '32', 16:22:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:22:16 INFO - 'title': 'talos-linux64-ix-061', 16:22:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:22:16 INFO - 'use_talos_json': True, 16:22:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:22:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:22:16 INFO - 'work_dir': 'build'} 16:22:16 INFO - [mozharness: 2016-08-03 23:22:16.787802Z] Running clobber step. 16:22:16 INFO - Running pre-action listener: _resource_record_pre_action 16:22:16 INFO - Running main action method: clobber 16:22:16 INFO - rmtree: /builds/slave/test/build 16:22:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:22:17 INFO - Running post-action listener: _resource_record_post_action 16:22:17 INFO - [mozharness: 2016-08-03 23:22:17.245356Z] Finished clobber step (success) 16:22:17 INFO - [mozharness: 2016-08-03 23:22:17.245458Z] Running read-buildbot-config step. 16:22:17 INFO - Running pre-action listener: _resource_record_pre_action 16:22:17 INFO - Running main action method: read_buildbot_config 16:22:17 INFO - Using buildbot properties: 16:22:17 INFO - { 16:22:17 INFO - "project": "", 16:22:17 INFO - "product": "firefox", 16:22:17 INFO - "script_repo_revision": "production", 16:22:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:22:17 INFO - "repository": "", 16:22:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 16:22:17 INFO - "buildid": "20160803154221", 16:22:17 INFO - "pgo_build": "False", 16:22:17 INFO - "basedir": "/builds/slave/test", 16:22:17 INFO - "buildnumber": 1847, 16:22:17 INFO - "slavename": "talos-linux64-ix-061", 16:22:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:22:17 INFO - "platform": "ubuntu64_hw", 16:22:17 INFO - "scheduler": "tests-fx-team-linux64-talos", 16:22:17 INFO - "branch": "fx-team", 16:22:17 INFO - "repo_path": "integration/fx-team", 16:22:17 INFO - "revision": "69b0f784a9a21369d3aba9c467c953dce81b1e59", 16:22:17 INFO - "stage_platform": "linux64", 16:22:17 INFO - "builduid": "a257a70cee554b39bbbaf79189679514", 16:22:17 INFO - "slavebuilddir": "test" 16:22:17 INFO - } 16:22:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/KNhBZfw2R26dOba1YT_C3g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 16:22:17 INFO - Running post-action listener: _resource_record_post_action 16:22:17 INFO - [mozharness: 2016-08-03 23:22:17.247893Z] Finished read-buildbot-config step (success) 16:22:17 INFO - [mozharness: 2016-08-03 23:22:17.247982Z] Running download-and-extract step. 16:22:17 INFO - Running pre-action listener: _resource_record_pre_action 16:22:17 INFO - Running main action method: download_and_extract 16:22:17 INFO - mkdir: /builds/slave/test/build/tests 16:22: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')]} 16:22:17 INFO - https://queue.taskcluster.net/v1/task/KNhBZfw2R26dOba1YT_C3g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:22:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNhBZfw2R26dOba1YT_C3g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:22:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNhBZfw2R26dOba1YT_C3g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:22:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNhBZfw2R26dOba1YT_C3g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:22:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNhBZfw2R26dOba1YT_C3g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:22:17 INFO - Downloaded 1361 bytes. 16:22:17 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:22:17 INFO - Using the following test package requirements: 16:22:17 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:22:17 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:22:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:22:17 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:22:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:22:17 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:22:17 INFO - u'jsshell-linux-x86_64.zip'], 16:22:17 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:22:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:22:17 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:22:17 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:22:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:22:17 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:22:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:22:17 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:22:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:22:17 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:22:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:22:17 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:22: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')]} 16:22:17 INFO - https://queue.taskcluster.net/v1/task/KNhBZfw2R26dOba1YT_C3g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:22:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNhBZfw2R26dOba1YT_C3g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:22:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNhBZfw2R26dOba1YT_C3g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:22:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNhBZfw2R26dOba1YT_C3g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:22:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNhBZfw2R26dOba1YT_C3g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:22:18 INFO - Downloaded 20240759 bytes. 16:22:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:22:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:22:20 INFO - Return code: 0 16:22:20 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:22: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')]} 16:22:20 INFO - https://queue.taskcluster.net/v1/task/KNhBZfw2R26dOba1YT_C3g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:22:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNhBZfw2R26dOba1YT_C3g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:22:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNhBZfw2R26dOba1YT_C3g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:22:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNhBZfw2R26dOba1YT_C3g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:22:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNhBZfw2R26dOba1YT_C3g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:22:21 INFO - Downloaded 20240759 bytes. 16:22:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:22:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:22:22 INFO - Return code: 0 16:22: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')]} 16:22:22 INFO - https://queue.taskcluster.net/v1/task/KNhBZfw2R26dOba1YT_C3g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:22:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNhBZfw2R26dOba1YT_C3g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 16:22:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNhBZfw2R26dOba1YT_C3g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 16:22:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNhBZfw2R26dOba1YT_C3g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 16:22:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNhBZfw2R26dOba1YT_C3g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:22:23 INFO - Downloaded 14413723 bytes. 16:22:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:22:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:22:23 INFO - Return code: 0 16:22:23 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')]} 16:22:23 INFO - https://queue.taskcluster.net/v1/task/KNhBZfw2R26dOba1YT_C3g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:22:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNhBZfw2R26dOba1YT_C3g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:22:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNhBZfw2R26dOba1YT_C3g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:22:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNhBZfw2R26dOba1YT_C3g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:22:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNhBZfw2R26dOba1YT_C3g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:22:25 INFO - Downloaded 55631105 bytes. 16:22:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KNhBZfw2R26dOba1YT_C3g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:22:25 INFO - mkdir: /builds/slave/test/properties 16:22:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:22:25 INFO - Writing to file /builds/slave/test/properties/build_url 16:22:25 INFO - Contents: 16:22:25 INFO - build_url:https://queue.taskcluster.net/v1/task/KNhBZfw2R26dOba1YT_C3g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:22:25 INFO - Running post-action listener: _resource_record_post_action 16:22:25 INFO - Running post-action listener: set_extra_try_arguments 16:22:25 INFO - [mozharness: 2016-08-03 23:22:25.871787Z] Finished download-and-extract step (success) 16:22:25 INFO - [mozharness: 2016-08-03 23:22:25.872020Z] Running populate-webroot step. 16:22:25 INFO - Running pre-action listener: _resource_record_pre_action 16:22:25 INFO - Running main action method: populate_webroot 16:22:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:22:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:22:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:22:25 INFO - '--tppagecycles', 16:22:25 INFO - '7'], 16:22:25 INFO - 'tests': ['tsvgm']}}, 16:22:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:22:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:22:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:22:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:22:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:22:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:22:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:22:25 INFO - 'talos_options': ['--disable-e10s'], 16:22:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:22:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:22:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:22:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:22:25 INFO - 'talos_options': ['--disable-e10s'], 16:22:25 INFO - 'tests': ['damp', 'tps']}, 16:22:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:22:25 INFO - 'tests': ['damp', 'tps']}, 16:22:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:22:25 INFO - 'tests': ['dromaeo_dom']}, 16:22:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:22:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:22:25 INFO - 'tests': ['basic_compositor_video']}, 16:22:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:22:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:22:25 INFO - 'tests': ['a11yr', 16:22:25 INFO - 'ts_paint', 16:22:25 INFO - 'tpaint', 16:22:25 INFO - 'sessionrestore', 16:22:25 INFO - 'sessionrestore_no_auto_restore', 16:22:25 INFO - 'tabpaint']}, 16:22:25 INFO - 'other-e10s': {'tests': ['a11yr', 16:22:25 INFO - 'ts_paint', 16:22:25 INFO - 'tpaint', 16:22:25 INFO - 'sessionrestore', 16:22:25 INFO - 'sessionrestore_no_auto_restore', 16:22:25 INFO - 'tabpaint']}, 16:22:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:22:25 INFO - 'ts_paint', 16:22:25 INFO - 'tpaint', 16:22:25 INFO - 'sessionrestore', 16:22:25 INFO - 'sessionrestore_no_auto_restore', 16:22:25 INFO - 'tabpaint']}, 16:22:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:22:25 INFO - 'ts_paint', 16:22:25 INFO - 'tpaint', 16:22:25 INFO - 'sessionrestore', 16:22:25 INFO - 'sessionrestore_no_auto_restore', 16:22:25 INFO - 'tabpaint']}, 16:22:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:22:25 INFO - 'tests': ['a11yr', 16:22:25 INFO - 'ts_paint', 16:22:25 INFO - 'tpaint', 16:22:25 INFO - 'sessionrestore', 16:22:25 INFO - 'sessionrestore_no_auto_restore', 16:22:25 INFO - 'tabpaint']}, 16:22:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:22:25 INFO - 'tests': ['a11yr', 16:22:25 INFO - 'ts_paint', 16:22:25 INFO - 'tpaint', 16:22:25 INFO - 'sessionrestore', 16:22:25 INFO - 'sessionrestore_no_auto_restore', 16:22:25 INFO - 'tabpaint']}, 16:22:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:22:25 INFO - 'tests': ['tsvgx', 16:22:25 INFO - 'tsvgr_opacity', 16:22:25 INFO - 'tart', 16:22:25 INFO - 'tscrollx', 16:22:25 INFO - 'cart']}, 16:22:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:22:25 INFO - 'tsvgr_opacity', 16:22:25 INFO - 'tart', 16:22:25 INFO - 'tscrollx', 16:22:25 INFO - 'cart']}, 16:22:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:22:25 INFO - 'talos_options': ['--disable-e10s'], 16:22:25 INFO - 'tests': ['tp5o']}, 16:22:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:22:25 INFO - 'tests': ['tp5o']}, 16:22:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:22:25 INFO - 'talos_options': ['--disable-e10s', 16:22:25 INFO - '--xperf_path', 16:22:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:22:25 INFO - 'tests': ['tp5n']}, 16:22:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:22:25 INFO - 'talos_options': ['--xperf_path', 16:22:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:22:25 INFO - 'tests': ['tp5n']}}, 16:22:25 INFO - 'talos.zip': {'path': '', 16:22:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:22:25 INFO - Running post-action listener: _resource_record_post_action 16:22:25 INFO - [mozharness: 2016-08-03 23:22:25.893232Z] Finished populate-webroot step (success) 16:22:25 INFO - [mozharness: 2016-08-03 23:22:25.893321Z] Running create-virtualenv step. 16:22:25 INFO - Running pre-action listener: _resource_record_pre_action 16:22:25 INFO - Running main action method: create_virtualenv 16:22:25 INFO - Creating virtualenv /builds/slave/test/build/venv 16:22:25 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 16:22:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:22:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:22:25 INFO - Using real prefix '/usr' 16:22:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:22:26 INFO - Installing distribute.............................................................................................................................................................................................done. 16:22:28 INFO - Installing pip.................done. 16:22:28 INFO - Return code: 0 16:22:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:22:28 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')]} 16:22:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:28 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')]} 16:22:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:28 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 0x2326030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e53b0>, '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 0x25e62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e6740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1470266330.304297-1829036138', '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 16:22:28 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 16:22:28 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 16:22:28 INFO - Using env: {'DISPLAY': ':0', 16:22:28 INFO - 'HOME': '/home/cltbld', 16:22:28 INFO - 'LANG': 'en_US.UTF-8', 16:22:28 INFO - 'LANGUAGE': 'en_US:en', 16:22:28 INFO - 'LOGNAME': 'cltbld', 16:22:28 INFO - 'MAIL': '/var/mail/cltbld', 16:22:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:28 INFO - 'MOZ_NO_REMOTE': '1', 16:22:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:28 INFO - 'NO_EM_RESTART': '1', 16:22:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:28 INFO - 'PWD': '/builds/slave/test', 16:22:28 INFO - 'SHELL': '/bin/bash', 16:22:28 INFO - 'SHLVL': '1', 16:22:28 INFO - 'TERM': 'linux', 16:22:28 INFO - 'TMOUT': '86400', 16:22:28 INFO - 'USER': 'cltbld', 16:22:28 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470266330.304297-1829036138', 16:22:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:28 INFO - '_': '/tools/buildbot/bin/python'} 16:22:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:28 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 16:22:28 INFO - Cleaning up... 16:22:28 INFO - Return code: 0 16:22:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:22:28 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')]} 16:22:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:28 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')]} 16:22:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:28 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2326030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e53b0>, '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 0x25e62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e6740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1470266330.304297-1829036138', '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 16:22:28 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>=3.1.1'] in /builds/slave/test/build 16:22:28 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>=3.1.1 16:22:28 INFO - Using env: {'DISPLAY': ':0', 16:22:28 INFO - 'HOME': '/home/cltbld', 16:22:28 INFO - 'LANG': 'en_US.UTF-8', 16:22:28 INFO - 'LANGUAGE': 'en_US:en', 16:22:28 INFO - 'LOGNAME': 'cltbld', 16:22:28 INFO - 'MAIL': '/var/mail/cltbld', 16:22:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:28 INFO - 'MOZ_NO_REMOTE': '1', 16:22:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:28 INFO - 'NO_EM_RESTART': '1', 16:22:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:28 INFO - 'PWD': '/builds/slave/test', 16:22:28 INFO - 'SHELL': '/bin/bash', 16:22:28 INFO - 'SHLVL': '1', 16:22:28 INFO - 'TERM': 'linux', 16:22:28 INFO - 'TMOUT': '86400', 16:22:28 INFO - 'USER': 'cltbld', 16:22:28 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470266330.304297-1829036138', 16:22:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:28 INFO - '_': '/tools/buildbot/bin/python'} 16:22:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:28 INFO - Downloading/unpacking psutil>=3.1.1 16:22:28 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 16:22:28 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 16:22:28 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 16:22:28 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 16:22:28 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 16:22:28 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 16:22:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:22:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:22:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:22:30 INFO - Installing collected packages: psutil 16:22:30 INFO - Running setup.py install for psutil 16:22:30 INFO - building 'psutil._psutil_linux' extension 16:22:30 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 16:22:31 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 16:22:31 INFO - building 'psutil._psutil_posix' extension 16:22:31 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 16:22:31 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 16:22:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:22:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:22:31 INFO - Successfully installed psutil 16:22:31 INFO - Cleaning up... 16:22:31 INFO - Return code: 0 16:22:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:22:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:22:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:22:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:31 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2326030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e53b0>, '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 0x25e62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e6740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1470266330.304297-1829036138', '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 16:22:31 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.3'] in /builds/slave/test/build 16:22:31 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.3 16:22:31 INFO - Using env: {'DISPLAY': ':0', 16:22:31 INFO - 'HOME': '/home/cltbld', 16:22:31 INFO - 'LANG': 'en_US.UTF-8', 16:22:31 INFO - 'LANGUAGE': 'en_US:en', 16:22:31 INFO - 'LOGNAME': 'cltbld', 16:22:31 INFO - 'MAIL': '/var/mail/cltbld', 16:22:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:31 INFO - 'MOZ_NO_REMOTE': '1', 16:22:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:31 INFO - 'NO_EM_RESTART': '1', 16:22:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:31 INFO - 'PWD': '/builds/slave/test', 16:22:31 INFO - 'SHELL': '/bin/bash', 16:22:31 INFO - 'SHLVL': '1', 16:22:31 INFO - 'TERM': 'linux', 16:22:31 INFO - 'TMOUT': '86400', 16:22:31 INFO - 'USER': 'cltbld', 16:22:31 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470266330.304297-1829036138', 16:22:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:31 INFO - '_': '/tools/buildbot/bin/python'} 16:22:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:22:31 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 16:22:31 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 16:22:31 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 16:22:31 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 16:22:31 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 16:22:31 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 16:22:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:22:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:22:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:22:33 INFO - Installing collected packages: mozsystemmonitor 16:22:33 INFO - Running setup.py install for mozsystemmonitor 16:22:33 INFO - Successfully installed mozsystemmonitor 16:22:33 INFO - Cleaning up... 16:22:33 INFO - Return code: 0 16:22:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:22: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')]} 16:22:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22: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')]} 16:22:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2326030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e53b0>, '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 0x25e62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e6740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1470266330.304297-1829036138', '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 16:22: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==2.5.1'] in /builds/slave/test/build 16:22: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==2.5.1 16:22:33 INFO - Using env: {'DISPLAY': ':0', 16:22:33 INFO - 'HOME': '/home/cltbld', 16:22:33 INFO - 'LANG': 'en_US.UTF-8', 16:22:33 INFO - 'LANGUAGE': 'en_US:en', 16:22:33 INFO - 'LOGNAME': 'cltbld', 16:22:33 INFO - 'MAIL': '/var/mail/cltbld', 16:22:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:33 INFO - 'MOZ_NO_REMOTE': '1', 16:22:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:33 INFO - 'NO_EM_RESTART': '1', 16:22:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:33 INFO - 'PWD': '/builds/slave/test', 16:22:33 INFO - 'SHELL': '/bin/bash', 16:22:33 INFO - 'SHLVL': '1', 16:22:33 INFO - 'TERM': 'linux', 16:22:33 INFO - 'TMOUT': '86400', 16:22:33 INFO - 'USER': 'cltbld', 16:22:33 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470266330.304297-1829036138', 16:22:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:33 INFO - '_': '/tools/buildbot/bin/python'} 16:22:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:33 INFO - Downloading/unpacking jsonschema==2.5.1 16:22: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 16:22: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 16:22: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 16:22: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 16:22: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 16:22: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 16:22:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:22:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:22: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 16:22: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 16:22: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 16:22: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 16:22: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 16:22: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 16:22:36 INFO - Downloading functools32-3.2.3-2.tar.gz 16:22:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:22:36 INFO - warning: no files found matching '*.txt' 16:22:36 INFO - no previously-included directories found matching 'build' 16:22:36 INFO - no previously-included directories found matching 'dist' 16:22:36 INFO - no previously-included directories found matching '.git*' 16:22:36 INFO - Installing collected packages: jsonschema, functools32 16:22:36 INFO - Running setup.py install for functools32 16:22:36 INFO - warning: no files found matching '*.txt' 16:22:36 INFO - no previously-included directories found matching 'build' 16:22:36 INFO - no previously-included directories found matching 'dist' 16:22:36 INFO - no previously-included directories found matching '.git*' 16:22:36 INFO - Successfully installed jsonschema functools32 16:22:36 INFO - Cleaning up... 16:22:36 INFO - Return code: 0 16:22:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:22:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:22:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:22:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2326030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e53b0>, '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 0x25e62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e6740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1470266330.304297-1829036138', '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 16:22:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:22:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:22:36 INFO - Using env: {'DISPLAY': ':0', 16:22:36 INFO - 'HOME': '/home/cltbld', 16:22:36 INFO - 'LANG': 'en_US.UTF-8', 16:22:36 INFO - 'LANGUAGE': 'en_US:en', 16:22:36 INFO - 'LOGNAME': 'cltbld', 16:22:36 INFO - 'MAIL': '/var/mail/cltbld', 16:22:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:36 INFO - 'MOZ_NO_REMOTE': '1', 16:22:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:36 INFO - 'NO_EM_RESTART': '1', 16:22:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:36 INFO - 'PWD': '/builds/slave/test', 16:22:36 INFO - 'SHELL': '/bin/bash', 16:22:36 INFO - 'SHLVL': '1', 16:22:36 INFO - 'TERM': 'linux', 16:22:36 INFO - 'TMOUT': '86400', 16:22:36 INFO - 'USER': 'cltbld', 16:22:36 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470266330.304297-1829036138', 16:22:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:36 INFO - '_': '/tools/buildbot/bin/python'} 16:22:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:22:36 INFO - Cleaning up... 16:22:36 INFO - Return code: 0 16:22:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:22:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:22:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:22:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2326030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e53b0>, '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 0x25e62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e6740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1470266330.304297-1829036138', '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 16:22:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:22:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:22:36 INFO - Using env: {'DISPLAY': ':0', 16:22:36 INFO - 'HOME': '/home/cltbld', 16:22:36 INFO - 'LANG': 'en_US.UTF-8', 16:22:36 INFO - 'LANGUAGE': 'en_US:en', 16:22:36 INFO - 'LOGNAME': 'cltbld', 16:22:36 INFO - 'MAIL': '/var/mail/cltbld', 16:22:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:36 INFO - 'MOZ_NO_REMOTE': '1', 16:22:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:36 INFO - 'NO_EM_RESTART': '1', 16:22:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:36 INFO - 'PWD': '/builds/slave/test', 16:22:36 INFO - 'SHELL': '/bin/bash', 16:22:36 INFO - 'SHLVL': '1', 16:22:36 INFO - 'TERM': 'linux', 16:22:36 INFO - 'TMOUT': '86400', 16:22:36 INFO - 'USER': 'cltbld', 16:22:36 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470266330.304297-1829036138', 16:22:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:36 INFO - '_': '/tools/buildbot/bin/python'} 16:22:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:36 INFO - Downloading/unpacking blobuploader==1.2.4 16:22: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 16:22: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 16:22: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 16:22: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 16:22: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 16:22: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 16:22:38 INFO - Downloading blobuploader-1.2.4.tar.gz 16:22:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:22:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:22: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 16:22: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 16:22: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 16:22: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 16:22: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 16:22: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 16:22:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:22:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:22:39 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 16:22:39 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 16:22:39 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 16:22:39 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 16:22:39 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 16:22:39 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 16:22:39 INFO - Downloading docopt-0.6.1.tar.gz 16:22:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:22:39 INFO - Installing collected packages: blobuploader, requests, docopt 16:22:39 INFO - Running setup.py install for blobuploader 16:22:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:22:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:22:39 INFO - Running setup.py install for requests 16:22:39 INFO - Running setup.py install for docopt 16:22:39 INFO - Successfully installed blobuploader requests docopt 16:22:39 INFO - Cleaning up... 16:22:39 INFO - Return code: 0 16:22:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:22:39 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')]} 16:22:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:39 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')]} 16:22:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:39 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 0x2326030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e53b0>, '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 0x25e62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e6740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1470266330.304297-1829036138', '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 16:22:39 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 16:22:39 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 16:22:39 INFO - Using env: {'DISPLAY': ':0', 16:22:39 INFO - 'HOME': '/home/cltbld', 16:22:39 INFO - 'LANG': 'en_US.UTF-8', 16:22:39 INFO - 'LANGUAGE': 'en_US:en', 16:22:39 INFO - 'LOGNAME': 'cltbld', 16:22:39 INFO - 'MAIL': '/var/mail/cltbld', 16:22:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:39 INFO - 'MOZ_NO_REMOTE': '1', 16:22:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:39 INFO - 'NO_EM_RESTART': '1', 16:22:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:39 INFO - 'PWD': '/builds/slave/test', 16:22:39 INFO - 'SHELL': '/bin/bash', 16:22:39 INFO - 'SHLVL': '1', 16:22:39 INFO - 'TERM': 'linux', 16:22:39 INFO - 'TMOUT': '86400', 16:22:39 INFO - 'USER': 'cltbld', 16:22:39 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470266330.304297-1829036138', 16:22:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:39 INFO - '_': '/tools/buildbot/bin/python'} 16:22:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:22:40 INFO - Running setup.py (path:/tmp/pip-F1XSSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:22:40 INFO - Running setup.py (path:/tmp/pip-rgHePx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:22:40 INFO - Running setup.py (path:/tmp/pip-y9653p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:22:40 INFO - Running setup.py (path:/tmp/pip-tAJJF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:22:40 INFO - Running setup.py (path:/tmp/pip-1nbuos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:22:40 INFO - Running setup.py (path:/tmp/pip-6YoUD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:22:40 INFO - Running setup.py (path:/tmp/pip-0WdyCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:22:40 INFO - Running setup.py (path:/tmp/pip-_efnq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:22:40 INFO - Running setup.py (path:/tmp/pip-hWM95q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:22:40 INFO - Running setup.py (path:/tmp/pip-cc3EFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:22:40 INFO - Running setup.py (path:/tmp/pip-QDKa_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:22:41 INFO - Running setup.py (path:/tmp/pip-iTr1Gi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:22:41 INFO - Running setup.py (path:/tmp/pip-xD1BNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:22:41 INFO - Running setup.py (path:/tmp/pip-mDYqhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:22:41 INFO - Running setup.py (path:/tmp/pip-Am1gjw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:22:41 INFO - Running setup.py (path:/tmp/pip-5JWjiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:22:41 INFO - Running setup.py (path:/tmp/pip-3hFA0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:22:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:22:41 INFO - Running setup.py install for manifestparser 16:22:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:22:41 INFO - Running setup.py install for mozcrash 16:22:41 INFO - Running setup.py install for mozdebug 16:22:41 INFO - Running setup.py install for mozdevice 16:22:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:22:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:22:41 INFO - Running setup.py install for mozfile 16:22:41 INFO - Running setup.py install for mozhttpd 16:22:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:22:42 INFO - Running setup.py install for mozinfo 16:22:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:22:42 INFO - Running setup.py install for mozInstall 16:22:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:22:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:22:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:22:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:22:42 INFO - Running setup.py install for mozleak 16:22:42 INFO - Running setup.py install for mozlog 16:22:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:22:42 INFO - Running setup.py install for moznetwork 16:22:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:22:42 INFO - Running setup.py install for mozprocess 16:22:42 INFO - Running setup.py install for mozprofile 16:22:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:22:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:22:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:22:42 INFO - Running setup.py install for mozrunner 16:22:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:22:42 INFO - Running setup.py install for mozscreenshot 16:22:43 INFO - Running setup.py install for moztest 16:22:43 INFO - Running setup.py install for mozversion 16:22:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:22:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:22:43 INFO - Cleaning up... 16:22:43 INFO - Return code: 0 16:22:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:22:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:22:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:22:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:43 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 0x2326030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e53b0>, '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 0x25e62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e6740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1470266330.304297-1829036138', '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 16:22:43 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 16:22:43 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 16:22:43 INFO - Using env: {'DISPLAY': ':0', 16:22:43 INFO - 'HOME': '/home/cltbld', 16:22:43 INFO - 'LANG': 'en_US.UTF-8', 16:22:43 INFO - 'LANGUAGE': 'en_US:en', 16:22:43 INFO - 'LOGNAME': 'cltbld', 16:22:43 INFO - 'MAIL': '/var/mail/cltbld', 16:22:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:43 INFO - 'MOZ_NO_REMOTE': '1', 16:22:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:43 INFO - 'NO_EM_RESTART': '1', 16:22:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:43 INFO - 'PWD': '/builds/slave/test', 16:22:43 INFO - 'SHELL': '/bin/bash', 16:22:43 INFO - 'SHLVL': '1', 16:22:43 INFO - 'TERM': 'linux', 16:22:43 INFO - 'TMOUT': '86400', 16:22:43 INFO - 'USER': 'cltbld', 16:22:43 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470266330.304297-1829036138', 16:22:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:43 INFO - '_': '/tools/buildbot/bin/python'} 16:22:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:22:43 INFO - Running setup.py (path:/tmp/pip-iiAdOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:22:43 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)) 16:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:22:43 INFO - Running setup.py (path:/tmp/pip-m6UAZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:22:43 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)) 16:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:22:43 INFO - Running setup.py (path:/tmp/pip-0nAnAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:22:43 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)) 16:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:22:43 INFO - Running setup.py (path:/tmp/pip-ZB9CBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:22:43 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)) 16:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:22:43 INFO - Running setup.py (path:/tmp/pip-CoD_C7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:22:43 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)) 16:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:22:43 INFO - Running setup.py (path:/tmp/pip-wCIgV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:22:43 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)) 16:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:22:43 INFO - Running setup.py (path:/tmp/pip-a8OyXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:22:43 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)) 16:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:22:43 INFO - Running setup.py (path:/tmp/pip-f4TH97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:22:44 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)) 16:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:22:44 INFO - Running setup.py (path:/tmp/pip-LsahFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:22:44 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)) 16:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:22:44 INFO - Running setup.py (path:/tmp/pip-6g6KyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:22:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 16:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:22:44 INFO - Running setup.py (path:/tmp/pip-83vdgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:22:44 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)) 16:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:22:44 INFO - Running setup.py (path:/tmp/pip-KtQy3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:22:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 16:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:22:44 INFO - Running setup.py (path:/tmp/pip-RdrXA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:22:44 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)) 16:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:22:44 INFO - Running setup.py (path:/tmp/pip-nE1Hyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:22:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 16:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:22:44 INFO - Running setup.py (path:/tmp/pip-XOPGpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:22:44 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)) 16:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:22:44 INFO - Running setup.py (path:/tmp/pip-NhzfnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:22:44 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)) 16:22:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:22:44 INFO - Running setup.py (path:/tmp/pip-01CZnp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:22:44 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)) 16:22:44 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)) 16:22:44 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)) 16:22:44 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)) 16:22:44 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)) 16:22:44 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)) 16:22:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:22:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:46 INFO - Downloading blessings-1.6.tar.gz 16:22:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:22:46 INFO - Installing collected packages: blessings 16:22:46 INFO - Running setup.py install for blessings 16:22:46 INFO - Successfully installed blessings 16:22:46 INFO - Cleaning up... 16:22:46 INFO - Return code: 0 16:22:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:22:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:22:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:22:47 INFO - Reading from file tmpfile_stdout 16:22:47 INFO - Current package versions: 16:22:47 INFO - argparse == 1.2.1 16:22:47 INFO - blessings == 1.6 16:22:47 INFO - blobuploader == 1.2.4 16:22:47 INFO - docopt == 0.6.1 16:22:47 INFO - functools32 == 3.2.3-2 16:22:47 INFO - jsonschema == 2.5.1 16:22:47 INFO - manifestparser == 1.1 16:22:47 INFO - mozInstall == 1.12 16:22:47 INFO - mozcrash == 0.17 16:22:47 INFO - mozdebug == 0.1 16:22:47 INFO - mozdevice == 0.48 16:22:47 INFO - mozfile == 1.2 16:22:47 INFO - mozhttpd == 0.7 16:22:47 INFO - mozinfo == 0.9 16:22:47 INFO - mozleak == 0.1 16:22:47 INFO - mozlog == 3.3 16:22:47 INFO - moznetwork == 0.27 16:22:47 INFO - mozprocess == 0.23 16:22:47 INFO - mozprofile == 0.28 16:22:47 INFO - mozrunner == 6.12 16:22:47 INFO - mozscreenshot == 0.1 16:22:47 INFO - mozsystemmonitor == 0.3 16:22:47 INFO - moztest == 0.7 16:22:47 INFO - mozversion == 1.4 16:22:47 INFO - psutil == 3.1.1 16:22:47 INFO - requests == 1.2.3 16:22:47 INFO - wsgiref == 0.1.2 16:22:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:22:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:22:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:22:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:47 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 0x2326030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e53b0>, '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 0x25e62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e6740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1470266330.304297-1829036138', '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 16:22:47 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 16:22:47 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 16:22:47 INFO - Using env: {'DISPLAY': ':0', 16:22:47 INFO - 'HOME': '/home/cltbld', 16:22:47 INFO - 'LANG': 'en_US.UTF-8', 16:22:47 INFO - 'LANGUAGE': 'en_US:en', 16:22:47 INFO - 'LOGNAME': 'cltbld', 16:22:47 INFO - 'MAIL': '/var/mail/cltbld', 16:22:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:47 INFO - 'MOZ_NO_REMOTE': '1', 16:22:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:47 INFO - 'NO_EM_RESTART': '1', 16:22:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:47 INFO - 'PWD': '/builds/slave/test', 16:22:47 INFO - 'SHELL': '/bin/bash', 16:22:47 INFO - 'SHLVL': '1', 16:22:47 INFO - 'TERM': 'linux', 16:22:47 INFO - 'TMOUT': '86400', 16:22:47 INFO - 'USER': 'cltbld', 16:22:47 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470266330.304297-1829036138', 16:22:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:47 INFO - '_': '/tools/buildbot/bin/python'} 16:22:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:47 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)) 16:22:47 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)) 16:22:47 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)) 16:22:47 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)) 16:22:47 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)) 16:22:47 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)) 16:22:47 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)) 16:22:47 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)) 16:22:47 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)) 16:22:47 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)) 16:22:47 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)) 16:22:47 INFO - Cleaning up... 16:22:47 INFO - Return code: 0 16:22:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:22:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:22:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:22:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2326030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e53b0>, '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 0x25e62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e6740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1470266330.304297-1829036138', '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 16:22:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:22:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:22:47 INFO - Using env: {'DISPLAY': ':0', 16:22:47 INFO - 'HOME': '/home/cltbld', 16:22:47 INFO - 'LANG': 'en_US.UTF-8', 16:22:47 INFO - 'LANGUAGE': 'en_US:en', 16:22:47 INFO - 'LOGNAME': 'cltbld', 16:22:47 INFO - 'MAIL': '/var/mail/cltbld', 16:22:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:47 INFO - 'MOZ_NO_REMOTE': '1', 16:22:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:47 INFO - 'NO_EM_RESTART': '1', 16:22:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:47 INFO - 'PWD': '/builds/slave/test', 16:22:47 INFO - 'SHELL': '/bin/bash', 16:22:47 INFO - 'SHLVL': '1', 16:22:47 INFO - 'TERM': 'linux', 16:22:47 INFO - 'TMOUT': '86400', 16:22:47 INFO - 'USER': 'cltbld', 16:22:47 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470266330.304297-1829036138', 16:22:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:47 INFO - '_': '/tools/buildbot/bin/python'} 16:22:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:22:47 INFO - Cleaning up... 16:22:47 INFO - Return code: 0 16:22:47 INFO - Running post-action listener: _resource_record_post_action 16:22:47 INFO - Running post-action listener: _start_resource_monitoring 16:22:47 INFO - Starting resource monitoring. 16:22:47 INFO - [mozharness: 2016-08-03 23:22:47.503297Z] Finished create-virtualenv step (success) 16:22:47 INFO - [mozharness: 2016-08-03 23:22:47.503777Z] Running install step. 16:22:47 INFO - Running pre-action listener: _resource_record_pre_action 16:22:47 INFO - Running main action method: install 16:22:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:22:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:22:47 INFO - Reading from file tmpfile_stdout 16:22:47 INFO - Detecting whether we're running mozinstall >=1.0... 16:22:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:22:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:22:47 INFO - Reading from file tmpfile_stdout 16:22:47 INFO - Output received: 16:22:47 INFO - Usage: mozinstall [options] installer 16:22:47 INFO - Options: 16:22:47 INFO - -h, --help show this help message and exit 16:22:47 INFO - -d DEST, --destination=DEST 16:22:47 INFO - Directory to install application into. [default: 16:22:47 INFO - "/builds/slave/test"] 16:22:47 INFO - --app=APP Application being installed. [default: firefox] 16:22:47 INFO - mkdir: /builds/slave/test/build/application 16:22:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:22:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:23:03 INFO - Reading from file tmpfile_stdout 16:23:03 INFO - Output received: 16:23:03 INFO - /builds/slave/test/build/application/firefox/firefox 16:23:03 INFO - Running post-action listener: _resource_record_post_action 16:23:03 INFO - [mozharness: 2016-08-03 23:23:03.827600Z] Finished install step (success) 16:23:03 INFO - [mozharness: 2016-08-03 23:23:03.827889Z] Running run-tests step. 16:23:03 INFO - Running pre-action listener: _resource_record_pre_action 16:23:03 INFO - Running main action method: run_tests 16:23:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:23:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:23:03 INFO - Python 2.7.3 16:23:03 INFO - Return code: 0 16:23:03 INFO - grabbing minidump binary from tooltool 16:23:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:23:03 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e53b0>, '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 0x25e62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e6740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:23:03 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 16:23:03 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 16:23:03 INFO - Calling ['/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'] with output_timeout 600 16:23:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:23:03 INFO - Return code: 0 16:23:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:23:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:23:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:23:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:23:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:23:03 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/KNhBZfw2R26dOba1YT_C3g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 16:23:03 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/KNhBZfw2R26dOba1YT_C3g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 16:23:03 INFO - Using env: {'DISPLAY': ':0', 16:23:03 INFO - 'HOME': '/home/cltbld', 16:23:03 INFO - 'LANG': 'en_US.UTF-8', 16:23:03 INFO - 'LANGUAGE': 'en_US:en', 16:23:03 INFO - 'LOGNAME': 'cltbld', 16:23:03 INFO - 'MAIL': '/var/mail/cltbld', 16:23:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:23:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:23:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:03 INFO - 'MOZ_NO_REMOTE': '1', 16:23:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:23:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:03 INFO - 'NO_EM_RESTART': '1', 16:23:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:03 INFO - 'PWD': '/builds/slave/test', 16:23:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:23:03 INFO - 'SHELL': '/bin/bash', 16:23:03 INFO - 'SHLVL': '1', 16:23:03 INFO - 'TERM': 'linux', 16:23:03 INFO - 'TMOUT': '86400', 16:23:03 INFO - 'USER': 'cltbld', 16:23:03 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470266330.304297-1829036138', 16:23:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:03 INFO - '_': '/tools/buildbot/bin/python'} 16:23:03 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/KNhBZfw2R26dOba1YT_C3g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 16:23:04 INFO - mozversion application_buildid: 20160803154221 16:23:04 INFO - mozversion application_changeset: 69b0f784a9a21369d3aba9c467c953dce81b1e59 16:23:04 INFO - mozversion application_display_name: Nightly 16:23:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:23:04 INFO - mozversion application_name: Firefox 16:23:04 INFO - mozversion application_remotingname: firefox 16:23:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:23:04 INFO - mozversion application_vendor: Mozilla 16:23:04 INFO - mozversion application_version: 51.0a1 16:23:04 INFO - mozversion platform_buildid: 20160803154221 16:23:04 INFO - mozversion platform_changeset: 69b0f784a9a21369d3aba9c467c953dce81b1e59 16:23:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:23:04 INFO - mozversion platform_version: 51.0a1 16:23:04 INFO - using testdate: 1470266584 16:23:04 INFO - actual date: 1470266584 16:23:04 INFO - starting webserver on 'localhost:59701' 16:23:04 INFO - SUITE-START | Running 2 tests 16:23:04 INFO - TEST-START | dromaeo_css 16:23:04 INFO - operating with platform_type : linux_ 16:23:04 INFO - Initialising browser for dromaeo_css test... 16:23:04 INFO - TEST-INFO | started process 9463 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJIgu8z/profile http://localhost:59701/getInfo.html) 16:23:08 INFO - PROCESS | 9463 | __metrics Screen width/height:1600/1200 16:23:08 INFO - PROCESS | 9463 | colorDepth:24 16:23:08 INFO - PROCESS | 9463 | Browser inner width/height: 1024/697 16:23:08 INFO - PROCESS | 9463 | __metrics 16:23:09 INFO - PROCESS | 9463 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:23:09 INFO - PROCESS | 9463 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:23:10 INFO - PROCESS | 9463 | console.error: PushService: 16:23:10 INFO - PROCESS | 9463 | stateChangeProcessEnqueue: Error transitioning state 16:23:10 INFO - PROCESS | 9463 | UnknownError 16:23:10 INFO - TEST-INFO | 9463: exit 0 16:23:10 INFO - Browser initialized. 16:23:10 INFO - Running cycle 1/1 for dromaeo_css test... 16:23:10 INFO - TEST-INFO | started process 9544 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJIgu8z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:23:22 INFO - PROCESS | 9544 | RSS: Main: 157782016 16:23:22 INFO - PROCESS | 9544 | 16:24:14 INFO - PROCESS | 9544 | 1470266654150 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] 16:26:27 INFO - PROCESS | 9544 | Cycle 1(1): loaded http://localhost:59701/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59701/tests/dromaeo/cssquery-ext.html) 16:26:28 INFO - PROCESS | 9544 | RSS: Main: 249921536 16:26:28 INFO - PROCESS | 9544 | 16:29:31 INFO - PROCESS | 9544 | Cycle 1(1): loaded http://localhost:59701/tests/dromaeo/cssquery-ext.html (next: http://localhost:59701/tests/dromaeo/cssquery-jquery.html) 16:29:31 INFO - PROCESS | 9544 | RSS: Main: 244928512 16:29:31 INFO - PROCESS | 9544 | 16:32:33 INFO - PROCESS | 9544 | Cycle 1(1): loaded http://localhost:59701/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59701/tests/dromaeo/cssquery-mootools.html) 16:32:34 INFO - PROCESS | 9544 | RSS: Main: 219328512 16:32:34 INFO - PROCESS | 9544 | 16:35:36 INFO - PROCESS | 9544 | Cycle 1(1): loaded http://localhost:59701/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59701/tests/dromaeo/cssquery-prototype.html) 16:35:37 INFO - PROCESS | 9544 | RSS: Main: 189210624 16:35:37 INFO - PROCESS | 9544 | 16:38:40 INFO - PROCESS | 9544 | Cycle 1(1): loaded http://localhost:59701/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59701/tests/dromaeo/cssquery-yui.html) 16:38:40 INFO - PROCESS | 9544 | RSS: Main: 189263872 16:38:40 INFO - PROCESS | 9544 | 16:41:44 INFO - PROCESS | 9544 | Cycle 1(1): loaded http://localhost:59701/tests/dromaeo/cssquery-yui.html (next: http://localhost:59701/tests/dromaeo/cssquery-dojo.html) 16:41:44 INFO - PROCESS | 9544 | RSS: Main: 282423296 16:41:44 INFO - PROCESS | 9544 | 16:41:44 INFO - PROCESS | 9544 | __start_tp_report 16:41:44 INFO - PROCESS | 9544 | _x_x_mozilla_page_load 16:41:44 INFO - PROCESS | 9544 | _x_x_mozilla_page_load_details 16:41:44 INFO - PROCESS | 9544 | |i|pagename|runs| 16:41:44 INFO - PROCESS | 9544 | |0;dojo.html;2639.934001649959;2674.8498145797307;2683.490136873995;2725.5639097744365;2729.7816174706027;4711.081339138861;4798;4811.566958973692;4923.679960802549;4947.901041979158;4857.465678775341;4882.804687812492;4900.6569540132205;4907.092187945233;4937.604991600672;4424.115176964604;4472.485664148632;4518.593326600605;4526.937064048798;4674.368960190365;4573.451185857702;4592.609628181609;4615.769211539427;4623.8844028899375;4639.605633521155;4334.544872788343;4373.300271956472;4424.225760491901;4456.2201614717615;4518.186726389248;4452.866414007585;4453.554644535553;4459.843905463294;4531.977340113312;4543.182227199103;4466.798994045275;4506.932396014063;4518.615917647004;4538.092381523708;4559.931601025987;4752.809887604491;4780.378550788375;4928.236123400879;4963.230699241623;4978.303037574742;5234.371875374942;5266.631335806495;5316.12283973144;5318.73406329682;5326.786928522854;5257.842264732064;5301.098813201726;5320.095583750733;5347.1177255752755;5349.893002139975;4683.063387322481;4841.394825646794;4892.437369702458;4930.654854160246;4956.10790057793;5383.919241211385;5409.134538473904;5436.891262174734;5458.372287186945;5460.781568737206;5189.7405129743365;5190.844274671766;5225.555827754683;5236.450172731885;5239.790408383698;5112.897742045138;5208.088584497697;5263.473652634782;5311.044012077863;5333.919991200135;5237.031149237403;5239.292695486137;5245.790168393221;5259.289995850588;5273.709945952933;5222.529972302511;5226.97386513065;5233.895322093536;5243.370795504564;5291.1798671206025;4212;4247.766372849461;4251.553586873334;4415.139047885696;4420.071784925201;3825.2540754552597;3867.0525721197923;3907.941380879289;3968.1666849961252;3970.722049456568;4538.818447262139;4544.2501987171745;4550.658700597469;4593.47175074864;4600.585947264695;5278.683279003195;5291.391489978701;5318.44156363584;5339.519443250126;5340.759665815048;4281.464816897887;4396.49440314368;4463.04044630406;4495.011097558532;4562.908741825145;4681.602063824613;4690.882727931829;4692.929606055912;4696.624270058387;4735.763211839394;4950.950490495049;4954.900901981868;4962.33008543842;4969.527894849984;5009.073321435546;5059.06407314648;5089.567386772166;5108.3103780989095;5119.641625086358;5240.659357141773;4834.105690447279;4835.975820121018;4849.2968519565175;4858.076965376567;4888.071266459361;5061.342025536656;5119.590432765295;5123.052235336475;5127.051495473349;5170.146925757208;4999.875003124951;5055.898882022412;5151.407588127264;5215.426303106579;5230.5815534757885;5110.9488905110475;5126.051680439131;5134.15286477727;5142.357205349332;5143.099957507496;5147.047796157723;5148.613853961043;5151.0470562945975;5156.61325400589;5187.559057480156;4854.587360074292;4977.900441991067;5002.324686167466;5006.274090256965;5079.619028572798;5128.974355128201;5136.409312928911;5138.12651849179;5140.56305214061;5145.948540514547;4984.8753781155765;5018.42288136869;5026.949730502648;5030.170021946338;5060.974695126501 16:41:44 INFO - PROCESS | 9544 | |1;ext.html;566.3741565570045;583.5885700581088;583.7519054401879;589.613802959062;590.937951515091;29822.552661710066;40663.79668101659;41828;41851.79074104633;44620.3306950396;41631.79184104083;41829;41976.79011604938;41978;42153.36769948453;7371.594562299071;7651.617419129049;7778.961105194495;7791.454598178129;7793.883091753628;9377.953110234439;9596.904030959706;9614.903850961471;9814.50927453628;9825.361351512129;9883.703488895344;10009.249306302056;10009.849852252222;10039.498025098752;10042.648507302245;9784.706458806248;9823.263255255884;9852.901470985342;9854.556544955494;9859.260555458333;9668.854967175497;9725.270604704676;9727.367721098106;9730.659426920094;9737.707868763948;38582.61417385846;38796.61203387958;38917.61082389196;38978;38987.80506097451;3065.249013991564;3149.4488464518618;3239.5140728890856;3329.96670033299;3369.4608862581867;29097;29165.56251656227;29417.852910735524;30374.54438183429;30903.227419314473;3483.442649176145;3555.1112221944513;3565.1364887067843;3586.4620306954166;3633.615417507779;243764;244937;244940;245580;245602.99999999822;54847.451525485034;55059.17411238835;55575.16637250444;55604;55623.72188139033;58655.70672146612;58748;58832.41167588355;58859.70570147122;58861.705691472125;12801;13417.932910335387;13439.395227214798;13872.167669939836;13874.791878121836;9507.954125046239;9747.805043899225;9965.900340996643;10294.897051029544;10483.895161048444;18658.253669853326;18689.719654205197;18709.719354209697;18722.344717934808;18736;6711.832204194934;6763.797086087426;6803.795886123424;6818.795436136924;6853.246142924274;794.8767940969159;860.7030574451804;885.8494056010494;894.7763059235191;946.9431834089977;28660.283492912426;29304.853475732485;29408.11775646734;29423;29824.552631710543;913.4382354851851;955.617752898846;984.9362688296623;1003.6136087606324;1031.6183012285503;15127.924360378347;15372.538823835079;15594.844051559567;15624.76562851558;15882;385557;389682;389931;390649;391509;49903.25145122826;50554.74722626364;50569.494305056476;50577.49422505801;50601.49398506041;1107.3189988157226;1134.6539305511733;1181.5628217559558;1192.9222605677332;1210.6549633354452;27956.720432795413;30041.849790750908;30301.242468938453;30863.2284192897;30917;48839.75580122077;50030.249546256106;50271;55060.72469637626;55086.72456637691;345935;349146;349220;349603;350669;25258.49483010293;25721.614175787752;25792.26012228254;26261.4747705041;40309.1938161241;42553.361699573914;42802.143957121305;42973.355399668406;43056.78471607622;43276.78361608172;36270;36449.635503644626;36620.81689591535;37220;37985.810070950574;36224.09439764027;36858;37026.074348140435;37058.8147059263;37467.43798843074;35885.820570896976;36180.45729314115;36651.633483664824;36698.082547936516;37338.43992340171;31036;33409.83295083509;33451.16372090717;33490.33019339551;33512;24744;25683;25899.870500647376;26007.60988585135;26378.07676731305 16:41:44 INFO - PROCESS | 9544 | |2;jquery.html;346.70356844897594;366.15783697495755;374.47012477344555;377.0987340256786;390.88078136168474;12462.750744985095;16075.196240187974;16108.275127619256;16461.999999999985;17426.82573174268;15681.529554113395;15922.920385398056;16574.585635359123;16700.164991750393;16707.83292167078;4888.511148885119;5086.872828179288;5104.5405913467785;5134.897302053957;5258.368995720519;3457.896263112111;3626.0572251214744;5157.7936882524655;5194.194899790519;5204.9219261711105;3635.745497815154;3877.3408520551575;5689.829305120832;5755.25181726375;5769.134629805541;5709.571782116358;5751.424857514278;5756.6546007239285;5772.163036359704;5777.393373695785;5065.898682026339;5172.379314482248;5187.403448603383;5193.766280517386;5197.610179236534;11563.074954003743;11730.941345293219;11927.224730392496;11951.820722689079;12037.699057523632;1879.586490971984;1956.7358406615067;1985.5830275642134;1999.8900060496667;2403.291029146406;8718.86921696175;8815.206631403205;8949.328800340001;8960.327975401871;8977.32670049749;1595.9521214363588;1630.5678995066316;1670.2066518403783;1746.074580472339;1765.2674140231788;63972;67061;67126;67237.64668236588;67686.66156669185;8699.782505437415;8861.33539984491;9350.345475816763;10079.949600251952;10203.234757393226;13892.652683682989;13981.370838312301;13995.650108747159;14009.509667161601;14009.929950350182;6781.084553585203;6958.06066181059;6978.511504194657;7092.574445533284;7100.68046937889;6206.534509911775;6330.905036424458;6338.271098823602;6460.192475940507;6487.643179625166;4343.739375637472;4363.083752412029;4400.163968845909;4413.911721765547;4464.888377790581;1761.9207135678926;1866.9533261668566;1878.342580096955;1914.473519782071;1929.1126082002436;816.4937738602105;899.2266650680409;905.6241659711146;936.9038225276443;957.5403806172936;15535.766963495556;16591;16794.91602542004;17193.226304816315;17631.823681763017;829.4069740135832;863.6415887406781;880.1682410122373;905.4160066756905;905.7735566108473;9435;9700.6119755209;9786.461744604116;9866.642905937144;9894.455804930654;368205;373406;377442;384466;385913;72204.68034932761;73785;73887.63056184685;74179;76749.61625191839;886.3573908915985;904.5793705926776;920.5719340506696;921.6083164655129;923.6443969071955;14815.629609259855;15185.6203594911;15555.14446705442;15843.841561584697;15859.682806344039;32556;35072.47391289184;36298.818505908355;36695;36739.26521469502;53135.73432132815;53347.733261333444;53601.46398536121;54236.45763542314;54877;7471.327580517779;7723.575203363869;7772.222777722182;7884.487508311941;7909.327707144727;9428.764280893032;11919.76160476803;11948.103892208293;12405.565805196775;12598.496060157491;9947.900520994697;9963.153131983572;10253.641122560675;10285.74285642835;10393.272470926962;10248.692539223835;10527.94736026315;10589.629362972259;10644.733881653021;10696.732581685521;10008.741040433322;10030.749231268985;10136.341137826017;10148.340357876714;10463.843042354218;7760.223977602194;7824.608769561385;7856.135825059353;7858.214178582325;8201.671933122609;7884.6057697113765;9306.208972237435;9600.66397676078;9847;10573.2598718089 16:41:44 INFO - PROCESS | 9544 | |3;mootools.html;1284.8843604075632;1338.551585218952;1406.303879579608;1448.6885319656271;1699.9745003824944;6620.569662971903;7334.339909408159;7558.055243094614;7569.091708994922;7769.7669069928;7547.0943486781525;7603.657835397406;7611.9619401903055;7614.809629759259;7619.961900190491;2141.8072373486343;2160.643493823517;2171.89140542973;2175.8041776240134;2176.107795803721;2051.9281825136122;2089.8432617553667;2177.716896803421;2201.7357917049976;2212.258893270748;2134.231676596424;2138.347803919804;2144.2066435418915;2155.1271734947372;2190.4414374334524;2138.828893688501;2139.743230812305;2144.613969485492;2144.9034793434334;2144.9892750536146;2079.334612923865;2137.7969092936146;2140.903659335318;2141.068635143702;2141.486043349585;7528.8117797054965;7679.884801727979;7682.7311044113185;7684.116326622398;7687.077550693896;4220.261454245495;4270.103278311558;4387.758673272969;4395.780210989437;4399.64802815774;2780.374415756459;2852.2441552988475;2860.599516067752;2865.770738340928;2866.656001279839;908.3505293715026;957.2389949989774;975.3757595139117;975.7121649113528;986.7483791633159;9956.15372693322;10078.949605251926;10099.04059114383;10110.635064266377;10127.088562029452;3700.16746232101;3892.785896775648;3993.201359728066;4008.719389642697;4024.7383920045104;8014.15851335613;8016.438849280495;8022.318102961197;8031.879521807177;8034.718784842619;4257.63810076147;4257.957420425818;4262.552431994658;4263.211305908417;4265.168292182994;3485.5120283160377;3819.52255968004;3907.882763517099;3932.075962148893;3981.462502562117;3382.3573521030926;3417.572803399575;3491.0574144980715;3499.0377646147003;3538.469229615578;1045.4668119259081;1066.461436974323;1073.940933248679;1082.4966390628238;1086.4187659602233;797.3501596199079;816.5549775372436;822.1942496353607;825.1830687619214;840.5083026429485;4919.532644398776;4951.405831300267;5039.44566097729;5125.282460455539;5138.177891537411;384.6653411531985;396.85316432920007;398.4362127589486;398.7846562856025;400.159664704119;3393.5079413484905;3394.8132852692843;3432.7940323580665;3462.342154990544;3520.823958802101;9127.634894604142;9630.374025688448;9636.42181469114;9641.132298093205;9661.565229564545;9583.616655333848;9592.184664303473;9600.951995239979;9602.519874006271;9613.951930240304;7073.08049953513;7082.327178917994;7138.535995160401;7153.463490238253;7178.102737157856;4901.828436004866;4959.13215187348;4966.404031516241;4980.477049909852;5101.56636685871;8744.387892847439;8824.249938755278;8850.911490885266;8869.822603548022;8869.955650221707;8756.781080472785;9022;9082;9104.362694611315;9115.817683646157;5655.773769049192;6137.631742095488;6199.132121503083;6240.28236752761;6249.875002500015;7221.133463984355;7418.851622967619;7492.138404083382;7493.812654683677;7495;6559.442447392025;6636.203655561363;6682.966585167043;6798.082258895183;6871.862562748617;6470.838229044311;6607.2071351438135;6661.267260601427;6717.261101278953;6781.660916954232;6016.42843929826;6106.6946652668075;6112.663803490851;6114.0828875669;6115.471132216946;4503.166914120898;4562.5665561771575;4605.907881842278;4658.93011604833;4660.953390466052;4469.195544801967;4472.821087156477;4605.539446055368;4641.303804429228;4647.395838540968 16:41:44 INFO - PROCESS | 9544 | |4;prototype.html;285.3252058880747;289.62782824071076;294.5831648217772;297.0879400241259;297.55812618261865;4807.951920480794;4825.396825396825;4825.951740482594;4829.879253018672;4839.249916262985;4750.121227572901;4756.9286460703115;4763.9523604763945;4769.737664428455;4783.306420569024;3529.92940141197;3638.909027274326;3704.5554533456025;3759.586445490994;3782.6595606395417;3742.9625703742886;3752.0994961209385;3758.267137908109;3760.9623903760885;3769.6607305342513;3707.499487569184;3713.777173369593;3713.925721485582;3717.8884633460902;3720.869769558066;3549.5917969433585;3586.7130629549574;3713;3720.6093360197196;3748.906277343061;3281.0812972367776;3283.819389933553;3285.4250506161566;3288.2108294009504;3292.8682852685865;4659;4662.906741865144;4692.319613656035;4692.554207350297;4694.788734506956;4122.299209134454;4227.408162857202;4244.787760611988;4251.406641948409;4258.510271318776;4948.158813001798;4971.304017437562;4986.152354099811;4989.401271847365;5008.098542262392;3574.946375804365;3578.3380074686006;3592.191756854713;3593.3711600470074;3596.496490491307;5100.38795344561;5236.266922630834;5237;5248.81629142982;5259.815906443295;3623.8912832615065;3656.689181419556;3657.195417008254;3661.9816900915325;3677.5219221501034;3699.7965111918566;3701.1857391373856;3708.6291370863237;3713.145976425383;3717.7397582168987;4208.305629571148;4209;4215.325547912319;4219.493660760729;4226.408302837605;4859.829905953346;4934.580560652313;4980.477049909708;5005.774740136702;5018.799248030111;1268.9048321375933;1282.3524120319366;1286.601153642374;1287.3498883063992;1294.3140135728079;802.4783890471241;824.9298809601252;835.7283882738013;839.7732612194795;843.6709683223547;4364.781760911942;4455.1535208310315;4475.239209334421;4483.3723278741;4485.125400546927;5157.742112894341;5168.9741551292;5191.169412893919;5191.480851914854;5199.66202196856;4446.421965144576;4455.398521199597;4462.219111655448;4462.286034234507;4481.955180448153;2580.5226033183544;2724.645796046541;2748.8350698958125;2757.6828664703817;2766.1286694691107;4906.11689895815;4922.778474968635;4925.75371231437;4927.531884470969;4929.630277729113;5040.798368065236;5283.418823929364;5300.469953004668;5335.813246536352;5345.679259244458;4879.585235255043;4930.5069493050405;4931.432885218174;4939.086269040239;4950.306957025947;5212.218167274939;5230.8169214077325;5231.346081739783;5275.683458992473;5278.709670968134;4876.829310974099;5137.8201762938115;5155.613329000415;5166.121759301003;5172.827412486839;4922.827701030446;4929.852104436873;4934.100371356982;4939.6542242042715;4941.308216849572;3654.597994220687;3662.5788034376387;3676.4485327200064;3682.484452176751;3697.1311741740133;5062.139890961595;5211.76547055391;5213.40045894727;5215.16557350822;5220.355587989771;5035.255785596785;5036.244563315532;5050.242463630485;5064.797408103635;5067.847964561069;5047.217681259411;5052.898942021213;5080.771365288645;5080.872978175576;5087.592992560512;4874.811643664758;4895.828645997373;4925.975370123127;4993.151164302005;4994.750262486934;4903.877403064809;4961.5286547777905;5065.164247899055;5074.720890351066;5200.427952925251;4970.229614409773;4972.353594032753;5009.849704508871;5011.198208286657;5015.799368025384 16:41:44 INFO - PROCESS | 9544 | |5;yui.html;654.3554598720261;656.3469347998742;685.4447897203269;694.6457306773544;735.0517831996724;12494.687632809173;13323.666908327272;13324.133931294458;13334.799978000337;13341.399637016333;13296.069275150743;13362.19826810392;13396.866031339683;13404.597862064154;13461.394237259323;623.199189042081;753.0737193252303;757.7234309477043;780.5394817057935;783.4437549339975;776.3905334312566;777.5801067423613;781.3436713160944;782.2646712090645;782.3037496628006;830.1366578758084;830.5639539241917;830.6469750356105;831.0359982420393;831.4387788242911;663.2041550139803;799.2407213147533;824.2540500846743;824.3652387661467;824.4929368438427;604.6704546022385;605.3220393159645;605.3946053946054;605.4036773777825;606.2361424604985;12701.364931753375;12733.363331833463;12749.490020399173;12756.362181890869;12779.872201277962;11915;12670.746585068247;13055.934720326337;13284.730257897609;13792.724145517033;11596.420178991017;12256.693582660415;12290.631281061582;12634.49462021518;13013.609591712264;4243.087736136715;4306.070176311156;4314.546972567898;4338.370936214231;4343.261645520238;68145.3185468144;69641;71912.640436798;72207.2779272211;72439.63780181119;9662.855057174149;9693.951530242444;10080.143187829117;10558.155347572176;10642.787144257072;18209.180586873623;18570.535736606424;18573.25706971706;18573.90713046426;18592.07039648012;6754.493412994045;6809.080774095532;7029.4376449883885;7099.325564071508;7195.92804071963;3673.246984368198;3855.575886652466;3859.073822282632;3986.740861844029;4029.81865816039;2704.3644743485265;2800.649918760155;2802.607634931111;2804.284907348613;2804.733550312717;479.63787340557656;491.65829748325285;500.52450172336427;547.5236544206566;566.2553741829481;485.9829905953345;553.92522009529;581.119603800243;603.8580933480629;612.6140531465148;7533.623318834037;7859.017622797151;8017.158198389086;8109.148539403395;8126.918730812617;515.1551455612798;566.8888977603942;577.3014652270715;601.6239850093691;607.5079185859468;3667.2298817248143;3753.943690844585;3797.715171362104;3908.7263891527887;3973.4834471518516;103161;105452;106866;108442;108710;49672;57605.42394576084;88657.55671221603;90254;91722.54138729397;81139.59430202811;81295;82928;83926.58036709778;84150.15849841546;6938.27148149437;7014.5440546364325;7123.536970096927;7354.595497247703;7474.103107627119;48166.27750583674;48419;48606;49398;49690;68281.78195943683;71883.28116718975;72374.63812680903;72443;73311;10024.599016039569;10199.0820826126;10322;10322.638707645196;10697;11881;11967.461464233957;12194.207376520499;12663.366831658564;12822.551210707581;10853.294535855144;11288;11354.205205635526;11413.828792568283;11474.082073434272;10714.946425267824;11063.83404248953;11242.718932026437;11353.772924541629;11423.942880285878;10243.94878025605;10496.21278404138;10620.787584248426;10851.728706782078;10875.401852898167;8907.153820387053;8982.82034359296;9097.09029097085;9325.86011209846;9462.952685236529;8746.30029597618;9072.591733371883;9189.724308270763;9270.814583708154;9356.485393303434 16:41:44 INFO - PROCESS | 9544 | __end_tp_report 16:41:44 INFO - PROCESS | 9544 | __start_cc_report 16:41:44 INFO - PROCESS | 9544 | _x_x_mozilla_cycle_collect,1029 16:41:44 INFO - PROCESS | 9544 | __end_cc_report 16:41:44 INFO - PROCESS | 9544 | __startTimestamp1470267704266__endTimestamp 16:41:44 INFO - PROCESS | 9544 | 16:41:44 INFO - PROCESS | 9544 | ------- Summary: start ------- 16:41:44 INFO - PROCESS | 9544 | Number of tests: 6 16:41:44 INFO - PROCESS | 9544 | 16:41:44 INFO - PROCESS | 9544 | [#0] dojo.html Cycles:165 Average:4836.08 Median:4963.23 stddev:521.28 (10.5%) stddev-sans-first:493.59 16:41:44 INFO - PROCESS | 9544 | Values: 2639.9 2674.8 2683.5 2725.6 2729.8 4711.1 4798.0 4811.6 4923.7 4947.9 4857.5 4882.8 4900.7 4907.1 4937.6 4424.1 4472.5 4518.6 4526.9 4674.4 4573.5 4592.6 4615.8 4623.9 4639.6 4334.5 4373.3 4424.2 4456.2 4518.2 4452.9 4453.6 4459.8 4532.0 4543.2 4466.8 4506.9 4518.6 4538.1 4559.9 4752.8 4780.4 4928.2 4963.2 4978.3 5234.4 5266.6 5316.1 5318.7 5326.8 5257.8 5301.1 5320.1 5347.1 5349.9 4683.1 4841.4 4892.4 4930.7 4956.1 5383.9 5409.1 5436.9 5458.4 5460.8 5189.7 5190.8 5225.6 5236.5 5239.8 5112.9 5208.1 5263.5 5311.0 5333.9 5237.0 5239.3 5245.8 5259.3 5273.7 5222.5 5227.0 5233.9 5243.4 5291.2 4212.0 4247.8 4251.6 4415.1 4420.1 3825.3 3867.1 3907.9 3968.2 3970.7 4538.8 4544.3 4550.7 4593.5 4600.6 5278.7 5291.4 5318.4 5339.5 5340.8 4281.5 4396.5 4463.0 4495.0 4562.9 4681.6 4690.9 4692.9 4696.6 4735.8 4951.0 4954.9 4962.3 4969.5 5009.1 5059.1 5089.6 5108.3 5119.6 5240.7 4834.1 4836.0 4849.3 4858.1 4888.1 5061.3 5119.6 5123.1 5127.1 5170.1 4999.9 5055.9 5151.4 5215.4 5230.6 5110.9 5126.1 5134.2 5142.4 5143.1 5147.0 5148.6 5151.0 5156.6 5187.6 4854.6 4977.9 5002.3 5006.3 5079.6 5129.0 5136.4 5138.1 5140.6 5145.9 4984.9 5018.4 5026.9 5030.2 5061.0 16:41:44 INFO - PROCESS | 9544 | 16:41:44 INFO - PROCESS | 9544 | [#1] ext.html Cycles:180 Average:49219.72 Median:37402.94 stddev:87710.24 (234.5%) stddev-sans-first:87880.22 16:41:44 INFO - PROCESS | 9544 | Values: 566.4 583.6 583.8 589.6 590.9 29822.6 40663.8 41828.0 41851.8 44620.3 41631.8 41829.0 41976.8 41978.0 42153.4 7371.6 7651.6 7779.0 7791.5 7793.9 9378.0 9596.9 9614.9 9814.5 9825.4 9883.7 10009.2 10009.8 10039.5 10042.6 9784.7 9823.3 9852.9 9854.6 9859.3 9668.9 9725.3 9727.4 9730.7 9737.7 38582.6 38796.6 38917.6 38978.0 38987.8 3065.2 3149.4 3239.5 3330.0 3369.5 29097.0 29165.6 29417.9 30374.5 30903.2 3483.4 3555.1 3565.1 3586.5 3633.6 243764.0 244937.0 244940.0 245580.0 245603.0 54847.5 55059.2 55575.2 55604.0 55623.7 58655.7 58748.0 58832.4 58859.7 58861.7 12801.0 13417.9 13439.4 13872.2 13874.8 9508.0 9747.8 9965.9 10294.9 10483.9 18658.3 18689.7 18709.7 18722.3 18736.0 6711.8 6763.8 6803.8 6818.8 6853.2 794.9 860.7 885.8 894.8 946.9 28660.3 29304.9 29408.1 29423.0 29824.6 913.4 955.6 984.9 1003.6 1031.6 15127.9 15372.5 15594.8 15624.8 15882.0 385557.0 389682.0 389931.0 390649.0 391509.0 49903.3 50554.7 50569.5 50577.5 50601.5 1107.3 1134.7 1181.6 1192.9 1210.7 27956.7 30041.8 30301.2 30863.2 30917.0 48839.8 50030.2 50271.0 55060.7 55086.7 345935.0 349146.0 349220.0 349603.0 350669.0 25258.5 25721.6 25792.3 26261.5 40309.2 42553.4 42802.1 42973.4 43056.8 43276.8 36270.0 36449.6 36620.8 37220.0 37985.8 36224.1 36858.0 37026.1 37058.8 37467.4 35885.8 36180.5 36651.6 36698.1 37338.4 31036.0 33409.8 33451.2 33490.3 33512.0 24744.0 25683.0 25899.9 26007.6 26378.1 16:41:44 INFO - PROCESS | 9544 | 16:41:44 INFO - PROCESS | 9544 | [#2] jquery.html Cycles:180 Average:23488.69 Median:5076.39 stddev:62454.13 (1230.3%) stddev-sans-first:62605.16 16:41:44 INFO - PROCESS | 9544 | Values: 346.7 366.2 374.5 377.1 390.9 12462.8 16075.2 16108.3 16462.0 17426.8 15681.5 15922.9 16574.6 16700.2 16707.8 4888.5 5086.9 5104.5 5134.9 5258.4 3457.9 3626.1 5157.8 5194.2 5204.9 3635.7 3877.3 5689.8 5755.3 5769.1 5709.6 5751.4 5756.7 5772.2 5777.4 5065.9 5172.4 5187.4 5193.8 5197.6 11563.1 11730.9 11927.2 11951.8 12037.7 1879.6 1956.7 1985.6 1999.9 2403.3 8718.9 8815.2 8949.3 8960.3 8977.3 1596.0 1630.6 1670.2 1746.1 1765.3 63972.0 67061.0 67126.0 67237.6 67686.7 8699.8 8861.3 9350.3 10079.9 10203.2 13892.7 13981.4 13995.7 14009.5 14009.9 6781.1 6958.1 6978.5 7092.6 7100.7 6206.5 6330.9 6338.3 6460.2 6487.6 4343.7 4363.1 4400.2 4413.9 4464.9 1761.9 1867.0 1878.3 1914.5 1929.1 816.5 899.2 905.6 936.9 957.5 15535.8 16591.0 16794.9 17193.2 17631.8 829.4 863.6 880.2 905.4 905.8 9435.0 9700.6 9786.5 9866.6 9894.5 368205.0 373406.0 377442.0 384466.0 385913.0 72204.7 73785.0 73887.6 74179.0 76749.6 886.4 904.6 920.6 921.6 923.6 14815.6 15185.6 15555.1 15843.8 15859.7 32556.0 35072.5 36298.8 36695.0 36739.3 53135.7 53347.7 53601.5 54236.5 54877.0 7471.3 7723.6 7772.2 7884.5 7909.3 9428.8 11919.8 11948.1 12405.6 12598.5 9947.9 9963.2 10253.6 10285.7 10393.3 10248.7 10527.9 10589.6 10644.7 10696.7 10008.7 10030.7 10136.3 10148.3 10463.8 7760.2 7824.6 7856.1 7858.2 8201.7 7884.6 9306.2 9600.7 9847.0 10573.3 16:41:44 INFO - PROCESS | 9544 | 16:41:44 INFO - PROCESS | 9544 | [#3] mootools.html Cycles:180 Average:4958.35 Median:4935.47 stddev:2810.56 (56.9%) stddev-sans-first:2804.88 16:41:44 INFO - PROCESS | 9544 | Values: 1284.9 1338.6 1406.3 1448.7 1700.0 6620.6 7334.3 7558.1 7569.1 7769.8 7547.1 7603.7 7612.0 7614.8 7620.0 2141.8 2160.6 2171.9 2175.8 2176.1 2051.9 2089.8 2177.7 2201.7 2212.3 2134.2 2138.3 2144.2 2155.1 2190.4 2138.8 2139.7 2144.6 2144.9 2145.0 2079.3 2137.8 2140.9 2141.1 2141.5 7528.8 7679.9 7682.7 7684.1 7687.1 4220.3 4270.1 4387.8 4395.8 4399.6 2780.4 2852.2 2860.6 2865.8 2866.7 908.4 957.2 975.4 975.7 986.7 9956.2 10078.9 10099.0 10110.6 10127.1 3700.2 3892.8 3993.2 4008.7 4024.7 8014.2 8016.4 8022.3 8031.9 8034.7 4257.6 4258.0 4262.6 4263.2 4265.2 3485.5 3819.5 3907.9 3932.1 3981.5 3382.4 3417.6 3491.1 3499.0 3538.5 1045.5 1066.5 1073.9 1082.5 1086.4 797.4 816.6 822.2 825.2 840.5 4919.5 4951.4 5039.4 5125.3 5138.2 384.7 396.9 398.4 398.8 400.2 3393.5 3394.8 3432.8 3462.3 3520.8 9127.6 9630.4 9636.4 9641.1 9661.6 9583.6 9592.2 9601.0 9602.5 9614.0 7073.1 7082.3 7138.5 7153.5 7178.1 4901.8 4959.1 4966.4 4980.5 5101.6 8744.4 8824.2 8850.9 8869.8 8870.0 8756.8 9022.0 9082.0 9104.4 9115.8 5655.8 6137.6 6199.1 6240.3 6249.9 7221.1 7418.9 7492.1 7493.8 7495.0 6559.4 6636.2 6683.0 6798.1 6871.9 6470.8 6607.2 6661.3 6717.3 6781.7 6016.4 6106.7 6112.7 6114.1 6115.5 4503.2 4562.6 4605.9 4658.9 4661.0 4469.2 4472.8 4605.5 4641.3 4647.4 16:41:44 INFO - PROCESS | 9544 | 16:41:44 INFO - PROCESS | 9544 | [#4] prototype.html Cycles:180 Average:4180.07 Median:4816.67 stddev:1223.86 (25.4%) stddev-sans-first:1191.87 16:41:44 INFO - PROCESS | 9544 | Values: 285.3 289.6 294.6 297.1 297.6 4808.0 4825.4 4826.0 4829.9 4839.2 4750.1 4756.9 4764.0 4769.7 4783.3 3529.9 3638.9 3704.6 3759.6 3782.7 3743.0 3752.1 3758.3 3761.0 3769.7 3707.5 3713.8 3713.9 3717.9 3720.9 3549.6 3586.7 3713.0 3720.6 3748.9 3281.1 3283.8 3285.4 3288.2 3292.9 4659.0 4662.9 4692.3 4692.6 4694.8 4122.3 4227.4 4244.8 4251.4 4258.5 4948.2 4971.3 4986.2 4989.4 5008.1 3574.9 3578.3 3592.2 3593.4 3596.5 5100.4 5236.3 5237.0 5248.8 5259.8 3623.9 3656.7 3657.2 3662.0 3677.5 3699.8 3701.2 3708.6 3713.1 3717.7 4208.3 4209.0 4215.3 4219.5 4226.4 4859.8 4934.6 4980.5 5005.8 5018.8 1268.9 1282.4 1286.6 1287.3 1294.3 802.5 824.9 835.7 839.8 843.7 4364.8 4455.2 4475.2 4483.4 4485.1 5157.7 5169.0 5191.2 5191.5 5199.7 4446.4 4455.4 4462.2 4462.3 4482.0 2580.5 2724.6 2748.8 2757.7 2766.1 4906.1 4922.8 4925.8 4927.5 4929.6 5040.8 5283.4 5300.5 5335.8 5345.7 4879.6 4930.5 4931.4 4939.1 4950.3 5212.2 5230.8 5231.3 5275.7 5278.7 4876.8 5137.8 5155.6 5166.1 5172.8 4922.8 4929.9 4934.1 4939.7 4941.3 3654.6 3662.6 3676.4 3682.5 3697.1 5062.1 5211.8 5213.4 5215.2 5220.4 5035.3 5036.2 5050.2 5064.8 5067.8 5047.2 5052.9 5080.8 5080.9 5087.6 4874.8 4895.8 4926.0 4993.2 4994.8 4903.9 4961.5 5065.2 5074.7 5200.4 4970.2 4972.4 5009.8 5011.2 5015.8 16:41:44 INFO - PROCESS | 9544 | 16:41:44 INFO - PROCESS | 9544 | [#5] yui.html Cycles:180 Average:18509.13 Median:49681.00 stddev:27331.78 (55.0%) stddev-sans-first:27375.57 16:41:44 INFO - PROCESS | 9544 | Values: 654.4 656.3 685.4 694.6 735.1 12494.7 13323.7 13324.1 13334.8 13341.4 13296.1 13362.2 13396.9 13404.6 13461.4 623.2 753.1 757.7 780.5 783.4 776.4 777.6 781.3 782.3 782.3 830.1 830.6 830.6 831.0 831.4 663.2 799.2 824.3 824.4 824.5 604.7 605.3 605.4 605.4 606.2 12701.4 12733.4 12749.5 12756.4 12779.9 11915.0 12670.7 13055.9 13284.7 13792.7 11596.4 12256.7 12290.6 12634.5 13013.6 4243.1 4306.1 4314.5 4338.4 4343.3 68145.3 69641.0 71912.6 72207.3 72439.6 9662.9 9694.0 10080.1 10558.2 10642.8 18209.2 18570.5 18573.3 18573.9 18592.1 6754.5 6809.1 7029.4 7099.3 7195.9 3673.2 3855.6 3859.1 3986.7 4029.8 2704.4 2800.6 2802.6 2804.3 2804.7 479.6 491.7 500.5 547.5 566.3 486.0 553.9 581.1 603.9 612.6 7533.6 7859.0 8017.2 8109.1 8126.9 515.2 566.9 577.3 601.6 607.5 3667.2 3753.9 3797.7 3908.7 3973.5 103161.0 105452.0 106866.0 108442.0 108710.0 49672.0 57605.4 88657.6 90254.0 91722.5 81139.6 81295.0 82928.0 83926.6 84150.2 6938.3 7014.5 7123.5 7354.6 7474.1 48166.3 48419.0 48606.0 49398.0 49690.0 68281.8 71883.3 72374.6 72443.0 73311.0 10024.6 10199.1 10322.0 10322.6 10697.0 11881.0 11967.5 12194.2 12663.4 12822.6 10853.3 11288.0 11354.2 11413.8 11474.1 10714.9 11063.8 11242.7 11353.8 11423.9 10243.9 10496.2 10620.8 10851.7 10875.4 8907.2 8982.8 9097.1 9325.9 9463.0 8746.3 9072.6 9189.7 9270.8 9356.5 16:41:44 INFO - PROCESS | 9544 | -------- Summary: end -------- 16:41:44 INFO - PROCESS | 9544 | 16:41:45 INFO - TEST-INFO | 9544: exit 0 16:41:45 INFO - TEST-OK | dromaeo_css | took 1120977ms 16:41:45 INFO - TEST-START | kraken 16:41:45 INFO - operating with platform_type : linux_ 16:41:45 INFO - Initialising browser for kraken test... 16:41:45 INFO - TEST-INFO | started process 9730 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU0qkdS/profile http://localhost:59701/getInfo.html) 16:41:49 INFO - PROCESS | 9730 | __metrics Screen width/height:1600/1200 16:41:49 INFO - PROCESS | 9730 | colorDepth:24 16:41:49 INFO - PROCESS | 9730 | Browser inner width/height: 1024/697 16:41:49 INFO - PROCESS | 9730 | __metrics 16:41:50 INFO - PROCESS | 9730 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:41:50 INFO - PROCESS | 9730 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:41:51 INFO - PROCESS | 9730 | console.error: PushService: 16:41:51 INFO - PROCESS | 9730 | stateChangeProcessEnqueue: Error transitioning state 16:41:51 INFO - PROCESS | 9730 | UnknownError 16:41:51 INFO - TEST-INFO | 9730: exit 0 16:41:51 INFO - Browser initialized. 16:41:51 INFO - Running cycle 1/1 for kraken test... 16:41:51 INFO - TEST-INFO | started process 9811 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU0qkdS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:42:03 INFO - PROCESS | 9811 | RSS: Main: 157835264 16:42:03 INFO - PROCESS | 9811 | 16:42:06 INFO - PROCESS | 9811 | Cycle 1(1): loaded http://localhost:59701/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59701/tests/kraken/driver.html?testName=audio-beat-detection) 16:42:07 INFO - PROCESS | 9811 | RSS: Main: 213565440 16:42:07 INFO - PROCESS | 9811 | 16:42:10 INFO - PROCESS | 9811 | Cycle 1(1): loaded http://localhost:59701/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59701/tests/kraken/driver.html?testName=audio-dft) 16:42:10 INFO - PROCESS | 9811 | RSS: Main: 193015808 16:42:10 INFO - PROCESS | 9811 | 16:42:14 INFO - PROCESS | 9811 | Cycle 1(1): loaded http://localhost:59701/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59701/tests/kraken/driver.html?testName=audio-fft) 16:42:14 INFO - PROCESS | 9811 | RSS: Main: 273715200 16:42:14 INFO - PROCESS | 9811 | 16:42:16 INFO - PROCESS | 9811 | Cycle 1(1): loaded http://localhost:59701/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59701/tests/kraken/driver.html?testName=audio-oscillator) 16:42:17 INFO - PROCESS | 9811 | RSS: Main: 180457472 16:42:17 INFO - PROCESS | 9811 | 16:42:19 INFO - PROCESS | 9811 | Cycle 1(1): loaded http://localhost:59701/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59701/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:42:20 INFO - PROCESS | 9811 | RSS: Main: 184709120 16:42:20 INFO - PROCESS | 9811 | 16:42:23 INFO - PROCESS | 9811 | Cycle 1(1): loaded http://localhost:59701/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59701/tests/kraken/driver.html?testName=imaging-darkroom) 16:42:24 INFO - PROCESS | 9811 | RSS: Main: 221671424 16:42:24 INFO - PROCESS | 9811 | 16:42:27 INFO - PROCESS | 9811 | Cycle 1(1): loaded http://localhost:59701/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59701/tests/kraken/driver.html?testName=imaging-desaturate) 16:42:28 INFO - PROCESS | 9811 | RSS: Main: 214880256 16:42:28 INFO - PROCESS | 9811 | 16:42:31 INFO - PROCESS | 9811 | Cycle 1(1): loaded http://localhost:59701/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59701/tests/kraken/driver.html?testName=json-parse-financial) 16:42:31 INFO - PROCESS | 9811 | RSS: Main: 218365952 16:42:31 INFO - PROCESS | 9811 | 16:42:33 INFO - PROCESS | 9811 | Cycle 1(1): loaded http://localhost:59701/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59701/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:42:34 INFO - PROCESS | 9811 | RSS: Main: 184614912 16:42:34 INFO - PROCESS | 9811 | 16:42:35 INFO - PROCESS | 9811 | Cycle 1(1): loaded http://localhost:59701/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59701/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:42:36 INFO - PROCESS | 9811 | RSS: Main: 190111744 16:42:36 INFO - PROCESS | 9811 | 16:42:38 INFO - PROCESS | 9811 | Cycle 1(1): loaded http://localhost:59701/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59701/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:42:39 INFO - PROCESS | 9811 | RSS: Main: 194396160 16:42:39 INFO - PROCESS | 9811 | 16:42:42 INFO - PROCESS | 9811 | Cycle 1(1): loaded http://localhost:59701/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59701/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:42:42 INFO - PROCESS | 9811 | RSS: Main: 189669376 16:42:42 INFO - PROCESS | 9811 | 16:42:45 INFO - PROCESS | 9811 | Cycle 1(1): loaded http://localhost:59701/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59701/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:42:46 INFO - PROCESS | 9811 | RSS: Main: 193339392 16:42:46 INFO - PROCESS | 9811 | 16:42:48 INFO - PROCESS | 9811 | Cycle 1(1): loaded http://localhost:59701/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59701/tests/kraken/driver.html?testName=ai-astar) 16:42:48 INFO - PROCESS | 9811 | RSS: Main: 243687424 16:42:48 INFO - PROCESS | 9811 | 16:42:48 INFO - PROCESS | 9811 | __start_tp_report 16:42:48 INFO - PROCESS | 9811 | _x_x_mozilla_page_load 16:42:48 INFO - PROCESS | 9811 | _x_x_mozilla_page_load_details 16:42:48 INFO - PROCESS | 9811 | |i|pagename|runs| 16:42:48 INFO - PROCESS | 9811 | |0;ai-astar;105;118;115;113;114;117;114;114;113;113 16:42:48 INFO - PROCESS | 9811 | |1;audio-beat-detection;143;124;125;201;130;124;154;127;166;121 16:42:48 INFO - PROCESS | 9811 | |2;audio-dft;161;160;160;163;161;160;162;162;162;160 16:42:48 INFO - PROCESS | 9811 | |3;audio-fft;77;76;77;121;75;76;76;76;99;76 16:42:48 INFO - PROCESS | 9811 | |4;audio-oscillator;85;84;132;85;85;86;114;85;84;126 16:42:48 INFO - PROCESS | 9811 | |5;imaging-gaussian-blur;116;117;116;116;117;117;117;117;117;117 16:42:48 INFO - PROCESS | 9811 | |6;imaging-darkroom;147;147;146;147;146;148;147;146;146;147 16:42:48 INFO - PROCESS | 9811 | |7;imaging-desaturate;95;94;95;95;95;95;95;96;94;95 16:42:48 INFO - PROCESS | 9811 | |8;json-parse-financial;66;66;65;66;66;65;70;65;64;64 16:42:48 INFO - PROCESS | 9811 | |9;json-stringify-tinderbox;65;64;64;65;65;64;66;65;64;65 16:42:48 INFO - PROCESS | 9811 | |10;stanford-crypto-aes;80;78;79;82;78;79;78;79;79;82 16:42:48 INFO - PROCESS | 9811 | |11;stanford-crypto-ccm;131;139;132;138;131;129;138;136;172;139 16:42:48 INFO - PROCESS | 9811 | |12;stanford-crypto-pbkdf2;169;165;164;167;163;167;166;164;170;166 16:42:48 INFO - PROCESS | 9811 | |13;stanford-crypto-sha256-iterative;70;67;70;68;67;68;67;68;67;74 16:42:48 INFO - PROCESS | 9811 | __end_tp_report 16:42:48 INFO - PROCESS | 9811 | __start_cc_report 16:42:48 INFO - PROCESS | 9811 | _x_x_mozilla_cycle_collect,1956 16:42:48 INFO - PROCESS | 9811 | __end_cc_report 16:42:48 INFO - PROCESS | 9811 | __startTimestamp1470267768307__endTimestamp 16:42:48 INFO - PROCESS | 9811 | 16:42:48 INFO - PROCESS | 9811 | ------- Summary: start ------- 16:42:48 INFO - PROCESS | 9811 | Number of tests: 14 16:42:48 INFO - PROCESS | 9811 | 16:42:48 INFO - PROCESS | 9811 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.00 stddev:3.47 (3.0%) stddev-sans-first:1.81 16:42:48 INFO - PROCESS | 9811 | Values: 105.0 118.0 115.0 113.0 114.0 117.0 114.0 114.0 113.0 113.0 16:42:48 INFO - PROCESS | 9811 | 16:42:48 INFO - PROCESS | 9811 | [#1] audio-beat-detection Cycles:10 Average:141.50 Median:136.50 stddev:25.70 (18.8%) stddev-sans-first:27.26 16:42:48 INFO - PROCESS | 9811 | Values: 143.0 124.0 125.0 201.0 130.0 124.0 154.0 127.0 166.0 121.0 16:42:48 INFO - PROCESS | 9811 | 16:42:48 INFO - PROCESS | 9811 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:1.10 (0.7%) stddev-sans-first:1.17 16:42:48 INFO - PROCESS | 9811 | Values: 161.0 160.0 160.0 163.0 161.0 160.0 162.0 162.0 162.0 160.0 16:42:48 INFO - PROCESS | 9811 | 16:42:48 INFO - PROCESS | 9811 | [#3] audio-fft Cycles:10 Average:82.90 Median:76.00 stddev:15.21 (20.0%) stddev-sans-first:15.98 16:42:48 INFO - PROCESS | 9811 | Values: 77.0 76.0 77.0 121.0 75.0 76.0 76.0 76.0 99.0 76.0 16:42:48 INFO - PROCESS | 9811 | 16:42:48 INFO - PROCESS | 9811 | [#4] audio-oscillator Cycles:10 Average:96.60 Median:85.00 stddev:19.40 (22.8%) stddev-sans-first:20.12 16:42:48 INFO - PROCESS | 9811 | Values: 85.0 84.0 132.0 85.0 85.0 86.0 114.0 85.0 84.0 126.0 16:42:48 INFO - PROCESS | 9811 | 16:42:48 INFO - PROCESS | 9811 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 16:42:48 INFO - PROCESS | 9811 | Values: 116.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 16:42:48 INFO - PROCESS | 9811 | 16:42:48 INFO - PROCESS | 9811 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 16:42:48 INFO - PROCESS | 9811 | Values: 147.0 147.0 146.0 147.0 146.0 148.0 147.0 146.0 146.0 147.0 16:42:48 INFO - PROCESS | 9811 | 16:42:48 INFO - PROCESS | 9811 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 16:42:48 INFO - PROCESS | 9811 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 95.0 96.0 94.0 95.0 16:42:48 INFO - PROCESS | 9811 | 16:42:48 INFO - PROCESS | 9811 | [#8] json-parse-financial Cycles:10 Average:65.70 Median:66.00 stddev:1.70 (2.6%) stddev-sans-first:1.80 16:42:48 INFO - PROCESS | 9811 | Values: 66.0 66.0 65.0 66.0 66.0 65.0 70.0 65.0 64.0 64.0 16:42:48 INFO - PROCESS | 9811 | 16:42:48 INFO - PROCESS | 9811 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 16:42:48 INFO - PROCESS | 9811 | Values: 65.0 64.0 64.0 65.0 65.0 64.0 66.0 65.0 64.0 65.0 16:42:48 INFO - PROCESS | 9811 | 16:42:48 INFO - PROCESS | 9811 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:79.00 stddev:1.51 (1.9%) stddev-sans-first:1.58 16:42:48 INFO - PROCESS | 9811 | Values: 80.0 78.0 79.0 82.0 78.0 79.0 78.0 79.0 79.0 82.0 16:42:48 INFO - PROCESS | 9811 | 16:42:48 INFO - PROCESS | 9811 | [#11] stanford-crypto-ccm Cycles:10 Average:138.50 Median:138.00 stddev:12.36 (9.0%) stddev-sans-first:12.81 16:42:48 INFO - PROCESS | 9811 | Values: 131.0 139.0 132.0 138.0 131.0 129.0 138.0 136.0 172.0 139.0 16:42:48 INFO - PROCESS | 9811 | 16:42:48 INFO - PROCESS | 9811 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.10 Median:166.50 stddev:2.23 (1.3%) stddev-sans-first:2.11 16:42:48 INFO - PROCESS | 9811 | Values: 169.0 165.0 164.0 167.0 163.0 167.0 166.0 164.0 170.0 166.0 16:42:48 INFO - PROCESS | 9811 | 16:42:48 INFO - PROCESS | 9811 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:68.00 stddev:2.22 (3.3%) stddev-sans-first:2.30 16:42:48 INFO - PROCESS | 9811 | Values: 70.0 67.0 70.0 68.0 67.0 68.0 67.0 68.0 67.0 74.0 16:42:48 INFO - PROCESS | 9811 | -------- Summary: end -------- 16:42:48 INFO - PROCESS | 9811 | 16:42:49 INFO - TEST-INFO | 9811: exit 0 16:42:49 INFO - TEST-OK | kraken | took 64365ms 16:42:49 INFO - SUITE-END | took 1185s 16:42:49 INFO - Completed test suite (00:19:45) 16:42:49 INFO - javascript benchmark 16:42:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2639.934001649959, 2674.8498145797307, 2683.490136873995, 2725.5639097744365, 2729.7816174706027, 4711.081339138861, 4798.0, 4811.566958973692, 4923.679960802549, 4947.901041979158, 4857.465678775341, 4882.804687812492, 4900.6569540132205, 4907.092187945233, 4937.604991600672, 4424.115176964604, 4472.485664148632, 4518.593326600605, 4526.937064048798, 4674.368960190365, 4573.451185857702, 4592.609628181609, 4615.769211539427, 4623.8844028899375, 4639.605633521155, 4334.544872788343, 4373.300271956472, 4424.225760491901, 4456.2201614717615, 4518.186726389248, 4452.866414007585, 4453.554644535553, 4459.843905463294, 4531.977340113312, 4543.182227199103, 4466.798994045275, 4506.932396014063, 4518.615917647004, 4538.092381523708, 4559.931601025987, 4752.809887604491, 4780.378550788375, 4928.236123400879, 4963.230699241623, 4978.303037574742, 5234.371875374942, 5266.631335806495, 5316.12283973144, 5318.73406329682, 5326.786928522854, 5257.842264732064, 5301.098813201726, 5320.095583750733, 5347.1177255752755, 5349.893002139975, 4683.063387322481, 4841.394825646794, 4892.437369702458, 4930.654854160246, 4956.10790057793, 5383.919241211385, 5409.134538473904, 5436.891262174734, 5458.372287186945, 5460.781568737206, 5189.7405129743365, 5190.844274671766, 5225.555827754683, 5236.450172731885, 5239.790408383698, 5112.897742045138, 5208.088584497697, 5263.473652634782, 5311.044012077863, 5333.919991200135, 5237.031149237403, 5239.292695486137, 5245.790168393221, 5259.289995850588, 5273.709945952933, 5222.529972302511, 5226.97386513065, 5233.895322093536, 5243.370795504564, 5291.1798671206025, 4212.0, 4247.766372849461, 4251.553586873334, 4415.139047885696, 4420.071784925201, 3825.2540754552597, 3867.0525721197923, 3907.941380879289, 3968.1666849961252, 3970.722049456568, 4538.818447262139, 4544.2501987171745, 4550.658700597469, 4593.47175074864, 4600.585947264695, 5278.683279003195, 5291.391489978701, 5318.44156363584, 5339.519443250126, 5340.759665815048, 4281.464816897887, 4396.49440314368, 4463.04044630406, 4495.011097558532, 4562.908741825145, 4681.602063824613, 4690.882727931829, 4692.929606055912, 4696.624270058387, 4735.763211839394, 4950.950490495049, 4954.900901981868, 4962.33008543842, 4969.527894849984, 5009.073321435546, 5059.06407314648, 5089.567386772166, 5108.3103780989095, 5119.641625086358, 5240.659357141773, 4834.105690447279, 4835.975820121018, 4849.2968519565175, 4858.076965376567, 4888.071266459361, 5061.342025536656, 5119.590432765295, 5123.052235336475, 5127.051495473349, 5170.146925757208, 4999.875003124951, 5055.898882022412, 5151.407588127264, 5215.426303106579, 5230.5815534757885, 5110.9488905110475, 5126.051680439131, 5134.15286477727, 5142.357205349332, 5143.099957507496, 5147.047796157723, 5148.613853961043, 5151.0470562945975, 5156.61325400589, 5187.559057480156, 4854.587360074292, 4977.900441991067, 5002.324686167466, 5006.274090256965, 5079.619028572798, 5128.974355128201, 5136.409312928911, 5138.12651849179, 5140.56305214061, 5145.948540514547, 4984.8753781155765, 5018.42288136869, 5026.949730502648, 5030.170021946338, 5060.974695126501], "value": 4801.886296689634, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.3741565570045, 583.5885700581088, 583.7519054401879, 589.613802959062, 590.937951515091, 29822.552661710066, 40663.79668101659, 41828.0, 41851.79074104633, 44620.3306950396, 41631.79184104083, 41829.0, 41976.79011604938, 41978.0, 42153.36769948453, 7371.594562299071, 7651.617419129049, 7778.961105194495, 7791.454598178129, 7793.883091753628, 9377.953110234439, 9596.904030959706, 9614.903850961471, 9814.50927453628, 9825.361351512129, 9883.703488895344, 10009.249306302056, 10009.849852252222, 10039.498025098752, 10042.648507302245, 9784.706458806248, 9823.263255255884, 9852.901470985342, 9854.556544955494, 9859.260555458333, 9668.854967175497, 9725.270604704676, 9727.367721098106, 9730.659426920094, 9737.707868763948, 38582.61417385846, 38796.61203387958, 38917.61082389196, 38978.0, 38987.80506097451, 3065.249013991564, 3149.4488464518618, 3239.5140728890856, 3329.96670033299, 3369.4608862581867, 29097.0, 29165.56251656227, 29417.852910735524, 30374.54438183429, 30903.227419314473, 3483.442649176145, 3555.1112221944513, 3565.1364887067843, 3586.4620306954166, 3633.615417507779, 243764.0, 244937.0, 244940.0, 245580.0, 245602.99999999822, 54847.451525485034, 55059.17411238835, 55575.16637250444, 55604.0, 55623.72188139033, 58655.70672146612, 58748.0, 58832.41167588355, 58859.70570147122, 58861.705691472125, 12801.0, 13417.932910335387, 13439.395227214798, 13872.167669939836, 13874.791878121836, 9507.954125046239, 9747.805043899225, 9965.900340996643, 10294.897051029544, 10483.895161048444, 18658.253669853326, 18689.719654205197, 18709.719354209697, 18722.344717934808, 18736.0, 6711.832204194934, 6763.797086087426, 6803.795886123424, 6818.795436136924, 6853.246142924274, 794.8767940969159, 860.7030574451804, 885.8494056010494, 894.7763059235191, 946.9431834089977, 28660.283492912426, 29304.853475732485, 29408.11775646734, 29423.0, 29824.552631710543, 913.4382354851851, 955.617752898846, 984.9362688296623, 1003.6136087606324, 1031.6183012285503, 15127.924360378347, 15372.538823835079, 15594.844051559567, 15624.76562851558, 15882.0, 385557.0, 389682.0, 389931.0, 390649.0, 391509.0, 49903.25145122826, 50554.74722626364, 50569.494305056476, 50577.49422505801, 50601.49398506041, 1107.3189988157226, 1134.6539305511733, 1181.5628217559558, 1192.9222605677332, 1210.6549633354452, 27956.720432795413, 30041.849790750908, 30301.242468938453, 30863.2284192897, 30917.0, 48839.75580122077, 50030.249546256106, 50271.0, 55060.72469637626, 55086.72456637691, 345935.0, 349146.0, 349220.0, 349603.0, 350669.0, 25258.49483010293, 25721.614175787752, 25792.26012228254, 26261.4747705041, 40309.1938161241, 42553.361699573914, 42802.143957121305, 42973.355399668406, 43056.78471607622, 43276.78361608172, 36270.0, 36449.635503644626, 36620.81689591535, 37220.0, 37985.810070950574, 36224.09439764027, 36858.0, 37026.074348140435, 37058.8147059263, 37467.43798843074, 35885.820570896976, 36180.45729314115, 36651.633483664824, 36698.082547936516, 37338.43992340171, 31036.0, 33409.83295083509, 33451.16372090717, 33490.33019339551, 33512.0, 24744.0, 25683.0, 25899.870500647376, 26007.60988585135, 26378.07676731305], "value": 18362.28026246377, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.70356844897594, 366.15783697495755, 374.47012477344555, 377.0987340256786, 390.88078136168474, 12462.750744985095, 16075.196240187974, 16108.275127619256, 16461.999999999985, 17426.82573174268, 15681.529554113395, 15922.920385398056, 16574.585635359123, 16700.164991750393, 16707.83292167078, 4888.511148885119, 5086.872828179288, 5104.5405913467785, 5134.897302053957, 5258.368995720519, 3457.896263112111, 3626.0572251214744, 5157.7936882524655, 5194.194899790519, 5204.9219261711105, 3635.745497815154, 3877.3408520551575, 5689.829305120832, 5755.25181726375, 5769.134629805541, 5709.571782116358, 5751.424857514278, 5756.6546007239285, 5772.163036359704, 5777.393373695785, 5065.898682026339, 5172.379314482248, 5187.403448603383, 5193.766280517386, 5197.610179236534, 11563.074954003743, 11730.941345293219, 11927.224730392496, 11951.820722689079, 12037.699057523632, 1879.586490971984, 1956.7358406615067, 1985.5830275642134, 1999.8900060496667, 2403.291029146406, 8718.86921696175, 8815.206631403205, 8949.328800340001, 8960.327975401871, 8977.32670049749, 1595.9521214363588, 1630.5678995066316, 1670.2066518403783, 1746.074580472339, 1765.2674140231788, 63972.0, 67061.0, 67126.0, 67237.64668236588, 67686.66156669185, 8699.782505437415, 8861.33539984491, 9350.345475816763, 10079.949600251952, 10203.234757393226, 13892.652683682989, 13981.370838312301, 13995.650108747159, 14009.509667161601, 14009.929950350182, 6781.084553585203, 6958.06066181059, 6978.511504194657, 7092.574445533284, 7100.68046937889, 6206.534509911775, 6330.905036424458, 6338.271098823602, 6460.192475940507, 6487.643179625166, 4343.739375637472, 4363.083752412029, 4400.163968845909, 4413.911721765547, 4464.888377790581, 1761.9207135678926, 1866.9533261668566, 1878.342580096955, 1914.473519782071, 1929.1126082002436, 816.4937738602105, 899.2266650680409, 905.6241659711146, 936.9038225276443, 957.5403806172936, 15535.766963495556, 16591.0, 16794.91602542004, 17193.226304816315, 17631.823681763017, 829.4069740135832, 863.6415887406781, 880.1682410122373, 905.4160066756905, 905.7735566108473, 9435.0, 9700.6119755209, 9786.461744604116, 9866.642905937144, 9894.455804930654, 368205.0, 373406.0, 377442.0, 384466.0, 385913.0, 72204.68034932761, 73785.0, 73887.63056184685, 74179.0, 76749.61625191839, 886.3573908915985, 904.5793705926776, 920.5719340506696, 921.6083164655129, 923.6443969071955, 14815.629609259855, 15185.6203594911, 15555.14446705442, 15843.841561584697, 15859.682806344039, 32556.0, 35072.47391289184, 36298.818505908355, 36695.0, 36739.26521469502, 53135.73432132815, 53347.733261333444, 53601.46398536121, 54236.45763542314, 54877.0, 7471.327580517779, 7723.575203363869, 7772.222777722182, 7884.487508311941, 7909.327707144727, 9428.764280893032, 11919.76160476803, 11948.103892208293, 12405.565805196775, 12598.496060157491, 9947.900520994697, 9963.153131983572, 10253.641122560675, 10285.74285642835, 10393.272470926962, 10248.692539223835, 10527.94736026315, 10589.629362972259, 10644.733881653021, 10696.732581685521, 10008.741040433322, 10030.749231268985, 10136.341137826017, 10148.340357876714, 10463.843042354218, 7760.223977602194, 7824.608769561385, 7856.135825059353, 7858.214178582325, 8201.671933122609, 7884.6057697113765, 9306.208972237435, 9600.66397676078, 9847.0, 10573.2598718089], "value": 7958.713455882513, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1284.8843604075632, 1338.551585218952, 1406.303879579608, 1448.6885319656271, 1699.9745003824944, 6620.569662971903, 7334.339909408159, 7558.055243094614, 7569.091708994922, 7769.7669069928, 7547.0943486781525, 7603.657835397406, 7611.9619401903055, 7614.809629759259, 7619.961900190491, 2141.8072373486343, 2160.643493823517, 2171.89140542973, 2175.8041776240134, 2176.107795803721, 2051.9281825136122, 2089.8432617553667, 2177.716896803421, 2201.7357917049976, 2212.258893270748, 2134.231676596424, 2138.347803919804, 2144.2066435418915, 2155.1271734947372, 2190.4414374334524, 2138.828893688501, 2139.743230812305, 2144.613969485492, 2144.9034793434334, 2144.9892750536146, 2079.334612923865, 2137.7969092936146, 2140.903659335318, 2141.068635143702, 2141.486043349585, 7528.8117797054965, 7679.884801727979, 7682.7311044113185, 7684.116326622398, 7687.077550693896, 4220.261454245495, 4270.103278311558, 4387.758673272969, 4395.780210989437, 4399.64802815774, 2780.374415756459, 2852.2441552988475, 2860.599516067752, 2865.770738340928, 2866.656001279839, 908.3505293715026, 957.2389949989774, 975.3757595139117, 975.7121649113528, 986.7483791633159, 9956.15372693322, 10078.949605251926, 10099.04059114383, 10110.635064266377, 10127.088562029452, 3700.16746232101, 3892.785896775648, 3993.201359728066, 4008.719389642697, 4024.7383920045104, 8014.15851335613, 8016.438849280495, 8022.318102961197, 8031.879521807177, 8034.718784842619, 4257.63810076147, 4257.957420425818, 4262.552431994658, 4263.211305908417, 4265.168292182994, 3485.5120283160377, 3819.52255968004, 3907.882763517099, 3932.075962148893, 3981.462502562117, 3382.3573521030926, 3417.572803399575, 3491.0574144980715, 3499.0377646147003, 3538.469229615578, 1045.4668119259081, 1066.461436974323, 1073.940933248679, 1082.4966390628238, 1086.4187659602233, 797.3501596199079, 816.5549775372436, 822.1942496353607, 825.1830687619214, 840.5083026429485, 4919.532644398776, 4951.405831300267, 5039.44566097729, 5125.282460455539, 5138.177891537411, 384.6653411531985, 396.85316432920007, 398.4362127589486, 398.7846562856025, 400.159664704119, 3393.5079413484905, 3394.8132852692843, 3432.7940323580665, 3462.342154990544, 3520.823958802101, 9127.634894604142, 9630.374025688448, 9636.42181469114, 9641.132298093205, 9661.565229564545, 9583.616655333848, 9592.184664303473, 9600.951995239979, 9602.519874006271, 9613.951930240304, 7073.08049953513, 7082.327178917994, 7138.535995160401, 7153.463490238253, 7178.102737157856, 4901.828436004866, 4959.13215187348, 4966.404031516241, 4980.477049909852, 5101.56636685871, 8744.387892847439, 8824.249938755278, 8850.911490885266, 8869.822603548022, 8869.955650221707, 8756.781080472785, 9022.0, 9082.0, 9104.362694611315, 9115.817683646157, 5655.773769049192, 6137.631742095488, 6199.132121503083, 6240.28236752761, 6249.875002500015, 7221.133463984355, 7418.851622967619, 7492.138404083382, 7493.812654683677, 7495.0, 6559.442447392025, 6636.203655561363, 6682.966585167043, 6798.082258895183, 6871.862562748617, 6470.838229044311, 6607.2071351438135, 6661.267260601427, 6717.261101278953, 6781.660916954232, 6016.42843929826, 6106.6946652668075, 6112.663803490851, 6114.0828875669, 6115.471132216946, 4503.166914120898, 4562.5665561771575, 4605.907881842278, 4658.93011604833, 4660.953390466052, 4469.195544801967, 4472.821087156477, 4605.539446055368, 4641.303804429228, 4647.395838540968], "value": 3925.991150295731, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.3252058880747, 289.62782824071076, 294.5831648217772, 297.0879400241259, 297.55812618261865, 4807.951920480794, 4825.396825396825, 4825.951740482594, 4829.879253018672, 4839.249916262985, 4750.121227572901, 4756.9286460703115, 4763.9523604763945, 4769.737664428455, 4783.306420569024, 3529.92940141197, 3638.909027274326, 3704.5554533456025, 3759.586445490994, 3782.6595606395417, 3742.9625703742886, 3752.0994961209385, 3758.267137908109, 3760.9623903760885, 3769.6607305342513, 3707.499487569184, 3713.777173369593, 3713.925721485582, 3717.8884633460902, 3720.869769558066, 3549.5917969433585, 3586.7130629549574, 3713.0, 3720.6093360197196, 3748.906277343061, 3281.0812972367776, 3283.819389933553, 3285.4250506161566, 3288.2108294009504, 3292.8682852685865, 4659.0, 4662.906741865144, 4692.319613656035, 4692.554207350297, 4694.788734506956, 4122.299209134454, 4227.408162857202, 4244.787760611988, 4251.406641948409, 4258.510271318776, 4948.158813001798, 4971.304017437562, 4986.152354099811, 4989.401271847365, 5008.098542262392, 3574.946375804365, 3578.3380074686006, 3592.191756854713, 3593.3711600470074, 3596.496490491307, 5100.38795344561, 5236.266922630834, 5237.0, 5248.81629142982, 5259.815906443295, 3623.8912832615065, 3656.689181419556, 3657.195417008254, 3661.9816900915325, 3677.5219221501034, 3699.7965111918566, 3701.1857391373856, 3708.6291370863237, 3713.145976425383, 3717.7397582168987, 4208.305629571148, 4209.0, 4215.325547912319, 4219.493660760729, 4226.408302837605, 4859.829905953346, 4934.580560652313, 4980.477049909708, 5005.774740136702, 5018.799248030111, 1268.9048321375933, 1282.3524120319366, 1286.601153642374, 1287.3498883063992, 1294.3140135728079, 802.4783890471241, 824.9298809601252, 835.7283882738013, 839.7732612194795, 843.6709683223547, 4364.781760911942, 4455.1535208310315, 4475.239209334421, 4483.3723278741, 4485.125400546927, 5157.742112894341, 5168.9741551292, 5191.169412893919, 5191.480851914854, 5199.66202196856, 4446.421965144576, 4455.398521199597, 4462.219111655448, 4462.286034234507, 4481.955180448153, 2580.5226033183544, 2724.645796046541, 2748.8350698958125, 2757.6828664703817, 2766.1286694691107, 4906.11689895815, 4922.778474968635, 4925.75371231437, 4927.531884470969, 4929.630277729113, 5040.798368065236, 5283.418823929364, 5300.469953004668, 5335.813246536352, 5345.679259244458, 4879.585235255043, 4930.5069493050405, 4931.432885218174, 4939.086269040239, 4950.306957025947, 5212.218167274939, 5230.8169214077325, 5231.346081739783, 5275.683458992473, 5278.709670968134, 4876.829310974099, 5137.8201762938115, 5155.613329000415, 5166.121759301003, 5172.827412486839, 4922.827701030446, 4929.852104436873, 4934.100371356982, 4939.6542242042715, 4941.308216849572, 3654.597994220687, 3662.5788034376387, 3676.4485327200064, 3682.484452176751, 3697.1311741740133, 5062.139890961595, 5211.76547055391, 5213.40045894727, 5215.16557350822, 5220.355587989771, 5035.255785596785, 5036.244563315532, 5050.242463630485, 5064.797408103635, 5067.847964561069, 5047.217681259411, 5052.898942021213, 5080.771365288645, 5080.872978175576, 5087.592992560512, 4874.811643664758, 4895.828645997373, 4925.975370123127, 4993.151164302005, 4994.750262486934, 4903.877403064809, 4961.5286547777905, 5065.164247899055, 5074.720890351066, 5200.427952925251, 4970.229614409773, 4972.353594032753, 5009.849704508871, 5011.198208286657, 5015.799368025384], "value": 3787.7950334941675, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [654.3554598720261, 656.3469347998742, 685.4447897203269, 694.6457306773544, 735.0517831996724, 12494.687632809173, 13323.666908327272, 13324.133931294458, 13334.799978000337, 13341.399637016333, 13296.069275150743, 13362.19826810392, 13396.866031339683, 13404.597862064154, 13461.394237259323, 623.199189042081, 753.0737193252303, 757.7234309477043, 780.5394817057935, 783.4437549339975, 776.3905334312566, 777.5801067423613, 781.3436713160944, 782.2646712090645, 782.3037496628006, 830.1366578758084, 830.5639539241917, 830.6469750356105, 831.0359982420393, 831.4387788242911, 663.2041550139803, 799.2407213147533, 824.2540500846743, 824.3652387661467, 824.4929368438427, 604.6704546022385, 605.3220393159645, 605.3946053946054, 605.4036773777825, 606.2361424604985, 12701.364931753375, 12733.363331833463, 12749.490020399173, 12756.362181890869, 12779.872201277962, 11915.0, 12670.746585068247, 13055.934720326337, 13284.730257897609, 13792.724145517033, 11596.420178991017, 12256.693582660415, 12290.631281061582, 12634.49462021518, 13013.609591712264, 4243.087736136715, 4306.070176311156, 4314.546972567898, 4338.370936214231, 4343.261645520238, 68145.3185468144, 69641.0, 71912.640436798, 72207.2779272211, 72439.63780181119, 9662.855057174149, 9693.951530242444, 10080.143187829117, 10558.155347572176, 10642.787144257072, 18209.180586873623, 18570.535736606424, 18573.25706971706, 18573.90713046426, 18592.07039648012, 6754.493412994045, 6809.080774095532, 7029.4376449883885, 7099.325564071508, 7195.92804071963, 3673.246984368198, 3855.575886652466, 3859.073822282632, 3986.740861844029, 4029.81865816039, 2704.3644743485265, 2800.649918760155, 2802.607634931111, 2804.284907348613, 2804.733550312717, 479.63787340557656, 491.65829748325285, 500.52450172336427, 547.5236544206566, 566.2553741829481, 485.9829905953345, 553.92522009529, 581.119603800243, 603.8580933480629, 612.6140531465148, 7533.623318834037, 7859.017622797151, 8017.158198389086, 8109.148539403395, 8126.918730812617, 515.1551455612798, 566.8888977603942, 577.3014652270715, 601.6239850093691, 607.5079185859468, 3667.2298817248143, 3753.943690844585, 3797.715171362104, 3908.7263891527887, 3973.4834471518516, 103161.0, 105452.0, 106866.0, 108442.0, 108710.0, 49672.0, 57605.42394576084, 88657.55671221603, 90254.0, 91722.54138729397, 81139.59430202811, 81295.0, 82928.0, 83926.58036709778, 84150.15849841546, 6938.27148149437, 7014.5440546364325, 7123.536970096927, 7354.595497247703, 7474.103107627119, 48166.27750583674, 48419.0, 48606.0, 49398.0, 49690.0, 68281.78195943683, 71883.28116718975, 72374.63812680903, 72443.0, 73311.0, 10024.599016039569, 10199.0820826126, 10322.0, 10322.638707645196, 10697.0, 11881.0, 11967.461464233957, 12194.207376520499, 12663.366831658564, 12822.551210707581, 10853.294535855144, 11288.0, 11354.205205635526, 11413.828792568283, 11474.082073434272, 10714.946425267824, 11063.83404248953, 11242.718932026437, 11353.772924541629, 11423.942880285878, 10243.94878025605, 10496.21278404138, 10620.787584248426, 10851.728706782078, 10875.401852898167, 8907.153820387053, 8982.82034359296, 9097.09029097085, 9325.86011209846, 9462.952685236529, 8746.30029597618, 9072.591733371883, 9189.724308270763, 9270.814583708154, 9356.485393303434], "value": 6586.654419393644, "unit": "score"}], "name": "dromaeo_css", "value": 6400.380472189773, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 118.0, 115.0, 113.0, 114.0, 117.0, 114.0, 114.0, 113.0, 113.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 124.0, 125.0, 201.0, 130.0, 124.0, 154.0, 127.0, 166.0, 121.0], "value": 141.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 163.0, 161.0, 160.0, 162.0, 162.0, 162.0, 160.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 121.0, 75.0, 76.0, 76.0, 76.0, 99.0, 76.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 132.0, 85.0, 85.0, 86.0, 114.0, 85.0, 84.0, 126.0], "value": 96.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 146.0, 148.0, 147.0, 146.0, 146.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 94.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 66.0, 66.0, 65.0, 70.0, 65.0, 64.0, 64.0], "value": 65.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 65.0, 65.0, 64.0, 66.0, 65.0, 64.0, 65.0], "value": 64.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 79.0, 82.0, 78.0, 79.0, 78.0, 79.0, 79.0, 82.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 139.0, 132.0, 138.0, 131.0, 129.0, 138.0, 136.0, 172.0, 139.0], "value": 138.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 165.0, 164.0, 167.0, 163.0, 167.0, 166.0, 164.0, 170.0, 166.0], "value": 166.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 70.0, 68.0, 67.0, 68.0, 67.0, 68.0, 67.0, 74.0], "value": 68.6, "unit": "score"}], "name": "kraken", "value": 1537.0, "alertThreshold": 2.0}]} 16:42:49 INFO - Return code: 0 16:42:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:42:49 INFO - # TBPL SUCCESS # 16:42:49 INFO - Running post-action listener: _resource_record_post_action 16:42:49 INFO - [mozharness: 2016-08-03 23:42:49.611686Z] Finished run-tests step (success) 16:42:49 INFO - Running post-run listener: _resource_record_post_run 16:42:49 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 541687808; Read time: 12; Write time: 389560 16:42:49 INFO - TinderboxPrint: CPU usage
13.0% 16:42:49 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 16:42:49 INFO - TinderboxPrint: I/O write bytes / time
541,687,808 / 389,560 16:42:49 INFO - TinderboxPrint: CPU idle
8,347.1 (87.0%) 16:42:49 INFO - TinderboxPrint: CPU user
1,199.7 (12.5%) 16:42:49 INFO - TinderboxPrint: Swap in / out
0 / 0 16:42:49 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 248123392; Read time: 0; Write time: 213932 16:42:49 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 293564416; Read time: 0; Write time: 175628 16:42:50 INFO - Running post-run listener: _upload_blobber_files 16:42:50 INFO - Blob upload gear active. 16:42:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:42:50 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 16:42:50 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'] 16:42:50 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 16:42:50 INFO - (blobuploader) - INFO - Open directory for files ... 16:42:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:42:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:42:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:42:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:42:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:42:51 INFO - (blobuploader) - INFO - Done attempting. 16:42:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:42:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:42:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:42:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:42:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:42:55 INFO - (blobuploader) - INFO - Done attempting. 16:42:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:42:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:42:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:42:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:42:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:42:56 INFO - (blobuploader) - INFO - Done attempting. 16:42:56 INFO - (blobuploader) - INFO - Iteration through files over. 16:42:56 INFO - Return code: 0 16:42:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:42:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:42:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c7b218d61927a95241a9811a335eb0d896bbace9ed79e48b81222865f4c1af188ece2ec1c697a42d3ea6b19544951459a4aea1f972559785e6cbf37468cf1370", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/df36ce2d4f499178c0d876f2a459011f895e75f4340613637802a7185810c55209739b3d25fc0cbd32e4835a94767e2abeba6086c3fab02600de70e96d12998c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4dc445f45bfce13eeb73650fd2bb05dc306224caed33f2af0c7b7824f3459fcb3b6f5db8532ce1852deea13881183f9f06ccbc7e11dd073d3d4687693afef819"} 16:42:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:42:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:42:56 INFO - Contents: 16:42:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c7b218d61927a95241a9811a335eb0d896bbace9ed79e48b81222865f4c1af188ece2ec1c697a42d3ea6b19544951459a4aea1f972559785e6cbf37468cf1370", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/df36ce2d4f499178c0d876f2a459011f895e75f4340613637802a7185810c55209739b3d25fc0cbd32e4835a94767e2abeba6086c3fab02600de70e96d12998c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4dc445f45bfce13eeb73650fd2bb05dc306224caed33f2af0c7b7824f3459fcb3b6f5db8532ce1852deea13881183f9f06ccbc7e11dd073d3d4687693afef819"} 16:42:56 INFO - Running post-run listener: copy_logs_to_upload_dir 16:42:56 INFO - Copying logs to upload dir... 16:42:56 INFO - mkdir: /builds/slave/test/build/upload/logs 16:42:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.451784 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-08-03 16:42:55.685993) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-03 16:42:55.689712) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1470266330.304297-1829036138 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/c7b218d61927a95241a9811a335eb0d896bbace9ed79e48b81222865f4c1af188ece2ec1c697a42d3ea6b19544951459a4aea1f972559785e6cbf37468cf1370", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/df36ce2d4f499178c0d876f2a459011f895e75f4340613637802a7185810c55209739b3d25fc0cbd32e4835a94767e2abeba6086c3fab02600de70e96d12998c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4dc445f45bfce13eeb73650fd2bb05dc306224caed33f2af0c7b7824f3459fcb3b6f5db8532ce1852deea13881183f9f06ccbc7e11dd073d3d4687693afef819"} build_url:https://queue.taskcluster.net/v1/task/KNhBZfw2R26dOba1YT_C3g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011190 build_url: 'https://queue.taskcluster.net/v1/task/KNhBZfw2R26dOba1YT_C3g/artifacts/public/build/firefox-51.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/c7b218d61927a95241a9811a335eb0d896bbace9ed79e48b81222865f4c1af188ece2ec1c697a42d3ea6b19544951459a4aea1f972559785e6cbf37468cf1370", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/df36ce2d4f499178c0d876f2a459011f895e75f4340613637802a7185810c55209739b3d25fc0cbd32e4835a94767e2abeba6086c3fab02600de70e96d12998c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4dc445f45bfce13eeb73650fd2bb05dc306224caed33f2af0c7b7824f3459fcb3b6f5db8532ce1852deea13881183f9f06ccbc7e11dd073d3d4687693afef819"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-03 16:42:55.716549) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 16:42:55.716946) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1470266330.304297-1829036138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004399 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 16:42:55.803215) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-03 16:42:55.803533) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-03 16:42:55.803834) ========= ========= Total master_lag: 0.19 =========