builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-022 starttime: 1470320276.86 results: success (0) buildid: 20160804064622 builduid: 776047abb05148878bae385389077c6e revision: 343370281fd7b256b65c5a3cda35d43b8f21ac17 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 07:17:56.857072) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 07:17:56.857609) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 07:17:56.858076) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 07:17:56.892927) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 07:17:56.893287) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1470318847.721522-1460001773 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-04 07:17:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.0M=0s 2016-08-04 07:17:57 (46.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094378 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 07:17:57.002334) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 07:17:57.002678) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1470318847.721522-1460001773 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017021 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 07:17:57.052246) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 07:17:57.052613) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 343370281fd7b256b65c5a3cda35d43b8f21ac17 --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 343370281fd7b256b65c5a3cda35d43b8f21ac17 --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=9c43b49b387003dc8f5b4e5c000001c4-1470318847.721522-1460001773 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-04 07:17:57,382 truncating revision to first 12 chars 2016-08-04 07:17:57,382 Setting DEBUG logging. 2016-08-04 07:17:57,382 attempt 1/10 2016-08-04 07:17:57,382 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/343370281fd7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-04 07:17:57,999 unpacking tar archive at: fx-team-343370281fd7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.957046 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 07:17:58.025782) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 07:17:58.026160) ========= script_repo_revision: 343370281fd7b256b65c5a3cda35d43b8f21ac17 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 07:17:58.026597) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 07:17:58.026882) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 07:17:58.040958) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-08-04 07:17:58.041402) ========= /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=9c43b49b387003dc8f5b4e5c000001c4-1470318847.721522-1460001773 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:17:58 INFO - MultiFileLogger online at 20160804 07:17:58 in /builds/slave/test 07:17:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 07:17:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:17:58 INFO - {'append_to_log': False, 07:17:58 INFO - 'base_work_dir': '/builds/slave/test', 07:17:58 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:17:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:17:58 INFO - 'branch': 'Fx-Team-Non-PGO', 07:17:58 INFO - 'buildbot_json_path': 'buildprops.json', 07:17:58 INFO - 'config_files': ('talos/linux_config.py',), 07:17:58 INFO - 'default_actions': ('clobber', 07:17:58 INFO - 'read-buildbot-config', 07:17:58 INFO - 'download-and-extract', 07:17:58 INFO - 'populate-webroot', 07:17:58 INFO - 'create-virtualenv', 07:17:58 INFO - 'install', 07:17:58 INFO - 'run-tests'), 07:17:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:17:58 INFO - 'download_minidump_stackwalk': True, 07:17:58 INFO - 'download_symbols': 'ondemand', 07:17:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:17:58 INFO - 'tooltool.py': '/tools/tooltool.py', 07:17:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:17:58 INFO - '/tools/misc-python/virtualenv.py')}, 07:17:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:17:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:17:58 INFO - 'installer_path': 'installer.exe', 07:17:58 INFO - 'log_level': 'info', 07:17:58 INFO - 'log_name': 'talos', 07:17:58 INFO - 'log_to_console': True, 07:17:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:17:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:17:58 INFO - 'opt_config_files': (), 07:17:58 INFO - 'pip_index': False, 07:17:58 INFO - 'sps_profile': False, 07:17:58 INFO - 'sps_profile_interval': 0, 07:17:58 INFO - 'suite': 'dromaeojs', 07:17:58 INFO - 'system_bits': '32', 07:17:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:17:58 INFO - 'title': 'talos-linux64-ix-022', 07:17:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:17:58 INFO - 'use_talos_json': True, 07:17:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:17:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:17:58 INFO - 'work_dir': 'build'} 07:17:58 INFO - [mozharness: 2016-08-04 14:17:58.473663Z] Running clobber step. 07:17:58 INFO - Running pre-action listener: _resource_record_pre_action 07:17:58 INFO - Running main action method: clobber 07:17:58 INFO - rmtree: /builds/slave/test/build 07:17:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:17:59 INFO - Running post-action listener: _resource_record_post_action 07:17:59 INFO - [mozharness: 2016-08-04 14:17:59.443568Z] Finished clobber step (success) 07:17:59 INFO - [mozharness: 2016-08-04 14:17:59.443668Z] Running read-buildbot-config step. 07:17:59 INFO - Running pre-action listener: _resource_record_pre_action 07:17:59 INFO - Running main action method: read_buildbot_config 07:17:59 INFO - Using buildbot properties: 07:17:59 INFO - { 07:17:59 INFO - "project": "", 07:17:59 INFO - "product": "firefox", 07:17:59 INFO - "script_repo_revision": "production", 07:17:59 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 07:17:59 INFO - "repository": "", 07:17:59 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 07:17:59 INFO - "buildid": "20160804064622", 07:17:59 INFO - "pgo_build": "False", 07:17:59 INFO - "basedir": "/builds/slave/test", 07:17:59 INFO - "buildnumber": 3210, 07:17:59 INFO - "slavename": "talos-linux64-ix-022", 07:17:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:17:59 INFO - "platform": "ubuntu64_hw", 07:17:59 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:17:59 INFO - "branch": "fx-team", 07:17:59 INFO - "repo_path": "integration/fx-team", 07:17:59 INFO - "revision": "343370281fd7b256b65c5a3cda35d43b8f21ac17", 07:17:59 INFO - "stage_platform": "linux64", 07:17:59 INFO - "builduid": "776047abb05148878bae385389077c6e", 07:17:59 INFO - "slavebuilddir": "test" 07:17:59 INFO - } 07:17:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/BKMnkRQBREuwNfRyT1GtFQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 07:17:59 INFO - Running post-action listener: _resource_record_post_action 07:17:59 INFO - [mozharness: 2016-08-04 14:17:59.446110Z] Finished read-buildbot-config step (success) 07:17:59 INFO - [mozharness: 2016-08-04 14:17:59.446198Z] Running download-and-extract step. 07:17:59 INFO - Running pre-action listener: _resource_record_pre_action 07:17:59 INFO - Running main action method: download_and_extract 07:17:59 INFO - mkdir: /builds/slave/test/build/tests 07:17:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:59 INFO - https://queue.taskcluster.net/v1/task/BKMnkRQBREuwNfRyT1GtFQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:17:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKMnkRQBREuwNfRyT1GtFQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 07:17:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKMnkRQBREuwNfRyT1GtFQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 07:17:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKMnkRQBREuwNfRyT1GtFQ/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 07:17:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKMnkRQBREuwNfRyT1GtFQ/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 07:18:02 INFO - Downloaded 1361 bytes. 07:18:02 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 07:18:02 INFO - Using the following test package requirements: 07:18:02 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 07:18:02 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:18:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:18:02 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:18:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:18:02 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:18:02 INFO - u'jsshell-linux-x86_64.zip'], 07:18:02 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:18:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:18:02 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 07:18:02 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:18:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:18:02 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:18:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:18:02 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:18:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:18:02 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:18:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:18:02 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:18:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:02 INFO - https://queue.taskcluster.net/v1/task/BKMnkRQBREuwNfRyT1GtFQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:18:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKMnkRQBREuwNfRyT1GtFQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:18:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKMnkRQBREuwNfRyT1GtFQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:18:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKMnkRQBREuwNfRyT1GtFQ/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 07:18:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKMnkRQBREuwNfRyT1GtFQ/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 07:18:03 INFO - Downloaded 20241066 bytes. 07:18:03 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'] 07:18:03 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 07:18:05 INFO - Return code: 0 07:18:05 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 07:18:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:05 INFO - https://queue.taskcluster.net/v1/task/BKMnkRQBREuwNfRyT1GtFQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:18:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKMnkRQBREuwNfRyT1GtFQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:18:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKMnkRQBREuwNfRyT1GtFQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:18:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKMnkRQBREuwNfRyT1GtFQ/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 07:18:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKMnkRQBREuwNfRyT1GtFQ/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 07:18:07 INFO - Downloaded 20241066 bytes. 07:18:07 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'] 07:18:07 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 07:18:09 INFO - Return code: 0 07:18:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:09 INFO - https://queue.taskcluster.net/v1/task/BKMnkRQBREuwNfRyT1GtFQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:18:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKMnkRQBREuwNfRyT1GtFQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 07:18:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKMnkRQBREuwNfRyT1GtFQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 07:18:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKMnkRQBREuwNfRyT1GtFQ/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 07:18:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKMnkRQBREuwNfRyT1GtFQ/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 07:18:10 INFO - Downloaded 14413723 bytes. 07:18:10 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'] 07:18:10 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 07:18:10 INFO - Return code: 0 07:18:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:10 INFO - https://queue.taskcluster.net/v1/task/BKMnkRQBREuwNfRyT1GtFQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:18:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKMnkRQBREuwNfRyT1GtFQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:18:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKMnkRQBREuwNfRyT1GtFQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:18:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKMnkRQBREuwNfRyT1GtFQ/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 07:18:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKMnkRQBREuwNfRyT1GtFQ/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 07:18:11 INFO - Downloaded 55629338 bytes. 07:18:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BKMnkRQBREuwNfRyT1GtFQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:18:11 INFO - mkdir: /builds/slave/test/properties 07:18:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:18:11 INFO - Writing to file /builds/slave/test/properties/build_url 07:18:11 INFO - Contents: 07:18:11 INFO - build_url:https://queue.taskcluster.net/v1/task/BKMnkRQBREuwNfRyT1GtFQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:18:12 INFO - Running post-action listener: _resource_record_post_action 07:18:12 INFO - Running post-action listener: set_extra_try_arguments 07:18:12 INFO - [mozharness: 2016-08-04 14:18:12.669858Z] Finished download-and-extract step (success) 07:18:12 INFO - [mozharness: 2016-08-04 14:18:12.670091Z] Running populate-webroot step. 07:18:12 INFO - Running pre-action listener: _resource_record_pre_action 07:18:12 INFO - Running main action method: populate_webroot 07:18:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:18:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:18:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:18:12 INFO - '--tppagecycles', 07:18:12 INFO - '7'], 07:18:12 INFO - 'tests': ['tsvgm']}}, 07:18:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:18:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:18:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:18:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:18:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:18:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:18:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:12 INFO - 'talos_options': ['--disable-e10s'], 07:18:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:18:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:18:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:12 INFO - 'talos_options': ['--disable-e10s'], 07:18:12 INFO - 'tests': ['damp', 'tps']}, 07:18:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:12 INFO - 'tests': ['damp', 'tps']}, 07:18:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:18:12 INFO - 'tests': ['dromaeo_dom']}, 07:18:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:18:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:18:12 INFO - 'tests': ['basic_compositor_video']}, 07:18:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:18:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:18:12 INFO - 'tests': ['a11yr', 07:18:12 INFO - 'ts_paint', 07:18:12 INFO - 'tpaint', 07:18:12 INFO - 'sessionrestore', 07:18:12 INFO - 'sessionrestore_no_auto_restore', 07:18:12 INFO - 'tabpaint']}, 07:18:12 INFO - 'other-e10s': {'tests': ['a11yr', 07:18:12 INFO - 'ts_paint', 07:18:12 INFO - 'tpaint', 07:18:12 INFO - 'sessionrestore', 07:18:12 INFO - 'sessionrestore_no_auto_restore', 07:18:12 INFO - 'tabpaint']}, 07:18:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:18:12 INFO - 'ts_paint', 07:18:12 INFO - 'tpaint', 07:18:12 INFO - 'sessionrestore', 07:18:12 INFO - 'sessionrestore_no_auto_restore', 07:18:12 INFO - 'tabpaint']}, 07:18:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:18:12 INFO - 'ts_paint', 07:18:12 INFO - 'tpaint', 07:18:12 INFO - 'sessionrestore', 07:18:12 INFO - 'sessionrestore_no_auto_restore', 07:18:12 INFO - 'tabpaint']}, 07:18:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:18:12 INFO - 'tests': ['a11yr', 07:18:12 INFO - 'ts_paint', 07:18:12 INFO - 'tpaint', 07:18:12 INFO - 'sessionrestore', 07:18:12 INFO - 'sessionrestore_no_auto_restore', 07:18:12 INFO - 'tabpaint']}, 07:18:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:18:12 INFO - 'tests': ['a11yr', 07:18:12 INFO - 'ts_paint', 07:18:12 INFO - 'tpaint', 07:18:12 INFO - 'sessionrestore', 07:18:12 INFO - 'sessionrestore_no_auto_restore', 07:18:12 INFO - 'tabpaint']}, 07:18:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:18:12 INFO - 'tests': ['tsvgx', 07:18:12 INFO - 'tsvgr_opacity', 07:18:12 INFO - 'tart', 07:18:12 INFO - 'tscrollx', 07:18:12 INFO - 'cart']}, 07:18:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:18:12 INFO - 'tsvgr_opacity', 07:18:12 INFO - 'tart', 07:18:12 INFO - 'tscrollx', 07:18:12 INFO - 'cart']}, 07:18:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:12 INFO - 'talos_options': ['--disable-e10s'], 07:18:12 INFO - 'tests': ['tp5o']}, 07:18:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:12 INFO - 'tests': ['tp5o']}, 07:18:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:12 INFO - 'talos_options': ['--disable-e10s', 07:18:12 INFO - '--xperf_path', 07:18:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:18:12 INFO - 'tests': ['tp5n']}, 07:18:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:12 INFO - 'talos_options': ['--xperf_path', 07:18:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:18:12 INFO - 'tests': ['tp5n']}}, 07:18:12 INFO - 'talos.zip': {'path': '', 07:18:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:18:12 INFO - Running post-action listener: _resource_record_post_action 07:18:12 INFO - [mozharness: 2016-08-04 14:18:12.691854Z] Finished populate-webroot step (success) 07:18:12 INFO - [mozharness: 2016-08-04 14:18:12.691944Z] Running create-virtualenv step. 07:18:12 INFO - Running pre-action listener: _resource_record_pre_action 07:18:12 INFO - Running main action method: create_virtualenv 07:18:12 INFO - Creating virtualenv /builds/slave/test/build/venv 07:18:12 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:18:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:18:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:18:12 INFO - Using real prefix '/usr' 07:18:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:18:13 INFO - Installing distribute.............................................................................................................................................................................................done. 07:18:15 INFO - Installing pip.................done. 07:18:15 INFO - Return code: 0 07:18:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:18:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:15 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 0x1207030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c63b0>, '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 0x14c72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c7740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1470318847.721522-1460001773', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:18:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:18:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:18:15 INFO - Using env: {'DISPLAY': ':0', 07:18:15 INFO - 'HOME': '/home/cltbld', 07:18:15 INFO - 'LANG': 'en_US.UTF-8', 07:18:15 INFO - 'LANGUAGE': 'en_US:en', 07:18:15 INFO - 'LOGNAME': 'cltbld', 07:18:15 INFO - 'MAIL': '/var/mail/cltbld', 07:18:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:15 INFO - 'MOZ_NO_REMOTE': '1', 07:18:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:15 INFO - 'NO_EM_RESTART': '1', 07:18:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:15 INFO - 'PWD': '/builds/slave/test', 07:18:15 INFO - 'SHELL': '/bin/bash', 07:18:15 INFO - 'SHLVL': '1', 07:18:15 INFO - 'TERM': 'linux', 07:18:15 INFO - 'TMOUT': '86400', 07:18:15 INFO - 'USER': 'cltbld', 07:18:15 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470318847.721522-1460001773', 07:18:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:15 INFO - '_': '/tools/buildbot/bin/python'} 07:18:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:15 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:18:15 INFO - Cleaning up... 07:18:15 INFO - Return code: 0 07:18:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:18:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:15 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 0x1207030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c63b0>, '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 0x14c72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c7740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1470318847.721522-1460001773', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:18:15 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 07:18:15 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 07:18:15 INFO - Using env: {'DISPLAY': ':0', 07:18:15 INFO - 'HOME': '/home/cltbld', 07:18:15 INFO - 'LANG': 'en_US.UTF-8', 07:18:15 INFO - 'LANGUAGE': 'en_US:en', 07:18:15 INFO - 'LOGNAME': 'cltbld', 07:18:15 INFO - 'MAIL': '/var/mail/cltbld', 07:18:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:15 INFO - 'MOZ_NO_REMOTE': '1', 07:18:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:15 INFO - 'NO_EM_RESTART': '1', 07:18:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:15 INFO - 'PWD': '/builds/slave/test', 07:18:15 INFO - 'SHELL': '/bin/bash', 07:18:15 INFO - 'SHLVL': '1', 07:18:15 INFO - 'TERM': 'linux', 07:18:15 INFO - 'TMOUT': '86400', 07:18:15 INFO - 'USER': 'cltbld', 07:18:15 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470318847.721522-1460001773', 07:18:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:15 INFO - '_': '/tools/buildbot/bin/python'} 07:18:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:15 INFO - Downloading/unpacking psutil>=3.1.1 07:18:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:18:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:18:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:18:17 INFO - Installing collected packages: psutil 07:18:17 INFO - Running setup.py install for psutil 07:18:17 INFO - building 'psutil._psutil_linux' extension 07:18:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:18:17 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:18:17 INFO - building 'psutil._psutil_posix' extension 07:18:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:18:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:18:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:18:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:18:18 INFO - Successfully installed psutil 07:18:18 INFO - Cleaning up... 07:18:18 INFO - Return code: 0 07:18:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:18:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:18 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 0x1207030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c63b0>, '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 0x14c72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c7740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1470318847.721522-1460001773', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:18:18 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 07:18:18 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 07:18:18 INFO - Using env: {'DISPLAY': ':0', 07:18:18 INFO - 'HOME': '/home/cltbld', 07:18:18 INFO - 'LANG': 'en_US.UTF-8', 07:18:18 INFO - 'LANGUAGE': 'en_US:en', 07:18:18 INFO - 'LOGNAME': 'cltbld', 07:18:18 INFO - 'MAIL': '/var/mail/cltbld', 07:18:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:18 INFO - 'MOZ_NO_REMOTE': '1', 07:18:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:18 INFO - 'NO_EM_RESTART': '1', 07:18:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:18 INFO - 'PWD': '/builds/slave/test', 07:18:18 INFO - 'SHELL': '/bin/bash', 07:18:18 INFO - 'SHLVL': '1', 07:18:18 INFO - 'TERM': 'linux', 07:18:18 INFO - 'TMOUT': '86400', 07:18:18 INFO - 'USER': 'cltbld', 07:18:18 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470318847.721522-1460001773', 07:18:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:18 INFO - '_': '/tools/buildbot/bin/python'} 07:18:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:18:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:18:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:18:20 INFO - Installing collected packages: mozsystemmonitor 07:18:20 INFO - Running setup.py install for mozsystemmonitor 07:18:20 INFO - Successfully installed mozsystemmonitor 07:18:20 INFO - Cleaning up... 07:18:20 INFO - Return code: 0 07:18:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:18:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1207030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c63b0>, '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 0x14c72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c7740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1470318847.721522-1460001773', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:18:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:18:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:18:20 INFO - Using env: {'DISPLAY': ':0', 07:18:20 INFO - 'HOME': '/home/cltbld', 07:18:20 INFO - 'LANG': 'en_US.UTF-8', 07:18:20 INFO - 'LANGUAGE': 'en_US:en', 07:18:20 INFO - 'LOGNAME': 'cltbld', 07:18:20 INFO - 'MAIL': '/var/mail/cltbld', 07:18:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:20 INFO - 'MOZ_NO_REMOTE': '1', 07:18:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:20 INFO - 'NO_EM_RESTART': '1', 07:18:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:20 INFO - 'PWD': '/builds/slave/test', 07:18:20 INFO - 'SHELL': '/bin/bash', 07:18:20 INFO - 'SHLVL': '1', 07:18:20 INFO - 'TERM': 'linux', 07:18:20 INFO - 'TMOUT': '86400', 07:18:20 INFO - 'USER': 'cltbld', 07:18:20 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470318847.721522-1460001773', 07:18:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:20 INFO - '_': '/tools/buildbot/bin/python'} 07:18:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:20 INFO - Downloading/unpacking jsonschema==2.5.1 07:18:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:18:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:18:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:22 INFO - Downloading functools32-3.2.3-2.tar.gz 07:18:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:18:22 INFO - warning: no files found matching '*.txt' 07:18:22 INFO - no previously-included directories found matching 'build' 07:18:22 INFO - no previously-included directories found matching 'dist' 07:18:22 INFO - no previously-included directories found matching '.git*' 07:18:22 INFO - Installing collected packages: jsonschema, functools32 07:18:22 INFO - Running setup.py install for functools32 07:18:23 INFO - warning: no files found matching '*.txt' 07:18:23 INFO - no previously-included directories found matching 'build' 07:18:23 INFO - no previously-included directories found matching 'dist' 07:18:23 INFO - no previously-included directories found matching '.git*' 07:18:23 INFO - Successfully installed jsonschema functools32 07:18:23 INFO - Cleaning up... 07:18:23 INFO - Return code: 0 07:18:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:18: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')]} 07:18:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18: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')]} 07:18:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:23 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 0x1207030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c63b0>, '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 0x14c72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c7740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1470318847.721522-1460001773', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:18:23 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 07:18:23 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 07:18:23 INFO - Using env: {'DISPLAY': ':0', 07:18:23 INFO - 'HOME': '/home/cltbld', 07:18:23 INFO - 'LANG': 'en_US.UTF-8', 07:18:23 INFO - 'LANGUAGE': 'en_US:en', 07:18:23 INFO - 'LOGNAME': 'cltbld', 07:18:23 INFO - 'MAIL': '/var/mail/cltbld', 07:18:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:23 INFO - 'MOZ_NO_REMOTE': '1', 07:18:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:23 INFO - 'NO_EM_RESTART': '1', 07:18:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:23 INFO - 'PWD': '/builds/slave/test', 07:18:23 INFO - 'SHELL': '/bin/bash', 07:18:23 INFO - 'SHLVL': '1', 07:18:23 INFO - 'TERM': 'linux', 07:18:23 INFO - 'TMOUT': '86400', 07:18:23 INFO - 'USER': 'cltbld', 07:18:23 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470318847.721522-1460001773', 07:18:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:23 INFO - '_': '/tools/buildbot/bin/python'} 07:18:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:18:23 INFO - Cleaning up... 07:18:23 INFO - Return code: 0 07:18:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:18: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')]} 07:18:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18: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')]} 07:18:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:23 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 0x1207030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c63b0>, '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 0x14c72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c7740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1470318847.721522-1460001773', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:18:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:18:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:18:23 INFO - Using env: {'DISPLAY': ':0', 07:18:23 INFO - 'HOME': '/home/cltbld', 07:18:23 INFO - 'LANG': 'en_US.UTF-8', 07:18:23 INFO - 'LANGUAGE': 'en_US:en', 07:18:23 INFO - 'LOGNAME': 'cltbld', 07:18:23 INFO - 'MAIL': '/var/mail/cltbld', 07:18:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:23 INFO - 'MOZ_NO_REMOTE': '1', 07:18:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:23 INFO - 'NO_EM_RESTART': '1', 07:18:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:23 INFO - 'PWD': '/builds/slave/test', 07:18:23 INFO - 'SHELL': '/bin/bash', 07:18:23 INFO - 'SHLVL': '1', 07:18:23 INFO - 'TERM': 'linux', 07:18:23 INFO - 'TMOUT': '86400', 07:18:23 INFO - 'USER': 'cltbld', 07:18:23 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470318847.721522-1460001773', 07:18:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:23 INFO - '_': '/tools/buildbot/bin/python'} 07:18:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:23 INFO - Downloading/unpacking blobuploader==1.2.4 07:18:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:25 INFO - Downloading blobuploader-1.2.4.tar.gz 07:18:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:18:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:18:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:26 INFO - Downloading docopt-0.6.1.tar.gz 07:18:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:18:26 INFO - Installing collected packages: blobuploader, requests, docopt 07:18:26 INFO - Running setup.py install for blobuploader 07:18:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:18:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:18:26 INFO - Running setup.py install for requests 07:18:26 INFO - Running setup.py install for docopt 07:18:26 INFO - Successfully installed blobuploader requests docopt 07:18:26 INFO - Cleaning up... 07:18:26 INFO - Return code: 0 07:18:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:18:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1207030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c63b0>, '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 0x14c72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c7740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1470318847.721522-1460001773', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:18:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:18:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:18:26 INFO - Using env: {'DISPLAY': ':0', 07:18:26 INFO - 'HOME': '/home/cltbld', 07:18:26 INFO - 'LANG': 'en_US.UTF-8', 07:18:26 INFO - 'LANGUAGE': 'en_US:en', 07:18:26 INFO - 'LOGNAME': 'cltbld', 07:18:26 INFO - 'MAIL': '/var/mail/cltbld', 07:18:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:26 INFO - 'MOZ_NO_REMOTE': '1', 07:18:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:26 INFO - 'NO_EM_RESTART': '1', 07:18:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:26 INFO - 'PWD': '/builds/slave/test', 07:18:26 INFO - 'SHELL': '/bin/bash', 07:18:26 INFO - 'SHLVL': '1', 07:18:26 INFO - 'TERM': 'linux', 07:18:26 INFO - 'TMOUT': '86400', 07:18:26 INFO - 'USER': 'cltbld', 07:18:26 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470318847.721522-1460001773', 07:18:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:26 INFO - '_': '/tools/buildbot/bin/python'} 07:18:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:18:27 INFO - Running setup.py (path:/tmp/pip-DYnuN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:18:27 INFO - Running setup.py (path:/tmp/pip-npbgG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:18:27 INFO - Running setup.py (path:/tmp/pip-YRYgJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:18:27 INFO - Running setup.py (path:/tmp/pip-LT5keC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:18:27 INFO - Running setup.py (path:/tmp/pip-u8kkeN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:18:27 INFO - Running setup.py (path:/tmp/pip-190bC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:18:27 INFO - Running setup.py (path:/tmp/pip-Qri229-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:18:27 INFO - Running setup.py (path:/tmp/pip-Pxeer2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:18:27 INFO - Running setup.py (path:/tmp/pip-O_LsbK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:18:27 INFO - Running setup.py (path:/tmp/pip-NE9aS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:18:27 INFO - Running setup.py (path:/tmp/pip-SdgfOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:18:27 INFO - Running setup.py (path:/tmp/pip-Muy7fP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:18:27 INFO - Running setup.py (path:/tmp/pip-G5od3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:18:27 INFO - Running setup.py (path:/tmp/pip-wUVpf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:18:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:18:28 INFO - Running setup.py (path:/tmp/pip-_fa4lK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:18:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:18:28 INFO - Running setup.py (path:/tmp/pip-FlClTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:18:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:18:28 INFO - Running setup.py (path:/tmp/pip-HY3wLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:18:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:18:28 INFO - Running setup.py install for manifestparser 07:18:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:18:28 INFO - Running setup.py install for mozcrash 07:18:28 INFO - Running setup.py install for mozdebug 07:18:28 INFO - Running setup.py install for mozdevice 07:18:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:18:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:18:28 INFO - Running setup.py install for mozfile 07:18:28 INFO - Running setup.py install for mozhttpd 07:18:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:18:28 INFO - Running setup.py install for mozinfo 07:18:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:18:28 INFO - Running setup.py install for mozInstall 07:18:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:18:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:18:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:18:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:18:29 INFO - Running setup.py install for mozleak 07:18:29 INFO - Running setup.py install for mozlog 07:18:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:18:29 INFO - Running setup.py install for moznetwork 07:18:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:18:29 INFO - Running setup.py install for mozprocess 07:18:29 INFO - Running setup.py install for mozprofile 07:18:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:18:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:18:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:18:29 INFO - Running setup.py install for mozrunner 07:18:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:18:29 INFO - Running setup.py install for mozscreenshot 07:18:29 INFO - Running setup.py install for moztest 07:18:29 INFO - Running setup.py install for mozversion 07:18:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:18:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:18:30 INFO - Cleaning up... 07:18:30 INFO - Return code: 0 07:18:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:18:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:30 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 0x1207030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c63b0>, '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 0x14c72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c7740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1470318847.721522-1460001773', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:18:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:18:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:18:30 INFO - Using env: {'DISPLAY': ':0', 07:18:30 INFO - 'HOME': '/home/cltbld', 07:18:30 INFO - 'LANG': 'en_US.UTF-8', 07:18:30 INFO - 'LANGUAGE': 'en_US:en', 07:18:30 INFO - 'LOGNAME': 'cltbld', 07:18:30 INFO - 'MAIL': '/var/mail/cltbld', 07:18:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:30 INFO - 'MOZ_NO_REMOTE': '1', 07:18:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:30 INFO - 'NO_EM_RESTART': '1', 07:18:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:30 INFO - 'PWD': '/builds/slave/test', 07:18:30 INFO - 'SHELL': '/bin/bash', 07:18:30 INFO - 'SHLVL': '1', 07:18:30 INFO - 'TERM': 'linux', 07:18:30 INFO - 'TMOUT': '86400', 07:18:30 INFO - 'USER': 'cltbld', 07:18:30 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470318847.721522-1460001773', 07:18:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:30 INFO - '_': '/tools/buildbot/bin/python'} 07:18:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:18:30 INFO - Running setup.py (path:/tmp/pip-Nwp2fl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:18:30 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:18:30 INFO - Running setup.py (path:/tmp/pip-2gZ1cY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:18:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:18:30 INFO - Running setup.py (path:/tmp/pip-e4KYzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:18:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:18:30 INFO - Running setup.py (path:/tmp/pip-Zu6q14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:18:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:18:30 INFO - Running setup.py (path:/tmp/pip-znXjXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:18:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:18:30 INFO - Running setup.py (path:/tmp/pip-FN0uF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:18:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:18:30 INFO - Running setup.py (path:/tmp/pip-T2Rj5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:18:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:18:30 INFO - Running setup.py (path:/tmp/pip-GKM2un-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:18:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:18:30 INFO - Running setup.py (path:/tmp/pip-ZcRtOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:18:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:18:30 INFO - Running setup.py (path:/tmp/pip-8sesqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:18:30 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)) 07:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:18:30 INFO - Running setup.py (path:/tmp/pip-6g7Of6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:18:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:18:31 INFO - Running setup.py (path:/tmp/pip-hAsHG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:18:31 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)) 07:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:18:31 INFO - Running setup.py (path:/tmp/pip-bl2Qrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:18:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:18:31 INFO - Running setup.py (path:/tmp/pip-jspMgF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:18:31 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)) 07:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:18:31 INFO - Running setup.py (path:/tmp/pip-LCjGI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:18:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:18:31 INFO - Running setup.py (path:/tmp/pip-_Gu3e8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:18:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:18:31 INFO - Running setup.py (path:/tmp/pip-C25FNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:18:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:18:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:18:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:18:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:18:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:18:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:18:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:18: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 07:18: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 07:18: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 07:18: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 07:18: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 07:18: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 07:18:33 INFO - Downloading blessings-1.6.tar.gz 07:18:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:18:33 INFO - Installing collected packages: blessings 07:18:33 INFO - Running setup.py install for blessings 07:18:33 INFO - Successfully installed blessings 07:18:33 INFO - Cleaning up... 07:18:33 INFO - Return code: 0 07:18:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:18:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:18:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:18:33 INFO - Reading from file tmpfile_stdout 07:18:33 INFO - Current package versions: 07:18:33 INFO - argparse == 1.2.1 07:18:33 INFO - blessings == 1.6 07:18:33 INFO - blobuploader == 1.2.4 07:18:33 INFO - docopt == 0.6.1 07:18:33 INFO - functools32 == 3.2.3-2 07:18:33 INFO - jsonschema == 2.5.1 07:18:33 INFO - manifestparser == 1.1 07:18:33 INFO - mozInstall == 1.12 07:18:33 INFO - mozcrash == 0.17 07:18:33 INFO - mozdebug == 0.1 07:18:33 INFO - mozdevice == 0.48 07:18:33 INFO - mozfile == 1.2 07:18:33 INFO - mozhttpd == 0.7 07:18:33 INFO - mozinfo == 0.9 07:18:33 INFO - mozleak == 0.1 07:18:33 INFO - mozlog == 3.3 07:18:33 INFO - moznetwork == 0.27 07:18:33 INFO - mozprocess == 0.23 07:18:33 INFO - mozprofile == 0.28 07:18:33 INFO - mozrunner == 6.12 07:18:33 INFO - mozscreenshot == 0.1 07:18:33 INFO - mozsystemmonitor == 0.3 07:18:33 INFO - moztest == 0.7 07:18:33 INFO - mozversion == 1.4 07:18:33 INFO - psutil == 3.1.1 07:18:33 INFO - requests == 1.2.3 07:18:33 INFO - wsgiref == 0.1.2 07:18:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:18:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1207030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c63b0>, '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 0x14c72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c7740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1470318847.721522-1460001773', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:18:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:18:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:18:33 INFO - Using env: {'DISPLAY': ':0', 07:18:33 INFO - 'HOME': '/home/cltbld', 07:18:33 INFO - 'LANG': 'en_US.UTF-8', 07:18:33 INFO - 'LANGUAGE': 'en_US:en', 07:18:33 INFO - 'LOGNAME': 'cltbld', 07:18:33 INFO - 'MAIL': '/var/mail/cltbld', 07:18:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:33 INFO - 'MOZ_NO_REMOTE': '1', 07:18:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:33 INFO - 'NO_EM_RESTART': '1', 07:18:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:33 INFO - 'PWD': '/builds/slave/test', 07:18:33 INFO - 'SHELL': '/bin/bash', 07:18:33 INFO - 'SHLVL': '1', 07:18:33 INFO - 'TERM': 'linux', 07:18:33 INFO - 'TMOUT': '86400', 07:18:33 INFO - 'USER': 'cltbld', 07:18:33 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470318847.721522-1460001773', 07:18:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:33 INFO - '_': '/tools/buildbot/bin/python'} 07:18:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:18:34 INFO - Cleaning up... 07:18:34 INFO - Return code: 0 07:18:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:18:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:34 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 0x1207030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c63b0>, '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 0x14c72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c7740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1470318847.721522-1460001773', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:18:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:18:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:18:34 INFO - Using env: {'DISPLAY': ':0', 07:18:34 INFO - 'HOME': '/home/cltbld', 07:18:34 INFO - 'LANG': 'en_US.UTF-8', 07:18:34 INFO - 'LANGUAGE': 'en_US:en', 07:18:34 INFO - 'LOGNAME': 'cltbld', 07:18:34 INFO - 'MAIL': '/var/mail/cltbld', 07:18:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:34 INFO - 'MOZ_NO_REMOTE': '1', 07:18:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:34 INFO - 'NO_EM_RESTART': '1', 07:18:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:34 INFO - 'PWD': '/builds/slave/test', 07:18:34 INFO - 'SHELL': '/bin/bash', 07:18:34 INFO - 'SHLVL': '1', 07:18:34 INFO - 'TERM': 'linux', 07:18:34 INFO - 'TMOUT': '86400', 07:18:34 INFO - 'USER': 'cltbld', 07:18:34 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470318847.721522-1460001773', 07:18:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:34 INFO - '_': '/tools/buildbot/bin/python'} 07:18:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:18:34 INFO - Cleaning up... 07:18:34 INFO - Return code: 0 07:18:34 INFO - Running post-action listener: _resource_record_post_action 07:18:34 INFO - Running post-action listener: _start_resource_monitoring 07:18:34 INFO - Starting resource monitoring. 07:18:34 INFO - [mozharness: 2016-08-04 14:18:34.344261Z] Finished create-virtualenv step (success) 07:18:34 INFO - [mozharness: 2016-08-04 14:18:34.344700Z] Running install step. 07:18:34 INFO - Running pre-action listener: _resource_record_pre_action 07:18:34 INFO - Running main action method: install 07:18:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:18:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:18:34 INFO - Reading from file tmpfile_stdout 07:18:34 INFO - Detecting whether we're running mozinstall >=1.0... 07:18:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:18:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:18:34 INFO - Reading from file tmpfile_stdout 07:18:34 INFO - Output received: 07:18:34 INFO - Usage: mozinstall [options] installer 07:18:34 INFO - Options: 07:18:34 INFO - -h, --help show this help message and exit 07:18:34 INFO - -d DEST, --destination=DEST 07:18:34 INFO - Directory to install application into. [default: 07:18:34 INFO - "/builds/slave/test"] 07:18:34 INFO - --app=APP Application being installed. [default: firefox] 07:18:34 INFO - mkdir: /builds/slave/test/build/application 07:18:34 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'] 07:18:34 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 07:18:50 INFO - Reading from file tmpfile_stdout 07:18:50 INFO - Output received: 07:18:50 INFO - /builds/slave/test/build/application/firefox/firefox 07:18:50 INFO - Running post-action listener: _resource_record_post_action 07:18:50 INFO - [mozharness: 2016-08-04 14:18:50.673029Z] Finished install step (success) 07:18:50 INFO - [mozharness: 2016-08-04 14:18:50.673423Z] Running run-tests step. 07:18:50 INFO - Running pre-action listener: _resource_record_pre_action 07:18:50 INFO - Running main action method: run_tests 07:18:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:18:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:18:50 INFO - Python 2.7.3 07:18:50 INFO - Return code: 0 07:18:50 INFO - grabbing minidump binary from tooltool 07:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:50 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 0x14c63b0>, '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 0x14c72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c7740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:18:50 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:18:50 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:18:50 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 07:18:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:18:50 INFO - Return code: 0 07:18:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:18:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:18:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:18:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:18:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:18:50 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/BKMnkRQBREuwNfRyT1GtFQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:18:50 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/BKMnkRQBREuwNfRyT1GtFQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:18:50 INFO - Using env: {'DISPLAY': ':0', 07:18:50 INFO - 'HOME': '/home/cltbld', 07:18:50 INFO - 'LANG': 'en_US.UTF-8', 07:18:50 INFO - 'LANGUAGE': 'en_US:en', 07:18:50 INFO - 'LOGNAME': 'cltbld', 07:18:50 INFO - 'MAIL': '/var/mail/cltbld', 07:18:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:18:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:18:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:50 INFO - 'MOZ_NO_REMOTE': '1', 07:18:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:18:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:50 INFO - 'NO_EM_RESTART': '1', 07:18:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:50 INFO - 'PWD': '/builds/slave/test', 07:18:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:18:50 INFO - 'SHELL': '/bin/bash', 07:18:50 INFO - 'SHLVL': '1', 07:18:50 INFO - 'TERM': 'linux', 07:18:50 INFO - 'TMOUT': '86400', 07:18:50 INFO - 'USER': 'cltbld', 07:18:50 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470318847.721522-1460001773', 07:18:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:50 INFO - '_': '/tools/buildbot/bin/python'} 07:18:50 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/BKMnkRQBREuwNfRyT1GtFQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:18:50 INFO - mozversion application_buildid: 20160804064622 07:18:50 INFO - mozversion application_changeset: 343370281fd7b256b65c5a3cda35d43b8f21ac17 07:18:50 INFO - mozversion application_display_name: Nightly 07:18:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:18:50 INFO - mozversion application_name: Firefox 07:18:50 INFO - mozversion application_remotingname: firefox 07:18:50 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:18:50 INFO - mozversion application_vendor: Mozilla 07:18:50 INFO - mozversion application_version: 51.0a1 07:18:50 INFO - mozversion platform_buildid: 20160804064622 07:18:50 INFO - mozversion platform_changeset: 343370281fd7b256b65c5a3cda35d43b8f21ac17 07:18:50 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:18:50 INFO - mozversion platform_version: 51.0a1 07:18:50 INFO - using testdate: 1470320330 07:18:50 INFO - actual date: 1470320330 07:18:50 INFO - starting webserver on 'localhost:36314' 07:18:50 INFO - SUITE-START | Running 2 tests 07:18:50 INFO - TEST-START | dromaeo_css 07:18:50 INFO - operating with platform_type : linux_ 07:18:50 INFO - Initialising browser for dromaeo_css test... 07:18:50 INFO - TEST-INFO | started process 12864 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph1jYzT/profile http://localhost:36314/getInfo.html) 07:18:55 INFO - PROCESS | 12864 | __metrics Screen width/height:1600/1200 07:18:55 INFO - PROCESS | 12864 | colorDepth:24 07:18:55 INFO - PROCESS | 12864 | Browser inner width/height: 1024/697 07:18:55 INFO - PROCESS | 12864 | __metrics 07:18:56 INFO - PROCESS | 12864 | 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" 07:18:56 INFO - PROCESS | 12864 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:18:57 INFO - TEST-INFO | 12864: exit 0 07:18:57 INFO - Browser initialized. 07:18:57 INFO - Running cycle 1/1 for dromaeo_css test... 07:18:57 INFO - TEST-INFO | started process 12944 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph1jYzT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:19:09 INFO - PROCESS | 12944 | RSS: Main: 158154752 07:19:09 INFO - PROCESS | 12944 | 07:20:01 INFO - PROCESS | 12944 | 1470320401177 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:22:14 INFO - PROCESS | 12944 | Cycle 1(1): loaded http://localhost:36314/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36314/tests/dromaeo/cssquery-ext.html) 07:22:15 INFO - PROCESS | 12944 | RSS: Main: 251076608 07:22:15 INFO - PROCESS | 12944 | 07:25:18 INFO - PROCESS | 12944 | Cycle 1(1): loaded http://localhost:36314/tests/dromaeo/cssquery-ext.html (next: http://localhost:36314/tests/dromaeo/cssquery-jquery.html) 07:25:19 INFO - PROCESS | 12944 | RSS: Main: 247627776 07:25:19 INFO - PROCESS | 12944 | 07:28:21 INFO - PROCESS | 12944 | Cycle 1(1): loaded http://localhost:36314/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36314/tests/dromaeo/cssquery-mootools.html) 07:28:21 INFO - PROCESS | 12944 | RSS: Main: 189935616 07:28:21 INFO - PROCESS | 12944 | 07:31:24 INFO - PROCESS | 12944 | Cycle 1(1): loaded http://localhost:36314/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36314/tests/dromaeo/cssquery-prototype.html) 07:31:24 INFO - PROCESS | 12944 | RSS: Main: 188751872 07:31:24 INFO - PROCESS | 12944 | 07:34:27 INFO - PROCESS | 12944 | Cycle 1(1): loaded http://localhost:36314/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36314/tests/dromaeo/cssquery-yui.html) 07:34:28 INFO - PROCESS | 12944 | RSS: Main: 190136320 07:34:28 INFO - PROCESS | 12944 | 07:37:31 INFO - PROCESS | 12944 | Cycle 1(1): loaded http://localhost:36314/tests/dromaeo/cssquery-yui.html (next: http://localhost:36314/tests/dromaeo/cssquery-dojo.html) 07:37:31 INFO - PROCESS | 12944 | RSS: Main: 282853376 07:37:31 INFO - PROCESS | 12944 | 07:37:31 INFO - PROCESS | 12944 | __start_tp_report 07:37:31 INFO - PROCESS | 12944 | _x_x_mozilla_page_load 07:37:31 INFO - PROCESS | 12944 | _x_x_mozilla_page_load_details 07:37:31 INFO - PROCESS | 12944 | |i|pagename|runs| 07:37:31 INFO - PROCESS | 12944 | |0;dojo.html;2697.473992571449;2712.213458097152;2737.548304529752;2744.835309881406;2753.8210016348935;4721.173794585942;4793.880152996168;4888.560029597335;4941.456439791625;4944.25836124581;4799.808007679698;4845.418549774032;4852.878678033051;4874;4942.579880710135;4383.890402739925;4391.3193455014525;4493.999999999984;4545.52272011439;4609.907801843961;4526.230540808054;4548.317752337126;4577.771111444431;4595.655325850558;4626.467956185032;4388.736675799462;4389.934150987738;4435.556444355571;4436.911261774746;4486.618637415823;4435.2238358287495;4458.821647134111;4460.085682435093;4467.977660111711;4530.048689775118;4487.685861989662;4490.101979604092;4492.168948744493;4523.547645235483;4528.796204170821;4663.580277774982;4800.063987522434;4932.334134891779;4984.102861484931;4986.177280748672;5226.947730522684;5266.631335806495;5319.840404787863;5322.121849894763;5326.041312563737;5286.788528458857;5303.363596368422;5327.573794096502;5347.946520534783;5349.919751203735;4725.291206319011;4800.615950723934;4874.731889746098;4982.77577509013;4987.376577927759;5378.7041712705395;5389.595780316414;5419.756110975016;5431.076716958127;5431.6740995540395;5109.412417572027;5112.105381558213;5154.613403994716;5160.045391602565;5169.922451163236;4948.628852836052;5201.921971170435;5202.635815492955;5259.0796610593;5263.3947096083675;5232.607554433433;5251.501107394792;5256.658317209369;5291.973540132275;5297.761600727977;5216.947830521722;5224.92162617561;5234.214867769865;5239.476052394806;5309.097453432925;4269.060806622538;4302.03204279041;4425.114977004612;4506.662000349987;4508.458984921765;3865.9613403866165;3875.5736868944396;3913.5890731473355;3949.2891279569953;3972.682185425159;4454.888627784331;4457.219986502414;4470.552944705503;4514.345419914094;4516.774161291923;4981.2030075187795;5020.723860187724;5250.291210686585;5255.605829562722;5274.551663108602;4377.9781101094295;4406.757628330409;4414.028913638995;4432.423784907941;4454.420925279757;4690.530946905282;4697.577218050324;4714.15145273854;4720.527947205252;4756.6670333077045;4751.904961900812;4877.585405240523;4899.951000489949;4913.091078150554;4946.851594452172;5153.7165455898785;5197.7141257231215;5207;5246.3704355477585;5285.656432331886;4888.2178851383605;4897.926531102107;4901.117798796251;4912.263160525949;4936.333594964777;4922.556969872729;5165.535101840853;5166.767495462638;5169.741512924264;5170.121079416433;5182.32629758129;5253.317068781034;5257.658252213594;5283.049051170672;5355.277037599874;5121.8463446096675;5126.948730512796;5129.512696293846;5132.820351287687;5157.819476318311;4893.608511319015;5106.540411362995;5109.463506331782;5114.795408183631;5115.335006449287;4886.853394398174;4933.827316043921;4940.75296235194;4958.2810492477665;5003.499650034967;5046.318746969112;5060;5074.644774865872;5076.593872490266;5123.513266239701;4807;4855.684380515255;4907.165781817171;4958.603311735124;4960.677555958851 07:37:31 INFO - PROCESS | 12944 | |1;ext.html;577.7891069759538;586.1149664007347;588.3498733899041;591.902336114541;593.9168516407701;28557.57163642547;39490.210195796106;40759.388609170885;40804.59195408045;44649.330260046125;41184.382234266435;41419.514829110274;41576.58423415765;41623.16753664925;41674.37488437668;7303.45224108194;7602.961985190066;7742.574158421285;7750.224977502261;7751.573663448508;9556.761080972961;9819.6072157114;9849.852252216187;10131.594736210543;10141.797164056714;9966;10058.798824023515;10062.295639305252;10062.54718537664;10072.093511583957;9916.950415247913;9947.651832185911;9969.451680157588;9994.200463962938;9998.950005249928;9822.066903644143;9886.703398898044;9889.258305627034;9892.109710126051;9897.851532227023;37467.437988430196;37626;37715.62284377176;37758;37765.622343776486;2994.970050299491;3082.3835232953497;3167.1448708848484;3319.3859136059905;3362.075429256974;28760.568591471143;29377.559336609967;29864.40271194564;29933.550996735066;30392;3216.404965081444;3232.563603913489;3321.618013928405;3330.167458135466;3362.83185840707;241503;242683;242797.99999999822;243968.99999999822;244262;29247.853760731487;52060.47939520632;52289.738551307;52391.21413178805;52411.47588524142;31040.68959310423;33006.50490242648;33009;33055.338893222004;33066.338673226404;11561.710957226136;11720.17958742897;11729;11729.296242225493;11731.47208375625;8184.140665230184;8814.250788682906;8832.51421171829;9163.358564900393;9387.953060234791;7835.49069310493;7885.2114788520685;7964.8805267921025;7973.122956474783;7987.3610111190965;3082.9229269268;3089.90730278092;3120.8127512349333;3149.9527507087414;3157.826319552447;847.4406891451613;896.5616859344487;943.8112377524385;956.1585804492003;959.1080295325274;27890.581641275396;28633.856830715715;28858.855705721337;29063.709362906524;29247.56128658072;901.197933838884;949.8242825077383;967.7580604848788;968.2399316536485;1008.7226012846379;15296.694066118615;15385.692286154439;15390.384384624489;15406.614834629225;15681.372745090068;391029;395380;396175;396849;398310;49053.26420103701;49615.50384496109;49646.25530617044;49728.75135624299;49748.75125624421;1069.198101423932;1124.145649306533;1156.219551802513;1174.629991552658;1198.1612870990168;25692.87153564295;29212.707872920997;29574.556381654722;29713.405731885672;30159.396812064075;42301.78849105735;42906.78546607247;43282.134357313305;43397;43443.782781085894;288054;290476;290656.65403422405;290880;291067;25418.618720718834;25819.483610328065;26071.73928260769;26246.081387151356;27127.59308610333;42305.78847105868;42588.787056064524;42694.78652606717;42807.785961069996;43040.569594303655;36483.45274820827;36750.8162459186;37115.628843711216;37211.81394093012;38617.806910965264;36379.818100909324;36431.27137457289;36439.63560364363;36501.63498365089;36762.63237367699;36463.088422789646;36644.81677591595;36693;36705.26589468249;37582.8120859394;31881.840590797827;33223.50494227717;33399.49900751442;33804.32391352209;34119.65880341264;25441.618375724007;25631.871840640677;25851.353716157246;25924.61113083343;25996.35009124787 07:37:31 INFO - PROCESS | 12944 | |2;jquery.html;342.70899039918163;363.4530032301386;366.6242101845608;367.5075398965386;386.1832224844455;12820.551280705176;16151.515454536353;16226.350945962147;17313.48059558212;17547.912260438712;14508.347124379401;14588.197649129293;14756.11463312202;14818.481353152642;14983.850161498382;4896.167651499236;5039.622028347871;5137.101007323722;5138.9743051284695;5271.077561426754;3453.4992426098324;5227.764750586214;5271.920921186166;5273.209018647195;5284.07528682479;5091.796328146888;5304.6286759926825;5342.439043900393;5400.135978243482;5402.459754024586;5151.330327057459;5274.077036518633;5369.24830523725;5370.167624018264;5380.838574842722;5193.662411943212;5194.766235519411;5196.948030519684;5198.2722418861385;5198.870028249324;11121.666350009513;11581.826272605918;11647.242929209575;11681;11902.047836173086;1794.4885707573278;1917;2037.3480486244407;2056.7120603115577;2335.217702069792;8867.246284065863;8937.910620893774;8965.462072275619;9127.132922372364;9454.57454414553;1681.932722691091;1687.12269619797;1697.193832929361;1782.2514543891596;1790.8388245058006;46682;64153;68277;68835;71338.64330678365;9517.952410237904;9786.657466988763;9869.259805514472;10096.980603879254;10167.186625069977;14106.717865642835;14107.435702571987;14113.717725645634;14151.221682807338;14178.14931104137;6481.254655714653;6512.73949042033;6560.507961902877;6625.569337993015;6649.168853893263;5651.660900345993;5756.0502517084215;5874.412558744091;5909.881802363929;5989.760409583568;4242.575742425733;4346.2828633275785;4396.3625274335045;4474.105178964221;4491.258942274553;1692.5091723400321;1749.9300027998738;1764.9470515884543;1800.1809176824513;1874.8968806715761;690.6098054599136;831.5052543736467;833.3291700181412;877.4779006491256;891.6477991193442;16327.18364081815;16402.753958690628;16969.83030169707;17178.484645460656;17327.047012414438;828.0973738624807;836.8117173636005;841.5413599588239;862.3273846399818;869.4479005831342;9163.496007719506;9176.311776616647;9960.651377201762;10095.09144177013;10451.634192803216;419764;421016;421461;430349;430621;50665.74667126641;50878;84172.57913710392;84346.27438631153;88932;911.289194428347;925.9629614815332;931.6040682709821;943.0811637980439;944.6504793226413;15081.472148474752;15259.389624415344;15636.4527241546;15897.284622191797;15918.522444326689;38530.422043669925;38803.24937617433;39472.40791388074;39967.40048899327;40064.99837504086;53366.46633533615;54571.72714136404;55363.16955245755;55764.163537546156;56712.86574268574;7350.595717235603;7459.589722565311;7538.057742782153;7632.244583745881;7791.844163116592;11757.882421175678;11833.763324733629;11886.643400697993;11942.34317112567;12283;10020.849687254551;10213.642522511676;10332.380057196593;10493.317934334244;10535.104516116216;10157.39055656663;10369.948150259503;10377.429241391494;10520.526576303932;10532.894671053498;8916.894070950137;9789.314747967574;9914.603415863285;9988.750281243027;10277.588896444058;7287.781366559012;7408.073990751156;7536;7578.772636820904;7614.428917831296;8342.249197572248;9717.514124293615;9733.367331123454;9799.657012004545;10270.178385729274 07:37:31 INFO - PROCESS | 12944 | |3;mootools.html;1351.108268542762;1410.957671269862;1448.326528164404;1639.9016059036467;1666.9916650416747;7090.964545177273;7700.037495313086;7705.190954949734;7709.961450192755;7710.49881757686;6490.091387205795;6982.790516284507;7182.784516464501;7206.315400037001;7529.849403011936;2125.553633736917;2157.4714195022243;2160.384290477214;2160.5138843760187;2165.6859755335468;2119.6502577074843;2146.67799830026;2183.061283648031;2185.7814218578173;2187.092356671987;2141.4325203821;2143.9571208575817;2156.0836644426136;2157.5037741319506;2181.8581792183536;2115.7461104667386;2119.9894000530053;2122.257209976511;2122.9256976005922;2125.2774056820676;2066.7933206679213;2109.535902101535;2110.556783075556;2112.5352422467186;2115.3442432845713;7363.116426028911;7455;7517.812054698622;7580.4314676398935;7583.696652133908;4048.7773172475504;4154.335306350999;4158;4162.292410290258;4165.375193720935;2704.391511909824;2776.694563598003;2832.122042166914;2838.148555433382;2839.801213915027;855.5478155077826;893.7542175901614;919.1865199298602;921.5208091792231;927.5808013738923;10275.383476991405;10285.434301113435;10289.536970836256;10296.433696146709;10317.123044541224;3849.0762217067704;3992.341263691458;4026.7785271809744;4176.686748493875;4186.518550366747;8701.869471957925;8703.738887833248;8708.477491350539;8712.259457946018;8728.083551227157;4140.668746500272;4145.3781932709735;4151.522574903925;4153.314703074019;4161.417401563784;3373.1061268763797;3592.5329707137903;3760.7743535387963;3761.4357846322723;3789.981050094787;3588.7846729195808;3670.3576874046935;3777.338965680995;3795.886123416302;3799.0692280390926;1170.5551890281808;1218.8110842819199;1226.9631911042684;1229.7925224222543;1242.4222736427605;794.9920500794918;798.7723498802814;798.9800254993671;816.4325793573528;832.8292699996487;4835.927461088087;4897.2654101885;4995.550400463976;5048.242763585492;5190.354384483557;390.97458665186673;393.5454549994761;396.964273215412;399.59840360438153;411.07303031663406;3326.9334613307597;3385.4752513360468;3391.7117045051446;3432.1419645088727;3437.295354452331;8778.824423511622;8997.055309192572;9181.495017774087;9216.986131525528;9221.631134754669;9026.819463610691;9126.26989840811;9126.315526335551;9127.26981841451;9157.084291570924;6808.08090907731;6818.011388348662;6828.7268509259075;6832.111825462757;6854.074699915547;5050.72221027847;5102.1326374515675;5177.611679124006;5225.242339860622;5353.304070470814;8320.459170153921;8464.915350846659;8581.570921454027;8584.613692383982;8644.178803013956;8338.082810890919;8504.44721093127;8552.615132319184;8762.605682744419;8840.823183536164;5931.961906666403;6421.165248517663;6577.506686998398;6810.897836532356;6878.828029299308;7136.892946605702;7422.294881986203;7422.554646720998;7425.257474252748;7431.071116110486;6533.216014078151;6576.375244351779;6580.473562114924;6670.9332906670315;6719.731210751515;6383.904241436289;6476.643784591893;6521.673916304071;6576.901346479903;6606.867862642816;6135.662538560244;6264.906026409699;6267.4986001120715;6271.749130034747;6272.498200143887;4393.045253420139;4554.908901822011;4562.58936695699;4658.37111989877;4660.4640466345445;4390.868273951786;4440.2229609817505;4491.281394976788;4653.511381304914;4660.813567457264 07:37:31 INFO - PROCESS | 12944 | |4;prototype.html;294.3494876323327;294.4934712294853;298.337690327473;302.52654595557965;304.04681324049125;4800.423949126105;4805.90388192236;4832.130216561018;4836.347093142429;4855.03371134691;4779.283107533872;4784;4784.282357646355;4784.784684689189;4791.496892826255;3606.675399214064;3696.1129328961124;3709.8684901105153;3761.664609063784;3777.1501412182315;3775.7168212384045;3783.545974483066;3790.431435284702;3795.633571914109;3799.9620003799882;3746.569144548371;3749.662530372266;3755.906102347436;3763.604821493745;3764.5858955514873;3509.842057107436;3595.137167079908;3628.3468975584383;3692.390755525335;3754.793486358249;3324.3517514084765;3326.8835590754206;3344.7491438142238;3348.5312056312137;3351.329734053199;4641.350210970467;4657.4876763555985;4659.95340046602;4665.230237010889;4696.9530304696855;4202.331519485118;4287.592678695519;4324.286492728696;4336.8698939031565;4341.218580655481;4943.6539442239055;4950.975245123751;4966.726830024347;4986.376702912136;5001.3998320201445;3623.547056617923;3634.3639863023864;3637.5453068366455;3656;3667.21154951684;5102.295783234855;5234.110201265794;5249.055170069386;5253.9474605253845;5258.395284542288;3703.3889408247337;3717.275131349361;3723.1995121049104;3733.9439908401396;3736.308782875177;3755;3767.3972164453558;3768.5491085931567;3768.6419790119894;3776.3202623527477;4276.764777937244;4279.465066866642;4285.185814695198;4289.849855255051;4295.4415925929425;4780.354652121989;4941.555260026543;4977.452480227172;5023.492952114424;5023.6985780853265;1271.1165739810742;1295.1387327427344;1300.590314051071;1308.717456892232;1313;808.8595080935852;839.8955373683586;841.772721365228;855.7805127693013;857.9742607721778;3969.174179877231;3970.4441378207075;4192;4254.595813397722;4392.363107349416;5092.821751238763;5131.897362052738;5139.254808052811;5156.664816786897;5169.638125331266;4365.236083685342;4388.956110438919;4390.912181756411;4397.362382454527;4397.73613583186;2594.6237795519546;2710.5663093905273;2722.203345791768;2740.383413731934;2752.1881045091745;4817.253325734517;4853.587445067209;4863.686804562748;4872.366592342973;4872.585830204402;5321.6540924839765;5329.7068661224;5341.172118321666;5348.545373643206;5351.866203344947;4753.382060332135;4822.204336284544;4830.396200474941;4843.975780121077;4917.5082491751255;5135.794568217229;5151.098557752453;5151.562117219928;5153.072446959583;5153.196381266676;5039.748012599429;5082.4409314976065;5086.669366491315;5086.898262034664;5116.334876466036;4646.953530464652;4857.53853383928;4867.245576935581;4889.824028307369;4934.669098358522;3675.5114178757644;3680.871169509054;3691.7969511677115;3691.8555247873246;3696.77819330841;5187.403448603459;5190.8961820764125;5202.635815492879;5212.296339994204;5226.843194704165;4899.681520701143;4992.450830408579;4999.675021123615;5026.84919452417;5044.520770526794;5038.193888977892;5049.722265275445;5069.467705890828;5070.4929507049;5071.822486212965;4943.110240156806;4969.4782047884455;4975.502449754996;4994.525520075587;4999.250112483011;4826.758662066813;4846.781894814671;5028.64799464034;5071.746412679425;5084.211947148198;4831.106245344622;4941.827036053721;4950.203135228729;4957;4960.20636698141 07:37:31 INFO - PROCESS | 12944 | |5;yui.html;647.7344288841576;650.80150554081;671.7178784910341;730.6675462664485;748.9812754681134;12579.685507862296;13368.532101376453;13370.197788132695;13389;13401.7989730154;12989.805152922714;13178.011649126305;13202.07585469015;13210;13226.338683065833;627.3506920337452;738.3613174603969;747.3199388556415;759.4721668440436;772.9458937874351;767.110152223421;781.3670926549513;783.1463704562026;783.8667426537473;785.8114052627357;832.097174565597;833.3583140981441;833.6457005772553;833.9499630022187;834.8246868157664;653.4739534674585;794.5391672829803;816.4162623724006;824.027647376096;824.5094168969483;606.5784279925454;608.5709574749791;609.2962628164477;609.34495417426;609.5062998970848;12890.291033993126;12929.935350323189;12935.417906194243;12985.545505907248;12998.805017924738;11824.23142495735;12063;12347.259164450072;12614.306213158272;12851.357432128356;11801.350925699084;11925.582604608797;11990;12153.270803751802;12261.325627090506;3973.145773658677;3974.841006359742;3996.460477835484;4095.1195492968855;4096.877093687164;68786.65606671985;68954;71368.99999999948;73472;73887.63056184739;8907.465552066897;9307.348485605942;10081.49592520371;10251.38491690501;10415.427151506588;17875;18203.362882299058;18371.357002504847;18411.171497282656;18476.630467390576;6647.5679080860555;6741.764038258638;6789.864202715918;6885.518013739091;6915.616876624595;3755.6619904208205;3759.266942946154;3781.5840257571645;3826.942595861064;3928.2143571285856;2768.3771151490755;2850.8432036238205;2865;2869.7704183665255;2873.5258682317185;458.91280656675127;465.40893065806915;467.28038820217165;474.68433491727615;474.93350930869013;536.2037374498866;558.0680263959198;560.7925067724968;582.4845012164266;607.2075940897172;7596.24037596247;8092.3121534669035;8144.714934977247;8184.959075204586;8400.873986890201;583.1893667801759;589.2163422647868;605.8909396308619;627.159606127791;631.4537924695197;3702.259548090393;3838.558565764917;3901.2197560488016;3960.544537378181;4009.4386785850006;56674.43325566774;58073.70963145157;98801.01198988062;106415.4679226599;109749;53378;53440;66767.66616166888;92307.53846230726;92361.53819230861;48961.26558101631;78837;79442.60278698686;81031.59484202541;82960;7184.784456466315;7204.4956853019785;7211.783646490614;7312.378447831781;7458.366038886756;44356.33465498085;44589.777051114535;45411.545884540734;46156;46324.7683761579;64392.67803660952;69012.654936725;70007;70771.64614176896;71343;10234.846477302995;10377.9481102594;10456.58173673075;11312.83030754523;11459.31244125355;13300.667483312995;13604.591862244148;13649.658758531115;13649.727005460034;14549.85450145485;12322.137450378388;12434.440450179583;12672.112952093265;13143.73712525725;13164.210147391188;11798.174127811315;12239.877601223874;12253.203541769757;12406.25562466255;12509.438461232892;11903.285802851857;12190.329531875832;12402.441890115148;12405.193662411913;12468.750624987631;9826.39113495115;10425.218108641731;10444.529996150039;10471.10995565355;10779.89220107789;9299.535023248674;9805.754856128653;10147.238957078396;10806;10814.729631759268 07:37:31 INFO - PROCESS | 12944 | __end_tp_report 07:37:31 INFO - PROCESS | 12944 | __start_cc_report 07:37:31 INFO - PROCESS | 12944 | _x_x_mozilla_cycle_collect,1005 07:37:31 INFO - PROCESS | 12944 | __end_cc_report 07:37:31 INFO - PROCESS | 12944 | __startTimestamp1470321451728__endTimestamp 07:37:31 INFO - PROCESS | 12944 | 07:37:31 INFO - PROCESS | 12944 | ------- Summary: start ------- 07:37:31 INFO - PROCESS | 12944 | Number of tests: 6 07:37:31 INFO - PROCESS | 12944 | 07:37:31 INFO - PROCESS | 12944 | [#0] dojo.html Cycles:165 Average:4821.56 Median:4933.83 stddev:511.73 (10.4%) stddev-sans-first:485.42 07:37:31 INFO - PROCESS | 12944 | Values: 2697.5 2712.2 2737.5 2744.8 2753.8 4721.2 4793.9 4888.6 4941.5 4944.3 4799.8 4845.4 4852.9 4874.0 4942.6 4383.9 4391.3 4494.0 4545.5 4609.9 4526.2 4548.3 4577.8 4595.7 4626.5 4388.7 4389.9 4435.6 4436.9 4486.6 4435.2 4458.8 4460.1 4468.0 4530.0 4487.7 4490.1 4492.2 4523.5 4528.8 4663.6 4800.1 4932.3 4984.1 4986.2 5226.9 5266.6 5319.8 5322.1 5326.0 5286.8 5303.4 5327.6 5347.9 5349.9 4725.3 4800.6 4874.7 4982.8 4987.4 5378.7 5389.6 5419.8 5431.1 5431.7 5109.4 5112.1 5154.6 5160.0 5169.9 4948.6 5201.9 5202.6 5259.1 5263.4 5232.6 5251.5 5256.7 5292.0 5297.8 5216.9 5224.9 5234.2 5239.5 5309.1 4269.1 4302.0 4425.1 4506.7 4508.5 3866.0 3875.6 3913.6 3949.3 3972.7 4454.9 4457.2 4470.6 4514.3 4516.8 4981.2 5020.7 5250.3 5255.6 5274.6 4378.0 4406.8 4414.0 4432.4 4454.4 4690.5 4697.6 4714.2 4720.5 4756.7 4751.9 4877.6 4900.0 4913.1 4946.9 5153.7 5197.7 5207.0 5246.4 5285.7 4888.2 4897.9 4901.1 4912.3 4936.3 4922.6 5165.5 5166.8 5169.7 5170.1 5182.3 5253.3 5257.7 5283.0 5355.3 5121.8 5126.9 5129.5 5132.8 5157.8 4893.6 5106.5 5109.5 5114.8 5115.3 4886.9 4933.8 4940.8 4958.3 5003.5 5046.3 5060.0 5074.6 5076.6 5123.5 4807.0 4855.7 4907.2 4958.6 4960.7 07:37:31 INFO - PROCESS | 12944 | 07:37:31 INFO - PROCESS | 12944 | [#1] ext.html Cycles:180 Average:45834.55 Median:36668.91 stddev:83307.23 (227.2%) stddev-sans-first:83471.63 07:37:31 INFO - PROCESS | 12944 | Values: 577.8 586.1 588.3 591.9 593.9 28557.6 39490.2 40759.4 40804.6 44649.3 41184.4 41419.5 41576.6 41623.2 41674.4 7303.5 7603.0 7742.6 7750.2 7751.6 9556.8 9819.6 9849.9 10131.6 10141.8 9966.0 10058.8 10062.3 10062.5 10072.1 9917.0 9947.7 9969.5 9994.2 9999.0 9822.1 9886.7 9889.3 9892.1 9897.9 37467.4 37626.0 37715.6 37758.0 37765.6 2995.0 3082.4 3167.1 3319.4 3362.1 28760.6 29377.6 29864.4 29933.6 30392.0 3216.4 3232.6 3321.6 3330.2 3362.8 241503.0 242683.0 242798.0 243969.0 244262.0 29247.9 52060.5 52289.7 52391.2 52411.5 31040.7 33006.5 33009.0 33055.3 33066.3 11561.7 11720.2 11729.0 11729.3 11731.5 8184.1 8814.3 8832.5 9163.4 9388.0 7835.5 7885.2 7964.9 7973.1 7987.4 3082.9 3089.9 3120.8 3150.0 3157.8 847.4 896.6 943.8 956.2 959.1 27890.6 28633.9 28858.9 29063.7 29247.6 901.2 949.8 967.8 968.2 1008.7 15296.7 15385.7 15390.4 15406.6 15681.4 391029.0 395380.0 396175.0 396849.0 398310.0 49053.3 49615.5 49646.3 49728.8 49748.8 1069.2 1124.1 1156.2 1174.6 1198.2 25692.9 29212.7 29574.6 29713.4 30159.4 42301.8 42906.8 43282.1 43397.0 43443.8 288054.0 290476.0 290656.7 290880.0 291067.0 25418.6 25819.5 26071.7 26246.1 27127.6 42305.8 42588.8 42694.8 42807.8 43040.6 36483.5 36750.8 37115.6 37211.8 38617.8 36379.8 36431.3 36439.6 36501.6 36762.6 36463.1 36644.8 36693.0 36705.3 37582.8 31881.8 33223.5 33399.5 33804.3 34119.7 25441.6 25631.9 25851.4 25924.6 25996.4 07:37:31 INFO - PROCESS | 12944 | 07:37:31 INFO - PROCESS | 12944 | [#2] jquery.html Cycles:180 Average:24737.71 Median:50771.87 stddev:69922.19 (137.7%) stddev-sans-first:70094.35 07:37:31 INFO - PROCESS | 12944 | Values: 342.7 363.5 366.6 367.5 386.2 12820.6 16151.5 16226.4 17313.5 17547.9 14508.3 14588.2 14756.1 14818.5 14983.9 4896.2 5039.6 5137.1 5139.0 5271.1 3453.5 5227.8 5271.9 5273.2 5284.1 5091.8 5304.6 5342.4 5400.1 5402.5 5151.3 5274.1 5369.2 5370.2 5380.8 5193.7 5194.8 5196.9 5198.3 5198.9 11121.7 11581.8 11647.2 11681.0 11902.0 1794.5 1917.0 2037.3 2056.7 2335.2 8867.2 8937.9 8965.5 9127.1 9454.6 1681.9 1687.1 1697.2 1782.3 1790.8 46682.0 64153.0 68277.0 68835.0 71338.6 9518.0 9786.7 9869.3 10097.0 10167.2 14106.7 14107.4 14113.7 14151.2 14178.1 6481.3 6512.7 6560.5 6625.6 6649.2 5651.7 5756.1 5874.4 5909.9 5989.8 4242.6 4346.3 4396.4 4474.1 4491.3 1692.5 1749.9 1764.9 1800.2 1874.9 690.6 831.5 833.3 877.5 891.6 16327.2 16402.8 16969.8 17178.5 17327.0 828.1 836.8 841.5 862.3 869.4 9163.5 9176.3 9960.7 10095.1 10451.6 419764.0 421016.0 421461.0 430349.0 430621.0 50665.7 50878.0 84172.6 84346.3 88932.0 911.3 926.0 931.6 943.1 944.7 15081.5 15259.4 15636.5 15897.3 15918.5 38530.4 38803.2 39472.4 39967.4 40065.0 53366.5 54571.7 55363.2 55764.2 56712.9 7350.6 7459.6 7538.1 7632.2 7791.8 11757.9 11833.8 11886.6 11942.3 12283.0 10020.8 10213.6 10332.4 10493.3 10535.1 10157.4 10369.9 10377.4 10520.5 10532.9 8916.9 9789.3 9914.6 9988.8 10277.6 7287.8 7408.1 7536.0 7578.8 7614.4 8342.2 9717.5 9733.4 9799.7 10270.2 07:37:31 INFO - PROCESS | 12944 | 07:37:31 INFO - PROCESS | 12944 | [#3] mootools.html Cycles:180 Average:4924.33 Median:4866.60 stddev:2759.44 (56.7%) stddev-sans-first:2754.11 07:37:31 INFO - PROCESS | 12944 | Values: 1351.1 1411.0 1448.3 1639.9 1667.0 7091.0 7700.0 7705.2 7710.0 7710.5 6490.1 6982.8 7182.8 7206.3 7529.8 2125.6 2157.5 2160.4 2160.5 2165.7 2119.7 2146.7 2183.1 2185.8 2187.1 2141.4 2144.0 2156.1 2157.5 2181.9 2115.7 2120.0 2122.3 2122.9 2125.3 2066.8 2109.5 2110.6 2112.5 2115.3 7363.1 7455.0 7517.8 7580.4 7583.7 4048.8 4154.3 4158.0 4162.3 4165.4 2704.4 2776.7 2832.1 2838.1 2839.8 855.5 893.8 919.2 921.5 927.6 10275.4 10285.4 10289.5 10296.4 10317.1 3849.1 3992.3 4026.8 4176.7 4186.5 8701.9 8703.7 8708.5 8712.3 8728.1 4140.7 4145.4 4151.5 4153.3 4161.4 3373.1 3592.5 3760.8 3761.4 3790.0 3588.8 3670.4 3777.3 3795.9 3799.1 1170.6 1218.8 1227.0 1229.8 1242.4 795.0 798.8 799.0 816.4 832.8 4835.9 4897.3 4995.6 5048.2 5190.4 391.0 393.5 397.0 399.6 411.1 3326.9 3385.5 3391.7 3432.1 3437.3 8778.8 8997.1 9181.5 9217.0 9221.6 9026.8 9126.3 9126.3 9127.3 9157.1 6808.1 6818.0 6828.7 6832.1 6854.1 5050.7 5102.1 5177.6 5225.2 5353.3 8320.5 8464.9 8581.6 8584.6 8644.2 8338.1 8504.4 8552.6 8762.6 8840.8 5932.0 6421.2 6577.5 6810.9 6878.8 7136.9 7422.3 7422.6 7425.3 7431.1 6533.2 6576.4 6580.5 6670.9 6719.7 6383.9 6476.6 6521.7 6576.9 6606.9 6135.7 6264.9 6267.5 6271.7 6272.5 4393.0 4554.9 4562.6 4658.4 4660.5 4390.9 4440.2 4491.3 4653.5 4660.8 07:37:31 INFO - PROCESS | 12944 | 07:37:31 INFO - PROCESS | 12944 | [#4] prototype.html Cycles:180 Average:4169.54 Median:4784.53 stddev:1208.34 (25.3%) stddev-sans-first:1176.20 07:37:31 INFO - PROCESS | 12944 | Values: 294.3 294.5 298.3 302.5 304.0 4800.4 4805.9 4832.1 4836.3 4855.0 4779.3 4784.0 4784.3 4784.8 4791.5 3606.7 3696.1 3709.9 3761.7 3777.2 3775.7 3783.5 3790.4 3795.6 3800.0 3746.6 3749.7 3755.9 3763.6 3764.6 3509.8 3595.1 3628.3 3692.4 3754.8 3324.4 3326.9 3344.7 3348.5 3351.3 4641.4 4657.5 4660.0 4665.2 4697.0 4202.3 4287.6 4324.3 4336.9 4341.2 4943.7 4951.0 4966.7 4986.4 5001.4 3623.5 3634.4 3637.5 3656.0 3667.2 5102.3 5234.1 5249.1 5253.9 5258.4 3703.4 3717.3 3723.2 3733.9 3736.3 3755.0 3767.4 3768.5 3768.6 3776.3 4276.8 4279.5 4285.2 4289.8 4295.4 4780.4 4941.6 4977.5 5023.5 5023.7 1271.1 1295.1 1300.6 1308.7 1313.0 808.9 839.9 841.8 855.8 858.0 3969.2 3970.4 4192.0 4254.6 4392.4 5092.8 5131.9 5139.3 5156.7 5169.6 4365.2 4389.0 4390.9 4397.4 4397.7 2594.6 2710.6 2722.2 2740.4 2752.2 4817.3 4853.6 4863.7 4872.4 4872.6 5321.7 5329.7 5341.2 5348.5 5351.9 4753.4 4822.2 4830.4 4844.0 4917.5 5135.8 5151.1 5151.6 5153.1 5153.2 5039.7 5082.4 5086.7 5086.9 5116.3 4647.0 4857.5 4867.2 4889.8 4934.7 3675.5 3680.9 3691.8 3691.9 3696.8 5187.4 5190.9 5202.6 5212.3 5226.8 4899.7 4992.5 4999.7 5026.8 5044.5 5038.2 5049.7 5069.5 5070.5 5071.8 4943.1 4969.5 4975.5 4994.5 4999.3 4826.8 4846.8 5028.6 5071.7 5084.2 4831.1 4941.8 4950.2 4957.0 4960.2 07:37:31 INFO - PROCESS | 12944 | 07:37:31 INFO - PROCESS | 12944 | [#5] yui.html Cycles:180 Average:17624.98 Median:23307.46 stddev:24930.90 (107.0%) stddev-sans-first:24968.25 07:37:31 INFO - PROCESS | 12944 | Values: 647.7 650.8 671.7 730.7 749.0 12579.7 13368.5 13370.2 13389.0 13401.8 12989.8 13178.0 13202.1 13210.0 13226.3 627.4 738.4 747.3 759.5 772.9 767.1 781.4 783.1 783.9 785.8 832.1 833.4 833.6 833.9 834.8 653.5 794.5 816.4 824.0 824.5 606.6 608.6 609.3 609.3 609.5 12890.3 12929.9 12935.4 12985.5 12998.8 11824.2 12063.0 12347.3 12614.3 12851.4 11801.4 11925.6 11990.0 12153.3 12261.3 3973.1 3974.8 3996.5 4095.1 4096.9 68786.7 68954.0 71369.0 73472.0 73887.6 8907.5 9307.3 10081.5 10251.4 10415.4 17875.0 18203.4 18371.4 18411.2 18476.6 6647.6 6741.8 6789.9 6885.5 6915.6 3755.7 3759.3 3781.6 3826.9 3928.2 2768.4 2850.8 2865.0 2869.8 2873.5 458.9 465.4 467.3 474.7 474.9 536.2 558.1 560.8 582.5 607.2 7596.2 8092.3 8144.7 8185.0 8400.9 583.2 589.2 605.9 627.2 631.5 3702.3 3838.6 3901.2 3960.5 4009.4 56674.4 58073.7 98801.0 106415.5 109749.0 53378.0 53440.0 66767.7 92307.5 92361.5 48961.3 78837.0 79442.6 81031.6 82960.0 7184.8 7204.5 7211.8 7312.4 7458.4 44356.3 44589.8 45411.5 46156.0 46324.8 64392.7 69012.7 70007.0 70771.6 71343.0 10234.8 10377.9 10456.6 11312.8 11459.3 13300.7 13604.6 13649.7 13649.7 14549.9 12322.1 12434.4 12672.1 13143.7 13164.2 11798.2 12239.9 12253.2 12406.3 12509.4 11903.3 12190.3 12402.4 12405.2 12468.8 9826.4 10425.2 10444.5 10471.1 10779.9 9299.5 9805.8 10147.2 10806.0 10814.7 07:37:31 INFO - PROCESS | 12944 | -------- Summary: end -------- 07:37:31 INFO - PROCESS | 12944 | 07:37:32 INFO - TEST-INFO | 12944: exit 0 07:37:32 INFO - TEST-OK | dromaeo_css | took 1121606ms 07:37:32 INFO - TEST-START | kraken 07:37:32 INFO - operating with platform_type : linux_ 07:37:32 INFO - Initialising browser for kraken test... 07:37:32 INFO - TEST-INFO | started process 13168 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsqNHrD/profile http://localhost:36314/getInfo.html) 07:37:37 INFO - PROCESS | 13168 | __metrics Screen width/height:1600/1200 07:37:37 INFO - PROCESS | 13168 | colorDepth:24 07:37:37 INFO - PROCESS | 13168 | Browser inner width/height: 1024/697 07:37:37 INFO - PROCESS | 13168 | __metrics 07:37:38 INFO - PROCESS | 13168 | 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" 07:37:38 INFO - PROCESS | 13168 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:37:39 INFO - TEST-INFO | 13168: exit 0 07:37:39 INFO - Browser initialized. 07:37:39 INFO - Running cycle 1/1 for kraken test... 07:37:39 INFO - TEST-INFO | started process 13248 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsqNHrD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:37:51 INFO - PROCESS | 13248 | RSS: Main: 157818880 07:37:51 INFO - PROCESS | 13248 | 07:37:53 INFO - PROCESS | 13248 | Cycle 1(1): loaded http://localhost:36314/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36314/tests/kraken/driver.html?testName=audio-beat-detection) 07:37:54 INFO - PROCESS | 13248 | RSS: Main: 214196224 07:37:54 INFO - PROCESS | 13248 | 07:37:57 INFO - PROCESS | 13248 | Cycle 1(1): loaded http://localhost:36314/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36314/tests/kraken/driver.html?testName=audio-dft) 07:37:58 INFO - PROCESS | 13248 | RSS: Main: 192811008 07:37:58 INFO - PROCESS | 13248 | 07:38:01 INFO - PROCESS | 13248 | Cycle 1(1): loaded http://localhost:36314/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36314/tests/kraken/driver.html?testName=audio-fft) 07:38:01 INFO - PROCESS | 13248 | RSS: Main: 270544896 07:38:01 INFO - PROCESS | 13248 | 07:38:04 INFO - PROCESS | 13248 | Cycle 1(1): loaded http://localhost:36314/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36314/tests/kraken/driver.html?testName=audio-oscillator) 07:38:04 INFO - PROCESS | 13248 | RSS: Main: 180686848 07:38:04 INFO - PROCESS | 13248 | 07:38:06 INFO - PROCESS | 13248 | Cycle 1(1): loaded http://localhost:36314/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36314/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:38:07 INFO - PROCESS | 13248 | RSS: Main: 185667584 07:38:07 INFO - PROCESS | 13248 | 07:38:10 INFO - PROCESS | 13248 | Cycle 1(1): loaded http://localhost:36314/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36314/tests/kraken/driver.html?testName=imaging-darkroom) 07:38:11 INFO - PROCESS | 13248 | RSS: Main: 221528064 07:38:11 INFO - PROCESS | 13248 | 07:38:14 INFO - PROCESS | 13248 | Cycle 1(1): loaded http://localhost:36314/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36314/tests/kraken/driver.html?testName=imaging-desaturate) 07:38:15 INFO - PROCESS | 13248 | RSS: Main: 215470080 07:38:15 INFO - PROCESS | 13248 | 07:38:18 INFO - PROCESS | 13248 | Cycle 1(1): loaded http://localhost:36314/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36314/tests/kraken/driver.html?testName=json-parse-financial) 07:38:18 INFO - PROCESS | 13248 | RSS: Main: 219095040 07:38:18 INFO - PROCESS | 13248 | 07:38:20 INFO - PROCESS | 13248 | Cycle 1(1): loaded http://localhost:36314/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36314/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:38:21 INFO - PROCESS | 13248 | RSS: Main: 184266752 07:38:21 INFO - PROCESS | 13248 | 07:38:23 INFO - PROCESS | 13248 | Cycle 1(1): loaded http://localhost:36314/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36314/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:38:23 INFO - PROCESS | 13248 | RSS: Main: 189845504 07:38:23 INFO - PROCESS | 13248 | 07:38:25 INFO - PROCESS | 13248 | Cycle 1(1): loaded http://localhost:36314/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36314/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:38:26 INFO - PROCESS | 13248 | RSS: Main: 194813952 07:38:26 INFO - PROCESS | 13248 | 07:38:29 INFO - PROCESS | 13248 | Cycle 1(1): loaded http://localhost:36314/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36314/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:38:29 INFO - PROCESS | 13248 | RSS: Main: 189706240 07:38:29 INFO - PROCESS | 13248 | 07:38:32 INFO - PROCESS | 13248 | Cycle 1(1): loaded http://localhost:36314/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36314/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:38:33 INFO - PROCESS | 13248 | RSS: Main: 192782336 07:38:33 INFO - PROCESS | 13248 | 07:38:35 INFO - PROCESS | 13248 | Cycle 1(1): loaded http://localhost:36314/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36314/tests/kraken/driver.html?testName=ai-astar) 07:38:35 INFO - PROCESS | 13248 | RSS: Main: 242880512 07:38:35 INFO - PROCESS | 13248 | 07:38:35 INFO - PROCESS | 13248 | __start_tp_report 07:38:35 INFO - PROCESS | 13248 | _x_x_mozilla_page_load 07:38:35 INFO - PROCESS | 13248 | _x_x_mozilla_page_load_details 07:38:35 INFO - PROCESS | 13248 | |i|pagename|runs| 07:38:35 INFO - PROCESS | 13248 | |0;ai-astar;104;115;114;114;114;115;113;114;116;113 07:38:35 INFO - PROCESS | 13248 | |1;audio-beat-detection;142;122;125;176;126;124;148;120;157;122 07:38:35 INFO - PROCESS | 13248 | |2;audio-dft;162;163;162;161;163;163;164;161;163;162 07:38:35 INFO - PROCESS | 13248 | |3;audio-fft;76;76;76;114;75;77;75;76;109;76 07:38:35 INFO - PROCESS | 13248 | |4;audio-oscillator;85;85;110;85;85;86;118;85;86;131 07:38:35 INFO - PROCESS | 13248 | |5;imaging-gaussian-blur;117;117;117;117;116;117;117;117;117;117 07:38:35 INFO - PROCESS | 13248 | |6;imaging-darkroom;146;146;146;146;147;147;147;146;147;146 07:38:35 INFO - PROCESS | 13248 | |7;imaging-desaturate;95;95;95;94;95;95;95;97;94;95 07:38:35 INFO - PROCESS | 13248 | |8;json-parse-financial;65;63;63;64;63;65;62;63;63;63 07:38:35 INFO - PROCESS | 13248 | |9;json-stringify-tinderbox;64;65;64;65;66;65;65;66;65;65 07:38:35 INFO - PROCESS | 13248 | |10;stanford-crypto-aes;79;78;79;89;79;78;80;79;78;78 07:38:35 INFO - PROCESS | 13248 | |11;stanford-crypto-ccm;133;132;130;130;131;129;128;125;175;129 07:38:35 INFO - PROCESS | 13248 | |12;stanford-crypto-pbkdf2;177;169;175;167;173;170;168;166;164;165 07:38:35 INFO - PROCESS | 13248 | |13;stanford-crypto-sha256-iterative;67;68;71;74;66;69;67;70;67;77 07:38:35 INFO - PROCESS | 13248 | __end_tp_report 07:38:35 INFO - PROCESS | 13248 | __start_cc_report 07:38:35 INFO - PROCESS | 13248 | _x_x_mozilla_cycle_collect,1950 07:38:35 INFO - PROCESS | 13248 | __end_cc_report 07:38:35 INFO - PROCESS | 13248 | __startTimestamp1470321515470__endTimestamp 07:38:35 INFO - PROCESS | 13248 | 07:38:35 INFO - PROCESS | 13248 | ------- Summary: start ------- 07:38:35 INFO - PROCESS | 13248 | Number of tests: 14 07:38:35 INFO - PROCESS | 13248 | 07:38:35 INFO - PROCESS | 13248 | [#0] ai-astar Cycles:10 Average:113.20 Median:114.00 stddev:3.36 (2.9%) stddev-sans-first:0.97 07:38:35 INFO - PROCESS | 13248 | Values: 104.0 115.0 114.0 114.0 114.0 115.0 113.0 114.0 116.0 113.0 07:38:35 INFO - PROCESS | 13248 | 07:38:35 INFO - PROCESS | 13248 | [#1] audio-beat-detection Cycles:10 Average:136.20 Median:134.00 stddev:18.95 (14.1%) stddev-sans-first:19.99 07:38:35 INFO - PROCESS | 13248 | Values: 142.0 122.0 125.0 176.0 126.0 124.0 148.0 120.0 157.0 122.0 07:38:35 INFO - PROCESS | 13248 | 07:38:35 INFO - PROCESS | 13248 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 07:38:35 INFO - PROCESS | 13248 | Values: 162.0 163.0 162.0 161.0 163.0 163.0 164.0 161.0 163.0 162.0 07:38:35 INFO - PROCESS | 13248 | 07:38:35 INFO - PROCESS | 13248 | [#3] audio-fft Cycles:10 Average:83.00 Median:76.00 stddev:15.08 (19.8%) stddev-sans-first:15.78 07:38:35 INFO - PROCESS | 13248 | Values: 76.0 76.0 76.0 114.0 75.0 77.0 75.0 76.0 109.0 76.0 07:38:35 INFO - PROCESS | 13248 | 07:38:35 INFO - PROCESS | 13248 | [#4] audio-oscillator Cycles:10 Average:95.60 Median:85.00 stddev:17.35 (20.4%) stddev-sans-first:17.97 07:38:35 INFO - PROCESS | 13248 | Values: 85.0 85.0 110.0 85.0 85.0 86.0 118.0 85.0 86.0 131.0 07:38:35 INFO - PROCESS | 13248 | 07:38:35 INFO - PROCESS | 13248 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 07:38:35 INFO - PROCESS | 13248 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 07:38:35 INFO - PROCESS | 13248 | 07:38:35 INFO - PROCESS | 13248 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 07:38:35 INFO - PROCESS | 13248 | Values: 146.0 146.0 146.0 146.0 147.0 147.0 147.0 146.0 147.0 146.0 07:38:35 INFO - PROCESS | 13248 | 07:38:35 INFO - PROCESS | 13248 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 07:38:35 INFO - PROCESS | 13248 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 95.0 97.0 94.0 95.0 07:38:35 INFO - PROCESS | 13248 | 07:38:35 INFO - PROCESS | 13248 | [#8] json-parse-financial Cycles:10 Average:63.40 Median:63.00 stddev:0.97 (1.5%) stddev-sans-first:0.83 07:38:35 INFO - PROCESS | 13248 | Values: 65.0 63.0 63.0 64.0 63.0 65.0 62.0 63.0 63.0 63.0 07:38:35 INFO - PROCESS | 13248 | 07:38:35 INFO - PROCESS | 13248 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 07:38:35 INFO - PROCESS | 13248 | Values: 64.0 65.0 64.0 65.0 66.0 65.0 65.0 66.0 65.0 65.0 07:38:35 INFO - PROCESS | 13248 | 07:38:35 INFO - PROCESS | 13248 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:79.00 stddev:3.33 (4.2%) stddev-sans-first:3.53 07:38:35 INFO - PROCESS | 13248 | Values: 79.0 78.0 79.0 89.0 79.0 78.0 80.0 79.0 78.0 78.0 07:38:35 INFO - PROCESS | 13248 | 07:38:35 INFO - PROCESS | 13248 | [#11] stanford-crypto-ccm Cycles:10 Average:134.20 Median:130.50 stddev:14.51 (11.1%) stddev-sans-first:15.38 07:38:35 INFO - PROCESS | 13248 | Values: 133.0 132.0 130.0 130.0 131.0 129.0 128.0 125.0 175.0 129.0 07:38:35 INFO - PROCESS | 13248 | 07:38:35 INFO - PROCESS | 13248 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.40 Median:169.50 stddev:4.35 (2.6%) stddev-sans-first:3.64 07:38:35 INFO - PROCESS | 13248 | Values: 177.0 169.0 175.0 167.0 173.0 170.0 168.0 166.0 164.0 165.0 07:38:35 INFO - PROCESS | 13248 | 07:38:35 INFO - PROCESS | 13248 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:69.50 stddev:3.53 (5.1%) stddev-sans-first:3.62 07:38:35 INFO - PROCESS | 13248 | Values: 67.0 68.0 71.0 74.0 66.0 69.0 67.0 70.0 67.0 77.0 07:38:35 INFO - PROCESS | 13248 | -------- Summary: end -------- 07:38:35 INFO - PROCESS | 13248 | 07:38:36 INFO - TEST-INFO | 13248: exit 0 07:38:36 INFO - TEST-OK | kraken | took 64030ms 07:38:36 INFO - SUITE-END | took 1185s 07:38:36 INFO - Completed test suite (00:19:45) 07:38:36 INFO - javascript benchmark 07:38:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2697.473992571449, 2712.213458097152, 2737.548304529752, 2744.835309881406, 2753.8210016348935, 4721.173794585942, 4793.880152996168, 4888.560029597335, 4941.456439791625, 4944.25836124581, 4799.808007679698, 4845.418549774032, 4852.878678033051, 4874.0, 4942.579880710135, 4383.890402739925, 4391.3193455014525, 4493.999999999984, 4545.52272011439, 4609.907801843961, 4526.230540808054, 4548.317752337126, 4577.771111444431, 4595.655325850558, 4626.467956185032, 4388.736675799462, 4389.934150987738, 4435.556444355571, 4436.911261774746, 4486.618637415823, 4435.2238358287495, 4458.821647134111, 4460.085682435093, 4467.977660111711, 4530.048689775118, 4487.685861989662, 4490.101979604092, 4492.168948744493, 4523.547645235483, 4528.796204170821, 4663.580277774982, 4800.063987522434, 4932.334134891779, 4984.102861484931, 4986.177280748672, 5226.947730522684, 5266.631335806495, 5319.840404787863, 5322.121849894763, 5326.041312563737, 5286.788528458857, 5303.363596368422, 5327.573794096502, 5347.946520534783, 5349.919751203735, 4725.291206319011, 4800.615950723934, 4874.731889746098, 4982.77577509013, 4987.376577927759, 5378.7041712705395, 5389.595780316414, 5419.756110975016, 5431.076716958127, 5431.6740995540395, 5109.412417572027, 5112.105381558213, 5154.613403994716, 5160.045391602565, 5169.922451163236, 4948.628852836052, 5201.921971170435, 5202.635815492955, 5259.0796610593, 5263.3947096083675, 5232.607554433433, 5251.501107394792, 5256.658317209369, 5291.973540132275, 5297.761600727977, 5216.947830521722, 5224.92162617561, 5234.214867769865, 5239.476052394806, 5309.097453432925, 4269.060806622538, 4302.03204279041, 4425.114977004612, 4506.662000349987, 4508.458984921765, 3865.9613403866165, 3875.5736868944396, 3913.5890731473355, 3949.2891279569953, 3972.682185425159, 4454.888627784331, 4457.219986502414, 4470.552944705503, 4514.345419914094, 4516.774161291923, 4981.2030075187795, 5020.723860187724, 5250.291210686585, 5255.605829562722, 5274.551663108602, 4377.9781101094295, 4406.757628330409, 4414.028913638995, 4432.423784907941, 4454.420925279757, 4690.530946905282, 4697.577218050324, 4714.15145273854, 4720.527947205252, 4756.6670333077045, 4751.904961900812, 4877.585405240523, 4899.951000489949, 4913.091078150554, 4946.851594452172, 5153.7165455898785, 5197.7141257231215, 5207.0, 5246.3704355477585, 5285.656432331886, 4888.2178851383605, 4897.926531102107, 4901.117798796251, 4912.263160525949, 4936.333594964777, 4922.556969872729, 5165.535101840853, 5166.767495462638, 5169.741512924264, 5170.121079416433, 5182.32629758129, 5253.317068781034, 5257.658252213594, 5283.049051170672, 5355.277037599874, 5121.8463446096675, 5126.948730512796, 5129.512696293846, 5132.820351287687, 5157.819476318311, 4893.608511319015, 5106.540411362995, 5109.463506331782, 5114.795408183631, 5115.335006449287, 4886.853394398174, 4933.827316043921, 4940.75296235194, 4958.2810492477665, 5003.499650034967, 5046.318746969112, 5060.0, 5074.644774865872, 5076.593872490266, 5123.513266239701, 4807.0, 4855.684380515255, 4907.165781817171, 4958.603311735124, 4960.677555958851], "value": 4788.94568315593, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.7891069759538, 586.1149664007347, 588.3498733899041, 591.902336114541, 593.9168516407701, 28557.57163642547, 39490.210195796106, 40759.388609170885, 40804.59195408045, 44649.330260046125, 41184.382234266435, 41419.514829110274, 41576.58423415765, 41623.16753664925, 41674.37488437668, 7303.45224108194, 7602.961985190066, 7742.574158421285, 7750.224977502261, 7751.573663448508, 9556.761080972961, 9819.6072157114, 9849.852252216187, 10131.594736210543, 10141.797164056714, 9966.0, 10058.798824023515, 10062.295639305252, 10062.54718537664, 10072.093511583957, 9916.950415247913, 9947.651832185911, 9969.451680157588, 9994.200463962938, 9998.950005249928, 9822.066903644143, 9886.703398898044, 9889.258305627034, 9892.109710126051, 9897.851532227023, 37467.437988430196, 37626.0, 37715.62284377176, 37758.0, 37765.622343776486, 2994.970050299491, 3082.3835232953497, 3167.1448708848484, 3319.3859136059905, 3362.075429256974, 28760.568591471143, 29377.559336609967, 29864.40271194564, 29933.550996735066, 30392.0, 3216.404965081444, 3232.563603913489, 3321.618013928405, 3330.167458135466, 3362.83185840707, 241503.0, 242683.0, 242797.99999999822, 243968.99999999822, 244262.0, 29247.853760731487, 52060.47939520632, 52289.738551307, 52391.21413178805, 52411.47588524142, 31040.68959310423, 33006.50490242648, 33009.0, 33055.338893222004, 33066.338673226404, 11561.710957226136, 11720.17958742897, 11729.0, 11729.296242225493, 11731.47208375625, 8184.140665230184, 8814.250788682906, 8832.51421171829, 9163.358564900393, 9387.953060234791, 7835.49069310493, 7885.2114788520685, 7964.8805267921025, 7973.122956474783, 7987.3610111190965, 3082.9229269268, 3089.90730278092, 3120.8127512349333, 3149.9527507087414, 3157.826319552447, 847.4406891451613, 896.5616859344487, 943.8112377524385, 956.1585804492003, 959.1080295325274, 27890.581641275396, 28633.856830715715, 28858.855705721337, 29063.709362906524, 29247.56128658072, 901.197933838884, 949.8242825077383, 967.7580604848788, 968.2399316536485, 1008.7226012846379, 15296.694066118615, 15385.692286154439, 15390.384384624489, 15406.614834629225, 15681.372745090068, 391029.0, 395380.0, 396175.0, 396849.0, 398310.0, 49053.26420103701, 49615.50384496109, 49646.25530617044, 49728.75135624299, 49748.75125624421, 1069.198101423932, 1124.145649306533, 1156.219551802513, 1174.629991552658, 1198.1612870990168, 25692.87153564295, 29212.707872920997, 29574.556381654722, 29713.405731885672, 30159.396812064075, 42301.78849105735, 42906.78546607247, 43282.134357313305, 43397.0, 43443.782781085894, 288054.0, 290476.0, 290656.65403422405, 290880.0, 291067.0, 25418.618720718834, 25819.483610328065, 26071.73928260769, 26246.081387151356, 27127.59308610333, 42305.78847105868, 42588.787056064524, 42694.78652606717, 42807.785961069996, 43040.569594303655, 36483.45274820827, 36750.8162459186, 37115.628843711216, 37211.81394093012, 38617.806910965264, 36379.818100909324, 36431.27137457289, 36439.63560364363, 36501.63498365089, 36762.63237367699, 36463.088422789646, 36644.81677591595, 36693.0, 36705.26589468249, 37582.8120859394, 31881.840590797827, 33223.50494227717, 33399.49900751442, 33804.32391352209, 34119.65880341264, 25441.618375724007, 25631.871840640677, 25851.353716157246, 25924.61113083343, 25996.35009124787], "value": 16776.771805064524, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.70899039918163, 363.4530032301386, 366.6242101845608, 367.5075398965386, 386.1832224844455, 12820.551280705176, 16151.515454536353, 16226.350945962147, 17313.48059558212, 17547.912260438712, 14508.347124379401, 14588.197649129293, 14756.11463312202, 14818.481353152642, 14983.850161498382, 4896.167651499236, 5039.622028347871, 5137.101007323722, 5138.9743051284695, 5271.077561426754, 3453.4992426098324, 5227.764750586214, 5271.920921186166, 5273.209018647195, 5284.07528682479, 5091.796328146888, 5304.6286759926825, 5342.439043900393, 5400.135978243482, 5402.459754024586, 5151.330327057459, 5274.077036518633, 5369.24830523725, 5370.167624018264, 5380.838574842722, 5193.662411943212, 5194.766235519411, 5196.948030519684, 5198.2722418861385, 5198.870028249324, 11121.666350009513, 11581.826272605918, 11647.242929209575, 11681.0, 11902.047836173086, 1794.4885707573278, 1917.0, 2037.3480486244407, 2056.7120603115577, 2335.217702069792, 8867.246284065863, 8937.910620893774, 8965.462072275619, 9127.132922372364, 9454.57454414553, 1681.932722691091, 1687.12269619797, 1697.193832929361, 1782.2514543891596, 1790.8388245058006, 46682.0, 64153.0, 68277.0, 68835.0, 71338.64330678365, 9517.952410237904, 9786.657466988763, 9869.259805514472, 10096.980603879254, 10167.186625069977, 14106.717865642835, 14107.435702571987, 14113.717725645634, 14151.221682807338, 14178.14931104137, 6481.254655714653, 6512.73949042033, 6560.507961902877, 6625.569337993015, 6649.168853893263, 5651.660900345993, 5756.0502517084215, 5874.412558744091, 5909.881802363929, 5989.760409583568, 4242.575742425733, 4346.2828633275785, 4396.3625274335045, 4474.105178964221, 4491.258942274553, 1692.5091723400321, 1749.9300027998738, 1764.9470515884543, 1800.1809176824513, 1874.8968806715761, 690.6098054599136, 831.5052543736467, 833.3291700181412, 877.4779006491256, 891.6477991193442, 16327.18364081815, 16402.753958690628, 16969.83030169707, 17178.484645460656, 17327.047012414438, 828.0973738624807, 836.8117173636005, 841.5413599588239, 862.3273846399818, 869.4479005831342, 9163.496007719506, 9176.311776616647, 9960.651377201762, 10095.09144177013, 10451.634192803216, 419764.0, 421016.0, 421461.0, 430349.0, 430621.0, 50665.74667126641, 50878.0, 84172.57913710392, 84346.27438631153, 88932.0, 911.289194428347, 925.9629614815332, 931.6040682709821, 943.0811637980439, 944.6504793226413, 15081.472148474752, 15259.389624415344, 15636.4527241546, 15897.284622191797, 15918.522444326689, 38530.422043669925, 38803.24937617433, 39472.40791388074, 39967.40048899327, 40064.99837504086, 53366.46633533615, 54571.72714136404, 55363.16955245755, 55764.163537546156, 56712.86574268574, 7350.595717235603, 7459.589722565311, 7538.057742782153, 7632.244583745881, 7791.844163116592, 11757.882421175678, 11833.763324733629, 11886.643400697993, 11942.34317112567, 12283.0, 10020.849687254551, 10213.642522511676, 10332.380057196593, 10493.317934334244, 10535.104516116216, 10157.39055656663, 10369.948150259503, 10377.429241391494, 10520.526576303932, 10532.894671053498, 8916.894070950137, 9789.314747967574, 9914.603415863285, 9988.750281243027, 10277.588896444058, 7287.781366559012, 7408.073990751156, 7536.0, 7578.772636820904, 7614.428917831296, 8342.249197572248, 9717.514124293615, 9733.367331123454, 9799.657012004545, 10270.178385729274], "value": 7926.738763601573, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1351.108268542762, 1410.957671269862, 1448.326528164404, 1639.9016059036467, 1666.9916650416747, 7090.964545177273, 7700.037495313086, 7705.190954949734, 7709.961450192755, 7710.49881757686, 6490.091387205795, 6982.790516284507, 7182.784516464501, 7206.315400037001, 7529.849403011936, 2125.553633736917, 2157.4714195022243, 2160.384290477214, 2160.5138843760187, 2165.6859755335468, 2119.6502577074843, 2146.67799830026, 2183.061283648031, 2185.7814218578173, 2187.092356671987, 2141.4325203821, 2143.9571208575817, 2156.0836644426136, 2157.5037741319506, 2181.8581792183536, 2115.7461104667386, 2119.9894000530053, 2122.257209976511, 2122.9256976005922, 2125.2774056820676, 2066.7933206679213, 2109.535902101535, 2110.556783075556, 2112.5352422467186, 2115.3442432845713, 7363.116426028911, 7455.0, 7517.812054698622, 7580.4314676398935, 7583.696652133908, 4048.7773172475504, 4154.335306350999, 4158.0, 4162.292410290258, 4165.375193720935, 2704.391511909824, 2776.694563598003, 2832.122042166914, 2838.148555433382, 2839.801213915027, 855.5478155077826, 893.7542175901614, 919.1865199298602, 921.5208091792231, 927.5808013738923, 10275.383476991405, 10285.434301113435, 10289.536970836256, 10296.433696146709, 10317.123044541224, 3849.0762217067704, 3992.341263691458, 4026.7785271809744, 4176.686748493875, 4186.518550366747, 8701.869471957925, 8703.738887833248, 8708.477491350539, 8712.259457946018, 8728.083551227157, 4140.668746500272, 4145.3781932709735, 4151.522574903925, 4153.314703074019, 4161.417401563784, 3373.1061268763797, 3592.5329707137903, 3760.7743535387963, 3761.4357846322723, 3789.981050094787, 3588.7846729195808, 3670.3576874046935, 3777.338965680995, 3795.886123416302, 3799.0692280390926, 1170.5551890281808, 1218.8110842819199, 1226.9631911042684, 1229.7925224222543, 1242.4222736427605, 794.9920500794918, 798.7723498802814, 798.9800254993671, 816.4325793573528, 832.8292699996487, 4835.927461088087, 4897.2654101885, 4995.550400463976, 5048.242763585492, 5190.354384483557, 390.97458665186673, 393.5454549994761, 396.964273215412, 399.59840360438153, 411.07303031663406, 3326.9334613307597, 3385.4752513360468, 3391.7117045051446, 3432.1419645088727, 3437.295354452331, 8778.824423511622, 8997.055309192572, 9181.495017774087, 9216.986131525528, 9221.631134754669, 9026.819463610691, 9126.26989840811, 9126.315526335551, 9127.26981841451, 9157.084291570924, 6808.08090907731, 6818.011388348662, 6828.7268509259075, 6832.111825462757, 6854.074699915547, 5050.72221027847, 5102.1326374515675, 5177.611679124006, 5225.242339860622, 5353.304070470814, 8320.459170153921, 8464.915350846659, 8581.570921454027, 8584.613692383982, 8644.178803013956, 8338.082810890919, 8504.44721093127, 8552.615132319184, 8762.605682744419, 8840.823183536164, 5931.961906666403, 6421.165248517663, 6577.506686998398, 6810.897836532356, 6878.828029299308, 7136.892946605702, 7422.294881986203, 7422.554646720998, 7425.257474252748, 7431.071116110486, 6533.216014078151, 6576.375244351779, 6580.473562114924, 6670.9332906670315, 6719.731210751515, 6383.904241436289, 6476.643784591893, 6521.673916304071, 6576.901346479903, 6606.867862642816, 6135.662538560244, 6264.906026409699, 6267.4986001120715, 6271.749130034747, 6272.498200143887, 4393.045253420139, 4554.908901822011, 4562.58936695699, 4658.37111989877, 4660.4640466345445, 4390.868273951786, 4440.2229609817505, 4491.281394976788, 4653.511381304914, 4660.813567457264], "value": 3917.4387490173826, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.3494876323327, 294.4934712294853, 298.337690327473, 302.52654595557965, 304.04681324049125, 4800.423949126105, 4805.90388192236, 4832.130216561018, 4836.347093142429, 4855.03371134691, 4779.283107533872, 4784.0, 4784.282357646355, 4784.784684689189, 4791.496892826255, 3606.675399214064, 3696.1129328961124, 3709.8684901105153, 3761.664609063784, 3777.1501412182315, 3775.7168212384045, 3783.545974483066, 3790.431435284702, 3795.633571914109, 3799.9620003799882, 3746.569144548371, 3749.662530372266, 3755.906102347436, 3763.604821493745, 3764.5858955514873, 3509.842057107436, 3595.137167079908, 3628.3468975584383, 3692.390755525335, 3754.793486358249, 3324.3517514084765, 3326.8835590754206, 3344.7491438142238, 3348.5312056312137, 3351.329734053199, 4641.350210970467, 4657.4876763555985, 4659.95340046602, 4665.230237010889, 4696.9530304696855, 4202.331519485118, 4287.592678695519, 4324.286492728696, 4336.8698939031565, 4341.218580655481, 4943.6539442239055, 4950.975245123751, 4966.726830024347, 4986.376702912136, 5001.3998320201445, 3623.547056617923, 3634.3639863023864, 3637.5453068366455, 3656.0, 3667.21154951684, 5102.295783234855, 5234.110201265794, 5249.055170069386, 5253.9474605253845, 5258.395284542288, 3703.3889408247337, 3717.275131349361, 3723.1995121049104, 3733.9439908401396, 3736.308782875177, 3755.0, 3767.3972164453558, 3768.5491085931567, 3768.6419790119894, 3776.3202623527477, 4276.764777937244, 4279.465066866642, 4285.185814695198, 4289.849855255051, 4295.4415925929425, 4780.354652121989, 4941.555260026543, 4977.452480227172, 5023.492952114424, 5023.6985780853265, 1271.1165739810742, 1295.1387327427344, 1300.590314051071, 1308.717456892232, 1313.0, 808.8595080935852, 839.8955373683586, 841.772721365228, 855.7805127693013, 857.9742607721778, 3969.174179877231, 3970.4441378207075, 4192.0, 4254.595813397722, 4392.363107349416, 5092.821751238763, 5131.897362052738, 5139.254808052811, 5156.664816786897, 5169.638125331266, 4365.236083685342, 4388.956110438919, 4390.912181756411, 4397.362382454527, 4397.73613583186, 2594.6237795519546, 2710.5663093905273, 2722.203345791768, 2740.383413731934, 2752.1881045091745, 4817.253325734517, 4853.587445067209, 4863.686804562748, 4872.366592342973, 4872.585830204402, 5321.6540924839765, 5329.7068661224, 5341.172118321666, 5348.545373643206, 5351.866203344947, 4753.382060332135, 4822.204336284544, 4830.396200474941, 4843.975780121077, 4917.5082491751255, 5135.794568217229, 5151.098557752453, 5151.562117219928, 5153.072446959583, 5153.196381266676, 5039.748012599429, 5082.4409314976065, 5086.669366491315, 5086.898262034664, 5116.334876466036, 4646.953530464652, 4857.53853383928, 4867.245576935581, 4889.824028307369, 4934.669098358522, 3675.5114178757644, 3680.871169509054, 3691.7969511677115, 3691.8555247873246, 3696.77819330841, 5187.403448603459, 5190.8961820764125, 5202.635815492879, 5212.296339994204, 5226.843194704165, 4899.681520701143, 4992.450830408579, 4999.675021123615, 5026.84919452417, 5044.520770526794, 5038.193888977892, 5049.722265275445, 5069.467705890828, 5070.4929507049, 5071.822486212965, 4943.110240156806, 4969.4782047884455, 4975.502449754996, 4994.525520075587, 4999.250112483011, 4826.758662066813, 4846.781894814671, 5028.64799464034, 5071.746412679425, 5084.211947148198, 4831.106245344622, 4941.827036053721, 4950.203135228729, 4957.0, 4960.20636698141], "value": 3785.38326045977, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.7344288841576, 650.80150554081, 671.7178784910341, 730.6675462664485, 748.9812754681134, 12579.685507862296, 13368.532101376453, 13370.197788132695, 13389.0, 13401.7989730154, 12989.805152922714, 13178.011649126305, 13202.07585469015, 13210.0, 13226.338683065833, 627.3506920337452, 738.3613174603969, 747.3199388556415, 759.4721668440436, 772.9458937874351, 767.110152223421, 781.3670926549513, 783.1463704562026, 783.8667426537473, 785.8114052627357, 832.097174565597, 833.3583140981441, 833.6457005772553, 833.9499630022187, 834.8246868157664, 653.4739534674585, 794.5391672829803, 816.4162623724006, 824.027647376096, 824.5094168969483, 606.5784279925454, 608.5709574749791, 609.2962628164477, 609.34495417426, 609.5062998970848, 12890.291033993126, 12929.935350323189, 12935.417906194243, 12985.545505907248, 12998.805017924738, 11824.23142495735, 12063.0, 12347.259164450072, 12614.306213158272, 12851.357432128356, 11801.350925699084, 11925.582604608797, 11990.0, 12153.270803751802, 12261.325627090506, 3973.145773658677, 3974.841006359742, 3996.460477835484, 4095.1195492968855, 4096.877093687164, 68786.65606671985, 68954.0, 71368.99999999948, 73472.0, 73887.63056184739, 8907.465552066897, 9307.348485605942, 10081.49592520371, 10251.38491690501, 10415.427151506588, 17875.0, 18203.362882299058, 18371.357002504847, 18411.171497282656, 18476.630467390576, 6647.5679080860555, 6741.764038258638, 6789.864202715918, 6885.518013739091, 6915.616876624595, 3755.6619904208205, 3759.266942946154, 3781.5840257571645, 3826.942595861064, 3928.2143571285856, 2768.3771151490755, 2850.8432036238205, 2865.0, 2869.7704183665255, 2873.5258682317185, 458.91280656675127, 465.40893065806915, 467.28038820217165, 474.68433491727615, 474.93350930869013, 536.2037374498866, 558.0680263959198, 560.7925067724968, 582.4845012164266, 607.2075940897172, 7596.24037596247, 8092.3121534669035, 8144.714934977247, 8184.959075204586, 8400.873986890201, 583.1893667801759, 589.2163422647868, 605.8909396308619, 627.159606127791, 631.4537924695197, 3702.259548090393, 3838.558565764917, 3901.2197560488016, 3960.544537378181, 4009.4386785850006, 56674.43325566774, 58073.70963145157, 98801.01198988062, 106415.4679226599, 109749.0, 53378.0, 53440.0, 66767.66616166888, 92307.53846230726, 92361.53819230861, 48961.26558101631, 78837.0, 79442.60278698686, 81031.59484202541, 82960.0, 7184.784456466315, 7204.4956853019785, 7211.783646490614, 7312.378447831781, 7458.366038886756, 44356.33465498085, 44589.777051114535, 45411.545884540734, 46156.0, 46324.7683761579, 64392.67803660952, 69012.654936725, 70007.0, 70771.64614176896, 71343.0, 10234.846477302995, 10377.9481102594, 10456.58173673075, 11312.83030754523, 11459.31244125355, 13300.667483312995, 13604.591862244148, 13649.658758531115, 13649.727005460034, 14549.85450145485, 12322.137450378388, 12434.440450179583, 12672.112952093265, 13143.73712525725, 13164.210147391188, 11798.174127811315, 12239.877601223874, 12253.203541769757, 12406.25562466255, 12509.438461232892, 11903.285802851857, 12190.329531875832, 12402.441890115148, 12405.193662411913, 12468.750624987631, 9826.39113495115, 10425.218108641731, 10444.529996150039, 10471.10995565355, 10779.89220107789, 9299.535023248674, 9805.754856128653, 10147.238957078396, 10806.0, 10814.729631759268], "value": 6598.696799807317, "unit": "score"}], "name": "dromaeo_css", "value": 6296.661352904511, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 114.0, 114.0, 114.0, 115.0, 113.0, 114.0, 116.0, 113.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 122.0, 125.0, 176.0, 126.0, 124.0, 148.0, 120.0, 157.0, 122.0], "value": 136.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 161.0, 163.0, 163.0, 164.0, 161.0, 163.0, 162.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 114.0, 75.0, 77.0, 75.0, 76.0, 109.0, 76.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 110.0, 85.0, 85.0, 86.0, 118.0, 85.0, 86.0, 131.0], "value": 95.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 147.0, 146.0, 147.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 97.0, 94.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 63.0, 64.0, 63.0, 65.0, 62.0, 63.0, 63.0, 63.0], "value": 63.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 65.0, 66.0, 65.0, 65.0, 66.0, 65.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 79.0, 89.0, 79.0, 78.0, 80.0, 79.0, 78.0, 78.0], "value": 79.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 132.0, 130.0, 130.0, 131.0, 129.0, 128.0, 125.0, 175.0, 129.0], "value": 134.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 169.0, 175.0, 167.0, 173.0, 170.0, 168.0, 166.0, 164.0, 165.0], "value": 169.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 71.0, 74.0, 66.0, 69.0, 67.0, 70.0, 67.0, 77.0], "value": 69.6, "unit": "score"}], "name": "kraken", "value": 1530.0, "alertThreshold": 2.0}]} 07:38:36 INFO - Return code: 0 07:38:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:38:36 INFO - # TBPL SUCCESS # 07:38:36 INFO - Running post-action listener: _resource_record_post_action 07:38:36 INFO - [mozharness: 2016-08-04 14:38:36.763834Z] Finished run-tests step (success) 07:38:36 INFO - Running post-run listener: _resource_record_post_run 07:38:36 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 2555904; Write bytes: 539488256; Read time: 916; Write time: 574984 07:38:36 INFO - TinderboxPrint: CPU usage
13.0% 07:38:36 INFO - TinderboxPrint: I/O read bytes / time
2,555,904 / 916 07:38:36 INFO - TinderboxPrint: I/O write bytes / time
539,488,256 / 574,984 07:38:36 INFO - TinderboxPrint: CPU idle
8,345.1 (87.0%) 07:38:36 INFO - TinderboxPrint: CPU user
1,201.7 (12.5%) 07:38:36 INFO - TinderboxPrint: Swap in / out
0 / 0 07:38:36 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 253997056; Read time: 0; Write time: 299316 07:38:36 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 2547712; Write bytes: 285491200; Read time: 888; Write time: 275668 07:38:37 INFO - Running post-run listener: _upload_blobber_files 07:38:37 INFO - Blob upload gear active. 07:38:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:38:37 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:38:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:38:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:38:37 INFO - (blobuploader) - INFO - Open directory for files ... 07:38:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:38:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:38:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:38:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:38:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:38:38 INFO - (blobuploader) - INFO - Done attempting. 07:38:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:38:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:38:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:38:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:38:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:38:44 INFO - (blobuploader) - INFO - Done attempting. 07:38:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:38:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:38:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:38:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:38:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:38:45 INFO - (blobuploader) - INFO - Done attempting. 07:38:45 INFO - (blobuploader) - INFO - Iteration through files over. 07:38:45 INFO - Return code: 0 07:38:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:38:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:38:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/61ecebf047f6d30fd3dda39eed4e0553ee2bddcef037aed40fa52746ce43a7f82322f216385e0f19f89c8ae5ea4d106acf421609b827a5b75af44dda2e1df05d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9beedd74972e0ceb9a1cb4a3421a375409c59dcc50ba33c17283c684b259d46b9701988c639d82ef5981d1d9531d5f5b9bd15e5c561d7f8d41d3c4107afd05ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/665495599738c70d9dcd8c4218f2d44671e6f5162c16cf0c7db55549d93f9b580f96c68a7d64597702890f261614260c3ed424e035ce25c1f960068f60b2b56e"} 07:38:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:38:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:38:45 INFO - Contents: 07:38:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/61ecebf047f6d30fd3dda39eed4e0553ee2bddcef037aed40fa52746ce43a7f82322f216385e0f19f89c8ae5ea4d106acf421609b827a5b75af44dda2e1df05d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9beedd74972e0ceb9a1cb4a3421a375409c59dcc50ba33c17283c684b259d46b9701988c639d82ef5981d1d9531d5f5b9bd15e5c561d7f8d41d3c4107afd05ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/665495599738c70d9dcd8c4218f2d44671e6f5162c16cf0c7db55549d93f9b580f96c68a7d64597702890f261614260c3ed424e035ce25c1f960068f60b2b56e"} 07:38:45 INFO - Running post-run listener: copy_logs_to_upload_dir 07:38:45 INFO - Copying logs to upload dir... 07:38:45 INFO - mkdir: /builds/slave/test/build/upload/logs 07:38:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.273905 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-08-04 07:38:45.339720) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 07:38:45.342774) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1470318847.721522-1460001773 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/61ecebf047f6d30fd3dda39eed4e0553ee2bddcef037aed40fa52746ce43a7f82322f216385e0f19f89c8ae5ea4d106acf421609b827a5b75af44dda2e1df05d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9beedd74972e0ceb9a1cb4a3421a375409c59dcc50ba33c17283c684b259d46b9701988c639d82ef5981d1d9531d5f5b9bd15e5c561d7f8d41d3c4107afd05ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/665495599738c70d9dcd8c4218f2d44671e6f5162c16cf0c7db55549d93f9b580f96c68a7d64597702890f261614260c3ed424e035ce25c1f960068f60b2b56e"} build_url:https://queue.taskcluster.net/v1/task/BKMnkRQBREuwNfRyT1GtFQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011426 build_url: 'https://queue.taskcluster.net/v1/task/BKMnkRQBREuwNfRyT1GtFQ/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/61ecebf047f6d30fd3dda39eed4e0553ee2bddcef037aed40fa52746ce43a7f82322f216385e0f19f89c8ae5ea4d106acf421609b827a5b75af44dda2e1df05d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9beedd74972e0ceb9a1cb4a3421a375409c59dcc50ba33c17283c684b259d46b9701988c639d82ef5981d1d9531d5f5b9bd15e5c561d7f8d41d3c4107afd05ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/665495599738c70d9dcd8c4218f2d44671e6f5162c16cf0c7db55549d93f9b580f96c68a7d64597702890f261614260c3ed424e035ce25c1f960068f60b2b56e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 07:38:45.368472) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 07:38:45.368829) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1470318847.721522-1460001773 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004423 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 07:38:45.451391) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 07:38:45.451748) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 07:38:45.452069) ========= ========= Total master_lag: 0.18 =========