builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-057 starttime: 1469837337.71 results: success (0) buildid: 20160729143001 builduid: c8b7447b5fee4eb580d3e52be9d01e56 revision: fa9e9291bfe34c20797978d5d6a8f4168bf961b8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-29 17:08:57.708185) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-29 17:08:57.708800) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-29 17:08:57.709075) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-29 17:08:57.736730) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 17:08:57.737014) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1469836837.273657-140640478 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-29 17:08:58-- 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% 109M=0s 2016-07-29 17:08:58 (109 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.077711 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 17:08:57.828090) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 17:08:57.828379) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1469836837.273657-140640478 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016429 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 17:08:57.882004) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 17:08:57.882353) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev fa9e9291bfe34c20797978d5d6a8f4168bf961b8 --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 fa9e9291bfe34c20797978d5d6a8f4168bf961b8 --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=934fc3100db09dcb9af4d4b6000001ab-1469836837.273657-140640478 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-29 17:08:58,494 truncating revision to first 12 chars 2016-07-29 17:08:58,494 Setting DEBUG logging. 2016-07-29 17:08:58,494 attempt 1/10 2016-07-29 17:08:58,494 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/fa9e9291bfe3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-29 17:08:59,050 unpacking tar archive at: fx-team-fa9e9291bfe3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.891292 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 17:08:58.788618) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-29 17:08:58.788922) ========= script_repo_revision: fa9e9291bfe34c20797978d5d6a8f4168bf961b8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-29 17:08:58.789327) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-29 17:08:58.789617) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-29 17:08:58.800242) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-07-29 17:08:58.800542) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=934fc3100db09dcb9af4d4b6000001ab-1469836837.273657-140640478 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:08:59 INFO - MultiFileLogger online at 20160729 17:08:59 in /builds/slave/test 17:08:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:08:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:08:59 INFO - {'append_to_log': False, 17:08:59 INFO - 'base_work_dir': '/builds/slave/test', 17:08:59 INFO - 'blob_upload_branch': 'Fx-Team', 17:08:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:08:59 INFO - 'branch': 'Fx-Team', 17:08:59 INFO - 'buildbot_json_path': 'buildprops.json', 17:08:59 INFO - 'config_files': ('talos/linux_config.py',), 17:08:59 INFO - 'default_actions': ('clobber', 17:08:59 INFO - 'read-buildbot-config', 17:08:59 INFO - 'download-and-extract', 17:08:59 INFO - 'populate-webroot', 17:08:59 INFO - 'create-virtualenv', 17:08:59 INFO - 'install', 17:08:59 INFO - 'run-tests'), 17:08:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:08:59 INFO - 'download_minidump_stackwalk': True, 17:08:59 INFO - 'download_symbols': 'ondemand', 17:08:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:08:59 INFO - 'tooltool.py': '/tools/tooltool.py', 17:08:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:08:59 INFO - '/tools/misc-python/virtualenv.py')}, 17:08:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:08:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:08:59 INFO - 'installer_path': 'installer.exe', 17:08:59 INFO - 'log_level': 'info', 17:08:59 INFO - 'log_name': 'talos', 17:08:59 INFO - 'log_to_console': True, 17:08:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:08:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:08:59 INFO - 'opt_config_files': (), 17:08:59 INFO - 'pip_index': False, 17:08:59 INFO - 'sps_profile': False, 17:08:59 INFO - 'sps_profile_interval': 0, 17:08:59 INFO - 'suite': 'dromaeojs', 17:08:59 INFO - 'system_bits': '32', 17:08:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:08:59 INFO - 'title': 'talos-linux64-ix-057', 17:08:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:08:59 INFO - 'use_talos_json': True, 17:08:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:08:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:08:59 INFO - 'work_dir': 'build'} 17:08:59 INFO - [mozharness: 2016-07-30 00:08:59.498834Z] Running clobber step. 17:08:59 INFO - Running pre-action listener: _resource_record_pre_action 17:08:59 INFO - Running main action method: clobber 17:08:59 INFO - rmtree: /builds/slave/test/build 17:08:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:08:59 INFO - Running post-action listener: _resource_record_post_action 17:08:59 INFO - [mozharness: 2016-07-30 00:08:59.974866Z] Finished clobber step (success) 17:08:59 INFO - [mozharness: 2016-07-30 00:08:59.974968Z] Running read-buildbot-config step. 17:08:59 INFO - Running pre-action listener: _resource_record_pre_action 17:08:59 INFO - Running main action method: read_buildbot_config 17:08:59 INFO - Using buildbot properties: 17:08:59 INFO - { 17:08:59 INFO - "project": "", 17:08:59 INFO - "product": "firefox", 17:08:59 INFO - "script_repo_revision": "production", 17:08:59 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:08:59 INFO - "repository": "", 17:08:59 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 17:08:59 INFO - "buildid": "20160729143001", 17:08:59 INFO - "pgo_build": "True", 17:08:59 INFO - "basedir": "/builds/slave/test", 17:08:59 INFO - "buildnumber": 1394, 17:08:59 INFO - "slavename": "talos-linux64-ix-057", 17:08:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:08:59 INFO - "platform": "ubuntu64_hw", 17:08:59 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:08:59 INFO - "branch": "fx-team", 17:08:59 INFO - "repo_path": "integration/fx-team", 17:08:59 INFO - "revision": "fa9e9291bfe34c20797978d5d6a8f4168bf961b8", 17:08:59 INFO - "stage_platform": "linux64-pgo", 17:08:59 INFO - "builduid": "c8b7447b5fee4eb580d3e52be9d01e56", 17:08:59 INFO - "slavebuilddir": "test" 17:08:59 INFO - } 17:08:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/ODGCBl5aSAOP4Ozj7Ktslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 17:08:59 INFO - Running post-action listener: _resource_record_post_action 17:08:59 INFO - [mozharness: 2016-07-30 00:08:59.977389Z] Finished read-buildbot-config step (success) 17:08:59 INFO - [mozharness: 2016-07-30 00:08:59.977476Z] Running download-and-extract step. 17:08:59 INFO - Running pre-action listener: _resource_record_pre_action 17:08:59 INFO - Running main action method: download_and_extract 17:08:59 INFO - mkdir: /builds/slave/test/build/tests 17:08:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:59 INFO - https://queue.taskcluster.net/v1/task/ODGCBl5aSAOP4Ozj7Ktslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:08:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ODGCBl5aSAOP4Ozj7Ktslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:08:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ODGCBl5aSAOP4Ozj7Ktslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:08:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ODGCBl5aSAOP4Ozj7Ktslg/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 17:08:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ODGCBl5aSAOP4Ozj7Ktslg/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 17:09:03 INFO - Downloaded 1361 bytes. 17:09:03 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:09:03 INFO - Using the following test package requirements: 17:09:03 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:09:03 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:09:03 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:09:03 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:03 INFO - u'jsshell-linux-x86_64.zip'], 17:09:03 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:09:03 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:09:03 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:09:03 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:09:03 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:09:03 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:09:03 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:09:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:03 INFO - https://queue.taskcluster.net/v1/task/ODGCBl5aSAOP4Ozj7Ktslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:09:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ODGCBl5aSAOP4Ozj7Ktslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:09:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ODGCBl5aSAOP4Ozj7Ktslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:09:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ODGCBl5aSAOP4Ozj7Ktslg/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 17:09:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ODGCBl5aSAOP4Ozj7Ktslg/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 17:09:09 INFO - Downloaded 24329954 bytes. 17:09:09 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'] 17:09:09 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 17:09:10 INFO - Return code: 0 17:09:10 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 17:09:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:10 INFO - https://queue.taskcluster.net/v1/task/ODGCBl5aSAOP4Ozj7Ktslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:09:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ODGCBl5aSAOP4Ozj7Ktslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:09:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ODGCBl5aSAOP4Ozj7Ktslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:09:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ODGCBl5aSAOP4Ozj7Ktslg/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 17:09:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ODGCBl5aSAOP4Ozj7Ktslg/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 17:09:14 INFO - Downloaded 24329954 bytes. 17:09:14 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'] 17:09:14 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 17:09:16 INFO - Return code: 0 17:09:16 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')]} 17:09:16 INFO - https://queue.taskcluster.net/v1/task/ODGCBl5aSAOP4Ozj7Ktslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:09:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ODGCBl5aSAOP4Ozj7Ktslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:09:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ODGCBl5aSAOP4Ozj7Ktslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:09:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ODGCBl5aSAOP4Ozj7Ktslg/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 17:09:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ODGCBl5aSAOP4Ozj7Ktslg/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 17:09:17 INFO - Downloaded 14413725 bytes. 17:09:17 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'] 17:09:17 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 17:09:17 INFO - Return code: 0 17:09:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:17 INFO - https://queue.taskcluster.net/v1/task/ODGCBl5aSAOP4Ozj7Ktslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:09:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ODGCBl5aSAOP4Ozj7Ktslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:09:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ODGCBl5aSAOP4Ozj7Ktslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:09:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ODGCBl5aSAOP4Ozj7Ktslg/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 17:09:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ODGCBl5aSAOP4Ozj7Ktslg/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 17:09:19 INFO - Downloaded 61007520 bytes. 17:09:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ODGCBl5aSAOP4Ozj7Ktslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:09:19 INFO - mkdir: /builds/slave/test/properties 17:09:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:09:19 INFO - Writing to file /builds/slave/test/properties/build_url 17:09:19 INFO - Contents: 17:09:19 INFO - build_url:https://queue.taskcluster.net/v1/task/ODGCBl5aSAOP4Ozj7Ktslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:09:20 INFO - Running post-action listener: _resource_record_post_action 17:09:20 INFO - Running post-action listener: set_extra_try_arguments 17:09:20 INFO - [mozharness: 2016-07-30 00:09:20.409380Z] Finished download-and-extract step (success) 17:09:20 INFO - [mozharness: 2016-07-30 00:09:20.409611Z] Running populate-webroot step. 17:09:20 INFO - Running pre-action listener: _resource_record_pre_action 17:09:20 INFO - Running main action method: populate_webroot 17:09:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:09:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:09:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:09:20 INFO - '--tppagecycles', 17:09:20 INFO - '7'], 17:09:20 INFO - 'tests': ['tsvgm']}}, 17:09:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:09:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:09:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:09:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:09:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:09:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:09:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:20 INFO - 'talos_options': ['--disable-e10s'], 17:09:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:09:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:09:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:20 INFO - 'talos_options': ['--disable-e10s'], 17:09:20 INFO - 'tests': ['damp', 'tps']}, 17:09:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:20 INFO - 'tests': ['damp', 'tps']}, 17:09:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:09:20 INFO - 'tests': ['dromaeo_dom']}, 17:09:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:09:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:09:20 INFO - 'tests': ['basic_compositor_video']}, 17:09:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:09:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:09:20 INFO - 'tests': ['a11yr', 17:09:20 INFO - 'ts_paint', 17:09:20 INFO - 'tpaint', 17:09:20 INFO - 'sessionrestore', 17:09:20 INFO - 'sessionrestore_no_auto_restore', 17:09:20 INFO - 'tabpaint']}, 17:09:20 INFO - 'other-e10s': {'tests': ['a11yr', 17:09:20 INFO - 'ts_paint', 17:09:20 INFO - 'tpaint', 17:09:20 INFO - 'sessionrestore', 17:09:20 INFO - 'sessionrestore_no_auto_restore', 17:09:20 INFO - 'tabpaint']}, 17:09:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:09:20 INFO - 'ts_paint', 17:09:20 INFO - 'tpaint', 17:09:20 INFO - 'sessionrestore', 17:09:20 INFO - 'sessionrestore_no_auto_restore', 17:09:20 INFO - 'tabpaint']}, 17:09:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:09:20 INFO - 'ts_paint', 17:09:20 INFO - 'tpaint', 17:09:20 INFO - 'sessionrestore', 17:09:20 INFO - 'sessionrestore_no_auto_restore', 17:09:20 INFO - 'tabpaint']}, 17:09:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:09:20 INFO - 'tests': ['a11yr', 17:09:20 INFO - 'ts_paint', 17:09:20 INFO - 'tpaint', 17:09:20 INFO - 'sessionrestore', 17:09:20 INFO - 'sessionrestore_no_auto_restore', 17:09:20 INFO - 'tabpaint']}, 17:09:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:09:20 INFO - 'tests': ['a11yr', 17:09:20 INFO - 'ts_paint', 17:09:20 INFO - 'tpaint', 17:09:20 INFO - 'sessionrestore', 17:09:20 INFO - 'sessionrestore_no_auto_restore', 17:09:20 INFO - 'tabpaint']}, 17:09:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:09:20 INFO - 'tests': ['tsvgx', 17:09:20 INFO - 'tsvgr_opacity', 17:09:20 INFO - 'tart', 17:09:20 INFO - 'tscrollx', 17:09:20 INFO - 'cart']}, 17:09:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:09:20 INFO - 'tsvgr_opacity', 17:09:20 INFO - 'tart', 17:09:20 INFO - 'tscrollx', 17:09:20 INFO - 'cart']}, 17:09:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:20 INFO - 'talos_options': ['--disable-e10s'], 17:09:20 INFO - 'tests': ['tp5o']}, 17:09:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:20 INFO - 'tests': ['tp5o']}, 17:09:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:20 INFO - 'talos_options': ['--disable-e10s', 17:09:20 INFO - '--xperf_path', 17:09:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:09:20 INFO - 'tests': ['tp5n']}, 17:09:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:20 INFO - 'talos_options': ['--xperf_path', 17:09:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:09:20 INFO - 'tests': ['tp5n']}}, 17:09:20 INFO - 'talos.zip': {'path': '', 17:09:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:09:20 INFO - Running post-action listener: _resource_record_post_action 17:09:20 INFO - [mozharness: 2016-07-30 00:09:20.425594Z] Finished populate-webroot step (success) 17:09:20 INFO - [mozharness: 2016-07-30 00:09:20.425682Z] Running create-virtualenv step. 17:09:20 INFO - Running pre-action listener: _resource_record_pre_action 17:09:20 INFO - Running main action method: create_virtualenv 17:09:20 INFO - Creating virtualenv /builds/slave/test/build/venv 17:09:20 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 17:09:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:09:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:09:20 INFO - Using real prefix '/usr' 17:09:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:09:21 INFO - Installing distribute.............................................................................................................................................................................................done. 17:09:22 INFO - Installing pip.................done. 17:09:23 INFO - Return code: 0 17:09:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:09:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2522030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e13b0>, '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 0x27e22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e2740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1469836837.273657-140640478', '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 17:09:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:09:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:09:23 INFO - Using env: {'DISPLAY': ':0', 17:09:23 INFO - 'HOME': '/home/cltbld', 17:09:23 INFO - 'LANG': 'en_US.UTF-8', 17:09:23 INFO - 'LANGUAGE': 'en_US:en', 17:09:23 INFO - 'LOGNAME': 'cltbld', 17:09:23 INFO - 'MAIL': '/var/mail/cltbld', 17:09:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:23 INFO - 'MOZ_NO_REMOTE': '1', 17:09:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:23 INFO - 'NO_EM_RESTART': '1', 17:09:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:23 INFO - 'PWD': '/builds/slave/test', 17:09:23 INFO - 'SHELL': '/bin/bash', 17:09:23 INFO - 'SHLVL': '1', 17:09:23 INFO - 'TERM': 'linux', 17:09:23 INFO - 'TMOUT': '86400', 17:09:23 INFO - 'USER': 'cltbld', 17:09:23 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1469836837.273657-140640478', 17:09:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:23 INFO - '_': '/tools/buildbot/bin/python'} 17:09:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:23 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 17:09:23 INFO - Cleaning up... 17:09:23 INFO - Return code: 0 17:09:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:09:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2522030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e13b0>, '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 0x27e22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e2740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1469836837.273657-140640478', '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 17:09:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:09:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:09:23 INFO - Using env: {'DISPLAY': ':0', 17:09:23 INFO - 'HOME': '/home/cltbld', 17:09:23 INFO - 'LANG': 'en_US.UTF-8', 17:09:23 INFO - 'LANGUAGE': 'en_US:en', 17:09:23 INFO - 'LOGNAME': 'cltbld', 17:09:23 INFO - 'MAIL': '/var/mail/cltbld', 17:09:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:23 INFO - 'MOZ_NO_REMOTE': '1', 17:09:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:23 INFO - 'NO_EM_RESTART': '1', 17:09:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:23 INFO - 'PWD': '/builds/slave/test', 17:09:23 INFO - 'SHELL': '/bin/bash', 17:09:23 INFO - 'SHLVL': '1', 17:09:23 INFO - 'TERM': 'linux', 17:09:23 INFO - 'TMOUT': '86400', 17:09:23 INFO - 'USER': 'cltbld', 17:09:23 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1469836837.273657-140640478', 17:09:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:23 INFO - '_': '/tools/buildbot/bin/python'} 17:09:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:23 INFO - Downloading/unpacking psutil>=3.1.1 17:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:09:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:09:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:09:25 INFO - Installing collected packages: psutil 17:09:25 INFO - Running setup.py install for psutil 17:09:25 INFO - building 'psutil._psutil_linux' extension 17:09:25 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 17:09:25 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 17:09:25 INFO - building 'psutil._psutil_posix' extension 17:09:25 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 17:09:25 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 17:09:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:09:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:09:25 INFO - Successfully installed psutil 17:09:25 INFO - Cleaning up... 17:09:26 INFO - Return code: 0 17:09:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:09:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:26 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 0x2522030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e13b0>, '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 0x27e22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e2740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1469836837.273657-140640478', '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 17:09:26 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 17:09:26 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 17:09:26 INFO - Using env: {'DISPLAY': ':0', 17:09:26 INFO - 'HOME': '/home/cltbld', 17:09:26 INFO - 'LANG': 'en_US.UTF-8', 17:09:26 INFO - 'LANGUAGE': 'en_US:en', 17:09:26 INFO - 'LOGNAME': 'cltbld', 17:09:26 INFO - 'MAIL': '/var/mail/cltbld', 17:09:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:26 INFO - 'MOZ_NO_REMOTE': '1', 17:09:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:26 INFO - 'NO_EM_RESTART': '1', 17:09:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:26 INFO - 'PWD': '/builds/slave/test', 17:09:26 INFO - 'SHELL': '/bin/bash', 17:09:26 INFO - 'SHLVL': '1', 17:09:26 INFO - 'TERM': 'linux', 17:09:26 INFO - 'TMOUT': '86400', 17:09:26 INFO - 'USER': 'cltbld', 17:09:26 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1469836837.273657-140640478', 17:09:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:26 INFO - '_': '/tools/buildbot/bin/python'} 17:09:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:09:26 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 17:09:26 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 17:09:26 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 17:09:26 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 17:09:26 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 17:09:26 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 17:09:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:09:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:09:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:09:28 INFO - Installing collected packages: mozsystemmonitor 17:09:28 INFO - Running setup.py install for mozsystemmonitor 17:09:28 INFO - Successfully installed mozsystemmonitor 17:09:28 INFO - Cleaning up... 17:09:28 INFO - Return code: 0 17:09:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:09: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')]} 17:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09: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')]} 17:09:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2522030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e13b0>, '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 0x27e22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e2740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1469836837.273657-140640478', '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 17:09:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:09:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:09:28 INFO - Using env: {'DISPLAY': ':0', 17:09:28 INFO - 'HOME': '/home/cltbld', 17:09:28 INFO - 'LANG': 'en_US.UTF-8', 17:09:28 INFO - 'LANGUAGE': 'en_US:en', 17:09:28 INFO - 'LOGNAME': 'cltbld', 17:09:28 INFO - 'MAIL': '/var/mail/cltbld', 17:09:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:28 INFO - 'MOZ_NO_REMOTE': '1', 17:09:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:28 INFO - 'NO_EM_RESTART': '1', 17:09:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:28 INFO - 'PWD': '/builds/slave/test', 17:09:28 INFO - 'SHELL': '/bin/bash', 17:09:28 INFO - 'SHLVL': '1', 17:09:28 INFO - 'TERM': 'linux', 17:09:28 INFO - 'TMOUT': '86400', 17:09:28 INFO - 'USER': 'cltbld', 17:09:28 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1469836837.273657-140640478', 17:09:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:28 INFO - '_': '/tools/buildbot/bin/python'} 17:09:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:28 INFO - Downloading/unpacking jsonschema==2.5.1 17:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:09:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:30 INFO - Downloading functools32-3.2.3-2.tar.gz 17:09:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:09:30 INFO - warning: no files found matching '*.txt' 17:09:30 INFO - no previously-included directories found matching 'build' 17:09:30 INFO - no previously-included directories found matching 'dist' 17:09:30 INFO - no previously-included directories found matching '.git*' 17:09:30 INFO - Installing collected packages: jsonschema, functools32 17:09:30 INFO - Running setup.py install for functools32 17:09:30 INFO - warning: no files found matching '*.txt' 17:09:30 INFO - no previously-included directories found matching 'build' 17:09:30 INFO - no previously-included directories found matching 'dist' 17:09:30 INFO - no previously-included directories found matching '.git*' 17:09:30 INFO - Successfully installed jsonschema functools32 17:09:30 INFO - Cleaning up... 17:09:30 INFO - Return code: 0 17:09:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:09: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')]} 17:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09: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')]} 17:09:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:30 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 0x2522030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e13b0>, '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 0x27e22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e2740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1469836837.273657-140640478', '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 17:09:30 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 17:09:30 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 17:09:30 INFO - Using env: {'DISPLAY': ':0', 17:09:30 INFO - 'HOME': '/home/cltbld', 17:09:30 INFO - 'LANG': 'en_US.UTF-8', 17:09:30 INFO - 'LANGUAGE': 'en_US:en', 17:09:30 INFO - 'LOGNAME': 'cltbld', 17:09:30 INFO - 'MAIL': '/var/mail/cltbld', 17:09:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:30 INFO - 'MOZ_NO_REMOTE': '1', 17:09:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:30 INFO - 'NO_EM_RESTART': '1', 17:09:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:30 INFO - 'PWD': '/builds/slave/test', 17:09:30 INFO - 'SHELL': '/bin/bash', 17:09:30 INFO - 'SHLVL': '1', 17:09:30 INFO - 'TERM': 'linux', 17:09:30 INFO - 'TMOUT': '86400', 17:09:30 INFO - 'USER': 'cltbld', 17:09:30 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1469836837.273657-140640478', 17:09:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:30 INFO - '_': '/tools/buildbot/bin/python'} 17:09:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:09:31 INFO - Cleaning up... 17:09:31 INFO - Return code: 0 17:09:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:09:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2522030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e13b0>, '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 0x27e22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e2740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1469836837.273657-140640478', '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 17:09:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:09:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:09:31 INFO - Using env: {'DISPLAY': ':0', 17:09:31 INFO - 'HOME': '/home/cltbld', 17:09:31 INFO - 'LANG': 'en_US.UTF-8', 17:09:31 INFO - 'LANGUAGE': 'en_US:en', 17:09:31 INFO - 'LOGNAME': 'cltbld', 17:09:31 INFO - 'MAIL': '/var/mail/cltbld', 17:09:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:31 INFO - 'MOZ_NO_REMOTE': '1', 17:09:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:31 INFO - 'NO_EM_RESTART': '1', 17:09:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:31 INFO - 'PWD': '/builds/slave/test', 17:09:31 INFO - 'SHELL': '/bin/bash', 17:09:31 INFO - 'SHLVL': '1', 17:09:31 INFO - 'TERM': 'linux', 17:09:31 INFO - 'TMOUT': '86400', 17:09:31 INFO - 'USER': 'cltbld', 17:09:31 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1469836837.273657-140640478', 17:09:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:31 INFO - '_': '/tools/buildbot/bin/python'} 17:09:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:31 INFO - Downloading/unpacking blobuploader==1.2.4 17:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:33 INFO - Downloading blobuploader-1.2.4.tar.gz 17:09:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:09:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:09:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:09:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:09:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:33 INFO - Downloading docopt-0.6.1.tar.gz 17:09:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:09:33 INFO - Installing collected packages: blobuploader, requests, docopt 17:09:33 INFO - Running setup.py install for blobuploader 17:09:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:09:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:09:34 INFO - Running setup.py install for requests 17:09:34 INFO - Running setup.py install for docopt 17:09:34 INFO - Successfully installed blobuploader requests docopt 17:09:34 INFO - Cleaning up... 17:09:34 INFO - Return code: 0 17:09:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:09: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')]} 17:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09: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')]} 17:09:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:34 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 0x2522030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e13b0>, '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 0x27e22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e2740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1469836837.273657-140640478', '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 17:09:34 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 17:09:34 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 17:09:34 INFO - Using env: {'DISPLAY': ':0', 17:09:34 INFO - 'HOME': '/home/cltbld', 17:09:34 INFO - 'LANG': 'en_US.UTF-8', 17:09:34 INFO - 'LANGUAGE': 'en_US:en', 17:09:34 INFO - 'LOGNAME': 'cltbld', 17:09:34 INFO - 'MAIL': '/var/mail/cltbld', 17:09:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:34 INFO - 'MOZ_NO_REMOTE': '1', 17:09:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:34 INFO - 'NO_EM_RESTART': '1', 17:09:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:34 INFO - 'PWD': '/builds/slave/test', 17:09:34 INFO - 'SHELL': '/bin/bash', 17:09:34 INFO - 'SHLVL': '1', 17:09:34 INFO - 'TERM': 'linux', 17:09:34 INFO - 'TMOUT': '86400', 17:09:34 INFO - 'USER': 'cltbld', 17:09:34 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1469836837.273657-140640478', 17:09:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:34 INFO - '_': '/tools/buildbot/bin/python'} 17:09:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:09:34 INFO - Running setup.py (path:/tmp/pip-lNeaw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:09:34 INFO - Running setup.py (path:/tmp/pip-lrVEWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:09:34 INFO - Running setup.py (path:/tmp/pip-ioNwxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:09:34 INFO - Running setup.py (path:/tmp/pip-HWsYgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:09:35 INFO - Running setup.py (path:/tmp/pip-e0vM8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:09:35 INFO - Running setup.py (path:/tmp/pip-2KSdZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:09:35 INFO - Running setup.py (path:/tmp/pip-BihkS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:09:35 INFO - Running setup.py (path:/tmp/pip-0BNUqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:09:35 INFO - Running setup.py (path:/tmp/pip-GQGiAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:09:35 INFO - Running setup.py (path:/tmp/pip-8YsmK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:09:35 INFO - Running setup.py (path:/tmp/pip-j4BVQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:09:35 INFO - Running setup.py (path:/tmp/pip-jHcEil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:09:35 INFO - Running setup.py (path:/tmp/pip-e7Oa00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:09:35 INFO - Running setup.py (path:/tmp/pip-y0WWbW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:09:35 INFO - Running setup.py (path:/tmp/pip-6rnl3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:09:35 INFO - Running setup.py (path:/tmp/pip-cz2Ohd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:09:35 INFO - Running setup.py (path:/tmp/pip-zhaU8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:09:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:09:35 INFO - Running setup.py install for manifestparser 17:09:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:09:36 INFO - Running setup.py install for mozcrash 17:09:36 INFO - Running setup.py install for mozdebug 17:09:36 INFO - Running setup.py install for mozdevice 17:09:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:09:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:09:36 INFO - Running setup.py install for mozfile 17:09:36 INFO - Running setup.py install for mozhttpd 17:09:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:09:36 INFO - Running setup.py install for mozinfo 17:09:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:09:36 INFO - Running setup.py install for mozInstall 17:09:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:09:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:09:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:09:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:09:36 INFO - Running setup.py install for mozleak 17:09:36 INFO - Running setup.py install for mozlog 17:09:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:09:37 INFO - Running setup.py install for moznetwork 17:09:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:09:37 INFO - Running setup.py install for mozprocess 17:09:37 INFO - Running setup.py install for mozprofile 17:09:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:09:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:09:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:09:37 INFO - Running setup.py install for mozrunner 17:09:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:09:37 INFO - Running setup.py install for mozscreenshot 17:09:37 INFO - Running setup.py install for moztest 17:09:37 INFO - Running setup.py install for mozversion 17:09:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:09:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:09:37 INFO - Cleaning up... 17:09:37 INFO - Return code: 0 17:09:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:09:37 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')]} 17:09:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:37 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')]} 17:09:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:37 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 0x2522030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e13b0>, '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 0x27e22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e2740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1469836837.273657-140640478', '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 17:09:37 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 17:09:37 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 17:09:37 INFO - Using env: {'DISPLAY': ':0', 17:09:37 INFO - 'HOME': '/home/cltbld', 17:09:37 INFO - 'LANG': 'en_US.UTF-8', 17:09:37 INFO - 'LANGUAGE': 'en_US:en', 17:09:37 INFO - 'LOGNAME': 'cltbld', 17:09:37 INFO - 'MAIL': '/var/mail/cltbld', 17:09:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:37 INFO - 'MOZ_NO_REMOTE': '1', 17:09:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:37 INFO - 'NO_EM_RESTART': '1', 17:09:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:37 INFO - 'PWD': '/builds/slave/test', 17:09:37 INFO - 'SHELL': '/bin/bash', 17:09:37 INFO - 'SHLVL': '1', 17:09:37 INFO - 'TERM': 'linux', 17:09:37 INFO - 'TMOUT': '86400', 17:09:37 INFO - 'USER': 'cltbld', 17:09:37 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1469836837.273657-140640478', 17:09:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:37 INFO - '_': '/tools/buildbot/bin/python'} 17:09:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:09:37 INFO - Running setup.py (path:/tmp/pip-6vFD3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:09:38 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)) 17:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:09:38 INFO - Running setup.py (path:/tmp/pip-xWHOZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:09:38 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)) 17:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:09:38 INFO - Running setup.py (path:/tmp/pip-wOC6pB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:09:38 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)) 17:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:09:38 INFO - Running setup.py (path:/tmp/pip-2xPhKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:09:38 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)) 17:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:09:38 INFO - Running setup.py (path:/tmp/pip-EECkfB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:09:38 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)) 17:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:09:38 INFO - Running setup.py (path:/tmp/pip-g_b38O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:09:38 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)) 17:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:09:38 INFO - Running setup.py (path:/tmp/pip-uSUn6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:09:38 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)) 17:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:09:38 INFO - Running setup.py (path:/tmp/pip-xtuggQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:09:38 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)) 17:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:09:38 INFO - Running setup.py (path:/tmp/pip-H7mHcX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:09:38 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)) 17:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:09:38 INFO - Running setup.py (path:/tmp/pip-iRu9h0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:09:38 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)) 17:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:09:38 INFO - Running setup.py (path:/tmp/pip-asYQyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:09:38 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)) 17:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:09:38 INFO - Running setup.py (path:/tmp/pip-ooqRNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:09:38 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)) 17:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:09:38 INFO - Running setup.py (path:/tmp/pip-kZ9uA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:09:38 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)) 17:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:09:38 INFO - Running setup.py (path:/tmp/pip-0t2Tt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:09:39 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)) 17:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:09:39 INFO - Running setup.py (path:/tmp/pip-lutLqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:09:39 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)) 17:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:09:39 INFO - Running setup.py (path:/tmp/pip-hfZpma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:09:39 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)) 17:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:09:39 INFO - Running setup.py (path:/tmp/pip-Ek1J0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:09:39 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)) 17:09:39 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)) 17:09:39 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)) 17:09:39 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)) 17:09:39 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)) 17:09:39 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)) 17:09:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:09: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 17:09: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 17:09: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 17:09: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 17:09: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 17:09: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 17:09:41 INFO - Downloading blessings-1.6.tar.gz 17:09:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:09:41 INFO - Installing collected packages: blessings 17:09:41 INFO - Running setup.py install for blessings 17:09:41 INFO - Successfully installed blessings 17:09:41 INFO - Cleaning up... 17:09:41 INFO - Return code: 0 17:09:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:09:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:09:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:09:41 INFO - Reading from file tmpfile_stdout 17:09:41 INFO - Current package versions: 17:09:41 INFO - argparse == 1.2.1 17:09:41 INFO - blessings == 1.6 17:09:41 INFO - blobuploader == 1.2.4 17:09:41 INFO - docopt == 0.6.1 17:09:41 INFO - functools32 == 3.2.3-2 17:09:41 INFO - jsonschema == 2.5.1 17:09:41 INFO - manifestparser == 1.1 17:09:41 INFO - mozInstall == 1.12 17:09:41 INFO - mozcrash == 0.17 17:09:41 INFO - mozdebug == 0.1 17:09:41 INFO - mozdevice == 0.48 17:09:41 INFO - mozfile == 1.2 17:09:41 INFO - mozhttpd == 0.7 17:09:41 INFO - mozinfo == 0.9 17:09:41 INFO - mozleak == 0.1 17:09:41 INFO - mozlog == 3.3 17:09:41 INFO - moznetwork == 0.27 17:09:41 INFO - mozprocess == 0.23 17:09:41 INFO - mozprofile == 0.28 17:09:41 INFO - mozrunner == 6.12 17:09:41 INFO - mozscreenshot == 0.1 17:09:41 INFO - mozsystemmonitor == 0.3 17:09:41 INFO - moztest == 0.7 17:09:41 INFO - mozversion == 1.4 17:09:41 INFO - psutil == 3.1.1 17:09:41 INFO - requests == 1.2.3 17:09:41 INFO - wsgiref == 0.1.2 17:09:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:09: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')]} 17:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09: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')]} 17:09:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:41 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 0x2522030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e13b0>, '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 0x27e22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e2740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1469836837.273657-140640478', '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 17:09:41 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 17:09:41 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 17:09:41 INFO - Using env: {'DISPLAY': ':0', 17:09:41 INFO - 'HOME': '/home/cltbld', 17:09:41 INFO - 'LANG': 'en_US.UTF-8', 17:09:41 INFO - 'LANGUAGE': 'en_US:en', 17:09:41 INFO - 'LOGNAME': 'cltbld', 17:09:41 INFO - 'MAIL': '/var/mail/cltbld', 17:09:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:41 INFO - 'MOZ_NO_REMOTE': '1', 17:09:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:41 INFO - 'NO_EM_RESTART': '1', 17:09:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:41 INFO - 'PWD': '/builds/slave/test', 17:09:41 INFO - 'SHELL': '/bin/bash', 17:09:41 INFO - 'SHLVL': '1', 17:09:41 INFO - 'TERM': 'linux', 17:09:41 INFO - 'TMOUT': '86400', 17:09:41 INFO - 'USER': 'cltbld', 17:09:41 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1469836837.273657-140640478', 17:09:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:41 INFO - '_': '/tools/buildbot/bin/python'} 17:09:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:41 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)) 17:09:41 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)) 17:09:41 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)) 17:09:41 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)) 17:09:41 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)) 17:09:41 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)) 17:09:41 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)) 17:09:41 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)) 17:09:41 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)) 17:09:41 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)) 17:09:41 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)) 17:09:41 INFO - Cleaning up... 17:09:41 INFO - Return code: 0 17:09:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:09: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')]} 17:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09: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')]} 17:09:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2522030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e13b0>, '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 0x27e22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e2740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1469836837.273657-140640478', '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 17:09: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', 'jsonschema'] in /builds/slave/test/build 17:09: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 jsonschema 17:09:41 INFO - Using env: {'DISPLAY': ':0', 17:09:41 INFO - 'HOME': '/home/cltbld', 17:09:41 INFO - 'LANG': 'en_US.UTF-8', 17:09:41 INFO - 'LANGUAGE': 'en_US:en', 17:09:41 INFO - 'LOGNAME': 'cltbld', 17:09:41 INFO - 'MAIL': '/var/mail/cltbld', 17:09:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:41 INFO - 'MOZ_NO_REMOTE': '1', 17:09:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:41 INFO - 'NO_EM_RESTART': '1', 17:09:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:41 INFO - 'PWD': '/builds/slave/test', 17:09:41 INFO - 'SHELL': '/bin/bash', 17:09:41 INFO - 'SHLVL': '1', 17:09:41 INFO - 'TERM': 'linux', 17:09:41 INFO - 'TMOUT': '86400', 17:09:41 INFO - 'USER': 'cltbld', 17:09:41 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1469836837.273657-140640478', 17:09:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:41 INFO - '_': '/tools/buildbot/bin/python'} 17:09:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:09:42 INFO - Cleaning up... 17:09:42 INFO - Return code: 0 17:09:42 INFO - Running post-action listener: _resource_record_post_action 17:09:42 INFO - Running post-action listener: _start_resource_monitoring 17:09:42 INFO - Starting resource monitoring. 17:09:42 INFO - [mozharness: 2016-07-30 00:09:42.066858Z] Finished create-virtualenv step (success) 17:09:42 INFO - [mozharness: 2016-07-30 00:09:42.067288Z] Running install step. 17:09:42 INFO - Running pre-action listener: _resource_record_pre_action 17:09:42 INFO - Running main action method: install 17:09:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:09:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:09:42 INFO - Reading from file tmpfile_stdout 17:09:42 INFO - Detecting whether we're running mozinstall >=1.0... 17:09:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:09:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:09:42 INFO - Reading from file tmpfile_stdout 17:09:42 INFO - Output received: 17:09:42 INFO - Usage: mozinstall [options] installer 17:09:42 INFO - Options: 17:09:42 INFO - -h, --help show this help message and exit 17:09:42 INFO - -d DEST, --destination=DEST 17:09:42 INFO - Directory to install application into. [default: 17:09:42 INFO - "/builds/slave/test"] 17:09:42 INFO - --app=APP Application being installed. [default: firefox] 17:09:42 INFO - mkdir: /builds/slave/test/build/application 17:09:42 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'] 17:09:42 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 17:09:59 INFO - Reading from file tmpfile_stdout 17:09:59 INFO - Output received: 17:09:59 INFO - /builds/slave/test/build/application/firefox/firefox 17:09:59 INFO - Running post-action listener: _resource_record_post_action 17:09:59 INFO - [mozharness: 2016-07-30 00:09:59.648113Z] Finished install step (success) 17:09:59 INFO - [mozharness: 2016-07-30 00:09:59.648389Z] Running run-tests step. 17:09:59 INFO - Running pre-action listener: _resource_record_pre_action 17:09:59 INFO - Running main action method: run_tests 17:09:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:09:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:09:59 INFO - Python 2.7.3 17:09:59 INFO - Return code: 0 17:09:59 INFO - grabbing minidump binary from tooltool 17:09:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:59 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 0x27e13b0>, '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 0x27e22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e2740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:09:59 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 17:09:59 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 17:09:59 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 17:09:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:09:59 INFO - Return code: 0 17:09:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:09:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:09:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:09:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:09:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:09:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ODGCBl5aSAOP4Ozj7Ktslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 17:09:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ODGCBl5aSAOP4Ozj7Ktslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 17:09:59 INFO - Using env: {'DISPLAY': ':0', 17:09:59 INFO - 'HOME': '/home/cltbld', 17:09:59 INFO - 'LANG': 'en_US.UTF-8', 17:09:59 INFO - 'LANGUAGE': 'en_US:en', 17:09:59 INFO - 'LOGNAME': 'cltbld', 17:09:59 INFO - 'MAIL': '/var/mail/cltbld', 17:09:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:09:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:09:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:59 INFO - 'MOZ_NO_REMOTE': '1', 17:09:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:09:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:59 INFO - 'NO_EM_RESTART': '1', 17:09:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:59 INFO - 'PWD': '/builds/slave/test', 17:09:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:09:59 INFO - 'SHELL': '/bin/bash', 17:09:59 INFO - 'SHLVL': '1', 17:09:59 INFO - 'TERM': 'linux', 17:09:59 INFO - 'TMOUT': '86400', 17:09:59 INFO - 'USER': 'cltbld', 17:09:59 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1469836837.273657-140640478', 17:09:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:59 INFO - '_': '/tools/buildbot/bin/python'} 17:09:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ODGCBl5aSAOP4Ozj7Ktslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 17:09:59 INFO - mozversion application_buildid: 20160729143001 17:09:59 INFO - mozversion application_changeset: fa9e9291bfe34c20797978d5d6a8f4168bf961b8 17:09:59 INFO - mozversion application_display_name: Nightly 17:09:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:09:59 INFO - mozversion application_name: Firefox 17:09:59 INFO - mozversion application_remotingname: firefox 17:09:59 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:09:59 INFO - mozversion application_vendor: Mozilla 17:09:59 INFO - mozversion application_version: 50.0a1 17:09:59 INFO - mozversion platform_buildid: 20160729143001 17:09:59 INFO - mozversion platform_changeset: fa9e9291bfe34c20797978d5d6a8f4168bf961b8 17:09:59 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:09:59 INFO - mozversion platform_version: 50.0a1 17:09:59 INFO - using testdate: 1469837399 17:09:59 INFO - actual date: 1469837399 17:09:59 INFO - starting webserver on 'localhost:54023' 17:09:59 INFO - SUITE-START | Running 2 tests 17:09:59 INFO - TEST-START | dromaeo_css 17:09:59 INFO - operating with platform_type : linux_ 17:09:59 INFO - Initialising browser for dromaeo_css test... 17:09:59 INFO - TEST-INFO | started process 13102 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphfFR7l/profile http://localhost:54023/getInfo.html) 17:10:03 INFO - PROCESS | 13102 | JavaScript error: , line 0: uncaught exception: undefined 17:10:04 INFO - PROCESS | 13102 | __metrics Screen width/height:1600/1200 17:10:04 INFO - PROCESS | 13102 | colorDepth:24 17:10:04 INFO - PROCESS | 13102 | Browser inner width/height: 1024/697 17:10:04 INFO - PROCESS | 13102 | __metrics 17:10:05 INFO - PROCESS | 13102 | 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" 17:10:05 INFO - PROCESS | 13102 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:10:05 INFO - PROCESS | 13102 | console.error: PushService: 17:10:05 INFO - PROCESS | 13102 | stateChangeProcessEnqueue: Error transitioning state 17:10:05 INFO - PROCESS | 13102 | UnknownError 17:10:06 INFO - TEST-INFO | 13102: exit 0 17:10:06 INFO - Browser initialized. 17:10:06 INFO - Running cycle 1/1 for dromaeo_css test... 17:10:06 INFO - TEST-INFO | started process 13181 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphfFR7l/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:10:17 INFO - PROCESS | 13181 | RSS: Main: 158134272 17:10:17 INFO - PROCESS | 13181 | 17:11:09 INFO - PROCESS | 13181 | 1469837469578 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] 17:13:17 INFO - PROCESS | 13181 | Cycle 1(1): loaded http://localhost:54023/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54023/tests/dromaeo/cssquery-ext.html) 17:13:18 INFO - PROCESS | 13181 | RSS: Main: 269234176 17:13:18 INFO - PROCESS | 13181 | 17:16:21 INFO - PROCESS | 13181 | Cycle 1(1): loaded http://localhost:54023/tests/dromaeo/cssquery-ext.html (next: http://localhost:54023/tests/dromaeo/cssquery-jquery.html) 17:16:21 INFO - PROCESS | 13181 | RSS: Main: 247037952 17:16:21 INFO - PROCESS | 13181 | 17:19:23 INFO - PROCESS | 13181 | Cycle 1(1): loaded http://localhost:54023/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54023/tests/dromaeo/cssquery-mootools.html) 17:19:24 INFO - PROCESS | 13181 | RSS: Main: 225058816 17:19:24 INFO - PROCESS | 13181 | 17:22:26 INFO - PROCESS | 13181 | Cycle 1(1): loaded http://localhost:54023/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54023/tests/dromaeo/cssquery-prototype.html) 17:22:27 INFO - PROCESS | 13181 | RSS: Main: 222339072 17:22:27 INFO - PROCESS | 13181 | 17:25:29 INFO - PROCESS | 13181 | Cycle 1(1): loaded http://localhost:54023/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54023/tests/dromaeo/cssquery-yui.html) 17:25:30 INFO - PROCESS | 13181 | RSS: Main: 186372096 17:25:30 INFO - PROCESS | 13181 | 17:28:33 INFO - PROCESS | 13181 | Cycle 1(1): loaded http://localhost:54023/tests/dromaeo/cssquery-yui.html (next: http://localhost:54023/tests/dromaeo/cssquery-dojo.html) 17:28:33 INFO - PROCESS | 13181 | RSS: Main: 280801280 17:28:33 INFO - PROCESS | 13181 | 17:28:33 INFO - PROCESS | 13181 | __start_tp_report 17:28:33 INFO - PROCESS | 13181 | _x_x_mozilla_page_load 17:28:33 INFO - PROCESS | 13181 | _x_x_mozilla_page_load_details 17:28:33 INFO - PROCESS | 13181 | |i|pagename|runs| 17:28:33 INFO - PROCESS | 13181 | |0;dojo.html;3010.2624856910056;3010.774191935604;3033.6814634463376;3044.573759673645;3071.339661972677;5181.326427564421;5230.34620672416;5253.264542963988;5294.232336311237;5351.999999999995;5293.020791153639;5318.069337865877;5344.652597581165;5349.893002139955;5404.351477822667;4840.733759643218;4845.3216549683075;4920;4941.851744447672;5055.797768089272;4949.505049495057;4975.9004819903585;5012.699238045729;5028.371453568304;5033.647644664875;4790.233562629997;4842.612590992712;4904.117258893398;4904.362432883738;4991.226359914219;4899.632527560448;4901.897073158547;4912.164931961575;4924.359833221658;5013.047520971004;4876.609871210295;4878.487758785347;4881.194602890519;4933.605311575066;4967;5208.869778255536;5307.018201632672;5330.733463326818;5378.838634840961;5488.341399032141;5762.596618236725;5763.740631671585;5785.247917770705;5813.593048486608;5817.360090390053;5850.6489610623075;5851.151583020438;5854.970725146347;5863.208466856962;5880.117982302646;5167.689938603696;5319.867003324909;5396.946030539644;5399.514043736082;5440.156775699773;5976.491998180117;6012.30858451275;6013.579049466583;6013.609115407485;6017.638941663514;5730.19777231188;5744.741486633028;5746.856328591819;5747.741351639186;5753.741081651336;5550.222968784374;5701.344345400332;5774.047282198474;5786.94213057864;5823.010088285002;5778;5813.854653633608;5816.389279125716;5822.097574875901;5855.970720146372;5758.942410575841;5798.478136967693;5808.564357673192;5810;5817.534597232296;4296.334068219431;4332.696711230246;4347.8260869564865;4362.934555981663;4440.267355886307;3899.74651647642;3903;3944.7041471889725;3944.9802750986637;3975.5626881043063;5403.5136837684795;5414.864628384322;5418.647787893774;5425.240466334716;5456.290682211366;5571.192177134374;5692.288463942007;5761.9135712964335;5765.308163020464;5808.680522571299;5460.918086228709;5464.0711079116645;5467.972660136674;5487.670739755627;5489.039418101816;4992.450830408652;4992.500749924979;5000.924986125211;5003.149464591028;5049.166887463601;5813.883722325614;5903.881922361528;5966.2243908290775;5986.491148252448;6000.489958353502;5801.912971305349;5803.332616749128;5805.303363596396;5827.155062515996;5860.589758716849;5998.730057147526;6004.729787159501;6007.189029480965;6010.789622363196;6017.428344307284;5500.532454741392;5559.861003474945;5592.888142237051;5646.153077038477;5717.628354156966;5705.172749951151;5743.052396354722;5757.596968212185;5777.768889244383;5805.506531944663;5618.044932361427;5624.606277560531;5628.634138780966;5633.549316054788;5641.971790141023;5443.265159203457;5555.416681248573;5587.804426845041;5598.86002849932;5599.1041433370465;5596.664200148004;5599.776008959596;5615.354234263112;5634.154876768517;5635.6618602883955;5697.886042279214;5698.2592263005545;5751.223584815996;5752.9712351437975;5759.395263497272;5483.506484416422;5505.449455054462;5552.333719953632;5579.553635709052;5589.888202236014 17:28:33 INFO - PROCESS | 13181 | |1;ext.html;600.7897235967412;616.6454288783949;632.6109442692742;634.3878157577938;644.6776611694153;43308.78345608272;45358.77320613396;45360.09279814402;45386.54613453864;47701.284480732815;45336.546634533646;45501;45720.771396143056;45722.54277457233;45810.541894581045;9039.774005649879;9168.679096231634;9178.173964343208;9178.265738740918;9189.72430827073;8991.865122023175;9065.773355666128;9072.909270907272;9076.31927605429;9080.909190908073;9114.817703645924;9120.133587309196;9127.452352858816;9140.085991400872;9147.268218542535;9053.864192037125;9058.818823623524;9106.77233069172;9108.453492790453;9109.089091090904;8963.820723585557;8992.640294388217;9014.86477702835;9020.729378118667;9030.729078127666;42505.78747106276;42964;42994;43058.2012169208;43264;3489.685928266468;3626.4197728363333;3681.5029970953847;3822.7706337619834;4413.337999300131;32942;33027.504587431205;33531.329373412394;33551.664483355096;33574.49638255428;4290.377895205209;4439.600435960747;4470.865874023784;4494.280915053576;4591.104734576759;337266;337734;338236.3088184568;338899;339243;57736;57934.71032644894;57964;58046;58080;59485.10772338332;59851.10223346653;60378;60637;60752.69623651853;14162.787558186636;14302.64006438926;14373;14373.353199106064;14410.495632653017;10399.636012739518;10405.687829365132;10435.217358698128;10437.843432348522;10440.947795261127;15204.923975380274;16040.919795401182;16099.436519721754;16181.514554563382;16260.105694186934;5874.882502350015;5893.174955506232;5979.4917432018765;6049.5462840287155;6201.596896201732;1004.2367800471694;1029.4749677664295;1044.4099084017505;1085.5386460754148;1177.7173478365303;32372.838135809172;32863.1784205392;32957.67042329546;33085.83457082747;33565.16087097842;1104.5692180049787;1134.9375784331776;1146.529922731676;1170.3329102411544;1213.0356366688504;16287.267072981744;17234.482965511055;17329.913350433166;17594.472165835046;17672.646547068987;563103;592216;600365;605919;861984;59698.70150649219;60085.09872351918;60250;60256.69871650702;60282.39717602856;1253.0977696058824;1333.8932885369147;1342.0806747378272;1358.2529608715167;1379.620604333796;30079.248018799706;33465;33684;33916.32167356688;34271.657283426845;54711.72644136754;58790.706046469495;58826.411735882095;58859.411405885396;58893.411065890505;492945;496415;498757;500884;501066;27554.5866811994;27900.16299511018;29179.85410072936;29374.26564335823;29425.85287073551;48883;49122.508774911796;49208.50791492182;49487.50512494973;49550;40145.013905443455;40562;41207;42032;42298;40716.389254161804;41429.79285103555;41497.58502415058;42653.5734642662;42719.57280427156;31332.843335783175;41238.38142427806;41478.585214147475;42725.35911961385;44389.77805110954;35998.64001359953;37375;37599.5015576324;38248.808755956044;38656.61343386643;28410.85794571014;28460;28666.85666571654;28821.855890720413;28886.566701499072 17:28:33 INFO - PROCESS | 13181 | |2;jquery.html;377.2172741561261;385.7606593723438;390.3442217075314;395.3476763340488;414.4053283538123;14539.127652340867;17743.46769596911;18916.148773305198;20475.07862146203;20493.692594611075;15205.23973801311;17144.14279286037;18754.718679219823;19047.809521904775;19325.806741932578;5618.91571626426;5723.198752174699;5733.512651424613;5745.770169193248;5821.67980761058;5686.0617998030275;5761.625494342875;5762.510186634141;5766.798162064329;5769.1923130761725;5539.446055394468;5633.774649014034;5678.687672178028;5678.801241956532;5747.798827041054;5659.1511273309125;5689.772409103631;5696.2594862668;5696.487316141567;5699.116636921284;4908.9263661045115;5042.873928151789;5076.187809950427;5079.060373830816;5092.465291144451;23383.88308058466;23458.530829383315;23494.64758028631;23502.529949401087;23739.169129080572;2418.1415597462824;2572.65269188659;2915.1546051644996;3057.9694203057907;3147.339058797655;13962.930185349009;14350.210738409383;14773.778393324108;15189.240537973057;15195.62010949724;1832.3678330975924;1877.2029675783122;1946.3966170487054;1976.505873531617;2082.98958505208;81183.59408202922;81608;83587;85327;86526.13473865244;10019.599216031424;10241.897581024243;10273.280870339004;10431.582736690447;10616.150707943347;14629.268536573341;14697.706045879237;14699.191544465157;14706.55880323592;14720.484783032542;7360.227176146427;7636.770896873103;7649.655765490566;7772.222777722295;7791.727289544839;7193.208747037822;7262.273772622695;7390.260973902567;7424.071991001125;7490.400767938552;5706.629069110578;6134.079888016833;6434.2600600930555;6513.576617519846;6558.770443034471;1823.2812136741102;1896.8198021187966;1907.2275728330048;1918.5491409518752;1925.8555608329432;933.9766505837408;952.7332346942867;1050.2280823594651;1076.5908954597203;1083.9078678312273;18584.535386615444;19435.611287774165;20273.17541421279;20327.796722032886;20429.795702043088;985.3595163144014;1032.550840384435;1075.6181555547669;1080.2168427889717;1080.2168427889874;8676.60955257015;10924.180686448548;11402.771944561062;11430.142739294586;11466.54133834654;549343;555128;559345;577662;578865;78481.60759196282;80245;80847;81588.06501447443;83108.58445707854;973.9659111931048;999.5601935148511;1007.5415685862915;1011.9038691324313;1022.3610243597751;16956.576085597957;17214.913925430294;17820.108994549963;17980.37068702589;18043.909780451013;43424;44108.0302772752;44718.3292250623;44762.3285650709;44956.100877981604;56827.43172568221;59558;61136.38863611307;61223;61469.692651538244;6889.207741109836;7117.359437650636;8195.549244791593;8360.12218717026;8413.368997325102;9563.474008929576;10271.435071071162;11069.094884344888;11189.160812939224;12374.010079193822;10374.792504149724;10413.166946644402;10572.682819515427;10618.460323253239;10622.044016038593;10510.684679459628;10636.946815265874;10668.30656007357;10782.622608208674;10959.945200273947;10831;10840.620578279722;10879.1840611956;11182.273152245078;11209.215354925076;10906.50920708554;10944.835827462435;11650.126240531825;11780;11918.986886114777;9057.320700947323;10897.727556810825;11248.550057997589;11448.713782155513;11605.419729013347 17:28:33 INFO - PROCESS | 13181 | |3;mootools.html;1462.4881291547956;1523.8323784383717;1659.701253774321;1665.7085010123226;1817.972730409044;8644.092370301121;9275.768105797342;9276.768080797983;9278.90721092789;9279.76800579985;7472.626368681557;8628.525431101287;8928.419652722569;8958.283337333014;9063.818723625523;2396.4248580340723;2423.9636405453844;2426.5632186206476;2427.6965379327585;2428.6642346709327;2372.78644921957;2400.8199385046105;2447.669564608782;2450.6936632920883;2454.153317105605;2407.4944261705064;2408.8795560222006;2415.04605680756;2425.9393515162087;2440.8291419600637;2335.474518233401;2340.941476463085;2341.8594884306913;2343.039353864916;2379.904803807863;2325.8837058147024;2335.649652552114;2335.74306826249;2336.1823361823394;2340.403197184707;9239.30705197113;9383.155516003593;9385.76535586609;9386.389884657543;9392.248620110375;5194.402643695986;5300.681959082467;5301.443348448396;5302.6023048271145;5304.522592966613;3200.9679903200904;3251.4960181171955;3288.96711032889;3291.670832916689;3302.8018318900704;1052.7736536644659;1072.2708558180434;2024.6558085125416;2092.6233278009954;2108.388567315477;12710.872891271061;12788.232706037574;12864.549740759028;12888.291143986984;12892.613221603367;4294.699371044059;4477.843275485342;4535.659825513099;4550.908981820345;4559.316102584638;10037.146842518321;10037.297389182688;10041.648542300984;10050.849237261447;10052.145567626687;5294.549963253166;5298.337707786527;5306.204069389545;5307.177387504943;5309.46905309466;4220.303649897794;4774.188387974053;4884.975575122102;4927.359443272351;4949.158643030693;3873.69010479161;3931.7837518936735;4019.879403617896;4027.5368332641533;4028.3554631258858;1146.0545050333508;1177.364223319415;1181.2262967756133;1189.6193218170276;1198.9940050299692;804.5574933786394;824.9010118785784;886.2201262888746;927.5872236854669;988.6292640259902;6105.908411373833;6155.35368786271;6225.221847269091;6505.186851643544;6508.446782023581;949.240607513986;958.9376690515094;980.9047227823808;998.825205589019;1028.92797504174;4016.1365306458665;4038.1519880825354;4104.979475102606;4251.787410629456;4334.8266069357505;11365.54537818478;11849.822252666218;11851.881481185077;11860.110491713156;11868.643940681794;11000.394978276272;11378.829317560243;11388.601398950997;11712.414379281003;11792.587259445878;8001;8094.473859199015;8138.959305203436;8147.959260203661;8151.95924020388;6283.523372007666;6286.622802631857;6339.28839213419;6395.16862807832;6490.675466226576;10475.266731328733;10692.358458492205;10706.304090234109;10797.406142662228;10848.349099054081;10780.946095269474;10985.231033827875;11002.779944401227;11011.559537618727;11013.83479247828;6994.230634630085;7877.527348359117;8119.066307374491;8150.144234855255;8235;8861.73414797557;9020.729378118667;9054.456732596065;9064.954675226581;9083.68207112748;7925.445218834626;8017.478863873829;8064.798380040546;8169.673213071411;8222.424430290062;7858.60706964638;7981.760547183594;7992.320652744582;8017.158198389086;8032.718854840053;7254.89117663246;7436.367908727819;7439.665215065227;7442;7450.292222238879;5199.454057324077;5301.390340110936;5394.514493695587;5463.699496527729;5487.039768040657;5095.87260318495;5170.896582068262;5217.556507696889;5271.604629652868;5401.6218864679095 17:28:33 INFO - PROCESS | 13181 | |4;prototype.html;311.08359133126936;325.26490132301;334.47654420831407;335.76664218368245;337.88005258133376;5296.205569164627;5337.572994160468;5386.218998245257;5396.78412863485;5400.243965844785;4990.725510096943;5143.254228136918;5146.228065790134;5151.922721159186;5280.841574752763;4019.296623090962;4083.9183216335728;4124.298869192229;4154.646855017327;4192.601702838226;4149.958500415002;4161.396597493362;4169.541350451448;4200.130941730931;4216.262154123032;4066.227416790815;4091.713580049398;4119.485064366954;4146.129312844291;4162.708610397273;4144.357624568197;4151.543330233702;4159.10579225468;4160.9375859362135;4168.7707176105305;3689.8339574719203;3709.3137769512728;3715.2755212733528;3717.4052151655605;3728.81355932205;5106.744662766847;5196.68819870809;5205.245239440298;5207.921881171747;5208.687478751249;4683.578477936968;4697.577218050357;4742.9525704742855;4758.0016393114975;4768.284757286435;5436.157395603688;5444.346678398618;5457.253678822739;5459.372172200168;5506.504414602665;3914.9804250978846;3984.0836607580127;3990;3991.345755072873;4016.2168377166463;5628.690422026787;5668.263125793662;5669.291338582677;5705.6291341063115;5719.571032172604;4070.9185816284103;4095.447114639545;4105.199486100182;4112.876613701594;4118.382242663624;4164.8125834337525;4176.227397931392;4198.8110535026;4202.558731333227;4205.495340559152;4433.334999750064;4562.429696287964;4613.469451013177;4618.284165954283;4626.306054091846;5539.169124631338;5558.333000040021;5568.387477377485;5571.9721401392735;5588.972055139699;1340.9262490562917;1399.3423091147145;1404.45226361719;1406.9226192559304;1409.2037998531002;875.6497401039635;965.5461932891529;976.9951150244345;981.4651015196735;983.0759086458849;5176.663516871391;5184.14461613837;5188.377394712658;5189.377274727057;5211.322528071402;5484.095124304525;5515.696636684941;5550.944490555043;5552.833414997556;5592.266397416814;5017.698938063728;5156.911450862407;5187.610929180327;5244.9737751310995;5245.842624721265;2971.5839782430476;2972.1975066732293;2973.6321292205826;2981.1801754517683;2989.880404783828;5637.295338082739;5778.566607504454;5791.420857914259;5804.593678442468;5808.767649293981;5818.592698511148;5832.708364581754;5841.561882858802;5842.912356314659;5845.450955496797;5846.766129354778;5895.823125306248;5926.399872034526;5939.970300148471;5955.225820643289;5512.732071623469;5661.207430959751;5710.2576665033275;5743.684097374685;5743.712814359349;5594.636348637326;5610.747516361692;5640.830775076754;5647.774089036392;5656.830295091154;5575.470330318613;5926.496247818984;5976.372480889444;6015.72929218195;6019.050665173946;4014.598540145962;4034.1528279061727;4056.8174432151213;4061.2892743770312;4083.244599749056;5500.22996780459;5614.775408983758;5650.604457687922;5678.68767217807;5698.0598201296325;5619.80330688424;5623.578231632562;5631.577631677558;5637.46444087811;5638.295213098363;5285.524302812765;5518.255035570147;5521.420250873601;5533.750981205775;5594.496495315441;5476.890462190813;5492.5331346835965;5493.615446918678;5497;5497.45025497447;5578.470045345685;5597.832065038056;5693.601447898607;5698.544116470755;5704.429557044263;5265.789368425373;5467.917981230365;5505.366882808368;5508.752106155152;5568.6658800472105 17:28:33 INFO - PROCESS | 13181 | |5;yui.html;707.2856415020827;730.7661548304538;743.5575832379735;801.1667865419963;812.772423721358;14397.784033239497;15258.313375898084;15645.530634080982;15771.21143942804;15890.76163857543;13145.868541314583;13407.73184536311;13408.128471649336;13410.932945335284;13419.731605367911;656.0585559721791;801.4550105927981;813.9389545784061;814.3363159025375;815.7389635316702;786.7993661616308;826.4958375391006;828.4780588229407;832.854250506162;833.3458235285302;860.290260535058;862.4738909265343;864.11859902899;864.2006144316514;864.5806783709895;686.8935315026129;857.695518091078;858.1504310732362;859.4585411190973;859.5444414460314;593.7357875745295;619.8977168767148;622.6233128957007;624.2758400255727;624.5503237668871;14148.221847798366;14231.146131232159;14245.358958846773;14294.92852535741;14307.28463576817;12920.676983075404;12979.480820767158;13175.934120329433;13363;14542.636434089127;13176;13233.73532529344;13426.925845932303;13501.122427042212;14024.789628155586;4354.891127721832;4378.496472905625;4433.955660443419;4509.706869053501;4615.169269531483;72384.6380768098;75429.99999999945;75434.24565754327;85999.57000214959;86664;11763.944931761784;11947.820782688266;11972.28038687795;12056.156069075081;12541.122121451594;22228.666570001464;22230.444238893833;22261.886905654977;22283.55432891333;22413.66379504309;8538.188872057144;8549.572521373906;8691.608877600524;8705.434146780439;8764.904386951632;4835.443923948791;4888.315635810989;5039.44566097729;5043.4956504349275;5121.948780512222;3432.262063656326;3482.164280572695;3518.401871681769;3525.1715846775987;3528.188516641187;612.5803824380314;640.6476437959104;644.2076246217085;644.5842431631571;658.2726087673052;626.5582764151262;708.6988030087192;732.8241222106656;736.5139008254527;753.0737193252221;8618.439801413013;9903.900960990442;9926.751831204278;10033.197344212445;10233.181345492343;683.460066547422;701.4038067642463;705.4990956420999;719.7049209824052;735.8638651849318;4645.187092258841;4922.532359425849;4943.233798761198;4960.702357858468;4977.303177555073;88697;120497.08575772791;120878.3956080214;122015;124304;87414;89638;104941;106014.46992765141;107680.38479422814;86155;88841.12912052387;90302;90309;94123;10229.48852557384;10444.688103117196;10924.2899211551;11079.944600276947;11127.276727012719;48117;50460.747696261285;51206.231906522175;51453;52981.20528192003;46304.76847615875;46490.76754616205;68231.33698966424;74322;80345;13376.464941402624;13706;13747.587572372844;13790.862091378958;14175.858241417867;15007.924960375129;15121.546353609408;15508.991915525456;16069.910911581419;16307.918460407622;14075.648108796953;14570.125792452487;14988.850111499181;15155.393784248947;15744.448944286894;13628.93185534066;13670.11144275619;13682.884193016396;13867.671758777618;14434.494792682206;13468.663283417993;15149.697006060038;15306.693866122838;15488.380464781734;15829;11222.66332010041;11397.886021140013;11408.429578521207;11415.60045398407;12121.575744848888;10163.898361016296;10648.89351106479;11316.6039188628;11465.31208127515;11681.474333654836 17:28:33 INFO - PROCESS | 13181 | __end_tp_report 17:28:33 INFO - PROCESS | 13181 | __start_cc_report 17:28:33 INFO - PROCESS | 13181 | _x_x_mozilla_cycle_collect,1009 17:28:33 INFO - PROCESS | 13181 | __end_cc_report 17:28:33 INFO - PROCESS | 13181 | __startTimestamp1469838513889__endTimestamp 17:28:33 INFO - PROCESS | 13181 | 17:28:33 INFO - PROCESS | 13181 | ------- Summary: start ------- 17:28:33 INFO - PROCESS | 13181 | Number of tests: 6 17:28:33 INFO - PROCESS | 13181 | 17:28:33 INFO - PROCESS | 13181 | [#0] dojo.html Cycles:165 Average:5358.43 Median:5559.86 stddev:624.96 (11.2%) stddev-sans-first:599.11 17:28:33 INFO - PROCESS | 13181 | Values: 3010.3 3010.8 3033.7 3044.6 3071.3 5181.3 5230.3 5253.3 5294.2 5352.0 5293.0 5318.1 5344.7 5349.9 5404.4 4840.7 4845.3 4920.0 4941.9 5055.8 4949.5 4975.9 5012.7 5028.4 5033.6 4790.2 4842.6 4904.1 4904.4 4991.2 4899.6 4901.9 4912.2 4924.4 5013.0 4876.6 4878.5 4881.2 4933.6 4967.0 5208.9 5307.0 5330.7 5378.8 5488.3 5762.6 5763.7 5785.2 5813.6 5817.4 5850.6 5851.2 5855.0 5863.2 5880.1 5167.7 5319.9 5396.9 5399.5 5440.2 5976.5 6012.3 6013.6 6013.6 6017.6 5730.2 5744.7 5746.9 5747.7 5753.7 5550.2 5701.3 5774.0 5786.9 5823.0 5778.0 5813.9 5816.4 5822.1 5856.0 5758.9 5798.5 5808.6 5810.0 5817.5 4296.3 4332.7 4347.8 4362.9 4440.3 3899.7 3903.0 3944.7 3945.0 3975.6 5403.5 5414.9 5418.6 5425.2 5456.3 5571.2 5692.3 5761.9 5765.3 5808.7 5460.9 5464.1 5468.0 5487.7 5489.0 4992.5 4992.5 5000.9 5003.1 5049.2 5813.9 5903.9 5966.2 5986.5 6000.5 5801.9 5803.3 5805.3 5827.2 5860.6 5998.7 6004.7 6007.2 6010.8 6017.4 5500.5 5559.9 5592.9 5646.2 5717.6 5705.2 5743.1 5757.6 5777.8 5805.5 5618.0 5624.6 5628.6 5633.5 5642.0 5443.3 5555.4 5587.8 5598.9 5599.1 5596.7 5599.8 5615.4 5634.2 5635.7 5697.9 5698.3 5751.2 5753.0 5759.4 5483.5 5505.4 5552.3 5579.6 5589.9 17:28:33 INFO - PROCESS | 13181 | 17:28:33 INFO - PROCESS | 13181 | [#1] ext.html Cycles:180 Average:64998.30 Median:42979.00 stddev:137131.95 (319.1%) stddev-sans-first:137431.40 17:28:33 INFO - PROCESS | 13181 | Values: 600.8 616.6 632.6 634.4 644.7 43308.8 45358.8 45360.1 45386.5 47701.3 45336.5 45501.0 45720.8 45722.5 45810.5 9039.8 9168.7 9178.2 9178.3 9189.7 8991.9 9065.8 9072.9 9076.3 9080.9 9114.8 9120.1 9127.5 9140.1 9147.3 9053.9 9058.8 9106.8 9108.5 9109.1 8963.8 8992.6 9014.9 9020.7 9030.7 42505.8 42964.0 42994.0 43058.2 43264.0 3489.7 3626.4 3681.5 3822.8 4413.3 32942.0 33027.5 33531.3 33551.7 33574.5 4290.4 4439.6 4470.9 4494.3 4591.1 337266.0 337734.0 338236.3 338899.0 339243.0 57736.0 57934.7 57964.0 58046.0 58080.0 59485.1 59851.1 60378.0 60637.0 60752.7 14162.8 14302.6 14373.0 14373.4 14410.5 10399.6 10405.7 10435.2 10437.8 10440.9 15204.9 16040.9 16099.4 16181.5 16260.1 5874.9 5893.2 5979.5 6049.5 6201.6 1004.2 1029.5 1044.4 1085.5 1177.7 32372.8 32863.2 32957.7 33085.8 33565.2 1104.6 1134.9 1146.5 1170.3 1213.0 16287.3 17234.5 17329.9 17594.5 17672.6 563103.0 592216.0 600365.0 605919.0 861984.0 59698.7 60085.1 60250.0 60256.7 60282.4 1253.1 1333.9 1342.1 1358.3 1379.6 30079.2 33465.0 33684.0 33916.3 34271.7 54711.7 58790.7 58826.4 58859.4 58893.4 492945.0 496415.0 498757.0 500884.0 501066.0 27554.6 27900.2 29179.9 29374.3 29425.9 48883.0 49122.5 49208.5 49487.5 49550.0 40145.0 40562.0 41207.0 42032.0 42298.0 40716.4 41429.8 41497.6 42653.6 42719.6 31332.8 41238.4 41478.6 42725.4 44389.8 35998.6 37375.0 37599.5 38248.8 38656.6 28410.9 28460.0 28666.9 28821.9 28886.6 17:28:33 INFO - PROCESS | 13181 | 17:28:33 INFO - PROCESS | 13181 | [#2] jquery.html Cycles:180 Average:30922.13 Median:23620.85 stddev:92557.93 (391.8%) stddev-sans-first:92789.16 17:28:33 INFO - PROCESS | 13181 | Values: 377.2 385.8 390.3 395.3 414.4 14539.1 17743.5 18916.1 20475.1 20493.7 15205.2 17144.1 18754.7 19047.8 19325.8 5618.9 5723.2 5733.5 5745.8 5821.7 5686.1 5761.6 5762.5 5766.8 5769.2 5539.4 5633.8 5678.7 5678.8 5747.8 5659.2 5689.8 5696.3 5696.5 5699.1 4908.9 5042.9 5076.2 5079.1 5092.5 23383.9 23458.5 23494.6 23502.5 23739.2 2418.1 2572.7 2915.2 3058.0 3147.3 13962.9 14350.2 14773.8 15189.2 15195.6 1832.4 1877.2 1946.4 1976.5 2083.0 81183.6 81608.0 83587.0 85327.0 86526.1 10019.6 10241.9 10273.3 10431.6 10616.2 14629.3 14697.7 14699.2 14706.6 14720.5 7360.2 7636.8 7649.7 7772.2 7791.7 7193.2 7262.3 7390.3 7424.1 7490.4 5706.6 6134.1 6434.3 6513.6 6558.8 1823.3 1896.8 1907.2 1918.5 1925.9 934.0 952.7 1050.2 1076.6 1083.9 18584.5 19435.6 20273.2 20327.8 20429.8 985.4 1032.6 1075.6 1080.2 1080.2 8676.6 10924.2 11402.8 11430.1 11466.5 549343.0 555128.0 559345.0 577662.0 578865.0 78481.6 80245.0 80847.0 81588.1 83108.6 974.0 999.6 1007.5 1011.9 1022.4 16956.6 17214.9 17820.1 17980.4 18043.9 43424.0 44108.0 44718.3 44762.3 44956.1 56827.4 59558.0 61136.4 61223.0 61469.7 6889.2 7117.4 8195.5 8360.1 8413.4 9563.5 10271.4 11069.1 11189.2 12374.0 10374.8 10413.2 10572.7 10618.5 10622.0 10510.7 10636.9 10668.3 10782.6 10959.9 10831.0 10840.6 10879.2 11182.3 11209.2 10906.5 10944.8 11650.1 11780.0 11919.0 9057.3 10897.7 11248.6 11448.7 11605.4 17:28:33 INFO - PROCESS | 13181 | 17:28:33 INFO - PROCESS | 13181 | [#3] mootools.html Cycles:180 Average:6002.57 Median:4555.11 stddev:3456.89 (75.9%) stddev-sans-first:3449.75 17:28:33 INFO - PROCESS | 13181 | Values: 1462.5 1523.8 1659.7 1665.7 1818.0 8644.1 9275.8 9276.8 9278.9 9279.8 7472.6 8628.5 8928.4 8958.3 9063.8 2396.4 2424.0 2426.6 2427.7 2428.7 2372.8 2400.8 2447.7 2450.7 2454.2 2407.5 2408.9 2415.0 2425.9 2440.8 2335.5 2340.9 2341.9 2343.0 2379.9 2325.9 2335.6 2335.7 2336.2 2340.4 9239.3 9383.2 9385.8 9386.4 9392.2 5194.4 5300.7 5301.4 5302.6 5304.5 3201.0 3251.5 3289.0 3291.7 3302.8 1052.8 1072.3 2024.7 2092.6 2108.4 12710.9 12788.2 12864.5 12888.3 12892.6 4294.7 4477.8 4535.7 4550.9 4559.3 10037.1 10037.3 10041.6 10050.8 10052.1 5294.5 5298.3 5306.2 5307.2 5309.5 4220.3 4774.2 4885.0 4927.4 4949.2 3873.7 3931.8 4019.9 4027.5 4028.4 1146.1 1177.4 1181.2 1189.6 1199.0 804.6 824.9 886.2 927.6 988.6 6105.9 6155.4 6225.2 6505.2 6508.4 949.2 958.9 980.9 998.8 1028.9 4016.1 4038.2 4105.0 4251.8 4334.8 11365.5 11849.8 11851.9 11860.1 11868.6 11000.4 11378.8 11388.6 11712.4 11792.6 8001.0 8094.5 8139.0 8148.0 8152.0 6283.5 6286.6 6339.3 6395.2 6490.7 10475.3 10692.4 10706.3 10797.4 10848.3 10780.9 10985.2 11002.8 11011.6 11013.8 6994.2 7877.5 8119.1 8150.1 8235.0 8861.7 9020.7 9054.5 9065.0 9083.7 7925.4 8017.5 8064.8 8169.7 8222.4 7858.6 7981.8 7992.3 8017.2 8032.7 7254.9 7436.4 7439.7 7442.0 7450.3 5199.5 5301.4 5394.5 5463.7 5487.0 5095.9 5170.9 5217.6 5271.6 5401.6 17:28:33 INFO - PROCESS | 13181 | 17:28:33 INFO - PROCESS | 13181 | [#4] prototype.html Cycles:180 Average:4664.74 Median:5283.18 stddev:1366.46 (25.9%) stddev-sans-first:1330.65 17:28:33 INFO - PROCESS | 13181 | Values: 311.1 325.3 334.5 335.8 337.9 5296.2 5337.6 5386.2 5396.8 5400.2 4990.7 5143.3 5146.2 5151.9 5280.8 4019.3 4083.9 4124.3 4154.6 4192.6 4150.0 4161.4 4169.5 4200.1 4216.3 4066.2 4091.7 4119.5 4146.1 4162.7 4144.4 4151.5 4159.1 4160.9 4168.8 3689.8 3709.3 3715.3 3717.4 3728.8 5106.7 5196.7 5205.2 5207.9 5208.7 4683.6 4697.6 4743.0 4758.0 4768.3 5436.2 5444.3 5457.3 5459.4 5506.5 3915.0 3984.1 3990.0 3991.3 4016.2 5628.7 5668.3 5669.3 5705.6 5719.6 4070.9 4095.4 4105.2 4112.9 4118.4 4164.8 4176.2 4198.8 4202.6 4205.5 4433.3 4562.4 4613.5 4618.3 4626.3 5539.2 5558.3 5568.4 5572.0 5589.0 1340.9 1399.3 1404.5 1406.9 1409.2 875.6 965.5 977.0 981.5 983.1 5176.7 5184.1 5188.4 5189.4 5211.3 5484.1 5515.7 5550.9 5552.8 5592.3 5017.7 5156.9 5187.6 5245.0 5245.8 2971.6 2972.2 2973.6 2981.2 2989.9 5637.3 5778.6 5791.4 5804.6 5808.8 5818.6 5832.7 5841.6 5842.9 5845.5 5846.8 5895.8 5926.4 5940.0 5955.2 5512.7 5661.2 5710.3 5743.7 5743.7 5594.6 5610.7 5640.8 5647.8 5656.8 5575.5 5926.5 5976.4 6015.7 6019.1 4014.6 4034.2 4056.8 4061.3 4083.2 5500.2 5614.8 5650.6 5678.7 5698.1 5619.8 5623.6 5631.6 5637.5 5638.3 5285.5 5518.3 5521.4 5533.8 5594.5 5476.9 5492.5 5493.6 5497.0 5497.5 5578.5 5597.8 5693.6 5698.5 5704.4 5265.8 5467.9 5505.4 5508.8 5568.7 17:28:33 INFO - PROCESS | 13181 | 17:28:33 INFO - PROCESS | 13181 | [#5] yui.html Cycles:180 Average:20866.31 Median:4406.23 stddev:29990.45 (680.6%) stddev-sans-first:30036.38 17:28:33 INFO - PROCESS | 13181 | Values: 707.3 730.8 743.6 801.2 812.8 14397.8 15258.3 15645.5 15771.2 15890.8 13145.9 13407.7 13408.1 13410.9 13419.7 656.1 801.5 813.9 814.3 815.7 786.8 826.5 828.5 832.9 833.3 860.3 862.5 864.1 864.2 864.6 686.9 857.7 858.2 859.5 859.5 593.7 619.9 622.6 624.3 624.6 14148.2 14231.1 14245.4 14294.9 14307.3 12920.7 12979.5 13175.9 13363.0 14542.6 13176.0 13233.7 13426.9 13501.1 14024.8 4354.9 4378.5 4434.0 4509.7 4615.2 72384.6 75430.0 75434.2 85999.6 86664.0 11763.9 11947.8 11972.3 12056.2 12541.1 22228.7 22230.4 22261.9 22283.6 22413.7 8538.2 8549.6 8691.6 8705.4 8764.9 4835.4 4888.3 5039.4 5043.5 5121.9 3432.3 3482.2 3518.4 3525.2 3528.2 612.6 640.6 644.2 644.6 658.3 626.6 708.7 732.8 736.5 753.1 8618.4 9903.9 9926.8 10033.2 10233.2 683.5 701.4 705.5 719.7 735.9 4645.2 4922.5 4943.2 4960.7 4977.3 88697.0 120497.1 120878.4 122015.0 124304.0 87414.0 89638.0 104941.0 106014.5 107680.4 86155.0 88841.1 90302.0 90309.0 94123.0 10229.5 10444.7 10924.3 11079.9 11127.3 48117.0 50460.7 51206.2 51453.0 52981.2 46304.8 46490.8 68231.3 74322.0 80345.0 13376.5 13706.0 13747.6 13790.9 14175.9 15007.9 15121.5 15509.0 16069.9 16307.9 14075.6 14570.1 14988.9 15155.4 15744.4 13628.9 13670.1 13682.9 13867.7 14434.5 13468.7 15149.7 15306.7 15488.4 15829.0 11222.7 11397.9 11408.4 11415.6 12121.6 10163.9 10648.9 11316.6 11465.3 11681.5 17:28:33 INFO - PROCESS | 13181 | -------- Summary: end -------- 17:28:33 INFO - PROCESS | 13181 | 17:28:34 INFO - TEST-INFO | 13181: exit 0 17:28:34 INFO - TEST-OK | dromaeo_css | took 1114759ms 17:28:34 INFO - TEST-START | kraken 17:28:34 INFO - operating with platform_type : linux_ 17:28:34 INFO - Initialising browser for kraken test... 17:28:34 INFO - TEST-INFO | started process 13373 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0_3a3G/profile http://localhost:54023/getInfo.html) 17:28:38 INFO - PROCESS | 13373 | JavaScript error: , line 0: uncaught exception: undefined 17:28:38 INFO - PROCESS | 13373 | __metrics Screen width/height:1600/1200 17:28:38 INFO - PROCESS | 13373 | colorDepth:24 17:28:38 INFO - PROCESS | 13373 | Browser inner width/height: 1024/697 17:28:38 INFO - PROCESS | 13373 | __metrics 17:28:39 INFO - PROCESS | 13373 | 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" 17:28:39 INFO - PROCESS | 13373 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:28:40 INFO - TEST-INFO | 13373: exit 0 17:28:40 INFO - Browser initialized. 17:28:40 INFO - Running cycle 1/1 for kraken test... 17:28:40 INFO - TEST-INFO | started process 13450 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0_3a3G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:28:52 INFO - PROCESS | 13450 | RSS: Main: 158298112 17:28:52 INFO - PROCESS | 13450 | 17:28:55 INFO - PROCESS | 13450 | Cycle 1(1): loaded http://localhost:54023/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54023/tests/kraken/driver.html?testName=audio-beat-detection) 17:28:55 INFO - PROCESS | 13450 | RSS: Main: 214257664 17:28:55 INFO - PROCESS | 13450 | 17:28:58 INFO - PROCESS | 13450 | Cycle 1(1): loaded http://localhost:54023/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54023/tests/kraken/driver.html?testName=audio-dft) 17:28:59 INFO - PROCESS | 13450 | RSS: Main: 192942080 17:28:59 INFO - PROCESS | 13450 | 17:29:02 INFO - PROCESS | 13450 | Cycle 1(1): loaded http://localhost:54023/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54023/tests/kraken/driver.html?testName=audio-fft) 17:29:02 INFO - PROCESS | 13450 | RSS: Main: 270340096 17:29:02 INFO - PROCESS | 13450 | 17:29:04 INFO - PROCESS | 13450 | Cycle 1(1): loaded http://localhost:54023/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54023/tests/kraken/driver.html?testName=audio-oscillator) 17:29:05 INFO - PROCESS | 13450 | RSS: Main: 181465088 17:29:05 INFO - PROCESS | 13450 | 17:29:07 INFO - PROCESS | 13450 | Cycle 1(1): loaded http://localhost:54023/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54023/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:29:08 INFO - PROCESS | 13450 | RSS: Main: 185708544 17:29:08 INFO - PROCESS | 13450 | 17:29:11 INFO - PROCESS | 13450 | Cycle 1(1): loaded http://localhost:54023/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54023/tests/kraken/driver.html?testName=imaging-darkroom) 17:29:11 INFO - PROCESS | 13450 | RSS: Main: 219877376 17:29:11 INFO - PROCESS | 13450 | 17:29:15 INFO - PROCESS | 13450 | Cycle 1(1): loaded http://localhost:54023/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54023/tests/kraken/driver.html?testName=imaging-desaturate) 17:29:15 INFO - PROCESS | 13450 | RSS: Main: 220889088 17:29:15 INFO - PROCESS | 13450 | 17:29:18 INFO - PROCESS | 13450 | Cycle 1(1): loaded http://localhost:54023/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54023/tests/kraken/driver.html?testName=json-parse-financial) 17:29:19 INFO - PROCESS | 13450 | RSS: Main: 221237248 17:29:19 INFO - PROCESS | 13450 | 17:29:20 INFO - PROCESS | 13450 | Cycle 1(1): loaded http://localhost:54023/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54023/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:29:21 INFO - PROCESS | 13450 | RSS: Main: 185282560 17:29:21 INFO - PROCESS | 13450 | 17:29:23 INFO - PROCESS | 13450 | Cycle 1(1): loaded http://localhost:54023/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54023/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:29:23 INFO - PROCESS | 13450 | RSS: Main: 191156224 17:29:23 INFO - PROCESS | 13450 | 17:29:25 INFO - PROCESS | 13450 | Cycle 1(1): loaded http://localhost:54023/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54023/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:29:26 INFO - PROCESS | 13450 | RSS: Main: 195534848 17:29:26 INFO - PROCESS | 13450 | 17:29:28 INFO - PROCESS | 13450 | Cycle 1(1): loaded http://localhost:54023/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54023/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:29:29 INFO - PROCESS | 13450 | RSS: Main: 189460480 17:29:29 INFO - PROCESS | 13450 | 17:29:32 INFO - PROCESS | 13450 | Cycle 1(1): loaded http://localhost:54023/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54023/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:29:32 INFO - PROCESS | 13450 | RSS: Main: 193835008 17:29:32 INFO - PROCESS | 13450 | 17:29:34 INFO - PROCESS | 13450 | Cycle 1(1): loaded http://localhost:54023/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54023/tests/kraken/driver.html?testName=ai-astar) 17:29:34 INFO - PROCESS | 13450 | RSS: Main: 244588544 17:29:34 INFO - PROCESS | 13450 | 17:29:34 INFO - PROCESS | 13450 | __start_tp_report 17:29:34 INFO - PROCESS | 13450 | _x_x_mozilla_page_load 17:29:34 INFO - PROCESS | 13450 | _x_x_mozilla_page_load_details 17:29:34 INFO - PROCESS | 13450 | |i|pagename|runs| 17:29:34 INFO - PROCESS | 13450 | |0;ai-astar;103;111;110;110;111;111;110;110;108;111 17:29:34 INFO - PROCESS | 13450 | |1;audio-beat-detection;141;117;123;167;120;118;150;117;147;115 17:29:34 INFO - PROCESS | 13450 | |2;audio-dft;160;160;161;161;160;160;161;161;161;164 17:29:34 INFO - PROCESS | 13450 | |3;audio-fft;84;75;74;131;77;76;73;74;115;73 17:29:34 INFO - PROCESS | 13450 | |4;audio-oscillator;83;84;121;83;84;83;119;83;83;122 17:29:34 INFO - PROCESS | 13450 | |5;imaging-gaussian-blur;117;117;116;117;117;117;116;117;116;117 17:29:34 INFO - PROCESS | 13450 | |6;imaging-darkroom;145;147;145;146;145;145;146;146;146;146 17:29:34 INFO - PROCESS | 13450 | |7;imaging-desaturate;95;95;95;94;95;94;94;94;94;94 17:29:34 INFO - PROCESS | 13450 | |8;json-parse-financial;55;52;51;52;52;53;53;51;52;52 17:29:34 INFO - PROCESS | 13450 | |9;json-stringify-tinderbox;62;62;61;62;62;62;62;62;62;62 17:29:34 INFO - PROCESS | 13450 | |10;stanford-crypto-aes;76;75;75;76;76;75;75;75;75;79 17:29:34 INFO - PROCESS | 13450 | |11;stanford-crypto-ccm;121;119;138;137;120;118;123;124;149;123 17:29:34 INFO - PROCESS | 13450 | |12;stanford-crypto-pbkdf2;159;155;155;161;155;156;159;158;158;155 17:29:34 INFO - PROCESS | 13450 | |13;stanford-crypto-sha256-iterative;63;62;66;63;62;62;63;63;62;61 17:29:34 INFO - PROCESS | 13450 | __end_tp_report 17:29:34 INFO - PROCESS | 13450 | __start_cc_report 17:29:34 INFO - PROCESS | 13450 | _x_x_mozilla_cycle_collect,1688 17:29:34 INFO - PROCESS | 13450 | __end_cc_report 17:29:34 INFO - PROCESS | 13450 | __startTimestamp1469838574618__endTimestamp 17:29:34 INFO - PROCESS | 13450 | 17:29:34 INFO - PROCESS | 13450 | ------- Summary: start ------- 17:29:34 INFO - PROCESS | 13450 | Number of tests: 14 17:29:34 INFO - PROCESS | 13450 | 17:29:34 INFO - PROCESS | 13450 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.50 stddev:2.46 (2.2%) stddev-sans-first:0.97 17:29:34 INFO - PROCESS | 13450 | Values: 103.0 111.0 110.0 110.0 111.0 111.0 110.0 110.0 108.0 111.0 17:29:34 INFO - PROCESS | 13450 | 17:29:34 INFO - PROCESS | 13450 | [#1] audio-beat-detection Cycles:10 Average:131.50 Median:132.00 stddev:18.30 (13.9%) stddev-sans-first:19.08 17:29:34 INFO - PROCESS | 13450 | Values: 141.0 117.0 123.0 167.0 120.0 118.0 150.0 117.0 147.0 115.0 17:29:34 INFO - PROCESS | 13450 | 17:29:34 INFO - PROCESS | 13450 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.20 (0.7%) stddev-sans-first:1.22 17:29:34 INFO - PROCESS | 13450 | Values: 160.0 160.0 161.0 161.0 160.0 160.0 161.0 161.0 161.0 164.0 17:29:34 INFO - PROCESS | 13450 | 17:29:34 INFO - PROCESS | 13450 | [#3] audio-fft Cycles:10 Average:85.20 Median:74.50 stddev:20.53 (27.6%) stddev-sans-first:21.77 17:29:34 INFO - PROCESS | 13450 | Values: 84.0 75.0 74.0 131.0 77.0 76.0 73.0 74.0 115.0 73.0 17:29:34 INFO - PROCESS | 13450 | 17:29:34 INFO - PROCESS | 13450 | [#4] audio-oscillator Cycles:10 Average:94.50 Median:83.00 stddev:18.08 (21.8%) stddev-sans-first:18.69 17:29:34 INFO - PROCESS | 13450 | Values: 83.0 84.0 121.0 83.0 84.0 83.0 119.0 83.0 83.0 122.0 17:29:34 INFO - PROCESS | 13450 | 17:29:34 INFO - PROCESS | 13450 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 17:29:34 INFO - PROCESS | 13450 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 17:29:34 INFO - PROCESS | 13450 | 17:29:34 INFO - PROCESS | 13450 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 17:29:34 INFO - PROCESS | 13450 | Values: 145.0 147.0 145.0 146.0 145.0 145.0 146.0 146.0 146.0 146.0 17:29:34 INFO - PROCESS | 13450 | 17:29:34 INFO - PROCESS | 13450 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 17:29:34 INFO - PROCESS | 13450 | Values: 95.0 95.0 95.0 94.0 95.0 94.0 94.0 94.0 94.0 94.0 17:29:34 INFO - PROCESS | 13450 | 17:29:34 INFO - PROCESS | 13450 | [#8] json-parse-financial Cycles:10 Average:52.30 Median:52.00 stddev:1.16 (2.2%) stddev-sans-first:0.71 17:29:34 INFO - PROCESS | 13450 | Values: 55.0 52.0 51.0 52.0 52.0 53.0 53.0 51.0 52.0 52.0 17:29:34 INFO - PROCESS | 13450 | 17:29:34 INFO - PROCESS | 13450 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:62.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 17:29:34 INFO - PROCESS | 13450 | Values: 62.0 62.0 61.0 62.0 62.0 62.0 62.0 62.0 62.0 62.0 17:29:34 INFO - PROCESS | 13450 | 17:29:34 INFO - PROCESS | 13450 | [#10] stanford-crypto-aes Cycles:10 Average:75.70 Median:75.50 stddev:1.25 (1.7%) stddev-sans-first:1.32 17:29:34 INFO - PROCESS | 13450 | Values: 76.0 75.0 75.0 76.0 76.0 75.0 75.0 75.0 75.0 79.0 17:29:34 INFO - PROCESS | 13450 | 17:29:34 INFO - PROCESS | 13450 | [#11] stanford-crypto-ccm Cycles:10 Average:127.20 Median:123.50 stddev:10.41 (8.4%) stddev-sans-first:10.80 17:29:34 INFO - PROCESS | 13450 | Values: 121.0 119.0 138.0 137.0 120.0 118.0 123.0 124.0 149.0 123.0 17:29:34 INFO - PROCESS | 13450 | 17:29:34 INFO - PROCESS | 13450 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.10 Median:158.00 stddev:2.18 (1.4%) stddev-sans-first:2.20 17:29:34 INFO - PROCESS | 13450 | Values: 159.0 155.0 155.0 161.0 155.0 156.0 159.0 158.0 158.0 155.0 17:29:34 INFO - PROCESS | 13450 | 17:29:34 INFO - PROCESS | 13450 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:1.34 (2.1%) stddev-sans-first:1.41 17:29:34 INFO - PROCESS | 13450 | Values: 63.0 62.0 66.0 63.0 62.0 62.0 63.0 63.0 62.0 61.0 17:29:34 INFO - PROCESS | 13450 | -------- Summary: end -------- 17:29:34 INFO - PROCESS | 13450 | 17:29:35 INFO - TEST-INFO | 13450: exit 0 17:29:35 INFO - TEST-OK | kraken | took 60934ms 17:29:35 INFO - SUITE-END | took 1175s 17:29:35 INFO - Completed test suite (00:19:35) 17:29:35 INFO - javascript benchmark 17:29:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3010.2624856910056, 3010.774191935604, 3033.6814634463376, 3044.573759673645, 3071.339661972677, 5181.326427564421, 5230.34620672416, 5253.264542963988, 5294.232336311237, 5351.999999999995, 5293.020791153639, 5318.069337865877, 5344.652597581165, 5349.893002139955, 5404.351477822667, 4840.733759643218, 4845.3216549683075, 4920.0, 4941.851744447672, 5055.797768089272, 4949.505049495057, 4975.9004819903585, 5012.699238045729, 5028.371453568304, 5033.647644664875, 4790.233562629997, 4842.612590992712, 4904.117258893398, 4904.362432883738, 4991.226359914219, 4899.632527560448, 4901.897073158547, 4912.164931961575, 4924.359833221658, 5013.047520971004, 4876.609871210295, 4878.487758785347, 4881.194602890519, 4933.605311575066, 4967.0, 5208.869778255536, 5307.018201632672, 5330.733463326818, 5378.838634840961, 5488.341399032141, 5762.596618236725, 5763.740631671585, 5785.247917770705, 5813.593048486608, 5817.360090390053, 5850.6489610623075, 5851.151583020438, 5854.970725146347, 5863.208466856962, 5880.117982302646, 5167.689938603696, 5319.867003324909, 5396.946030539644, 5399.514043736082, 5440.156775699773, 5976.491998180117, 6012.30858451275, 6013.579049466583, 6013.609115407485, 6017.638941663514, 5730.19777231188, 5744.741486633028, 5746.856328591819, 5747.741351639186, 5753.741081651336, 5550.222968784374, 5701.344345400332, 5774.047282198474, 5786.94213057864, 5823.010088285002, 5778.0, 5813.854653633608, 5816.389279125716, 5822.097574875901, 5855.970720146372, 5758.942410575841, 5798.478136967693, 5808.564357673192, 5810.0, 5817.534597232296, 4296.334068219431, 4332.696711230246, 4347.8260869564865, 4362.934555981663, 4440.267355886307, 3899.74651647642, 3903.0, 3944.7041471889725, 3944.9802750986637, 3975.5626881043063, 5403.5136837684795, 5414.864628384322, 5418.647787893774, 5425.240466334716, 5456.290682211366, 5571.192177134374, 5692.288463942007, 5761.9135712964335, 5765.308163020464, 5808.680522571299, 5460.918086228709, 5464.0711079116645, 5467.972660136674, 5487.670739755627, 5489.039418101816, 4992.450830408652, 4992.500749924979, 5000.924986125211, 5003.149464591028, 5049.166887463601, 5813.883722325614, 5903.881922361528, 5966.2243908290775, 5986.491148252448, 6000.489958353502, 5801.912971305349, 5803.332616749128, 5805.303363596396, 5827.155062515996, 5860.589758716849, 5998.730057147526, 6004.729787159501, 6007.189029480965, 6010.789622363196, 6017.428344307284, 5500.532454741392, 5559.861003474945, 5592.888142237051, 5646.153077038477, 5717.628354156966, 5705.172749951151, 5743.052396354722, 5757.596968212185, 5777.768889244383, 5805.506531944663, 5618.044932361427, 5624.606277560531, 5628.634138780966, 5633.549316054788, 5641.971790141023, 5443.265159203457, 5555.416681248573, 5587.804426845041, 5598.86002849932, 5599.1041433370465, 5596.664200148004, 5599.776008959596, 5615.354234263112, 5634.154876768517, 5635.6618602883955, 5697.886042279214, 5698.2592263005545, 5751.223584815996, 5752.9712351437975, 5759.395263497272, 5483.506484416422, 5505.449455054462, 5552.333719953632, 5579.553635709052, 5589.888202236014], "value": 5314.628844767989, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.7897235967412, 616.6454288783949, 632.6109442692742, 634.3878157577938, 644.6776611694153, 43308.78345608272, 45358.77320613396, 45360.09279814402, 45386.54613453864, 47701.284480732815, 45336.546634533646, 45501.0, 45720.771396143056, 45722.54277457233, 45810.541894581045, 9039.774005649879, 9168.679096231634, 9178.173964343208, 9178.265738740918, 9189.72430827073, 8991.865122023175, 9065.773355666128, 9072.909270907272, 9076.31927605429, 9080.909190908073, 9114.817703645924, 9120.133587309196, 9127.452352858816, 9140.085991400872, 9147.268218542535, 9053.864192037125, 9058.818823623524, 9106.77233069172, 9108.453492790453, 9109.089091090904, 8963.820723585557, 8992.640294388217, 9014.86477702835, 9020.729378118667, 9030.729078127666, 42505.78747106276, 42964.0, 42994.0, 43058.2012169208, 43264.0, 3489.685928266468, 3626.4197728363333, 3681.5029970953847, 3822.7706337619834, 4413.337999300131, 32942.0, 33027.504587431205, 33531.329373412394, 33551.664483355096, 33574.49638255428, 4290.377895205209, 4439.600435960747, 4470.865874023784, 4494.280915053576, 4591.104734576759, 337266.0, 337734.0, 338236.3088184568, 338899.0, 339243.0, 57736.0, 57934.71032644894, 57964.0, 58046.0, 58080.0, 59485.10772338332, 59851.10223346653, 60378.0, 60637.0, 60752.69623651853, 14162.787558186636, 14302.64006438926, 14373.0, 14373.353199106064, 14410.495632653017, 10399.636012739518, 10405.687829365132, 10435.217358698128, 10437.843432348522, 10440.947795261127, 15204.923975380274, 16040.919795401182, 16099.436519721754, 16181.514554563382, 16260.105694186934, 5874.882502350015, 5893.174955506232, 5979.4917432018765, 6049.5462840287155, 6201.596896201732, 1004.2367800471694, 1029.4749677664295, 1044.4099084017505, 1085.5386460754148, 1177.7173478365303, 32372.838135809172, 32863.1784205392, 32957.67042329546, 33085.83457082747, 33565.16087097842, 1104.5692180049787, 1134.9375784331776, 1146.529922731676, 1170.3329102411544, 1213.0356366688504, 16287.267072981744, 17234.482965511055, 17329.913350433166, 17594.472165835046, 17672.646547068987, 563103.0, 592216.0, 600365.0, 605919.0, 861984.0, 59698.70150649219, 60085.09872351918, 60250.0, 60256.69871650702, 60282.39717602856, 1253.0977696058824, 1333.8932885369147, 1342.0806747378272, 1358.2529608715167, 1379.620604333796, 30079.248018799706, 33465.0, 33684.0, 33916.32167356688, 34271.657283426845, 54711.72644136754, 58790.706046469495, 58826.411735882095, 58859.411405885396, 58893.411065890505, 492945.0, 496415.0, 498757.0, 500884.0, 501066.0, 27554.5866811994, 27900.16299511018, 29179.85410072936, 29374.26564335823, 29425.85287073551, 48883.0, 49122.508774911796, 49208.50791492182, 49487.50512494973, 49550.0, 40145.013905443455, 40562.0, 41207.0, 42032.0, 42298.0, 40716.389254161804, 41429.79285103555, 41497.58502415058, 42653.5734642662, 42719.57280427156, 31332.843335783175, 41238.38142427806, 41478.585214147475, 42725.35911961385, 44389.77805110954, 35998.64001359953, 37375.0, 37599.5015576324, 38248.808755956044, 38656.61343386643, 28410.85794571014, 28460.0, 28666.85666571654, 28821.855890720413, 28886.566701499072], "value": 20314.986673401083, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.2172741561261, 385.7606593723438, 390.3442217075314, 395.3476763340488, 414.4053283538123, 14539.127652340867, 17743.46769596911, 18916.148773305198, 20475.07862146203, 20493.692594611075, 15205.23973801311, 17144.14279286037, 18754.718679219823, 19047.809521904775, 19325.806741932578, 5618.91571626426, 5723.198752174699, 5733.512651424613, 5745.770169193248, 5821.67980761058, 5686.0617998030275, 5761.625494342875, 5762.510186634141, 5766.798162064329, 5769.1923130761725, 5539.446055394468, 5633.774649014034, 5678.687672178028, 5678.801241956532, 5747.798827041054, 5659.1511273309125, 5689.772409103631, 5696.2594862668, 5696.487316141567, 5699.116636921284, 4908.9263661045115, 5042.873928151789, 5076.187809950427, 5079.060373830816, 5092.465291144451, 23383.88308058466, 23458.530829383315, 23494.64758028631, 23502.529949401087, 23739.169129080572, 2418.1415597462824, 2572.65269188659, 2915.1546051644996, 3057.9694203057907, 3147.339058797655, 13962.930185349009, 14350.210738409383, 14773.778393324108, 15189.240537973057, 15195.62010949724, 1832.3678330975924, 1877.2029675783122, 1946.3966170487054, 1976.505873531617, 2082.98958505208, 81183.59408202922, 81608.0, 83587.0, 85327.0, 86526.13473865244, 10019.599216031424, 10241.897581024243, 10273.280870339004, 10431.582736690447, 10616.150707943347, 14629.268536573341, 14697.706045879237, 14699.191544465157, 14706.55880323592, 14720.484783032542, 7360.227176146427, 7636.770896873103, 7649.655765490566, 7772.222777722295, 7791.727289544839, 7193.208747037822, 7262.273772622695, 7390.260973902567, 7424.071991001125, 7490.400767938552, 5706.629069110578, 6134.079888016833, 6434.2600600930555, 6513.576617519846, 6558.770443034471, 1823.2812136741102, 1896.8198021187966, 1907.2275728330048, 1918.5491409518752, 1925.8555608329432, 933.9766505837408, 952.7332346942867, 1050.2280823594651, 1076.5908954597203, 1083.9078678312273, 18584.535386615444, 19435.611287774165, 20273.17541421279, 20327.796722032886, 20429.795702043088, 985.3595163144014, 1032.550840384435, 1075.6181555547669, 1080.2168427889717, 1080.2168427889874, 8676.60955257015, 10924.180686448548, 11402.771944561062, 11430.142739294586, 11466.54133834654, 549343.0, 555128.0, 559345.0, 577662.0, 578865.0, 78481.60759196282, 80245.0, 80847.0, 81588.06501447443, 83108.58445707854, 973.9659111931048, 999.5601935148511, 1007.5415685862915, 1011.9038691324313, 1022.3610243597751, 16956.576085597957, 17214.913925430294, 17820.108994549963, 17980.37068702589, 18043.909780451013, 43424.0, 44108.0302772752, 44718.3292250623, 44762.3285650709, 44956.100877981604, 56827.43172568221, 59558.0, 61136.38863611307, 61223.0, 61469.692651538244, 6889.207741109836, 7117.359437650636, 8195.549244791593, 8360.12218717026, 8413.368997325102, 9563.474008929576, 10271.435071071162, 11069.094884344888, 11189.160812939224, 12374.010079193822, 10374.792504149724, 10413.166946644402, 10572.682819515427, 10618.460323253239, 10622.044016038593, 10510.684679459628, 10636.946815265874, 10668.30656007357, 10782.622608208674, 10959.945200273947, 10831.0, 10840.620578279722, 10879.1840611956, 11182.273152245078, 11209.215354925076, 10906.50920708554, 10944.835827462435, 11650.126240531825, 11780.0, 11918.986886114777, 9057.320700947323, 10897.727556810825, 11248.550057997589, 11448.713782155513, 11605.419729013347], "value": 9293.300866956753, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1462.4881291547956, 1523.8323784383717, 1659.701253774321, 1665.7085010123226, 1817.972730409044, 8644.092370301121, 9275.768105797342, 9276.768080797983, 9278.90721092789, 9279.76800579985, 7472.626368681557, 8628.525431101287, 8928.419652722569, 8958.283337333014, 9063.818723625523, 2396.4248580340723, 2423.9636405453844, 2426.5632186206476, 2427.6965379327585, 2428.6642346709327, 2372.78644921957, 2400.8199385046105, 2447.669564608782, 2450.6936632920883, 2454.153317105605, 2407.4944261705064, 2408.8795560222006, 2415.04605680756, 2425.9393515162087, 2440.8291419600637, 2335.474518233401, 2340.941476463085, 2341.8594884306913, 2343.039353864916, 2379.904803807863, 2325.8837058147024, 2335.649652552114, 2335.74306826249, 2336.1823361823394, 2340.403197184707, 9239.30705197113, 9383.155516003593, 9385.76535586609, 9386.389884657543, 9392.248620110375, 5194.402643695986, 5300.681959082467, 5301.443348448396, 5302.6023048271145, 5304.522592966613, 3200.9679903200904, 3251.4960181171955, 3288.96711032889, 3291.670832916689, 3302.8018318900704, 1052.7736536644659, 1072.2708558180434, 2024.6558085125416, 2092.6233278009954, 2108.388567315477, 12710.872891271061, 12788.232706037574, 12864.549740759028, 12888.291143986984, 12892.613221603367, 4294.699371044059, 4477.843275485342, 4535.659825513099, 4550.908981820345, 4559.316102584638, 10037.146842518321, 10037.297389182688, 10041.648542300984, 10050.849237261447, 10052.145567626687, 5294.549963253166, 5298.337707786527, 5306.204069389545, 5307.177387504943, 5309.46905309466, 4220.303649897794, 4774.188387974053, 4884.975575122102, 4927.359443272351, 4949.158643030693, 3873.69010479161, 3931.7837518936735, 4019.879403617896, 4027.5368332641533, 4028.3554631258858, 1146.0545050333508, 1177.364223319415, 1181.2262967756133, 1189.6193218170276, 1198.9940050299692, 804.5574933786394, 824.9010118785784, 886.2201262888746, 927.5872236854669, 988.6292640259902, 6105.908411373833, 6155.35368786271, 6225.221847269091, 6505.186851643544, 6508.446782023581, 949.240607513986, 958.9376690515094, 980.9047227823808, 998.825205589019, 1028.92797504174, 4016.1365306458665, 4038.1519880825354, 4104.979475102606, 4251.787410629456, 4334.8266069357505, 11365.54537818478, 11849.822252666218, 11851.881481185077, 11860.110491713156, 11868.643940681794, 11000.394978276272, 11378.829317560243, 11388.601398950997, 11712.414379281003, 11792.587259445878, 8001.0, 8094.473859199015, 8138.959305203436, 8147.959260203661, 8151.95924020388, 6283.523372007666, 6286.622802631857, 6339.28839213419, 6395.16862807832, 6490.675466226576, 10475.266731328733, 10692.358458492205, 10706.304090234109, 10797.406142662228, 10848.349099054081, 10780.946095269474, 10985.231033827875, 11002.779944401227, 11011.559537618727, 11013.83479247828, 6994.230634630085, 7877.527348359117, 8119.066307374491, 8150.144234855255, 8235.0, 8861.73414797557, 9020.729378118667, 9054.456732596065, 9064.954675226581, 9083.68207112748, 7925.445218834626, 8017.478863873829, 8064.798380040546, 8169.673213071411, 8222.424430290062, 7858.60706964638, 7981.760547183594, 7992.320652744582, 8017.158198389086, 8032.718854840053, 7254.89117663246, 7436.367908727819, 7439.665215065227, 7442.0, 7450.292222238879, 5199.454057324077, 5301.390340110936, 5394.514493695587, 5463.699496527729, 5487.039768040657, 5095.87260318495, 5170.896582068262, 5217.556507696889, 5271.604629652868, 5401.6218864679095], "value": 4796.118076177224, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.08359133126936, 325.26490132301, 334.47654420831407, 335.76664218368245, 337.88005258133376, 5296.205569164627, 5337.572994160468, 5386.218998245257, 5396.78412863485, 5400.243965844785, 4990.725510096943, 5143.254228136918, 5146.228065790134, 5151.922721159186, 5280.841574752763, 4019.296623090962, 4083.9183216335728, 4124.298869192229, 4154.646855017327, 4192.601702838226, 4149.958500415002, 4161.396597493362, 4169.541350451448, 4200.130941730931, 4216.262154123032, 4066.227416790815, 4091.713580049398, 4119.485064366954, 4146.129312844291, 4162.708610397273, 4144.357624568197, 4151.543330233702, 4159.10579225468, 4160.9375859362135, 4168.7707176105305, 3689.8339574719203, 3709.3137769512728, 3715.2755212733528, 3717.4052151655605, 3728.81355932205, 5106.744662766847, 5196.68819870809, 5205.245239440298, 5207.921881171747, 5208.687478751249, 4683.578477936968, 4697.577218050357, 4742.9525704742855, 4758.0016393114975, 4768.284757286435, 5436.157395603688, 5444.346678398618, 5457.253678822739, 5459.372172200168, 5506.504414602665, 3914.9804250978846, 3984.0836607580127, 3990.0, 3991.345755072873, 4016.2168377166463, 5628.690422026787, 5668.263125793662, 5669.291338582677, 5705.6291341063115, 5719.571032172604, 4070.9185816284103, 4095.447114639545, 4105.199486100182, 4112.876613701594, 4118.382242663624, 4164.8125834337525, 4176.227397931392, 4198.8110535026, 4202.558731333227, 4205.495340559152, 4433.334999750064, 4562.429696287964, 4613.469451013177, 4618.284165954283, 4626.306054091846, 5539.169124631338, 5558.333000040021, 5568.387477377485, 5571.9721401392735, 5588.972055139699, 1340.9262490562917, 1399.3423091147145, 1404.45226361719, 1406.9226192559304, 1409.2037998531002, 875.6497401039635, 965.5461932891529, 976.9951150244345, 981.4651015196735, 983.0759086458849, 5176.663516871391, 5184.14461613837, 5188.377394712658, 5189.377274727057, 5211.322528071402, 5484.095124304525, 5515.696636684941, 5550.944490555043, 5552.833414997556, 5592.266397416814, 5017.698938063728, 5156.911450862407, 5187.610929180327, 5244.9737751310995, 5245.842624721265, 2971.5839782430476, 2972.1975066732293, 2973.6321292205826, 2981.1801754517683, 2989.880404783828, 5637.295338082739, 5778.566607504454, 5791.420857914259, 5804.593678442468, 5808.767649293981, 5818.592698511148, 5832.708364581754, 5841.561882858802, 5842.912356314659, 5845.450955496797, 5846.766129354778, 5895.823125306248, 5926.399872034526, 5939.970300148471, 5955.225820643289, 5512.732071623469, 5661.207430959751, 5710.2576665033275, 5743.684097374685, 5743.712814359349, 5594.636348637326, 5610.747516361692, 5640.830775076754, 5647.774089036392, 5656.830295091154, 5575.470330318613, 5926.496247818984, 5976.372480889444, 6015.72929218195, 6019.050665173946, 4014.598540145962, 4034.1528279061727, 4056.8174432151213, 4061.2892743770312, 4083.244599749056, 5500.22996780459, 5614.775408983758, 5650.604457687922, 5678.68767217807, 5698.0598201296325, 5619.80330688424, 5623.578231632562, 5631.577631677558, 5637.46444087811, 5638.295213098363, 5285.524302812765, 5518.255035570147, 5521.420250873601, 5533.750981205775, 5594.496495315441, 5476.890462190813, 5492.5331346835965, 5493.615446918678, 5497.0, 5497.45025497447, 5578.470045345685, 5597.832065038056, 5693.601447898607, 5698.544116470755, 5704.429557044263, 5265.789368425373, 5467.917981230365, 5505.366882808368, 5508.752106155152, 5568.6658800472105], "value": 4228.040104347134, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [707.2856415020827, 730.7661548304538, 743.5575832379735, 801.1667865419963, 812.772423721358, 14397.784033239497, 15258.313375898084, 15645.530634080982, 15771.21143942804, 15890.76163857543, 13145.868541314583, 13407.73184536311, 13408.128471649336, 13410.932945335284, 13419.731605367911, 656.0585559721791, 801.4550105927981, 813.9389545784061, 814.3363159025375, 815.7389635316702, 786.7993661616308, 826.4958375391006, 828.4780588229407, 832.854250506162, 833.3458235285302, 860.290260535058, 862.4738909265343, 864.11859902899, 864.2006144316514, 864.5806783709895, 686.8935315026129, 857.695518091078, 858.1504310732362, 859.4585411190973, 859.5444414460314, 593.7357875745295, 619.8977168767148, 622.6233128957007, 624.2758400255727, 624.5503237668871, 14148.221847798366, 14231.146131232159, 14245.358958846773, 14294.92852535741, 14307.28463576817, 12920.676983075404, 12979.480820767158, 13175.934120329433, 13363.0, 14542.636434089127, 13176.0, 13233.73532529344, 13426.925845932303, 13501.122427042212, 14024.789628155586, 4354.891127721832, 4378.496472905625, 4433.955660443419, 4509.706869053501, 4615.169269531483, 72384.6380768098, 75429.99999999945, 75434.24565754327, 85999.57000214959, 86664.0, 11763.944931761784, 11947.820782688266, 11972.28038687795, 12056.156069075081, 12541.122121451594, 22228.666570001464, 22230.444238893833, 22261.886905654977, 22283.55432891333, 22413.66379504309, 8538.188872057144, 8549.572521373906, 8691.608877600524, 8705.434146780439, 8764.904386951632, 4835.443923948791, 4888.315635810989, 5039.44566097729, 5043.4956504349275, 5121.948780512222, 3432.262063656326, 3482.164280572695, 3518.401871681769, 3525.1715846775987, 3528.188516641187, 612.5803824380314, 640.6476437959104, 644.2076246217085, 644.5842431631571, 658.2726087673052, 626.5582764151262, 708.6988030087192, 732.8241222106656, 736.5139008254527, 753.0737193252221, 8618.439801413013, 9903.900960990442, 9926.751831204278, 10033.197344212445, 10233.181345492343, 683.460066547422, 701.4038067642463, 705.4990956420999, 719.7049209824052, 735.8638651849318, 4645.187092258841, 4922.532359425849, 4943.233798761198, 4960.702357858468, 4977.303177555073, 88697.0, 120497.08575772791, 120878.3956080214, 122015.0, 124304.0, 87414.0, 89638.0, 104941.0, 106014.46992765141, 107680.38479422814, 86155.0, 88841.12912052387, 90302.0, 90309.0, 94123.0, 10229.48852557384, 10444.688103117196, 10924.2899211551, 11079.944600276947, 11127.276727012719, 48117.0, 50460.747696261285, 51206.231906522175, 51453.0, 52981.20528192003, 46304.76847615875, 46490.76754616205, 68231.33698966424, 74322.0, 80345.0, 13376.464941402624, 13706.0, 13747.587572372844, 13790.862091378958, 14175.858241417867, 15007.924960375129, 15121.546353609408, 15508.991915525456, 16069.910911581419, 16307.918460407622, 14075.648108796953, 14570.125792452487, 14988.850111499181, 15155.393784248947, 15744.448944286894, 13628.93185534066, 13670.11144275619, 13682.884193016396, 13867.671758777618, 14434.494792682206, 13468.663283417993, 15149.697006060038, 15306.693866122838, 15488.380464781734, 15829.0, 11222.66332010041, 11397.886021140013, 11408.429578521207, 11415.60045398407, 12121.575744848888, 10163.898361016296, 10648.89351106479, 11316.6039188628, 11465.31208127515, 11681.474333654836], "value": 7683.080414239346, "unit": "score"}], "name": "dromaeo_css", "value": 7339.695928421572, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 110.0, 110.0, 111.0, 111.0, 110.0, 110.0, 108.0, 111.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 117.0, 123.0, 167.0, 120.0, 118.0, 150.0, 117.0, 147.0, 115.0], "value": 131.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 161.0, 160.0, 160.0, 161.0, 161.0, 161.0, 164.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 75.0, 74.0, 131.0, 77.0, 76.0, 73.0, 74.0, 115.0, 73.0], "value": 85.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 121.0, 83.0, 84.0, 83.0, 119.0, 83.0, 83.0, 122.0], "value": 94.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 146.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 51.0, 52.0, 52.0, 53.0, 53.0, 51.0, 52.0, 52.0], "value": 52.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 76.0, 76.0, 75.0, 75.0, 75.0, 75.0, 79.0], "value": 75.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 119.0, 138.0, 137.0, 120.0, 118.0, 123.0, 124.0, 149.0, 123.0], "value": 127.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 155.0, 155.0, 161.0, 155.0, 156.0, 159.0, 158.0, 158.0, 155.0], "value": 157.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 66.0, 63.0, 62.0, 62.0, 63.0, 63.0, 62.0, 61.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1475.3, "alertThreshold": 2.0}]} 17:29:35 INFO - Return code: 0 17:29:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:29:35 INFO - # TBPL SUCCESS # 17:29:35 INFO - Running post-action listener: _resource_record_post_action 17:29:35 INFO - [mozharness: 2016-07-30 00:29:35.943272Z] Finished run-tests step (success) 17:29:35 INFO - Running post-run listener: _resource_record_post_run 17:29:36 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 553328640; Read time: 12; Write time: 474544 17:29:36 INFO - TinderboxPrint: CPU usage
13.0% 17:29:36 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 17:29:36 INFO - TinderboxPrint: I/O write bytes / time
553,328,640 / 474,544 17:29:36 INFO - TinderboxPrint: CPU idle
8,282.8 (87.0%) 17:29:36 INFO - TinderboxPrint: CPU user
1,191.6 (12.5%) 17:29:36 INFO - TinderboxPrint: Swap in / out
0 / 0 17:29:36 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 257036288; Read time: 0; Write time: 269716 17:29:36 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 295677952; Read time: 0; Write time: 204824 17:29:36 INFO - Running post-run listener: _upload_blobber_files 17:29:36 INFO - Blob upload gear active. 17:29:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:29:36 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 17:29:36 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:29:36 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:29:36 INFO - (blobuploader) - INFO - Open directory for files ... 17:29:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:29:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:29:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:29:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:29:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:29:37 INFO - (blobuploader) - INFO - Done attempting. 17:29:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:29:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:29:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:29:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:29:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:29:43 INFO - (blobuploader) - INFO - Done attempting. 17:29:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:29:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:29:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:29:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:29:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:29:43 INFO - (blobuploader) - INFO - Done attempting. 17:29:43 INFO - (blobuploader) - INFO - Iteration through files over. 17:29:43 INFO - Return code: 0 17:29:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:29:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:29:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9845f14db57c6ddcbaf0e5768014d137eb870e7860fd2fe53633ae95c32d66d646a55eb5251b676693ec09c9eb6799202a3280f1db5060664d8c586deec25e94", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1cece195a62472997820783439ca360a104bf30851e7891c8c592b66a37826fc175857e21e00741d0b98e8bc6c8e773cc041cccca112547a784352d6052ae5e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6de6c7fae80109dd7ba966f3b41c41a3233f71f6cbceb45cdefe77cc1bf82beb4c7c06b454c31a320588b7d8cd75c37072ada6c94d9e17a3730587d5fd3f99d9"} 17:29:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:29:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:29:43 INFO - Contents: 17:29:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9845f14db57c6ddcbaf0e5768014d137eb870e7860fd2fe53633ae95c32d66d646a55eb5251b676693ec09c9eb6799202a3280f1db5060664d8c586deec25e94", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1cece195a62472997820783439ca360a104bf30851e7891c8c592b66a37826fc175857e21e00741d0b98e8bc6c8e773cc041cccca112547a784352d6052ae5e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6de6c7fae80109dd7ba966f3b41c41a3233f71f6cbceb45cdefe77cc1bf82beb4c7c06b454c31a320588b7d8cd75c37072ada6c94d9e17a3730587d5fd3f99d9"} 17:29:43 INFO - Running post-run listener: copy_logs_to_upload_dir 17:29:43 INFO - Copying logs to upload dir... 17:29:43 INFO - mkdir: /builds/slave/test/build/upload/logs 17:29:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.605117 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-07-29 17:29:43.419019) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-29 17:29:43.422808) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1469836837.273657-140640478 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/sha512/9845f14db57c6ddcbaf0e5768014d137eb870e7860fd2fe53633ae95c32d66d646a55eb5251b676693ec09c9eb6799202a3280f1db5060664d8c586deec25e94", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1cece195a62472997820783439ca360a104bf30851e7891c8c592b66a37826fc175857e21e00741d0b98e8bc6c8e773cc041cccca112547a784352d6052ae5e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6de6c7fae80109dd7ba966f3b41c41a3233f71f6cbceb45cdefe77cc1bf82beb4c7c06b454c31a320588b7d8cd75c37072ada6c94d9e17a3730587d5fd3f99d9"} build_url:https://queue.taskcluster.net/v1/task/ODGCBl5aSAOP4Ozj7Ktslg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011469 build_url: 'https://queue.taskcluster.net/v1/task/ODGCBl5aSAOP4Ozj7Ktslg/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/sha512/9845f14db57c6ddcbaf0e5768014d137eb870e7860fd2fe53633ae95c32d66d646a55eb5251b676693ec09c9eb6799202a3280f1db5060664d8c586deec25e94", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1cece195a62472997820783439ca360a104bf30851e7891c8c592b66a37826fc175857e21e00741d0b98e8bc6c8e773cc041cccca112547a784352d6052ae5e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6de6c7fae80109dd7ba966f3b41c41a3233f71f6cbceb45cdefe77cc1bf82beb4c7c06b454c31a320588b7d8cd75c37072ada6c94d9e17a3730587d5fd3f99d9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-29 17:29:43.448684) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 17:29:43.449050) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1469836837.273657-140640478 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004486 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 17:29:43.531315) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-29 17:29:43.531663) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-29 17:29:43.531969) ========= ========= Total master_lag: 0.17 =========