builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-021 starttime: 1469754984.97 results: success (0) buildid: 20160728170528 builduid: e2b9dd3d5c3e4ae084347786a3d78202 revision: 2932bdab2bf7872c9cddac95d5d327e3c51a2784 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 18:16:24.974638) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 18:16:24.975061) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 18:16:24.975360) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 18:16:24.990278) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 18:16:24.990558) ========= 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=df17445c3590ff7897617a0e00000225-1469754984.319590-728038812 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-28 18:16:25-- 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% 70.9M=0s 2016-07-28 18:16:25 (70.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.082376 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 18:16:25.087008) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 18:16:25.087331) ========= 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=df17445c3590ff7897617a0e00000225-1469754984.319590-728038812 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014663 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 18:16:25.136988) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-28 18:16:25.137342) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2932bdab2bf7872c9cddac95d5d327e3c51a2784 --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 2932bdab2bf7872c9cddac95d5d327e3c51a2784 --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=df17445c3590ff7897617a0e00000225-1469754984.319590-728038812 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-28 18:16:25,323 truncating revision to first 12 chars 2016-07-28 18:16:25,323 Setting DEBUG logging. 2016-07-28 18:16:25,323 attempt 1/10 2016-07-28 18:16:25,323 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2932bdab2bf7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-28 18:16:26,497 unpacking tar archive at: fx-team-2932bdab2bf7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.495947 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-28 18:16:26.647045) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 18:16:26.647376) ========= script_repo_revision: 2932bdab2bf7872c9cddac95d5d327e3c51a2784 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 18:16:26.647753) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 18:16:26.648011) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 18:16:26.658953) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-28 18:16:26.659355) ========= /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=df17445c3590ff7897617a0e00000225-1469754984.319590-728038812 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:16:26 INFO - MultiFileLogger online at 20160728 18:16:26 in /builds/slave/test 18:16:26 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 18:16:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:16:26 INFO - {'append_to_log': False, 18:16:26 INFO - 'base_work_dir': '/builds/slave/test', 18:16:26 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 18:16:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:16:26 INFO - 'branch': 'Fx-Team-Non-PGO', 18:16:26 INFO - 'buildbot_json_path': 'buildprops.json', 18:16:26 INFO - 'config_files': ('talos/linux_config.py',), 18:16:26 INFO - 'default_actions': ('clobber', 18:16:26 INFO - 'read-buildbot-config', 18:16:26 INFO - 'download-and-extract', 18:16:26 INFO - 'populate-webroot', 18:16:26 INFO - 'create-virtualenv', 18:16:26 INFO - 'install', 18:16:26 INFO - 'run-tests'), 18:16:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:16:26 INFO - 'download_minidump_stackwalk': True, 18:16:26 INFO - 'download_symbols': 'ondemand', 18:16:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:16:26 INFO - 'tooltool.py': '/tools/tooltool.py', 18:16:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:16:26 INFO - '/tools/misc-python/virtualenv.py')}, 18:16:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:16:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:16:26 INFO - 'installer_path': 'installer.exe', 18:16:26 INFO - 'log_level': 'info', 18:16:26 INFO - 'log_name': 'talos', 18:16:26 INFO - 'log_to_console': True, 18:16:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:16:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:16:26 INFO - 'opt_config_files': (), 18:16:26 INFO - 'pip_index': False, 18:16:26 INFO - 'sps_profile': False, 18:16:26 INFO - 'sps_profile_interval': 0, 18:16:26 INFO - 'suite': 'dromaeojs', 18:16:26 INFO - 'system_bits': '32', 18:16:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:16:26 INFO - 'title': 'talos-linux64-ix-021', 18:16:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:16:26 INFO - 'use_talos_json': True, 18:16:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:16:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:16:26 INFO - 'work_dir': 'build'} 18:16:26 INFO - [mozharness: 2016-07-29 01:16:26.935799Z] Running clobber step. 18:16:26 INFO - Running pre-action listener: _resource_record_pre_action 18:16:26 INFO - Running main action method: clobber 18:16:26 INFO - rmtree: /builds/slave/test/build 18:16:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:16:27 INFO - Running post-action listener: _resource_record_post_action 18:16:27 INFO - [mozharness: 2016-07-29 01:16:27.408691Z] Finished clobber step (success) 18:16:27 INFO - [mozharness: 2016-07-29 01:16:27.408793Z] Running read-buildbot-config step. 18:16:27 INFO - Running pre-action listener: _resource_record_pre_action 18:16:27 INFO - Running main action method: read_buildbot_config 18:16:27 INFO - Using buildbot properties: 18:16:27 INFO - { 18:16:27 INFO - "project": "", 18:16:27 INFO - "product": "firefox", 18:16:27 INFO - "script_repo_revision": "production", 18:16:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 18:16:27 INFO - "repository": "", 18:16:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 18:16:27 INFO - "buildid": "20160728170528", 18:16:27 INFO - "pgo_build": "False", 18:16:27 INFO - "basedir": "/builds/slave/test", 18:16:27 INFO - "buildnumber": 2036, 18:16:27 INFO - "slavename": "talos-linux64-ix-021", 18:16:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:16:27 INFO - "platform": "ubuntu64_hw", 18:16:27 INFO - "scheduler": "tests-fx-team-linux64-talos", 18:16:27 INFO - "branch": "fx-team", 18:16:27 INFO - "repo_path": "integration/fx-team", 18:16:27 INFO - "revision": "2932bdab2bf7872c9cddac95d5d327e3c51a2784", 18:16:27 INFO - "stage_platform": "linux64", 18:16:27 INFO - "builduid": "e2b9dd3d5c3e4ae084347786a3d78202", 18:16:27 INFO - "slavebuilddir": "test" 18:16:27 INFO - } 18:16:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/Swisj72CR1mdPCheLEzzDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 18:16:27 INFO - Running post-action listener: _resource_record_post_action 18:16:27 INFO - [mozharness: 2016-07-29 01:16:27.411244Z] Finished read-buildbot-config step (success) 18:16:27 INFO - [mozharness: 2016-07-29 01:16:27.411333Z] Running download-and-extract step. 18:16:27 INFO - Running pre-action listener: _resource_record_pre_action 18:16:27 INFO - Running main action method: download_and_extract 18:16:27 INFO - mkdir: /builds/slave/test/build/tests 18:16:27 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')]} 18:16:27 INFO - https://queue.taskcluster.net/v1/task/Swisj72CR1mdPCheLEzzDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:16:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Swisj72CR1mdPCheLEzzDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:16:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Swisj72CR1mdPCheLEzzDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:16:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Swisj72CR1mdPCheLEzzDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:16:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Swisj72CR1mdPCheLEzzDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:16:28 INFO - Downloaded 1361 bytes. 18:16:28 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:16:28 INFO - Using the following test package requirements: 18:16:28 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 18:16:28 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:16:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:16:28 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:16:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:16:28 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:16:28 INFO - u'jsshell-linux-x86_64.zip'], 18:16:28 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:16:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:16:28 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 18:16:28 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:16:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:16:28 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:16:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:16:28 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:16:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:16:28 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:16:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:16:28 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:16:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:28 INFO - https://queue.taskcluster.net/v1/task/Swisj72CR1mdPCheLEzzDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:16:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Swisj72CR1mdPCheLEzzDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:16:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Swisj72CR1mdPCheLEzzDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:16:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Swisj72CR1mdPCheLEzzDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:16:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Swisj72CR1mdPCheLEzzDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:16:28 INFO - Downloaded 22749779 bytes. 18:16:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:16:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:16:30 INFO - Return code: 0 18:16:30 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:16: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')]} 18:16:30 INFO - https://queue.taskcluster.net/v1/task/Swisj72CR1mdPCheLEzzDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:16:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Swisj72CR1mdPCheLEzzDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:16:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Swisj72CR1mdPCheLEzzDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:16:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Swisj72CR1mdPCheLEzzDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:16:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Swisj72CR1mdPCheLEzzDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:16:31 INFO - Downloaded 22749779 bytes. 18:16:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:16:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:16:33 INFO - Return code: 0 18:16: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')]} 18:16:33 INFO - https://queue.taskcluster.net/v1/task/Swisj72CR1mdPCheLEzzDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:16:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Swisj72CR1mdPCheLEzzDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:16:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Swisj72CR1mdPCheLEzzDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:16:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Swisj72CR1mdPCheLEzzDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:16:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Swisj72CR1mdPCheLEzzDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:16:34 INFO - Downloaded 14413725 bytes. 18:16:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:16:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 18:16:34 INFO - Return code: 0 18:16: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')]} 18:16:34 INFO - https://queue.taskcluster.net/v1/task/Swisj72CR1mdPCheLEzzDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:16:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Swisj72CR1mdPCheLEzzDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:16:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Swisj72CR1mdPCheLEzzDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:16:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Swisj72CR1mdPCheLEzzDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:16:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Swisj72CR1mdPCheLEzzDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:16:35 INFO - Downloaded 57165205 bytes. 18:16:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Swisj72CR1mdPCheLEzzDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:16:35 INFO - mkdir: /builds/slave/test/properties 18:16:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:16:35 INFO - Writing to file /builds/slave/test/properties/build_url 18:16:35 INFO - Contents: 18:16:35 INFO - build_url:https://queue.taskcluster.net/v1/task/Swisj72CR1mdPCheLEzzDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:16:36 INFO - Running post-action listener: _resource_record_post_action 18:16:36 INFO - Running post-action listener: set_extra_try_arguments 18:16:36 INFO - [mozharness: 2016-07-29 01:16:36.146385Z] Finished download-and-extract step (success) 18:16:36 INFO - [mozharness: 2016-07-29 01:16:36.146622Z] Running populate-webroot step. 18:16:36 INFO - Running pre-action listener: _resource_record_pre_action 18:16:36 INFO - Running main action method: populate_webroot 18:16:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:16:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:16:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:16:36 INFO - '--tppagecycles', 18:16:36 INFO - '7'], 18:16:36 INFO - 'tests': ['tsvgm']}}, 18:16:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:16:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:16:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:16:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:16:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:16:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:16:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:16:36 INFO - 'talos_options': ['--disable-e10s'], 18:16:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:16:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:16:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:16:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:16:36 INFO - 'talos_options': ['--disable-e10s'], 18:16:36 INFO - 'tests': ['damp', 'tps']}, 18:16:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:16:36 INFO - 'tests': ['damp', 'tps']}, 18:16:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:16:36 INFO - 'tests': ['dromaeo_dom']}, 18:16:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:16:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:16:36 INFO - 'tests': ['basic_compositor_video']}, 18:16:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:16:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:16:36 INFO - 'tests': ['a11yr', 18:16:36 INFO - 'ts_paint', 18:16:36 INFO - 'tpaint', 18:16:36 INFO - 'sessionrestore', 18:16:36 INFO - 'sessionrestore_no_auto_restore', 18:16:36 INFO - 'tabpaint']}, 18:16:36 INFO - 'other-e10s': {'tests': ['a11yr', 18:16:36 INFO - 'ts_paint', 18:16:36 INFO - 'tpaint', 18:16:36 INFO - 'sessionrestore', 18:16:36 INFO - 'sessionrestore_no_auto_restore', 18:16:36 INFO - 'tabpaint']}, 18:16:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:16:36 INFO - 'ts_paint', 18:16:36 INFO - 'tpaint', 18:16:36 INFO - 'sessionrestore', 18:16:36 INFO - 'sessionrestore_no_auto_restore', 18:16:36 INFO - 'tabpaint']}, 18:16:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:16:36 INFO - 'ts_paint', 18:16:36 INFO - 'tpaint', 18:16:36 INFO - 'sessionrestore', 18:16:36 INFO - 'sessionrestore_no_auto_restore', 18:16:36 INFO - 'tabpaint']}, 18:16:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:16:36 INFO - 'tests': ['a11yr', 18:16:36 INFO - 'ts_paint', 18:16:36 INFO - 'tpaint', 18:16:36 INFO - 'sessionrestore', 18:16:36 INFO - 'sessionrestore_no_auto_restore', 18:16:36 INFO - 'tabpaint']}, 18:16:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:16:36 INFO - 'tests': ['a11yr', 18:16:36 INFO - 'ts_paint', 18:16:36 INFO - 'tpaint', 18:16:36 INFO - 'sessionrestore', 18:16:36 INFO - 'sessionrestore_no_auto_restore', 18:16:36 INFO - 'tabpaint']}, 18:16:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:16:36 INFO - 'tests': ['tsvgx', 18:16:36 INFO - 'tsvgr_opacity', 18:16:36 INFO - 'tart', 18:16:36 INFO - 'tscrollx', 18:16:36 INFO - 'cart']}, 18:16:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:16:36 INFO - 'tsvgr_opacity', 18:16:36 INFO - 'tart', 18:16:36 INFO - 'tscrollx', 18:16:36 INFO - 'cart']}, 18:16:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:16:36 INFO - 'talos_options': ['--disable-e10s'], 18:16:36 INFO - 'tests': ['tp5o']}, 18:16:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:16:36 INFO - 'tests': ['tp5o']}, 18:16:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:16:36 INFO - 'talos_options': ['--disable-e10s', 18:16:36 INFO - '--xperf_path', 18:16:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:16:36 INFO - 'tests': ['tp5n']}, 18:16:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:16:36 INFO - 'talos_options': ['--xperf_path', 18:16:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:16:36 INFO - 'tests': ['tp5n']}}, 18:16:36 INFO - 'talos.zip': {'path': '', 18:16:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:16:36 INFO - Running post-action listener: _resource_record_post_action 18:16:36 INFO - [mozharness: 2016-07-29 01:16:36.162791Z] Finished populate-webroot step (success) 18:16:36 INFO - [mozharness: 2016-07-29 01:16:36.162881Z] Running create-virtualenv step. 18:16:36 INFO - Running pre-action listener: _resource_record_pre_action 18:16:36 INFO - Running main action method: create_virtualenv 18:16:36 INFO - Creating virtualenv /builds/slave/test/build/venv 18:16:36 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 18:16:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:16:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:16:36 INFO - Using real prefix '/usr' 18:16:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:16:36 INFO - Installing distribute.............................................................................................................................................................................................done. 18:16:38 INFO - Installing pip.................done. 18:16:38 INFO - Return code: 0 18:16:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:16:38 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')]} 18:16:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:16:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:38 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')]} 18:16:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:16:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:38 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 0x1e20030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20df3b0>, '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 0x20e02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e0740>, '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': 'df17445c3590ff7897617a0e00000225-1469754984.319590-728038812', '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 18:16:38 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 18:16:38 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 18:16:38 INFO - Using env: {'DISPLAY': ':0', 18:16:38 INFO - 'HOME': '/home/cltbld', 18:16:38 INFO - 'LANG': 'en_US.UTF-8', 18:16:38 INFO - 'LANGUAGE': 'en_US:en', 18:16:38 INFO - 'LOGNAME': 'cltbld', 18:16:38 INFO - 'MAIL': '/var/mail/cltbld', 18:16:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:38 INFO - 'MOZ_NO_REMOTE': '1', 18:16:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:16:38 INFO - 'NO_EM_RESTART': '1', 18:16:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:16:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:16:38 INFO - 'PWD': '/builds/slave/test', 18:16:38 INFO - 'SHELL': '/bin/bash', 18:16:38 INFO - 'SHLVL': '1', 18:16:38 INFO - 'TERM': 'linux', 18:16:38 INFO - 'TMOUT': '86400', 18:16:38 INFO - 'USER': 'cltbld', 18:16:38 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1469754984.319590-728038812', 18:16:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:38 INFO - '_': '/tools/buildbot/bin/python'} 18:16:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:16:39 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 18:16:39 INFO - Cleaning up... 18:16:39 INFO - Return code: 0 18:16:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:16:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:16:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:16:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:39 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 0x1e20030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20df3b0>, '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 0x20e02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e0740>, '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': 'df17445c3590ff7897617a0e00000225-1469754984.319590-728038812', '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 18:16:39 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 18:16:39 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 18:16:39 INFO - Using env: {'DISPLAY': ':0', 18:16:39 INFO - 'HOME': '/home/cltbld', 18:16:39 INFO - 'LANG': 'en_US.UTF-8', 18:16:39 INFO - 'LANGUAGE': 'en_US:en', 18:16:39 INFO - 'LOGNAME': 'cltbld', 18:16:39 INFO - 'MAIL': '/var/mail/cltbld', 18:16:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:39 INFO - 'MOZ_NO_REMOTE': '1', 18:16:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:16:39 INFO - 'NO_EM_RESTART': '1', 18:16:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:16:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:16:39 INFO - 'PWD': '/builds/slave/test', 18:16:39 INFO - 'SHELL': '/bin/bash', 18:16:39 INFO - 'SHLVL': '1', 18:16:39 INFO - 'TERM': 'linux', 18:16:39 INFO - 'TMOUT': '86400', 18:16:39 INFO - 'USER': 'cltbld', 18:16:39 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1469754984.319590-728038812', 18:16:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:39 INFO - '_': '/tools/buildbot/bin/python'} 18:16:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:16:39 INFO - Downloading/unpacking psutil>=3.1.1 18:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:16:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:16:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:16:41 INFO - Installing collected packages: psutil 18:16:41 INFO - Running setup.py install for psutil 18:16:41 INFO - building 'psutil._psutil_linux' extension 18:16:41 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 18:16:41 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 18:16:41 INFO - building 'psutil._psutil_posix' extension 18:16:41 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 18:16:41 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 18:16:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:16:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:16:41 INFO - Successfully installed psutil 18:16:41 INFO - Cleaning up... 18:16:41 INFO - Return code: 0 18:16:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:16:41 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')]} 18:16:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:16:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:41 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')]} 18:16:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:16:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e20030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20df3b0>, '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 0x20e02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e0740>, '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': 'df17445c3590ff7897617a0e00000225-1469754984.319590-728038812', '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 18:16:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:16:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:16:41 INFO - Using env: {'DISPLAY': ':0', 18:16:41 INFO - 'HOME': '/home/cltbld', 18:16:41 INFO - 'LANG': 'en_US.UTF-8', 18:16:41 INFO - 'LANGUAGE': 'en_US:en', 18:16:41 INFO - 'LOGNAME': 'cltbld', 18:16:41 INFO - 'MAIL': '/var/mail/cltbld', 18:16:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:41 INFO - 'MOZ_NO_REMOTE': '1', 18:16:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:16:41 INFO - 'NO_EM_RESTART': '1', 18:16:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:16:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:16:41 INFO - 'PWD': '/builds/slave/test', 18:16:41 INFO - 'SHELL': '/bin/bash', 18:16:41 INFO - 'SHLVL': '1', 18:16:41 INFO - 'TERM': 'linux', 18:16:41 INFO - 'TMOUT': '86400', 18:16:41 INFO - 'USER': 'cltbld', 18:16:41 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1469754984.319590-728038812', 18:16:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:41 INFO - '_': '/tools/buildbot/bin/python'} 18:16:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:16:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:16:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:16:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:16:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:16:43 INFO - Installing collected packages: mozsystemmonitor 18:16:43 INFO - Running setup.py install for mozsystemmonitor 18:16:44 INFO - Successfully installed mozsystemmonitor 18:16:44 INFO - Cleaning up... 18:16:44 INFO - Return code: 0 18:16:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:16:44 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')]} 18:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:16:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:44 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')]} 18:16:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:16:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:44 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 0x1e20030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20df3b0>, '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 0x20e02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e0740>, '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': 'df17445c3590ff7897617a0e00000225-1469754984.319590-728038812', '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 18:16:44 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 18:16:44 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 18:16:44 INFO - Using env: {'DISPLAY': ':0', 18:16:44 INFO - 'HOME': '/home/cltbld', 18:16:44 INFO - 'LANG': 'en_US.UTF-8', 18:16:44 INFO - 'LANGUAGE': 'en_US:en', 18:16:44 INFO - 'LOGNAME': 'cltbld', 18:16:44 INFO - 'MAIL': '/var/mail/cltbld', 18:16:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:44 INFO - 'MOZ_NO_REMOTE': '1', 18:16:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:16:44 INFO - 'NO_EM_RESTART': '1', 18:16:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:16:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:16:44 INFO - 'PWD': '/builds/slave/test', 18:16:44 INFO - 'SHELL': '/bin/bash', 18:16:44 INFO - 'SHLVL': '1', 18:16:44 INFO - 'TERM': 'linux', 18:16:44 INFO - 'TMOUT': '86400', 18:16:44 INFO - 'USER': 'cltbld', 18:16:44 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1469754984.319590-728038812', 18:16:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:44 INFO - '_': '/tools/buildbot/bin/python'} 18:16:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:16:44 INFO - Downloading/unpacking jsonschema==2.5.1 18:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:16:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:16:46 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 18:16:46 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 18:16:46 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 18:16:46 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 18:16:46 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 18:16:46 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 18:16:46 INFO - Downloading functools32-3.2.3-2.tar.gz 18:16:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:16:46 INFO - warning: no files found matching '*.txt' 18:16:46 INFO - no previously-included directories found matching 'build' 18:16:46 INFO - no previously-included directories found matching 'dist' 18:16:46 INFO - no previously-included directories found matching '.git*' 18:16:46 INFO - Installing collected packages: jsonschema, functools32 18:16:46 INFO - Running setup.py install for functools32 18:16:46 INFO - warning: no files found matching '*.txt' 18:16:46 INFO - no previously-included directories found matching 'build' 18:16:46 INFO - no previously-included directories found matching 'dist' 18:16:46 INFO - no previously-included directories found matching '.git*' 18:16:46 INFO - Successfully installed jsonschema functools32 18:16:46 INFO - Cleaning up... 18:16:46 INFO - Return code: 0 18:16:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:16:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:16:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:16:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:46 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 0x1e20030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20df3b0>, '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 0x20e02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e0740>, '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': 'df17445c3590ff7897617a0e00000225-1469754984.319590-728038812', '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 18:16:46 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 18:16:46 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 18:16:46 INFO - Using env: {'DISPLAY': ':0', 18:16:46 INFO - 'HOME': '/home/cltbld', 18:16:46 INFO - 'LANG': 'en_US.UTF-8', 18:16:46 INFO - 'LANGUAGE': 'en_US:en', 18:16:46 INFO - 'LOGNAME': 'cltbld', 18:16:46 INFO - 'MAIL': '/var/mail/cltbld', 18:16:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:46 INFO - 'MOZ_NO_REMOTE': '1', 18:16:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:16:46 INFO - 'NO_EM_RESTART': '1', 18:16:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:16:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:16:46 INFO - 'PWD': '/builds/slave/test', 18:16:46 INFO - 'SHELL': '/bin/bash', 18:16:46 INFO - 'SHLVL': '1', 18:16:46 INFO - 'TERM': 'linux', 18:16:46 INFO - 'TMOUT': '86400', 18:16:46 INFO - 'USER': 'cltbld', 18:16:46 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1469754984.319590-728038812', 18:16:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:46 INFO - '_': '/tools/buildbot/bin/python'} 18:16:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:16:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:16:46 INFO - Cleaning up... 18:16:46 INFO - Return code: 0 18:16:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:16:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:16:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:16:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:46 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 0x1e20030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20df3b0>, '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 0x20e02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e0740>, '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': 'df17445c3590ff7897617a0e00000225-1469754984.319590-728038812', '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 18:16:46 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 18:16:46 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 18:16:46 INFO - Using env: {'DISPLAY': ':0', 18:16:46 INFO - 'HOME': '/home/cltbld', 18:16:46 INFO - 'LANG': 'en_US.UTF-8', 18:16:46 INFO - 'LANGUAGE': 'en_US:en', 18:16:46 INFO - 'LOGNAME': 'cltbld', 18:16:46 INFO - 'MAIL': '/var/mail/cltbld', 18:16:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:46 INFO - 'MOZ_NO_REMOTE': '1', 18:16:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:16:46 INFO - 'NO_EM_RESTART': '1', 18:16:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:16:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:16:46 INFO - 'PWD': '/builds/slave/test', 18:16:46 INFO - 'SHELL': '/bin/bash', 18:16:46 INFO - 'SHLVL': '1', 18:16:46 INFO - 'TERM': 'linux', 18:16:46 INFO - 'TMOUT': '86400', 18:16:46 INFO - 'USER': 'cltbld', 18:16:46 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1469754984.319590-728038812', 18:16:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:46 INFO - '_': '/tools/buildbot/bin/python'} 18:16:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:16:47 INFO - Downloading/unpacking blobuploader==1.2.4 18:16:47 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 18:16:47 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 18:16:47 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 18:16:47 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 18:16:47 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 18:16:47 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 18:16:49 INFO - Downloading blobuploader-1.2.4.tar.gz 18:16:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:16:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:16:49 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 18:16:49 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 18:16:49 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 18:16:49 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 18:16:49 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 18:16:49 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 18:16:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:16:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:16:49 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 18:16:49 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 18:16:49 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 18:16:49 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 18:16:49 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 18:16:49 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 18:16:49 INFO - Downloading docopt-0.6.1.tar.gz 18:16:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:16:49 INFO - Installing collected packages: blobuploader, requests, docopt 18:16:49 INFO - Running setup.py install for blobuploader 18:16:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:16:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:16:49 INFO - Running setup.py install for requests 18:16:50 INFO - Running setup.py install for docopt 18:16:50 INFO - Successfully installed blobuploader requests docopt 18:16:50 INFO - Cleaning up... 18:16:50 INFO - Return code: 0 18:16:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:16: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')]} 18:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:16:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16: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')]} 18:16:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:16:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:50 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 0x1e20030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20df3b0>, '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 0x20e02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e0740>, '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': 'df17445c3590ff7897617a0e00000225-1469754984.319590-728038812', '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 18:16:50 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 18:16:50 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 18:16:50 INFO - Using env: {'DISPLAY': ':0', 18:16:50 INFO - 'HOME': '/home/cltbld', 18:16:50 INFO - 'LANG': 'en_US.UTF-8', 18:16:50 INFO - 'LANGUAGE': 'en_US:en', 18:16:50 INFO - 'LOGNAME': 'cltbld', 18:16:50 INFO - 'MAIL': '/var/mail/cltbld', 18:16:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:50 INFO - 'MOZ_NO_REMOTE': '1', 18:16:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:16:50 INFO - 'NO_EM_RESTART': '1', 18:16:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:16:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:16:50 INFO - 'PWD': '/builds/slave/test', 18:16:50 INFO - 'SHELL': '/bin/bash', 18:16:50 INFO - 'SHLVL': '1', 18:16:50 INFO - 'TERM': 'linux', 18:16:50 INFO - 'TMOUT': '86400', 18:16:50 INFO - 'USER': 'cltbld', 18:16:50 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1469754984.319590-728038812', 18:16:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:50 INFO - '_': '/tools/buildbot/bin/python'} 18:16:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:16:50 INFO - Running setup.py (path:/tmp/pip-TNWzhn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:16:50 INFO - Running setup.py (path:/tmp/pip-tR8ISp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:16:50 INFO - Running setup.py (path:/tmp/pip-go0b7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:16:50 INFO - Running setup.py (path:/tmp/pip-3qE2Re-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:16:50 INFO - Running setup.py (path:/tmp/pip-opRMTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:16:50 INFO - Running setup.py (path:/tmp/pip-ivnh9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:16:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:16:51 INFO - Running setup.py (path:/tmp/pip-dGjtUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:16:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:16:51 INFO - Running setup.py (path:/tmp/pip-nG_JTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:16:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:16:51 INFO - Running setup.py (path:/tmp/pip-DCYHe_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:16:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:16:51 INFO - Running setup.py (path:/tmp/pip-7Ll8hx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:16:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:16:51 INFO - Running setup.py (path:/tmp/pip-ZK94v_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:16:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:16:51 INFO - Running setup.py (path:/tmp/pip-JkU3vu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:16:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:16:51 INFO - Running setup.py (path:/tmp/pip-2_tuyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:16:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:16:51 INFO - Running setup.py (path:/tmp/pip-BwNGGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:16:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:16:51 INFO - Running setup.py (path:/tmp/pip-XUk654-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:16:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:16:51 INFO - Running setup.py (path:/tmp/pip-oXNTF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:16:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:16:51 INFO - Running setup.py (path:/tmp/pip-1_FRKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:16:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:16:51 INFO - Running setup.py install for manifestparser 18:16:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:16:51 INFO - Running setup.py install for mozcrash 18:16:52 INFO - Running setup.py install for mozdebug 18:16:52 INFO - Running setup.py install for mozdevice 18:16:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:16:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:16:52 INFO - Running setup.py install for mozfile 18:16:52 INFO - Running setup.py install for mozhttpd 18:16:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:16:52 INFO - Running setup.py install for mozinfo 18:16:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:16:52 INFO - Running setup.py install for mozInstall 18:16:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:16:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:16:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:16:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:16:52 INFO - Running setup.py install for mozleak 18:16:52 INFO - Running setup.py install for mozlog 18:16:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:16:52 INFO - Running setup.py install for moznetwork 18:16:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:16:52 INFO - Running setup.py install for mozprocess 18:16:53 INFO - Running setup.py install for mozprofile 18:16:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:16:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:16:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:16:53 INFO - Running setup.py install for mozrunner 18:16:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:16:53 INFO - Running setup.py install for mozscreenshot 18:16:53 INFO - Running setup.py install for moztest 18:16:53 INFO - Running setup.py install for mozversion 18:16:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:16:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:16:53 INFO - Cleaning up... 18:16:53 INFO - Return code: 0 18:16:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:16:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:16:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:16:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:53 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 0x1e20030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20df3b0>, '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 0x20e02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e0740>, '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': 'df17445c3590ff7897617a0e00000225-1469754984.319590-728038812', '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 18:16:53 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 18:16:53 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 18:16:53 INFO - Using env: {'DISPLAY': ':0', 18:16:53 INFO - 'HOME': '/home/cltbld', 18:16:53 INFO - 'LANG': 'en_US.UTF-8', 18:16:53 INFO - 'LANGUAGE': 'en_US:en', 18:16:53 INFO - 'LOGNAME': 'cltbld', 18:16:53 INFO - 'MAIL': '/var/mail/cltbld', 18:16:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:53 INFO - 'MOZ_NO_REMOTE': '1', 18:16:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:16:53 INFO - 'NO_EM_RESTART': '1', 18:16:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:16:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:16:53 INFO - 'PWD': '/builds/slave/test', 18:16:53 INFO - 'SHELL': '/bin/bash', 18:16:53 INFO - 'SHLVL': '1', 18:16:53 INFO - 'TERM': 'linux', 18:16:53 INFO - 'TMOUT': '86400', 18:16:53 INFO - 'USER': 'cltbld', 18:16:53 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1469754984.319590-728038812', 18:16:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:53 INFO - '_': '/tools/buildbot/bin/python'} 18:16:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:16:53 INFO - Running setup.py (path:/tmp/pip-svXdFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:16:53 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)) 18:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:16:53 INFO - Running setup.py (path:/tmp/pip-3qddWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:16:54 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)) 18:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:16:54 INFO - Running setup.py (path:/tmp/pip-GY4_Sd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:16:54 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)) 18:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:16:54 INFO - Running setup.py (path:/tmp/pip-_j6YU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:16:54 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)) 18:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:16:54 INFO - Running setup.py (path:/tmp/pip-dM3rmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:16:54 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)) 18:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:16:54 INFO - Running setup.py (path:/tmp/pip-F0Matt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:16:54 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)) 18:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:16:54 INFO - Running setup.py (path:/tmp/pip-WPGOtq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:16:54 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)) 18:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:16:54 INFO - Running setup.py (path:/tmp/pip-hn1a7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:16:54 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)) 18:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:16:54 INFO - Running setup.py (path:/tmp/pip-YiCaUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:16:54 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)) 18:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:16:54 INFO - Running setup.py (path:/tmp/pip-AjbtoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:16:54 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)) 18:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:16:54 INFO - Running setup.py (path:/tmp/pip-kpgXnY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:16:54 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)) 18:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:16:54 INFO - Running setup.py (path:/tmp/pip-MXH1Mt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:16:54 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)) 18:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:16:54 INFO - Running setup.py (path:/tmp/pip-H5W1Yp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:16:54 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)) 18:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:16:54 INFO - Running setup.py (path:/tmp/pip-k7eAkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:16:54 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)) 18:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:16:54 INFO - Running setup.py (path:/tmp/pip-Ox9P8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:16:54 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)) 18:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:16:54 INFO - Running setup.py (path:/tmp/pip-5DoXwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:16:55 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)) 18:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:16:55 INFO - Running setup.py (path:/tmp/pip-RQENS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:16:55 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)) 18:16:55 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)) 18:16:55 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)) 18:16:55 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)) 18:16:55 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)) 18:16:55 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)) 18:16:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:56 INFO - Downloading blessings-1.6.tar.gz 18:16:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:16:57 INFO - Installing collected packages: blessings 18:16:57 INFO - Running setup.py install for blessings 18:16:57 INFO - Successfully installed blessings 18:16:57 INFO - Cleaning up... 18:16:57 INFO - Return code: 0 18:16:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:16:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:16:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:16:57 INFO - Reading from file tmpfile_stdout 18:16:57 INFO - Current package versions: 18:16:57 INFO - argparse == 1.2.1 18:16:57 INFO - blessings == 1.6 18:16:57 INFO - blobuploader == 1.2.4 18:16:57 INFO - docopt == 0.6.1 18:16:57 INFO - functools32 == 3.2.3-2 18:16:57 INFO - jsonschema == 2.5.1 18:16:57 INFO - manifestparser == 1.1 18:16:57 INFO - mozInstall == 1.12 18:16:57 INFO - mozcrash == 0.17 18:16:57 INFO - mozdebug == 0.1 18:16:57 INFO - mozdevice == 0.48 18:16:57 INFO - mozfile == 1.2 18:16:57 INFO - mozhttpd == 0.7 18:16:57 INFO - mozinfo == 0.9 18:16:57 INFO - mozleak == 0.1 18:16:57 INFO - mozlog == 3.3 18:16:57 INFO - moznetwork == 0.27 18:16:57 INFO - mozprocess == 0.23 18:16:57 INFO - mozprofile == 0.28 18:16:57 INFO - mozrunner == 6.12 18:16:57 INFO - mozscreenshot == 0.1 18:16:57 INFO - mozsystemmonitor == 0.3 18:16:57 INFO - moztest == 0.7 18:16:57 INFO - mozversion == 1.4 18:16:57 INFO - psutil == 3.1.1 18:16:57 INFO - requests == 1.2.3 18:16:57 INFO - wsgiref == 0.1.2 18:16:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:16:57 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')]} 18:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:16:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:57 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')]} 18:16:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:16:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:57 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 0x1e20030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20df3b0>, '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 0x20e02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e0740>, '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': 'df17445c3590ff7897617a0e00000225-1469754984.319590-728038812', '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 18:16:57 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 18:16:57 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 18:16:57 INFO - Using env: {'DISPLAY': ':0', 18:16:57 INFO - 'HOME': '/home/cltbld', 18:16:57 INFO - 'LANG': 'en_US.UTF-8', 18:16:57 INFO - 'LANGUAGE': 'en_US:en', 18:16:57 INFO - 'LOGNAME': 'cltbld', 18:16:57 INFO - 'MAIL': '/var/mail/cltbld', 18:16:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:57 INFO - 'MOZ_NO_REMOTE': '1', 18:16:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:16:57 INFO - 'NO_EM_RESTART': '1', 18:16:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:16:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:16:57 INFO - 'PWD': '/builds/slave/test', 18:16:57 INFO - 'SHELL': '/bin/bash', 18:16:57 INFO - 'SHLVL': '1', 18:16:57 INFO - 'TERM': 'linux', 18:16:57 INFO - 'TMOUT': '86400', 18:16:57 INFO - 'USER': 'cltbld', 18:16:57 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1469754984.319590-728038812', 18:16:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:57 INFO - '_': '/tools/buildbot/bin/python'} 18:16:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:16:57 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)) 18:16:57 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)) 18:16:57 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)) 18:16:57 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)) 18:16:57 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)) 18:16:57 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)) 18:16:57 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)) 18:16:57 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)) 18:16:57 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)) 18:16:57 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)) 18:16:57 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)) 18:16:57 INFO - Cleaning up... 18:16:57 INFO - Return code: 0 18:16:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:16:57 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')]} 18:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:16:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:57 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')]} 18:16:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:16:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:57 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 0x1e20030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20df3b0>, '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 0x20e02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e0740>, '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': 'df17445c3590ff7897617a0e00000225-1469754984.319590-728038812', '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 18:16:57 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 18:16:57 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 18:16:57 INFO - Using env: {'DISPLAY': ':0', 18:16:57 INFO - 'HOME': '/home/cltbld', 18:16:57 INFO - 'LANG': 'en_US.UTF-8', 18:16:57 INFO - 'LANGUAGE': 'en_US:en', 18:16:57 INFO - 'LOGNAME': 'cltbld', 18:16:57 INFO - 'MAIL': '/var/mail/cltbld', 18:16:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:57 INFO - 'MOZ_NO_REMOTE': '1', 18:16:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:16:57 INFO - 'NO_EM_RESTART': '1', 18:16:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:16:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:16:57 INFO - 'PWD': '/builds/slave/test', 18:16:57 INFO - 'SHELL': '/bin/bash', 18:16:57 INFO - 'SHLVL': '1', 18:16:57 INFO - 'TERM': 'linux', 18:16:57 INFO - 'TMOUT': '86400', 18:16:57 INFO - 'USER': 'cltbld', 18:16:57 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1469754984.319590-728038812', 18:16:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:57 INFO - '_': '/tools/buildbot/bin/python'} 18:16:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:16:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:16:57 INFO - Cleaning up... 18:16:57 INFO - Return code: 0 18:16:57 INFO - Running post-action listener: _resource_record_post_action 18:16:57 INFO - Running post-action listener: _start_resource_monitoring 18:16:58 INFO - Starting resource monitoring. 18:16:58 INFO - [mozharness: 2016-07-29 01:16:58.019374Z] Finished create-virtualenv step (success) 18:16:58 INFO - [mozharness: 2016-07-29 01:16:58.019856Z] Running install step. 18:16:58 INFO - Running pre-action listener: _resource_record_pre_action 18:16:58 INFO - Running main action method: install 18:16:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:16:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:16:58 INFO - Reading from file tmpfile_stdout 18:16:58 INFO - Detecting whether we're running mozinstall >=1.0... 18:16:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:16:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:16:58 INFO - Reading from file tmpfile_stdout 18:16:58 INFO - Output received: 18:16:58 INFO - Usage: mozinstall [options] installer 18:16:58 INFO - Options: 18:16:58 INFO - -h, --help show this help message and exit 18:16:58 INFO - -d DEST, --destination=DEST 18:16:58 INFO - Directory to install application into. [default: 18:16:58 INFO - "/builds/slave/test"] 18:16:58 INFO - --app=APP Application being installed. [default: firefox] 18:16:58 INFO - mkdir: /builds/slave/test/build/application 18:16:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:16:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:17:14 INFO - Reading from file tmpfile_stdout 18:17:14 INFO - Output received: 18:17:14 INFO - /builds/slave/test/build/application/firefox/firefox 18:17:14 INFO - Running post-action listener: _resource_record_post_action 18:17:14 INFO - [mozharness: 2016-07-29 01:17:14.792872Z] Finished install step (success) 18:17:14 INFO - [mozharness: 2016-07-29 01:17:14.793149Z] Running run-tests step. 18:17:14 INFO - Running pre-action listener: _resource_record_pre_action 18:17:14 INFO - Running main action method: run_tests 18:17:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:17:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:17:14 INFO - Python 2.7.3 18:17:14 INFO - Return code: 0 18:17:14 INFO - grabbing minidump binary from tooltool 18:17:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:17:14 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20df3b0>, '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 0x20e02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e0740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:17:14 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:17:14 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:17:14 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 18:17:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:17:14 INFO - Return code: 0 18:17:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:17:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:17:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:17:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:17:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:17:14 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/Swisj72CR1mdPCheLEzzDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 18:17:14 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/Swisj72CR1mdPCheLEzzDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --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 18:17:14 INFO - Using env: {'DISPLAY': ':0', 18:17:14 INFO - 'HOME': '/home/cltbld', 18:17:14 INFO - 'LANG': 'en_US.UTF-8', 18:17:14 INFO - 'LANGUAGE': 'en_US:en', 18:17:14 INFO - 'LOGNAME': 'cltbld', 18:17:14 INFO - 'MAIL': '/var/mail/cltbld', 18:17:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:17:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:17:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:14 INFO - 'MOZ_NO_REMOTE': '1', 18:17:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:17:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:17:14 INFO - 'NO_EM_RESTART': '1', 18:17:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:17:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:14 INFO - 'PWD': '/builds/slave/test', 18:17:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:17:14 INFO - 'SHELL': '/bin/bash', 18:17:14 INFO - 'SHLVL': '1', 18:17:14 INFO - 'TERM': 'linux', 18:17:14 INFO - 'TMOUT': '86400', 18:17:14 INFO - 'USER': 'cltbld', 18:17:14 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1469754984.319590-728038812', 18:17:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:14 INFO - '_': '/tools/buildbot/bin/python'} 18:17:14 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/Swisj72CR1mdPCheLEzzDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 18:17:15 INFO - mozversion application_buildid: 20160728170528 18:17:15 INFO - mozversion application_changeset: 2932bdab2bf7872c9cddac95d5d327e3c51a2784 18:17:15 INFO - mozversion application_display_name: Nightly 18:17:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:17:15 INFO - mozversion application_name: Firefox 18:17:15 INFO - mozversion application_remotingname: firefox 18:17:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:17:15 INFO - mozversion application_vendor: Mozilla 18:17:15 INFO - mozversion application_version: 50.0a1 18:17:15 INFO - mozversion platform_buildid: 20160728170528 18:17:15 INFO - mozversion platform_changeset: 2932bdab2bf7872c9cddac95d5d327e3c51a2784 18:17:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:17:15 INFO - mozversion platform_version: 50.0a1 18:17:15 INFO - using testdate: 1469755035 18:17:15 INFO - actual date: 1469755035 18:17:15 INFO - starting webserver on 'localhost:52300' 18:17:15 INFO - SUITE-START | Running 2 tests 18:17:15 INFO - TEST-START | dromaeo_css 18:17:15 INFO - operating with platform_type : linux_ 18:17:15 INFO - Initialising browser for dromaeo_css test... 18:17:15 INFO - TEST-INFO | started process 16190 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbd5MMy/profile http://localhost:52300/getInfo.html) 18:17:19 INFO - PROCESS | 16190 | JavaScript error: , line 0: uncaught exception: undefined 18:17:20 INFO - PROCESS | 16190 | __metrics Screen width/height:1600/1200 18:17:20 INFO - PROCESS | 16190 | colorDepth:24 18:17:20 INFO - PROCESS | 16190 | Browser inner width/height: 1024/697 18:17:20 INFO - PROCESS | 16190 | __metrics 18:17:21 INFO - PROCESS | 16190 | 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" 18:17:21 INFO - PROCESS | 16190 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:17:22 INFO - TEST-INFO | 16190: exit 0 18:17:22 INFO - Browser initialized. 18:17:22 INFO - Running cycle 1/1 for dromaeo_css test... 18:17:22 INFO - TEST-INFO | started process 16269 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbd5MMy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:17:34 INFO - PROCESS | 16269 | RSS: Main: 159203328 18:17:34 INFO - PROCESS | 16269 | 18:18:26 INFO - PROCESS | 16269 | 1469755106028 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] 18:20:37 INFO - PROCESS | 16269 | Cycle 1(1): loaded http://localhost:52300/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52300/tests/dromaeo/cssquery-ext.html) 18:20:39 INFO - PROCESS | 16269 | RSS: Main: 280719360 18:20:39 INFO - PROCESS | 16269 | 18:23:41 INFO - PROCESS | 16269 | Cycle 1(1): loaded http://localhost:52300/tests/dromaeo/cssquery-ext.html (next: http://localhost:52300/tests/dromaeo/cssquery-jquery.html) 18:23:42 INFO - PROCESS | 16269 | RSS: Main: 247861248 18:23:42 INFO - PROCESS | 16269 | 18:26:44 INFO - PROCESS | 16269 | Cycle 1(1): loaded http://localhost:52300/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52300/tests/dromaeo/cssquery-mootools.html) 18:26:45 INFO - PROCESS | 16269 | RSS: Main: 189669376 18:26:45 INFO - PROCESS | 16269 | 18:29:47 INFO - PROCESS | 16269 | Cycle 1(1): loaded http://localhost:52300/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52300/tests/dromaeo/cssquery-prototype.html) 18:29:48 INFO - PROCESS | 16269 | RSS: Main: 199450624 18:29:48 INFO - PROCESS | 16269 | 18:32:51 INFO - PROCESS | 16269 | Cycle 1(1): loaded http://localhost:52300/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52300/tests/dromaeo/cssquery-yui.html) 18:32:51 INFO - PROCESS | 16269 | RSS: Main: 190824448 18:32:51 INFO - PROCESS | 16269 | 18:35:54 INFO - PROCESS | 16269 | Cycle 1(1): loaded http://localhost:52300/tests/dromaeo/cssquery-yui.html (next: http://localhost:52300/tests/dromaeo/cssquery-dojo.html) 18:35:54 INFO - PROCESS | 16269 | RSS: Main: 284254208 18:35:54 INFO - PROCESS | 16269 | 18:35:54 INFO - PROCESS | 16269 | __start_tp_report 18:35:54 INFO - PROCESS | 16269 | _x_x_mozilla_page_load 18:35:54 INFO - PROCESS | 16269 | _x_x_mozilla_page_load_details 18:35:54 INFO - PROCESS | 16269 | |i|pagename|runs| 18:35:54 INFO - PROCESS | 16269 | |0;dojo.html;2572.5240830446382;2589.585666293393;2603.2710840964533;2605.5961325994454;2617.1232637066582;4530.524294949032;4582.312653102036;4652.53474652535;4674.27548729947;4674.602658774004;4614.4462664480225;4657.278121891112;4668.5564871337165;4680.789364478598;4721.433427988638;4244.702870799046;4248.447701798762;4286.5284818669925;4289.678274129445;4352.281873490871;4303.505096913848;4351.0862718829085;4354.9765805035795;4378.956210437903;4415.425994620711;4183.5398106208595;4209.137126888981;4376.387305777193;4392.121575684876;4437.84467543636;4282.914341713179;4330.935035974463;4339.327404252346;4344.500382455994;4403.559644035603;4309.095090031097;4314.546972567867;4319.589638984291;4359.629431498326;4368.191884501346;4569.405977222939;4691.319758635013;4704.317873908299;4714.7642617869315;4766;4852.757362131879;4998.050370429607;5053.9241911371355;5054.1407960646775;5136.845894623168;5112.872178195575;5159.380874295071;5168.9224661630105;5171.974140129313;5173.663711858717;4746.264329029006;4752.97810970643;4756.6432517561325;4801.519848015206;4802.975985120122;5064.215046667772;5067.797288108434;5081.212412076134;5095.414027386824;5117.590592752571;4900.852974410702;4943.3573635427165;4949.82675606352;4950.975245123751;4951.851444456672;5014.448410674823;5022.422421421583;5061.974690126526;5069.949300507022;5072.568831649277;4838.782254798542;4944.752762361867;4946.3817022872145;5029.823956161516;5042.168042273057;5018.89962200754;5028.195488721787;5060.418051924003;5075.807185311449;5076.670016448919;4251.277282861921;4276.807543660543;4286.314189729628;4286.721363111388;4329.134173165379;3627.746057775983;3639.8180090995343;3710.8144592770254;3715.8142092895246;3739.551253849501;4193;4278.657707383401;4306.935395969063;4313;4347.652187824967;5042.722650254198;5045;5049.974750126299;5082.313887625197;5085.084684756779;4330.783460826946;4334.718243314174;4337.501187363494;4376.956230437719;4386.627136693353;4391.824327026883;4472.9105417892115;4476.35092911526;4507.504174540798;4571.451425828922;4719.480857105647;4720.268358404453;4736.9052618946735;4764.833230836974;4779.617630589614;4995.450500444876;4997.525235102659;5005.249212618136;5014.623903207347;5053.772580233972;4618.0994706032;4700.318453824245;4714.952850471452;4733.9763301183275;4757.7621118943225;4936.8765780855765;4944.8763780905765;4952.851414457572;4969.254611808113;5016.924746128738;5013.874653133555;5017.247412888096;5021.924671130009;5027.994401119718;5069.543741063322;4746.145693775154;4870.878228044327;4890.975545122252;4906.705597664151;4927.088488629615;4890.975545122252;4907.645406180787;4909.631777616764;4911.214205727067;4944.1100601892;4797.592204662503;4803.135435621622;4842.709437433625;4860.732659703609;4870.512948705101;4782.545658162469;4866.440359358719;4896.387951506062;4900.558949694545;4969.428515720594;4765.785539650655;4790;4794.376731024944;4801.879953001063;4826.6621336506105 18:35:54 INFO - PROCESS | 16269 | |1;ext.html;573.4552175433338;585.0054906658679;593.1725243285616;595.1667665268626;597.5160120302555;26842.194734157983;29614.111576652682;29666.11001669948;29858.402831943375;38495.61504384955;36012.27975440496;39546;39574.20851582967;39600;39663;7426.517276377018;7554.622268886561;7558.2063883292285;7561.470697051209;7565.205653406396;7654.923450765505;7733.265339792711;7739.110002349717;7750;7755.457118001742;7724.9227507725045;7759.534427934342;7765.689372425124;7769.728059517918;7775.766726998199;7722.768316950473;7723.691052357955;7727.652255648453;7755.612219389008;7756.767296981099;7679.078510578711;7763.883541746878;7768.417368697314;7769.067711874554;7769.145394006655;36414.27171456556;36649.63350366489;36758.63241367579;36759.26481470383;36803.63196368056;3088.81467111974;3150.322680623654;3306.8842590509457;3394.321135772855;3768.3028639701743;26329.605055924178;26564.46871062568;27254.727452725416;30859.69140308613;31027.689723102932;3444.8277586120594;3461.3769521486124;3495.6853883150384;3600.1719604491113;3692.759970601929;257209;258196;258869;259181;260344;31117.68882311193;31941.68058319387;53329.73335133377;53701.731491342296;53713.46286537163;32503.349933001682;32775.18062048468;32814.17964550905;32836.83581582124;32859.50710739341;13109.344532773322;13255.270960097094;13261.010848372629;13269;13270.336483175803;11038;11159.386233757059;11205.551777928955;11248.775024499464;11263.211575189822;7768.53388796674;7778.844423111506;7826.882596761053;7871.645775940096;7879.172686867911;3063.6629970703207;3077.153782709728;3079.5534647475993;3101.7518598512065;3139.450596145711;843.1147295339869;866.5623859950811;883.6774577279247;906.4244204929917;941.538646063424;27735.081600223846;27856.44287114287;27886.216443244717;28169.859150704116;28293.57559636607;940.3276657190141;982.8574856645746;1004.492731170754;1026.6714651311509;1048.6224959014748;14307;15099.698006040038;15111.697766044617;15373.692526149414;15392.384304627913;417995;418047;419189;419274;419997;48455.75772121117;48793;49102.50897491051;49228;49297.753511232215;1077.4289626497812;1163.1450883600546;1185.5554167187304;1194.6296648039136;1198.8801119887942;27564.173074807786;28964.13107606775;29455.26361840971;29516.409671806872;29848.104556863327;42019.36970945377;42495.57504424916;42555.148897022504;42570.36144457898;42576.78711606546;318035;320863;321341;322173;322389;22567.66148507741;24275;25097.749022509543;25215.117470888432;25256.873715631304;41138.177236455704;41274;41514.58485415107;41792.3731144027;41973;34882.127946801535;35468.46797297991;35501;35600.821995889855;35860.462093068105;34845.477317839745;34987;35418;35588;35703;34899.65100348964;35277.11807204738;35759.82120089487;35789.82105089562;36045.819770902024;30964.535531966587;32424.513632296006;32754;32776.34447310993;33034.504482432305;24820.751792481846;25150.49699005973;25154.74845251524;25237.621435678113;25423 18:35:54 INFO - PROCESS | 16269 | |2;jquery.html;345.2990429428261;349.79187383506803;356.49377883405543;367.3369567929887;370.10434747910057;15914.681706365865;16682.165891705412;17033.97796132233;17130.657386852286;17138.22877970491;15970.680586388295;16365.181740912936;16977.915110424463;17136.914315428407;17137.485875423725;4862.197737373329;5098.872528186806;5108.540231379176;5113.565346945514;5114.516790130858;3632.6548977847197;3815.828287727059;5070.2141168119;5798.739056742456;6044.818655440344;6135.110408990694;6140.324564297924;6146.5390095743;6147.262328520584;6148.200733904586;5846.181534585162;5931.1696362509065;5957.957357462448;5958.851028724316;5964.7912323068485;4652.185867473212;5307.601929855237;5340.465953404668;5351.973240133813;5355.919661205085;11653.883461165364;12240;12266.75466490674;12290.75418491634;12294.508219671203;1810.257794304342;1862.8044055374125;1901.7717873855227;1912.7800302965197;1944.0765636322774;9167.633294668205;9456.290778191595;12338.568150114703;12650.114491985565;13046.869531304661;1701.455534229047;1747.0042076016675;1753.3687872365938;1754.508737553487;1763.5150333658219;63945;68915.65542172307;70864;71629;72063;9568.95215523918;9882.11061004513;9886;9930.950345248228;10102.797944041225;13351.265680387673;13435.328233588281;13444.596662100153;13479.730405392034;13479.797803032963;5780.572159692939;5891.7054147292465;5919.940800592025;6388.680565971776;7354.595497247703;6819.31806819324;6876.346747059021;6923.134608173978;7063.293670632896;7102.076730025167;4145.66834653227;4150.501939767187;4156.750594964312;4250.55369186231;4278.700490965664;1604.3261830031415;1683.1836559268745;1707.3000069971251;1710.6065604910941;1838.669039572863;819.5451524403894;837.9036410812713;846.6655671009917;878.8022694893598;934.5794392523392;16308.592285192964;16439.342426303054;16712.49862504127;16849.663006739796;17498.825011749974;828.9295409890107;833.9374546908884;859.862422012475;869.0614136732314;883.7172104926361;9392.530373481299;9440.433573985583;9714;9723.367981081206;9900.207983361313;324666;327633;328897;420876;425985;51342.48657513377;67388;86960;87717;87958.56020719855;899.8020435504178;924.5746956399997;945.3807755919746;951.4671783801093;968.8885778135464;14831.11013339203;15426.30581623852;15445.459408920633;15478.690426191639;15896.523104306889;37908.43137352887;39047.21905561816;39368.80315598404;39657;39891.40162897617;55317;56851.01021464229;57009.714951424976;57223.713881430325;57920.131198032905;7365.079365079365;7572.5835079068975;7852.568108754073;7901.762947111596;10354.689359319233;11249.156313276373;12387.380630968595;12467.31429771335;12771.361431928552;13412.664683382993;10714.464276785973;10840.67477975662;10953;11261.66215013551;11269.71825704364;10406.219533534864;10528.94710528941;10627.787444251226;10855.782884342427;11134.888651113386;10293.43386113741;10797.838032429363;10870.673879783619;11151.498182581641;11189.328640281608;11153.776924461303;11221.887781122085;11582.189246752647;11812.822807658064;11923.165378423773;10930.836037459603;11097.278676885977;11229.382383968634;11309.604163854226;11361 18:35:54 INFO - PROCESS | 16269 | |3;mootools.html;1341.6377578053925;1403.4736973634886;1415.4833485777694;1660.1616183827173;1661.5181597336773;7451.6274186290675;7925.801854953629;7926.088499822507;7931.643076061577;7945.562994035333;6733.865322693543;7218.927810721892;7431.777046688608;7468.178500364969;7741.806454838617;2151.150295633228;2172.4134483689395;2173.3588591365506;2177.825773938081;2181.1275489804048;2180.4003898927763;2220.245116660335;2236.317923033482;2238.2837492002564;2245.6631505274177;2202.218212534551;2203.6253836847773;2214.6013717530836;2219.5782801267706;2237.7090978172814;2124.2777455665073;2126.9361919142452;2130.2970019893396;2132.040581738224;2133.370655656585;2025.2506572568243;2094.8114669679803;2096.75887272964;2099.5066159452517;2104.2214380679093;7843.803904902366;7907.486013409168;7914.169012253746;7915.802104947423;7931.444798864082;4503.549645035503;4614.123316569841;4619.9076018479445;4622.237330840408;4624.3988281523525;2820.6615206175184;2899.6810350861388;2928.9853550732323;2932.2669332666833;2961.31889665376;872.3370238618633;915.7756349694301;935.9298052646079;936.4147407870081;936.6347124621403;10256.487175641263;10318.122959548447;10335.844962325571;10337.74155646115;10362.533685984148;4013.3979903014197;4178.6865985051245;4281.550437204111;4319.805608747614;4334.891627709332;8820.382573219813;8842.513661748666;8847.911520884709;8848.690295839615;8850.247728943112;4646.512116227815;4648.1865673507;4650.720956742539;4651.046535460223;4652.488226295105;3687.4468829675225;4116.58834116586;4231.132617813402;4236.597523235288;4268.295731204316;3600.4779307000863;3652.926941461156;3802.372608519563;3804.543454785388;3810.399632154502;1173.647905628308;1193.2840295822436;1208.0999655256715;1220.2373516552154;1220.2983284611385;716.4698123388655;869.626060793852;872.3457406944791;875.8598624220094;889.9288056955428;5189.42916279209;5391.272178255886;5535.114381698909;5543.196236545678;5622.212890195376;405.1673810319762;405.7829061452109;411.8599676110137;412.2579357157105;420.2330746387793;3667.7982710951155;3753.155540003477;3754.5494540655295;3786.545614526219;3789.7536660117003;9345.672901448552;9703.175230105378;9782.315237933277;9795.412275263507;9801.705948821547;9644.276679249084;9668.468234247042;9754.853677194847;9769.804603907882;9776.462294573867;7332.9266707332245;7358.7424440145405;7362.116546014619;7385.372243359375;7408.888866667005;5462.781488740406;5490.313710786152;5683.175939488834;5709.9714501427225;5855.268091488564;8911.287097032351;8984.595693193953;9004.819903602021;9005.63977440895;9076.591553379982;8452.957735211285;8736.650533978569;8742.562871856255;8997.910020899708;9010.684626038057;5872.677002764889;6487.0593763903025;6584.8353791155605;6598.076269322202;6599.241087275025;7402.629868506661;7410.703571857065;7487.775366739006;7518.436117291116;7530.736424225126;6821.420179284816;6864.4554975130195;6869.793906182823;6874.450043996569;7077.929220707727;6482.448991835747;6542.672866356568;6607.636579988147;6617.933820661732;6656.134702488645;6339.651319177489;6611.636360000246;6611.867762644816;6621.238557565749;6623.138991931018;4580.175568397721;4639.48965613789;4671.18254305502;4758.310045043519;4824.0834241494;4546.9545304547855;4639.443266808004;4695.389599352063;4735.644826637947;4791.904161916812 18:35:54 INFO - PROCESS | 16269 | |4;prototype.html;289.94925887969606;290.27286646949386;296.6632871690631;303.8541500079963;304.7561950439648;4822.831200907969;4848.587870031051;4851.22380419133;4864.805407783684;4900.868122366773;4583.129205450962;4629;4660.394148760664;4681.88295292617;4844.619283504202;3697.759645623026;3702.2040261343805;3727.8881633551036;3765.8493660253557;3772.735908486407;3756.887293381203;3789.109559253573;3798.620137986207;3799.0122568132347;3838.558565764931;3696.297703436352;3745.8314375853015;3780.584135745066;3792.3932170852668;3792.58281589025;3762.5673047599603;3772.5472943246714;3779.4330850372526;3782.205736795276;3787.2993496203153;3303.487959366278;3327.7670563060597;3360.294338188983;3361.3277344530948;3377.9155521111925;4633.884152896171;4683.367745354368;4698.671093023489;4707;4739.0758802033615;4139.482564679415;4284.721493102938;4288.24955632763;4293.677974151919;4320.546342634009;4957.652964292501;4971.6271279654175;4988.725620090893;4996.350474438336;5005.1491246488185;3656.5246517952496;3669.3578623741005;3674.81625918703;3679.5400574928135;3688.3360995020885;5115.181570948667;5200.583953283691;5215.895682086375;5240.187770895517;5277.261183434322;3747.1381582235695;3752.1182522107283;3755.6432138946757;3759.93565244325;3763.1344790697744;3821.121142137324;3829.291581057513;3829.904252393657;3847.942280865789;3851.78815165163;4327.307630779061;4327.978360108179;4328.11273688893;4332.913341733148;4339.262325404688;4921.040397122527;5001.374828146481;5017.046761115376;5030.748462576857;5033;1308.1366298243304;1319.8812106910232;1320.8150858879765;1323.5235315286488;1326.4163767942075;853.3913572914976;868.3400615532241;899.4333569850952;916.4272329793879;928.3176865004217;4354.738715677069;4362.629176520031;4372.562743725665;4372.595072709997;4379.978100109479;5089.847304580869;5114.948850511521;5127.79488820443;5146.353166986603;5171.224316352502;4144.316187829035;4317.395564620955;4344.847930322487;4363.2364336241035;4376.518582955872;2710.7966902482;2712.416830381438;2715.5655095184675;2720.387912719662;2722.727727227301;4848.200046992207;4850.369451971221;4859.07677541266;4871.244957031666;4890.119778439844;5032.672876263031;5200.97399513;5220.843374698765;5259.8422047338645;5270.973645131827;4798.856034318976;4806.2310030394965;4807.423109226916;4822.204336284544;4830.203016502238;5060.038592667382;5062;5086.898262034664;5087.796488140433;5125.846224613268;4866.467062875183;4989.750512474435;5016.172331565251;5105.157648987875;5136.229565565195;4919.4834542373965;4920.434150072644;4920.6555541111775;4933.309336692794;4946.752662366939;3652;3683.134463401045;3686.391745361985;3686.668199862025;3708.8145592719716;5051.494850514919;5158.484151584811;5190.506901844319;5220.295260139985;5228.268042473981;4978;5022.974885125551;5036.924446133385;5040.57155141817;5055.317532133115;5019.799208031784;5045.268436076675;5077.543021127968;5123.795048198031;5140.640155189101;4879.127141249937;4933.407991041098;4976.527229913152;5004.224345226496;5036.445990941067;4883.6325828768;4965.155923493087;5069.5666080280935;5079.974600126976;5084.847454576368;4973;4977.253411988231;4982.377202849644;4982.4768399317545;4988.551030407136 18:35:54 INFO - PROCESS | 16269 | |5;yui.html;623.5385814497272;658.6180015590954;662.9801105966823;663.7643636509039;709.2411120101492;12331.136820422564;13292.667683307911;13388.93305533471;13425.127366721157;13450.192988420702;12962.546310879121;13133.27766972816;13147.342632868365;13172.34138293084;13175.472981080746;627.9058141278822;750.3884334267555;757.8294883651162;778.6846327237478;785.9646315915769;765.0245936431039;778.6690656471005;779.0806847919453;779.6803310642638;780.7657702689199;839.4417712221396;841.1168273313027;841.5203334099566;841.7727213652311;841.9242268195861;659.9043138744903;791.7189397763826;827.611022819274;829.340674164038;830.2942498875938;598.2312728144313;604.2869414091371;604.3714536881638;604.4710877981765;604.5798170271663;13225.735485290337;13250.403731832092;13273.601791946257;13285.003624728184;13289.202647841064;13410;13528.526501572398;13802.65493362664;13814.102083364549;13902.51341203053;10602.46987650622;10699.83950240747;10972.670819875417;11011.119110471223;11328.207025508136;3272.132884785534;3318.303156337172;3350.6984371406447;3419.452887538007;3427.5886893572683;59475.70262148661;59587;59834;63485.36514634887;63695.363046369406;10457.738556536147;10577.259591828499;10695.465226738632;10757.623483178051;10946.343219406703;20161.39515814528;20182.09180586877;20197.293094741613;20228.69656955147;20238.797612023693;6736.292689267654;6811.693473793691;7050.823729406806;7117.217106118426;7117.4306055515435;3573.6247693992277;3688.8524459021874;3722.4788529605876;3786.3941769316775;3880.2821478026653;2765.612814206013;2871.2821794551364;2887.307046308913;2887.4080813433197;2887.696791836827;472.91487532244525;476.6520440078762;479.1782093709305;482.1682597519321;491.1086378223513;513.2122192434595;516.51963673783;532.4622131646987;535.344203350892;541.7183064806279;6657.700403481855;7082.362587367162;7168.53404528704;7281.1262648482525;7470.663820128108;517.5445607865055;553.4189101443468;554.0802268234711;560.1234068682498;562.2830890614417;3305.454599991023;3335.216224187314;3439.4133349210742;3496.5804103507744;3593.6765691087926;91879;94164.52917735367;94438.52780736053;95446.52276738572;95468;48927;49092;49588;53249.73375133177;81865;65227.347726523076;68020;73202;73579;74791;6469.320721324193;6657.007284369312;6718.7312507499155;6863;6871.828204294932;32602.51096233511;40259.59740402558;43066.354004690584;45192.54807451883;45484;36897.81551092227;37639.62360376361;38028.809855950545;38539.42190867083;42467.36298955456;9481;9484.668036618685;9707.805843883225;9711.5144242789;9860.506974651382;9821.705348839547;9824.312298139348;9851.556679949563;9885;9899.059589339002;9107.271418286653;9276.907230927603;9451.858222126812;9484.146426821619;9778.951105244712;9322.533873306444;9549.761255968378;9846.753831154278;9884;11314.60398886035;11017.669469915916;11566.074714023027;11853.703657408634;12393.504259829506;12768;9705.757356066155;9861.112499875046;9869.309148359545;10529.052385285055;10718;8273.83452330938;8480.194381533744;8636.740897772825;8700.303975681803;8789.165029322205 18:35:54 INFO - PROCESS | 16269 | __end_tp_report 18:35:54 INFO - PROCESS | 16269 | __start_cc_report 18:35:54 INFO - PROCESS | 16269 | _x_x_mozilla_cycle_collect,1197 18:35:54 INFO - PROCESS | 16269 | __end_cc_report 18:35:54 INFO - PROCESS | 16269 | __startTimestamp1469756154927__endTimestamp 18:35:54 INFO - PROCESS | 16269 | 18:35:54 INFO - PROCESS | 16269 | ------- Summary: start ------- 18:35:54 INFO - PROCESS | 16269 | Number of tests: 6 18:35:54 INFO - PROCESS | 16269 | 18:35:54 INFO - PROCESS | 16269 | [#0] dojo.html Cycles:165 Average:4641.27 Median:4765.79 stddev:493.48 (10.4%) stddev-sans-first:467.55 18:35:54 INFO - PROCESS | 16269 | Values: 2572.5 2589.6 2603.3 2605.6 2617.1 4530.5 4582.3 4652.5 4674.3 4674.6 4614.4 4657.3 4668.6 4680.8 4721.4 4244.7 4248.4 4286.5 4289.7 4352.3 4303.5 4351.1 4355.0 4379.0 4415.4 4183.5 4209.1 4376.4 4392.1 4437.8 4282.9 4330.9 4339.3 4344.5 4403.6 4309.1 4314.5 4319.6 4359.6 4368.2 4569.4 4691.3 4704.3 4714.8 4766.0 4852.8 4998.1 5053.9 5054.1 5136.8 5112.9 5159.4 5168.9 5172.0 5173.7 4746.3 4753.0 4756.6 4801.5 4803.0 5064.2 5067.8 5081.2 5095.4 5117.6 4900.9 4943.4 4949.8 4951.0 4951.9 5014.4 5022.4 5062.0 5069.9 5072.6 4838.8 4944.8 4946.4 5029.8 5042.2 5018.9 5028.2 5060.4 5075.8 5076.7 4251.3 4276.8 4286.3 4286.7 4329.1 3627.7 3639.8 3710.8 3715.8 3739.6 4193.0 4278.7 4306.9 4313.0 4347.7 5042.7 5045.0 5050.0 5082.3 5085.1 4330.8 4334.7 4337.5 4377.0 4386.6 4391.8 4472.9 4476.4 4507.5 4571.5 4719.5 4720.3 4736.9 4764.8 4779.6 4995.5 4997.5 5005.2 5014.6 5053.8 4618.1 4700.3 4715.0 4734.0 4757.8 4936.9 4944.9 4952.9 4969.3 5016.9 5013.9 5017.2 5021.9 5028.0 5069.5 4746.1 4870.9 4891.0 4906.7 4927.1 4891.0 4907.6 4909.6 4911.2 4944.1 4797.6 4803.1 4842.7 4860.7 4870.5 4782.5 4866.4 4896.4 4900.6 4969.4 4765.8 4790.0 4794.4 4801.9 4826.7 18:35:54 INFO - PROCESS | 16269 | 18:35:54 INFO - PROCESS | 16269 | [#1] ext.html Cycles:180 Average:46910.76 Median:35347.56 stddev:89784.60 (254.0%) stddev-sans-first:89969.06 18:35:54 INFO - PROCESS | 16269 | Values: 573.5 585.0 593.2 595.2 597.5 26842.2 29614.1 29666.1 29858.4 38495.6 36012.3 39546.0 39574.2 39600.0 39663.0 7426.5 7554.6 7558.2 7561.5 7565.2 7654.9 7733.3 7739.1 7750.0 7755.5 7724.9 7759.5 7765.7 7769.7 7775.8 7722.8 7723.7 7727.7 7755.6 7756.8 7679.1 7763.9 7768.4 7769.1 7769.1 36414.3 36649.6 36758.6 36759.3 36803.6 3088.8 3150.3 3306.9 3394.3 3768.3 26329.6 26564.5 27254.7 30859.7 31027.7 3444.8 3461.4 3495.7 3600.2 3692.8 257209.0 258196.0 258869.0 259181.0 260344.0 31117.7 31941.7 53329.7 53701.7 53713.5 32503.3 32775.2 32814.2 32836.8 32859.5 13109.3 13255.3 13261.0 13269.0 13270.3 11038.0 11159.4 11205.6 11248.8 11263.2 7768.5 7778.8 7826.9 7871.6 7879.2 3063.7 3077.2 3079.6 3101.8 3139.5 843.1 866.6 883.7 906.4 941.5 27735.1 27856.4 27886.2 28169.9 28293.6 940.3 982.9 1004.5 1026.7 1048.6 14307.0 15099.7 15111.7 15373.7 15392.4 417995.0 418047.0 419189.0 419274.0 419997.0 48455.8 48793.0 49102.5 49228.0 49297.8 1077.4 1163.1 1185.6 1194.6 1198.9 27564.2 28964.1 29455.3 29516.4 29848.1 42019.4 42495.6 42555.1 42570.4 42576.8 318035.0 320863.0 321341.0 322173.0 322389.0 22567.7 24275.0 25097.7 25215.1 25256.9 41138.2 41274.0 41514.6 41792.4 41973.0 34882.1 35468.5 35501.0 35600.8 35860.5 34845.5 34987.0 35418.0 35588.0 35703.0 34899.7 35277.1 35759.8 35789.8 36045.8 30964.5 32424.5 32754.0 32776.3 33034.5 24820.8 25150.5 25154.7 25237.6 25423.0 18:35:54 INFO - PROCESS | 16269 | 18:35:54 INFO - PROCESS | 16269 | [#2] jquery.html Cycles:180 Average:23846.18 Median:21431.52 stddev:61159.42 (285.4%) stddev-sans-first:61305.54 18:35:54 INFO - PROCESS | 16269 | Values: 345.3 349.8 356.5 367.3 370.1 15914.7 16682.2 17034.0 17130.7 17138.2 15970.7 16365.2 16977.9 17136.9 17137.5 4862.2 5098.9 5108.5 5113.6 5114.5 3632.7 3815.8 5070.2 5798.7 6044.8 6135.1 6140.3 6146.5 6147.3 6148.2 5846.2 5931.2 5958.0 5958.9 5964.8 4652.2 5307.6 5340.5 5352.0 5355.9 11653.9 12240.0 12266.8 12290.8 12294.5 1810.3 1862.8 1901.8 1912.8 1944.1 9167.6 9456.3 12338.6 12650.1 13046.9 1701.5 1747.0 1753.4 1754.5 1763.5 63945.0 68915.7 70864.0 71629.0 72063.0 9569.0 9882.1 9886.0 9931.0 10102.8 13351.3 13435.3 13444.6 13479.7 13479.8 5780.6 5891.7 5919.9 6388.7 7354.6 6819.3 6876.3 6923.1 7063.3 7102.1 4145.7 4150.5 4156.8 4250.6 4278.7 1604.3 1683.2 1707.3 1710.6 1838.7 819.5 837.9 846.7 878.8 934.6 16308.6 16439.3 16712.5 16849.7 17498.8 828.9 833.9 859.9 869.1 883.7 9392.5 9440.4 9714.0 9723.4 9900.2 324666.0 327633.0 328897.0 420876.0 425985.0 51342.5 67388.0 86960.0 87717.0 87958.6 899.8 924.6 945.4 951.5 968.9 14831.1 15426.3 15445.5 15478.7 15896.5 37908.4 39047.2 39368.8 39657.0 39891.4 55317.0 56851.0 57009.7 57223.7 57920.1 7365.1 7572.6 7852.6 7901.8 10354.7 11249.2 12387.4 12467.3 12771.4 13412.7 10714.5 10840.7 10953.0 11261.7 11269.7 10406.2 10528.9 10627.8 10855.8 11134.9 10293.4 10797.8 10870.7 11151.5 11189.3 11153.8 11221.9 11582.2 11812.8 11923.2 10930.8 11097.3 11229.4 11309.6 11361.0 18:35:54 INFO - PROCESS | 16269 | 18:35:54 INFO - PROCESS | 16269 | [#3] mootools.html Cycles:180 Average:5135.37 Median:5290.35 stddev:2863.59 (54.1%) stddev-sans-first:2857.43 18:35:54 INFO - PROCESS | 16269 | Values: 1341.6 1403.5 1415.5 1660.2 1661.5 7451.6 7925.8 7926.1 7931.6 7945.6 6733.9 7218.9 7431.8 7468.2 7741.8 2151.2 2172.4 2173.4 2177.8 2181.1 2180.4 2220.2 2236.3 2238.3 2245.7 2202.2 2203.6 2214.6 2219.6 2237.7 2124.3 2126.9 2130.3 2132.0 2133.4 2025.3 2094.8 2096.8 2099.5 2104.2 7843.8 7907.5 7914.2 7915.8 7931.4 4503.5 4614.1 4619.9 4622.2 4624.4 2820.7 2899.7 2929.0 2932.3 2961.3 872.3 915.8 935.9 936.4 936.6 10256.5 10318.1 10335.8 10337.7 10362.5 4013.4 4178.7 4281.6 4319.8 4334.9 8820.4 8842.5 8847.9 8848.7 8850.2 4646.5 4648.2 4650.7 4651.0 4652.5 3687.4 4116.6 4231.1 4236.6 4268.3 3600.5 3652.9 3802.4 3804.5 3810.4 1173.6 1193.3 1208.1 1220.2 1220.3 716.5 869.6 872.3 875.9 889.9 5189.4 5391.3 5535.1 5543.2 5622.2 405.2 405.8 411.9 412.3 420.2 3667.8 3753.2 3754.5 3786.5 3789.8 9345.7 9703.2 9782.3 9795.4 9801.7 9644.3 9668.5 9754.9 9769.8 9776.5 7332.9 7358.7 7362.1 7385.4 7408.9 5462.8 5490.3 5683.2 5710.0 5855.3 8911.3 8984.6 9004.8 9005.6 9076.6 8453.0 8736.7 8742.6 8997.9 9010.7 5872.7 6487.1 6584.8 6598.1 6599.2 7402.6 7410.7 7487.8 7518.4 7530.7 6821.4 6864.5 6869.8 6874.5 7077.9 6482.4 6542.7 6607.6 6617.9 6656.1 6339.7 6611.6 6611.9 6621.2 6623.1 4580.2 4639.5 4671.2 4758.3 4824.1 4547.0 4639.4 4695.4 4735.6 4791.9 18:35:54 INFO - PROCESS | 16269 | 18:35:54 INFO - PROCESS | 16269 | [#4] prototype.html Cycles:180 Average:4182.46 Median:4806.83 stddev:1196.43 (24.9%) stddev-sans-first:1163.57 18:35:54 INFO - PROCESS | 16269 | Values: 289.9 290.3 296.7 303.9 304.8 4822.8 4848.6 4851.2 4864.8 4900.9 4583.1 4629.0 4660.4 4681.9 4844.6 3697.8 3702.2 3727.9 3765.8 3772.7 3756.9 3789.1 3798.6 3799.0 3838.6 3696.3 3745.8 3780.6 3792.4 3792.6 3762.6 3772.5 3779.4 3782.2 3787.3 3303.5 3327.8 3360.3 3361.3 3377.9 4633.9 4683.4 4698.7 4707.0 4739.1 4139.5 4284.7 4288.2 4293.7 4320.5 4957.7 4971.6 4988.7 4996.4 5005.1 3656.5 3669.4 3674.8 3679.5 3688.3 5115.2 5200.6 5215.9 5240.2 5277.3 3747.1 3752.1 3755.6 3759.9 3763.1 3821.1 3829.3 3829.9 3847.9 3851.8 4327.3 4328.0 4328.1 4332.9 4339.3 4921.0 5001.4 5017.0 5030.7 5033.0 1308.1 1319.9 1320.8 1323.5 1326.4 853.4 868.3 899.4 916.4 928.3 4354.7 4362.6 4372.6 4372.6 4380.0 5089.8 5114.9 5127.8 5146.4 5171.2 4144.3 4317.4 4344.8 4363.2 4376.5 2710.8 2712.4 2715.6 2720.4 2722.7 4848.2 4850.4 4859.1 4871.2 4890.1 5032.7 5201.0 5220.8 5259.8 5271.0 4798.9 4806.2 4807.4 4822.2 4830.2 5060.0 5062.0 5086.9 5087.8 5125.8 4866.5 4989.8 5016.2 5105.2 5136.2 4919.5 4920.4 4920.7 4933.3 4946.8 3652.0 3683.1 3686.4 3686.7 3708.8 5051.5 5158.5 5190.5 5220.3 5228.3 4978.0 5023.0 5036.9 5040.6 5055.3 5019.8 5045.3 5077.5 5123.8 5140.6 4879.1 4933.4 4976.5 5004.2 5036.4 4883.6 4965.2 5069.6 5080.0 5084.8 4973.0 4977.3 4982.4 4982.5 4988.6 18:35:54 INFO - PROCESS | 16269 | 18:35:54 INFO - PROCESS | 16269 | [#5] yui.html Cycles:180 Average:15772.51 Median:561.20 stddev:22154.17 (3947.6%) stddev-sans-first:22187.11 18:35:54 INFO - PROCESS | 16269 | Values: 623.5 658.6 663.0 663.8 709.2 12331.1 13292.7 13388.9 13425.1 13450.2 12962.5 13133.3 13147.3 13172.3 13175.5 627.9 750.4 757.8 778.7 786.0 765.0 778.7 779.1 779.7 780.8 839.4 841.1 841.5 841.8 841.9 659.9 791.7 827.6 829.3 830.3 598.2 604.3 604.4 604.5 604.6 13225.7 13250.4 13273.6 13285.0 13289.2 13410.0 13528.5 13802.7 13814.1 13902.5 10602.5 10699.8 10972.7 11011.1 11328.2 3272.1 3318.3 3350.7 3419.5 3427.6 59475.7 59587.0 59834.0 63485.4 63695.4 10457.7 10577.3 10695.5 10757.6 10946.3 20161.4 20182.1 20197.3 20228.7 20238.8 6736.3 6811.7 7050.8 7117.2 7117.4 3573.6 3688.9 3722.5 3786.4 3880.3 2765.6 2871.3 2887.3 2887.4 2887.7 472.9 476.7 479.2 482.2 491.1 513.2 516.5 532.5 535.3 541.7 6657.7 7082.4 7168.5 7281.1 7470.7 517.5 553.4 554.1 560.1 562.3 3305.5 3335.2 3439.4 3496.6 3593.7 91879.0 94164.5 94438.5 95446.5 95468.0 48927.0 49092.0 49588.0 53249.7 81865.0 65227.3 68020.0 73202.0 73579.0 74791.0 6469.3 6657.0 6718.7 6863.0 6871.8 32602.5 40259.6 43066.4 45192.5 45484.0 36897.8 37639.6 38028.8 38539.4 42467.4 9481.0 9484.7 9707.8 9711.5 9860.5 9821.7 9824.3 9851.6 9885.0 9899.1 9107.3 9276.9 9451.9 9484.1 9779.0 9322.5 9549.8 9846.8 9884.0 11314.6 11017.7 11566.1 11853.7 12393.5 12768.0 9705.8 9861.1 9869.3 10529.1 10718.0 8273.8 8480.2 8636.7 8700.3 8789.2 18:35:54 INFO - PROCESS | 16269 | -------- Summary: end -------- 18:35:54 INFO - PROCESS | 16269 | 18:35:55 INFO - TEST-INFO | 16269: exit 0 18:35:55 INFO - TEST-OK | dromaeo_css | took 1120751ms 18:35:55 INFO - TEST-START | kraken 18:35:55 INFO - operating with platform_type : linux_ 18:35:55 INFO - Initialising browser for kraken test... 18:35:55 INFO - TEST-INFO | started process 16457 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGyLWBy/profile http://localhost:52300/getInfo.html) 18:36:00 INFO - PROCESS | 16457 | JavaScript error: , line 0: uncaught exception: undefined 18:36:01 INFO - PROCESS | 16457 | __metrics Screen width/height:1600/1200 18:36:01 INFO - PROCESS | 16457 | colorDepth:24 18:36:01 INFO - PROCESS | 16457 | Browser inner width/height: 1024/697 18:36:01 INFO - PROCESS | 16457 | __metrics 18:36:01 INFO - PROCESS | 16457 | 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" 18:36:01 INFO - PROCESS | 16457 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:36:03 INFO - TEST-INFO | 16457: exit 0 18:36:03 INFO - Browser initialized. 18:36:03 INFO - Running cycle 1/1 for kraken test... 18:36:03 INFO - TEST-INFO | started process 16533 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGyLWBy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:36:15 INFO - PROCESS | 16533 | RSS: Main: 159719424 18:36:15 INFO - PROCESS | 16533 | 18:36:17 INFO - PROCESS | 16533 | Cycle 1(1): loaded http://localhost:52300/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52300/tests/kraken/driver.html?testName=audio-beat-detection) 18:36:18 INFO - PROCESS | 16533 | RSS: Main: 215576576 18:36:18 INFO - PROCESS | 16533 | 18:36:21 INFO - PROCESS | 16533 | Cycle 1(1): loaded http://localhost:52300/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52300/tests/kraken/driver.html?testName=audio-dft) 18:36:22 INFO - PROCESS | 16533 | RSS: Main: 192364544 18:36:22 INFO - PROCESS | 16533 | 18:36:25 INFO - PROCESS | 16533 | Cycle 1(1): loaded http://localhost:52300/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52300/tests/kraken/driver.html?testName=audio-fft) 18:36:25 INFO - PROCESS | 16533 | RSS: Main: 273358848 18:36:25 INFO - PROCESS | 16533 | 18:36:28 INFO - PROCESS | 16533 | Cycle 1(1): loaded http://localhost:52300/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52300/tests/kraken/driver.html?testName=audio-oscillator) 18:36:28 INFO - PROCESS | 16533 | RSS: Main: 182427648 18:36:28 INFO - PROCESS | 16533 | 18:36:30 INFO - PROCESS | 16533 | Cycle 1(1): loaded http://localhost:52300/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52300/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:36:31 INFO - PROCESS | 16533 | RSS: Main: 186687488 18:36:31 INFO - PROCESS | 16533 | 18:36:34 INFO - PROCESS | 16533 | Cycle 1(1): loaded http://localhost:52300/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52300/tests/kraken/driver.html?testName=imaging-darkroom) 18:36:35 INFO - PROCESS | 16533 | RSS: Main: 223010816 18:36:35 INFO - PROCESS | 16533 | 18:36:38 INFO - PROCESS | 16533 | Cycle 1(1): loaded http://localhost:52300/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52300/tests/kraken/driver.html?testName=imaging-desaturate) 18:36:39 INFO - PROCESS | 16533 | RSS: Main: 222085120 18:36:39 INFO - PROCESS | 16533 | 18:36:42 INFO - PROCESS | 16533 | Cycle 1(1): loaded http://localhost:52300/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52300/tests/kraken/driver.html?testName=json-parse-financial) 18:36:42 INFO - PROCESS | 16533 | RSS: Main: 222482432 18:36:42 INFO - PROCESS | 16533 | 18:36:44 INFO - PROCESS | 16533 | Cycle 1(1): loaded http://localhost:52300/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52300/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:36:45 INFO - PROCESS | 16533 | RSS: Main: 187117568 18:36:45 INFO - PROCESS | 16533 | 18:36:47 INFO - PROCESS | 16533 | Cycle 1(1): loaded http://localhost:52300/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52300/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:36:47 INFO - PROCESS | 16533 | RSS: Main: 192528384 18:36:47 INFO - PROCESS | 16533 | 18:36:49 INFO - PROCESS | 16533 | Cycle 1(1): loaded http://localhost:52300/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52300/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:36:50 INFO - PROCESS | 16533 | RSS: Main: 196755456 18:36:50 INFO - PROCESS | 16533 | 18:36:53 INFO - PROCESS | 16533 | Cycle 1(1): loaded http://localhost:52300/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52300/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:36:53 INFO - PROCESS | 16533 | RSS: Main: 191700992 18:36:53 INFO - PROCESS | 16533 | 18:36:56 INFO - PROCESS | 16533 | Cycle 1(1): loaded http://localhost:52300/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52300/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:36:57 INFO - PROCESS | 16533 | RSS: Main: 195047424 18:36:57 INFO - PROCESS | 16533 | 18:36:59 INFO - PROCESS | 16533 | Cycle 1(1): loaded http://localhost:52300/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52300/tests/kraken/driver.html?testName=ai-astar) 18:36:59 INFO - PROCESS | 16533 | RSS: Main: 245731328 18:36:59 INFO - PROCESS | 16533 | 18:36:59 INFO - PROCESS | 16533 | __start_tp_report 18:36:59 INFO - PROCESS | 16533 | _x_x_mozilla_page_load 18:36:59 INFO - PROCESS | 16533 | _x_x_mozilla_page_load_details 18:36:59 INFO - PROCESS | 16533 | |i|pagename|runs| 18:36:59 INFO - PROCESS | 16533 | |0;ai-astar;103;113;113;112;113;115;112;116;112;113 18:36:59 INFO - PROCESS | 16533 | |1;audio-beat-detection;159;125;125;185;124;123;149;125;165;129 18:36:59 INFO - PROCESS | 16533 | |2;audio-dft;162;162;161;162;162;163;161;162;162;160 18:36:59 INFO - PROCESS | 16533 | |3;audio-fft;75;77;75;123;75;76;74;74;100;75 18:36:59 INFO - PROCESS | 16533 | |4;audio-oscillator;84;86;117;85;86;85;128;84;85;118 18:36:59 INFO - PROCESS | 16533 | |5;imaging-gaussian-blur;117;117;117;116;116;116;116;117;117;117 18:36:59 INFO - PROCESS | 16533 | |6;imaging-darkroom;146;147;147;148;146;146;146;147;146;145 18:36:59 INFO - PROCESS | 16533 | |7;imaging-desaturate;95;95;95;94;95;95;94;95;94;95 18:36:59 INFO - PROCESS | 16533 | |8;json-parse-financial;67;63;63;62;63;62;76;62;62;62 18:36:59 INFO - PROCESS | 16533 | |9;json-stringify-tinderbox;67;65;66;65;66;65;66;67;67;67 18:36:59 INFO - PROCESS | 16533 | |10;stanford-crypto-aes;81;79;80;80;80;90;78;78;79;87 18:36:59 INFO - PROCESS | 16533 | |11;stanford-crypto-ccm;130;130;127;128;127;126;134;136;166;138 18:36:59 INFO - PROCESS | 16533 | |12;stanford-crypto-pbkdf2;165;163;170;168;163;166;166;167;164;165 18:36:59 INFO - PROCESS | 16533 | |13;stanford-crypto-sha256-iterative;68;67;67;66;66;71;67;68;68;65 18:36:59 INFO - PROCESS | 16533 | __end_tp_report 18:36:59 INFO - PROCESS | 16533 | __start_cc_report 18:36:59 INFO - PROCESS | 16533 | _x_x_mozilla_cycle_collect,1992 18:36:59 INFO - PROCESS | 16533 | __end_cc_report 18:36:59 INFO - PROCESS | 16533 | __startTimestamp1469756219369__endTimestamp 18:36:59 INFO - PROCESS | 16533 | 18:36:59 INFO - PROCESS | 16533 | ------- Summary: start ------- 18:36:59 INFO - PROCESS | 16533 | Number of tests: 14 18:36:59 INFO - PROCESS | 16533 | 18:36:59 INFO - PROCESS | 16533 | [#0] ai-astar Cycles:10 Average:112.20 Median:113.00 stddev:3.49 (3.1%) stddev-sans-first:1.39 18:36:59 INFO - PROCESS | 16533 | Values: 103.0 113.0 113.0 112.0 113.0 115.0 112.0 116.0 112.0 113.0 18:36:59 INFO - PROCESS | 16533 | 18:36:59 INFO - PROCESS | 16533 | [#1] audio-beat-detection Cycles:10 Average:140.90 Median:139.00 stddev:22.17 (16.0%) stddev-sans-first:22.53 18:36:59 INFO - PROCESS | 16533 | Values: 159.0 125.0 125.0 185.0 124.0 123.0 149.0 125.0 165.0 129.0 18:36:59 INFO - PROCESS | 16533 | 18:36:59 INFO - PROCESS | 16533 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 18:36:59 INFO - PROCESS | 16533 | Values: 162.0 162.0 161.0 162.0 162.0 163.0 161.0 162.0 162.0 160.0 18:36:59 INFO - PROCESS | 16533 | 18:36:59 INFO - PROCESS | 16533 | [#3] audio-fft Cycles:10 Average:82.40 Median:75.00 stddev:16.29 (21.7%) stddev-sans-first:17.06 18:36:59 INFO - PROCESS | 16533 | Values: 75.0 77.0 75.0 123.0 75.0 76.0 74.0 74.0 100.0 75.0 18:36:59 INFO - PROCESS | 16533 | 18:36:59 INFO - PROCESS | 16533 | [#4] audio-oscillator Cycles:10 Average:95.80 Median:85.00 stddev:17.64 (20.7%) stddev-sans-first:18.18 18:36:59 INFO - PROCESS | 16533 | Values: 84.0 86.0 117.0 85.0 86.0 85.0 128.0 84.0 85.0 118.0 18:36:59 INFO - PROCESS | 16533 | 18:36:59 INFO - PROCESS | 16533 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 18:36:59 INFO - PROCESS | 16533 | Values: 117.0 117.0 117.0 116.0 116.0 116.0 116.0 117.0 117.0 117.0 18:36:59 INFO - PROCESS | 16533 | 18:36:59 INFO - PROCESS | 16533 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.84 (0.6%) stddev-sans-first:0.88 18:36:59 INFO - PROCESS | 16533 | Values: 146.0 147.0 147.0 148.0 146.0 146.0 146.0 147.0 146.0 145.0 18:36:59 INFO - PROCESS | 16533 | 18:36:59 INFO - PROCESS | 16533 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 18:36:59 INFO - PROCESS | 16533 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 94.0 95.0 94.0 95.0 18:36:59 INFO - PROCESS | 16533 | 18:36:59 INFO - PROCESS | 16533 | [#8] json-parse-financial Cycles:10 Average:64.20 Median:63.00 stddev:4.42 (7.0%) stddev-sans-first:4.57 18:36:59 INFO - PROCESS | 16533 | Values: 67.0 63.0 63.0 62.0 63.0 62.0 76.0 62.0 62.0 62.0 18:36:59 INFO - PROCESS | 16533 | 18:36:59 INFO - PROCESS | 16533 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.50 stddev:0.88 (1.3%) stddev-sans-first:0.87 18:36:59 INFO - PROCESS | 16533 | Values: 67.0 65.0 66.0 65.0 66.0 65.0 66.0 67.0 67.0 67.0 18:36:59 INFO - PROCESS | 16533 | 18:36:59 INFO - PROCESS | 16533 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:80.00 stddev:4.02 (5.0%) stddev-sans-first:4.27 18:36:59 INFO - PROCESS | 16533 | Values: 81.0 79.0 80.0 80.0 80.0 90.0 78.0 78.0 79.0 87.0 18:36:59 INFO - PROCESS | 16533 | 18:36:59 INFO - PROCESS | 16533 | [#11] stanford-crypto-ccm Cycles:10 Average:134.20 Median:132.00 stddev:11.90 (9.0%) stddev-sans-first:12.52 18:36:59 INFO - PROCESS | 16533 | Values: 130.0 130.0 127.0 128.0 127.0 126.0 134.0 136.0 166.0 138.0 18:36:59 INFO - PROCESS | 16533 | 18:36:59 INFO - PROCESS | 16533 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.70 Median:166.00 stddev:2.21 (1.3%) stddev-sans-first:2.33 18:36:59 INFO - PROCESS | 16533 | Values: 165.0 163.0 170.0 168.0 163.0 166.0 166.0 167.0 164.0 165.0 18:36:59 INFO - PROCESS | 16533 | 18:36:59 INFO - PROCESS | 16533 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:1.64 (2.4%) stddev-sans-first:1.72 18:36:59 INFO - PROCESS | 16533 | Values: 68.0 67.0 67.0 66.0 66.0 71.0 67.0 68.0 68.0 65.0 18:36:59 INFO - PROCESS | 16533 | -------- Summary: end -------- 18:36:59 INFO - PROCESS | 16533 | 18:37:00 INFO - TEST-INFO | 16533: exit 0 18:37:00 INFO - TEST-OK | kraken | took 64952ms 18:37:00 INFO - SUITE-END | took 1185s 18:37:01 INFO - Completed test suite (00:19:45) 18:37:01 INFO - javascript benchmark 18:37:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2572.5240830446382, 2589.585666293393, 2603.2710840964533, 2605.5961325994454, 2617.1232637066582, 4530.524294949032, 4582.312653102036, 4652.53474652535, 4674.27548729947, 4674.602658774004, 4614.4462664480225, 4657.278121891112, 4668.5564871337165, 4680.789364478598, 4721.433427988638, 4244.702870799046, 4248.447701798762, 4286.5284818669925, 4289.678274129445, 4352.281873490871, 4303.505096913848, 4351.0862718829085, 4354.9765805035795, 4378.956210437903, 4415.425994620711, 4183.5398106208595, 4209.137126888981, 4376.387305777193, 4392.121575684876, 4437.84467543636, 4282.914341713179, 4330.935035974463, 4339.327404252346, 4344.500382455994, 4403.559644035603, 4309.095090031097, 4314.546972567867, 4319.589638984291, 4359.629431498326, 4368.191884501346, 4569.405977222939, 4691.319758635013, 4704.317873908299, 4714.7642617869315, 4766.0, 4852.757362131879, 4998.050370429607, 5053.9241911371355, 5054.1407960646775, 5136.845894623168, 5112.872178195575, 5159.380874295071, 5168.9224661630105, 5171.974140129313, 5173.663711858717, 4746.264329029006, 4752.97810970643, 4756.6432517561325, 4801.519848015206, 4802.975985120122, 5064.215046667772, 5067.797288108434, 5081.212412076134, 5095.414027386824, 5117.590592752571, 4900.852974410702, 4943.3573635427165, 4949.82675606352, 4950.975245123751, 4951.851444456672, 5014.448410674823, 5022.422421421583, 5061.974690126526, 5069.949300507022, 5072.568831649277, 4838.782254798542, 4944.752762361867, 4946.3817022872145, 5029.823956161516, 5042.168042273057, 5018.89962200754, 5028.195488721787, 5060.418051924003, 5075.807185311449, 5076.670016448919, 4251.277282861921, 4276.807543660543, 4286.314189729628, 4286.721363111388, 4329.134173165379, 3627.746057775983, 3639.8180090995343, 3710.8144592770254, 3715.8142092895246, 3739.551253849501, 4193.0, 4278.657707383401, 4306.935395969063, 4313.0, 4347.652187824967, 5042.722650254198, 5045.0, 5049.974750126299, 5082.313887625197, 5085.084684756779, 4330.783460826946, 4334.718243314174, 4337.501187363494, 4376.956230437719, 4386.627136693353, 4391.824327026883, 4472.9105417892115, 4476.35092911526, 4507.504174540798, 4571.451425828922, 4719.480857105647, 4720.268358404453, 4736.9052618946735, 4764.833230836974, 4779.617630589614, 4995.450500444876, 4997.525235102659, 5005.249212618136, 5014.623903207347, 5053.772580233972, 4618.0994706032, 4700.318453824245, 4714.952850471452, 4733.9763301183275, 4757.7621118943225, 4936.8765780855765, 4944.8763780905765, 4952.851414457572, 4969.254611808113, 5016.924746128738, 5013.874653133555, 5017.247412888096, 5021.924671130009, 5027.994401119718, 5069.543741063322, 4746.145693775154, 4870.878228044327, 4890.975545122252, 4906.705597664151, 4927.088488629615, 4890.975545122252, 4907.645406180787, 4909.631777616764, 4911.214205727067, 4944.1100601892, 4797.592204662503, 4803.135435621622, 4842.709437433625, 4860.732659703609, 4870.512948705101, 4782.545658162469, 4866.440359358719, 4896.387951506062, 4900.558949694545, 4969.428515720594, 4765.785539650655, 4790.0, 4794.376731024944, 4801.879953001063, 4826.6621336506105], "value": 4609.178639620088, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.4552175433338, 585.0054906658679, 593.1725243285616, 595.1667665268626, 597.5160120302555, 26842.194734157983, 29614.111576652682, 29666.11001669948, 29858.402831943375, 38495.61504384955, 36012.27975440496, 39546.0, 39574.20851582967, 39600.0, 39663.0, 7426.517276377018, 7554.622268886561, 7558.2063883292285, 7561.470697051209, 7565.205653406396, 7654.923450765505, 7733.265339792711, 7739.110002349717, 7750.0, 7755.457118001742, 7724.9227507725045, 7759.534427934342, 7765.689372425124, 7769.728059517918, 7775.766726998199, 7722.768316950473, 7723.691052357955, 7727.652255648453, 7755.612219389008, 7756.767296981099, 7679.078510578711, 7763.883541746878, 7768.417368697314, 7769.067711874554, 7769.145394006655, 36414.27171456556, 36649.63350366489, 36758.63241367579, 36759.26481470383, 36803.63196368056, 3088.81467111974, 3150.322680623654, 3306.8842590509457, 3394.321135772855, 3768.3028639701743, 26329.605055924178, 26564.46871062568, 27254.727452725416, 30859.69140308613, 31027.689723102932, 3444.8277586120594, 3461.3769521486124, 3495.6853883150384, 3600.1719604491113, 3692.759970601929, 257209.0, 258196.0, 258869.0, 259181.0, 260344.0, 31117.68882311193, 31941.68058319387, 53329.73335133377, 53701.731491342296, 53713.46286537163, 32503.349933001682, 32775.18062048468, 32814.17964550905, 32836.83581582124, 32859.50710739341, 13109.344532773322, 13255.270960097094, 13261.010848372629, 13269.0, 13270.336483175803, 11038.0, 11159.386233757059, 11205.551777928955, 11248.775024499464, 11263.211575189822, 7768.53388796674, 7778.844423111506, 7826.882596761053, 7871.645775940096, 7879.172686867911, 3063.6629970703207, 3077.153782709728, 3079.5534647475993, 3101.7518598512065, 3139.450596145711, 843.1147295339869, 866.5623859950811, 883.6774577279247, 906.4244204929917, 941.538646063424, 27735.081600223846, 27856.44287114287, 27886.216443244717, 28169.859150704116, 28293.57559636607, 940.3276657190141, 982.8574856645746, 1004.492731170754, 1026.6714651311509, 1048.6224959014748, 14307.0, 15099.698006040038, 15111.697766044617, 15373.692526149414, 15392.384304627913, 417995.0, 418047.0, 419189.0, 419274.0, 419997.0, 48455.75772121117, 48793.0, 49102.50897491051, 49228.0, 49297.753511232215, 1077.4289626497812, 1163.1450883600546, 1185.5554167187304, 1194.6296648039136, 1198.8801119887942, 27564.173074807786, 28964.13107606775, 29455.26361840971, 29516.409671806872, 29848.104556863327, 42019.36970945377, 42495.57504424916, 42555.148897022504, 42570.36144457898, 42576.78711606546, 318035.0, 320863.0, 321341.0, 322173.0, 322389.0, 22567.66148507741, 24275.0, 25097.749022509543, 25215.117470888432, 25256.873715631304, 41138.177236455704, 41274.0, 41514.58485415107, 41792.3731144027, 41973.0, 34882.127946801535, 35468.46797297991, 35501.0, 35600.821995889855, 35860.462093068105, 34845.477317839745, 34987.0, 35418.0, 35588.0, 35703.0, 34899.65100348964, 35277.11807204738, 35759.82120089487, 35789.82105089562, 36045.819770902024, 30964.535531966587, 32424.513632296006, 32754.0, 32776.34447310993, 33034.504482432305, 24820.751792481846, 25150.49699005973, 25154.74845251524, 25237.621435678113, 25423.0], "value": 16284.980428631656, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.2990429428261, 349.79187383506803, 356.49377883405543, 367.3369567929887, 370.10434747910057, 15914.681706365865, 16682.165891705412, 17033.97796132233, 17130.657386852286, 17138.22877970491, 15970.680586388295, 16365.181740912936, 16977.915110424463, 17136.914315428407, 17137.485875423725, 4862.197737373329, 5098.872528186806, 5108.540231379176, 5113.565346945514, 5114.516790130858, 3632.6548977847197, 3815.828287727059, 5070.2141168119, 5798.739056742456, 6044.818655440344, 6135.110408990694, 6140.324564297924, 6146.5390095743, 6147.262328520584, 6148.200733904586, 5846.181534585162, 5931.1696362509065, 5957.957357462448, 5958.851028724316, 5964.7912323068485, 4652.185867473212, 5307.601929855237, 5340.465953404668, 5351.973240133813, 5355.919661205085, 11653.883461165364, 12240.0, 12266.75466490674, 12290.75418491634, 12294.508219671203, 1810.257794304342, 1862.8044055374125, 1901.7717873855227, 1912.7800302965197, 1944.0765636322774, 9167.633294668205, 9456.290778191595, 12338.568150114703, 12650.114491985565, 13046.869531304661, 1701.455534229047, 1747.0042076016675, 1753.3687872365938, 1754.508737553487, 1763.5150333658219, 63945.0, 68915.65542172307, 70864.0, 71629.0, 72063.0, 9568.95215523918, 9882.11061004513, 9886.0, 9930.950345248228, 10102.797944041225, 13351.265680387673, 13435.328233588281, 13444.596662100153, 13479.730405392034, 13479.797803032963, 5780.572159692939, 5891.7054147292465, 5919.940800592025, 6388.680565971776, 7354.595497247703, 6819.31806819324, 6876.346747059021, 6923.134608173978, 7063.293670632896, 7102.076730025167, 4145.66834653227, 4150.501939767187, 4156.750594964312, 4250.55369186231, 4278.700490965664, 1604.3261830031415, 1683.1836559268745, 1707.3000069971251, 1710.6065604910941, 1838.669039572863, 819.5451524403894, 837.9036410812713, 846.6655671009917, 878.8022694893598, 934.5794392523392, 16308.592285192964, 16439.342426303054, 16712.49862504127, 16849.663006739796, 17498.825011749974, 828.9295409890107, 833.9374546908884, 859.862422012475, 869.0614136732314, 883.7172104926361, 9392.530373481299, 9440.433573985583, 9714.0, 9723.367981081206, 9900.207983361313, 324666.0, 327633.0, 328897.0, 420876.0, 425985.0, 51342.48657513377, 67388.0, 86960.0, 87717.0, 87958.56020719855, 899.8020435504178, 924.5746956399997, 945.3807755919746, 951.4671783801093, 968.8885778135464, 14831.11013339203, 15426.30581623852, 15445.459408920633, 15478.690426191639, 15896.523104306889, 37908.43137352887, 39047.21905561816, 39368.80315598404, 39657.0, 39891.40162897617, 55317.0, 56851.01021464229, 57009.714951424976, 57223.713881430325, 57920.131198032905, 7365.079365079365, 7572.5835079068975, 7852.568108754073, 7901.762947111596, 10354.689359319233, 11249.156313276373, 12387.380630968595, 12467.31429771335, 12771.361431928552, 13412.664683382993, 10714.464276785973, 10840.67477975662, 10953.0, 11261.66215013551, 11269.71825704364, 10406.219533534864, 10528.94710528941, 10627.787444251226, 10855.782884342427, 11134.888651113386, 10293.43386113741, 10797.838032429363, 10870.673879783619, 11151.498182581641, 11189.328640281608, 11153.776924461303, 11221.887781122085, 11582.189246752647, 11812.822807658064, 11923.165378423773, 10930.836037459603, 11097.278676885977, 11229.382383968634, 11309.604163854226, 11361.0], "value": 8279.17601496172, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1341.6377578053925, 1403.4736973634886, 1415.4833485777694, 1660.1616183827173, 1661.5181597336773, 7451.6274186290675, 7925.801854953629, 7926.088499822507, 7931.643076061577, 7945.562994035333, 6733.865322693543, 7218.927810721892, 7431.777046688608, 7468.178500364969, 7741.806454838617, 2151.150295633228, 2172.4134483689395, 2173.3588591365506, 2177.825773938081, 2181.1275489804048, 2180.4003898927763, 2220.245116660335, 2236.317923033482, 2238.2837492002564, 2245.6631505274177, 2202.218212534551, 2203.6253836847773, 2214.6013717530836, 2219.5782801267706, 2237.7090978172814, 2124.2777455665073, 2126.9361919142452, 2130.2970019893396, 2132.040581738224, 2133.370655656585, 2025.2506572568243, 2094.8114669679803, 2096.75887272964, 2099.5066159452517, 2104.2214380679093, 7843.803904902366, 7907.486013409168, 7914.169012253746, 7915.802104947423, 7931.444798864082, 4503.549645035503, 4614.123316569841, 4619.9076018479445, 4622.237330840408, 4624.3988281523525, 2820.6615206175184, 2899.6810350861388, 2928.9853550732323, 2932.2669332666833, 2961.31889665376, 872.3370238618633, 915.7756349694301, 935.9298052646079, 936.4147407870081, 936.6347124621403, 10256.487175641263, 10318.122959548447, 10335.844962325571, 10337.74155646115, 10362.533685984148, 4013.3979903014197, 4178.6865985051245, 4281.550437204111, 4319.805608747614, 4334.891627709332, 8820.382573219813, 8842.513661748666, 8847.911520884709, 8848.690295839615, 8850.247728943112, 4646.512116227815, 4648.1865673507, 4650.720956742539, 4651.046535460223, 4652.488226295105, 3687.4468829675225, 4116.58834116586, 4231.132617813402, 4236.597523235288, 4268.295731204316, 3600.4779307000863, 3652.926941461156, 3802.372608519563, 3804.543454785388, 3810.399632154502, 1173.647905628308, 1193.2840295822436, 1208.0999655256715, 1220.2373516552154, 1220.2983284611385, 716.4698123388655, 869.626060793852, 872.3457406944791, 875.8598624220094, 889.9288056955428, 5189.42916279209, 5391.272178255886, 5535.114381698909, 5543.196236545678, 5622.212890195376, 405.1673810319762, 405.7829061452109, 411.8599676110137, 412.2579357157105, 420.2330746387793, 3667.7982710951155, 3753.155540003477, 3754.5494540655295, 3786.545614526219, 3789.7536660117003, 9345.672901448552, 9703.175230105378, 9782.315237933277, 9795.412275263507, 9801.705948821547, 9644.276679249084, 9668.468234247042, 9754.853677194847, 9769.804603907882, 9776.462294573867, 7332.9266707332245, 7358.7424440145405, 7362.116546014619, 7385.372243359375, 7408.888866667005, 5462.781488740406, 5490.313710786152, 5683.175939488834, 5709.9714501427225, 5855.268091488564, 8911.287097032351, 8984.595693193953, 9004.819903602021, 9005.63977440895, 9076.591553379982, 8452.957735211285, 8736.650533978569, 8742.562871856255, 8997.910020899708, 9010.684626038057, 5872.677002764889, 6487.0593763903025, 6584.8353791155605, 6598.076269322202, 6599.241087275025, 7402.629868506661, 7410.703571857065, 7487.775366739006, 7518.436117291116, 7530.736424225126, 6821.420179284816, 6864.4554975130195, 6869.793906182823, 6874.450043996569, 7077.929220707727, 6482.448991835747, 6542.672866356568, 6607.636579988147, 6617.933820661732, 6656.134702488645, 6339.651319177489, 6611.636360000246, 6611.867762644816, 6621.238557565749, 6623.138991931018, 4580.175568397721, 4639.48965613789, 4671.18254305502, 4758.310045043519, 4824.0834241494, 4546.9545304547855, 4639.443266808004, 4695.389599352063, 4735.644826637947, 4791.904161916812], "value": 4073.579838614424, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.94925887969606, 290.27286646949386, 296.6632871690631, 303.8541500079963, 304.7561950439648, 4822.831200907969, 4848.587870031051, 4851.22380419133, 4864.805407783684, 4900.868122366773, 4583.129205450962, 4629.0, 4660.394148760664, 4681.88295292617, 4844.619283504202, 3697.759645623026, 3702.2040261343805, 3727.8881633551036, 3765.8493660253557, 3772.735908486407, 3756.887293381203, 3789.109559253573, 3798.620137986207, 3799.0122568132347, 3838.558565764931, 3696.297703436352, 3745.8314375853015, 3780.584135745066, 3792.3932170852668, 3792.58281589025, 3762.5673047599603, 3772.5472943246714, 3779.4330850372526, 3782.205736795276, 3787.2993496203153, 3303.487959366278, 3327.7670563060597, 3360.294338188983, 3361.3277344530948, 3377.9155521111925, 4633.884152896171, 4683.367745354368, 4698.671093023489, 4707.0, 4739.0758802033615, 4139.482564679415, 4284.721493102938, 4288.24955632763, 4293.677974151919, 4320.546342634009, 4957.652964292501, 4971.6271279654175, 4988.725620090893, 4996.350474438336, 5005.1491246488185, 3656.5246517952496, 3669.3578623741005, 3674.81625918703, 3679.5400574928135, 3688.3360995020885, 5115.181570948667, 5200.583953283691, 5215.895682086375, 5240.187770895517, 5277.261183434322, 3747.1381582235695, 3752.1182522107283, 3755.6432138946757, 3759.93565244325, 3763.1344790697744, 3821.121142137324, 3829.291581057513, 3829.904252393657, 3847.942280865789, 3851.78815165163, 4327.307630779061, 4327.978360108179, 4328.11273688893, 4332.913341733148, 4339.262325404688, 4921.040397122527, 5001.374828146481, 5017.046761115376, 5030.748462576857, 5033.0, 1308.1366298243304, 1319.8812106910232, 1320.8150858879765, 1323.5235315286488, 1326.4163767942075, 853.3913572914976, 868.3400615532241, 899.4333569850952, 916.4272329793879, 928.3176865004217, 4354.738715677069, 4362.629176520031, 4372.562743725665, 4372.595072709997, 4379.978100109479, 5089.847304580869, 5114.948850511521, 5127.79488820443, 5146.353166986603, 5171.224316352502, 4144.316187829035, 4317.395564620955, 4344.847930322487, 4363.2364336241035, 4376.518582955872, 2710.7966902482, 2712.416830381438, 2715.5655095184675, 2720.387912719662, 2722.727727227301, 4848.200046992207, 4850.369451971221, 4859.07677541266, 4871.244957031666, 4890.119778439844, 5032.672876263031, 5200.97399513, 5220.843374698765, 5259.8422047338645, 5270.973645131827, 4798.856034318976, 4806.2310030394965, 4807.423109226916, 4822.204336284544, 4830.203016502238, 5060.038592667382, 5062.0, 5086.898262034664, 5087.796488140433, 5125.846224613268, 4866.467062875183, 4989.750512474435, 5016.172331565251, 5105.157648987875, 5136.229565565195, 4919.4834542373965, 4920.434150072644, 4920.6555541111775, 4933.309336692794, 4946.752662366939, 3652.0, 3683.134463401045, 3686.391745361985, 3686.668199862025, 3708.8145592719716, 5051.494850514919, 5158.484151584811, 5190.506901844319, 5220.295260139985, 5228.268042473981, 4978.0, 5022.974885125551, 5036.924446133385, 5040.57155141817, 5055.317532133115, 5019.799208031784, 5045.268436076675, 5077.543021127968, 5123.795048198031, 5140.640155189101, 4879.127141249937, 4933.407991041098, 4976.527229913152, 5004.224345226496, 5036.445990941067, 4883.6325828768, 4965.155923493087, 5069.5666080280935, 5079.974600126976, 5084.847454576368, 4973.0, 4977.253411988231, 4982.377202849644, 4982.4768399317545, 4988.551030407136], "value": 3804.456719856608, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [623.5385814497272, 658.6180015590954, 662.9801105966823, 663.7643636509039, 709.2411120101492, 12331.136820422564, 13292.667683307911, 13388.93305533471, 13425.127366721157, 13450.192988420702, 12962.546310879121, 13133.27766972816, 13147.342632868365, 13172.34138293084, 13175.472981080746, 627.9058141278822, 750.3884334267555, 757.8294883651162, 778.6846327237478, 785.9646315915769, 765.0245936431039, 778.6690656471005, 779.0806847919453, 779.6803310642638, 780.7657702689199, 839.4417712221396, 841.1168273313027, 841.5203334099566, 841.7727213652311, 841.9242268195861, 659.9043138744903, 791.7189397763826, 827.611022819274, 829.340674164038, 830.2942498875938, 598.2312728144313, 604.2869414091371, 604.3714536881638, 604.4710877981765, 604.5798170271663, 13225.735485290337, 13250.403731832092, 13273.601791946257, 13285.003624728184, 13289.202647841064, 13410.0, 13528.526501572398, 13802.65493362664, 13814.102083364549, 13902.51341203053, 10602.46987650622, 10699.83950240747, 10972.670819875417, 11011.119110471223, 11328.207025508136, 3272.132884785534, 3318.303156337172, 3350.6984371406447, 3419.452887538007, 3427.5886893572683, 59475.70262148661, 59587.0, 59834.0, 63485.36514634887, 63695.363046369406, 10457.738556536147, 10577.259591828499, 10695.465226738632, 10757.623483178051, 10946.343219406703, 20161.39515814528, 20182.09180586877, 20197.293094741613, 20228.69656955147, 20238.797612023693, 6736.292689267654, 6811.693473793691, 7050.823729406806, 7117.217106118426, 7117.4306055515435, 3573.6247693992277, 3688.8524459021874, 3722.4788529605876, 3786.3941769316775, 3880.2821478026653, 2765.612814206013, 2871.2821794551364, 2887.307046308913, 2887.4080813433197, 2887.696791836827, 472.91487532244525, 476.6520440078762, 479.1782093709305, 482.1682597519321, 491.1086378223513, 513.2122192434595, 516.51963673783, 532.4622131646987, 535.344203350892, 541.7183064806279, 6657.700403481855, 7082.362587367162, 7168.53404528704, 7281.1262648482525, 7470.663820128108, 517.5445607865055, 553.4189101443468, 554.0802268234711, 560.1234068682498, 562.2830890614417, 3305.454599991023, 3335.216224187314, 3439.4133349210742, 3496.5804103507744, 3593.6765691087926, 91879.0, 94164.52917735367, 94438.52780736053, 95446.52276738572, 95468.0, 48927.0, 49092.0, 49588.0, 53249.73375133177, 81865.0, 65227.347726523076, 68020.0, 73202.0, 73579.0, 74791.0, 6469.320721324193, 6657.007284369312, 6718.7312507499155, 6863.0, 6871.828204294932, 32602.51096233511, 40259.59740402558, 43066.354004690584, 45192.54807451883, 45484.0, 36897.81551092227, 37639.62360376361, 38028.809855950545, 38539.42190867083, 42467.36298955456, 9481.0, 9484.668036618685, 9707.805843883225, 9711.5144242789, 9860.506974651382, 9821.705348839547, 9824.312298139348, 9851.556679949563, 9885.0, 9899.059589339002, 9107.271418286653, 9276.907230927603, 9451.858222126812, 9484.146426821619, 9778.951105244712, 9322.533873306444, 9549.761255968378, 9846.753831154278, 9884.0, 11314.60398886035, 11017.669469915916, 11566.074714023027, 11853.703657408634, 12393.504259829506, 12768.0, 9705.757356066155, 9861.112499875046, 9869.309148359545, 10529.052385285055, 10718.0, 8273.83452330938, 8480.194381533744, 8636.740897772825, 8700.303975681803, 8789.165029322205], "value": 6130.786277061306, "unit": "score"}], "name": "dromaeo_css", "value": 6240.29403596633, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 113.0, 112.0, 113.0, 115.0, 112.0, 116.0, 112.0, 113.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 125.0, 125.0, 185.0, 124.0, 123.0, 149.0, 125.0, 165.0, 129.0], "value": 140.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 162.0, 162.0, 163.0, 161.0, 162.0, 162.0, 160.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 75.0, 123.0, 75.0, 76.0, 74.0, 74.0, 100.0, 75.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 117.0, 85.0, 86.0, 85.0, 128.0, 84.0, 85.0, 118.0], "value": 95.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 148.0, 146.0, 146.0, 146.0, 147.0, 146.0, 145.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, 94.0, 95.0, 94.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 63.0, 63.0, 62.0, 63.0, 62.0, 76.0, 62.0, 62.0, 62.0], "value": 64.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 66.0, 65.0, 66.0, 65.0, 66.0, 67.0, 67.0, 67.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 80.0, 80.0, 80.0, 90.0, 78.0, 78.0, 79.0, 87.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 130.0, 127.0, 128.0, 127.0, 126.0, 134.0, 136.0, 166.0, 138.0], "value": 134.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 170.0, 168.0, 163.0, 166.0, 166.0, 167.0, 164.0, 165.0], "value": 165.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 66.0, 66.0, 71.0, 67.0, 68.0, 68.0, 65.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1529.4, "alertThreshold": 2.0}]} 18:37:01 INFO - Return code: 0 18:37:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:37:01 INFO - # TBPL SUCCESS # 18:37:01 INFO - Running post-action listener: _resource_record_post_action 18:37:01 INFO - [mozharness: 2016-07-29 01:37:01.178895Z] Finished run-tests step (success) 18:37:01 INFO - Running post-run listener: _resource_record_post_run 18:37:01 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 558936064; Read time: 32; Write time: 1819824 18:37:01 INFO - TinderboxPrint: CPU usage
13.1% 18:37:01 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 32 18:37:01 INFO - TinderboxPrint: I/O write bytes / time
558,936,064 / 1,819,824 18:37:01 INFO - TinderboxPrint: CPU idle
8,344.9 (86.9%) 18:37:01 INFO - TinderboxPrint: CPU user
1,198.4 (12.5%) 18:37:01 INFO - TinderboxPrint: Swap in / out
0 / 0 18:37:01 INFO - install - Wall time: 17s; CPU: 21.0%; Read bytes: 0; Write bytes: 260825088; Read time: 0; Write time: 1296708 18:37:01 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 298110976; Read time: 32; Write time: 523116 18:37:01 INFO - Running post-run listener: _upload_blobber_files 18:37:01 INFO - Blob upload gear active. 18:37:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:37:01 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 18:37:01 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'] 18:37:01 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 18:37:02 INFO - (blobuploader) - INFO - Open directory for files ... 18:37:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:37:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:37:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:37:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:37:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:37:05 INFO - (blobuploader) - INFO - Done attempting. 18:37:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:37:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:37:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:37:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:37:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:37:06 INFO - (blobuploader) - INFO - Done attempting. 18:37:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:37:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:37:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:37:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:37:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:37:07 INFO - (blobuploader) - INFO - Done attempting. 18:37:07 INFO - (blobuploader) - INFO - Iteration through files over. 18:37:07 INFO - Return code: 0 18:37:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:37:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:37:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b929c957150087fc64776aa4762eb842d6ae1628ce5d14c619897f6bd86681cd73a085a44372b20982bc2b833cdb4425e7b70143636ce38da527a6f688c35799", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1c53515731a16c13e7354c090f1b7cc3215082c0fc339bc2a2ffa15209dc2981b6088d128327d7300077e1db74a4437cd54401b4bacf8cd73a8eaa498342587d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dee5a1316db8f5b7f889ab1cdc1855ed0f04a28b4fb2c072659bb4f8f88471191bb304d68407ddd2f5ea1cb44686101e716dbc94521b189dacad3283bd57076f"} 18:37:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:37:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:37:07 INFO - Contents: 18:37:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b929c957150087fc64776aa4762eb842d6ae1628ce5d14c619897f6bd86681cd73a085a44372b20982bc2b833cdb4425e7b70143636ce38da527a6f688c35799", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1c53515731a16c13e7354c090f1b7cc3215082c0fc339bc2a2ffa15209dc2981b6088d128327d7300077e1db74a4437cd54401b4bacf8cd73a8eaa498342587d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dee5a1316db8f5b7f889ab1cdc1855ed0f04a28b4fb2c072659bb4f8f88471191bb304d68407ddd2f5ea1cb44686101e716dbc94521b189dacad3283bd57076f"} 18:37:07 INFO - Running post-run listener: copy_logs_to_upload_dir 18:37:07 INFO - Copying logs to upload dir... 18:37:07 INFO - mkdir: /builds/slave/test/build/upload/logs 18:37:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.708291 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-28 18:37:07.396794) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-28 18:37:07.400894) ========= 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=df17445c3590ff7897617a0e00000225-1469754984.319590-728038812 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/b929c957150087fc64776aa4762eb842d6ae1628ce5d14c619897f6bd86681cd73a085a44372b20982bc2b833cdb4425e7b70143636ce38da527a6f688c35799", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1c53515731a16c13e7354c090f1b7cc3215082c0fc339bc2a2ffa15209dc2981b6088d128327d7300077e1db74a4437cd54401b4bacf8cd73a8eaa498342587d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dee5a1316db8f5b7f889ab1cdc1855ed0f04a28b4fb2c072659bb4f8f88471191bb304d68407ddd2f5ea1cb44686101e716dbc94521b189dacad3283bd57076f"} build_url:https://queue.taskcluster.net/v1/task/Swisj72CR1mdPCheLEzzDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011396 build_url: 'https://queue.taskcluster.net/v1/task/Swisj72CR1mdPCheLEzzDw/artifacts/public/build/firefox-50.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/b929c957150087fc64776aa4762eb842d6ae1628ce5d14c619897f6bd86681cd73a085a44372b20982bc2b833cdb4425e7b70143636ce38da527a6f688c35799", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1c53515731a16c13e7354c090f1b7cc3215082c0fc339bc2a2ffa15209dc2981b6088d128327d7300077e1db74a4437cd54401b4bacf8cd73a8eaa498342587d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dee5a1316db8f5b7f889ab1cdc1855ed0f04a28b4fb2c072659bb4f8f88471191bb304d68407ddd2f5ea1cb44686101e716dbc94521b189dacad3283bd57076f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-28 18:37:07.427966) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 18:37:07.428429) ========= 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=df17445c3590ff7897617a0e00000225-1469754984.319590-728038812 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004333 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 18:37:07.513737) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 18:37:07.514442) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 18:37:07.515059) ========= ========= Total master_lag: 0.19 =========