builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-064 starttime: 1469889425.99 results: success (0) buildid: 20160730070025 builduid: abb39bb6f3f4449bbdd23e82c9247e4b revision: c7f33a87d95972f63f4462844b8d991186ab4765 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-30 07:37:05.991701) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-30 07:37:05.992141) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-30 07:37:05.992480) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-30 07:37:06.006888) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 07:37:06.007176) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1469889426.488110-514809297 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-30 07:37:07-- 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% 45.7M=0s 2016-07-30 07:37:08 (45.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115709 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 07:37:06.136664) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 07:37:06.136972) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1469889426.488110-514809297 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017169 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 07:37:06.185683) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-30 07:37:06.186014) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c7f33a87d95972f63f4462844b8d991186ab4765 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev c7f33a87d95972f63f4462844b8d991186ab4765 --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=a12cd81e0ef515edd9e0d800000001bb-1469889426.488110-514809297 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-30 07:37:08,193 truncating revision to first 12 chars 2016-07-30 07:37:08,193 Setting DEBUG logging. 2016-07-30 07:37:08,193 attempt 1/10 2016-07-30 07:37:08,193 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c7f33a87d959?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-30 07:37:09,661 unpacking tar archive at: fx-team-c7f33a87d959/testing/mozharness/ program finished with exit code 0 elapsedTime=1.839715 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-30 07:37:08.038359) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-30 07:37:08.038849) ========= script_repo_revision: c7f33a87d95972f63f4462844b8d991186ab4765 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-30 07:37:08.039277) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-30 07:37:08.039576) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-30 07:37:08.083805) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-30 07:37:08.084209) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1469889426.488110-514809297 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:37:10 INFO - MultiFileLogger online at 20160730 07:37:10 in /builds/slave/test 07:37:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 07:37:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:37:10 INFO - {'append_to_log': False, 07:37:10 INFO - 'base_work_dir': '/builds/slave/test', 07:37:10 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:37:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:37:10 INFO - 'branch': 'Fx-Team-Non-PGO', 07:37:10 INFO - 'buildbot_json_path': 'buildprops.json', 07:37:10 INFO - 'config_files': ('talos/linux_config.py',), 07:37:10 INFO - 'default_actions': ('clobber', 07:37:10 INFO - 'read-buildbot-config', 07:37:10 INFO - 'download-and-extract', 07:37:10 INFO - 'populate-webroot', 07:37:10 INFO - 'create-virtualenv', 07:37:10 INFO - 'install', 07:37:10 INFO - 'run-tests'), 07:37:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:37:10 INFO - 'download_minidump_stackwalk': True, 07:37:10 INFO - 'download_symbols': 'ondemand', 07:37:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:37:10 INFO - 'tooltool.py': '/tools/tooltool.py', 07:37:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:37:10 INFO - '/tools/misc-python/virtualenv.py')}, 07:37:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:37:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:37:10 INFO - 'installer_path': 'installer.exe', 07:37:10 INFO - 'log_level': 'info', 07:37:10 INFO - 'log_name': 'talos', 07:37:10 INFO - 'log_to_console': True, 07:37:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:37:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:37:10 INFO - 'opt_config_files': (), 07:37:10 INFO - 'pip_index': False, 07:37:10 INFO - 'sps_profile': False, 07:37:10 INFO - 'sps_profile_interval': 0, 07:37:10 INFO - 'suite': 'dromaeojs', 07:37:10 INFO - 'system_bits': '32', 07:37:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:37:10 INFO - 'title': 'talos-linux64-ix-064', 07:37:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:37:10 INFO - 'use_talos_json': True, 07:37:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:37:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:37:10 INFO - 'work_dir': 'build'} 07:37:10 INFO - [mozharness: 2016-07-30 14:37:10.188533Z] Running clobber step. 07:37:10 INFO - Running pre-action listener: _resource_record_pre_action 07:37:10 INFO - Running main action method: clobber 07:37:10 INFO - rmtree: /builds/slave/test/build 07:37:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:37:10 INFO - Running post-action listener: _resource_record_post_action 07:37:10 INFO - [mozharness: 2016-07-30 14:37:10.662486Z] Finished clobber step (success) 07:37:10 INFO - [mozharness: 2016-07-30 14:37:10.662586Z] Running read-buildbot-config step. 07:37:10 INFO - Running pre-action listener: _resource_record_pre_action 07:37:10 INFO - Running main action method: read_buildbot_config 07:37:10 INFO - Using buildbot properties: 07:37:10 INFO - { 07:37:10 INFO - "project": "", 07:37:10 INFO - "product": "firefox", 07:37:10 INFO - "script_repo_revision": "production", 07:37:10 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 07:37:10 INFO - "repository": "", 07:37:10 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 07:37:10 INFO - "buildid": "20160730070025", 07:37:10 INFO - "pgo_build": "False", 07:37:10 INFO - "basedir": "/builds/slave/test", 07:37:10 INFO - "buildnumber": 2051, 07:37:10 INFO - "slavename": "talos-linux64-ix-064", 07:37:10 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:37:10 INFO - "platform": "ubuntu64_hw", 07:37:10 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:37:10 INFO - "branch": "fx-team", 07:37:10 INFO - "repo_path": "integration/fx-team", 07:37:10 INFO - "revision": "c7f33a87d95972f63f4462844b8d991186ab4765", 07:37:10 INFO - "stage_platform": "linux64", 07:37:10 INFO - "builduid": "abb39bb6f3f4449bbdd23e82c9247e4b", 07:37:10 INFO - "slavebuilddir": "test" 07:37:10 INFO - } 07:37:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/CXFKn_YdRduhn7ayW5mhbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:37:10 INFO - Running post-action listener: _resource_record_post_action 07:37:10 INFO - [mozharness: 2016-07-30 14:37:10.665159Z] Finished read-buildbot-config step (success) 07:37:10 INFO - [mozharness: 2016-07-30 14:37:10.665248Z] Running download-and-extract step. 07:37:10 INFO - Running pre-action listener: _resource_record_pre_action 07:37:10 INFO - Running main action method: download_and_extract 07:37:10 INFO - mkdir: /builds/slave/test/build/tests 07:37:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:10 INFO - https://queue.taskcluster.net/v1/task/CXFKn_YdRduhn7ayW5mhbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:37:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CXFKn_YdRduhn7ayW5mhbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:37:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CXFKn_YdRduhn7ayW5mhbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:37:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CXFKn_YdRduhn7ayW5mhbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:37:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CXFKn_YdRduhn7ayW5mhbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:37:11 INFO - Downloaded 1361 bytes. 07:37:11 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:37:11 INFO - Using the following test package requirements: 07:37:11 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:37:11 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:37:11 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:37:11 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:11 INFO - u'jsshell-linux-x86_64.zip'], 07:37:11 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:37:11 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:37:11 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:37:11 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:37:11 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:37:11 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:37:11 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:37:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:11 INFO - https://queue.taskcluster.net/v1/task/CXFKn_YdRduhn7ayW5mhbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:37:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CXFKn_YdRduhn7ayW5mhbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:37:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CXFKn_YdRduhn7ayW5mhbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:37:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CXFKn_YdRduhn7ayW5mhbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:37:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CXFKn_YdRduhn7ayW5mhbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:37:12 INFO - Downloaded 20231869 bytes. 07:37:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:37:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:37:13 INFO - Return code: 0 07:37:13 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:37:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:13 INFO - https://queue.taskcluster.net/v1/task/CXFKn_YdRduhn7ayW5mhbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:37:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CXFKn_YdRduhn7ayW5mhbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:37:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CXFKn_YdRduhn7ayW5mhbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:37:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CXFKn_YdRduhn7ayW5mhbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:37:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CXFKn_YdRduhn7ayW5mhbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:37:14 INFO - Downloaded 20231869 bytes. 07:37:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:37:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:37:15 INFO - Return code: 0 07:37:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:15 INFO - https://queue.taskcluster.net/v1/task/CXFKn_YdRduhn7ayW5mhbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:37:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CXFKn_YdRduhn7ayW5mhbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:37:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CXFKn_YdRduhn7ayW5mhbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:37:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CXFKn_YdRduhn7ayW5mhbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:37:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CXFKn_YdRduhn7ayW5mhbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:37:16 INFO - Downloaded 14413725 bytes. 07:37:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:37:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:37:16 INFO - Return code: 0 07:37:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:16 INFO - https://queue.taskcluster.net/v1/task/CXFKn_YdRduhn7ayW5mhbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:37:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CXFKn_YdRduhn7ayW5mhbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:37:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CXFKn_YdRduhn7ayW5mhbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:37:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CXFKn_YdRduhn7ayW5mhbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:37:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CXFKn_YdRduhn7ayW5mhbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:37:18 INFO - Downloaded 55588167 bytes. 07:37:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CXFKn_YdRduhn7ayW5mhbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:37:18 INFO - mkdir: /builds/slave/test/properties 07:37:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:37:18 INFO - Writing to file /builds/slave/test/properties/build_url 07:37:18 INFO - Contents: 07:37:18 INFO - build_url:https://queue.taskcluster.net/v1/task/CXFKn_YdRduhn7ayW5mhbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:37:18 INFO - Running post-action listener: _resource_record_post_action 07:37:18 INFO - Running post-action listener: set_extra_try_arguments 07:37:18 INFO - [mozharness: 2016-07-30 14:37:18.769550Z] Finished download-and-extract step (success) 07:37:18 INFO - [mozharness: 2016-07-30 14:37:18.769782Z] Running populate-webroot step. 07:37:18 INFO - Running pre-action listener: _resource_record_pre_action 07:37:18 INFO - Running main action method: populate_webroot 07:37:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:37:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:37:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:37:18 INFO - '--tppagecycles', 07:37:18 INFO - '7'], 07:37:18 INFO - 'tests': ['tsvgm']}}, 07:37:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:37:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:37:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:37:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:37:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:37:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:37:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:18 INFO - 'talos_options': ['--disable-e10s'], 07:37:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:37:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:37:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:18 INFO - 'talos_options': ['--disable-e10s'], 07:37:18 INFO - 'tests': ['damp', 'tps']}, 07:37:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:18 INFO - 'tests': ['damp', 'tps']}, 07:37:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:37:18 INFO - 'tests': ['dromaeo_dom']}, 07:37:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:37:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:37:18 INFO - 'tests': ['basic_compositor_video']}, 07:37:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:37:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:37:18 INFO - 'tests': ['a11yr', 07:37:18 INFO - 'ts_paint', 07:37:18 INFO - 'tpaint', 07:37:18 INFO - 'sessionrestore', 07:37:18 INFO - 'sessionrestore_no_auto_restore', 07:37:18 INFO - 'tabpaint']}, 07:37:18 INFO - 'other-e10s': {'tests': ['a11yr', 07:37:18 INFO - 'ts_paint', 07:37:18 INFO - 'tpaint', 07:37:18 INFO - 'sessionrestore', 07:37:18 INFO - 'sessionrestore_no_auto_restore', 07:37:18 INFO - 'tabpaint']}, 07:37:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:37:18 INFO - 'ts_paint', 07:37:18 INFO - 'tpaint', 07:37:18 INFO - 'sessionrestore', 07:37:18 INFO - 'sessionrestore_no_auto_restore', 07:37:18 INFO - 'tabpaint']}, 07:37:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:37:18 INFO - 'ts_paint', 07:37:18 INFO - 'tpaint', 07:37:18 INFO - 'sessionrestore', 07:37:18 INFO - 'sessionrestore_no_auto_restore', 07:37:18 INFO - 'tabpaint']}, 07:37:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:37:18 INFO - 'tests': ['a11yr', 07:37:18 INFO - 'ts_paint', 07:37:18 INFO - 'tpaint', 07:37:18 INFO - 'sessionrestore', 07:37:18 INFO - 'sessionrestore_no_auto_restore', 07:37:18 INFO - 'tabpaint']}, 07:37:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:37:18 INFO - 'tests': ['a11yr', 07:37:18 INFO - 'ts_paint', 07:37:18 INFO - 'tpaint', 07:37:18 INFO - 'sessionrestore', 07:37:18 INFO - 'sessionrestore_no_auto_restore', 07:37:18 INFO - 'tabpaint']}, 07:37:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:37:18 INFO - 'tests': ['tsvgx', 07:37:18 INFO - 'tsvgr_opacity', 07:37:18 INFO - 'tart', 07:37:18 INFO - 'tscrollx', 07:37:18 INFO - 'cart']}, 07:37:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:37:18 INFO - 'tsvgr_opacity', 07:37:18 INFO - 'tart', 07:37:18 INFO - 'tscrollx', 07:37:18 INFO - 'cart']}, 07:37:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:18 INFO - 'talos_options': ['--disable-e10s'], 07:37:18 INFO - 'tests': ['tp5o']}, 07:37:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:18 INFO - 'tests': ['tp5o']}, 07:37:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:18 INFO - 'talos_options': ['--disable-e10s', 07:37:18 INFO - '--xperf_path', 07:37:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:37:18 INFO - 'tests': ['tp5n']}, 07:37:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:18 INFO - 'talos_options': ['--xperf_path', 07:37:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:37:18 INFO - 'tests': ['tp5n']}}, 07:37:18 INFO - 'talos.zip': {'path': '', 07:37:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:37:18 INFO - Running post-action listener: _resource_record_post_action 07:37:18 INFO - [mozharness: 2016-07-30 14:37:18.787274Z] Finished populate-webroot step (success) 07:37:18 INFO - [mozharness: 2016-07-30 14:37:18.787363Z] Running create-virtualenv step. 07:37:18 INFO - Running pre-action listener: _resource_record_pre_action 07:37:18 INFO - Running main action method: create_virtualenv 07:37:18 INFO - Creating virtualenv /builds/slave/test/build/venv 07:37:18 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:37:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:37:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:37:18 INFO - Using real prefix '/usr' 07:37:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:37:19 INFO - Installing distribute.............................................................................................................................................................................................done. 07:37:21 INFO - Installing pip.................done. 07:37:21 INFO - Return code: 0 07:37:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:37:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:21 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 0x20f5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b43b0>, '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 0x23b52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b5740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1469889426.488110-514809297', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:37:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:37:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:37:21 INFO - Using env: {'DISPLAY': ':0', 07:37:21 INFO - 'HOME': '/home/cltbld', 07:37:21 INFO - 'LANG': 'en_US.UTF-8', 07:37:21 INFO - 'LANGUAGE': 'en_US:en', 07:37:21 INFO - 'LOGNAME': 'cltbld', 07:37:21 INFO - 'MAIL': '/var/mail/cltbld', 07:37:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:21 INFO - 'MOZ_NO_REMOTE': '1', 07:37:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:21 INFO - 'NO_EM_RESTART': '1', 07:37:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:21 INFO - 'PWD': '/builds/slave/test', 07:37:21 INFO - 'SHELL': '/bin/bash', 07:37:21 INFO - 'SHLVL': '1', 07:37:21 INFO - 'TERM': 'linux', 07:37:21 INFO - 'TMOUT': '86400', 07:37:21 INFO - 'USER': 'cltbld', 07:37:21 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1469889426.488110-514809297', 07:37:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:21 INFO - '_': '/tools/buildbot/bin/python'} 07:37:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:21 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:37:21 INFO - Cleaning up... 07:37:21 INFO - Return code: 0 07:37:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:37:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:21 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 0x20f5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b43b0>, '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 0x23b52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b5740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1469889426.488110-514809297', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:37:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:37:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:37:21 INFO - Using env: {'DISPLAY': ':0', 07:37:21 INFO - 'HOME': '/home/cltbld', 07:37:21 INFO - 'LANG': 'en_US.UTF-8', 07:37:21 INFO - 'LANGUAGE': 'en_US:en', 07:37:21 INFO - 'LOGNAME': 'cltbld', 07:37:21 INFO - 'MAIL': '/var/mail/cltbld', 07:37:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:21 INFO - 'MOZ_NO_REMOTE': '1', 07:37:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:21 INFO - 'NO_EM_RESTART': '1', 07:37:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:21 INFO - 'PWD': '/builds/slave/test', 07:37:21 INFO - 'SHELL': '/bin/bash', 07:37:21 INFO - 'SHLVL': '1', 07:37:21 INFO - 'TERM': 'linux', 07:37:21 INFO - 'TMOUT': '86400', 07:37:21 INFO - 'USER': 'cltbld', 07:37:21 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1469889426.488110-514809297', 07:37:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:21 INFO - '_': '/tools/buildbot/bin/python'} 07:37:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:21 INFO - Downloading/unpacking psutil>=3.1.1 07:37:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:37:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:37:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:37:23 INFO - Installing collected packages: psutil 07:37:23 INFO - Running setup.py install for psutil 07:37:23 INFO - building 'psutil._psutil_linux' extension 07:37:23 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:37:24 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:37:24 INFO - building 'psutil._psutil_posix' extension 07:37:24 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:37:24 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:37:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:37:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:37:24 INFO - Successfully installed psutil 07:37:24 INFO - Cleaning up... 07:37:24 INFO - Return code: 0 07:37:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:37:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:24 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 0x20f5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b43b0>, '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 0x23b52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b5740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1469889426.488110-514809297', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:37:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:37:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:37:24 INFO - Using env: {'DISPLAY': ':0', 07:37:24 INFO - 'HOME': '/home/cltbld', 07:37:24 INFO - 'LANG': 'en_US.UTF-8', 07:37:24 INFO - 'LANGUAGE': 'en_US:en', 07:37:24 INFO - 'LOGNAME': 'cltbld', 07:37:24 INFO - 'MAIL': '/var/mail/cltbld', 07:37:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:24 INFO - 'MOZ_NO_REMOTE': '1', 07:37:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:24 INFO - 'NO_EM_RESTART': '1', 07:37:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:24 INFO - 'PWD': '/builds/slave/test', 07:37:24 INFO - 'SHELL': '/bin/bash', 07:37:24 INFO - 'SHLVL': '1', 07:37:24 INFO - 'TERM': 'linux', 07:37:24 INFO - 'TMOUT': '86400', 07:37:24 INFO - 'USER': 'cltbld', 07:37:24 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1469889426.488110-514809297', 07:37:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:24 INFO - '_': '/tools/buildbot/bin/python'} 07:37:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:37:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:37:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:37:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:37:26 INFO - Installing collected packages: mozsystemmonitor 07:37:26 INFO - Running setup.py install for mozsystemmonitor 07:37:26 INFO - Successfully installed mozsystemmonitor 07:37:26 INFO - Cleaning up... 07:37:26 INFO - Return code: 0 07:37:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:37:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x20f5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b43b0>, '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 0x23b52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b5740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1469889426.488110-514809297', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:37:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:37:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:37:26 INFO - Using env: {'DISPLAY': ':0', 07:37:26 INFO - 'HOME': '/home/cltbld', 07:37:26 INFO - 'LANG': 'en_US.UTF-8', 07:37:26 INFO - 'LANGUAGE': 'en_US:en', 07:37:26 INFO - 'LOGNAME': 'cltbld', 07:37:26 INFO - 'MAIL': '/var/mail/cltbld', 07:37:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:26 INFO - 'MOZ_NO_REMOTE': '1', 07:37:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:26 INFO - 'NO_EM_RESTART': '1', 07:37:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:26 INFO - 'PWD': '/builds/slave/test', 07:37:26 INFO - 'SHELL': '/bin/bash', 07:37:26 INFO - 'SHLVL': '1', 07:37:26 INFO - 'TERM': 'linux', 07:37:26 INFO - 'TMOUT': '86400', 07:37:26 INFO - 'USER': 'cltbld', 07:37:26 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1469889426.488110-514809297', 07:37:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:26 INFO - '_': '/tools/buildbot/bin/python'} 07:37:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:26 INFO - Downloading/unpacking jsonschema==2.5.1 07:37:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:37:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:37:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:29 INFO - Downloading functools32-3.2.3-2.tar.gz 07:37:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:37:29 INFO - warning: no files found matching '*.txt' 07:37:29 INFO - no previously-included directories found matching 'build' 07:37:29 INFO - no previously-included directories found matching 'dist' 07:37:29 INFO - no previously-included directories found matching '.git*' 07:37:29 INFO - Installing collected packages: jsonschema, functools32 07:37:29 INFO - Running setup.py install for functools32 07:37:29 INFO - warning: no files found matching '*.txt' 07:37:29 INFO - no previously-included directories found matching 'build' 07:37:29 INFO - no previously-included directories found matching 'dist' 07:37:29 INFO - no previously-included directories found matching '.git*' 07:37:29 INFO - Successfully installed jsonschema functools32 07:37:29 INFO - Cleaning up... 07:37:29 INFO - Return code: 0 07:37:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:37:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:29 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 0x20f5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b43b0>, '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 0x23b52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b5740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1469889426.488110-514809297', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:37:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:37:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:37:29 INFO - Using env: {'DISPLAY': ':0', 07:37:29 INFO - 'HOME': '/home/cltbld', 07:37:29 INFO - 'LANG': 'en_US.UTF-8', 07:37:29 INFO - 'LANGUAGE': 'en_US:en', 07:37:29 INFO - 'LOGNAME': 'cltbld', 07:37:29 INFO - 'MAIL': '/var/mail/cltbld', 07:37:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:29 INFO - 'MOZ_NO_REMOTE': '1', 07:37:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:29 INFO - 'NO_EM_RESTART': '1', 07:37:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:29 INFO - 'PWD': '/builds/slave/test', 07:37:29 INFO - 'SHELL': '/bin/bash', 07:37:29 INFO - 'SHLVL': '1', 07:37:29 INFO - 'TERM': 'linux', 07:37:29 INFO - 'TMOUT': '86400', 07:37:29 INFO - 'USER': 'cltbld', 07:37:29 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1469889426.488110-514809297', 07:37:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:29 INFO - '_': '/tools/buildbot/bin/python'} 07:37:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:37:29 INFO - Cleaning up... 07:37:29 INFO - Return code: 0 07:37:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:37:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:29 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 0x20f5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b43b0>, '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 0x23b52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b5740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1469889426.488110-514809297', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:37:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:37:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:37:29 INFO - Using env: {'DISPLAY': ':0', 07:37:29 INFO - 'HOME': '/home/cltbld', 07:37:29 INFO - 'LANG': 'en_US.UTF-8', 07:37:29 INFO - 'LANGUAGE': 'en_US:en', 07:37:29 INFO - 'LOGNAME': 'cltbld', 07:37:29 INFO - 'MAIL': '/var/mail/cltbld', 07:37:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:29 INFO - 'MOZ_NO_REMOTE': '1', 07:37:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:29 INFO - 'NO_EM_RESTART': '1', 07:37:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:29 INFO - 'PWD': '/builds/slave/test', 07:37:29 INFO - 'SHELL': '/bin/bash', 07:37:29 INFO - 'SHLVL': '1', 07:37:29 INFO - 'TERM': 'linux', 07:37:29 INFO - 'TMOUT': '86400', 07:37:29 INFO - 'USER': 'cltbld', 07:37:29 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1469889426.488110-514809297', 07:37:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:29 INFO - '_': '/tools/buildbot/bin/python'} 07:37:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:29 INFO - Downloading/unpacking blobuploader==1.2.4 07:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:31 INFO - Downloading blobuploader-1.2.4.tar.gz 07:37:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:37:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:37:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:37:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:37:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:32 INFO - Downloading docopt-0.6.1.tar.gz 07:37:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:37:32 INFO - Installing collected packages: blobuploader, requests, docopt 07:37:32 INFO - Running setup.py install for blobuploader 07:37:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:37:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:37:32 INFO - Running setup.py install for requests 07:37:32 INFO - Running setup.py install for docopt 07:37:32 INFO - Successfully installed blobuploader requests docopt 07:37:32 INFO - Cleaning up... 07:37:33 INFO - Return code: 0 07:37:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:37:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:33 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 0x20f5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b43b0>, '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 0x23b52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b5740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1469889426.488110-514809297', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:37:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:37:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:37:33 INFO - Using env: {'DISPLAY': ':0', 07:37:33 INFO - 'HOME': '/home/cltbld', 07:37:33 INFO - 'LANG': 'en_US.UTF-8', 07:37:33 INFO - 'LANGUAGE': 'en_US:en', 07:37:33 INFO - 'LOGNAME': 'cltbld', 07:37:33 INFO - 'MAIL': '/var/mail/cltbld', 07:37:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:33 INFO - 'MOZ_NO_REMOTE': '1', 07:37:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:33 INFO - 'NO_EM_RESTART': '1', 07:37:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:33 INFO - 'PWD': '/builds/slave/test', 07:37:33 INFO - 'SHELL': '/bin/bash', 07:37:33 INFO - 'SHLVL': '1', 07:37:33 INFO - 'TERM': 'linux', 07:37:33 INFO - 'TMOUT': '86400', 07:37:33 INFO - 'USER': 'cltbld', 07:37:33 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1469889426.488110-514809297', 07:37:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:33 INFO - '_': '/tools/buildbot/bin/python'} 07:37:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:37:33 INFO - Running setup.py (path:/tmp/pip-bedTwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:37:33 INFO - Running setup.py (path:/tmp/pip-BTREf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:37:33 INFO - Running setup.py (path:/tmp/pip-vklkKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:37:33 INFO - Running setup.py (path:/tmp/pip-BmGwy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:37:33 INFO - Running setup.py (path:/tmp/pip-C5mUKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:37:33 INFO - Running setup.py (path:/tmp/pip-HG3R63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:37:33 INFO - Running setup.py (path:/tmp/pip-ASsw5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:37:33 INFO - Running setup.py (path:/tmp/pip-1ndneB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:37:33 INFO - Running setup.py (path:/tmp/pip-KFnIta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:37:33 INFO - Running setup.py (path:/tmp/pip-Gsq2oR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:37:33 INFO - Running setup.py (path:/tmp/pip-DB8F1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:37:34 INFO - Running setup.py (path:/tmp/pip-sF2E6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:37:34 INFO - Running setup.py (path:/tmp/pip-P3Ygnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:37:34 INFO - Running setup.py (path:/tmp/pip-LCJlwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:34 INFO - Running setup.py (path:/tmp/pip-b69kOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:37:34 INFO - Running setup.py (path:/tmp/pip-dbId8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:37:34 INFO - Running setup.py (path:/tmp/pip-S6T2H4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:37:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:37:34 INFO - Running setup.py install for manifestparser 07:37:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:37:34 INFO - Running setup.py install for mozcrash 07:37:34 INFO - Running setup.py install for mozdebug 07:37:34 INFO - Running setup.py install for mozdevice 07:37:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:37:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:37:34 INFO - Running setup.py install for mozfile 07:37:34 INFO - Running setup.py install for mozhttpd 07:37:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:37:35 INFO - Running setup.py install for mozinfo 07:37:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:37:35 INFO - Running setup.py install for mozInstall 07:37:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:37:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:37:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:37:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:37:35 INFO - Running setup.py install for mozleak 07:37:35 INFO - Running setup.py install for mozlog 07:37:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:37:35 INFO - Running setup.py install for moznetwork 07:37:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:37:35 INFO - Running setup.py install for mozprocess 07:37:35 INFO - Running setup.py install for mozprofile 07:37:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:37:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:37:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:37:35 INFO - Running setup.py install for mozrunner 07:37:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:37:35 INFO - Running setup.py install for mozscreenshot 07:37:36 INFO - Running setup.py install for moztest 07:37:36 INFO - Running setup.py install for mozversion 07:37:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:37:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:37:36 INFO - Cleaning up... 07:37:36 INFO - Return code: 0 07:37:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:37: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')]} 07:37:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37: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')]} 07:37:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:36 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 0x20f5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b43b0>, '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 0x23b52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b5740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1469889426.488110-514809297', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:37:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:37:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:37:36 INFO - Using env: {'DISPLAY': ':0', 07:37:36 INFO - 'HOME': '/home/cltbld', 07:37:36 INFO - 'LANG': 'en_US.UTF-8', 07:37:36 INFO - 'LANGUAGE': 'en_US:en', 07:37:36 INFO - 'LOGNAME': 'cltbld', 07:37:36 INFO - 'MAIL': '/var/mail/cltbld', 07:37:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:36 INFO - 'MOZ_NO_REMOTE': '1', 07:37:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:36 INFO - 'NO_EM_RESTART': '1', 07:37:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:36 INFO - 'PWD': '/builds/slave/test', 07:37:36 INFO - 'SHELL': '/bin/bash', 07:37:36 INFO - 'SHLVL': '1', 07:37:36 INFO - 'TERM': 'linux', 07:37:36 INFO - 'TMOUT': '86400', 07:37:36 INFO - 'USER': 'cltbld', 07:37:36 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1469889426.488110-514809297', 07:37:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:36 INFO - '_': '/tools/buildbot/bin/python'} 07:37:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:37:36 INFO - Running setup.py (path:/tmp/pip-2gQgaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:37:36 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:37:36 INFO - Running setup.py (path:/tmp/pip-iyRu7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:37:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:37:36 INFO - Running setup.py (path:/tmp/pip-STTny0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:37:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:37:36 INFO - Running setup.py (path:/tmp/pip-IlZhFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:37:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:37:36 INFO - Running setup.py (path:/tmp/pip-MMB1Yg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:37:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:37:36 INFO - Running setup.py (path:/tmp/pip-X9UgVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:37:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:37:36 INFO - Running setup.py (path:/tmp/pip-RvdKmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:37:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:37:36 INFO - Running setup.py (path:/tmp/pip-OFxxr_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:37:37 INFO - Running setup.py (path:/tmp/pip-OBzenR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:37:37 INFO - Running setup.py (path:/tmp/pip-U3wcNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:37:37 INFO - Running setup.py (path:/tmp/pip-n2y6Cw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:37:37 INFO - Running setup.py (path:/tmp/pip-8bViEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:37:37 INFO - Running setup.py (path:/tmp/pip-PAik9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:37:37 INFO - Running setup.py (path:/tmp/pip-O21PUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:37 INFO - Running setup.py (path:/tmp/pip-tz3Mq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:37:37 INFO - Running setup.py (path:/tmp/pip-qpMJC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:37:37 INFO - Running setup.py (path:/tmp/pip-p8fGN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:37:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:37:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:39 INFO - Downloading blessings-1.6.tar.gz 07:37:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:37:39 INFO - Installing collected packages: blessings 07:37:39 INFO - Running setup.py install for blessings 07:37:39 INFO - Successfully installed blessings 07:37:39 INFO - Cleaning up... 07:37:39 INFO - Return code: 0 07:37:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:37:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:37:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:37:40 INFO - Reading from file tmpfile_stdout 07:37:40 INFO - Current package versions: 07:37:40 INFO - argparse == 1.2.1 07:37:40 INFO - blessings == 1.6 07:37:40 INFO - blobuploader == 1.2.4 07:37:40 INFO - docopt == 0.6.1 07:37:40 INFO - functools32 == 3.2.3-2 07:37:40 INFO - jsonschema == 2.5.1 07:37:40 INFO - manifestparser == 1.1 07:37:40 INFO - mozInstall == 1.12 07:37:40 INFO - mozcrash == 0.17 07:37:40 INFO - mozdebug == 0.1 07:37:40 INFO - mozdevice == 0.48 07:37:40 INFO - mozfile == 1.2 07:37:40 INFO - mozhttpd == 0.7 07:37:40 INFO - mozinfo == 0.9 07:37:40 INFO - mozleak == 0.1 07:37:40 INFO - mozlog == 3.3 07:37:40 INFO - moznetwork == 0.27 07:37:40 INFO - mozprocess == 0.23 07:37:40 INFO - mozprofile == 0.28 07:37:40 INFO - mozrunner == 6.12 07:37:40 INFO - mozscreenshot == 0.1 07:37:40 INFO - mozsystemmonitor == 0.3 07:37:40 INFO - moztest == 0.7 07:37:40 INFO - mozversion == 1.4 07:37:40 INFO - psutil == 3.1.1 07:37:40 INFO - requests == 1.2.3 07:37:40 INFO - wsgiref == 0.1.2 07:37:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:37:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:40 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 0x20f5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b43b0>, '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 0x23b52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b5740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1469889426.488110-514809297', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:37:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:37:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:37:40 INFO - Using env: {'DISPLAY': ':0', 07:37:40 INFO - 'HOME': '/home/cltbld', 07:37:40 INFO - 'LANG': 'en_US.UTF-8', 07:37:40 INFO - 'LANGUAGE': 'en_US:en', 07:37:40 INFO - 'LOGNAME': 'cltbld', 07:37:40 INFO - 'MAIL': '/var/mail/cltbld', 07:37:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:40 INFO - 'MOZ_NO_REMOTE': '1', 07:37:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:40 INFO - 'NO_EM_RESTART': '1', 07:37:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:40 INFO - 'PWD': '/builds/slave/test', 07:37:40 INFO - 'SHELL': '/bin/bash', 07:37:40 INFO - 'SHLVL': '1', 07:37:40 INFO - 'TERM': 'linux', 07:37:40 INFO - 'TMOUT': '86400', 07:37:40 INFO - 'USER': 'cltbld', 07:37:40 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1469889426.488110-514809297', 07:37:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:40 INFO - '_': '/tools/buildbot/bin/python'} 07:37:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:37:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:37:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:37:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:37:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:37:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:37:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:37:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:37:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:37:40 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:37:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:37:40 INFO - Cleaning up... 07:37:40 INFO - Return code: 0 07:37:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:37:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:40 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 0x20f5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b43b0>, '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 0x23b52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b5740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1469889426.488110-514809297', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:37:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:37:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:37:40 INFO - Using env: {'DISPLAY': ':0', 07:37:40 INFO - 'HOME': '/home/cltbld', 07:37:40 INFO - 'LANG': 'en_US.UTF-8', 07:37:40 INFO - 'LANGUAGE': 'en_US:en', 07:37:40 INFO - 'LOGNAME': 'cltbld', 07:37:40 INFO - 'MAIL': '/var/mail/cltbld', 07:37:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:40 INFO - 'MOZ_NO_REMOTE': '1', 07:37:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:40 INFO - 'NO_EM_RESTART': '1', 07:37:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:40 INFO - 'PWD': '/builds/slave/test', 07:37:40 INFO - 'SHELL': '/bin/bash', 07:37:40 INFO - 'SHLVL': '1', 07:37:40 INFO - 'TERM': 'linux', 07:37:40 INFO - 'TMOUT': '86400', 07:37:40 INFO - 'USER': 'cltbld', 07:37:40 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1469889426.488110-514809297', 07:37:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:40 INFO - '_': '/tools/buildbot/bin/python'} 07:37:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:37:40 INFO - Cleaning up... 07:37:40 INFO - Return code: 0 07:37:40 INFO - Running post-action listener: _resource_record_post_action 07:37:40 INFO - Running post-action listener: _start_resource_monitoring 07:37:40 INFO - Starting resource monitoring. 07:37:40 INFO - [mozharness: 2016-07-30 14:37:40.545649Z] Finished create-virtualenv step (success) 07:37:40 INFO - [mozharness: 2016-07-30 14:37:40.546134Z] Running install step. 07:37:40 INFO - Running pre-action listener: _resource_record_pre_action 07:37:40 INFO - Running main action method: install 07:37:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:37:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:37:40 INFO - Reading from file tmpfile_stdout 07:37:40 INFO - Detecting whether we're running mozinstall >=1.0... 07:37:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:37:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:37:40 INFO - Reading from file tmpfile_stdout 07:37:40 INFO - Output received: 07:37:40 INFO - Usage: mozinstall [options] installer 07:37:40 INFO - Options: 07:37:40 INFO - -h, --help show this help message and exit 07:37:40 INFO - -d DEST, --destination=DEST 07:37:40 INFO - Directory to install application into. [default: 07:37:40 INFO - "/builds/slave/test"] 07:37:40 INFO - --app=APP Application being installed. [default: firefox] 07:37:40 INFO - mkdir: /builds/slave/test/build/application 07:37:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:37:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:37:56 INFO - Reading from file tmpfile_stdout 07:37:56 INFO - Output received: 07:37:56 INFO - /builds/slave/test/build/application/firefox/firefox 07:37:56 INFO - Running post-action listener: _resource_record_post_action 07:37:56 INFO - [mozharness: 2016-07-30 14:37:56.896983Z] Finished install step (success) 07:37:56 INFO - [mozharness: 2016-07-30 14:37:56.897260Z] Running run-tests step. 07:37:56 INFO - Running pre-action listener: _resource_record_pre_action 07:37:56 INFO - Running main action method: run_tests 07:37:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:37:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:37:56 INFO - Python 2.7.3 07:37:56 INFO - Return code: 0 07:37:56 INFO - grabbing minidump binary from tooltool 07:37:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:56 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 0x23b43b0>, '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 0x23b52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b5740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:37:56 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:37:56 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:37:56 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:37:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:37:56 INFO - Return code: 0 07:37:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:37:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:37:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:37:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:37:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:37:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CXFKn_YdRduhn7ayW5mhbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:37:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CXFKn_YdRduhn7ayW5mhbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:37:56 INFO - Using env: {'DISPLAY': ':0', 07:37:56 INFO - 'HOME': '/home/cltbld', 07:37:56 INFO - 'LANG': 'en_US.UTF-8', 07:37:56 INFO - 'LANGUAGE': 'en_US:en', 07:37:56 INFO - 'LOGNAME': 'cltbld', 07:37:56 INFO - 'MAIL': '/var/mail/cltbld', 07:37:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:37:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:37:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:56 INFO - 'MOZ_NO_REMOTE': '1', 07:37:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:37:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:56 INFO - 'NO_EM_RESTART': '1', 07:37:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:56 INFO - 'PWD': '/builds/slave/test', 07:37:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:37:56 INFO - 'SHELL': '/bin/bash', 07:37:56 INFO - 'SHLVL': '1', 07:37:56 INFO - 'TERM': 'linux', 07:37:56 INFO - 'TMOUT': '86400', 07:37:56 INFO - 'USER': 'cltbld', 07:37:56 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1469889426.488110-514809297', 07:37:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:56 INFO - '_': '/tools/buildbot/bin/python'} 07:37:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CXFKn_YdRduhn7ayW5mhbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:37:57 INFO - mozversion application_buildid: 20160730070025 07:37:57 INFO - mozversion application_changeset: c7f33a87d95972f63f4462844b8d991186ab4765 07:37:57 INFO - mozversion application_display_name: Nightly 07:37:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:37:57 INFO - mozversion application_name: Firefox 07:37:57 INFO - mozversion application_remotingname: firefox 07:37:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:37:57 INFO - mozversion application_vendor: Mozilla 07:37:57 INFO - mozversion application_version: 50.0a1 07:37:57 INFO - mozversion platform_buildid: 20160730070025 07:37:57 INFO - mozversion platform_changeset: c7f33a87d95972f63f4462844b8d991186ab4765 07:37:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:37:57 INFO - mozversion platform_version: 50.0a1 07:37:57 INFO - using testdate: 1469889477 07:37:57 INFO - actual date: 1469889477 07:37:57 INFO - starting webserver on 'localhost:44421' 07:37:57 INFO - SUITE-START | Running 2 tests 07:37:57 INFO - TEST-START | dromaeo_css 07:37:57 INFO - operating with platform_type : linux_ 07:37:57 INFO - Initialising browser for dromaeo_css test... 07:37:57 INFO - TEST-INFO | started process 16166 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHDBdFZ/profile http://localhost:44421/getInfo.html) 07:38:01 INFO - PROCESS | 16166 | __metrics Screen width/height:1600/1200 07:38:01 INFO - PROCESS | 16166 | colorDepth:24 07:38:01 INFO - PROCESS | 16166 | Browser inner width/height: 1024/697 07:38:01 INFO - PROCESS | 16166 | __metrics 07:38:02 INFO - PROCESS | 16166 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:38:02 INFO - PROCESS | 16166 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:38:03 INFO - TEST-INFO | 16166: exit 0 07:38:03 INFO - Browser initialized. 07:38:03 INFO - Running cycle 1/1 for dromaeo_css test... 07:38:03 INFO - TEST-INFO | started process 16250 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHDBdFZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:38:15 INFO - PROCESS | 16250 | RSS: Main: 157392896 07:38:15 INFO - PROCESS | 16250 | 07:39:06 INFO - PROCESS | 16250 | 1469889546957 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:41:19 INFO - PROCESS | 16250 | Cycle 1(1): loaded http://localhost:44421/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44421/tests/dromaeo/cssquery-ext.html) 07:41:21 INFO - PROCESS | 16250 | RSS: Main: 251617280 07:41:21 INFO - PROCESS | 16250 | 07:44:23 INFO - PROCESS | 16250 | Cycle 1(1): loaded http://localhost:44421/tests/dromaeo/cssquery-ext.html (next: http://localhost:44421/tests/dromaeo/cssquery-jquery.html) 07:44:24 INFO - PROCESS | 16250 | RSS: Main: 241373184 07:44:24 INFO - PROCESS | 16250 | 07:47:26 INFO - PROCESS | 16250 | Cycle 1(1): loaded http://localhost:44421/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44421/tests/dromaeo/cssquery-mootools.html) 07:47:27 INFO - PROCESS | 16250 | RSS: Main: 188837888 07:47:27 INFO - PROCESS | 16250 | 07:50:29 INFO - PROCESS | 16250 | Cycle 1(1): loaded http://localhost:44421/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44421/tests/dromaeo/cssquery-prototype.html) 07:50:30 INFO - PROCESS | 16250 | RSS: Main: 213299200 07:50:30 INFO - PROCESS | 16250 | 07:53:33 INFO - PROCESS | 16250 | Cycle 1(1): loaded http://localhost:44421/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44421/tests/dromaeo/cssquery-yui.html) 07:53:33 INFO - PROCESS | 16250 | RSS: Main: 190992384 07:53:33 INFO - PROCESS | 16250 | 07:56:36 INFO - PROCESS | 16250 | Cycle 1(1): loaded http://localhost:44421/tests/dromaeo/cssquery-yui.html (next: http://localhost:44421/tests/dromaeo/cssquery-dojo.html) 07:56:36 INFO - PROCESS | 16250 | RSS: Main: 280539136 07:56:36 INFO - PROCESS | 16250 | 07:56:36 INFO - PROCESS | 16250 | __start_tp_report 07:56:36 INFO - PROCESS | 16250 | _x_x_mozilla_page_load 07:56:36 INFO - PROCESS | 16250 | _x_x_mozilla_page_load_details 07:56:36 INFO - PROCESS | 16250 | |i|pagename|runs| 07:56:36 INFO - PROCESS | 16250 | |0;dojo.html;2673.157955244098;2673.9732602673967;2695.8921643134267;2708.0521817363915;2712.3490362313037;4716.575508204261;4743.644226683;4800.8319708810195;4856;4882.975585122073;4795.088933102708;4796.736179510134;4842.152623290927;4847.079054979551;4853.733044682541;4344.97827510862;4396.758178300192;4416.094700586388;4469.776511174445;4539.387182730338;4443.155800397914;4478.664100192483;4488.147252022105;4503.301988191835;4508.301213311942;4266.679999000056;4298.656107511391;4299.333603291495;4370.38814565961;4417.072414792898;4340.392345071693;4352.825886964518;4358.607725304738;4398.208322501949;4410.977945110286;4387.934180987288;4392.604665580081;4393.912121757547;4423.248047831844;4425.690201685883;4648.74431906245;4791.6406269529925;4803.831865884712;4807.206810876201;4852.757362131879;5166.793328266865;5201.219817027439;5203.037438073969;5252.501012403815;5254.3169387979315;5167.276581278624;5267.683938963636;5279.762410691528;5286.9471305287225;5288.206768984644;4653.278741795028;4751.667383283137;4776.785044672998;4864.537868902484;4925.039617274597;5206.427292997767;5227.980543793924;5289.285946397187;5295.655782374133;5305.151175811851;5032.345795046694;5076.416212135578;5082.491750824888;5084.288199652052;5085.567726743194;4980.252962055648;5118.667286626357;5119.10415677255;5137.460566640524;5172.19830926207;5122.359705036871;5124.743762811844;5127.692338459704;5136.614753893473;5169.25045868347;5114.360704911886;5130.333056702605;5130.7178105204575;5138.717370544581;5180.093483640348;4309.310510318334;4350.042990542076;4392.868213953587;4451.910961780811;4497.820087196541;3829.2341531693774;3833.9041523961564;3876.6511014008875;3909.9413508797393;3937.625925537069;4461.977690111528;4469.821207151743;4475.328700694857;4480.171168333869;4521.683482156283;4999.275105109738;5042.747862606855;5144.151215049475;5154.768035438415;5203.245529398216;4435.556444355539;4459.44256967879;4478.6864919455975;4497.370368148462;4503.7522936238165;4684.969306752509;4689.976550117228;4697.671163018625;4711.3480352010465;4746.928796068062;4763.118823017753;4837.782299796448;4898.681585696918;4902.240152776325;4950.18321976877;5121.79512819498;5128.538431541179;5151.175811870083;5172.7155006475;5215.113430716711;4882.438519570295;4882.829100981448;4888.364512613338;4901.779419926041;4938.580220681282;4904.877378065434;5071.487182037359;5085.46602606721;5092.363454568179;5092.388913330424;4989.625778066732;5020.849374518771;5037.219231019198;5060.063888180698;5083.440821509705;4851.199552073868;4855.5387238212315;4861.756912154449;4867.780949857194;4912.066707325596;4787.138315103176;4899.510048995215;4919.114559379203;4923.679960802537;4974.154393752999;4871.95128048715;4874.707517548958;4935.259711043373;4967.801287948586;4999.225120106389;5039.470855560114;5042.067217564762;5043.823466178666;5045.445001049955;5080.441151473261;4726.550977657117;4892.315075889307;4909.631777616764;4911.312416261655;4951.851444456672 07:56:36 INFO - PROCESS | 16250 | |1;ext.html;574.1817909478992;589.4135335341333;593.9643621382718;597.5189972072485;597.910313452982;27492.587611185823;39793.801030994844;41137.382939255935;41184.382234266435;44443.555564444345;41022;41514.377284340684;41527;41574.58425415745;41579.376309355306;7448.515846469989;7802.648880800378;7942.6425810838655;7946.960265198666;7952;9668.226541876633;9901.306908516406;9911.207103431745;10236.74408139795;10251.282410231286;10082.143017843455;10190.949045254763;10191.59233630654;10196.643117490888;10199.745006374862;10092.24308176886;10149.797004059878;10150.18798496126;10161.745956351077;10164.949175254113;9668.90331096687;9681.612735490642;9771.511424428822;9781.510924453749;9786.41281523111;39118.60881391178;39617.20765584701;39644.801775991225;39663.20673586541;39726;2902.7968042237053;2988.13344130202;3002.324476992659;3160.668129846356;3291.3417316536547;29778.55332170019;30146.84926575375;30183.396332073455;30247.848760756275;30755.07734767938;2787.5957986091903;2902.8258304501796;2914.9271268218254;2922.284040410092;2961.185673939684;246486.9999999982;246989;247008.76495617587;248032;248964;31691.524627130613;54560.454395456334;54826;54956.72521637366;54979;34095;34133.48799768005;34201.657983420344;34202.31595368079;34227.486587701205;12788.16876903017;12830.358482075859;12838.743225135446;12857.549985750455;12912.870871291354;9913;11005.394703291397;11044.116470682326;11108.888911110786;11366.772664546663;7898.802529936797;7905.486143400775;7948.324392426593;8013.559254240956;8027.197280272043;3062.7856050076725;3103.20868178613;3138.8587513561943;3145.7168854803176;3148.889788857379;857.3955361470148;874.4796845876693;875.1248751248751;886.663068034143;915.6108653822099;27738.861305693343;28439.573406398922;28451.857740711162;28738.568921466194;28880.27799304992;955.3790036476207;969.5491596407704;977.8093271812071;996.740847379672;1053.0469924718143;14436.639084022983;15264.618384540476;15386.769198462032;15395.384184632714;15522.301496432689;193268;193314;193962;194326;194521;49518.50481495211;49932;50006.74996625067;50092.749536252086;50171.49828501741;1061.4904845673966;1111.7943180511631;1152.2798251093068;1175.8295047218105;1204.6626944455566;26233.868830656487;29584;29799.70200297969;30448;30463.88737520495;43861.56138438702;44427.33358999682;44445;44467.555324446344;44480;301085;302533;302556;303624;304101;25404.745952540237;26108.086216982316;26428.0750173743;26487;27581.448371032067;42103.57896421119;42629;42714.1457170861;42764;43556.782216088715;35893;36313.818430907675;36380.81809590935;36957.673809357286;37220.62779372172;36283.637163628024;37156.25687486289;37322.44016339703;37860.24279514449;37904;36554.451683224244;36586.63413365832;36689.633103668624;36866.44700329444;36913.44629830501;31979.520307195875;33472.66527334695;33744.662553375136;33763;34268.82865585656;25676.817470515216;25699.871500642377;26030.86984565065;26077.608835867097;26406.603900941886 07:56:36 INFO - PROCESS | 16250 | |2;jquery.html;352.7918528068439;376.9076576238822;377.0611178166365;378.7178551978776;389.0584784820733;12849.29328886912;16354.754678679814;16605.916970415146;16686.249118789652;17710.114494275265;16969.83030169698;17090.914545427255;17585.64828703425;17718.734218986727;17858.553536161602;5028.245763135532;5034;5273.314469119028;5307.336582927134;5343.893122137555;3439.570053743282;5092.312537807404;5352.5182733553975;5381.838544843661;5388.299521062257;5334.626576139672;5358.089124848766;5358.223057656637;5363.195520671891;5392.56859451245;5337.14605663094;5344.14493681013;5344.572434205294;6128.509719222451;6166.784162554334;5462.562994960434;5468.26178465906;5472.808451704172;5480.068388373986;5486.341639003345;11649.88350116505;18964.905175474174;19694.606107877764;19773.80226197734;20317.085731142135;1798.6043070524463;1895.2797936783934;1903.1055403960254;1983.1931100707009;2043.4074118505616;8562.400631955765;8688.565571721389;8787.42881712693;9266.397684150508;9570.330076894621;1579.5024567261275;1668;1674.3637417781288;1713.6058706497452;1755.1399814091003;67657.3234267656;69125;69163.3083669167;70121;71728.6413567934;9130.817383652422;9415.623375065057;9544.618215271312;9816.165625921734;10393.948030259951;13739.862601374058;13802.723945521033;14103.435862565588;14131.85868141326;14147.787783183261;7410.407167426701;7619.733309334258;7640.426967977424;7708.691652333956;7733.651985660659;7233;7296.7810965671115;7370.631468426557;7473.775786726407;7489;3986.8405263789705;4082.9381162513337;4373.300271956472;4404.986853023823;4489.461264648263;1821.298799962024;1829.6249268899844;1831.9772375580133;1882.1436246507806;1898.7436696045856;820.9507429554246;858.733792524307;875.0986483921571;877.7761670773912;886.4371124336093;16493.752593711102;16682.582935426468;17495.562610934572;17615.911920440572;18183.908965462113;829.5769157729601;845.1464021338493;845.5287799229419;857.3055824781821;871.3203701113142;9618;9888.653897113567;10152;10167.339122956984;10312.381257124447;419515;425640;431861;431979;432293;79713;81613.59193203996;82995;83301.58349208336;84534.15465845262;890.7862113092812;906.8549032154824;935.6771913689767;943.9056094390643;948.170350942925;15244.31400586954;15483.612909676898;15845.841541584437;15874;16353.26410311515;39101.41347879727;39209;39283.607163928;40135.3979690299;40285.59714402819;49831;53354.19968700395;53484;53896.73051634717;55173.62065948384;7528.887066693895;7683.231676832272;7731.38148948094;7864.567448790372;7921.960390198243;11583.6524904253;12044.73530279308;12200.328981906081;12764;12931.5473958411;9783.60865565398;10516.474176291307;10537.42044187577;10643.095336896451;10700.197485188486;9542;10010;10065.396076235449;10247.282690211614;10300.845487317845;10117.140043096419;10284;10517.316374435637;10712.303700259457;10829.67510974672;6731.730730770714;6836.28219036994;6912.792616221522;7154.35610795031;8061.758147255592;10584.206184536037;10684.397340399002;10976.725581860517;11022.283551569122;11124.944375278072 07:56:36 INFO - PROCESS | 16250 | |3;mootools.html;1234.5679012345674;1332.1607387345973;1407.1416435974056;1424.2665027510827;1681.8150003499613;6676.399124078832;7754.302112809853;7963.562004089773;7975.601219938994;8239.670413183481;7987.161348058457;8040.316573091294;8068.031836179652;8070.314023308011;8080.232377924102;2216.5788500184954;2252.4706693926914;2252.6395776675736;2256.255435706213;2256.593813113639;2205.9448513787124;2239.193890199527;2254.9774502255013;2255.364860476158;2257.4243567890167;2180.90185941633;2189.4526368407896;2191.1016483241874;2194.2100843696257;2232.787885150908;2129.4569884679463;2159.201095594632;2160.8163306119;2165.177232651598;2167.0464995402053;2172.076867331378;2174.0325555127974;2174.934751957444;2178.2485042660255;2180.2369170790257;7800.297973182441;8016.198380161995;8034.47775894565;8114.066882308551;8115.634796434116;4708.858734237979;4842.515748425165;4913.484084171147;4914.3611330527165;4919.926201106986;2835.4470878178763;2955.807872488281;3002.3394853132277;3010.3527741535454;3051.5727798108283;904.4076130134772;904.8687940248693;920.2132176988712;927.2798957933005;936.4662142578733;10916;11180.105591552656;11186.496607652674;11189.720256993558;11193.10455163585;4353.499347575006;4467.084247729208;4570.54294570547;4586.151561960981;4600;8547.316214702809;8706.738797836075;8710.390272680977;8715.825683486295;8719;4868.513148685103;4871.050145221719;4872.366592342973;4874.147024270738;4880.463149053601;3453.568303962005;3799.886003419902;3915.804209789499;3927.9214415711526;4507.143642707941;3437.914052148716;3577.713782897362;3583.94624080639;3592.1199306169633;3626.7279954003557;1062.8565143705655;1078.4769386847372;1080.173667144635;1087.4617064553097;1092.159037541089;786.7364432915037;816.3673153306236;822.8354329134197;823.2714048067503;828.329053466694;5134.640575159778;5192.584593232608;5280.313559237275;5297.761600727977;5347.0909945309395;387.24873744934735;387.55818367061573;392.8958825911136;396.79961619382027;399.76813448199977;3390;3596.7841929484316;3605.387084195693;3622.239329740784;3641.5083963664565;9288.256939444827;9806.90193098074;9807.215422766161;9809.656662016796;9822.459764712867;9500.95249523748;9635.614575417045;9742.61029558824;9758.853617195748;9764.072413120743;7364.3003914628025;7459.142198647117;7461.365783908429;7468.85062298751;7472.589007604634;5028.9245661315845;5070.442251352274;5122.923156152735;5131.127708289525;5307.4692530746615;8847.071057539124;8906.73279801607;8954.776130596787;9014;9043.819123617623;8106.797330066795;8877.289816814768;9292.488913109844;9369.718908432758;9392.060793920553;5487.6981766003255;6548.214214294315;6567.9671601643595;6633.9336606633315;6672.799816005528;7724.497907635986;7760.068791745027;7780.221977802401;7780.49426787257;7793.181715919747;6871.553349032297;7000.859982800417;7011;7026.051483049927;7081.645917704197;6710.16122984627;6723.092382528296;6736.056952026818;6743.730250789913;6772.288909664414;6139.079138129317;6304.05439184126;6318.304986451579;6366.29970703213;6392.20097487814;4379.146066517126;4387.692861499664;4433;4481.910361792811;4551.954480455153;4296.806643701104;4379.934300985424;4380.3210502372185;4433.179861725591;4496.887577810581 07:56:36 INFO - PROCESS | 16250 | |4;prototype.html;299.41464437025604;306.1840195877985;310.4752967484951;313.69571515629843;319.9504076868086;4736.739479328636;4856.198727210006;4884.853454396365;4890.559849613534;4913.82801601944;4714.599259062984;4814.446338671045;4819.1325561398935;4836.2987366831785;4852.344933433986;3853.499045124144;3861.8455261789495;3861.9806900965455;3871.6709079728257;3881.9805900970455;3645.8177091145335;3663.7618554793853;3873.3221686204943;3884.242572698325;3893.1629699614577;3808.8666896658624;3812.1803812180374;3847.480590120326;3855.51806024247;3875.8255878485393;3842.346801043829;3843.1737176507186;3846.7307288489815;3847.5960024197334;3863.652271295583;3402.3705614461155;3406.4379377402697;3418.777779444328;3435.7251419886347;3447.2588393495266;4532.410786597721;4716.316134160527;4757.643176761722;4775.832845850378;4806.735629540374;4358.629516491102;4363.890902727426;4374.234508960919;4376.227627810742;4379.75911324877;5093.898122037575;5106.897862042775;5114.462981386975;5135.666181698215;5138.332016837787;3445.4659527773233;3556.146524834047;3587.802670853102;3660.7437479376454;3679.4848721179055;5232.162853943389;5250.81622143227;5260.736963151865;5263.684178949237;5289.1801770725215;3702.074481379655;3702.9074273142846;3711.350513660099;3713.9814300928865;3718.7025037996896;3667.211549516867;3765.642263984917;3785.37541305687;3788.5453745550712;3803.220339830328;4218.578142185818;4260.382244574519;4271.081717430768;4277.8288868444915;4294.742315461082;5045.445001049881;5052.520010599061;5060.3168572242275;5064.772085256172;5079.466656001141;1215.6899990502366;1244.3591550351575;1252.9099683275608;1290.348374071088;1304.660788195076;830.4394533689735;851.8211175653182;866.6923242248911;886.4504007515382;888.657866721304;4450.376947227391;4460.687751857404;4478.6864919455975;4508.661850361236;4513.345564893072;5148.845534633967;5164.786275225319;5166.948330516647;5167.328247327899;5208.218767184952;4342.283523218697;4516.16450956574;4518.367428560005;4522.773861306921;4524.8416305429155;2731.7814574833965;2755.338718707496;2782.582612608125;2784.5127102756937;2791.553351463756;4972.781668491243;4974.452810190876;4991.725455100004;4992.825251116194;4996.775145118479;5162.9741851291255;5345.1447768356875;5365.839024829262;5387.649802762808;5405.162199859028;4996.800127994912;5008.17365134756;5017.67385119966;5020.196768517019;5030.949690503048;5261.079705907393;5293.2589437479555;5300.893982120258;5302.549283310962;5304.787808487617;4959.330490383896;5182.792688292426;5203.765830537711;5225.092841113043;5233.555147812326;5023.271625614192;5029.321041659476;5034.974825125997;5047.6214283929585;5049.4094360276395;3755.661990420875;3780.5085338905765;3786.6935907112;3789.9431508527946;3793.260314238697;4837.661363704648;4942.935380064383;5237.895242095213;5326.9200961984825;5331.866703332447;4987.47631498702;4990.775415106256;5012.649114561946;5020.598352131748;5037.143685573388;5079.847604571869;5087.694738315713;5095.592352611708;5103.540681338697;5148.562372198256;4922.335484709519;4960.652754307164;5020.246962955586;5046.041252162077;5060.1650727631;5083.212102124176;5101.719405432588;5104.642675012714;5121.7695203715175;5125.641704948117;4987.301777751045;4993.251012348177;4996.101481437031;5016.698998060128;5021.573166280907 07:56:36 INFO - PROCESS | 16250 | |5;yui.html;573.166043406843;579.503056283242;594.4204400709307;603.3634515586058;633.6039975015615;11153.498092585833;11990.700232494191;12265.816012759815;12314.199577027486;12590.748185036316;12183.634490965285;12560.057995650317;12567.183133096343;12584.433700483478;12597;628.1143587541567;758.9506682065676;779.867422538167;786.7639708087579;787.7991112266365;741.329097167062;756.6670664907423;757.3221966340122;760.3385055002155;765.3915137465729;815.0260438775636;815.4780940198278;817.4032955942166;818.3085292927467;818.5293456262643;657.4608820766973;809.0049239435527;810.2586133687698;810.5055915891302;810.8580998325269;576.6079066234959;585.1865906390121;585.3034888482734;592.1325258496323;595.3926994465664;11579.073674106052;11600.593979210687;11645.417729113595;11666.241694289844;11695.649130526097;11516.251443656136;11757.35334556599;11940.223885447418;11972;12388.504459821595;11410.20128590999;11516.193866429354;11618.128640352008;11630.941845290805;12127.757444851142;3950.328444164499;3989.1822176453757;4021.8994525136814;4032.193561287725;4094.9176835944654;60605.6969715153;61680.38319616791;61697;63116.36883631151;63187.36812631907;9438.150566448916;9702.951485242529;9746.75633109178;9762.414255144715;9890.901090988998;17873.821261787474;17905.552361191076;17912.820871791115;17920.103994800207;17931.910340448216;6387.840303992344;6405.327440618761;6425.228972523327;6518.543701940914;6679.532432729662;3370.275390790992;3507.438809790421;3518.648135186461;3545.3972824619877;3628.63713628635;2667.3465001074474;2730.5358089124898;2767.7785777138183;2768.224897028835;2782.2070709848;470.2194357366823;472.8935989402357;473.3562355196929;483.04598418123925;487.88046928502035;487.1256095308929;523.1368242399994;536.1876756713582;568.3322096536554;575.2579172867038;7780.572068536285;8042.638081286356;8096.595170241464;8159.388045896581;8370.497770133812;552.9060059789846;562.3252097482955;576.3516044449993;579.7333226715758;594.6937327276456;3529.0945585635986;3663.9740872555726;3848.6728628066926;3888.16404473034;3952.3083460394314;92538;94726.52636736773;95597.52201239088;97655;98597;81854.18145818466;82200;82737;84162.15837841544;85527;74006.6299668509;74687.62656186684;75066;76181.61909190529;76711;7381.557106573623;7416.7033318666645;7561.848763024819;7710.190430004769;7823;44427;44668.14247537011;44749.32876006928;44920.32619510775;46157;36110.638893610725;36622.450663240605;38322.42516362313;42054.1589168221;42247.788761056;9658.75853103678;9726.902730972599;9738.123568878835;9759.853602195832;9829.508524573599;10162.339447935861;10344.948275258575;10498;10513.369197848153;10558.155347572329;9894.950525247328;10284.742881428025;10290.536925838205;10358.171346292127;10680.145588352758;9631.277654175825;9867.506624668882;10069.496525173858;10349.275550711378;10632.84050739224;10070.8489372658;10140.847887281845;10200;10294.691159265234;10334.224933129895;7916.881246781418;7982.361411086983;7996.800079998046;8352.624131913957;8373.455725377831;7834.67854160862;7854.528728276322;8146.144654811396;8454.704085356983;8608.741737747878 07:56:36 INFO - PROCESS | 16250 | __end_tp_report 07:56:36 INFO - PROCESS | 16250 | __start_cc_report 07:56:36 INFO - PROCESS | 16250 | _x_x_mozilla_cycle_collect,1076 07:56:36 INFO - PROCESS | 16250 | __end_cc_report 07:56:36 INFO - PROCESS | 16250 | __startTimestamp1469890596803__endTimestamp 07:56:36 INFO - PROCESS | 16250 | 07:56:36 INFO - PROCESS | 16250 | ------- Summary: start ------- 07:56:36 INFO - PROCESS | 16250 | Number of tests: 6 07:56:36 INFO - PROCESS | 16250 | 07:56:36 INFO - PROCESS | 16250 | [#0] dojo.html Cycles:165 Average:4751.64 Median:4874.71 stddev:491.18 (10.1%) stddev-sans-first:464.84 07:56:36 INFO - PROCESS | 16250 | Values: 2673.2 2674.0 2695.9 2708.1 2712.3 4716.6 4743.6 4800.8 4856.0 4883.0 4795.1 4796.7 4842.2 4847.1 4853.7 4345.0 4396.8 4416.1 4469.8 4539.4 4443.2 4478.7 4488.1 4503.3 4508.3 4266.7 4298.7 4299.3 4370.4 4417.1 4340.4 4352.8 4358.6 4398.2 4411.0 4387.9 4392.6 4393.9 4423.2 4425.7 4648.7 4791.6 4803.8 4807.2 4852.8 5166.8 5201.2 5203.0 5252.5 5254.3 5167.3 5267.7 5279.8 5286.9 5288.2 4653.3 4751.7 4776.8 4864.5 4925.0 5206.4 5228.0 5289.3 5295.7 5305.2 5032.3 5076.4 5082.5 5084.3 5085.6 4980.3 5118.7 5119.1 5137.5 5172.2 5122.4 5124.7 5127.7 5136.6 5169.3 5114.4 5130.3 5130.7 5138.7 5180.1 4309.3 4350.0 4392.9 4451.9 4497.8 3829.2 3833.9 3876.7 3909.9 3937.6 4462.0 4469.8 4475.3 4480.2 4521.7 4999.3 5042.7 5144.2 5154.8 5203.2 4435.6 4459.4 4478.7 4497.4 4503.8 4685.0 4690.0 4697.7 4711.3 4746.9 4763.1 4837.8 4898.7 4902.2 4950.2 5121.8 5128.5 5151.2 5172.7 5215.1 4882.4 4882.8 4888.4 4901.8 4938.6 4904.9 5071.5 5085.5 5092.4 5092.4 4989.6 5020.8 5037.2 5060.1 5083.4 4851.2 4855.5 4861.8 4867.8 4912.1 4787.1 4899.5 4919.1 4923.7 4974.2 4872.0 4874.7 4935.3 4967.8 4999.2 5039.5 5042.1 5043.8 5045.4 5080.4 4726.6 4892.3 4909.6 4911.3 4951.9 07:56:36 INFO - PROCESS | 16250 | 07:56:36 INFO - PROCESS | 16250 | [#1] ext.html Cycles:180 Average:41033.49 Median:33608.66 stddev:65803.04 (195.8%) stddev-sans-first:65917.52 07:56:36 INFO - PROCESS | 16250 | Values: 574.2 589.4 594.0 597.5 597.9 27492.6 39793.8 41137.4 41184.4 44443.6 41022.0 41514.4 41527.0 41574.6 41579.4 7448.5 7802.6 7942.6 7947.0 7952.0 9668.2 9901.3 9911.2 10236.7 10251.3 10082.1 10190.9 10191.6 10196.6 10199.7 10092.2 10149.8 10150.2 10161.7 10164.9 9668.9 9681.6 9771.5 9781.5 9786.4 39118.6 39617.2 39644.8 39663.2 39726.0 2902.8 2988.1 3002.3 3160.7 3291.3 29778.6 30146.8 30183.4 30247.8 30755.1 2787.6 2902.8 2914.9 2922.3 2961.2 246487.0 246989.0 247008.8 248032.0 248964.0 31691.5 54560.5 54826.0 54956.7 54979.0 34095.0 34133.5 34201.7 34202.3 34227.5 12788.2 12830.4 12838.7 12857.5 12912.9 9913.0 11005.4 11044.1 11108.9 11366.8 7898.8 7905.5 7948.3 8013.6 8027.2 3062.8 3103.2 3138.9 3145.7 3148.9 857.4 874.5 875.1 886.7 915.6 27738.9 28439.6 28451.9 28738.6 28880.3 955.4 969.5 977.8 996.7 1053.0 14436.6 15264.6 15386.8 15395.4 15522.3 193268.0 193314.0 193962.0 194326.0 194521.0 49518.5 49932.0 50006.7 50092.7 50171.5 1061.5 1111.8 1152.3 1175.8 1204.7 26233.9 29584.0 29799.7 30448.0 30463.9 43861.6 44427.3 44445.0 44467.6 44480.0 301085.0 302533.0 302556.0 303624.0 304101.0 25404.7 26108.1 26428.1 26487.0 27581.4 42103.6 42629.0 42714.1 42764.0 43556.8 35893.0 36313.8 36380.8 36957.7 37220.6 36283.6 37156.3 37322.4 37860.2 37904.0 36554.5 36586.6 36689.6 36866.4 36913.4 31979.5 33472.7 33744.7 33763.0 34268.8 25676.8 25699.9 26030.9 26077.6 26406.6 07:56:36 INFO - PROCESS | 16250 | 07:56:36 INFO - PROCESS | 16250 | [#2] jquery.html Cycles:180 Average:25657.15 Median:4389.14 stddev:70646.15 (1609.6%) stddev-sans-first:70818.78 07:56:36 INFO - PROCESS | 16250 | Values: 352.8 376.9 377.1 378.7 389.1 12849.3 16354.8 16605.9 16686.2 17710.1 16969.8 17090.9 17585.6 17718.7 17858.6 5028.2 5034.0 5273.3 5307.3 5343.9 3439.6 5092.3 5352.5 5381.8 5388.3 5334.6 5358.1 5358.2 5363.2 5392.6 5337.1 5344.1 5344.6 6128.5 6166.8 5462.6 5468.3 5472.8 5480.1 5486.3 11649.9 18964.9 19694.6 19773.8 20317.1 1798.6 1895.3 1903.1 1983.2 2043.4 8562.4 8688.6 8787.4 9266.4 9570.3 1579.5 1668.0 1674.4 1713.6 1755.1 67657.3 69125.0 69163.3 70121.0 71728.6 9130.8 9415.6 9544.6 9816.2 10393.9 13739.9 13802.7 14103.4 14131.9 14147.8 7410.4 7619.7 7640.4 7708.7 7733.7 7233.0 7296.8 7370.6 7473.8 7489.0 3986.8 4082.9 4373.3 4405.0 4489.5 1821.3 1829.6 1832.0 1882.1 1898.7 821.0 858.7 875.1 877.8 886.4 16493.8 16682.6 17495.6 17615.9 18183.9 829.6 845.1 845.5 857.3 871.3 9618.0 9888.7 10152.0 10167.3 10312.4 419515.0 425640.0 431861.0 431979.0 432293.0 79713.0 81613.6 82995.0 83301.6 84534.2 890.8 906.9 935.7 943.9 948.2 15244.3 15483.6 15845.8 15874.0 16353.3 39101.4 39209.0 39283.6 40135.4 40285.6 49831.0 53354.2 53484.0 53896.7 55173.6 7528.9 7683.2 7731.4 7864.6 7922.0 11583.7 12044.7 12200.3 12764.0 12931.5 9783.6 10516.5 10537.4 10643.1 10700.2 9542.0 10010.0 10065.4 10247.3 10300.8 10117.1 10284.0 10517.3 10712.3 10829.7 6731.7 6836.3 6912.8 7154.4 8061.8 10584.2 10684.4 10976.7 11022.3 11124.9 07:56:36 INFO - PROCESS | 16250 | 07:56:36 INFO - PROCESS | 16250 | [#3] mootools.html Cycles:180 Average:5159.10 Median:5049.68 stddev:2943.62 (58.3%) stddev-sans-first:2937.10 07:56:36 INFO - PROCESS | 16250 | Values: 1234.6 1332.2 1407.1 1424.3 1681.8 6676.4 7754.3 7963.6 7975.6 8239.7 7987.2 8040.3 8068.0 8070.3 8080.2 2216.6 2252.5 2252.6 2256.3 2256.6 2205.9 2239.2 2255.0 2255.4 2257.4 2180.9 2189.5 2191.1 2194.2 2232.8 2129.5 2159.2 2160.8 2165.2 2167.0 2172.1 2174.0 2174.9 2178.2 2180.2 7800.3 8016.2 8034.5 8114.1 8115.6 4708.9 4842.5 4913.5 4914.4 4919.9 2835.4 2955.8 3002.3 3010.4 3051.6 904.4 904.9 920.2 927.3 936.5 10916.0 11180.1 11186.5 11189.7 11193.1 4353.5 4467.1 4570.5 4586.2 4600.0 8547.3 8706.7 8710.4 8715.8 8719.0 4868.5 4871.1 4872.4 4874.1 4880.5 3453.6 3799.9 3915.8 3927.9 4507.1 3437.9 3577.7 3583.9 3592.1 3626.7 1062.9 1078.5 1080.2 1087.5 1092.2 786.7 816.4 822.8 823.3 828.3 5134.6 5192.6 5280.3 5297.8 5347.1 387.2 387.6 392.9 396.8 399.8 3390.0 3596.8 3605.4 3622.2 3641.5 9288.3 9806.9 9807.2 9809.7 9822.5 9501.0 9635.6 9742.6 9758.9 9764.1 7364.3 7459.1 7461.4 7468.9 7472.6 5028.9 5070.4 5122.9 5131.1 5307.5 8847.1 8906.7 8954.8 9014.0 9043.8 8106.8 8877.3 9292.5 9369.7 9392.1 5487.7 6548.2 6568.0 6633.9 6672.8 7724.5 7760.1 7780.2 7780.5 7793.2 6871.6 7000.9 7011.0 7026.1 7081.6 6710.2 6723.1 6736.1 6743.7 6772.3 6139.1 6304.1 6318.3 6366.3 6392.2 4379.1 4387.7 4433.0 4481.9 4552.0 4296.8 4379.9 4380.3 4433.2 4496.9 07:56:36 INFO - PROCESS | 16250 | 07:56:36 INFO - PROCESS | 16250 | [#4] prototype.html Cycles:180 Average:4238.64 Median:4845.00 stddev:1226.67 (25.3%) stddev-sans-first:1193.95 07:56:36 INFO - PROCESS | 16250 | Values: 299.4 306.2 310.5 313.7 320.0 4736.7 4856.2 4884.9 4890.6 4913.8 4714.6 4814.4 4819.1 4836.3 4852.3 3853.5 3861.8 3862.0 3871.7 3882.0 3645.8 3663.8 3873.3 3884.2 3893.2 3808.9 3812.2 3847.5 3855.5 3875.8 3842.3 3843.2 3846.7 3847.6 3863.7 3402.4 3406.4 3418.8 3435.7 3447.3 4532.4 4716.3 4757.6 4775.8 4806.7 4358.6 4363.9 4374.2 4376.2 4379.8 5093.9 5106.9 5114.5 5135.7 5138.3 3445.5 3556.1 3587.8 3660.7 3679.5 5232.2 5250.8 5260.7 5263.7 5289.2 3702.1 3702.9 3711.4 3714.0 3718.7 3667.2 3765.6 3785.4 3788.5 3803.2 4218.6 4260.4 4271.1 4277.8 4294.7 5045.4 5052.5 5060.3 5064.8 5079.5 1215.7 1244.4 1252.9 1290.3 1304.7 830.4 851.8 866.7 886.5 888.7 4450.4 4460.7 4478.7 4508.7 4513.3 5148.8 5164.8 5166.9 5167.3 5208.2 4342.3 4516.2 4518.4 4522.8 4524.8 2731.8 2755.3 2782.6 2784.5 2791.6 4972.8 4974.5 4991.7 4992.8 4996.8 5163.0 5345.1 5365.8 5387.6 5405.2 4996.8 5008.2 5017.7 5020.2 5030.9 5261.1 5293.3 5300.9 5302.5 5304.8 4959.3 5182.8 5203.8 5225.1 5233.6 5023.3 5029.3 5035.0 5047.6 5049.4 3755.7 3780.5 3786.7 3789.9 3793.3 4837.7 4942.9 5237.9 5326.9 5331.9 4987.5 4990.8 5012.6 5020.6 5037.1 5079.8 5087.7 5095.6 5103.5 5148.6 4922.3 4960.7 5020.2 5046.0 5060.2 5083.2 5101.7 5104.6 5121.8 5125.6 4987.3 4993.3 4996.1 5016.7 5021.6 07:56:36 INFO - PROCESS | 16250 | 07:56:36 INFO - PROCESS | 16250 | [#5] yui.html Cycles:180 Average:16586.47 Median:576.48 stddev:24395.98 (4231.9%) stddev-sans-first:24434.78 07:56:36 INFO - PROCESS | 16250 | Values: 573.2 579.5 594.4 603.4 633.6 11153.5 11990.7 12265.8 12314.2 12590.7 12183.6 12560.1 12567.2 12584.4 12597.0 628.1 759.0 779.9 786.8 787.8 741.3 756.7 757.3 760.3 765.4 815.0 815.5 817.4 818.3 818.5 657.5 809.0 810.3 810.5 810.9 576.6 585.2 585.3 592.1 595.4 11579.1 11600.6 11645.4 11666.2 11695.6 11516.3 11757.4 11940.2 11972.0 12388.5 11410.2 11516.2 11618.1 11630.9 12127.8 3950.3 3989.2 4021.9 4032.2 4094.9 60605.7 61680.4 61697.0 63116.4 63187.4 9438.2 9703.0 9746.8 9762.4 9890.9 17873.8 17905.6 17912.8 17920.1 17931.9 6387.8 6405.3 6425.2 6518.5 6679.5 3370.3 3507.4 3518.6 3545.4 3628.6 2667.3 2730.5 2767.8 2768.2 2782.2 470.2 472.9 473.4 483.0 487.9 487.1 523.1 536.2 568.3 575.3 7780.6 8042.6 8096.6 8159.4 8370.5 552.9 562.3 576.4 579.7 594.7 3529.1 3664.0 3848.7 3888.2 3952.3 92538.0 94726.5 95597.5 97655.0 98597.0 81854.2 82200.0 82737.0 84162.2 85527.0 74006.6 74687.6 75066.0 76181.6 76711.0 7381.6 7416.7 7561.8 7710.2 7823.0 44427.0 44668.1 44749.3 44920.3 46157.0 36110.6 36622.5 38322.4 42054.2 42247.8 9658.8 9726.9 9738.1 9759.9 9829.5 10162.3 10344.9 10498.0 10513.4 10558.2 9895.0 10284.7 10290.5 10358.2 10680.1 9631.3 9867.5 10069.5 10349.3 10632.8 10070.8 10140.8 10200.0 10294.7 10334.2 7916.9 7982.4 7996.8 8352.6 8373.5 7834.7 7854.5 8146.1 8454.7 8608.7 07:56:36 INFO - PROCESS | 16250 | -------- Summary: end -------- 07:56:36 INFO - PROCESS | 16250 | 07:56:37 INFO - TEST-INFO | 16250: exit 0 07:56:37 INFO - TEST-OK | dromaeo_css | took 1120471ms 07:56:37 INFO - TEST-START | kraken 07:56:37 INFO - operating with platform_type : linux_ 07:56:37 INFO - Initialising browser for kraken test... 07:56:37 INFO - TEST-INFO | started process 16441 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXhugQ3/profile http://localhost:44421/getInfo.html) 07:56:42 INFO - PROCESS | 16441 | __metrics Screen width/height:1600/1200 07:56:42 INFO - PROCESS | 16441 | colorDepth:24 07:56:42 INFO - PROCESS | 16441 | Browser inner width/height: 1024/697 07:56:42 INFO - PROCESS | 16441 | __metrics 07:56:43 INFO - PROCESS | 16441 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:56:43 INFO - PROCESS | 16441 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:56:44 INFO - TEST-INFO | 16441: exit 0 07:56:44 INFO - Browser initialized. 07:56:44 INFO - Running cycle 1/1 for kraken test... 07:56:44 INFO - TEST-INFO | started process 16516 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXhugQ3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:56:56 INFO - PROCESS | 16516 | RSS: Main: 157270016 07:56:56 INFO - PROCESS | 16516 | 07:56:58 INFO - PROCESS | 16516 | Cycle 1(1): loaded http://localhost:44421/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44421/tests/kraken/driver.html?testName=audio-beat-detection) 07:56:59 INFO - PROCESS | 16516 | RSS: Main: 213815296 07:56:59 INFO - PROCESS | 16516 | 07:57:02 INFO - PROCESS | 16516 | Cycle 1(1): loaded http://localhost:44421/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44421/tests/kraken/driver.html?testName=audio-dft) 07:57:03 INFO - PROCESS | 16516 | RSS: Main: 191832064 07:57:03 INFO - PROCESS | 16516 | 07:57:06 INFO - PROCESS | 16516 | Cycle 1(1): loaded http://localhost:44421/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44421/tests/kraken/driver.html?testName=audio-fft) 07:57:07 INFO - PROCESS | 16516 | RSS: Main: 271732736 07:57:07 INFO - PROCESS | 16516 | 07:57:09 INFO - PROCESS | 16516 | Cycle 1(1): loaded http://localhost:44421/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44421/tests/kraken/driver.html?testName=audio-oscillator) 07:57:09 INFO - PROCESS | 16516 | RSS: Main: 180183040 07:57:09 INFO - PROCESS | 16516 | 07:57:12 INFO - PROCESS | 16516 | Cycle 1(1): loaded http://localhost:44421/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44421/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:57:12 INFO - PROCESS | 16516 | RSS: Main: 184848384 07:57:12 INFO - PROCESS | 16516 | 07:57:15 INFO - PROCESS | 16516 | Cycle 1(1): loaded http://localhost:44421/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44421/tests/kraken/driver.html?testName=imaging-darkroom) 07:57:16 INFO - PROCESS | 16516 | RSS: Main: 222003200 07:57:16 INFO - PROCESS | 16516 | 07:57:19 INFO - PROCESS | 16516 | Cycle 1(1): loaded http://localhost:44421/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44421/tests/kraken/driver.html?testName=imaging-desaturate) 07:57:20 INFO - PROCESS | 16516 | RSS: Main: 221704192 07:57:20 INFO - PROCESS | 16516 | 07:57:23 INFO - PROCESS | 16516 | Cycle 1(1): loaded http://localhost:44421/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44421/tests/kraken/driver.html?testName=json-parse-financial) 07:57:23 INFO - PROCESS | 16516 | RSS: Main: 221462528 07:57:23 INFO - PROCESS | 16516 | 07:57:25 INFO - PROCESS | 16516 | Cycle 1(1): loaded http://localhost:44421/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44421/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:57:26 INFO - PROCESS | 16516 | RSS: Main: 185847808 07:57:26 INFO - PROCESS | 16516 | 07:57:28 INFO - PROCESS | 16516 | Cycle 1(1): loaded http://localhost:44421/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44421/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:57:28 INFO - PROCESS | 16516 | RSS: Main: 191717376 07:57:28 INFO - PROCESS | 16516 | 07:57:30 INFO - PROCESS | 16516 | Cycle 1(1): loaded http://localhost:44421/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44421/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:57:31 INFO - PROCESS | 16516 | RSS: Main: 194998272 07:57:31 INFO - PROCESS | 16516 | 07:57:34 INFO - PROCESS | 16516 | Cycle 1(1): loaded http://localhost:44421/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44421/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:57:35 INFO - PROCESS | 16516 | RSS: Main: 196685824 07:57:35 INFO - PROCESS | 16516 | 07:57:37 INFO - PROCESS | 16516 | Cycle 1(1): loaded http://localhost:44421/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44421/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:57:38 INFO - PROCESS | 16516 | RSS: Main: 194121728 07:57:38 INFO - PROCESS | 16516 | 07:57:40 INFO - PROCESS | 16516 | Cycle 1(1): loaded http://localhost:44421/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44421/tests/kraken/driver.html?testName=ai-astar) 07:57:40 INFO - PROCESS | 16516 | RSS: Main: 244469760 07:57:40 INFO - PROCESS | 16516 | 07:57:40 INFO - PROCESS | 16516 | __start_tp_report 07:57:40 INFO - PROCESS | 16516 | _x_x_mozilla_page_load 07:57:40 INFO - PROCESS | 16516 | _x_x_mozilla_page_load_details 07:57:40 INFO - PROCESS | 16516 | |i|pagename|runs| 07:57:40 INFO - PROCESS | 16516 | |0;ai-astar;104;113;113;111;114;113;112;113;113;114 07:57:40 INFO - PROCESS | 16516 | |1;audio-beat-detection;151;121;127;181;124;154;155;129;177;123 07:57:40 INFO - PROCESS | 16516 | |2;audio-dft;162;161;160;160;161;162;164;162;159;162 07:57:40 INFO - PROCESS | 16516 | |3;audio-fft;75;77;75;125;76;77;76;76;113;76 07:57:40 INFO - PROCESS | 16516 | |4;audio-oscillator;86;84;117;85;85;84;114;84;85;136 07:57:40 INFO - PROCESS | 16516 | |5;imaging-gaussian-blur;116;117;117;117;118;116;117;117;117;117 07:57:40 INFO - PROCESS | 16516 | |6;imaging-darkroom;146;147;146;147;147;146;147;147;147;147 07:57:40 INFO - PROCESS | 16516 | |7;imaging-desaturate;95;95;95;95;95;95;95;96;96;95 07:57:40 INFO - PROCESS | 16516 | |8;json-parse-financial;63;62;61;61;61;61;63;61;62;61 07:57:40 INFO - PROCESS | 16516 | |9;json-stringify-tinderbox;66;66;65;66;66;66;66;66;66;65 07:57:40 INFO - PROCESS | 16516 | |10;stanford-crypto-aes;79;79;83;79;78;91;78;78;82;83 07:57:40 INFO - PROCESS | 16516 | |11;stanford-crypto-ccm;132;132;147;131;134;142;147;132;175;136 07:57:40 INFO - PROCESS | 16516 | |12;stanford-crypto-pbkdf2;164;172;165;165;162;164;165;168;167;161 07:57:40 INFO - PROCESS | 16516 | |13;stanford-crypto-sha256-iterative;67;66;67;67;67;66;71;66;66;65 07:57:40 INFO - PROCESS | 16516 | __end_tp_report 07:57:40 INFO - PROCESS | 16516 | __start_cc_report 07:57:40 INFO - PROCESS | 16516 | _x_x_mozilla_cycle_collect,1959 07:57:40 INFO - PROCESS | 16516 | __end_cc_report 07:57:40 INFO - PROCESS | 16516 | __startTimestamp1469890660465__endTimestamp 07:57:40 INFO - PROCESS | 16516 | 07:57:40 INFO - PROCESS | 16516 | ------- Summary: start ------- 07:57:40 INFO - PROCESS | 16516 | Number of tests: 14 07:57:40 INFO - PROCESS | 16516 | 07:57:40 INFO - PROCESS | 16516 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:2.94 (2.6%) stddev-sans-first:0.93 07:57:40 INFO - PROCESS | 16516 | Values: 104.0 113.0 113.0 111.0 114.0 113.0 112.0 113.0 113.0 114.0 07:57:40 INFO - PROCESS | 16516 | 07:57:40 INFO - PROCESS | 16516 | [#1] audio-beat-detection Cycles:10 Average:144.20 Median:152.50 stddev:22.64 (14.8%) stddev-sans-first:23.88 07:57:40 INFO - PROCESS | 16516 | Values: 151.0 121.0 127.0 181.0 124.0 154.0 155.0 129.0 177.0 123.0 07:57:40 INFO - PROCESS | 16516 | 07:57:40 INFO - PROCESS | 16516 | [#2] audio-dft Cycles:10 Average:161.30 Median:162.00 stddev:1.42 (0.9%) stddev-sans-first:1.48 07:57:40 INFO - PROCESS | 16516 | Values: 162.0 161.0 160.0 160.0 161.0 162.0 164.0 162.0 159.0 162.0 07:57:40 INFO - PROCESS | 16516 | 07:57:40 INFO - PROCESS | 16516 | [#3] audio-fft Cycles:10 Average:84.60 Median:76.00 stddev:18.36 (24.2%) stddev-sans-first:19.14 07:57:40 INFO - PROCESS | 16516 | Values: 75.0 77.0 75.0 125.0 76.0 77.0 76.0 76.0 113.0 76.0 07:57:40 INFO - PROCESS | 16516 | 07:57:40 INFO - PROCESS | 16516 | [#4] audio-oscillator Cycles:10 Average:96.00 Median:84.50 stddev:19.03 (22.5%) stddev-sans-first:19.84 07:57:40 INFO - PROCESS | 16516 | Values: 86.0 84.0 117.0 85.0 85.0 84.0 114.0 84.0 85.0 136.0 07:57:40 INFO - PROCESS | 16516 | 07:57:40 INFO - PROCESS | 16516 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 07:57:40 INFO - PROCESS | 16516 | Values: 116.0 117.0 117.0 117.0 118.0 116.0 117.0 117.0 117.0 117.0 07:57:40 INFO - PROCESS | 16516 | 07:57:40 INFO - PROCESS | 16516 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 07:57:40 INFO - PROCESS | 16516 | Values: 146.0 147.0 146.0 147.0 147.0 146.0 147.0 147.0 147.0 147.0 07:57:40 INFO - PROCESS | 16516 | 07:57:40 INFO - PROCESS | 16516 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:57:40 INFO - PROCESS | 16516 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 07:57:40 INFO - PROCESS | 16516 | 07:57:40 INFO - PROCESS | 16516 | [#8] json-parse-financial Cycles:10 Average:61.60 Median:61.50 stddev:0.84 (1.4%) stddev-sans-first:0.73 07:57:40 INFO - PROCESS | 16516 | Values: 63.0 62.0 61.0 61.0 61.0 61.0 63.0 61.0 62.0 61.0 07:57:40 INFO - PROCESS | 16516 | 07:57:40 INFO - PROCESS | 16516 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 07:57:40 INFO - PROCESS | 16516 | Values: 66.0 66.0 65.0 66.0 66.0 66.0 66.0 66.0 66.0 65.0 07:57:40 INFO - PROCESS | 16516 | 07:57:40 INFO - PROCESS | 16516 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:80.50 stddev:4.06 (5.0%) stddev-sans-first:4.24 07:57:40 INFO - PROCESS | 16516 | Values: 79.0 79.0 83.0 79.0 78.0 91.0 78.0 78.0 82.0 83.0 07:57:40 INFO - PROCESS | 16516 | 07:57:40 INFO - PROCESS | 16516 | [#11] stanford-crypto-ccm Cycles:10 Average:140.80 Median:139.00 stddev:13.52 (9.7%) stddev-sans-first:13.96 07:57:40 INFO - PROCESS | 16516 | Values: 132.0 132.0 147.0 131.0 134.0 142.0 147.0 132.0 175.0 136.0 07:57:40 INFO - PROCESS | 16516 | 07:57:40 INFO - PROCESS | 16516 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.30 Median:165.00 stddev:3.13 (1.9%) stddev-sans-first:3.28 07:57:40 INFO - PROCESS | 16516 | Values: 164.0 172.0 165.0 165.0 162.0 164.0 165.0 168.0 167.0 161.0 07:57:40 INFO - PROCESS | 16516 | 07:57:40 INFO - PROCESS | 16516 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.62 (2.4%) stddev-sans-first:1.72 07:57:40 INFO - PROCESS | 16516 | Values: 67.0 66.0 67.0 67.0 67.0 66.0 71.0 66.0 66.0 65.0 07:57:40 INFO - PROCESS | 16516 | -------- Summary: end -------- 07:57:40 INFO - PROCESS | 16516 | 07:57:41 INFO - TEST-INFO | 16516: exit 0 07:57:41 INFO - TEST-OK | kraken | took 64063ms 07:57:41 INFO - SUITE-END | took 1184s 07:57:42 INFO - Completed test suite (00:19:44) 07:57:42 INFO - javascript benchmark 07:57:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2673.157955244098, 2673.9732602673967, 2695.8921643134267, 2708.0521817363915, 2712.3490362313037, 4716.575508204261, 4743.644226683, 4800.8319708810195, 4856.0, 4882.975585122073, 4795.088933102708, 4796.736179510134, 4842.152623290927, 4847.079054979551, 4853.733044682541, 4344.97827510862, 4396.758178300192, 4416.094700586388, 4469.776511174445, 4539.387182730338, 4443.155800397914, 4478.664100192483, 4488.147252022105, 4503.301988191835, 4508.301213311942, 4266.679999000056, 4298.656107511391, 4299.333603291495, 4370.38814565961, 4417.072414792898, 4340.392345071693, 4352.825886964518, 4358.607725304738, 4398.208322501949, 4410.977945110286, 4387.934180987288, 4392.604665580081, 4393.912121757547, 4423.248047831844, 4425.690201685883, 4648.74431906245, 4791.6406269529925, 4803.831865884712, 4807.206810876201, 4852.757362131879, 5166.793328266865, 5201.219817027439, 5203.037438073969, 5252.501012403815, 5254.3169387979315, 5167.276581278624, 5267.683938963636, 5279.762410691528, 5286.9471305287225, 5288.206768984644, 4653.278741795028, 4751.667383283137, 4776.785044672998, 4864.537868902484, 4925.039617274597, 5206.427292997767, 5227.980543793924, 5289.285946397187, 5295.655782374133, 5305.151175811851, 5032.345795046694, 5076.416212135578, 5082.491750824888, 5084.288199652052, 5085.567726743194, 4980.252962055648, 5118.667286626357, 5119.10415677255, 5137.460566640524, 5172.19830926207, 5122.359705036871, 5124.743762811844, 5127.692338459704, 5136.614753893473, 5169.25045868347, 5114.360704911886, 5130.333056702605, 5130.7178105204575, 5138.717370544581, 5180.093483640348, 4309.310510318334, 4350.042990542076, 4392.868213953587, 4451.910961780811, 4497.820087196541, 3829.2341531693774, 3833.9041523961564, 3876.6511014008875, 3909.9413508797393, 3937.625925537069, 4461.977690111528, 4469.821207151743, 4475.328700694857, 4480.171168333869, 4521.683482156283, 4999.275105109738, 5042.747862606855, 5144.151215049475, 5154.768035438415, 5203.245529398216, 4435.556444355539, 4459.44256967879, 4478.6864919455975, 4497.370368148462, 4503.7522936238165, 4684.969306752509, 4689.976550117228, 4697.671163018625, 4711.3480352010465, 4746.928796068062, 4763.118823017753, 4837.782299796448, 4898.681585696918, 4902.240152776325, 4950.18321976877, 5121.79512819498, 5128.538431541179, 5151.175811870083, 5172.7155006475, 5215.113430716711, 4882.438519570295, 4882.829100981448, 4888.364512613338, 4901.779419926041, 4938.580220681282, 4904.877378065434, 5071.487182037359, 5085.46602606721, 5092.363454568179, 5092.388913330424, 4989.625778066732, 5020.849374518771, 5037.219231019198, 5060.063888180698, 5083.440821509705, 4851.199552073868, 4855.5387238212315, 4861.756912154449, 4867.780949857194, 4912.066707325596, 4787.138315103176, 4899.510048995215, 4919.114559379203, 4923.679960802537, 4974.154393752999, 4871.95128048715, 4874.707517548958, 4935.259711043373, 4967.801287948586, 4999.225120106389, 5039.470855560114, 5042.067217564762, 5043.823466178666, 5045.445001049955, 5080.441151473261, 4726.550977657117, 4892.315075889307, 4909.631777616764, 4911.312416261655, 4951.851444456672], "value": 4720.716489689823, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.1817909478992, 589.4135335341333, 593.9643621382718, 597.5189972072485, 597.910313452982, 27492.587611185823, 39793.801030994844, 41137.382939255935, 41184.382234266435, 44443.555564444345, 41022.0, 41514.377284340684, 41527.0, 41574.58425415745, 41579.376309355306, 7448.515846469989, 7802.648880800378, 7942.6425810838655, 7946.960265198666, 7952.0, 9668.226541876633, 9901.306908516406, 9911.207103431745, 10236.74408139795, 10251.282410231286, 10082.143017843455, 10190.949045254763, 10191.59233630654, 10196.643117490888, 10199.745006374862, 10092.24308176886, 10149.797004059878, 10150.18798496126, 10161.745956351077, 10164.949175254113, 9668.90331096687, 9681.612735490642, 9771.511424428822, 9781.510924453749, 9786.41281523111, 39118.60881391178, 39617.20765584701, 39644.801775991225, 39663.20673586541, 39726.0, 2902.7968042237053, 2988.13344130202, 3002.324476992659, 3160.668129846356, 3291.3417316536547, 29778.55332170019, 30146.84926575375, 30183.396332073455, 30247.848760756275, 30755.07734767938, 2787.5957986091903, 2902.8258304501796, 2914.9271268218254, 2922.284040410092, 2961.185673939684, 246486.9999999982, 246989.0, 247008.76495617587, 248032.0, 248964.0, 31691.524627130613, 54560.454395456334, 54826.0, 54956.72521637366, 54979.0, 34095.0, 34133.48799768005, 34201.657983420344, 34202.31595368079, 34227.486587701205, 12788.16876903017, 12830.358482075859, 12838.743225135446, 12857.549985750455, 12912.870871291354, 9913.0, 11005.394703291397, 11044.116470682326, 11108.888911110786, 11366.772664546663, 7898.802529936797, 7905.486143400775, 7948.324392426593, 8013.559254240956, 8027.197280272043, 3062.7856050076725, 3103.20868178613, 3138.8587513561943, 3145.7168854803176, 3148.889788857379, 857.3955361470148, 874.4796845876693, 875.1248751248751, 886.663068034143, 915.6108653822099, 27738.861305693343, 28439.573406398922, 28451.857740711162, 28738.568921466194, 28880.27799304992, 955.3790036476207, 969.5491596407704, 977.8093271812071, 996.740847379672, 1053.0469924718143, 14436.639084022983, 15264.618384540476, 15386.769198462032, 15395.384184632714, 15522.301496432689, 193268.0, 193314.0, 193962.0, 194326.0, 194521.0, 49518.50481495211, 49932.0, 50006.74996625067, 50092.749536252086, 50171.49828501741, 1061.4904845673966, 1111.7943180511631, 1152.2798251093068, 1175.8295047218105, 1204.6626944455566, 26233.868830656487, 29584.0, 29799.70200297969, 30448.0, 30463.88737520495, 43861.56138438702, 44427.33358999682, 44445.0, 44467.555324446344, 44480.0, 301085.0, 302533.0, 302556.0, 303624.0, 304101.0, 25404.745952540237, 26108.086216982316, 26428.0750173743, 26487.0, 27581.448371032067, 42103.57896421119, 42629.0, 42714.1457170861, 42764.0, 43556.782216088715, 35893.0, 36313.818430907675, 36380.81809590935, 36957.673809357286, 37220.62779372172, 36283.637163628024, 37156.25687486289, 37322.44016339703, 37860.24279514449, 37904.0, 36554.451683224244, 36586.63413365832, 36689.633103668624, 36866.44700329444, 36913.44629830501, 31979.520307195875, 33472.66527334695, 33744.662553375136, 33763.0, 34268.82865585656, 25676.817470515216, 25699.871500642377, 26030.86984565065, 26077.608835867097, 26406.603900941886], "value": 16656.063051988753, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.7918528068439, 376.9076576238822, 377.0611178166365, 378.7178551978776, 389.0584784820733, 12849.29328886912, 16354.754678679814, 16605.916970415146, 16686.249118789652, 17710.114494275265, 16969.83030169698, 17090.914545427255, 17585.64828703425, 17718.734218986727, 17858.553536161602, 5028.245763135532, 5034.0, 5273.314469119028, 5307.336582927134, 5343.893122137555, 3439.570053743282, 5092.312537807404, 5352.5182733553975, 5381.838544843661, 5388.299521062257, 5334.626576139672, 5358.089124848766, 5358.223057656637, 5363.195520671891, 5392.56859451245, 5337.14605663094, 5344.14493681013, 5344.572434205294, 6128.509719222451, 6166.784162554334, 5462.562994960434, 5468.26178465906, 5472.808451704172, 5480.068388373986, 5486.341639003345, 11649.88350116505, 18964.905175474174, 19694.606107877764, 19773.80226197734, 20317.085731142135, 1798.6043070524463, 1895.2797936783934, 1903.1055403960254, 1983.1931100707009, 2043.4074118505616, 8562.400631955765, 8688.565571721389, 8787.42881712693, 9266.397684150508, 9570.330076894621, 1579.5024567261275, 1668.0, 1674.3637417781288, 1713.6058706497452, 1755.1399814091003, 67657.3234267656, 69125.0, 69163.3083669167, 70121.0, 71728.6413567934, 9130.817383652422, 9415.623375065057, 9544.618215271312, 9816.165625921734, 10393.948030259951, 13739.862601374058, 13802.723945521033, 14103.435862565588, 14131.85868141326, 14147.787783183261, 7410.407167426701, 7619.733309334258, 7640.426967977424, 7708.691652333956, 7733.651985660659, 7233.0, 7296.7810965671115, 7370.631468426557, 7473.775786726407, 7489.0, 3986.8405263789705, 4082.9381162513337, 4373.300271956472, 4404.986853023823, 4489.461264648263, 1821.298799962024, 1829.6249268899844, 1831.9772375580133, 1882.1436246507806, 1898.7436696045856, 820.9507429554246, 858.733792524307, 875.0986483921571, 877.7761670773912, 886.4371124336093, 16493.752593711102, 16682.582935426468, 17495.562610934572, 17615.911920440572, 18183.908965462113, 829.5769157729601, 845.1464021338493, 845.5287799229419, 857.3055824781821, 871.3203701113142, 9618.0, 9888.653897113567, 10152.0, 10167.339122956984, 10312.381257124447, 419515.0, 425640.0, 431861.0, 431979.0, 432293.0, 79713.0, 81613.59193203996, 82995.0, 83301.58349208336, 84534.15465845262, 890.7862113092812, 906.8549032154824, 935.6771913689767, 943.9056094390643, 948.170350942925, 15244.31400586954, 15483.612909676898, 15845.841541584437, 15874.0, 16353.26410311515, 39101.41347879727, 39209.0, 39283.607163928, 40135.3979690299, 40285.59714402819, 49831.0, 53354.19968700395, 53484.0, 53896.73051634717, 55173.62065948384, 7528.887066693895, 7683.231676832272, 7731.38148948094, 7864.567448790372, 7921.960390198243, 11583.6524904253, 12044.73530279308, 12200.328981906081, 12764.0, 12931.5473958411, 9783.60865565398, 10516.474176291307, 10537.42044187577, 10643.095336896451, 10700.197485188486, 9542.0, 10010.0, 10065.396076235449, 10247.282690211614, 10300.845487317845, 10117.140043096419, 10284.0, 10517.316374435637, 10712.303700259457, 10829.67510974672, 6731.730730770714, 6836.28219036994, 6912.792616221522, 7154.35610795031, 8061.758147255592, 10584.206184536037, 10684.397340399002, 10976.725581860517, 11022.283551569122, 11124.944375278072], "value": 8276.74617134645, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1234.5679012345674, 1332.1607387345973, 1407.1416435974056, 1424.2665027510827, 1681.8150003499613, 6676.399124078832, 7754.302112809853, 7963.562004089773, 7975.601219938994, 8239.670413183481, 7987.161348058457, 8040.316573091294, 8068.031836179652, 8070.314023308011, 8080.232377924102, 2216.5788500184954, 2252.4706693926914, 2252.6395776675736, 2256.255435706213, 2256.593813113639, 2205.9448513787124, 2239.193890199527, 2254.9774502255013, 2255.364860476158, 2257.4243567890167, 2180.90185941633, 2189.4526368407896, 2191.1016483241874, 2194.2100843696257, 2232.787885150908, 2129.4569884679463, 2159.201095594632, 2160.8163306119, 2165.177232651598, 2167.0464995402053, 2172.076867331378, 2174.0325555127974, 2174.934751957444, 2178.2485042660255, 2180.2369170790257, 7800.297973182441, 8016.198380161995, 8034.47775894565, 8114.066882308551, 8115.634796434116, 4708.858734237979, 4842.515748425165, 4913.484084171147, 4914.3611330527165, 4919.926201106986, 2835.4470878178763, 2955.807872488281, 3002.3394853132277, 3010.3527741535454, 3051.5727798108283, 904.4076130134772, 904.8687940248693, 920.2132176988712, 927.2798957933005, 936.4662142578733, 10916.0, 11180.105591552656, 11186.496607652674, 11189.720256993558, 11193.10455163585, 4353.499347575006, 4467.084247729208, 4570.54294570547, 4586.151561960981, 4600.0, 8547.316214702809, 8706.738797836075, 8710.390272680977, 8715.825683486295, 8719.0, 4868.513148685103, 4871.050145221719, 4872.366592342973, 4874.147024270738, 4880.463149053601, 3453.568303962005, 3799.886003419902, 3915.804209789499, 3927.9214415711526, 4507.143642707941, 3437.914052148716, 3577.713782897362, 3583.94624080639, 3592.1199306169633, 3626.7279954003557, 1062.8565143705655, 1078.4769386847372, 1080.173667144635, 1087.4617064553097, 1092.159037541089, 786.7364432915037, 816.3673153306236, 822.8354329134197, 823.2714048067503, 828.329053466694, 5134.640575159778, 5192.584593232608, 5280.313559237275, 5297.761600727977, 5347.0909945309395, 387.24873744934735, 387.55818367061573, 392.8958825911136, 396.79961619382027, 399.76813448199977, 3390.0, 3596.7841929484316, 3605.387084195693, 3622.239329740784, 3641.5083963664565, 9288.256939444827, 9806.90193098074, 9807.215422766161, 9809.656662016796, 9822.459764712867, 9500.95249523748, 9635.614575417045, 9742.61029558824, 9758.853617195748, 9764.072413120743, 7364.3003914628025, 7459.142198647117, 7461.365783908429, 7468.85062298751, 7472.589007604634, 5028.9245661315845, 5070.442251352274, 5122.923156152735, 5131.127708289525, 5307.4692530746615, 8847.071057539124, 8906.73279801607, 8954.776130596787, 9014.0, 9043.819123617623, 8106.797330066795, 8877.289816814768, 9292.488913109844, 9369.718908432758, 9392.060793920553, 5487.6981766003255, 6548.214214294315, 6567.9671601643595, 6633.9336606633315, 6672.799816005528, 7724.497907635986, 7760.068791745027, 7780.221977802401, 7780.49426787257, 7793.181715919747, 6871.553349032297, 7000.859982800417, 7011.0, 7026.051483049927, 7081.645917704197, 6710.16122984627, 6723.092382528296, 6736.056952026818, 6743.730250789913, 6772.288909664414, 6139.079138129317, 6304.05439184126, 6318.304986451579, 6366.29970703213, 6392.20097487814, 4379.146066517126, 4387.692861499664, 4433.0, 4481.910361792811, 4551.954480455153, 4296.806643701104, 4379.934300985424, 4380.3210502372185, 4433.179861725591, 4496.887577810581], "value": 4056.9518375970238, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.41464437025604, 306.1840195877985, 310.4752967484951, 313.69571515629843, 319.9504076868086, 4736.739479328636, 4856.198727210006, 4884.853454396365, 4890.559849613534, 4913.82801601944, 4714.599259062984, 4814.446338671045, 4819.1325561398935, 4836.2987366831785, 4852.344933433986, 3853.499045124144, 3861.8455261789495, 3861.9806900965455, 3871.6709079728257, 3881.9805900970455, 3645.8177091145335, 3663.7618554793853, 3873.3221686204943, 3884.242572698325, 3893.1629699614577, 3808.8666896658624, 3812.1803812180374, 3847.480590120326, 3855.51806024247, 3875.8255878485393, 3842.346801043829, 3843.1737176507186, 3846.7307288489815, 3847.5960024197334, 3863.652271295583, 3402.3705614461155, 3406.4379377402697, 3418.777779444328, 3435.7251419886347, 3447.2588393495266, 4532.410786597721, 4716.316134160527, 4757.643176761722, 4775.832845850378, 4806.735629540374, 4358.629516491102, 4363.890902727426, 4374.234508960919, 4376.227627810742, 4379.75911324877, 5093.898122037575, 5106.897862042775, 5114.462981386975, 5135.666181698215, 5138.332016837787, 3445.4659527773233, 3556.146524834047, 3587.802670853102, 3660.7437479376454, 3679.4848721179055, 5232.162853943389, 5250.81622143227, 5260.736963151865, 5263.684178949237, 5289.1801770725215, 3702.074481379655, 3702.9074273142846, 3711.350513660099, 3713.9814300928865, 3718.7025037996896, 3667.211549516867, 3765.642263984917, 3785.37541305687, 3788.5453745550712, 3803.220339830328, 4218.578142185818, 4260.382244574519, 4271.081717430768, 4277.8288868444915, 4294.742315461082, 5045.445001049881, 5052.520010599061, 5060.3168572242275, 5064.772085256172, 5079.466656001141, 1215.6899990502366, 1244.3591550351575, 1252.9099683275608, 1290.348374071088, 1304.660788195076, 830.4394533689735, 851.8211175653182, 866.6923242248911, 886.4504007515382, 888.657866721304, 4450.376947227391, 4460.687751857404, 4478.6864919455975, 4508.661850361236, 4513.345564893072, 5148.845534633967, 5164.786275225319, 5166.948330516647, 5167.328247327899, 5208.218767184952, 4342.283523218697, 4516.16450956574, 4518.367428560005, 4522.773861306921, 4524.8416305429155, 2731.7814574833965, 2755.338718707496, 2782.582612608125, 2784.5127102756937, 2791.553351463756, 4972.781668491243, 4974.452810190876, 4991.725455100004, 4992.825251116194, 4996.775145118479, 5162.9741851291255, 5345.1447768356875, 5365.839024829262, 5387.649802762808, 5405.162199859028, 4996.800127994912, 5008.17365134756, 5017.67385119966, 5020.196768517019, 5030.949690503048, 5261.079705907393, 5293.2589437479555, 5300.893982120258, 5302.549283310962, 5304.787808487617, 4959.330490383896, 5182.792688292426, 5203.765830537711, 5225.092841113043, 5233.555147812326, 5023.271625614192, 5029.321041659476, 5034.974825125997, 5047.6214283929585, 5049.4094360276395, 3755.661990420875, 3780.5085338905765, 3786.6935907112, 3789.9431508527946, 3793.260314238697, 4837.661363704648, 4942.935380064383, 5237.895242095213, 5326.9200961984825, 5331.866703332447, 4987.47631498702, 4990.775415106256, 5012.649114561946, 5020.598352131748, 5037.143685573388, 5079.847604571869, 5087.694738315713, 5095.592352611708, 5103.540681338697, 5148.562372198256, 4922.335484709519, 4960.652754307164, 5020.246962955586, 5046.041252162077, 5060.1650727631, 5083.212102124176, 5101.719405432588, 5104.642675012714, 5121.7695203715175, 5125.641704948117, 4987.301777751045, 4993.251012348177, 4996.101481437031, 5016.698998060128, 5021.573166280907], "value": 3848.804826572489, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.166043406843, 579.503056283242, 594.4204400709307, 603.3634515586058, 633.6039975015615, 11153.498092585833, 11990.700232494191, 12265.816012759815, 12314.199577027486, 12590.748185036316, 12183.634490965285, 12560.057995650317, 12567.183133096343, 12584.433700483478, 12597.0, 628.1143587541567, 758.9506682065676, 779.867422538167, 786.7639708087579, 787.7991112266365, 741.329097167062, 756.6670664907423, 757.3221966340122, 760.3385055002155, 765.3915137465729, 815.0260438775636, 815.4780940198278, 817.4032955942166, 818.3085292927467, 818.5293456262643, 657.4608820766973, 809.0049239435527, 810.2586133687698, 810.5055915891302, 810.8580998325269, 576.6079066234959, 585.1865906390121, 585.3034888482734, 592.1325258496323, 595.3926994465664, 11579.073674106052, 11600.593979210687, 11645.417729113595, 11666.241694289844, 11695.649130526097, 11516.251443656136, 11757.35334556599, 11940.223885447418, 11972.0, 12388.504459821595, 11410.20128590999, 11516.193866429354, 11618.128640352008, 11630.941845290805, 12127.757444851142, 3950.328444164499, 3989.1822176453757, 4021.8994525136814, 4032.193561287725, 4094.9176835944654, 60605.6969715153, 61680.38319616791, 61697.0, 63116.36883631151, 63187.36812631907, 9438.150566448916, 9702.951485242529, 9746.75633109178, 9762.414255144715, 9890.901090988998, 17873.821261787474, 17905.552361191076, 17912.820871791115, 17920.103994800207, 17931.910340448216, 6387.840303992344, 6405.327440618761, 6425.228972523327, 6518.543701940914, 6679.532432729662, 3370.275390790992, 3507.438809790421, 3518.648135186461, 3545.3972824619877, 3628.63713628635, 2667.3465001074474, 2730.5358089124898, 2767.7785777138183, 2768.224897028835, 2782.2070709848, 470.2194357366823, 472.8935989402357, 473.3562355196929, 483.04598418123925, 487.88046928502035, 487.1256095308929, 523.1368242399994, 536.1876756713582, 568.3322096536554, 575.2579172867038, 7780.572068536285, 8042.638081286356, 8096.595170241464, 8159.388045896581, 8370.497770133812, 552.9060059789846, 562.3252097482955, 576.3516044449993, 579.7333226715758, 594.6937327276456, 3529.0945585635986, 3663.9740872555726, 3848.6728628066926, 3888.16404473034, 3952.3083460394314, 92538.0, 94726.52636736773, 95597.52201239088, 97655.0, 98597.0, 81854.18145818466, 82200.0, 82737.0, 84162.15837841544, 85527.0, 74006.6299668509, 74687.62656186684, 75066.0, 76181.61909190529, 76711.0, 7381.557106573623, 7416.7033318666645, 7561.848763024819, 7710.190430004769, 7823.0, 44427.0, 44668.14247537011, 44749.32876006928, 44920.32619510775, 46157.0, 36110.638893610725, 36622.450663240605, 38322.42516362313, 42054.1589168221, 42247.788761056, 9658.75853103678, 9726.902730972599, 9738.123568878835, 9759.853602195832, 9829.508524573599, 10162.339447935861, 10344.948275258575, 10498.0, 10513.369197848153, 10558.155347572329, 9894.950525247328, 10284.742881428025, 10290.536925838205, 10358.171346292127, 10680.145588352758, 9631.277654175825, 9867.506624668882, 10069.496525173858, 10349.275550711378, 10632.84050739224, 10070.8489372658, 10140.847887281845, 10200.0, 10294.691159265234, 10334.224933129895, 7916.881246781418, 7982.361411086983, 7996.800079998046, 8352.624131913957, 8373.455725377831, 7834.67854160862, 7854.528728276322, 8146.144654811396, 8454.704085356983, 8608.741737747878], "value": 6125.8999160403155, "unit": "score"}], "name": "dromaeo_css", "value": 6295.5038235956545, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 113.0, 111.0, 114.0, 113.0, 112.0, 113.0, 113.0, 114.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 121.0, 127.0, 181.0, 124.0, 154.0, 155.0, 129.0, 177.0, 123.0], "value": 144.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 160.0, 160.0, 161.0, 162.0, 164.0, 162.0, 159.0, 162.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 75.0, 125.0, 76.0, 77.0, 76.0, 76.0, 113.0, 76.0], "value": 84.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 117.0, 85.0, 85.0, 84.0, 114.0, 84.0, 85.0, 136.0], "value": 96.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 118.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 61.0, 61.0, 61.0, 61.0, 63.0, 61.0, 62.0, 61.0], "value": 61.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 65.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 83.0, 79.0, 78.0, 91.0, 78.0, 78.0, 82.0, 83.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 132.0, 147.0, 131.0, 134.0, 142.0, 147.0, 132.0, 175.0, 136.0], "value": 140.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 172.0, 165.0, 165.0, 162.0, 164.0, 165.0, 168.0, 167.0, 161.0], "value": 165.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 67.0, 67.0, 66.0, 71.0, 66.0, 66.0, 65.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1538.2, "alertThreshold": 2.0}]} 07:57:42 INFO - Return code: 0 07:57:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:57:42 INFO - # TBPL SUCCESS # 07:57:42 INFO - Running post-action listener: _resource_record_post_action 07:57:42 INFO - [mozharness: 2016-07-30 14:57:42.249443Z] Finished run-tests step (success) 07:57:42 INFO - Running post-run listener: _resource_record_post_run 07:57:42 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 12288; Write bytes: 532451328; Read time: 200; Write time: 428848 07:57:42 INFO - TinderboxPrint: CPU usage
13.0% 07:57:42 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 200 07:57:42 INFO - TinderboxPrint: I/O write bytes / time
532,451,328 / 428,848 07:57:42 INFO - TinderboxPrint: CPU idle
8,341.0 (87.0%) 07:57:42 INFO - TinderboxPrint: CPU user
1,198.4 (12.5%) 07:57:42 INFO - TinderboxPrint: Swap in / out
0 / 0 07:57:42 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 245719040; Read time: 104; Write time: 252740 07:57:42 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 282234880; Read time: 84; Write time: 175696 07:57:42 INFO - Running post-run listener: _upload_blobber_files 07:57:42 INFO - Blob upload gear active. 07:57:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:57:42 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:57:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:57:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:57:43 INFO - (blobuploader) - INFO - Open directory for files ... 07:57:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:57:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:57:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:57:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:57:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:57:44 INFO - (blobuploader) - INFO - Done attempting. 07:57:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:57:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:57:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:57:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:57:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:57:47 INFO - (blobuploader) - INFO - Done attempting. 07:57:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:57:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:57:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:57:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:57:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:57:48 INFO - (blobuploader) - INFO - Done attempting. 07:57:48 INFO - (blobuploader) - INFO - Iteration through files over. 07:57:48 INFO - Return code: 0 07:57:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:57:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:57:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b96aafd910d33224c1621783d2a3d9a5d62ac384175627dfecc4d5b722f336b1c8026732e58175e7ad802efa5faf8ce5313e86d1464c812f8ec3985c1fe2a798", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/80110f52293e4699bb38fcf961fb1c08c39084c25bf9c0cdb1a7e0b0816190592c61e255d43090118d3c5718da36df9f6fd310f1501f22c788ff49092910dfc5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f1ead321047d95596d076427d3333900e5899a7ee8595406aaa00391921ed5884f42bae9b2c229cf65a9f59f9e90050251bac16224f3f7dcc9752a5056a57d82"} 07:57:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:57:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:57:48 INFO - Contents: 07:57:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b96aafd910d33224c1621783d2a3d9a5d62ac384175627dfecc4d5b722f336b1c8026732e58175e7ad802efa5faf8ce5313e86d1464c812f8ec3985c1fe2a798", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/80110f52293e4699bb38fcf961fb1c08c39084c25bf9c0cdb1a7e0b0816190592c61e255d43090118d3c5718da36df9f6fd310f1501f22c788ff49092910dfc5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f1ead321047d95596d076427d3333900e5899a7ee8595406aaa00391921ed5884f42bae9b2c229cf65a9f59f9e90050251bac16224f3f7dcc9752a5056a57d82"} 07:57:48 INFO - Running post-run listener: copy_logs_to_upload_dir 07:57:48 INFO - Copying logs to upload dir... 07:57:48 INFO - mkdir: /builds/slave/test/build/upload/logs 07:57:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.829635 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-30 07:57:46.914002) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-30 07:57:46.917672) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1469889426.488110-514809297 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b96aafd910d33224c1621783d2a3d9a5d62ac384175627dfecc4d5b722f336b1c8026732e58175e7ad802efa5faf8ce5313e86d1464c812f8ec3985c1fe2a798", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/80110f52293e4699bb38fcf961fb1c08c39084c25bf9c0cdb1a7e0b0816190592c61e255d43090118d3c5718da36df9f6fd310f1501f22c788ff49092910dfc5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f1ead321047d95596d076427d3333900e5899a7ee8595406aaa00391921ed5884f42bae9b2c229cf65a9f59f9e90050251bac16224f3f7dcc9752a5056a57d82"} build_url:https://queue.taskcluster.net/v1/task/CXFKn_YdRduhn7ayW5mhbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011284 build_url: 'https://queue.taskcluster.net/v1/task/CXFKn_YdRduhn7ayW5mhbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b96aafd910d33224c1621783d2a3d9a5d62ac384175627dfecc4d5b722f336b1c8026732e58175e7ad802efa5faf8ce5313e86d1464c812f8ec3985c1fe2a798", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/80110f52293e4699bb38fcf961fb1c08c39084c25bf9c0cdb1a7e0b0816190592c61e255d43090118d3c5718da36df9f6fd310f1501f22c788ff49092910dfc5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f1ead321047d95596d076427d3333900e5899a7ee8595406aaa00391921ed5884f42bae9b2c229cf65a9f59f9e90050251bac16224f3f7dcc9752a5056a57d82"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-30 07:57:46.945808) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 07:57:46.946264) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1469889426.488110-514809297 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004445 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 07:57:47.030113) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-30 07:57:47.030805) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-30 07:57:47.031350) ========= ========= Total master_lag: 0.15 =========