builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-003 starttime: 1470065277.14 results: success (0) buildid: 20160801070949 builduid: 1fc048ee03174d10b72e740fa55d5254 revision: ffac2798999c5b84f1b4605a1280994bb665a406 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 08:27:57.141226) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 08:27:57.141756) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 08:27:57.142145) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 08:27:57.161925) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 08:27:57.162208) ========= 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=7de08804244eb36560b44971000001c3-1470065060.921524-150398836 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-01 08:27:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-08-01 08:27:57 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.087220 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 08:27:57.270397) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 08:27:57.270686) ========= 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=7de08804244eb36560b44971000001c3-1470065060.921524-150398836 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016502 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 08:27:57.323635) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 08:27:57.324093) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ffac2798999c5b84f1b4605a1280994bb665a406 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev ffac2798999c5b84f1b4605a1280994bb665a406 --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=7de08804244eb36560b44971000001c3-1470065060.921524-150398836 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-01 08:27:57,576 truncating revision to first 12 chars 2016-08-01 08:27:57,577 Setting DEBUG logging. 2016-08-01 08:27:57,577 attempt 1/10 2016-08-01 08:27:57,577 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ffac2798999c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-01 08:27:58,186 unpacking tar archive at: mozilla-central-ffac2798999c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.948228 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 08:27:58.286186) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 08:27:58.286494) ========= script_repo_revision: ffac2798999c5b84f1b4605a1280994bb665a406 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 08:27:58.286885) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 08:27:58.287155) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 08:27:58.300015) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-08-01 08:27:58.300273) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7de08804244eb36560b44971000001c3-1470065060.921524-150398836 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:27:58 INFO - MultiFileLogger online at 20160801 08:27:58 in /builds/slave/test 08:27:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:27:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:27:58 INFO - {'append_to_log': False, 08:27:58 INFO - 'base_work_dir': '/builds/slave/test', 08:27:58 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:27:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:27:58 INFO - 'branch': 'Firefox-Non-PGO', 08:27:58 INFO - 'buildbot_json_path': 'buildprops.json', 08:27:58 INFO - 'config_files': ('talos/linux_config.py',), 08:27:58 INFO - 'default_actions': ('clobber', 08:27:58 INFO - 'read-buildbot-config', 08:27:58 INFO - 'download-and-extract', 08:27:58 INFO - 'populate-webroot', 08:27:58 INFO - 'create-virtualenv', 08:27:58 INFO - 'install', 08:27:58 INFO - 'run-tests'), 08:27:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:27:58 INFO - 'download_minidump_stackwalk': True, 08:27:58 INFO - 'download_symbols': 'ondemand', 08:27:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:27:58 INFO - 'tooltool.py': '/tools/tooltool.py', 08:27:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:27:58 INFO - '/tools/misc-python/virtualenv.py')}, 08:27:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:27:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:27:58 INFO - 'installer_path': 'installer.exe', 08:27:58 INFO - 'log_level': 'info', 08:27:58 INFO - 'log_name': 'talos', 08:27:58 INFO - 'log_to_console': True, 08:27:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:27:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:27:58 INFO - 'opt_config_files': (), 08:27:58 INFO - 'pip_index': False, 08:27:58 INFO - 'sps_profile': False, 08:27:58 INFO - 'sps_profile_interval': 0, 08:27:58 INFO - 'suite': 'dromaeojs', 08:27:58 INFO - 'system_bits': '32', 08:27:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:27:58 INFO - 'title': 'talos-linux64-ix-003', 08:27:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:27:58 INFO - 'use_talos_json': True, 08:27:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:27:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:27:58 INFO - 'work_dir': 'build'} 08:27:58 INFO - [mozharness: 2016-08-01 15:27:58.640415Z] Running clobber step. 08:27:58 INFO - Running pre-action listener: _resource_record_pre_action 08:27:58 INFO - Running main action method: clobber 08:27:58 INFO - rmtree: /builds/slave/test/build 08:27:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:27:59 INFO - Running post-action listener: _resource_record_post_action 08:27:59 INFO - [mozharness: 2016-08-01 15:27:59.108398Z] Finished clobber step (success) 08:27:59 INFO - [mozharness: 2016-08-01 15:27:59.108499Z] Running read-buildbot-config step. 08:27:59 INFO - Running pre-action listener: _resource_record_pre_action 08:27:59 INFO - Running main action method: read_buildbot_config 08:27:59 INFO - Using buildbot properties: 08:27:59 INFO - { 08:27:59 INFO - "project": "", 08:27:59 INFO - "product": "firefox", 08:27:59 INFO - "script_repo_revision": "production", 08:27:59 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 08:27:59 INFO - "repository": "", 08:27:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 08:27:59 INFO - "buildid": "20160801070949", 08:27:59 INFO - "pgo_build": "False", 08:27:59 INFO - "basedir": "/builds/slave/test", 08:27:59 INFO - "buildnumber": 667, 08:27:59 INFO - "slavename": "talos-linux64-ix-003", 08:27:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:27:59 INFO - "platform": "ubuntu64_hw", 08:27:59 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 08:27:59 INFO - "branch": "mozilla-central", 08:27:59 INFO - "repo_path": "mozilla-central", 08:27:59 INFO - "revision": "ffac2798999c5b84f1b4605a1280994bb665a406", 08:27:59 INFO - "stage_platform": "linux64", 08:27:59 INFO - "builduid": "1fc048ee03174d10b72e740fa55d5254", 08:27:59 INFO - "slavebuilddir": "test" 08:27:59 INFO - } 08:27:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/e0UgsodyS5-aFayGw9xv1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 08:27:59 INFO - Running post-action listener: _resource_record_post_action 08:27:59 INFO - [mozharness: 2016-08-01 15:27:59.110943Z] Finished read-buildbot-config step (success) 08:27:59 INFO - [mozharness: 2016-08-01 15:27:59.111033Z] Running download-and-extract step. 08:27:59 INFO - Running pre-action listener: _resource_record_pre_action 08:27:59 INFO - Running main action method: download_and_extract 08:27:59 INFO - mkdir: /builds/slave/test/build/tests 08:27: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')]} 08:27:59 INFO - https://queue.taskcluster.net/v1/task/e0UgsodyS5-aFayGw9xv1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:27:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0UgsodyS5-aFayGw9xv1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:27:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0UgsodyS5-aFayGw9xv1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:27:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0UgsodyS5-aFayGw9xv1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:27:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0UgsodyS5-aFayGw9xv1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:28:03 INFO - Downloaded 1361 bytes. 08:28:03 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:28:03 INFO - Using the following test package requirements: 08:28:03 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:28:03 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:28:03 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:28:03 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:28:03 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:28:03 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:28:03 INFO - u'jsshell-linux-x86_64.zip'], 08:28:03 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:28:03 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:28:03 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:28:03 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:28:03 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:28:03 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:28:03 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:28:03 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:28:03 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:28:03 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:28:03 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:28:03 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:28: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')]} 08:28:03 INFO - https://queue.taskcluster.net/v1/task/e0UgsodyS5-aFayGw9xv1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:28:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0UgsodyS5-aFayGw9xv1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:28:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0UgsodyS5-aFayGw9xv1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:28:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0UgsodyS5-aFayGw9xv1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:28:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0UgsodyS5-aFayGw9xv1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:28:04 INFO - Downloaded 20237458 bytes. 08:28:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:28:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:28:05 INFO - Return code: 0 08:28:05 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:28:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:28:05 INFO - https://queue.taskcluster.net/v1/task/e0UgsodyS5-aFayGw9xv1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:28:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0UgsodyS5-aFayGw9xv1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:28:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0UgsodyS5-aFayGw9xv1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:28:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0UgsodyS5-aFayGw9xv1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:28:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0UgsodyS5-aFayGw9xv1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:28:23 INFO - Downloaded 20237458 bytes. 08:28:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:28:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:28:25 INFO - Return code: 0 08:28:25 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')]} 08:28:25 INFO - https://queue.taskcluster.net/v1/task/e0UgsodyS5-aFayGw9xv1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:28:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0UgsodyS5-aFayGw9xv1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:28:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0UgsodyS5-aFayGw9xv1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:28:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0UgsodyS5-aFayGw9xv1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:28:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0UgsodyS5-aFayGw9xv1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:28:25 INFO - Downloaded 14413723 bytes. 08:28:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:28:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:28:26 INFO - Return code: 0 08:28: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')]} 08:28:26 INFO - https://queue.taskcluster.net/v1/task/e0UgsodyS5-aFayGw9xv1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:28:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0UgsodyS5-aFayGw9xv1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:28:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0UgsodyS5-aFayGw9xv1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:28:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0UgsodyS5-aFayGw9xv1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:28:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0UgsodyS5-aFayGw9xv1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:28:27 INFO - Downloaded 55648821 bytes. 08:28:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e0UgsodyS5-aFayGw9xv1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:28:27 INFO - mkdir: /builds/slave/test/properties 08:28:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:28:27 INFO - Writing to file /builds/slave/test/properties/build_url 08:28:27 INFO - Contents: 08:28:27 INFO - build_url:https://queue.taskcluster.net/v1/task/e0UgsodyS5-aFayGw9xv1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:28:28 INFO - Running post-action listener: _resource_record_post_action 08:28:28 INFO - Running post-action listener: set_extra_try_arguments 08:28:28 INFO - [mozharness: 2016-08-01 15:28:28.130902Z] Finished download-and-extract step (success) 08:28:28 INFO - [mozharness: 2016-08-01 15:28:28.131135Z] Running populate-webroot step. 08:28:28 INFO - Running pre-action listener: _resource_record_pre_action 08:28:28 INFO - Running main action method: populate_webroot 08:28:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:28:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:28:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:28:28 INFO - '--tppagecycles', 08:28:28 INFO - '7'], 08:28:28 INFO - 'tests': ['tsvgm']}}, 08:28:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:28:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:28:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:28:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:28:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:28:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:28:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:28:28 INFO - 'talos_options': ['--disable-e10s'], 08:28:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:28:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:28:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:28:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:28:28 INFO - 'talos_options': ['--disable-e10s'], 08:28:28 INFO - 'tests': ['damp', 'tps']}, 08:28:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:28:28 INFO - 'tests': ['damp', 'tps']}, 08:28:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:28:28 INFO - 'tests': ['dromaeo_dom']}, 08:28:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:28:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:28:28 INFO - 'tests': ['basic_compositor_video']}, 08:28:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:28:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:28:28 INFO - 'tests': ['a11yr', 08:28:28 INFO - 'ts_paint', 08:28:28 INFO - 'tpaint', 08:28:28 INFO - 'sessionrestore', 08:28:28 INFO - 'sessionrestore_no_auto_restore', 08:28:28 INFO - 'tabpaint']}, 08:28:28 INFO - 'other-e10s': {'tests': ['a11yr', 08:28:28 INFO - 'ts_paint', 08:28:28 INFO - 'tpaint', 08:28:28 INFO - 'sessionrestore', 08:28:28 INFO - 'sessionrestore_no_auto_restore', 08:28:28 INFO - 'tabpaint']}, 08:28:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:28:28 INFO - 'ts_paint', 08:28:28 INFO - 'tpaint', 08:28:28 INFO - 'sessionrestore', 08:28:28 INFO - 'sessionrestore_no_auto_restore', 08:28:28 INFO - 'tabpaint']}, 08:28:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:28:28 INFO - 'ts_paint', 08:28:28 INFO - 'tpaint', 08:28:28 INFO - 'sessionrestore', 08:28:28 INFO - 'sessionrestore_no_auto_restore', 08:28:28 INFO - 'tabpaint']}, 08:28:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:28:28 INFO - 'tests': ['a11yr', 08:28:28 INFO - 'ts_paint', 08:28:28 INFO - 'tpaint', 08:28:28 INFO - 'sessionrestore', 08:28:28 INFO - 'sessionrestore_no_auto_restore', 08:28:28 INFO - 'tabpaint']}, 08:28:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:28:28 INFO - 'tests': ['a11yr', 08:28:28 INFO - 'ts_paint', 08:28:28 INFO - 'tpaint', 08:28:28 INFO - 'sessionrestore', 08:28:28 INFO - 'sessionrestore_no_auto_restore', 08:28:28 INFO - 'tabpaint']}, 08:28:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:28:28 INFO - 'tests': ['tsvgx', 08:28:28 INFO - 'tsvgr_opacity', 08:28:28 INFO - 'tart', 08:28:28 INFO - 'tscrollx', 08:28:28 INFO - 'cart']}, 08:28:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:28:28 INFO - 'tsvgr_opacity', 08:28:28 INFO - 'tart', 08:28:28 INFO - 'tscrollx', 08:28:28 INFO - 'cart']}, 08:28:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:28:28 INFO - 'talos_options': ['--disable-e10s'], 08:28:28 INFO - 'tests': ['tp5o']}, 08:28:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:28:28 INFO - 'tests': ['tp5o']}, 08:28:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:28:28 INFO - 'talos_options': ['--disable-e10s', 08:28:28 INFO - '--xperf_path', 08:28:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:28:28 INFO - 'tests': ['tp5n']}, 08:28:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:28:28 INFO - 'talos_options': ['--xperf_path', 08:28:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:28:28 INFO - 'tests': ['tp5n']}}, 08:28:28 INFO - 'talos.zip': {'path': '', 08:28:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:28:28 INFO - Running post-action listener: _resource_record_post_action 08:28:28 INFO - [mozharness: 2016-08-01 15:28:28.152418Z] Finished populate-webroot step (success) 08:28:28 INFO - [mozharness: 2016-08-01 15:28:28.152507Z] Running create-virtualenv step. 08:28:28 INFO - Running pre-action listener: _resource_record_pre_action 08:28:28 INFO - Running main action method: create_virtualenv 08:28:28 INFO - Creating virtualenv /builds/slave/test/build/venv 08:28:28 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 08:28:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:28:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:28:28 INFO - Using real prefix '/usr' 08:28:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:28:28 INFO - Installing distribute.............................................................................................................................................................................................done. 08:28:30 INFO - Installing pip.................done. 08:28:30 INFO - Return code: 0 08:28:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:28: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')]} 08:28:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28: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')]} 08:28:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1752030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a13180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a113b0>, '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 0x1a122b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a12740>, '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': '7de08804244eb36560b44971000001c3-1470065060.921524-150398836', '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 08:28: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', 'pip>=1.5'] in /builds/slave/test/build 08:28: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 pip>=1.5 08:28:30 INFO - Using env: {'DISPLAY': ':0', 08:28:30 INFO - 'HOME': '/home/cltbld', 08:28:30 INFO - 'LANG': 'en_US.UTF-8', 08:28:30 INFO - 'LANGUAGE': 'en_US:en', 08:28:30 INFO - 'LOGNAME': 'cltbld', 08:28:30 INFO - 'MAIL': '/var/mail/cltbld', 08:28:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:30 INFO - 'MOZ_NO_REMOTE': '1', 08:28:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:30 INFO - 'NO_EM_RESTART': '1', 08:28:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:30 INFO - 'PWD': '/builds/slave/test', 08:28:30 INFO - 'SHELL': '/bin/bash', 08:28:30 INFO - 'SHLVL': '1', 08:28:30 INFO - 'TERM': 'linux', 08:28:30 INFO - 'TMOUT': '86400', 08:28:30 INFO - 'USER': 'cltbld', 08:28:30 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1470065060.921524-150398836', 08:28:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:30 INFO - '_': '/tools/buildbot/bin/python'} 08:28:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:31 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 08:28:31 INFO - Cleaning up... 08:28:31 INFO - Return code: 0 08:28:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:28: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')]} 08:28:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28: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')]} 08:28:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28: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', '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 0x1752030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a13180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a113b0>, '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 0x1a122b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a12740>, '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': '7de08804244eb36560b44971000001c3-1470065060.921524-150398836', '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 08:28: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', 'psutil>=3.1.1'] in /builds/slave/test/build 08:28: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 psutil>=3.1.1 08:28:31 INFO - Using env: {'DISPLAY': ':0', 08:28:31 INFO - 'HOME': '/home/cltbld', 08:28:31 INFO - 'LANG': 'en_US.UTF-8', 08:28:31 INFO - 'LANGUAGE': 'en_US:en', 08:28:31 INFO - 'LOGNAME': 'cltbld', 08:28:31 INFO - 'MAIL': '/var/mail/cltbld', 08:28:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:31 INFO - 'MOZ_NO_REMOTE': '1', 08:28:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:31 INFO - 'NO_EM_RESTART': '1', 08:28:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:31 INFO - 'PWD': '/builds/slave/test', 08:28:31 INFO - 'SHELL': '/bin/bash', 08:28:31 INFO - 'SHLVL': '1', 08:28:31 INFO - 'TERM': 'linux', 08:28:31 INFO - 'TMOUT': '86400', 08:28:31 INFO - 'USER': 'cltbld', 08:28:31 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1470065060.921524-150398836', 08:28:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:31 INFO - '_': '/tools/buildbot/bin/python'} 08:28:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:31 INFO - Downloading/unpacking psutil>=3.1.1 08:28: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 08:28: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 08:28: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 08:28: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 08:28: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 08:28: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 08:28:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:28:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:28:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:28:33 INFO - Installing collected packages: psutil 08:28:33 INFO - Running setup.py install for psutil 08:28:33 INFO - building 'psutil._psutil_linux' extension 08:28:33 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 08:28:33 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 08:28:33 INFO - building 'psutil._psutil_posix' extension 08:28:33 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 08:28:33 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 08:28:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:28:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:28:33 INFO - Successfully installed psutil 08:28:33 INFO - Cleaning up... 08:28:33 INFO - Return code: 0 08:28:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:28:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:28:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:28:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1752030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a13180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a113b0>, '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 0x1a122b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a12740>, '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': '7de08804244eb36560b44971000001c3-1470065060.921524-150398836', '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 08:28:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:28:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:28:33 INFO - Using env: {'DISPLAY': ':0', 08:28:33 INFO - 'HOME': '/home/cltbld', 08:28:33 INFO - 'LANG': 'en_US.UTF-8', 08:28:33 INFO - 'LANGUAGE': 'en_US:en', 08:28:33 INFO - 'LOGNAME': 'cltbld', 08:28:33 INFO - 'MAIL': '/var/mail/cltbld', 08:28:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:33 INFO - 'MOZ_NO_REMOTE': '1', 08:28:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:33 INFO - 'NO_EM_RESTART': '1', 08:28:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:33 INFO - 'PWD': '/builds/slave/test', 08:28:33 INFO - 'SHELL': '/bin/bash', 08:28:33 INFO - 'SHLVL': '1', 08:28:33 INFO - 'TERM': 'linux', 08:28:33 INFO - 'TMOUT': '86400', 08:28:33 INFO - 'USER': 'cltbld', 08:28:33 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1470065060.921524-150398836', 08:28:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:33 INFO - '_': '/tools/buildbot/bin/python'} 08:28:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:28:34 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 08:28:34 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 08:28:34 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 08:28:34 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 08:28:34 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 08:28:34 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 08:28:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:28:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:28:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:28:35 INFO - Installing collected packages: mozsystemmonitor 08:28:35 INFO - Running setup.py install for mozsystemmonitor 08:28:36 INFO - Successfully installed mozsystemmonitor 08:28:36 INFO - Cleaning up... 08:28:36 INFO - Return code: 0 08:28:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:28:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:28:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1752030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a13180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a113b0>, '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 0x1a122b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a12740>, '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': '7de08804244eb36560b44971000001c3-1470065060.921524-150398836', '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 08:28:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:28:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:28:36 INFO - Using env: {'DISPLAY': ':0', 08:28:36 INFO - 'HOME': '/home/cltbld', 08:28:36 INFO - 'LANG': 'en_US.UTF-8', 08:28:36 INFO - 'LANGUAGE': 'en_US:en', 08:28:36 INFO - 'LOGNAME': 'cltbld', 08:28:36 INFO - 'MAIL': '/var/mail/cltbld', 08:28:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:36 INFO - 'MOZ_NO_REMOTE': '1', 08:28:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:36 INFO - 'NO_EM_RESTART': '1', 08:28:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:36 INFO - 'PWD': '/builds/slave/test', 08:28:36 INFO - 'SHELL': '/bin/bash', 08:28:36 INFO - 'SHLVL': '1', 08:28:36 INFO - 'TERM': 'linux', 08:28:36 INFO - 'TMOUT': '86400', 08:28:36 INFO - 'USER': 'cltbld', 08:28:36 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1470065060.921524-150398836', 08:28:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:36 INFO - '_': '/tools/buildbot/bin/python'} 08:28:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:36 INFO - Downloading/unpacking jsonschema==2.5.1 08:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:28:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:28:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:28:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:28:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:28:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:38 INFO - Downloading functools32-3.2.3-2.tar.gz 08:28:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:28:38 INFO - warning: no files found matching '*.txt' 08:28:38 INFO - no previously-included directories found matching 'build' 08:28:38 INFO - no previously-included directories found matching 'dist' 08:28:38 INFO - no previously-included directories found matching '.git*' 08:28:38 INFO - Installing collected packages: jsonschema, functools32 08:28:38 INFO - Running setup.py install for functools32 08:28:38 INFO - warning: no files found matching '*.txt' 08:28:38 INFO - no previously-included directories found matching 'build' 08:28:38 INFO - no previously-included directories found matching 'dist' 08:28:38 INFO - no previously-included directories found matching '.git*' 08:28:38 INFO - Successfully installed jsonschema functools32 08:28:38 INFO - Cleaning up... 08:28:38 INFO - Return code: 0 08:28:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:28:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:28:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:28:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1752030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a13180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a113b0>, '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 0x1a122b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a12740>, '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': '7de08804244eb36560b44971000001c3-1470065060.921524-150398836', '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 08:28:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:28:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:28:38 INFO - Using env: {'DISPLAY': ':0', 08:28:38 INFO - 'HOME': '/home/cltbld', 08:28:38 INFO - 'LANG': 'en_US.UTF-8', 08:28:38 INFO - 'LANGUAGE': 'en_US:en', 08:28:38 INFO - 'LOGNAME': 'cltbld', 08:28:38 INFO - 'MAIL': '/var/mail/cltbld', 08:28:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:38 INFO - 'MOZ_NO_REMOTE': '1', 08:28:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:38 INFO - 'NO_EM_RESTART': '1', 08:28:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:38 INFO - 'PWD': '/builds/slave/test', 08:28:38 INFO - 'SHELL': '/bin/bash', 08:28:38 INFO - 'SHLVL': '1', 08:28:38 INFO - 'TERM': 'linux', 08:28:38 INFO - 'TMOUT': '86400', 08:28:38 INFO - 'USER': 'cltbld', 08:28:38 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1470065060.921524-150398836', 08:28:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:38 INFO - '_': '/tools/buildbot/bin/python'} 08:28:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:28:38 INFO - Cleaning up... 08:28:38 INFO - Return code: 0 08:28:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:28:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:28:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:28:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1752030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a13180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a113b0>, '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 0x1a122b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a12740>, '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': '7de08804244eb36560b44971000001c3-1470065060.921524-150398836', '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 08:28:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:28:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:28:38 INFO - Using env: {'DISPLAY': ':0', 08:28:38 INFO - 'HOME': '/home/cltbld', 08:28:38 INFO - 'LANG': 'en_US.UTF-8', 08:28:38 INFO - 'LANGUAGE': 'en_US:en', 08:28:38 INFO - 'LOGNAME': 'cltbld', 08:28:38 INFO - 'MAIL': '/var/mail/cltbld', 08:28:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:38 INFO - 'MOZ_NO_REMOTE': '1', 08:28:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:38 INFO - 'NO_EM_RESTART': '1', 08:28:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:38 INFO - 'PWD': '/builds/slave/test', 08:28:38 INFO - 'SHELL': '/bin/bash', 08:28:38 INFO - 'SHLVL': '1', 08:28:38 INFO - 'TERM': 'linux', 08:28:38 INFO - 'TMOUT': '86400', 08:28:38 INFO - 'USER': 'cltbld', 08:28:38 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1470065060.921524-150398836', 08:28:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:38 INFO - '_': '/tools/buildbot/bin/python'} 08:28:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:39 INFO - Downloading/unpacking blobuploader==1.2.4 08:28: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 08:28: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 08:28: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 08:28: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 08:28: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 08:28: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 08:28:40 INFO - Downloading blobuploader-1.2.4.tar.gz 08:28:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:28:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:28:41 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 08:28:41 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 08:28:41 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 08:28:41 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 08:28:41 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 08:28:41 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 08:28:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:28:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:28:41 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 08:28:41 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 08:28:41 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 08:28:41 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 08:28:41 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 08:28:41 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 08:28:41 INFO - Downloading docopt-0.6.1.tar.gz 08:28:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:28:41 INFO - Installing collected packages: blobuploader, requests, docopt 08:28:41 INFO - Running setup.py install for blobuploader 08:28:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:28:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:28:41 INFO - Running setup.py install for requests 08:28:42 INFO - Running setup.py install for docopt 08:28:42 INFO - Successfully installed blobuploader requests docopt 08:28:42 INFO - Cleaning up... 08:28:42 INFO - Return code: 0 08:28:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:28:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:28:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:28:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:42 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 0x1752030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a13180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a113b0>, '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 0x1a122b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a12740>, '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': '7de08804244eb36560b44971000001c3-1470065060.921524-150398836', '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 08:28:42 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 08:28:42 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 08:28:42 INFO - Using env: {'DISPLAY': ':0', 08:28:42 INFO - 'HOME': '/home/cltbld', 08:28:42 INFO - 'LANG': 'en_US.UTF-8', 08:28:42 INFO - 'LANGUAGE': 'en_US:en', 08:28:42 INFO - 'LOGNAME': 'cltbld', 08:28:42 INFO - 'MAIL': '/var/mail/cltbld', 08:28:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:42 INFO - 'MOZ_NO_REMOTE': '1', 08:28:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:42 INFO - 'NO_EM_RESTART': '1', 08:28:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:42 INFO - 'PWD': '/builds/slave/test', 08:28:42 INFO - 'SHELL': '/bin/bash', 08:28:42 INFO - 'SHLVL': '1', 08:28:42 INFO - 'TERM': 'linux', 08:28:42 INFO - 'TMOUT': '86400', 08:28:42 INFO - 'USER': 'cltbld', 08:28:42 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1470065060.921524-150398836', 08:28:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:42 INFO - '_': '/tools/buildbot/bin/python'} 08:28:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:28:42 INFO - Running setup.py (path:/tmp/pip-h5xKiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:28:42 INFO - Running setup.py (path:/tmp/pip-2bdC7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:28:42 INFO - Running setup.py (path:/tmp/pip-1XwEcB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:28:42 INFO - Running setup.py (path:/tmp/pip-IN7P7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:28:42 INFO - Running setup.py (path:/tmp/pip-Ukjwlj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:28:42 INFO - Running setup.py (path:/tmp/pip-95aHYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:28:42 INFO - Running setup.py (path:/tmp/pip-ez97FQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:28:43 INFO - Running setup.py (path:/tmp/pip-QxRB0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:28:43 INFO - Running setup.py (path:/tmp/pip-wjvciL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:28:43 INFO - Running setup.py (path:/tmp/pip-j2V_l0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:28:43 INFO - Running setup.py (path:/tmp/pip-Kc_zgd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:28:43 INFO - Running setup.py (path:/tmp/pip-SerL3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:28:43 INFO - Running setup.py (path:/tmp/pip-4tn9rl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:28:43 INFO - Running setup.py (path:/tmp/pip-RrkiHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:28:43 INFO - Running setup.py (path:/tmp/pip-GoSfR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:28:43 INFO - Running setup.py (path:/tmp/pip-Fj_DoZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:28:43 INFO - Running setup.py (path:/tmp/pip-fpoclv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:28:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:28:43 INFO - Running setup.py install for manifestparser 08:28:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:28:43 INFO - Running setup.py install for mozcrash 08:28:43 INFO - Running setup.py install for mozdebug 08:28:44 INFO - Running setup.py install for mozdevice 08:28:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:28:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:28:44 INFO - Running setup.py install for mozfile 08:28:44 INFO - Running setup.py install for mozhttpd 08:28:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:28:44 INFO - Running setup.py install for mozinfo 08:28:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:28:44 INFO - Running setup.py install for mozInstall 08:28:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:28:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:28:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:28:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:28:44 INFO - Running setup.py install for mozleak 08:28:44 INFO - Running setup.py install for mozlog 08:28:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:28:44 INFO - Running setup.py install for moznetwork 08:28:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:28:44 INFO - Running setup.py install for mozprocess 08:28:44 INFO - Running setup.py install for mozprofile 08:28:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:28:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:28:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:28:45 INFO - Running setup.py install for mozrunner 08:28:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:28:45 INFO - Running setup.py install for mozscreenshot 08:28:45 INFO - Running setup.py install for moztest 08:28:45 INFO - Running setup.py install for mozversion 08:28:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:28:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:28:45 INFO - Cleaning up... 08:28:45 INFO - Return code: 0 08:28:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:28:45 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')]} 08:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:45 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')]} 08:28:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:45 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 0x1752030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a13180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a113b0>, '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 0x1a122b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a12740>, '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': '7de08804244eb36560b44971000001c3-1470065060.921524-150398836', '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 08:28:45 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 08:28:45 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 08:28:45 INFO - Using env: {'DISPLAY': ':0', 08:28:45 INFO - 'HOME': '/home/cltbld', 08:28:45 INFO - 'LANG': 'en_US.UTF-8', 08:28:45 INFO - 'LANGUAGE': 'en_US:en', 08:28:45 INFO - 'LOGNAME': 'cltbld', 08:28:45 INFO - 'MAIL': '/var/mail/cltbld', 08:28:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:45 INFO - 'MOZ_NO_REMOTE': '1', 08:28:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:45 INFO - 'NO_EM_RESTART': '1', 08:28:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:45 INFO - 'PWD': '/builds/slave/test', 08:28:45 INFO - 'SHELL': '/bin/bash', 08:28:45 INFO - 'SHLVL': '1', 08:28:45 INFO - 'TERM': 'linux', 08:28:45 INFO - 'TMOUT': '86400', 08:28:45 INFO - 'USER': 'cltbld', 08:28:45 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1470065060.921524-150398836', 08:28:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:45 INFO - '_': '/tools/buildbot/bin/python'} 08:28:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:28:45 INFO - Running setup.py (path:/tmp/pip-Bwyr6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:28:45 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)) 08:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:28:45 INFO - Running setup.py (path:/tmp/pip-7A4ZGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:28:45 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)) 08:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:28:45 INFO - Running setup.py (path:/tmp/pip-_KUktQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:28:45 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)) 08:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:28:45 INFO - Running setup.py (path:/tmp/pip-RmZyQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:28:46 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)) 08:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:28:46 INFO - Running setup.py (path:/tmp/pip-HpjUSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:28:46 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)) 08:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:28:46 INFO - Running setup.py (path:/tmp/pip-2piSs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:28:46 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)) 08:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:28:46 INFO - Running setup.py (path:/tmp/pip-ChSPV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:28:46 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)) 08:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:28:46 INFO - Running setup.py (path:/tmp/pip-NUqEoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:28:46 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)) 08:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:28:46 INFO - Running setup.py (path:/tmp/pip-HJxx4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:28:46 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)) 08:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:28:46 INFO - Running setup.py (path:/tmp/pip-XCzlWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:28:46 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)) 08:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:28:46 INFO - Running setup.py (path:/tmp/pip-sfJqnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:28:46 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)) 08:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:28:46 INFO - Running setup.py (path:/tmp/pip-Mf0cdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:28:46 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)) 08:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:28:46 INFO - Running setup.py (path:/tmp/pip-qX7R9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:28:46 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)) 08:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:28:46 INFO - Running setup.py (path:/tmp/pip-Jww_6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:28:46 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)) 08:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:28:46 INFO - Running setup.py (path:/tmp/pip-spcQCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:28:46 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)) 08:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:28:46 INFO - Running setup.py (path:/tmp/pip-21WKgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:28:46 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)) 08:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:28:46 INFO - Running setup.py (path:/tmp/pip-WOFg8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:28:46 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)) 08:28:46 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)) 08:28:46 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)) 08:28:46 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)) 08:28:46 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)) 08:28:46 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)) 08:28:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:28:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:28:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:28:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:48 INFO - Downloading blessings-1.6.tar.gz 08:28:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:28:48 INFO - Installing collected packages: blessings 08:28:48 INFO - Running setup.py install for blessings 08:28:49 INFO - Successfully installed blessings 08:28:49 INFO - Cleaning up... 08:28:49 INFO - Return code: 0 08:28:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:28:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:28:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:28:49 INFO - Reading from file tmpfile_stdout 08:28:49 INFO - Current package versions: 08:28:49 INFO - argparse == 1.2.1 08:28:49 INFO - blessings == 1.6 08:28:49 INFO - blobuploader == 1.2.4 08:28:49 INFO - docopt == 0.6.1 08:28:49 INFO - functools32 == 3.2.3-2 08:28:49 INFO - jsonschema == 2.5.1 08:28:49 INFO - manifestparser == 1.1 08:28:49 INFO - mozInstall == 1.12 08:28:49 INFO - mozcrash == 0.17 08:28:49 INFO - mozdebug == 0.1 08:28:49 INFO - mozdevice == 0.48 08:28:49 INFO - mozfile == 1.2 08:28:49 INFO - mozhttpd == 0.7 08:28:49 INFO - mozinfo == 0.9 08:28:49 INFO - mozleak == 0.1 08:28:49 INFO - mozlog == 3.3 08:28:49 INFO - moznetwork == 0.27 08:28:49 INFO - mozprocess == 0.23 08:28:49 INFO - mozprofile == 0.28 08:28:49 INFO - mozrunner == 6.12 08:28:49 INFO - mozscreenshot == 0.1 08:28:49 INFO - mozsystemmonitor == 0.3 08:28:49 INFO - moztest == 0.7 08:28:49 INFO - mozversion == 1.4 08:28:49 INFO - psutil == 3.1.1 08:28:49 INFO - requests == 1.2.3 08:28:49 INFO - wsgiref == 0.1.2 08:28:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:28:49 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')]} 08:28:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:49 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')]} 08:28:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:49 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 0x1752030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a13180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a113b0>, '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 0x1a122b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a12740>, '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': '7de08804244eb36560b44971000001c3-1470065060.921524-150398836', '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 08:28:49 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 08:28:49 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 08:28:49 INFO - Using env: {'DISPLAY': ':0', 08:28:49 INFO - 'HOME': '/home/cltbld', 08:28:49 INFO - 'LANG': 'en_US.UTF-8', 08:28:49 INFO - 'LANGUAGE': 'en_US:en', 08:28:49 INFO - 'LOGNAME': 'cltbld', 08:28:49 INFO - 'MAIL': '/var/mail/cltbld', 08:28:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:49 INFO - 'MOZ_NO_REMOTE': '1', 08:28:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:49 INFO - 'NO_EM_RESTART': '1', 08:28:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:49 INFO - 'PWD': '/builds/slave/test', 08:28:49 INFO - 'SHELL': '/bin/bash', 08:28:49 INFO - 'SHLVL': '1', 08:28:49 INFO - 'TERM': 'linux', 08:28:49 INFO - 'TMOUT': '86400', 08:28:49 INFO - 'USER': 'cltbld', 08:28:49 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1470065060.921524-150398836', 08:28:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:49 INFO - '_': '/tools/buildbot/bin/python'} 08:28:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:49 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)) 08:28:49 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)) 08:28:49 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)) 08:28:49 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)) 08:28:49 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)) 08:28:49 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)) 08:28:49 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)) 08:28:49 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)) 08:28:49 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)) 08:28:49 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)) 08:28:49 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)) 08:28:49 INFO - Cleaning up... 08:28:49 INFO - Return code: 0 08:28:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:28:49 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')]} 08:28:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:49 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')]} 08:28:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:49 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 0x1752030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a13180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a113b0>, '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 0x1a122b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a12740>, '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': '7de08804244eb36560b44971000001c3-1470065060.921524-150398836', '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 08:28:49 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 08:28:49 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 08:28:49 INFO - Using env: {'DISPLAY': ':0', 08:28:49 INFO - 'HOME': '/home/cltbld', 08:28:49 INFO - 'LANG': 'en_US.UTF-8', 08:28:49 INFO - 'LANGUAGE': 'en_US:en', 08:28:49 INFO - 'LOGNAME': 'cltbld', 08:28:49 INFO - 'MAIL': '/var/mail/cltbld', 08:28:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:49 INFO - 'MOZ_NO_REMOTE': '1', 08:28:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:49 INFO - 'NO_EM_RESTART': '1', 08:28:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:49 INFO - 'PWD': '/builds/slave/test', 08:28:49 INFO - 'SHELL': '/bin/bash', 08:28:49 INFO - 'SHLVL': '1', 08:28:49 INFO - 'TERM': 'linux', 08:28:49 INFO - 'TMOUT': '86400', 08:28:49 INFO - 'USER': 'cltbld', 08:28:49 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1470065060.921524-150398836', 08:28:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:49 INFO - '_': '/tools/buildbot/bin/python'} 08:28:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:28:49 INFO - Cleaning up... 08:28:49 INFO - Return code: 0 08:28:49 INFO - Running post-action listener: _resource_record_post_action 08:28:49 INFO - Running post-action listener: _start_resource_monitoring 08:28:49 INFO - Starting resource monitoring. 08:28:49 INFO - [mozharness: 2016-08-01 15:28:49.819663Z] Finished create-virtualenv step (success) 08:28:49 INFO - [mozharness: 2016-08-01 15:28:49.820149Z] Running install step. 08:28:49 INFO - Running pre-action listener: _resource_record_pre_action 08:28:49 INFO - Running main action method: install 08:28:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:28:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:28:50 INFO - Reading from file tmpfile_stdout 08:28:50 INFO - Detecting whether we're running mozinstall >=1.0... 08:28:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:28:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:28:50 INFO - Reading from file tmpfile_stdout 08:28:50 INFO - Output received: 08:28:50 INFO - Usage: mozinstall [options] installer 08:28:50 INFO - Options: 08:28:50 INFO - -h, --help show this help message and exit 08:28:50 INFO - -d DEST, --destination=DEST 08:28:50 INFO - Directory to install application into. [default: 08:28:50 INFO - "/builds/slave/test"] 08:28:50 INFO - --app=APP Application being installed. [default: firefox] 08:28:50 INFO - mkdir: /builds/slave/test/build/application 08:28:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:28:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:29:06 INFO - Reading from file tmpfile_stdout 08:29:06 INFO - Output received: 08:29:06 INFO - /builds/slave/test/build/application/firefox/firefox 08:29:06 INFO - Running post-action listener: _resource_record_post_action 08:29:06 INFO - [mozharness: 2016-08-01 15:29:06.146163Z] Finished install step (success) 08:29:06 INFO - [mozharness: 2016-08-01 15:29:06.146444Z] Running run-tests step. 08:29:06 INFO - Running pre-action listener: _resource_record_pre_action 08:29:06 INFO - Running main action method: run_tests 08:29:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:29:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:29:06 INFO - Python 2.7.3 08:29:06 INFO - Return code: 0 08:29:06 INFO - grabbing minidump binary from tooltool 08:29:06 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')]} 08:29:06 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 0x1a113b0>, '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 0x1a122b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a12740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:29:06 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 08:29:06 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 08:29:06 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 08:29:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:29:06 INFO - Return code: 0 08:29:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:29:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:29:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:29:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:29:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:29:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e0UgsodyS5-aFayGw9xv1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 08:29:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/e0UgsodyS5-aFayGw9xv1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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 08:29:06 INFO - Using env: {'DISPLAY': ':0', 08:29:06 INFO - 'HOME': '/home/cltbld', 08:29:06 INFO - 'LANG': 'en_US.UTF-8', 08:29:06 INFO - 'LANGUAGE': 'en_US:en', 08:29:06 INFO - 'LOGNAME': 'cltbld', 08:29:06 INFO - 'MAIL': '/var/mail/cltbld', 08:29:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:29:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:29:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:06 INFO - 'MOZ_NO_REMOTE': '1', 08:29:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:29:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:06 INFO - 'NO_EM_RESTART': '1', 08:29:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:06 INFO - 'PWD': '/builds/slave/test', 08:29:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:29:06 INFO - 'SHELL': '/bin/bash', 08:29:06 INFO - 'SHLVL': '1', 08:29:06 INFO - 'TERM': 'linux', 08:29:06 INFO - 'TMOUT': '86400', 08:29:06 INFO - 'USER': 'cltbld', 08:29:06 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1470065060.921524-150398836', 08:29:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:06 INFO - '_': '/tools/buildbot/bin/python'} 08:29:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e0UgsodyS5-aFayGw9xv1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 08:29:06 INFO - mozversion application_buildid: 20160801070949 08:29:06 INFO - mozversion application_changeset: ffac2798999c5b84f1b4605a1280994bb665a406 08:29:06 INFO - mozversion application_display_name: Nightly 08:29:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:29:06 INFO - mozversion application_name: Firefox 08:29:06 INFO - mozversion application_remotingname: firefox 08:29:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:29:06 INFO - mozversion application_vendor: Mozilla 08:29:06 INFO - mozversion application_version: 51.0a1 08:29:06 INFO - mozversion platform_buildid: 20160801070949 08:29:06 INFO - mozversion platform_changeset: ffac2798999c5b84f1b4605a1280994bb665a406 08:29:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:29:06 INFO - mozversion platform_version: 51.0a1 08:29:06 INFO - using testdate: 1470065346 08:29:06 INFO - actual date: 1470065346 08:29:06 INFO - starting webserver on 'localhost:43362' 08:29:06 INFO - SUITE-START | Running 2 tests 08:29:06 INFO - TEST-START | dromaeo_css 08:29:06 INFO - operating with platform_type : linux_ 08:29:06 INFO - Initialising browser for dromaeo_css test... 08:29:06 INFO - TEST-INFO | started process 30636 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKX_v4a/profile http://localhost:43362/getInfo.html) 08:29:10 INFO - PROCESS | 30636 | __metrics Screen width/height:1600/1200 08:29:10 INFO - PROCESS | 30636 | colorDepth:24 08:29:10 INFO - PROCESS | 30636 | Browser inner width/height: 1024/697 08:29:10 INFO - PROCESS | 30636 | __metrics 08:29:11 INFO - PROCESS | 30636 | 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" 08:29:11 INFO - PROCESS | 30636 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:29:12 INFO - TEST-INFO | 30636: exit 0 08:29:12 INFO - Browser initialized. 08:29:12 INFO - Running cycle 1/1 for dromaeo_css test... 08:29:12 INFO - TEST-INFO | started process 30713 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKX_v4a/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:29:24 INFO - PROCESS | 30713 | RSS: Main: 157302784 08:29:24 INFO - PROCESS | 30713 | 08:30:16 INFO - PROCESS | 30713 | 1470065416919 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] 08:32:28 INFO - PROCESS | 30713 | Cycle 1(1): loaded http://localhost:43362/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43362/tests/dromaeo/cssquery-ext.html) 08:32:29 INFO - PROCESS | 30713 | RSS: Main: 250167296 08:32:29 INFO - PROCESS | 30713 | 08:35:32 INFO - PROCESS | 30713 | Cycle 1(1): loaded http://localhost:43362/tests/dromaeo/cssquery-ext.html (next: http://localhost:43362/tests/dromaeo/cssquery-jquery.html) 08:35:33 INFO - PROCESS | 30713 | RSS: Main: 242696192 08:35:33 INFO - PROCESS | 30713 | 08:38:35 INFO - PROCESS | 30713 | Cycle 1(1): loaded http://localhost:43362/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43362/tests/dromaeo/cssquery-mootools.html) 08:38:36 INFO - PROCESS | 30713 | RSS: Main: 186302464 08:38:36 INFO - PROCESS | 30713 | 08:41:38 INFO - PROCESS | 30713 | Cycle 1(1): loaded http://localhost:43362/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43362/tests/dromaeo/cssquery-prototype.html) 08:41:38 INFO - PROCESS | 30713 | RSS: Main: 187994112 08:41:38 INFO - PROCESS | 30713 | 08:44:41 INFO - PROCESS | 30713 | Cycle 1(1): loaded http://localhost:43362/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43362/tests/dromaeo/cssquery-yui.html) 08:44:42 INFO - PROCESS | 30713 | RSS: Main: 188989440 08:44:42 INFO - PROCESS | 30713 | 08:47:45 INFO - PROCESS | 30713 | Cycle 1(1): loaded http://localhost:43362/tests/dromaeo/cssquery-yui.html (next: http://localhost:43362/tests/dromaeo/cssquery-dojo.html) 08:47:45 INFO - PROCESS | 30713 | RSS: Main: 283308032 08:47:45 INFO - PROCESS | 30713 | 08:47:45 INFO - PROCESS | 30713 | __start_tp_report 08:47:45 INFO - PROCESS | 30713 | _x_x_mozilla_page_load 08:47:45 INFO - PROCESS | 30713 | _x_x_mozilla_page_load_details 08:47:45 INFO - PROCESS | 30713 | |i|pagename|runs| 08:47:45 INFO - PROCESS | 30713 | |0;dojo.html;2649.8807553660085;2650.3771613670788;2683.114572191177;2686.650735404397;2695.393536454298;4469.396631454752;4720.716756994582;4745.762711864406;4788.976055119724;4801.567858892703;4714.057188562293;4738.218193997995;4757.524247575249;4773.474917759052;4785.952140478594;4287.957120428795;4308.892277693051;4352.6953113281925;4408.096340250241;4540.704854184468;4467.486239082498;4497.392851964975;4520.141173177102;4548.772561371935;4549.499555048942;4303.548127446605;4348.34774783785;4405.383246345515;4415.20526305265;4489.685721999445;4316.48202215733;4331.198728235287;4361.890952726176;4378.978105109486;4385.583369579885;4342.305231162999;4408.801603927799;4422.137683151786;4426.336049592587;4473.709208901411;4632.166210082218;4805.231163013901;4850.660453768238;4854.466008739036;4865.051314993542;4986.62600304975;5024.899502009976;5036.244563315532;5047.823326183603;5110.6422550421485;5063.898722025576;5065.645404821664;5087.847364579068;5116.718580478072;5126.461721519224;4692.81228750853;4751.786169622375;4772.9761351193365;4779.02030083832;4786.664933454625;5234.031704134747;5261.316028916216;5278.4721527846905;5299.44355842631;5303.655262407931;5042.268871013755;5091.974540127349;5097.286379906816;5099.311592934981;5101.20931255656;4867.099586576494;5018.648694591344;5183.429822719498;5184.326037615086;5196.636235463557;4997.525235102659;5022.096022715873;5022.59819214462;5066.392032956069;5066.898662026739;5008;5018.347614810052;5019.824306149268;5024.2463630454995;5064.721440320818;4287.2711639021445;4314.439122914064;4379.802908869108;4385.912281754347;4437.733735975852;3726.5900750917376;3758.8684396046006;3773.339665558516;3783.4135708965155;3840.2703486337505;4325.15659446405;4326.783660817009;4327.783610819446;4364.978175109104;4369.956300437018;4994.101061808909;5026.824061157842;5027.572656324181;5029;5055.721935293521;4357.716748411343;4388.71473354231;4391.714538554984;4409.889752756207;4456.309272062836;4647.767611619405;4673.976630116896;4675.6727029108315;4675.859724208279;4727.220008698526;4688.484266730725;4838.830640927551;4843.709377437365;4849.248366503198;4900.166971614834;5032.62255330859;5045.621578381562;5088.160453525127;5104.795808167632;5174.741262936914;4812.807487700593;4825.059113472979;4825.469198388104;4826.493218212037;4844.128056949783;4941;5047.091523525801;5049.974750126225;5052.873678158076;5104.923426148536;5055.949440505695;5107.41264754558;5122.590192784493;5132.717700526507;5167.61242906791;4983.152864013054;4988.176950803077;4992.850214493571;4992.975035124801;5042.571381432473;4799.1601469743355;4988.176950803222;4999.10016197088;5000.849974500771;5007.529744985976;4837.4920633332995;4841.564259216688;4870.439899411613;4912.214045752662;4944.53026962438;4995.350604421402;4998.525140111684;5001.8749531260555;5004.649674522749;5017.046761115376;4752.5485078917445;4892.266160075875;4895.755212239303;4898.779554919965;4933.629977751755 08:47:45 INFO - PROCESS | 30713 | |1;ext.html;561.2619405481792;577.9335376431711;578.3897987623056;581.3837332427624;589.3046205477535;28933.27666808331;38227.42658860119;39794;39894.2021159577;42718.57281427185;40645.59354406462;40952.38571421431;41044.179116417654;41045.179096418055;41075.38386924191;7736.419768517356;7875.4487185897015;7881.014873140857;7883.093444253898;7889.132195458495;7798.4930979486435;7877.291043806056;7878.369730421581;7888.9605551972445;7889.171636978121;7845;7911.446198766089;7914.24814642608;7920.405969552277;7921.405894557903;7799.532028078305;7813.648385822595;7822.256885595916;7879.8030049248655;7881.842363152762;7579.279968402993;7652.885206721904;7670.616469176519;7675.385969122457;7675.846483070363;38548;38923.80538097292;39055;39102.60897391018;39108.41337379941;2913.1988703106604;3007.7142671446177;3077.9538306925415;3110.9066727998197;3251.122197006795;28015.719842801514;28326.575101373495;28675.426491470054;28741.425171496663;28806;2944.6319210098736;3023.5011223148153;3155.100796273074;3233.369492948876;3291.522729204252;263451;263849;264677;264921;265103.9999999981;53828.46171538313;54377;54421.183682244795;54439;54540.727296363264;32353.35293294121;33110.66889331124;33292.167695807315;34853;57852.421475785544;15166;15280.617984550476;15302.693946121015;15319.61700957485;15354.77355783405;11379.715507112223;11410.201285910072;11429.371384573928;11437.885621143849;11452;17800.3769868054;17811.821881781016;18015.549611259823;18045.7293140603;18073.096345182686;6690.498212634072;6795.422389096982;6820.727170913207;6829.760958366533;6995.930040699528;796.4783067091065;859.879616853641;876.6318146378536;878.7583414560919;954.4559601027487;28378.71621283802;28602.856985714938;28851.42297154045;28883.855580721964;29104;905.3888625177979;968.1963969904962;980.568549838069;1002.0180223381127;1017.9185665146919;14279.78580321296;14627.195504247156;14703.191324477042;15079.849201508065;15171.634552890073;421427;421951;422999;423516;423790;49246.261306080436;49717.25424118641;49939;50005.24992125121;50019.74990125026;1003.859459675646;1161.8373427720126;1198.3528894397102;1204.4399354300292;1222.0773316146253;27422.314442139104;28416.715832841408;28857.855710721313;29127;29415.558766618946;41823.58176418197;42183.36724949067;42219.3667095;42233.1553368937;42306;291151;291300;292045;293074;294126;23286.76713232846;23812.16657416982;24834.130805421722;24881.253562393158;25056.749432505443;40746;41007;41030.38454423127;41443.37834932418;41875.162496750505;34793.304133917685;34969.82515087408;35357.292854143285;35487.46768798522;35600.28799424049;35101.297974040885;35169.82415087908;35417;35469.46795798014;35610.28779424449;35381.29237415186;35470.64529354673;35874;36101.81949090238;36695.26609467849;30397.392052159274;32276.35447291088;32367.35265294728;32486.512702309956;32615.510767338033;24895.62656560189;25318.746812532376;25369.61945570781;25509.3622659435;25783.742162578885 08:47:45 INFO - PROCESS | 30713 | |2;jquery.html;348.61129840228153;351.57810627247306;354.21541286051394;365.0818192246499;366.6315353070164;16610.66778664426;16845.915770421147;17905.82094179058;17984.100794960264;17996.460106196835;16860.915695421536;17299;17470.475885723416;17541;17558;4878.902421951559;5127.077126117298;5135.563477104451;5136.332276804011;5138.820141295056;3819.8854034379015;3970.523537175543;5089.847304580869;5755.510781583571;5986.042233242682;6094.02495600704;6101.481374083208;6101.9389806102035;6103.633781973073;6106.847328816771;5816.302043754756;6002.639841609517;6018.277806663206;6033.125196846433;6036.9396306036815;4698.08387364464;5280.234366016906;5282.2340760589495;5287.127623942045;5290.497402746733;11688;12392.876071239263;12403.565875194416;12419.254844709347;12443.128980971336;1782.4830799068254;1805.0884303426817;1857.9535511612319;1953.2772874036698;2281;9016.504092274923;9018.188363047291;9115.680951166678;9605.327627066108;9656.613735450574;1667.633120713441;1724.1034661975702;1731.6450127723785;1744.6249056452796;1791.0003718854593;67918;68464;68485;69076.6546167271;69696.6515167426;10134.949325253327;10138.695839124837;10141.340812847142;10360.378377297386;10430.113440357654;14014;14029.508967186099;14030.649233769238;14032;14035.649108772363;7402.259774022555;7628.351590114791;7678.577678227751;7743.4966727162555;7760.379169666526;7434.628268586549;7475.401967842559;7629.3133617974645;7647.617619119022;7653.311201991847;4204.642605378577;4313.331433627793;4376.6717496187275;4454.532274111237;4512.796924138422;1513.9243037848064;1666.7166581680901;1727.6285598596362;1793.7757780277466;1878.117284876106;817.7669364231166;818.3616778912458;881.5504092912532;882.501386716516;895.6059333893066;16989.40537081196;17060.82939170617;17503.64992700139;17862.28550857977;18159.818401816075;841.4951029382444;849.9192576705203;851.5316575883239;865.8831057807241;889.3996552327153;9501.42991420517;10015.449150296658;10042.447665378475;10050.196039257828;10134.949325253327;396689;397446;401421;406084;406757;75690.62154689191;75967.24963907672;77105.61447192729;77525.61237193778;77594;791.8891355210275;858.4737702119381;889.7375274293969;905.4114825363434;909.5634095634133;14301.785473218119;15165.545033649008;16571.66856662884;16681.249343779316;16683.666326673156;36977.815110924275;37109.443358349105;37482;38024.61975380211;38778.41832372573;48843.5115648839;49170.508294916595;49898.251526226406;49938.25092623686;50257;6349.206349206349;6647.135872336566;6689.732410703712;6791.117154769849;6975.686094125878;8197.672093116209;10317.638882639072;11055.115590752881;11519.481623327138;11757.47091380907;9625.374350667184;10093.293469457067;10179.440130792582;10552.577896884039;10718.410487423267;9871.901280987098;9882.4564648945;10109.090181883372;10142.695719128438;10403.427811470441;9896.257780666623;9909.256805739742;10361.896381036093;10717.303375280582;10833.783324333626;6778.966105169443;6786.966065169642;6923;6937.306269373023;7022;9004.774880628036;9112.088791120836;9242.72271831846;9248;9396.248300136109 08:47:45 INFO - PROCESS | 30713 | |3;mootools.html;1328;1387.535175716135;1409.4644035266597;1626.5933516620844;1643.3837311008378;7138.571685698856;7705.422093343008;7726.768196954086;7734.961325193366;7735.110462296838;6408.231012278533;7083.929160708404;7311.597862117582;7334.669939852706;7567.091948966118;2148.21590119606;2166.6749987501844;2170.1861801824316;2170.2295685031745;2170.2621108822996;2071.564971356017;2126.5427932994403;2128.19128731082;2130.041481333398;2132.6694362373855;1797.128392729525;2072.2229164063474;2140.240214723774;2145.603063433262;2159.168720042787;2149.838762092834;2155.385715071205;2178.7276590426195;2180.9345719628436;2184.137265780008;2119.205298013245;2129.9254526091513;2130.936071917845;2134.541073669169;2136.0708091980036;7366.410687145016;7499.362554182901;7511.211322811136;7517.17311095779;7523.435742319348;4400.823967041314;4519.41247637805;4530.8867278317975;4531.229690952546;4537.478190008158;2764.7788176945796;2875.683674795771;2915.1691767846273;2923.6053132827224;2932.9706702932913;802.2539038694013;843.3169133002287;854.8717692346198;861.9224269815684;867.4925168776274;10124.139448146916;10196;10209.336393134423;10252.282340236186;10287.251167301576;3969.8809035728973;4088.550259471456;4216.2832318505925;4277.615014648634;4279.786010699452;8676.436031657922;8718.86921696175;8734.475931444007;8738.30093592511;8742.431741936754;4608.262677971508;4612.677112602153;4613.354130421743;4617.699849509771;4626.560476754703;4130.235906357333;4169.45797046382;4188.267053265667;4194.3498757692605;4194.706370554093;3501.7548771586253;3565.964340356615;3636.4908912752235;3638.9636103638622;3639.181184233579;1118.3178261260625;1135.73310272086;1154.8498695169574;1156.9363684997238;1160.5473865192582;566.0967628203514;662.102850637389;682.1405029662561;849.0490650471511;854.3506934729526;5204.089284375219;5205.349331333583;5443.319585051869;5476.616636835463;5607.607467477319;857.4855086947906;863.5336918064176;866.6836604639387;900.7928176519438;906.9365144439826;3679.3193259247123;3687.446882967576;3705.6479634434686;3781.962180378216;3818.3890577507464;9148.588313525906;9534;9551.856722149174;9553.235741140692;9564.760880977892;9409.482478463613;9503.667371642097;9511.334206605472;9517.90482095184;9521.666741664008;7069.8939515907305;7205.531640443459;7209.243029481829;7223.313785190398;7223.313785190398;4962.131626965194;5013.122703526941;5074.289599456153;5111.744412779271;5128.974355128201;8457.492550446992;8692.695755648521;8779.165979231962;8785.604647790737;8800.559972001247;8283.25450709439;8622.094680058504;8631.309495240492;8912.28701703875;8913.55432228373;6593.472522198117;6751.797446076625;6760.121184246016;6762.49281303914;6763.086983257197;7053.294670532906;7056.576605403692;7059.964700176466;7063.717451302096;7092.716291348288;6569.211694596679;6659.500537459613;6702.932970670231;6711.161104861892;6760.526763126534;6359.618422894641;6440.806775796734;6456.903146452901;6476.093346931528;6499.1876015498065;6056.152138700673;6157.630542167484;6157.907631385622;6161.260648722182;6165.4451099399475;4359.149965756647;4476.08240310742;4484.686071975061;4520.389747384061;4680.297955306732;4415.2935530315;4435.489918659267;4522.773861306987;4531.0711304181905;4535.569120933506 08:47:45 INFO - PROCESS | 30713 | |4;prototype.html;289.5945676053525;290.9389028304056;299.85007496251876;301.8536010035134;307.5893681934617;4831.202851529498;4857.87855303618;4864.440589332228;4874.025194961008;4894.167991441454;4779.665423420362;4788.688735232207;4810.807567697288;4836.322914791923;4846.297286893398;3589;3698.574663913644;3709.4806727058235;3770;3807.828647710846;3783.4703141560203;3788.071922379021;3793.742723079777;3795.8102094895285;3799.9740070181033;3757.643023912724;3769.453429252757;3783.8675646352385;3788.299164654548;3796.1838204785968;3490.2844916791996;3587.6232995535356;3668.5047518584915;3768.698504119664;3817.9045523861987;3339.4322965095994;3342.782719123249;3357.5635167428077;3359.72330514403;3384.9830750846336;4652.441706995149;4700.412448443944;4701.7414042227665;4703.435587729495;4728.952710472886;4136.31750761127;4267.957320426787;4354.455693038371;4356.324769660708;4366.912661746779;4994.375703037121;4995.750212489397;4999.75001249936;5011.223260394645;5015.22264049073;3613.7651052681754;3617.6201498842506;3640.2719456108885;3642;3648.233870887117;5092.8472145835685;5285.286486324374;5294.285271488338;5303.681779093266;5323.494268044529;3674.926501469956;3693.6675699187203;3701.315901264918;3710.9775172531035;3724.962750372516;3756.924861502809;3768.1521657627363;3769.133099387156;3772;3778.7165962552367;4175.185838761473;4279.957200428018;4299.763513006752;4313.102235016583;4320.243957307459;5018.372703412074;5042.193249080203;5047.596192304607;5049.469805670426;5105.438401775802;1265.1080987903506;1282.8460584729892;1289.4455384184891;1290.161395093197;1292.9482820687256;759.3583422008394;805.6173317674057;806.1897792718281;809.817790997021;811.9959400202961;3998.520177578709;4291.806868690854;4320.330348795942;4418.64650827933;4477.3731677565165;5186.896262074737;5211.322528071327;5221.686698798084;5226.843194704165;5236.790528378899;4485.147821913891;4495.910081798345;4496.414561627077;4508.616767574793;4509.6843220974215;2652.82756620819;2742.3281296082187;2751.1608959267214;2764.502389569897;2772.126780064273;4889.413270407574;4889.853304400874;4905.601903457497;4915.5330243626795;4915.721912302827;5302.666826596285;5316.468353164652;5317.325042611565;5359.705216213068;5364.222187782828;4619.9076018479445;4898.779554920037;4915.16442204826;4918.631102667314;4927.029188324699;5221.78860001089;5224.373075230997;5224.555912747459;5231.633785635121;5302.912902854982;4912.656114072123;5181.041507321158;5181.5077567631015;5203.791848326176;5215.269862219368;4909.9018019640125;4918.803247870188;4926.531979461945;4930.778114984762;4939.48135445773;3598.1724203433882;3608.4948107264477;3634.5093412390047;3653.689436397936;3679.632036796299;5103.209002604603;5293.841184764463;5318.813841515528;5322.760475778677;5322.866928326823;5071.008105217939;5084.313617661568;5094.2103973884105;5100.336956195671;5127.1540195867265;5075.87310317245;5078.720670363018;5079.492050794891;5094.993953567413;5142.202958541432;4737.8341758038305;5035.420926593489;5038;5068.594512438923;5075.771590278372;4872.975635121802;4932.556069953722;5033.798648054037;5077.375239923189;5111.488851114858;4972;4979.925301120414;4985.750712464434;4988.9251661225835;4990.101781679187 08:47:45 INFO - PROCESS | 30713 | |5;yui.html;576.0552693582525;589.4900910712236;604.2778879239308;641.304184959319;647.4561368450503;12261.448234829431;12597.937010314936;13262.602121936334;13276.07067505275;13339.666508337297;12811.551595694153;12854.93572532136;12911.096223264376;12921.547745828899;12925.547605833797;734.5225603357807;758.3402439877287;764.2433990349542;764.3770327183328;764.8087978005499;613.1844646620007;740.7296336837043;761.8552475029754;763.919788422216;766.7278116268728;805.2470939671426;807.116207752513;807.2371608829658;807.6042739057849;807.7536351412816;802.4262652203703;805.7341077444429;805.8227190018216;805.8710606302964;805.9717909873185;470.8046160843246;562.2634349002819;565.8161097643282;579.238301633355;579.5305802300109;12238.388080595934;12258.387080645933;12261.448234829453;12299.32353720545;12407.193532420364;11156.330620162817;11263.887361126366;11376.886231137749;11384;11918.761624767543;10602.787944241072;10673.466326683634;10783.13734901206;10788;11263.155263355282;3759.7180211484247;3847.03824043989;3873.2640798248244;3914.6868250539887;3979.781112038837;66488.66755666239;67524;67620;70191;70195;9281.340638092115;9476.857847132298;9523.333366664267;9733.124018838196;9740.853887191697;17807.46577602674;17824.46526604204;17962.91018544899;17997.640047198984;18075;6390.297067322591;6413.076077176828;6590;6596.703148358335;6657.20113586363;3397.796132232074;3403.3873902697255;3470.704990075821;3506.6668666476644;3514.578250609943;2664.5603475426337;2736.9589456158174;2738.0416854101304;2740.4245108527034;2745.135282386082;462.09660114476117;464.84195373573147;468.07087930458016;475.9428868535798;481.1291562272298;405.77885052646377;461.93301971213987;477.9604360515864;500.7195970256668;501.1255359397874;7129.643517824088;7230.313120253672;7311.378532824663;7343.192248852622;7552.169261381244;507.99492005080214;518.5048278893647;529.6689569019363;534.4601952028402;578.4475825586554;3324.384988777084;3334.249793796425;3415.777974431654;3462.1517728156764;3515.771474854126;97554;104080;104875;106648;107641;52333.7383313081;52333.95332093337;85563.57218213993;87911.56044219738;88306;81920.59039704764;81935;82253.9999999988;83561;84223;6470.935290647033;6568.47452203813;6586.934130658632;6592.80221593353;6681.732730690718;47238.76380618075;47902;47931.76034119807;48177.277340840614;50335.244971324726;38770;51775.48224517857;63103.36896631159;63789.36210637834;64329.42682292843;8321.833563328579;8394.164208602853;8626.568671566522;8703.608337624695;8731.301495880442;9121.77195570116;9204.815903682023;9217.124373184537;9254.213391861498;9446.85829712541;8464.44981076228;8607;8662.090480499457;8744.081871403665;8768.079351667982;8907.955460222658;9028;9127.041660625804;9271.490068046322;9496.335256531976;9006;9082.591283392396;9091.772705682411;9109.817803643757;9292.814143717223;6966.407855332353;6998.580085194904;7075.327843854826;7118.9644051779405;7125.893111603226;7203.783886483414;7303.196648368781;7333.413326933939;7402.4078073755045;7438.665260063419 08:47:45 INFO - PROCESS | 30713 | __end_tp_report 08:47:45 INFO - PROCESS | 30713 | __start_cc_report 08:47:45 INFO - PROCESS | 30713 | _x_x_mozilla_cycle_collect,1033 08:47:45 INFO - PROCESS | 30713 | __end_cc_report 08:47:45 INFO - PROCESS | 30713 | __startTimestamp1470066465277__endTimestamp 08:47:45 INFO - PROCESS | 30713 | 08:47:45 INFO - PROCESS | 30713 | ------- Summary: start ------- 08:47:45 INFO - PROCESS | 30713 | Number of tests: 6 08:47:45 INFO - PROCESS | 30713 | 08:47:45 INFO - PROCESS | 30713 | [#0] dojo.html Cycles:165 Average:4715.11 Median:4843.71 stddev:488.90 (10.1%) stddev-sans-first:462.77 08:47:45 INFO - PROCESS | 30713 | Values: 2649.9 2650.4 2683.1 2686.7 2695.4 4469.4 4720.7 4745.8 4789.0 4801.6 4714.1 4738.2 4757.5 4773.5 4786.0 4288.0 4308.9 4352.7 4408.1 4540.7 4467.5 4497.4 4520.1 4548.8 4549.5 4303.5 4348.3 4405.4 4415.2 4489.7 4316.5 4331.2 4361.9 4379.0 4385.6 4342.3 4408.8 4422.1 4426.3 4473.7 4632.2 4805.2 4850.7 4854.5 4865.1 4986.6 5024.9 5036.2 5047.8 5110.6 5063.9 5065.6 5087.8 5116.7 5126.5 4692.8 4751.8 4773.0 4779.0 4786.7 5234.0 5261.3 5278.5 5299.4 5303.7 5042.3 5092.0 5097.3 5099.3 5101.2 4867.1 5018.6 5183.4 5184.3 5196.6 4997.5 5022.1 5022.6 5066.4 5066.9 5008.0 5018.3 5019.8 5024.2 5064.7 4287.3 4314.4 4379.8 4385.9 4437.7 3726.6 3758.9 3773.3 3783.4 3840.3 4325.2 4326.8 4327.8 4365.0 4370.0 4994.1 5026.8 5027.6 5029.0 5055.7 4357.7 4388.7 4391.7 4409.9 4456.3 4647.8 4674.0 4675.7 4675.9 4727.2 4688.5 4838.8 4843.7 4849.2 4900.2 5032.6 5045.6 5088.2 5104.8 5174.7 4812.8 4825.1 4825.5 4826.5 4844.1 4941.0 5047.1 5050.0 5052.9 5104.9 5055.9 5107.4 5122.6 5132.7 5167.6 4983.2 4988.2 4992.9 4993.0 5042.6 4799.2 4988.2 4999.1 5000.8 5007.5 4837.5 4841.6 4870.4 4912.2 4944.5 4995.4 4998.5 5001.9 5004.6 5017.0 4752.5 4892.3 4895.8 4898.8 4933.6 08:47:45 INFO - PROCESS | 30713 | 08:47:45 INFO - PROCESS | 30713 | [#1] ext.html Cycles:180 Average:47567.17 Median:35479.06 stddev:88047.38 (248.2%) stddev-sans-first:88223.64 08:47:45 INFO - PROCESS | 30713 | Values: 561.3 577.9 578.4 581.4 589.3 28933.3 38227.4 39794.0 39894.2 42718.6 40645.6 40952.4 41044.2 41045.2 41075.4 7736.4 7875.4 7881.0 7883.1 7889.1 7798.5 7877.3 7878.4 7889.0 7889.2 7845.0 7911.4 7914.2 7920.4 7921.4 7799.5 7813.6 7822.3 7879.8 7881.8 7579.3 7652.9 7670.6 7675.4 7675.8 38548.0 38923.8 39055.0 39102.6 39108.4 2913.2 3007.7 3078.0 3110.9 3251.1 28015.7 28326.6 28675.4 28741.4 28806.0 2944.6 3023.5 3155.1 3233.4 3291.5 263451.0 263849.0 264677.0 264921.0 265104.0 53828.5 54377.0 54421.2 54439.0 54540.7 32353.4 33110.7 33292.2 34853.0 57852.4 15166.0 15280.6 15302.7 15319.6 15354.8 11379.7 11410.2 11429.4 11437.9 11452.0 17800.4 17811.8 18015.5 18045.7 18073.1 6690.5 6795.4 6820.7 6829.8 6995.9 796.5 859.9 876.6 878.8 954.5 28378.7 28602.9 28851.4 28883.9 29104.0 905.4 968.2 980.6 1002.0 1017.9 14279.8 14627.2 14703.2 15079.8 15171.6 421427.0 421951.0 422999.0 423516.0 423790.0 49246.3 49717.3 49939.0 50005.2 50019.7 1003.9 1161.8 1198.4 1204.4 1222.1 27422.3 28416.7 28857.9 29127.0 29415.6 41823.6 42183.4 42219.4 42233.2 42306.0 291151.0 291300.0 292045.0 293074.0 294126.0 23286.8 23812.2 24834.1 24881.3 25056.7 40746.0 41007.0 41030.4 41443.4 41875.2 34793.3 34969.8 35357.3 35487.5 35600.3 35101.3 35169.8 35417.0 35469.5 35610.3 35381.3 35470.6 35874.0 36101.8 36695.3 30397.4 32276.4 32367.4 32486.5 32615.5 24895.6 25318.7 25369.6 25509.4 25783.7 08:47:45 INFO - PROCESS | 30713 | 08:47:45 INFO - PROCESS | 30713 | [#2] jquery.html Cycles:180 Average:24378.97 Median:4788.49 stddev:66259.89 (1383.7%) stddev-sans-first:66421.20 08:47:45 INFO - PROCESS | 30713 | Values: 348.6 351.6 354.2 365.1 366.6 16610.7 16845.9 17905.8 17984.1 17996.5 16860.9 17299.0 17470.5 17541.0 17558.0 4878.9 5127.1 5135.6 5136.3 5138.8 3819.9 3970.5 5089.8 5755.5 5986.0 6094.0 6101.5 6101.9 6103.6 6106.8 5816.3 6002.6 6018.3 6033.1 6036.9 4698.1 5280.2 5282.2 5287.1 5290.5 11688.0 12392.9 12403.6 12419.3 12443.1 1782.5 1805.1 1858.0 1953.3 2281.0 9016.5 9018.2 9115.7 9605.3 9656.6 1667.6 1724.1 1731.6 1744.6 1791.0 67918.0 68464.0 68485.0 69076.7 69696.7 10134.9 10138.7 10141.3 10360.4 10430.1 14014.0 14029.5 14030.6 14032.0 14035.6 7402.3 7628.4 7678.6 7743.5 7760.4 7434.6 7475.4 7629.3 7647.6 7653.3 4204.6 4313.3 4376.7 4454.5 4512.8 1513.9 1666.7 1727.6 1793.8 1878.1 817.8 818.4 881.6 882.5 895.6 16989.4 17060.8 17503.6 17862.3 18159.8 841.5 849.9 851.5 865.9 889.4 9501.4 10015.4 10042.4 10050.2 10134.9 396689.0 397446.0 401421.0 406084.0 406757.0 75690.6 75967.2 77105.6 77525.6 77594.0 791.9 858.5 889.7 905.4 909.6 14301.8 15165.5 16571.7 16681.2 16683.7 36977.8 37109.4 37482.0 38024.6 38778.4 48843.5 49170.5 49898.3 49938.3 50257.0 6349.2 6647.1 6689.7 6791.1 6975.7 8197.7 10317.6 11055.1 11519.5 11757.5 9625.4 10093.3 10179.4 10552.6 10718.4 9871.9 9882.5 10109.1 10142.7 10403.4 9896.3 9909.3 10361.9 10717.3 10833.8 6779.0 6787.0 6923.0 6937.3 7022.0 9004.8 9112.1 9242.7 9248.0 9396.2 08:47:45 INFO - PROCESS | 30713 | 08:47:45 INFO - PROCESS | 30713 | [#3] mootools.html Cycles:180 Average:5016.18 Median:5204.72 stddev:2777.31 (53.4%) stddev-sans-first:2771.27 08:47:45 INFO - PROCESS | 30713 | Values: 1328.0 1387.5 1409.5 1626.6 1643.4 7138.6 7705.4 7726.8 7735.0 7735.1 6408.2 7083.9 7311.6 7334.7 7567.1 2148.2 2166.7 2170.2 2170.2 2170.3 2071.6 2126.5 2128.2 2130.0 2132.7 1797.1 2072.2 2140.2 2145.6 2159.2 2149.8 2155.4 2178.7 2180.9 2184.1 2119.2 2129.9 2130.9 2134.5 2136.1 7366.4 7499.4 7511.2 7517.2 7523.4 4400.8 4519.4 4530.9 4531.2 4537.5 2764.8 2875.7 2915.2 2923.6 2933.0 802.3 843.3 854.9 861.9 867.5 10124.1 10196.0 10209.3 10252.3 10287.3 3969.9 4088.6 4216.3 4277.6 4279.8 8676.4 8718.9 8734.5 8738.3 8742.4 4608.3 4612.7 4613.4 4617.7 4626.6 4130.2 4169.5 4188.3 4194.3 4194.7 3501.8 3566.0 3636.5 3639.0 3639.2 1118.3 1135.7 1154.8 1156.9 1160.5 566.1 662.1 682.1 849.0 854.4 5204.1 5205.3 5443.3 5476.6 5607.6 857.5 863.5 866.7 900.8 906.9 3679.3 3687.4 3705.6 3782.0 3818.4 9148.6 9534.0 9551.9 9553.2 9564.8 9409.5 9503.7 9511.3 9517.9 9521.7 7069.9 7205.5 7209.2 7223.3 7223.3 4962.1 5013.1 5074.3 5111.7 5129.0 8457.5 8692.7 8779.2 8785.6 8800.6 8283.3 8622.1 8631.3 8912.3 8913.6 6593.5 6751.8 6760.1 6762.5 6763.1 7053.3 7056.6 7060.0 7063.7 7092.7 6569.2 6659.5 6702.9 6711.2 6760.5 6359.6 6440.8 6456.9 6476.1 6499.2 6056.2 6157.6 6157.9 6161.3 6165.4 4359.1 4476.1 4484.7 4520.4 4680.3 4415.3 4435.5 4522.8 4531.1 4535.6 08:47:45 INFO - PROCESS | 30713 | 08:47:45 INFO - PROCESS | 30713 | [#4] prototype.html Cycles:180 Average:4202.33 Median:4833.76 stddev:1231.21 (25.5%) stddev-sans-first:1199.12 08:47:45 INFO - PROCESS | 30713 | Values: 289.6 290.9 299.9 301.9 307.6 4831.2 4857.9 4864.4 4874.0 4894.2 4779.7 4788.7 4810.8 4836.3 4846.3 3589.0 3698.6 3709.5 3770.0 3807.8 3783.5 3788.1 3793.7 3795.8 3800.0 3757.6 3769.5 3783.9 3788.3 3796.2 3490.3 3587.6 3668.5 3768.7 3817.9 3339.4 3342.8 3357.6 3359.7 3385.0 4652.4 4700.4 4701.7 4703.4 4729.0 4136.3 4268.0 4354.5 4356.3 4366.9 4994.4 4995.8 4999.8 5011.2 5015.2 3613.8 3617.6 3640.3 3642.0 3648.2 5092.8 5285.3 5294.3 5303.7 5323.5 3674.9 3693.7 3701.3 3711.0 3725.0 3756.9 3768.2 3769.1 3772.0 3778.7 4175.2 4280.0 4299.8 4313.1 4320.2 5018.4 5042.2 5047.6 5049.5 5105.4 1265.1 1282.8 1289.4 1290.2 1292.9 759.4 805.6 806.2 809.8 812.0 3998.5 4291.8 4320.3 4418.6 4477.4 5186.9 5211.3 5221.7 5226.8 5236.8 4485.1 4495.9 4496.4 4508.6 4509.7 2652.8 2742.3 2751.2 2764.5 2772.1 4889.4 4889.9 4905.6 4915.5 4915.7 5302.7 5316.5 5317.3 5359.7 5364.2 4619.9 4898.8 4915.2 4918.6 4927.0 5221.8 5224.4 5224.6 5231.6 5302.9 4912.7 5181.0 5181.5 5203.8 5215.3 4909.9 4918.8 4926.5 4930.8 4939.5 3598.2 3608.5 3634.5 3653.7 3679.6 5103.2 5293.8 5318.8 5322.8 5322.9 5071.0 5084.3 5094.2 5100.3 5127.2 5075.9 5078.7 5079.5 5095.0 5142.2 4737.8 5035.4 5038.0 5068.6 5075.8 4873.0 4932.6 5033.8 5077.4 5111.5 4972.0 4979.9 4985.8 4988.9 4990.1 08:47:45 INFO - PROCESS | 30713 | 08:47:45 INFO - PROCESS | 30713 | [#5] yui.html Cycles:180 Average:17219.77 Median:3527.19 stddev:26339.05 (746.7%) stddev-sans-first:26383.30 08:47:45 INFO - PROCESS | 30713 | Values: 576.1 589.5 604.3 641.3 647.5 12261.4 12597.9 13262.6 13276.1 13339.7 12811.6 12854.9 12911.1 12921.5 12925.5 734.5 758.3 764.2 764.4 764.8 613.2 740.7 761.9 763.9 766.7 805.2 807.1 807.2 807.6 807.8 802.4 805.7 805.8 805.9 806.0 470.8 562.3 565.8 579.2 579.5 12238.4 12258.4 12261.4 12299.3 12407.2 11156.3 11263.9 11376.9 11384.0 11918.8 10602.8 10673.5 10783.1 10788.0 11263.2 3759.7 3847.0 3873.3 3914.7 3979.8 66488.7 67524.0 67620.0 70191.0 70195.0 9281.3 9476.9 9523.3 9733.1 9740.9 17807.5 17824.5 17962.9 17997.6 18075.0 6390.3 6413.1 6590.0 6596.7 6657.2 3397.8 3403.4 3470.7 3506.7 3514.6 2664.6 2737.0 2738.0 2740.4 2745.1 462.1 464.8 468.1 475.9 481.1 405.8 461.9 478.0 500.7 501.1 7129.6 7230.3 7311.4 7343.2 7552.2 508.0 518.5 529.7 534.5 578.4 3324.4 3334.2 3415.8 3462.2 3515.8 97554.0 104080.0 104875.0 106648.0 107641.0 52333.7 52334.0 85563.6 87911.6 88306.0 81920.6 81935.0 82254.0 83561.0 84223.0 6470.9 6568.5 6586.9 6592.8 6681.7 47238.8 47902.0 47931.8 48177.3 50335.2 38770.0 51775.5 63103.4 63789.4 64329.4 8321.8 8394.2 8626.6 8703.6 8731.3 9121.8 9204.8 9217.1 9254.2 9446.9 8464.4 8607.0 8662.1 8744.1 8768.1 8908.0 9028.0 9127.0 9271.5 9496.3 9006.0 9082.6 9091.8 9109.8 9292.8 6966.4 6998.6 7075.3 7119.0 7125.9 7203.8 7303.2 7333.4 7402.4 7438.7 08:47:45 INFO - PROCESS | 30713 | -------- Summary: end -------- 08:47:45 INFO - PROCESS | 30713 | 08:47:46 INFO - TEST-INFO | 30713: exit 0 08:47:46 INFO - TEST-OK | dromaeo_css | took 1119723ms 08:47:46 INFO - TEST-START | kraken 08:47:46 INFO - operating with platform_type : linux_ 08:47:46 INFO - Initialising browser for kraken test... 08:47:46 INFO - TEST-INFO | started process 30905 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDPG0SV/profile http://localhost:43362/getInfo.html) 08:47:50 INFO - PROCESS | 30905 | __metrics Screen width/height:1600/1200 08:47:50 INFO - PROCESS | 30905 | colorDepth:24 08:47:50 INFO - PROCESS | 30905 | Browser inner width/height: 1024/697 08:47:50 INFO - PROCESS | 30905 | __metrics 08:47:51 INFO - PROCESS | 30905 | 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" 08:47:51 INFO - PROCESS | 30905 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:47:52 INFO - TEST-INFO | 30905: exit 0 08:47:52 INFO - Browser initialized. 08:47:52 INFO - Running cycle 1/1 for kraken test... 08:47:52 INFO - TEST-INFO | started process 30982 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDPG0SV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:48:04 INFO - PROCESS | 30982 | RSS: Main: 158044160 08:48:04 INFO - PROCESS | 30982 | 08:48:07 INFO - PROCESS | 30982 | Cycle 1(1): loaded http://localhost:43362/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43362/tests/kraken/driver.html?testName=audio-beat-detection) 08:48:07 INFO - PROCESS | 30982 | RSS: Main: 213938176 08:48:07 INFO - PROCESS | 30982 | 08:48:10 INFO - PROCESS | 30982 | Cycle 1(1): loaded http://localhost:43362/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43362/tests/kraken/driver.html?testName=audio-dft) 08:48:11 INFO - PROCESS | 30982 | RSS: Main: 192487424 08:48:11 INFO - PROCESS | 30982 | 08:48:14 INFO - PROCESS | 30982 | Cycle 1(1): loaded http://localhost:43362/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43362/tests/kraken/driver.html?testName=audio-fft) 08:48:15 INFO - PROCESS | 30982 | RSS: Main: 271986688 08:48:15 INFO - PROCESS | 30982 | 08:48:17 INFO - PROCESS | 30982 | Cycle 1(1): loaded http://localhost:43362/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43362/tests/kraken/driver.html?testName=audio-oscillator) 08:48:17 INFO - PROCESS | 30982 | RSS: Main: 180809728 08:48:17 INFO - PROCESS | 30982 | 08:48:20 INFO - PROCESS | 30982 | Cycle 1(1): loaded http://localhost:43362/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43362/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:48:20 INFO - PROCESS | 30982 | RSS: Main: 185495552 08:48:20 INFO - PROCESS | 30982 | 08:48:23 INFO - PROCESS | 30982 | Cycle 1(1): loaded http://localhost:43362/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43362/tests/kraken/driver.html?testName=imaging-darkroom) 08:48:24 INFO - PROCESS | 30982 | RSS: Main: 221937664 08:48:24 INFO - PROCESS | 30982 | 08:48:28 INFO - PROCESS | 30982 | Cycle 1(1): loaded http://localhost:43362/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43362/tests/kraken/driver.html?testName=imaging-desaturate) 08:48:28 INFO - PROCESS | 30982 | RSS: Main: 215281664 08:48:28 INFO - PROCESS | 30982 | 08:48:31 INFO - PROCESS | 30982 | Cycle 1(1): loaded http://localhost:43362/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43362/tests/kraken/driver.html?testName=json-parse-financial) 08:48:32 INFO - PROCESS | 30982 | RSS: Main: 218886144 08:48:32 INFO - PROCESS | 30982 | 08:48:33 INFO - PROCESS | 30982 | Cycle 1(1): loaded http://localhost:43362/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43362/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:48:34 INFO - PROCESS | 30982 | RSS: Main: 184569856 08:48:34 INFO - PROCESS | 30982 | 08:48:36 INFO - PROCESS | 30982 | Cycle 1(1): loaded http://localhost:43362/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43362/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:48:37 INFO - PROCESS | 30982 | RSS: Main: 190238720 08:48:37 INFO - PROCESS | 30982 | 08:48:39 INFO - PROCESS | 30982 | Cycle 1(1): loaded http://localhost:43362/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43362/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:48:39 INFO - PROCESS | 30982 | RSS: Main: 194740224 08:48:39 INFO - PROCESS | 30982 | 08:48:42 INFO - PROCESS | 30982 | Cycle 1(1): loaded http://localhost:43362/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43362/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:48:43 INFO - PROCESS | 30982 | RSS: Main: 188346368 08:48:43 INFO - PROCESS | 30982 | 08:48:46 INFO - PROCESS | 30982 | Cycle 1(1): loaded http://localhost:43362/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43362/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:48:46 INFO - PROCESS | 30982 | RSS: Main: 192675840 08:48:46 INFO - PROCESS | 30982 | 08:48:48 INFO - PROCESS | 30982 | Cycle 1(1): loaded http://localhost:43362/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43362/tests/kraken/driver.html?testName=ai-astar) 08:48:48 INFO - PROCESS | 30982 | RSS: Main: 242880512 08:48:48 INFO - PROCESS | 30982 | 08:48:48 INFO - PROCESS | 30982 | __start_tp_report 08:48:48 INFO - PROCESS | 30982 | _x_x_mozilla_page_load 08:48:48 INFO - PROCESS | 30982 | _x_x_mozilla_page_load_details 08:48:48 INFO - PROCESS | 30982 | |i|pagename|runs| 08:48:48 INFO - PROCESS | 30982 | |0;ai-astar;105;114;113;113;115;114;114;115;114;114 08:48:48 INFO - PROCESS | 30982 | |1;audio-beat-detection;153;123;125;202;124;134;149;128;179;122 08:48:48 INFO - PROCESS | 30982 | |2;audio-dft;161;161;162;160;161;161;162;161;162;160 08:48:48 INFO - PROCESS | 30982 | |3;audio-fft;76;77;76;128;77;77;75;74;98;76 08:48:48 INFO - PROCESS | 30982 | |4;audio-oscillator;86;86;112;86;85;86;114;86;86;125 08:48:48 INFO - PROCESS | 30982 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;117;118 08:48:48 INFO - PROCESS | 30982 | |6;imaging-darkroom;146;147;146;145;146;147;146;145;145;146 08:48:48 INFO - PROCESS | 30982 | |7;imaging-desaturate;95;95;95;96;95;95;95;95;95;95 08:48:48 INFO - PROCESS | 30982 | |8;json-parse-financial;63;62;63;63;62;64;63;64;61;63 08:48:48 INFO - PROCESS | 30982 | |9;json-stringify-tinderbox;64;66;65;65;65;65;66;66;66;67 08:48:48 INFO - PROCESS | 30982 | |10;stanford-crypto-aes;89;83;80;86;80;85;80;80;80;82 08:48:48 INFO - PROCESS | 30982 | |11;stanford-crypto-ccm;132;133;131;130;128;131;130;133;213;134 08:48:48 INFO - PROCESS | 30982 | |12;stanford-crypto-pbkdf2;166;169;166;164;165;163;165;164;166;162 08:48:48 INFO - PROCESS | 30982 | |13;stanford-crypto-sha256-iterative;75;67;67;67;67;66;66;66;66;70 08:48:48 INFO - PROCESS | 30982 | __end_tp_report 08:48:48 INFO - PROCESS | 30982 | __start_cc_report 08:48:48 INFO - PROCESS | 30982 | _x_x_mozilla_cycle_collect,1913 08:48:48 INFO - PROCESS | 30982 | __end_cc_report 08:48:48 INFO - PROCESS | 30982 | __startTimestamp1470066528761__endTimestamp 08:48:48 INFO - PROCESS | 30982 | 08:48:48 INFO - PROCESS | 30982 | ------- Summary: start ------- 08:48:48 INFO - PROCESS | 30982 | Number of tests: 14 08:48:48 INFO - PROCESS | 30982 | 08:48:48 INFO - PROCESS | 30982 | [#0] ai-astar Cycles:10 Average:113.10 Median:114.00 stddev:2.92 (2.6%) stddev-sans-first:0.71 08:48:48 INFO - PROCESS | 30982 | Values: 105.0 114.0 113.0 113.0 115.0 114.0 114.0 115.0 114.0 114.0 08:48:48 INFO - PROCESS | 30982 | 08:48:48 INFO - PROCESS | 30982 | [#1] audio-beat-detection Cycles:10 Average:143.90 Median:141.50 stddev:27.36 (19.3%) stddev-sans-first:28.82 08:48:48 INFO - PROCESS | 30982 | Values: 153.0 123.0 125.0 202.0 124.0 134.0 149.0 128.0 179.0 122.0 08:48:48 INFO - PROCESS | 30982 | 08:48:48 INFO - PROCESS | 30982 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 08:48:48 INFO - PROCESS | 30982 | Values: 161.0 161.0 162.0 160.0 161.0 161.0 162.0 161.0 162.0 160.0 08:48:48 INFO - PROCESS | 30982 | 08:48:48 INFO - PROCESS | 30982 | [#3] audio-fft Cycles:10 Average:83.40 Median:76.50 stddev:17.15 (22.4%) stddev-sans-first:17.98 08:48:48 INFO - PROCESS | 30982 | Values: 76.0 77.0 76.0 128.0 77.0 77.0 75.0 74.0 98.0 76.0 08:48:48 INFO - PROCESS | 30982 | 08:48:48 INFO - PROCESS | 30982 | [#4] audio-oscillator Cycles:10 Average:95.20 Median:86.00 stddev:15.40 (17.9%) stddev-sans-first:15.97 08:48:48 INFO - PROCESS | 30982 | Values: 86.0 86.0 112.0 86.0 85.0 86.0 114.0 86.0 86.0 125.0 08:48:48 INFO - PROCESS | 30982 | 08:48:48 INFO - PROCESS | 30982 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 08:48:48 INFO - PROCESS | 30982 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 08:48:48 INFO - PROCESS | 30982 | 08:48:48 INFO - PROCESS | 30982 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 08:48:48 INFO - PROCESS | 30982 | Values: 146.0 147.0 146.0 145.0 146.0 147.0 146.0 145.0 145.0 146.0 08:48:48 INFO - PROCESS | 30982 | 08:48:48 INFO - PROCESS | 30982 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:48:48 INFO - PROCESS | 30982 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 08:48:48 INFO - PROCESS | 30982 | 08:48:48 INFO - PROCESS | 30982 | [#8] json-parse-financial Cycles:10 Average:62.80 Median:63.00 stddev:0.92 (1.5%) stddev-sans-first:0.97 08:48:48 INFO - PROCESS | 30982 | Values: 63.0 62.0 63.0 63.0 62.0 64.0 63.0 64.0 61.0 63.0 08:48:48 INFO - PROCESS | 30982 | 08:48:48 INFO - PROCESS | 30982 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:66.00 stddev:0.85 (1.3%) stddev-sans-first:0.71 08:48:48 INFO - PROCESS | 30982 | Values: 64.0 66.0 65.0 65.0 65.0 65.0 66.0 66.0 66.0 67.0 08:48:48 INFO - PROCESS | 30982 | 08:48:48 INFO - PROCESS | 30982 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:82.50 stddev:3.21 (3.9%) stddev-sans-first:2.39 08:48:48 INFO - PROCESS | 30982 | Values: 89.0 83.0 80.0 86.0 80.0 85.0 80.0 80.0 80.0 82.0 08:48:48 INFO - PROCESS | 30982 | 08:48:48 INFO - PROCESS | 30982 | [#11] stanford-crypto-ccm Cycles:10 Average:139.50 Median:132.50 stddev:25.89 (19.5%) stddev-sans-first:27.31 08:48:48 INFO - PROCESS | 30982 | Values: 132.0 133.0 131.0 130.0 128.0 131.0 130.0 133.0 213.0 134.0 08:48:48 INFO - PROCESS | 30982 | 08:48:48 INFO - PROCESS | 30982 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.00 Median:165.50 stddev:1.94 (1.2%) stddev-sans-first:2.03 08:48:48 INFO - PROCESS | 30982 | Values: 166.0 169.0 166.0 164.0 165.0 163.0 165.0 164.0 166.0 162.0 08:48:48 INFO - PROCESS | 30982 | 08:48:48 INFO - PROCESS | 30982 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:67.00 stddev:2.83 (4.2%) stddev-sans-first:1.27 08:48:48 INFO - PROCESS | 30982 | Values: 75.0 67.0 67.0 67.0 67.0 66.0 66.0 66.0 66.0 70.0 08:48:48 INFO - PROCESS | 30982 | -------- Summary: end -------- 08:48:48 INFO - PROCESS | 30982 | 08:48:49 INFO - TEST-INFO | 30982: exit 0 08:48:49 INFO - TEST-OK | kraken | took 63767ms 08:48:49 INFO - SUITE-END | took 1183s 08:48:50 INFO - Completed test suite (00:19:43) 08:48:50 INFO - javascript benchmark 08:48:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2649.8807553660085, 2650.3771613670788, 2683.114572191177, 2686.650735404397, 2695.393536454298, 4469.396631454752, 4720.716756994582, 4745.762711864406, 4788.976055119724, 4801.567858892703, 4714.057188562293, 4738.218193997995, 4757.524247575249, 4773.474917759052, 4785.952140478594, 4287.957120428795, 4308.892277693051, 4352.6953113281925, 4408.096340250241, 4540.704854184468, 4467.486239082498, 4497.392851964975, 4520.141173177102, 4548.772561371935, 4549.499555048942, 4303.548127446605, 4348.34774783785, 4405.383246345515, 4415.20526305265, 4489.685721999445, 4316.48202215733, 4331.198728235287, 4361.890952726176, 4378.978105109486, 4385.583369579885, 4342.305231162999, 4408.801603927799, 4422.137683151786, 4426.336049592587, 4473.709208901411, 4632.166210082218, 4805.231163013901, 4850.660453768238, 4854.466008739036, 4865.051314993542, 4986.62600304975, 5024.899502009976, 5036.244563315532, 5047.823326183603, 5110.6422550421485, 5063.898722025576, 5065.645404821664, 5087.847364579068, 5116.718580478072, 5126.461721519224, 4692.81228750853, 4751.786169622375, 4772.9761351193365, 4779.02030083832, 4786.664933454625, 5234.031704134747, 5261.316028916216, 5278.4721527846905, 5299.44355842631, 5303.655262407931, 5042.268871013755, 5091.974540127349, 5097.286379906816, 5099.311592934981, 5101.20931255656, 4867.099586576494, 5018.648694591344, 5183.429822719498, 5184.326037615086, 5196.636235463557, 4997.525235102659, 5022.096022715873, 5022.59819214462, 5066.392032956069, 5066.898662026739, 5008.0, 5018.347614810052, 5019.824306149268, 5024.2463630454995, 5064.721440320818, 4287.2711639021445, 4314.439122914064, 4379.802908869108, 4385.912281754347, 4437.733735975852, 3726.5900750917376, 3758.8684396046006, 3773.339665558516, 3783.4135708965155, 3840.2703486337505, 4325.15659446405, 4326.783660817009, 4327.783610819446, 4364.978175109104, 4369.956300437018, 4994.101061808909, 5026.824061157842, 5027.572656324181, 5029.0, 5055.721935293521, 4357.716748411343, 4388.71473354231, 4391.714538554984, 4409.889752756207, 4456.309272062836, 4647.767611619405, 4673.976630116896, 4675.6727029108315, 4675.859724208279, 4727.220008698526, 4688.484266730725, 4838.830640927551, 4843.709377437365, 4849.248366503198, 4900.166971614834, 5032.62255330859, 5045.621578381562, 5088.160453525127, 5104.795808167632, 5174.741262936914, 4812.807487700593, 4825.059113472979, 4825.469198388104, 4826.493218212037, 4844.128056949783, 4941.0, 5047.091523525801, 5049.974750126225, 5052.873678158076, 5104.923426148536, 5055.949440505695, 5107.41264754558, 5122.590192784493, 5132.717700526507, 5167.61242906791, 4983.152864013054, 4988.176950803077, 4992.850214493571, 4992.975035124801, 5042.571381432473, 4799.1601469743355, 4988.176950803222, 4999.10016197088, 5000.849974500771, 5007.529744985976, 4837.4920633332995, 4841.564259216688, 4870.439899411613, 4912.214045752662, 4944.53026962438, 4995.350604421402, 4998.525140111684, 5001.8749531260555, 5004.649674522749, 5017.046761115376, 4752.5485078917445, 4892.266160075875, 4895.755212239303, 4898.779554919965, 4933.629977751755], "value": 4684.233697259316, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.2619405481792, 577.9335376431711, 578.3897987623056, 581.3837332427624, 589.3046205477535, 28933.27666808331, 38227.42658860119, 39794.0, 39894.2021159577, 42718.57281427185, 40645.59354406462, 40952.38571421431, 41044.179116417654, 41045.179096418055, 41075.38386924191, 7736.419768517356, 7875.4487185897015, 7881.014873140857, 7883.093444253898, 7889.132195458495, 7798.4930979486435, 7877.291043806056, 7878.369730421581, 7888.9605551972445, 7889.171636978121, 7845.0, 7911.446198766089, 7914.24814642608, 7920.405969552277, 7921.405894557903, 7799.532028078305, 7813.648385822595, 7822.256885595916, 7879.8030049248655, 7881.842363152762, 7579.279968402993, 7652.885206721904, 7670.616469176519, 7675.385969122457, 7675.846483070363, 38548.0, 38923.80538097292, 39055.0, 39102.60897391018, 39108.41337379941, 2913.1988703106604, 3007.7142671446177, 3077.9538306925415, 3110.9066727998197, 3251.122197006795, 28015.719842801514, 28326.575101373495, 28675.426491470054, 28741.425171496663, 28806.0, 2944.6319210098736, 3023.5011223148153, 3155.100796273074, 3233.369492948876, 3291.522729204252, 263451.0, 263849.0, 264677.0, 264921.0, 265103.9999999981, 53828.46171538313, 54377.0, 54421.183682244795, 54439.0, 54540.727296363264, 32353.35293294121, 33110.66889331124, 33292.167695807315, 34853.0, 57852.421475785544, 15166.0, 15280.617984550476, 15302.693946121015, 15319.61700957485, 15354.77355783405, 11379.715507112223, 11410.201285910072, 11429.371384573928, 11437.885621143849, 11452.0, 17800.3769868054, 17811.821881781016, 18015.549611259823, 18045.7293140603, 18073.096345182686, 6690.498212634072, 6795.422389096982, 6820.727170913207, 6829.760958366533, 6995.930040699528, 796.4783067091065, 859.879616853641, 876.6318146378536, 878.7583414560919, 954.4559601027487, 28378.71621283802, 28602.856985714938, 28851.42297154045, 28883.855580721964, 29104.0, 905.3888625177979, 968.1963969904962, 980.568549838069, 1002.0180223381127, 1017.9185665146919, 14279.78580321296, 14627.195504247156, 14703.191324477042, 15079.849201508065, 15171.634552890073, 421427.0, 421951.0, 422999.0, 423516.0, 423790.0, 49246.261306080436, 49717.25424118641, 49939.0, 50005.24992125121, 50019.74990125026, 1003.859459675646, 1161.8373427720126, 1198.3528894397102, 1204.4399354300292, 1222.0773316146253, 27422.314442139104, 28416.715832841408, 28857.855710721313, 29127.0, 29415.558766618946, 41823.58176418197, 42183.36724949067, 42219.3667095, 42233.1553368937, 42306.0, 291151.0, 291300.0, 292045.0, 293074.0, 294126.0, 23286.76713232846, 23812.16657416982, 24834.130805421722, 24881.253562393158, 25056.749432505443, 40746.0, 41007.0, 41030.38454423127, 41443.37834932418, 41875.162496750505, 34793.304133917685, 34969.82515087408, 35357.292854143285, 35487.46768798522, 35600.28799424049, 35101.297974040885, 35169.82415087908, 35417.0, 35469.46795798014, 35610.28779424449, 35381.29237415186, 35470.64529354673, 35874.0, 36101.81949090238, 36695.26609467849, 30397.392052159274, 32276.35447291088, 32367.35265294728, 32486.512702309956, 32615.510767338033, 24895.62656560189, 25318.746812532376, 25369.61945570781, 25509.3622659435, 25783.742162578885], "value": 17307.246248563646, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.61129840228153, 351.57810627247306, 354.21541286051394, 365.0818192246499, 366.6315353070164, 16610.66778664426, 16845.915770421147, 17905.82094179058, 17984.100794960264, 17996.460106196835, 16860.915695421536, 17299.0, 17470.475885723416, 17541.0, 17558.0, 4878.902421951559, 5127.077126117298, 5135.563477104451, 5136.332276804011, 5138.820141295056, 3819.8854034379015, 3970.523537175543, 5089.847304580869, 5755.510781583571, 5986.042233242682, 6094.02495600704, 6101.481374083208, 6101.9389806102035, 6103.633781973073, 6106.847328816771, 5816.302043754756, 6002.639841609517, 6018.277806663206, 6033.125196846433, 6036.9396306036815, 4698.08387364464, 5280.234366016906, 5282.2340760589495, 5287.127623942045, 5290.497402746733, 11688.0, 12392.876071239263, 12403.565875194416, 12419.254844709347, 12443.128980971336, 1782.4830799068254, 1805.0884303426817, 1857.9535511612319, 1953.2772874036698, 2281.0, 9016.504092274923, 9018.188363047291, 9115.680951166678, 9605.327627066108, 9656.613735450574, 1667.633120713441, 1724.1034661975702, 1731.6450127723785, 1744.6249056452796, 1791.0003718854593, 67918.0, 68464.0, 68485.0, 69076.6546167271, 69696.6515167426, 10134.949325253327, 10138.695839124837, 10141.340812847142, 10360.378377297386, 10430.113440357654, 14014.0, 14029.508967186099, 14030.649233769238, 14032.0, 14035.649108772363, 7402.259774022555, 7628.351590114791, 7678.577678227751, 7743.4966727162555, 7760.379169666526, 7434.628268586549, 7475.401967842559, 7629.3133617974645, 7647.617619119022, 7653.311201991847, 4204.642605378577, 4313.331433627793, 4376.6717496187275, 4454.532274111237, 4512.796924138422, 1513.9243037848064, 1666.7166581680901, 1727.6285598596362, 1793.7757780277466, 1878.117284876106, 817.7669364231166, 818.3616778912458, 881.5504092912532, 882.501386716516, 895.6059333893066, 16989.40537081196, 17060.82939170617, 17503.64992700139, 17862.28550857977, 18159.818401816075, 841.4951029382444, 849.9192576705203, 851.5316575883239, 865.8831057807241, 889.3996552327153, 9501.42991420517, 10015.449150296658, 10042.447665378475, 10050.196039257828, 10134.949325253327, 396689.0, 397446.0, 401421.0, 406084.0, 406757.0, 75690.62154689191, 75967.24963907672, 77105.61447192729, 77525.61237193778, 77594.0, 791.8891355210275, 858.4737702119381, 889.7375274293969, 905.4114825363434, 909.5634095634133, 14301.785473218119, 15165.545033649008, 16571.66856662884, 16681.249343779316, 16683.666326673156, 36977.815110924275, 37109.443358349105, 37482.0, 38024.61975380211, 38778.41832372573, 48843.5115648839, 49170.508294916595, 49898.251526226406, 49938.25092623686, 50257.0, 6349.206349206349, 6647.135872336566, 6689.732410703712, 6791.117154769849, 6975.686094125878, 8197.672093116209, 10317.638882639072, 11055.115590752881, 11519.481623327138, 11757.47091380907, 9625.374350667184, 10093.293469457067, 10179.440130792582, 10552.577896884039, 10718.410487423267, 9871.901280987098, 9882.4564648945, 10109.090181883372, 10142.695719128438, 10403.427811470441, 9896.257780666623, 9909.256805739742, 10361.896381036093, 10717.303375280582, 10833.783324333626, 6778.966105169443, 6786.966065169642, 6923.0, 6937.306269373023, 7022.0, 9004.774880628036, 9112.088791120836, 9242.72271831846, 9248.0, 9396.248300136109], "value": 8053.874888956561, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1328.0, 1387.535175716135, 1409.4644035266597, 1626.5933516620844, 1643.3837311008378, 7138.571685698856, 7705.422093343008, 7726.768196954086, 7734.961325193366, 7735.110462296838, 6408.231012278533, 7083.929160708404, 7311.597862117582, 7334.669939852706, 7567.091948966118, 2148.21590119606, 2166.6749987501844, 2170.1861801824316, 2170.2295685031745, 2170.2621108822996, 2071.564971356017, 2126.5427932994403, 2128.19128731082, 2130.041481333398, 2132.6694362373855, 1797.128392729525, 2072.2229164063474, 2140.240214723774, 2145.603063433262, 2159.168720042787, 2149.838762092834, 2155.385715071205, 2178.7276590426195, 2180.9345719628436, 2184.137265780008, 2119.205298013245, 2129.9254526091513, 2130.936071917845, 2134.541073669169, 2136.0708091980036, 7366.410687145016, 7499.362554182901, 7511.211322811136, 7517.17311095779, 7523.435742319348, 4400.823967041314, 4519.41247637805, 4530.8867278317975, 4531.229690952546, 4537.478190008158, 2764.7788176945796, 2875.683674795771, 2915.1691767846273, 2923.6053132827224, 2932.9706702932913, 802.2539038694013, 843.3169133002287, 854.8717692346198, 861.9224269815684, 867.4925168776274, 10124.139448146916, 10196.0, 10209.336393134423, 10252.282340236186, 10287.251167301576, 3969.8809035728973, 4088.550259471456, 4216.2832318505925, 4277.615014648634, 4279.786010699452, 8676.436031657922, 8718.86921696175, 8734.475931444007, 8738.30093592511, 8742.431741936754, 4608.262677971508, 4612.677112602153, 4613.354130421743, 4617.699849509771, 4626.560476754703, 4130.235906357333, 4169.45797046382, 4188.267053265667, 4194.3498757692605, 4194.706370554093, 3501.7548771586253, 3565.964340356615, 3636.4908912752235, 3638.9636103638622, 3639.181184233579, 1118.3178261260625, 1135.73310272086, 1154.8498695169574, 1156.9363684997238, 1160.5473865192582, 566.0967628203514, 662.102850637389, 682.1405029662561, 849.0490650471511, 854.3506934729526, 5204.089284375219, 5205.349331333583, 5443.319585051869, 5476.616636835463, 5607.607467477319, 857.4855086947906, 863.5336918064176, 866.6836604639387, 900.7928176519438, 906.9365144439826, 3679.3193259247123, 3687.446882967576, 3705.6479634434686, 3781.962180378216, 3818.3890577507464, 9148.588313525906, 9534.0, 9551.856722149174, 9553.235741140692, 9564.760880977892, 9409.482478463613, 9503.667371642097, 9511.334206605472, 9517.90482095184, 9521.666741664008, 7069.8939515907305, 7205.531640443459, 7209.243029481829, 7223.313785190398, 7223.313785190398, 4962.131626965194, 5013.122703526941, 5074.289599456153, 5111.744412779271, 5128.974355128201, 8457.492550446992, 8692.695755648521, 8779.165979231962, 8785.604647790737, 8800.559972001247, 8283.25450709439, 8622.094680058504, 8631.309495240492, 8912.28701703875, 8913.55432228373, 6593.472522198117, 6751.797446076625, 6760.121184246016, 6762.49281303914, 6763.086983257197, 7053.294670532906, 7056.576605403692, 7059.964700176466, 7063.717451302096, 7092.716291348288, 6569.211694596679, 6659.500537459613, 6702.932970670231, 6711.161104861892, 6760.526763126534, 6359.618422894641, 6440.806775796734, 6456.903146452901, 6476.093346931528, 6499.1876015498065, 6056.152138700673, 6157.630542167484, 6157.907631385622, 6161.260648722182, 6165.4451099399475, 4359.149965756647, 4476.08240310742, 4484.686071975061, 4520.389747384061, 4680.297955306732, 4415.2935530315, 4435.489918659267, 4522.773861306987, 4531.0711304181905, 4535.569120933506], "value": 4041.3058034792375, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.5945676053525, 290.9389028304056, 299.85007496251876, 301.8536010035134, 307.5893681934617, 4831.202851529498, 4857.87855303618, 4864.440589332228, 4874.025194961008, 4894.167991441454, 4779.665423420362, 4788.688735232207, 4810.807567697288, 4836.322914791923, 4846.297286893398, 3589.0, 3698.574663913644, 3709.4806727058235, 3770.0, 3807.828647710846, 3783.4703141560203, 3788.071922379021, 3793.742723079777, 3795.8102094895285, 3799.9740070181033, 3757.643023912724, 3769.453429252757, 3783.8675646352385, 3788.299164654548, 3796.1838204785968, 3490.2844916791996, 3587.6232995535356, 3668.5047518584915, 3768.698504119664, 3817.9045523861987, 3339.4322965095994, 3342.782719123249, 3357.5635167428077, 3359.72330514403, 3384.9830750846336, 4652.441706995149, 4700.412448443944, 4701.7414042227665, 4703.435587729495, 4728.952710472886, 4136.31750761127, 4267.957320426787, 4354.455693038371, 4356.324769660708, 4366.912661746779, 4994.375703037121, 4995.750212489397, 4999.75001249936, 5011.223260394645, 5015.22264049073, 3613.7651052681754, 3617.6201498842506, 3640.2719456108885, 3642.0, 3648.233870887117, 5092.8472145835685, 5285.286486324374, 5294.285271488338, 5303.681779093266, 5323.494268044529, 3674.926501469956, 3693.6675699187203, 3701.315901264918, 3710.9775172531035, 3724.962750372516, 3756.924861502809, 3768.1521657627363, 3769.133099387156, 3772.0, 3778.7165962552367, 4175.185838761473, 4279.957200428018, 4299.763513006752, 4313.102235016583, 4320.243957307459, 5018.372703412074, 5042.193249080203, 5047.596192304607, 5049.469805670426, 5105.438401775802, 1265.1080987903506, 1282.8460584729892, 1289.4455384184891, 1290.161395093197, 1292.9482820687256, 759.3583422008394, 805.6173317674057, 806.1897792718281, 809.817790997021, 811.9959400202961, 3998.520177578709, 4291.806868690854, 4320.330348795942, 4418.64650827933, 4477.3731677565165, 5186.896262074737, 5211.322528071327, 5221.686698798084, 5226.843194704165, 5236.790528378899, 4485.147821913891, 4495.910081798345, 4496.414561627077, 4508.616767574793, 4509.6843220974215, 2652.82756620819, 2742.3281296082187, 2751.1608959267214, 2764.502389569897, 2772.126780064273, 4889.413270407574, 4889.853304400874, 4905.601903457497, 4915.5330243626795, 4915.721912302827, 5302.666826596285, 5316.468353164652, 5317.325042611565, 5359.705216213068, 5364.222187782828, 4619.9076018479445, 4898.779554920037, 4915.16442204826, 4918.631102667314, 4927.029188324699, 5221.78860001089, 5224.373075230997, 5224.555912747459, 5231.633785635121, 5302.912902854982, 4912.656114072123, 5181.041507321158, 5181.5077567631015, 5203.791848326176, 5215.269862219368, 4909.9018019640125, 4918.803247870188, 4926.531979461945, 4930.778114984762, 4939.48135445773, 3598.1724203433882, 3608.4948107264477, 3634.5093412390047, 3653.689436397936, 3679.632036796299, 5103.209002604603, 5293.841184764463, 5318.813841515528, 5322.760475778677, 5322.866928326823, 5071.008105217939, 5084.313617661568, 5094.2103973884105, 5100.336956195671, 5127.1540195867265, 5075.87310317245, 5078.720670363018, 5079.492050794891, 5094.993953567413, 5142.202958541432, 4737.8341758038305, 5035.420926593489, 5038.0, 5068.594512438923, 5075.771590278372, 4872.975635121802, 4932.556069953722, 5033.798648054037, 5077.375239923189, 5111.488851114858, 4972.0, 4979.925301120414, 4985.750712464434, 4988.9251661225835, 4990.101781679187], "value": 3805.955510357236, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.0552693582525, 589.4900910712236, 604.2778879239308, 641.304184959319, 647.4561368450503, 12261.448234829431, 12597.937010314936, 13262.602121936334, 13276.07067505275, 13339.666508337297, 12811.551595694153, 12854.93572532136, 12911.096223264376, 12921.547745828899, 12925.547605833797, 734.5225603357807, 758.3402439877287, 764.2433990349542, 764.3770327183328, 764.8087978005499, 613.1844646620007, 740.7296336837043, 761.8552475029754, 763.919788422216, 766.7278116268728, 805.2470939671426, 807.116207752513, 807.2371608829658, 807.6042739057849, 807.7536351412816, 802.4262652203703, 805.7341077444429, 805.8227190018216, 805.8710606302964, 805.9717909873185, 470.8046160843246, 562.2634349002819, 565.8161097643282, 579.238301633355, 579.5305802300109, 12238.388080595934, 12258.387080645933, 12261.448234829453, 12299.32353720545, 12407.193532420364, 11156.330620162817, 11263.887361126366, 11376.886231137749, 11384.0, 11918.761624767543, 10602.787944241072, 10673.466326683634, 10783.13734901206, 10788.0, 11263.155263355282, 3759.7180211484247, 3847.03824043989, 3873.2640798248244, 3914.6868250539887, 3979.781112038837, 66488.66755666239, 67524.0, 67620.0, 70191.0, 70195.0, 9281.340638092115, 9476.857847132298, 9523.333366664267, 9733.124018838196, 9740.853887191697, 17807.46577602674, 17824.46526604204, 17962.91018544899, 17997.640047198984, 18075.0, 6390.297067322591, 6413.076077176828, 6590.0, 6596.703148358335, 6657.20113586363, 3397.796132232074, 3403.3873902697255, 3470.704990075821, 3506.6668666476644, 3514.578250609943, 2664.5603475426337, 2736.9589456158174, 2738.0416854101304, 2740.4245108527034, 2745.135282386082, 462.09660114476117, 464.84195373573147, 468.07087930458016, 475.9428868535798, 481.1291562272298, 405.77885052646377, 461.93301971213987, 477.9604360515864, 500.7195970256668, 501.1255359397874, 7129.643517824088, 7230.313120253672, 7311.378532824663, 7343.192248852622, 7552.169261381244, 507.99492005080214, 518.5048278893647, 529.6689569019363, 534.4601952028402, 578.4475825586554, 3324.384988777084, 3334.249793796425, 3415.777974431654, 3462.1517728156764, 3515.771474854126, 97554.0, 104080.0, 104875.0, 106648.0, 107641.0, 52333.7383313081, 52333.95332093337, 85563.57218213993, 87911.56044219738, 88306.0, 81920.59039704764, 81935.0, 82253.9999999988, 83561.0, 84223.0, 6470.935290647033, 6568.47452203813, 6586.934130658632, 6592.80221593353, 6681.732730690718, 47238.76380618075, 47902.0, 47931.76034119807, 48177.277340840614, 50335.244971324726, 38770.0, 51775.48224517857, 63103.36896631159, 63789.36210637834, 64329.42682292843, 8321.833563328579, 8394.164208602853, 8626.568671566522, 8703.608337624695, 8731.301495880442, 9121.77195570116, 9204.815903682023, 9217.124373184537, 9254.213391861498, 9446.85829712541, 8464.44981076228, 8607.0, 8662.090480499457, 8744.081871403665, 8768.079351667982, 8907.955460222658, 9028.0, 9127.041660625804, 9271.490068046322, 9496.335256531976, 9006.0, 9082.591283392396, 9091.772705682411, 9109.817803643757, 9292.814143717223, 6966.407855332353, 6998.580085194904, 7075.327843854826, 7118.9644051779405, 7125.893111603226, 7203.783886483414, 7303.196648368781, 7333.413326933939, 7402.4078073755045, 7438.665260063419], "value": 5968.851744555736, "unit": "score"}], "name": "dromaeo_css", "value": 6256.040113574014, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 113.0, 113.0, 115.0, 114.0, 114.0, 115.0, 114.0, 114.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 123.0, 125.0, 202.0, 124.0, 134.0, 149.0, 128.0, 179.0, 122.0], "value": 143.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 160.0, 161.0, 161.0, 162.0, 161.0, 162.0, 160.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 128.0, 77.0, 77.0, 75.0, 74.0, 98.0, 76.0], "value": 83.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 112.0, 86.0, 85.0, 86.0, 114.0, 86.0, 86.0, 125.0], "value": 95.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 145.0, 146.0, 147.0, 146.0, 145.0, 145.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 63.0, 62.0, 64.0, 63.0, 64.0, 61.0, 63.0], "value": 62.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 65.0, 65.0, 65.0, 66.0, 66.0, 66.0, 67.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 83.0, 80.0, 86.0, 80.0, 85.0, 80.0, 80.0, 80.0, 82.0], "value": 82.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 133.0, 131.0, 130.0, 128.0, 131.0, 130.0, 133.0, 213.0, 134.0], "value": 139.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 169.0, 166.0, 164.0, 165.0, 163.0, 165.0, 164.0, 166.0, 162.0], "value": 165.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 67.0, 67.0, 67.0, 67.0, 66.0, 66.0, 66.0, 66.0, 70.0], "value": 67.7, "unit": "score"}], "name": "kraken", "value": 1537.7, "alertThreshold": 2.0}]} 08:48:50 INFO - Return code: 0 08:48:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:48:50 INFO - # TBPL SUCCESS # 08:48:50 INFO - Running post-action listener: _resource_record_post_action 08:48:50 INFO - [mozharness: 2016-08-01 15:48:50.574057Z] Finished run-tests step (success) 08:48:50 INFO - Running post-run listener: _resource_record_post_run 08:48:50 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 8192; Write bytes: 522190848; Read time: 44; Write time: 415208 08:48:50 INFO - TinderboxPrint: CPU usage
13.0% 08:48:50 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 44 08:48:50 INFO - TinderboxPrint: I/O write bytes / time
522,190,848 / 415,208 08:48:50 INFO - TinderboxPrint: CPU idle
8,334.5 (87.0%) 08:48:50 INFO - TinderboxPrint: CPU user
1,199.1 (12.5%) 08:48:50 INFO - TinderboxPrint: Swap in / out
0 / 0 08:48:50 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237432832; Read time: 0; Write time: 248208 08:48:50 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 8192; Write bytes: 284758016; Read time: 44; Write time: 167000 08:48:51 INFO - Running post-run listener: _upload_blobber_files 08:48:51 INFO - Blob upload gear active. 08:48:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:48:51 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 08:48:51 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:48:51 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:48:51 INFO - (blobuploader) - INFO - Open directory for files ... 08:48:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:48:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:48:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:48:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:48:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:48:52 INFO - (blobuploader) - INFO - Done attempting. 08:48:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:48:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:48:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:48:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:48:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:48:53 INFO - (blobuploader) - INFO - Done attempting. 08:48:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:48:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:48:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:48:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:48:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:48:57 INFO - (blobuploader) - INFO - Done attempting. 08:48:57 INFO - (blobuploader) - INFO - Iteration through files over. 08:48:57 INFO - Return code: 0 08:48:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:48:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:48:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b583af72255285e223bcbfac85741ff51348ca3e89c1870f3a5ccb6001e0145cff38a16f39ba82693ae21b457907650c83a89df749bd283f1537a43fa82f2c14", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6eb2f733e444559adcc3a30afaa04d74d4769d1ec962afdd25c07388ea247bde79e6173bafb9d61b43e84d00c4725a881586ddfb325b582f731d2c9fe703291d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/81e76bf53a52864d6dbe47e485de54ffce6bdeb9de7392446cce3c0fcb17466a1ed2738d3134f41112193248caf7492bf6b3bcfebce0594cb8964e5d60f153c8"} 08:48:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:48:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:48:57 INFO - Contents: 08:48:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b583af72255285e223bcbfac85741ff51348ca3e89c1870f3a5ccb6001e0145cff38a16f39ba82693ae21b457907650c83a89df749bd283f1537a43fa82f2c14", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6eb2f733e444559adcc3a30afaa04d74d4769d1ec962afdd25c07388ea247bde79e6173bafb9d61b43e84d00c4725a881586ddfb325b582f731d2c9fe703291d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/81e76bf53a52864d6dbe47e485de54ffce6bdeb9de7392446cce3c0fcb17466a1ed2738d3134f41112193248caf7492bf6b3bcfebce0594cb8964e5d60f153c8"} 08:48:57 INFO - Running post-run listener: copy_logs_to_upload_dir 08:48:57 INFO - Copying logs to upload dir... 08:48:57 INFO - mkdir: /builds/slave/test/build/upload/logs 08:48:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.623931 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-08-01 08:48:56.946162) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 08:48:56.949794) ========= 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=7de08804244eb36560b44971000001c3-1470065060.921524-150398836 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b583af72255285e223bcbfac85741ff51348ca3e89c1870f3a5ccb6001e0145cff38a16f39ba82693ae21b457907650c83a89df749bd283f1537a43fa82f2c14", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6eb2f733e444559adcc3a30afaa04d74d4769d1ec962afdd25c07388ea247bde79e6173bafb9d61b43e84d00c4725a881586ddfb325b582f731d2c9fe703291d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/81e76bf53a52864d6dbe47e485de54ffce6bdeb9de7392446cce3c0fcb17466a1ed2738d3134f41112193248caf7492bf6b3bcfebce0594cb8964e5d60f153c8"} build_url:https://queue.taskcluster.net/v1/task/e0UgsodyS5-aFayGw9xv1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011294 build_url: 'https://queue.taskcluster.net/v1/task/e0UgsodyS5-aFayGw9xv1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b583af72255285e223bcbfac85741ff51348ca3e89c1870f3a5ccb6001e0145cff38a16f39ba82693ae21b457907650c83a89df749bd283f1537a43fa82f2c14", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6eb2f733e444559adcc3a30afaa04d74d4769d1ec962afdd25c07388ea247bde79e6173bafb9d61b43e84d00c4725a881586ddfb325b582f731d2c9fe703291d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/81e76bf53a52864d6dbe47e485de54ffce6bdeb9de7392446cce3c0fcb17466a1ed2738d3134f41112193248caf7492bf6b3bcfebce0594cb8964e5d60f153c8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 08:48:56.974761) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 08:48:56.975083) ========= 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=7de08804244eb36560b44971000001c3-1470065060.921524-150398836 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004408 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 08:48:57.061447) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 08:48:57.061780) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 08:48:57.062100) ========= ========= Total master_lag: 0.19 =========