builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-019 starttime: 1470133305.31 results: success (0) buildid: 20160802004003 builduid: 178d7b9a1e0245f9844ab2e2a2923b11 revision: 6e3a686084a0d3a5e8576be37238c0342bd162c2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-02 03:21:45.311279) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-02 03:21:45.311750) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-02 03:21:45.312030) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-02 03:21:45.327481) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 03:21:45.327830) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1470133305.66338-1953637177 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-02 03:21:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 21.1M=0.001s 2016-08-02 03:21:45 (21.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.108466 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 03:21:45.450988) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 03:21:45.451307) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1470133305.66338-1953637177 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017758 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 03:21:45.501171) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 03:21:45.501531) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6e3a686084a0d3a5e8576be37238c0342bd162c2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6e3a686084a0d3a5e8576be37238c0342bd162c2 --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=78329bfc0fd5309db0a6e0ac000001b4-1470133305.66338-1953637177 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-02 03:21:45,980 truncating revision to first 12 chars 2016-08-02 03:21:45,980 Setting DEBUG logging. 2016-08-02 03:21:45,980 attempt 1/10 2016-08-02 03:21:45,980 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/6e3a686084a0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-02 03:21:46,304 unpacking tar archive at: mozilla-aurora-6e3a686084a0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.680543 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 03:21:46.195846) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-02 03:21:46.196164) ========= script_repo_revision: 6e3a686084a0d3a5e8576be37238c0342bd162c2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-02 03:21:46.196583) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-02 03:21:46.196842) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-02 03:21:46.207909) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-08-02 03:21:46.208443) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=78329bfc0fd5309db0a6e0ac000001b4-1470133305.66338-1953637177 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:21:46 INFO - MultiFileLogger online at 20160802 03:21:46 in /builds/slave/test 03:21:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:21:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:21:46 INFO - {'append_to_log': False, 03:21:46 INFO - 'base_work_dir': '/builds/slave/test', 03:21:46 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:21:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:21:46 INFO - 'branch': 'Mozilla-Aurora', 03:21:46 INFO - 'buildbot_json_path': 'buildprops.json', 03:21:46 INFO - 'config_files': ('talos/linux_config.py',), 03:21:46 INFO - 'default_actions': ('clobber', 03:21:46 INFO - 'read-buildbot-config', 03:21:46 INFO - 'download-and-extract', 03:21:46 INFO - 'populate-webroot', 03:21:46 INFO - 'create-virtualenv', 03:21:46 INFO - 'install', 03:21:46 INFO - 'run-tests'), 03:21:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:21:46 INFO - 'download_minidump_stackwalk': True, 03:21:46 INFO - 'download_symbols': 'ondemand', 03:21:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:21:46 INFO - 'tooltool.py': '/tools/tooltool.py', 03:21:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:21:46 INFO - '/tools/misc-python/virtualenv.py')}, 03:21:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:21:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:21:46 INFO - 'installer_path': 'installer.exe', 03:21:46 INFO - 'log_level': 'info', 03:21:46 INFO - 'log_name': 'talos', 03:21:46 INFO - 'log_to_console': True, 03:21:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:21:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:21:46 INFO - 'opt_config_files': (), 03:21:46 INFO - 'pip_index': False, 03:21:46 INFO - 'sps_profile': False, 03:21:46 INFO - 'sps_profile_interval': 0, 03:21:46 INFO - 'suite': 'dromaeojs', 03:21:46 INFO - 'system_bits': '32', 03:21:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:21:46 INFO - 'title': 'talos-linux64-ix-019', 03:21:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:21:46 INFO - 'use_talos_json': True, 03:21:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:21:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:21:46 INFO - 'work_dir': 'build'} 03:21:46 INFO - [mozharness: 2016-08-02 10:21:46.783482Z] Running clobber step. 03:21:46 INFO - Running pre-action listener: _resource_record_pre_action 03:21:46 INFO - Running main action method: clobber 03:21:46 INFO - rmtree: /builds/slave/test/build 03:21:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:21:47 INFO - Running post-action listener: _resource_record_post_action 03:21:47 INFO - [mozharness: 2016-08-02 10:21:47.289578Z] Finished clobber step (success) 03:21:47 INFO - [mozharness: 2016-08-02 10:21:47.289679Z] Running read-buildbot-config step. 03:21:47 INFO - Running pre-action listener: _resource_record_pre_action 03:21:47 INFO - Running main action method: read_buildbot_config 03:21:47 INFO - Using buildbot properties: 03:21:47 INFO - { 03:21:47 INFO - "project": "", 03:21:47 INFO - "product": "firefox", 03:21:47 INFO - "script_repo_revision": "production", 03:21:47 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:21:47 INFO - "repository": "", 03:21:47 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:21:47 INFO - "buildid": "20160802004003", 03:21:47 INFO - "stage_platform": "linux64-pgo", 03:21:47 INFO - "basedir": "/builds/slave/test", 03:21:47 INFO - "nightly_build": "True", 03:21:47 INFO - "buildnumber": 409, 03:21:47 INFO - "slavename": "talos-linux64-ix-019", 03:21:47 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:21:47 INFO - "platform": "ubuntu64_hw", 03:21:47 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:21:47 INFO - "branch": "mozilla-aurora", 03:21:47 INFO - "repo_path": "releases/mozilla-aurora", 03:21:47 INFO - "revision": "6e3a686084a0d3a5e8576be37238c0342bd162c2", 03:21:47 INFO - "pgo_build": "True", 03:21:47 INFO - "builduid": "178d7b9a1e0245f9844ab2e2a2923b11", 03:21:47 INFO - "slavebuilddir": "test" 03:21:47 INFO - } 03:21:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ap0rsVMFRIipaeFevlR8fQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 03:21:47 INFO - Running post-action listener: _resource_record_post_action 03:21:47 INFO - [mozharness: 2016-08-02 10:21:47.292199Z] Finished read-buildbot-config step (success) 03:21:47 INFO - [mozharness: 2016-08-02 10:21:47.292289Z] Running download-and-extract step. 03:21:47 INFO - Running pre-action listener: _resource_record_pre_action 03:21:47 INFO - Running main action method: download_and_extract 03:21:47 INFO - mkdir: /builds/slave/test/build/tests 03:21:47 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')]} 03:21:47 INFO - https://queue.taskcluster.net/v1/task/Ap0rsVMFRIipaeFevlR8fQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:21:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ap0rsVMFRIipaeFevlR8fQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:21:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ap0rsVMFRIipaeFevlR8fQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:21:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ap0rsVMFRIipaeFevlR8fQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:21:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ap0rsVMFRIipaeFevlR8fQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:21:47 INFO - Downloaded 1361 bytes. 03:21:47 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:21:47 INFO - Using the following test package requirements: 03:21:47 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 03:21:47 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:21:47 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:21:47 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:21:47 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:21:47 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:21:47 INFO - u'jsshell-linux-x86_64.zip'], 03:21:47 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:21:47 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:21:47 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 03:21:47 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:21:47 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:21:47 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:21:47 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:21:47 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:21:47 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:21:47 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:21:47 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:21:47 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:21:47 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')]} 03:21:47 INFO - https://queue.taskcluster.net/v1/task/Ap0rsVMFRIipaeFevlR8fQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:21:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ap0rsVMFRIipaeFevlR8fQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:21:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ap0rsVMFRIipaeFevlR8fQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:21:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ap0rsVMFRIipaeFevlR8fQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:21:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ap0rsVMFRIipaeFevlR8fQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:21:48 INFO - Downloaded 21766012 bytes. 03:21:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:21:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:21:49 INFO - Return code: 0 03:21:49 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:21:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:49 INFO - https://queue.taskcluster.net/v1/task/Ap0rsVMFRIipaeFevlR8fQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:21:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ap0rsVMFRIipaeFevlR8fQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:21:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ap0rsVMFRIipaeFevlR8fQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:21:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ap0rsVMFRIipaeFevlR8fQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:21:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ap0rsVMFRIipaeFevlR8fQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:21:50 INFO - Downloaded 21766012 bytes. 03:21:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:21:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:21:52 INFO - Return code: 0 03:21:52 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')]} 03:21:52 INFO - https://queue.taskcluster.net/v1/task/Ap0rsVMFRIipaeFevlR8fQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:21:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ap0rsVMFRIipaeFevlR8fQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:21:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ap0rsVMFRIipaeFevlR8fQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:21:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ap0rsVMFRIipaeFevlR8fQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:21:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ap0rsVMFRIipaeFevlR8fQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:21:52 INFO - Downloaded 14413723 bytes. 03:21:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:21:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:21:53 INFO - Return code: 0 03:21:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:53 INFO - https://queue.taskcluster.net/v1/task/Ap0rsVMFRIipaeFevlR8fQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:21:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ap0rsVMFRIipaeFevlR8fQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:21:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ap0rsVMFRIipaeFevlR8fQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:21:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ap0rsVMFRIipaeFevlR8fQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:21:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ap0rsVMFRIipaeFevlR8fQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:21:54 INFO - Downloaded 63753411 bytes. 03:21:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ap0rsVMFRIipaeFevlR8fQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:21:54 INFO - mkdir: /builds/slave/test/properties 03:21:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:21:54 INFO - Writing to file /builds/slave/test/properties/build_url 03:21:54 INFO - Contents: 03:21:54 INFO - build_url:https://queue.taskcluster.net/v1/task/Ap0rsVMFRIipaeFevlR8fQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:21:55 INFO - Running post-action listener: _resource_record_post_action 03:21:55 INFO - Running post-action listener: set_extra_try_arguments 03:21:55 INFO - [mozharness: 2016-08-02 10:21:55.058231Z] Finished download-and-extract step (success) 03:21:55 INFO - [mozharness: 2016-08-02 10:21:55.058463Z] Running populate-webroot step. 03:21:55 INFO - Running pre-action listener: _resource_record_pre_action 03:21:55 INFO - Running main action method: populate_webroot 03:21:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:21:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:21:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:21:55 INFO - '--tppagecycles', 03:21:55 INFO - '7'], 03:21:55 INFO - 'tests': ['tsvgm']}}, 03:21:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:21:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:21:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:21:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:21:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:21:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:21:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:55 INFO - 'talos_options': ['--disable-e10s'], 03:21:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:21:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:21:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:55 INFO - 'talos_options': ['--disable-e10s'], 03:21:55 INFO - 'tests': ['damp', 'tps']}, 03:21:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:55 INFO - 'tests': ['damp', 'tps']}, 03:21:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:21:55 INFO - 'tests': ['dromaeo_dom']}, 03:21:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:21:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:21:55 INFO - 'tests': ['basic_compositor_video']}, 03:21:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:21:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:21:55 INFO - 'tests': ['a11yr', 03:21:55 INFO - 'ts_paint', 03:21:55 INFO - 'tpaint', 03:21:55 INFO - 'sessionrestore', 03:21:55 INFO - 'sessionrestore_no_auto_restore', 03:21:55 INFO - 'tabpaint']}, 03:21:55 INFO - 'other-e10s': {'tests': ['a11yr', 03:21:55 INFO - 'ts_paint', 03:21:55 INFO - 'tpaint', 03:21:55 INFO - 'sessionrestore', 03:21:55 INFO - 'sessionrestore_no_auto_restore', 03:21:55 INFO - 'tabpaint']}, 03:21:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:21:55 INFO - 'ts_paint', 03:21:55 INFO - 'tpaint', 03:21:55 INFO - 'sessionrestore', 03:21:55 INFO - 'sessionrestore_no_auto_restore', 03:21:55 INFO - 'tabpaint']}, 03:21:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:21:55 INFO - 'ts_paint', 03:21:55 INFO - 'tpaint', 03:21:55 INFO - 'sessionrestore', 03:21:55 INFO - 'sessionrestore_no_auto_restore', 03:21:55 INFO - 'tabpaint']}, 03:21:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:21:55 INFO - 'tests': ['a11yr', 03:21:55 INFO - 'ts_paint', 03:21:55 INFO - 'tpaint', 03:21:55 INFO - 'sessionrestore', 03:21:55 INFO - 'sessionrestore_no_auto_restore', 03:21:55 INFO - 'tabpaint']}, 03:21:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:21:55 INFO - 'tests': ['a11yr', 03:21:55 INFO - 'ts_paint', 03:21:55 INFO - 'tpaint', 03:21:55 INFO - 'sessionrestore', 03:21:55 INFO - 'sessionrestore_no_auto_restore', 03:21:55 INFO - 'tabpaint']}, 03:21:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:21:55 INFO - 'tests': ['tsvgx', 03:21:55 INFO - 'tsvgr_opacity', 03:21:55 INFO - 'tart', 03:21:55 INFO - 'tscrollx', 03:21:55 INFO - 'cart']}, 03:21:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:21:55 INFO - 'tsvgr_opacity', 03:21:55 INFO - 'tart', 03:21:55 INFO - 'tscrollx', 03:21:55 INFO - 'cart']}, 03:21:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:55 INFO - 'talos_options': ['--disable-e10s'], 03:21:55 INFO - 'tests': ['tp5o']}, 03:21:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:55 INFO - 'tests': ['tp5o']}, 03:21:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:55 INFO - 'talos_options': ['--disable-e10s', 03:21:55 INFO - '--xperf_path', 03:21:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:21:55 INFO - 'tests': ['tp5n']}, 03:21:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:55 INFO - 'talos_options': ['--xperf_path', 03:21:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:21:55 INFO - 'tests': ['tp5n']}}, 03:21:55 INFO - 'talos.zip': {'path': '', 03:21:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:21:55 INFO - Running post-action listener: _resource_record_post_action 03:21:55 INFO - [mozharness: 2016-08-02 10:21:55.074755Z] Finished populate-webroot step (success) 03:21:55 INFO - [mozharness: 2016-08-02 10:21:55.074844Z] Running create-virtualenv step. 03:21:55 INFO - Running pre-action listener: _resource_record_pre_action 03:21:55 INFO - Running main action method: create_virtualenv 03:21:55 INFO - Creating virtualenv /builds/slave/test/build/venv 03:21:55 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 03:21:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:21:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:21:55 INFO - Using real prefix '/usr' 03:21:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:21:55 INFO - Installing distribute.............................................................................................................................................................................................done. 03:21:57 INFO - Installing pip.................done. 03:21:57 INFO - Return code: 0 03:21:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:21:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2797030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a58180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a563b0>, '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 0x2a572b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a57740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1470133305.66338-1953637177', '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 03:21:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:21:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:21:57 INFO - Using env: {'DISPLAY': ':0', 03:21:57 INFO - 'HOME': '/home/cltbld', 03:21:57 INFO - 'LANG': 'en_US.UTF-8', 03:21:57 INFO - 'LANGUAGE': 'en_US:en', 03:21:57 INFO - 'LOGNAME': 'cltbld', 03:21:57 INFO - 'MAIL': '/var/mail/cltbld', 03:21:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:57 INFO - 'MOZ_NO_REMOTE': '1', 03:21:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:57 INFO - 'NO_EM_RESTART': '1', 03:21:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:57 INFO - 'PWD': '/builds/slave/test', 03:21:57 INFO - 'SHELL': '/bin/bash', 03:21:57 INFO - 'SHLVL': '1', 03:21:57 INFO - 'TERM': 'linux', 03:21:57 INFO - 'TMOUT': '86400', 03:21:57 INFO - 'USER': 'cltbld', 03:21:57 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470133305.66338-1953637177', 03:21:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:57 INFO - '_': '/tools/buildbot/bin/python'} 03:21:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:57 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 03:21:57 INFO - Cleaning up... 03:21:57 INFO - Return code: 0 03:21:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:21:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2797030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a58180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a563b0>, '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 0x2a572b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a57740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1470133305.66338-1953637177', '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 03:21:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:21:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:21:57 INFO - Using env: {'DISPLAY': ':0', 03:21:57 INFO - 'HOME': '/home/cltbld', 03:21:57 INFO - 'LANG': 'en_US.UTF-8', 03:21:57 INFO - 'LANGUAGE': 'en_US:en', 03:21:57 INFO - 'LOGNAME': 'cltbld', 03:21:57 INFO - 'MAIL': '/var/mail/cltbld', 03:21:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:57 INFO - 'MOZ_NO_REMOTE': '1', 03:21:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:57 INFO - 'NO_EM_RESTART': '1', 03:21:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:57 INFO - 'PWD': '/builds/slave/test', 03:21:57 INFO - 'SHELL': '/bin/bash', 03:21:57 INFO - 'SHLVL': '1', 03:21:57 INFO - 'TERM': 'linux', 03:21:57 INFO - 'TMOUT': '86400', 03:21:57 INFO - 'USER': 'cltbld', 03:21:57 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470133305.66338-1953637177', 03:21:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:57 INFO - '_': '/tools/buildbot/bin/python'} 03:21:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:58 INFO - Downloading/unpacking psutil>=3.1.1 03:21:58 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 03:21:58 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 03:21:58 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 03:21:58 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 03:21:58 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 03:21:58 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 03:21:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:22:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:22:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:22:00 INFO - Installing collected packages: psutil 03:22:00 INFO - Running setup.py install for psutil 03:22:00 INFO - building 'psutil._psutil_linux' extension 03:22:00 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 03:22:00 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 03:22:00 INFO - building 'psutil._psutil_posix' extension 03:22:00 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 03:22:00 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 03:22:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:22:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:22:00 INFO - Successfully installed psutil 03:22:00 INFO - Cleaning up... 03:22:00 INFO - Return code: 0 03:22:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:22:00 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')]} 03:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:00 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')]} 03:22:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:00 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 0x2797030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a58180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a563b0>, '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 0x2a572b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a57740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1470133305.66338-1953637177', '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 03:22:00 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 03:22:00 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 03:22:00 INFO - Using env: {'DISPLAY': ':0', 03:22:00 INFO - 'HOME': '/home/cltbld', 03:22:00 INFO - 'LANG': 'en_US.UTF-8', 03:22:00 INFO - 'LANGUAGE': 'en_US:en', 03:22:00 INFO - 'LOGNAME': 'cltbld', 03:22:00 INFO - 'MAIL': '/var/mail/cltbld', 03:22:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:00 INFO - 'MOZ_NO_REMOTE': '1', 03:22:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:00 INFO - 'NO_EM_RESTART': '1', 03:22:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:00 INFO - 'PWD': '/builds/slave/test', 03:22:00 INFO - 'SHELL': '/bin/bash', 03:22:00 INFO - 'SHLVL': '1', 03:22:00 INFO - 'TERM': 'linux', 03:22:00 INFO - 'TMOUT': '86400', 03:22:00 INFO - 'USER': 'cltbld', 03:22:00 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470133305.66338-1953637177', 03:22:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:00 INFO - '_': '/tools/buildbot/bin/python'} 03:22:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:22:00 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 03:22:00 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 03:22:00 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 03:22:00 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 03:22:00 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 03:22:00 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 03:22:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:22:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:22:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:22:02 INFO - Installing collected packages: mozsystemmonitor 03:22:02 INFO - Running setup.py install for mozsystemmonitor 03:22:02 INFO - Successfully installed mozsystemmonitor 03:22:02 INFO - Cleaning up... 03:22:02 INFO - Return code: 0 03:22:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:22:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:02 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 0x2797030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a58180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a563b0>, '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 0x2a572b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a57740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1470133305.66338-1953637177', '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 03:22:02 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 03:22:02 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 03:22:02 INFO - Using env: {'DISPLAY': ':0', 03:22:02 INFO - 'HOME': '/home/cltbld', 03:22:02 INFO - 'LANG': 'en_US.UTF-8', 03:22:02 INFO - 'LANGUAGE': 'en_US:en', 03:22:02 INFO - 'LOGNAME': 'cltbld', 03:22:02 INFO - 'MAIL': '/var/mail/cltbld', 03:22:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:02 INFO - 'MOZ_NO_REMOTE': '1', 03:22:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:02 INFO - 'NO_EM_RESTART': '1', 03:22:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:02 INFO - 'PWD': '/builds/slave/test', 03:22:02 INFO - 'SHELL': '/bin/bash', 03:22:02 INFO - 'SHLVL': '1', 03:22:02 INFO - 'TERM': 'linux', 03:22:02 INFO - 'TMOUT': '86400', 03:22:02 INFO - 'USER': 'cltbld', 03:22:02 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470133305.66338-1953637177', 03:22:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:02 INFO - '_': '/tools/buildbot/bin/python'} 03:22:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:03 INFO - Downloading/unpacking jsonschema==2.5.1 03:22:03 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 03:22:03 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 03:22:03 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 03:22:03 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 03:22:03 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 03:22:03 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 03:22:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:22:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:22:05 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 03:22:05 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 03:22:05 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 03:22:05 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 03:22:05 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 03:22:05 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 03:22:05 INFO - Downloading functools32-3.2.3-2.tar.gz 03:22:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:22:05 INFO - warning: no files found matching '*.txt' 03:22:05 INFO - no previously-included directories found matching 'build' 03:22:05 INFO - no previously-included directories found matching 'dist' 03:22:05 INFO - no previously-included directories found matching '.git*' 03:22:05 INFO - Installing collected packages: jsonschema, functools32 03:22:05 INFO - Running setup.py install for functools32 03:22:05 INFO - warning: no files found matching '*.txt' 03:22:05 INFO - no previously-included directories found matching 'build' 03:22:05 INFO - no previously-included directories found matching 'dist' 03:22:05 INFO - no previously-included directories found matching '.git*' 03:22:05 INFO - Successfully installed jsonschema functools32 03:22:05 INFO - Cleaning up... 03:22:05 INFO - Return code: 0 03:22:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:22:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:05 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 0x2797030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a58180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a563b0>, '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 0x2a572b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a57740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1470133305.66338-1953637177', '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 03:22:05 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 03:22:05 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 03:22:05 INFO - Using env: {'DISPLAY': ':0', 03:22:05 INFO - 'HOME': '/home/cltbld', 03:22:05 INFO - 'LANG': 'en_US.UTF-8', 03:22:05 INFO - 'LANGUAGE': 'en_US:en', 03:22:05 INFO - 'LOGNAME': 'cltbld', 03:22:05 INFO - 'MAIL': '/var/mail/cltbld', 03:22:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:05 INFO - 'MOZ_NO_REMOTE': '1', 03:22:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:05 INFO - 'NO_EM_RESTART': '1', 03:22:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:05 INFO - 'PWD': '/builds/slave/test', 03:22:05 INFO - 'SHELL': '/bin/bash', 03:22:05 INFO - 'SHLVL': '1', 03:22:05 INFO - 'TERM': 'linux', 03:22:05 INFO - 'TMOUT': '86400', 03:22:05 INFO - 'USER': 'cltbld', 03:22:05 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470133305.66338-1953637177', 03:22:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:05 INFO - '_': '/tools/buildbot/bin/python'} 03:22:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:22:05 INFO - Cleaning up... 03:22:05 INFO - Return code: 0 03:22:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:22:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:05 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 0x2797030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a58180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a563b0>, '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 0x2a572b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a57740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1470133305.66338-1953637177', '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 03:22:05 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 03:22:05 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 03:22:05 INFO - Using env: {'DISPLAY': ':0', 03:22:05 INFO - 'HOME': '/home/cltbld', 03:22:05 INFO - 'LANG': 'en_US.UTF-8', 03:22:05 INFO - 'LANGUAGE': 'en_US:en', 03:22:05 INFO - 'LOGNAME': 'cltbld', 03:22:05 INFO - 'MAIL': '/var/mail/cltbld', 03:22:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:05 INFO - 'MOZ_NO_REMOTE': '1', 03:22:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:05 INFO - 'NO_EM_RESTART': '1', 03:22:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:05 INFO - 'PWD': '/builds/slave/test', 03:22:05 INFO - 'SHELL': '/bin/bash', 03:22:05 INFO - 'SHLVL': '1', 03:22:05 INFO - 'TERM': 'linux', 03:22:05 INFO - 'TMOUT': '86400', 03:22:05 INFO - 'USER': 'cltbld', 03:22:05 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470133305.66338-1953637177', 03:22:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:05 INFO - '_': '/tools/buildbot/bin/python'} 03:22:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:05 INFO - Downloading/unpacking blobuploader==1.2.4 03:22:05 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 03:22:05 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 03:22:05 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 03:22:05 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 03:22:05 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 03:22:05 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 03:22:07 INFO - Downloading blobuploader-1.2.4.tar.gz 03:22:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:22:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:22:07 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 03:22:07 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 03:22:07 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 03:22:07 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 03:22:07 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 03:22:07 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 03:22:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:22:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:22:08 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 03:22:08 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 03:22:08 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 03:22:08 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 03:22:08 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 03:22:08 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 03:22:08 INFO - Downloading docopt-0.6.1.tar.gz 03:22:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:22:08 INFO - Installing collected packages: blobuploader, requests, docopt 03:22:08 INFO - Running setup.py install for blobuploader 03:22:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:22:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:22:08 INFO - Running setup.py install for requests 03:22:09 INFO - Running setup.py install for docopt 03:22:09 INFO - Successfully installed blobuploader requests docopt 03:22:09 INFO - Cleaning up... 03:22:09 INFO - Return code: 0 03:22:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:09 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 0x2797030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a58180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a563b0>, '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 0x2a572b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a57740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1470133305.66338-1953637177', '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 03:22:09 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 03:22:09 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 03:22:09 INFO - Using env: {'DISPLAY': ':0', 03:22:09 INFO - 'HOME': '/home/cltbld', 03:22:09 INFO - 'LANG': 'en_US.UTF-8', 03:22:09 INFO - 'LANGUAGE': 'en_US:en', 03:22:09 INFO - 'LOGNAME': 'cltbld', 03:22:09 INFO - 'MAIL': '/var/mail/cltbld', 03:22:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:09 INFO - 'MOZ_NO_REMOTE': '1', 03:22:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:09 INFO - 'NO_EM_RESTART': '1', 03:22:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:09 INFO - 'PWD': '/builds/slave/test', 03:22:09 INFO - 'SHELL': '/bin/bash', 03:22:09 INFO - 'SHLVL': '1', 03:22:09 INFO - 'TERM': 'linux', 03:22:09 INFO - 'TMOUT': '86400', 03:22:09 INFO - 'USER': 'cltbld', 03:22:09 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470133305.66338-1953637177', 03:22:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:09 INFO - '_': '/tools/buildbot/bin/python'} 03:22:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:22:09 INFO - Running setup.py (path:/tmp/pip-4Z63I9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:22:09 INFO - Running setup.py (path:/tmp/pip-oqrYOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:22:09 INFO - Running setup.py (path:/tmp/pip-OsXlDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:22:09 INFO - Running setup.py (path:/tmp/pip-a6ICYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:22:09 INFO - Running setup.py (path:/tmp/pip-YBWvIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:22:09 INFO - Running setup.py (path:/tmp/pip-OXOXCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:22:09 INFO - Running setup.py (path:/tmp/pip-VdqN08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:22:09 INFO - Running setup.py (path:/tmp/pip-abqJ5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:22:09 INFO - Running setup.py (path:/tmp/pip-1AieEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:22:10 INFO - Running setup.py (path:/tmp/pip-mJhHam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:22:10 INFO - Running setup.py (path:/tmp/pip-aGC9xs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:22:10 INFO - Running setup.py (path:/tmp/pip-IKGYbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:22:10 INFO - Running setup.py (path:/tmp/pip-vnt8cp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:22:10 INFO - Running setup.py (path:/tmp/pip-3lNXkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:22:10 INFO - Running setup.py (path:/tmp/pip-ROIikK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:22:10 INFO - Running setup.py (path:/tmp/pip-A5VI0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:22:10 INFO - Running setup.py (path:/tmp/pip-H6WrV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:22:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:22:10 INFO - Running setup.py install for manifestparser 03:22:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:22:10 INFO - Running setup.py install for mozcrash 03:22:10 INFO - Running setup.py install for mozdebug 03:22:10 INFO - Running setup.py install for mozdevice 03:22:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:22:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:22:11 INFO - Running setup.py install for mozfile 03:22:11 INFO - Running setup.py install for mozhttpd 03:22:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:22:11 INFO - Running setup.py install for mozinfo 03:22:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:22:11 INFO - Running setup.py install for mozInstall 03:22:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:22:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:22:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:22:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:22:11 INFO - Running setup.py install for mozleak 03:22:11 INFO - Running setup.py install for mozlog 03:22:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:22:11 INFO - Running setup.py install for moznetwork 03:22:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:22:11 INFO - Running setup.py install for mozprocess 03:22:11 INFO - Running setup.py install for mozprofile 03:22:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:22:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:22:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:22:11 INFO - Running setup.py install for mozrunner 03:22:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:22:12 INFO - Running setup.py install for mozscreenshot 03:22:12 INFO - Running setup.py install for moztest 03:22:12 INFO - Running setup.py install for mozversion 03:22:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:22:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:22:12 INFO - Cleaning up... 03:22:12 INFO - Return code: 0 03:22:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:22:12 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')]} 03:22:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:12 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')]} 03:22:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:12 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 0x2797030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a58180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a563b0>, '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 0x2a572b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a57740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1470133305.66338-1953637177', '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 03:22:12 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 03:22:12 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 03:22:12 INFO - Using env: {'DISPLAY': ':0', 03:22:12 INFO - 'HOME': '/home/cltbld', 03:22:12 INFO - 'LANG': 'en_US.UTF-8', 03:22:12 INFO - 'LANGUAGE': 'en_US:en', 03:22:12 INFO - 'LOGNAME': 'cltbld', 03:22:12 INFO - 'MAIL': '/var/mail/cltbld', 03:22:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:12 INFO - 'MOZ_NO_REMOTE': '1', 03:22:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:12 INFO - 'NO_EM_RESTART': '1', 03:22:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:12 INFO - 'PWD': '/builds/slave/test', 03:22:12 INFO - 'SHELL': '/bin/bash', 03:22:12 INFO - 'SHLVL': '1', 03:22:12 INFO - 'TERM': 'linux', 03:22:12 INFO - 'TMOUT': '86400', 03:22:12 INFO - 'USER': 'cltbld', 03:22:12 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470133305.66338-1953637177', 03:22:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:12 INFO - '_': '/tools/buildbot/bin/python'} 03:22:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:22:12 INFO - Running setup.py (path:/tmp/pip-7d1eY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:22:12 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)) 03:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:22:12 INFO - Running setup.py (path:/tmp/pip-aEmr63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:22:12 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)) 03:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:22:12 INFO - Running setup.py (path:/tmp/pip-Q89kfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:22:12 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)) 03:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:22:12 INFO - Running setup.py (path:/tmp/pip-xWrMDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:22:12 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)) 03:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:22:12 INFO - Running setup.py (path:/tmp/pip-PXn2br-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:22:13 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)) 03:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:22:13 INFO - Running setup.py (path:/tmp/pip-WcjNPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:22:13 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)) 03:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:22:13 INFO - Running setup.py (path:/tmp/pip-SbeloR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:22:13 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)) 03:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:22:13 INFO - Running setup.py (path:/tmp/pip-8yX9GI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:22:13 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)) 03:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:22:13 INFO - Running setup.py (path:/tmp/pip-5hTjoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:22:13 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)) 03:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:22:13 INFO - Running setup.py (path:/tmp/pip-_TuB1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:22:13 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)) 03:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:22:13 INFO - Running setup.py (path:/tmp/pip-ixHv4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:22:13 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)) 03:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:22:13 INFO - Running setup.py (path:/tmp/pip-fqB4ib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:22:13 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)) 03:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:22:13 INFO - Running setup.py (path:/tmp/pip-ItqqqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:22:13 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)) 03:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:22:13 INFO - Running setup.py (path:/tmp/pip-KtWg2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:22:13 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)) 03:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:22:13 INFO - Running setup.py (path:/tmp/pip-ZDGMVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:22:13 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)) 03:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:22:13 INFO - Running setup.py (path:/tmp/pip-zbKZ8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:22:13 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)) 03:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:22:13 INFO - Running setup.py (path:/tmp/pip-NXfoPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:22:13 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)) 03:22:13 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)) 03:22:13 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)) 03:22:13 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)) 03:22:13 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)) 03:22:13 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)) 03:22:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:22:13 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 03:22:13 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 03:22:13 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 03:22:13 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 03:22:13 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 03:22:13 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 03:22:15 INFO - Downloading blessings-1.6.tar.gz 03:22:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:22:15 INFO - Installing collected packages: blessings 03:22:15 INFO - Running setup.py install for blessings 03:22:15 INFO - Successfully installed blessings 03:22:15 INFO - Cleaning up... 03:22:16 INFO - Return code: 0 03:22:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:22:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:22:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:22:16 INFO - Reading from file tmpfile_stdout 03:22:16 INFO - Current package versions: 03:22:16 INFO - argparse == 1.2.1 03:22:16 INFO - blessings == 1.6 03:22:16 INFO - blobuploader == 1.2.4 03:22:16 INFO - docopt == 0.6.1 03:22:16 INFO - functools32 == 3.2.3-2 03:22:16 INFO - jsonschema == 2.5.1 03:22:16 INFO - manifestparser == 1.1 03:22:16 INFO - mozInstall == 1.12 03:22:16 INFO - mozcrash == 0.17 03:22:16 INFO - mozdebug == 0.1 03:22:16 INFO - mozdevice == 0.48 03:22:16 INFO - mozfile == 1.2 03:22:16 INFO - mozhttpd == 0.7 03:22:16 INFO - mozinfo == 0.9 03:22:16 INFO - mozleak == 0.1 03:22:16 INFO - mozlog == 3.3 03:22:16 INFO - moznetwork == 0.27 03:22:16 INFO - mozprocess == 0.23 03:22:16 INFO - mozprofile == 0.28 03:22:16 INFO - mozrunner == 6.12 03:22:16 INFO - mozscreenshot == 0.1 03:22:16 INFO - mozsystemmonitor == 0.3 03:22:16 INFO - moztest == 0.7 03:22:16 INFO - mozversion == 1.4 03:22:16 INFO - psutil == 3.1.1 03:22:16 INFO - requests == 1.2.3 03:22:16 INFO - wsgiref == 0.1.2 03:22:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:22: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')]} 03:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22: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')]} 03:22:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:16 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 0x2797030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a58180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a563b0>, '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 0x2a572b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a57740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1470133305.66338-1953637177', '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 03:22:16 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 03:22:16 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 03:22:16 INFO - Using env: {'DISPLAY': ':0', 03:22:16 INFO - 'HOME': '/home/cltbld', 03:22:16 INFO - 'LANG': 'en_US.UTF-8', 03:22:16 INFO - 'LANGUAGE': 'en_US:en', 03:22:16 INFO - 'LOGNAME': 'cltbld', 03:22:16 INFO - 'MAIL': '/var/mail/cltbld', 03:22:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:16 INFO - 'MOZ_NO_REMOTE': '1', 03:22:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:16 INFO - 'NO_EM_RESTART': '1', 03:22:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:16 INFO - 'PWD': '/builds/slave/test', 03:22:16 INFO - 'SHELL': '/bin/bash', 03:22:16 INFO - 'SHLVL': '1', 03:22:16 INFO - 'TERM': 'linux', 03:22:16 INFO - 'TMOUT': '86400', 03:22:16 INFO - 'USER': 'cltbld', 03:22:16 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470133305.66338-1953637177', 03:22:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:16 INFO - '_': '/tools/buildbot/bin/python'} 03:22:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:16 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)) 03:22:16 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)) 03:22:16 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)) 03:22:16 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)) 03:22:16 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)) 03:22:16 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)) 03:22:16 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)) 03:22:16 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)) 03:22:16 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)) 03:22:16 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)) 03:22:16 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)) 03:22:16 INFO - Cleaning up... 03:22:16 INFO - Return code: 0 03:22:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:22: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')]} 03:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22: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')]} 03:22:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:16 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 0x2797030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a58180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a563b0>, '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 0x2a572b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a57740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1470133305.66338-1953637177', '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 03:22:16 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 03:22:16 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 03:22:16 INFO - Using env: {'DISPLAY': ':0', 03:22:16 INFO - 'HOME': '/home/cltbld', 03:22:16 INFO - 'LANG': 'en_US.UTF-8', 03:22:16 INFO - 'LANGUAGE': 'en_US:en', 03:22:16 INFO - 'LOGNAME': 'cltbld', 03:22:16 INFO - 'MAIL': '/var/mail/cltbld', 03:22:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:16 INFO - 'MOZ_NO_REMOTE': '1', 03:22:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:16 INFO - 'NO_EM_RESTART': '1', 03:22:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:16 INFO - 'PWD': '/builds/slave/test', 03:22:16 INFO - 'SHELL': '/bin/bash', 03:22:16 INFO - 'SHLVL': '1', 03:22:16 INFO - 'TERM': 'linux', 03:22:16 INFO - 'TMOUT': '86400', 03:22:16 INFO - 'USER': 'cltbld', 03:22:16 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470133305.66338-1953637177', 03:22:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:16 INFO - '_': '/tools/buildbot/bin/python'} 03:22:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:22:16 INFO - Cleaning up... 03:22:16 INFO - Return code: 0 03:22:16 INFO - Running post-action listener: _resource_record_post_action 03:22:16 INFO - Running post-action listener: _start_resource_monitoring 03:22:16 INFO - Starting resource monitoring. 03:22:16 INFO - [mozharness: 2016-08-02 10:22:16.713319Z] Finished create-virtualenv step (success) 03:22:16 INFO - [mozharness: 2016-08-02 10:22:16.713806Z] Running install step. 03:22:16 INFO - Running pre-action listener: _resource_record_pre_action 03:22:16 INFO - Running main action method: install 03:22:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:22:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:22:16 INFO - Reading from file tmpfile_stdout 03:22:16 INFO - Detecting whether we're running mozinstall >=1.0... 03:22:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:22:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:22:17 INFO - Reading from file tmpfile_stdout 03:22:17 INFO - Output received: 03:22:17 INFO - Usage: mozinstall [options] installer 03:22:17 INFO - Options: 03:22:17 INFO - -h, --help show this help message and exit 03:22:17 INFO - -d DEST, --destination=DEST 03:22:17 INFO - Directory to install application into. [default: 03:22:17 INFO - "/builds/slave/test"] 03:22:17 INFO - --app=APP Application being installed. [default: firefox] 03:22:17 INFO - mkdir: /builds/slave/test/build/application 03:22:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:22:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:22:33 INFO - Reading from file tmpfile_stdout 03:22:33 INFO - Output received: 03:22:33 INFO - /builds/slave/test/build/application/firefox/firefox 03:22:33 INFO - Running post-action listener: _resource_record_post_action 03:22:33 INFO - [mozharness: 2016-08-02 10:22:33.002828Z] Finished install step (success) 03:22:33 INFO - [mozharness: 2016-08-02 10:22:33.003246Z] Running run-tests step. 03:22:33 INFO - Running pre-action listener: _resource_record_pre_action 03:22:33 INFO - Running main action method: run_tests 03:22:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:22:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:22:33 INFO - Python 2.7.3 03:22:33 INFO - Return code: 0 03:22:33 INFO - grabbing minidump binary from tooltool 03:22: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')]} 03:22:33 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 0x2a563b0>, '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 0x2a572b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a57740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:22:33 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 03:22:33 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 03:22:33 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 03:22:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:22:33 INFO - Return code: 0 03:22:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:22:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:22:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:22:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:22:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:22:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ap0rsVMFRIipaeFevlR8fQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 03:22:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ap0rsVMFRIipaeFevlR8fQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --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 03:22:33 INFO - Using env: {'DISPLAY': ':0', 03:22:33 INFO - 'HOME': '/home/cltbld', 03:22:33 INFO - 'LANG': 'en_US.UTF-8', 03:22:33 INFO - 'LANGUAGE': 'en_US:en', 03:22:33 INFO - 'LOGNAME': 'cltbld', 03:22:33 INFO - 'MAIL': '/var/mail/cltbld', 03:22:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:22:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:22:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:33 INFO - 'MOZ_NO_REMOTE': '1', 03:22:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:22:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:33 INFO - 'NO_EM_RESTART': '1', 03:22:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:33 INFO - 'PWD': '/builds/slave/test', 03:22:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:22:33 INFO - 'SHELL': '/bin/bash', 03:22:33 INFO - 'SHLVL': '1', 03:22:33 INFO - 'TERM': 'linux', 03:22:33 INFO - 'TMOUT': '86400', 03:22:33 INFO - 'USER': 'cltbld', 03:22:33 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470133305.66338-1953637177', 03:22:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:33 INFO - '_': '/tools/buildbot/bin/python'} 03:22:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ap0rsVMFRIipaeFevlR8fQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 03:22:33 INFO - mozversion application_buildid: 20160802004003 03:22:33 INFO - mozversion application_changeset: 6e3a686084a0d3a5e8576be37238c0342bd162c2 03:22:33 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:22:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:22:33 INFO - mozversion application_name: Firefox 03:22:33 INFO - mozversion application_remotingname: firefox-dev 03:22:33 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:22:33 INFO - mozversion application_vendor: Mozilla 03:22:33 INFO - mozversion application_version: 50.0a2 03:22:33 INFO - mozversion platform_buildid: 20160802004003 03:22:33 INFO - mozversion platform_changeset: 6e3a686084a0d3a5e8576be37238c0342bd162c2 03:22:33 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:22:33 INFO - mozversion platform_version: 50.0a2 03:22:33 INFO - using testdate: 1470133353 03:22:33 INFO - actual date: 1470133353 03:22:33 INFO - starting webserver on 'localhost:59763' 03:22:33 INFO - SUITE-START | Running 2 tests 03:22:33 INFO - TEST-START | dromaeo_css 03:22:33 INFO - operating with platform_type : linux_ 03:22:33 INFO - Initialising browser for dromaeo_css test... 03:22:33 INFO - TEST-INFO | started process 24021 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGJe4zp/profile http://localhost:59763/getInfo.html) 03:22:37 INFO - PROCESS | 24021 | __metrics Screen width/height:1600/1200 03:22:37 INFO - PROCESS | 24021 | colorDepth:24 03:22:37 INFO - PROCESS | 24021 | Browser inner width/height: 1024/697 03:22:37 INFO - PROCESS | 24021 | __metrics 03:22:38 INFO - PROCESS | 24021 | 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" 03:22:38 INFO - PROCESS | 24021 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:22:39 INFO - TEST-INFO | 24021: exit 0 03:22:39 INFO - Browser initialized. 03:22:39 INFO - Running cycle 1/1 for dromaeo_css test... 03:22:39 INFO - TEST-INFO | started process 24108 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGJe4zp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:22:51 INFO - PROCESS | 24108 | RSS: Main: 145788928 03:22:51 INFO - PROCESS | 24108 | 03:23:42 INFO - PROCESS | 24108 | 1470133422224 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] 03:25:51 INFO - PROCESS | 24108 | Cycle 1(1): loaded http://localhost:59763/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59763/tests/dromaeo/cssquery-ext.html) 03:25:52 INFO - PROCESS | 24108 | RSS: Main: 229384192 03:25:52 INFO - PROCESS | 24108 | 03:28:54 INFO - PROCESS | 24108 | Cycle 1(1): loaded http://localhost:59763/tests/dromaeo/cssquery-ext.html (next: http://localhost:59763/tests/dromaeo/cssquery-jquery.html) 03:28:55 INFO - PROCESS | 24108 | RSS: Main: 232292352 03:28:55 INFO - PROCESS | 24108 | 03:31:57 INFO - PROCESS | 24108 | Cycle 1(1): loaded http://localhost:59763/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59763/tests/dromaeo/cssquery-mootools.html) 03:31:58 INFO - PROCESS | 24108 | RSS: Main: 174772224 03:31:58 INFO - PROCESS | 24108 | 03:35:00 INFO - PROCESS | 24108 | Cycle 1(1): loaded http://localhost:59763/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59763/tests/dromaeo/cssquery-prototype.html) 03:35:00 INFO - PROCESS | 24108 | RSS: Main: 200220672 03:35:00 INFO - PROCESS | 24108 | 03:38:03 INFO - PROCESS | 24108 | Cycle 1(1): loaded http://localhost:59763/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59763/tests/dromaeo/cssquery-yui.html) 03:38:03 INFO - PROCESS | 24108 | RSS: Main: 176975872 03:38:03 INFO - PROCESS | 24108 | 03:41:06 INFO - PROCESS | 24108 | Cycle 1(1): loaded http://localhost:59763/tests/dromaeo/cssquery-yui.html (next: http://localhost:59763/tests/dromaeo/cssquery-dojo.html) 03:41:06 INFO - PROCESS | 24108 | RSS: Main: 265793536 03:41:06 INFO - PROCESS | 24108 | 03:41:06 INFO - PROCESS | 24108 | __start_tp_report 03:41:06 INFO - PROCESS | 24108 | _x_x_mozilla_page_load 03:41:06 INFO - PROCESS | 24108 | _x_x_mozilla_page_load_details 03:41:06 INFO - PROCESS | 24108 | |i|pagename|runs| 03:41:06 INFO - PROCESS | 24108 | |0;dojo.html;3236.126245913603;3243.886463973761;3246.9837650811755;3291.2923721399893;3309.966900330996;5530.032244357237;5608.270924779783;5620.943790562093;5639.5770317226215;5664.830055098349;5630.971845140769;5747.568932330081;5754.367019627837;5767.740451679674;5806.071028635419;5052.520010598987;5104.183330667094;5110.386753589574;5157.76790044447;5220.321358223445;5074.2895994560795;5091.694498330112;5189.714565698904;5235.86910327243;5245.606579506533;5095.847124586268;5137.332146820908;5153.896922061556;5156.69059856408;5160.303359046518;5160.5097515736325;5162.1482455395;5163.690178589297;5174.870628234286;5185.377754669464;5029.547340739351;5080.923786143211;5092.0579692756955;5097.643164978453;5138.2806407103035;5543.168524721284;5550.555955523589;5586;5591.580631452657;5613.354464236624;6059.939400606026;6071.071345040884;6071.8495565978255;6108.511319094506;6111.052786818006;6077.483413909823;6086.666898653316;6116.7553297868035;6133.78531751391;6181.938180618181;5743.310802703661;5795.710214489259;5809.2738407699035;5813.447722466359;5813.854653633608;6055.909161362583;6276.592021518587;6289.5911765736;6290.779822706183;6300.30696623371;5839.620424672383;5892;5894.233749612523;5944.048952167633;5969.701514924236;6004.279486461653;6009.759609615654;6037.607555508878;6050.788222412282;6052.213212282375;5958.344582095966;6006.579539432198;6007.15899774032;6020.729067191987;6021.337652858182;5987.401259873977;6080.908786368208;6093.695315234309;6164.4760195383;6166.753329866755;4663.790129444184;4695.460022097503;4698.177818881751;4715.693479923794;4727.858164255009;4127.979360103241;4173.10278290163;4191.937120943188;4218.535961044283;4227.725197862129;5741.1388291756575;5818.21454103699;5819.4762471376935;5868.677222752704;5893.528517718572;6172.938270617236;6177.505799536027;6180.505559555315;6187.071939209155;6199.473044791153;5665;5853.063509838491;5857.26784151981;5862.618929769551;5887.558433117448;5187.610929180327;5288.2596436498925;5298.6290959633225;5344.5724342052545;5368.275282836845;6276.529260305495;6310.368963103653;6343.365663433712;6347.079673447324;6351.491880649537;5945.464908158287;6151.108089327112;6156.445919867234;6161.507079433724;6166.568340216142;6186.721597528032;6252.5935814171935;6262.405071518198;6363.5227357947415;6376.776812811529;6044.942135126247;6047;6054.545909056927;6054.848628784315;6060.090986352083;5992.400759923973;6149.292831324455;6159.81520554384;6163.137160797582;6166.475849552839;5851.858887516893;5896.64620122794;5904.704764761659;5923.052311630118;5952.702364881652;5856.590038697421;5896.351401345934;5903.203067585821;5906.970465147647;5958.821235362946;5806.332271788799;5833.416658334133;5882.941170588239;5889.440503152194;5907.025340818888;5947.91078133837;5967.134765459071;6026.487748541423;6100.450959413674;6101.267847858286;5897.144913987534;5907.17299578068;5911.733971971357;5912.615679980788;5917.881642367214 03:41:06 INFO - PROCESS | 24108 | |1;ext.html;604.9818505444838;622.2470810319516;626.2359920896507;637.6142433827531;647.873664635396;34883.99999999997;37756.81121594392;37860.81069594648;37933;37991.43012854809;38016;47928.76035619817;48829.51170488294;48952.51047489524;52383.21425178625;9194.494302813342;9291.349605527615;9302.720918372459;9304.953475232614;9308.301877359192;8702.390832641717;9260.073992600719;9340.859887101698;9355.532223388804;9356.719298421025;11054.889451105506;11289.887101129007;11304.208705390625;11695.122865785057;11699.473523691455;11426.485808138654;11479.36863472517;11521.078313734964;11523.711907202303;11531.827022594667;8432.957835210786;10930.398828064453;11195.384253866034;11268.774624507463;11274.661760147126;46002.30996535055;46714.766426167655;46742.29886551671;46746;46802.531974680496;3674.0998455378603;3928.862489812843;3963.7225394222414;4060.3909413587903;4491.887702807423;34939;35096.47355289673;35105.718128321576;35109.82445087784;35326;4540.500544940054;4578.679492435531;4610.76946152691;4637.5594318540025;4662.230731929228;375434;376845;377489;378483;379530;63467.365326346146;63561.68219158967;63730.36269637337;63964.36035639677;64071.67964160242;65825;65847.34152658508;65867;66488;66695;13966.86033139676;14097.295135243197;14155.150690958575;14189.78715319271;14219.075760075562;11234.49444774987;11260.831087533694;11291.54833806655;11301.547938082549;11303.547858085749;15928.442504512286;16385;16401.83598164027;17713;17805.287788488575;5313.973430132902;6200.968995154995;6205.314987184646;6310.337414571496;6312.905306420407;1011.716719318592;1096.572336788653;1117.6982214801958;1118.3178261260625;1198.4726720243066;35299;35744.82127589398;35751.28497430037;35933.28133437317;36021;1174.8531433570804;1193.8388317577017;1208.5045131496045;1225.3383173086434;1231.2489381477292;17489.56276093108;18589.814101858807;18691.345802896834;18714.625707486048;18777;619050;622862;624259;625033;625708;56854.43145568574;63428.68285658542;64307.67846160739;64813;65187;1409.7603407420763;1423.181670539444;1426.4436869620856;1429.7712366021387;1462.824461064679;33704.66295337015;36797.44803827998;36813.63186368102;36829;37038.25923481569;55540.16689749738;55988;56025;56042.43957560372;56060.43939560552;552297;560946;561707;831446;833357;30672.233194170323;30701.23246918845;30736.23159420943;30960.69039309578;31103.68896311008;52159;52316.47683523116;52583.73708131588;52867.20699189438;53840.730796345764;44831.77584112059;44868.55131448644;44928.10143797171;45552.54447455483;46785.766071169426;44118.77940610277;45864;45892.54107458883;46030.53969460396;46968.29547556858;44084;45038.77480612576;45080.323795143755;45684;45786;35901.28197436089;39964.20071598494;40585.79707101446;40878.59121408748;41157.794211028755;29344;30468.238294042825;30492.847535763067;30840.845795770878;30904.227394315323 03:41:06 INFO - PROCESS | 24108 | |2;jquery.html;394.1093129527271;426.7021128015449;432.4983019697151;434.15990059235384;435.72331569453405;15900.681986360265;19562.510937226576;20125.19499220031;20191.798082019177;21037.789622103774;20331.28840490583;20417;20425.28511502098;20438.08028638711;20713.067911943963;5773.9422605773825;5803.883922321562;5875.471207591316;5936.109583562457;5960.344362120163;5850.414958504158;5870.794522191724;5881.323647780518;5889.793857214999;5899.439553242435;5769.82690519283;5866.325372582165;5870.0314448116005;5892.322382925976;5895.145203945425;5788.102844059156;5822.941770582324;5868.149118377854;5889.941100589003;5920.763169473237;5233.895322093575;5308.416074231832;5340.359156901158;5340.412554618989;5343.652662576959;21274.255401061044;23795.881020594785;23853.761462385326;24371.512569748684;24547.87726061376;2335.801456876168;2510.364346647527;2580.548404029287;2601.8959241630314;2949.218457108868;10989.670309890636;11336.206465547415;11351.091912646969;11421.42892855354;11593.60876694802;2052.1791283486577;2088.321295578943;2106.820920221783;2128.6806978953127;2247.0225451928463;82676;84186.73945866011;84782.15217847805;86728.56635716844;88982.5550872248;11677.416129193507;11762.176647634584;11791.587294444653;11841.23032002917;11919.642410727693;16773.412930547373;16803.907745996472;16807.747883781754;16812.74780878288;16813.831861681472;7726.806829829299;7965.761027169194;7969.561674107979;7973.681052757941;8211.95894020538;7181.281871812777;7468.178500364956;7508.43686723487;7569.425920986368;7724.871427072045;5020.472850350734;5059.266406371129;5084.3898732152375;5163.148080566664;5210.791568337224;2040.734704488407;2115.365390382879;2157.5769672172296;2167.4581354661336;2200.592890315265;458.7706146926537;486.7809485731435;502.5000124875699;921.9124183202586;983.6606370802061;12446.37768111609;12466.920319162624;12827.486900524062;12905.483780648668;13417.127886687334;494.2339373970332;503.9571636410946;510.2932438572604;511.05709965114306;520.8255234496486;6881.10545629065;6974.058502102152;7051.717931282794;7154.892676609855;7169.5698258104685;526821;528172;528986;533183;550387;61268;83113.58443207866;95631.52184239174;96266;96519.51740241394;499.73264303597404;508.524529564858;509.56432250425354;511.4578546740467;512.2751306900768;16922.830771692126;17493.650126997643;18344.357947471774;19050.52373690669;19455.61088778188;41122.58877411188;41560;41630.37554436747;41792.791036044626;42629.93425164396;50783.492165079355;56568;57778.422215777304;58751.23746287618;59481.70259148676;8837.469751814655;8853.114688531095;8907.421017633833;9000.86498702533;9146.817063658556;12194.512219511475;12698.746025079261;12859.678508037374;13486.86513134856;14609.780853287422;11520.193586448868;11839.467223975114;11917.34454605005;11936;12719.364031798188;11835.467403967014;12118.818217726917;12272.815907761213;12434.253944763343;12662.113652044269;11348.092152627605;11941.343226122646;12356.443960022001;12432.378381080729;12820.358982051046;7928.722494712888;8035.598220089089;8168.550729709923;8483.490990540588;9090.36367454272;11506.654800356002;11656.30062196271;11856.525738970344;11951.282923024646;12412.62762117138 03:41:06 INFO - PROCESS | 24108 | |3;mootools.html;1535.470262759348;1592.9601759956;1769.3807167491373;1828.615990641965;1880.435869239228;9258.981512033672;9962.053604907522;9962.153216976547;9968.850467242997;9971.850422243671;8342.791430214247;9121.771955701111;9451.33840631156;9470.76323091923;9756.219502439806;2409.4337830609793;2456.435019945414;2458.4591389894285;2458.50829834033;2460.9786938420534;2158.568286342738;2207.8896055197256;2245.438640339915;2251.583457060449;2256.0524579676576;2466.8643224622638;2475.393528585499;2489.5643262429094;2493.8254322197454;2494.5260400523844;2407.8194135439912;2408.205292253552;2413.9396515087087;2416.4442178299;2448.20433359159;2408.759124087577;2411.7105947286263;2411.9035238590436;2414.2395145529104;2417.830751847371;9650;9816.26378021644;9851.50742462874;9854;9864.901350986542;5375.301210842605;5521.723913804293;5524.806631767909;5530.446955304477;5539.750711217965;3296.456084746014;3333.250018745787;3357.6306606273533;3386.610539787907;3388.203772113576;1134.387430787382;1153.26191237608;1153.6423708650345;1158.1314014489133;1164.2025212729307;13662.726745465035;13668.794968075486;13716.354037515563;13724.519641812589;13734.519291824838;4735.384400027974;4755.7872742451145;4818.277258411266;4832.275158726219;4920.335754673145;11250.606228781953;11256.380899050631;11293.491792869341;11315.321080735182;11318.26431281964;5489.313835770528;5529.281193444826;5534.640248383923;5555.0834112371;5555.416681248492;4422.226110430726;4661.137689527448;4661.720296782204;4731.493362346104;5058.4435712071645;4017.276890159799;4026.214888096793;4112.3420252759415;4113.691473139526;4118.6499147572795;1328.554934097069;1338.8259526261525;1343.7715588349809;1348.1776116568885;1356.7422189783908;1017.9643712470177;1034.1519953637944;1053.2153545608571;1059.1999364082608;1070.314998401024;6276.6547839869245;6277.435030847246;6291.811245662638;6497.740090396331;6576.4410025147445;444.76872026546664;453.80940005197897;454.46373279530474;460.53946053946055;468.1129260052182;4501.392312037899;4512.2329204035395;4546.227141385973;4572.74849883253;4623.352730617717;11402;11481.655550333504;11818.586349477728;11825.586104486301;12040.518379264906;12225.327606981702;12253.509859605694;12269.69325766845;12270.2637841728;12291.692707682201;8881.067487913677;9008.144226298491;9033.548322583976;9046.638134474679;9064.048274931169;6346.079818426395;6464.967675161594;6559.639219842955;6576.145101136822;6647.634380109141;10596.682099537025;10708.357498550113;10720;10731.517081731185;10765.569377224823;10077.344972576759;10489.632862849763;10786.946065269938;10800.675979720621;10932.344059356465;8000.079990801132;8197.71308004241;8367.95816020916;8381.203785640355;8381.329493640616;9364.438133712;9576.377535460173;9626.278029147701;9638.566264517973;9643.758906027406;8232;8238.629261683118;8300.501969881827;8401.201885820838;8739.475631462132;7827.647755850887;8014.559199244098;8110.716124935835;8241.093479717347;8461.788455288666;7704.460687751804;7713.6143192841255;7827.178146294557;7922.524648520876;7928.167542407964;5053.545180933734;5103.157978933435;5125.74371281427;5235;5400.486953739389;5316.229146773619;5419.105847535113;5419.945800541944;5479.643823151482;5589.55283577321 03:41:06 INFO - PROCESS | 24108 | |4;prototype.html;329.38733954843985;344.4402845376264;357.8461261657488;373.3522338742283;374.53931664053215;5475.260839786628;5494.478024587663;5551.528120109796;5571.470710282521;5586.525145362649;5119.744012799364;5233.528982391584;5395.352557693082;5398.24424580559;5413.972930135344;4292;4294.720843145185;4294.785260736966;4303.6772242081815;4308.633766129867;4353.45322986052;4362.345648152771;4369.1480161368545;4372.409724687174;4398.560143985608;4099.077707515815;4245.681573881956;4264.87205383839;4269.188854117723;4328.502222244435;4223.87328380146;4237.894052648678;4238.922927765404;4242.575742425764;4250.766207858566;3752.9812350938346;3753.8123093845197;3756.530433695788;3762.529683789526;3780.372641014496;5251.291075704769;5339.919901201485;5342.332208473941;5365.865853353658;5397.62216644835;4811.4707382187935;4837.129316722989;4857.304196171123;4864.537868902484;4878.560929516325;5659.689081887101;5662.207290979266;5702.6293290935955;5705.315362156526;5706.887157004386;4050.392441133824;4123.711340206187;4131.814068366931;4157.97921010396;4182.975171083104;5882.6470411775;5925.8814823703715;5933.673647949361;5942.70286485674;5963.46328830403;4305.892352691208;4326.3510473428605;4328.718633288826;4334.28484300087;4337.8481753138485;4160.981923766971;4372.1692878353015;4383.167198232326;4393.714408563433;4403.2734598791485;4915.557599816034;4933.161362568372;4936.580390666762;4944.678595891256;4998;5822.126680997884;5830.271216097988;5835.416458354215;5848.415158484203;5890.646561206341;1425.1947649577955;1429.756941319978;1454.5781723300336;1490.0835985868612;1503.8570686278508;1020.8570800087994;1024.7489365105596;1049.2445439283856;1049.679847646475;1051.1328154272755;5508.779648814003;5550.888982220333;5560.693237089281;5576.498115169654;5598.664080155204;5829.9101476217675;5836.795712150054;5837.153612726131;5861.88276234473;5874.530037597067;5406.4321346809775;5530.972345138249;5552.611317207838;5554.833354999357;5641.774329026793;3101.72084512395;3138.717515423623;3140.136462472838;3172.8413579321405;3173.904782856518;6045.732191020174;6131.724072416752;6145.201123853871;6145.354737752472;6169.290531588835;5806.516090345844;5964.671943043088;5972.50687328168;6008.3390827009;6016.338202797689;6046.727897244635;6048.395160483917;6080.69596520181;6090.482309003784;6100.206973093469;5622.493975542221;5886.676232807236;5887.499562537061;5893.499052580407;5921.437463440966;5846.859862326975;5847.327557330961;5860.413958604276;5877.882442351214;5888.293404791452;5863.618864773776;6124.6325220486915;6134.539909506716;6141.47797437205;6166.845828854314;4250.383694364238;4286.957130428656;4302.82788688449;4319.984803571221;4339.218940590724;5999.88000239984;6019.668918209541;6024.457798798129;6042.879142417215;6045.848853778691;5605.439456054362;5682.119271512922;5683.5453163747625;5720.313562372542;5763.567732420001;5736.799212027559;5744.4829965303325;5755.820056888244;5764.9711751442655;5765.625234359753;5560.36055853582;5685.602007859576;5725.599208055396;5728.828135155952;5729.140628905698;5741.110127930177;5777.9133313001175;5780.8554786129;5784.739686714024;5789.33422656383;5605.271314729059;5622.381538030895;5622.718864056863;5635.8591035224445;5676.360492371067 03:41:06 INFO - PROCESS | 24108 | |5;yui.html;746.4998451037804;751.3538357012966;767.992320076799;819.4714409206063;923.8752768376268;16457.670846583074;17225.56936076599;17251.396201132964;17269.30922763091;17309;14562.563123106298;14732.18972956487;14786.926065369686;14811.407543698238;15188.088714677127;720.5388551327142;834.6369329341726;860.0324634785866;866.7399780065987;870.2863651805491;872.5026734761188;878.6529320918233;878.6748902905902;879.0857508191473;880.1594477274188;923.7921467669754;925.2366797392144;925.3013974449282;926.5089502563618;927.2165020557618;749.632679986808;878.9296856251517;902.2285945516587;906.7415786500882;911.3301723233418;661.0876989754156;661.7981515637777;662.2318110991228;662.3773652766432;662.4965026579835;14810.703785924328;14813.111213327127;14818.925905370512;14827.0362426443;14840;14278.214698191596;14340.784888226684;14567.781483277759;14658.193799341032;14982.550523484313;12992.350382480838;13051;13129.86870131296;13227.669308267274;13367.665808354868;4521.7739113044545;4574.794134263966;4633.096546173498;4648.093621743761;4648.976755116203;78886;79526;80260.79608805872;80715.5964220181;82754;12197.268163910016;12221.327826969424;12231.327276999673;12363.93818030904;12577.308248046262;22893.313200604007;22953.655695164587;22991.080356785875;23012.07951681914;23023;8769.693060742844;8989.280857531381;9050.773730656787;9291.442513449214;9384.90615093854;4926.187179115406;5028.698278103326;5118.616103792156;5151.201563757623;5277.445868183862;3781.8487260509823;3875.418687196887;3901.6098390161324;3904.9804750976064;3910.081130934228;643.4980715042275;647.3170804800981;659.3670076726396;663.3731124087788;665.0987911380107;631.8136149835717;659.0213532903634;685.530411668009;726.6512074204411;757.1141764135974;9786.706398808046;9831.557579908778;9958.900410995797;10153.593856245816;10215.540300686338;543.2747282377991;586.6362855029909;653.7189008726293;729.1687476277049;760.0309605253236;4856.739174933497;5027.572656324253;5035.496450354935;5054.671446356048;5081.898362032739;105888.47055764672;134171.30400436133;134767;136076;138941;112794;115004.42497787625;118507.40746296386;118692;119138.40430797964;95962;97249;99653.50173249087;99912;100916.49541752244;9583.664571739955;9631.422114673142;9734.172595329193;9765.414075155513;9782;59684.40315596962;60513.69743151256;60670;62093.37906620876;63996.36003639904;84434;87413;88578.55710721404;89475;91009.54495227481;12049.638510844688;12389.318587477776;12552.121351505672;12584.685382865502;12608.432620531914;12273.386330683608;12538.185017973803;12596.496140154291;12698.68253293638;13188.472461101448;12279.877201227873;12305.26168429897;12417.503299867903;12955.676108097374;13093.279869607262;11177.871441524965;11298.209125361145;11369.602063927723;11436.542538298374;11464.25482343645;11011.724706882393;11042.116630669367;11058.447077646246;11272.83090753623;11290.266132701348;9817.509124543887;10134.695959121238;10322.329048612117;10518;10664.680059598224;9657.275704322063;9799.363041402286;9870;9904.851427228454;9924.955236021464 03:41:06 INFO - PROCESS | 24108 | __end_tp_report 03:41:06 INFO - PROCESS | 24108 | __start_cc_report 03:41:06 INFO - PROCESS | 24108 | _x_x_mozilla_cycle_collect,1142 03:41:06 INFO - PROCESS | 24108 | __end_cc_report 03:41:06 INFO - PROCESS | 24108 | __startTimestamp1470134466596__endTimestamp 03:41:06 INFO - PROCESS | 24108 | 03:41:06 INFO - PROCESS | 24108 | ------- Summary: start ------- 03:41:06 INFO - PROCESS | 24108 | Number of tests: 6 03:41:06 INFO - PROCESS | 24108 | 03:41:06 INFO - PROCESS | 24108 | [#0] dojo.html Cycles:165 Average:5658.06 Median:5893.53 stddev:647.98 (11.0%) stddev-sans-first:621.49 03:41:06 INFO - PROCESS | 24108 | Values: 3236.1 3243.9 3247.0 3291.3 3310.0 5530.0 5608.3 5620.9 5639.6 5664.8 5631.0 5747.6 5754.4 5767.7 5806.1 5052.5 5104.2 5110.4 5157.8 5220.3 5074.3 5091.7 5189.7 5235.9 5245.6 5095.8 5137.3 5153.9 5156.7 5160.3 5160.5 5162.1 5163.7 5174.9 5185.4 5029.5 5080.9 5092.1 5097.6 5138.3 5543.2 5550.6 5586.0 5591.6 5613.4 6059.9 6071.1 6071.8 6108.5 6111.1 6077.5 6086.7 6116.8 6133.8 6181.9 5743.3 5795.7 5809.3 5813.4 5813.9 6055.9 6276.6 6289.6 6290.8 6300.3 5839.6 5892.0 5894.2 5944.0 5969.7 6004.3 6009.8 6037.6 6050.8 6052.2 5958.3 6006.6 6007.2 6020.7 6021.3 5987.4 6080.9 6093.7 6164.5 6166.8 4663.8 4695.5 4698.2 4715.7 4727.9 4128.0 4173.1 4191.9 4218.5 4227.7 5741.1 5818.2 5819.5 5868.7 5893.5 6172.9 6177.5 6180.5 6187.1 6199.5 5665.0 5853.1 5857.3 5862.6 5887.6 5187.6 5288.3 5298.6 5344.6 5368.3 6276.5 6310.4 6343.4 6347.1 6351.5 5945.5 6151.1 6156.4 6161.5 6166.6 6186.7 6252.6 6262.4 6363.5 6376.8 6044.9 6047.0 6054.5 6054.8 6060.1 5992.4 6149.3 6159.8 6163.1 6166.5 5851.9 5896.6 5904.7 5923.1 5952.7 5856.6 5896.4 5903.2 5907.0 5958.8 5806.3 5833.4 5882.9 5889.4 5907.0 5947.9 5967.1 6026.5 6100.5 6101.3 5897.1 5907.2 5911.7 5912.6 5917.9 03:41:06 INFO - PROCESS | 24108 | 03:41:06 INFO - PROCESS | 24108 | [#1] ext.html Cycles:180 Average:71600.99 Median:22323.09 stddev:154086.92 (690.3%) stddev-sans-first:154426.97 03:41:06 INFO - PROCESS | 24108 | Values: 605.0 622.2 626.2 637.6 647.9 34884.0 37756.8 37860.8 37933.0 37991.4 38016.0 47928.8 48829.5 48952.5 52383.2 9194.5 9291.3 9302.7 9305.0 9308.3 8702.4 9260.1 9340.9 9355.5 9356.7 11054.9 11289.9 11304.2 11695.1 11699.5 11426.5 11479.4 11521.1 11523.7 11531.8 8433.0 10930.4 11195.4 11268.8 11274.7 46002.3 46714.8 46742.3 46746.0 46802.5 3674.1 3928.9 3963.7 4060.4 4491.9 34939.0 35096.5 35105.7 35109.8 35326.0 4540.5 4578.7 4610.8 4637.6 4662.2 375434.0 376845.0 377489.0 378483.0 379530.0 63467.4 63561.7 63730.4 63964.4 64071.7 65825.0 65847.3 65867.0 66488.0 66695.0 13966.9 14097.3 14155.2 14189.8 14219.1 11234.5 11260.8 11291.5 11301.5 11303.5 15928.4 16385.0 16401.8 17713.0 17805.3 5314.0 6201.0 6205.3 6310.3 6312.9 1011.7 1096.6 1117.7 1118.3 1198.5 35299.0 35744.8 35751.3 35933.3 36021.0 1174.9 1193.8 1208.5 1225.3 1231.2 17489.6 18589.8 18691.3 18714.6 18777.0 619050.0 622862.0 624259.0 625033.0 625708.0 56854.4 63428.7 64307.7 64813.0 65187.0 1409.8 1423.2 1426.4 1429.8 1462.8 33704.7 36797.4 36813.6 36829.0 37038.3 55540.2 55988.0 56025.0 56042.4 56060.4 552297.0 560946.0 561707.0 831446.0 833357.0 30672.2 30701.2 30736.2 30960.7 31103.7 52159.0 52316.5 52583.7 52867.2 53840.7 44831.8 44868.6 44928.1 45552.5 46785.8 44118.8 45864.0 45892.5 46030.5 46968.3 44084.0 45038.8 45080.3 45684.0 45786.0 35901.3 39964.2 40585.8 40878.6 41157.8 29344.0 30468.2 30492.8 30840.8 30904.2 03:41:06 INFO - PROCESS | 24108 | 03:41:06 INFO - PROCESS | 24108 | [#2] jquery.html Cycles:180 Average:30069.20 Median:472.78 stddev:87771.96 (18565.2%) stddev-sans-first:87989.90 03:41:06 INFO - PROCESS | 24108 | Values: 394.1 426.7 432.5 434.2 435.7 15900.7 19562.5 20125.2 20191.8 21037.8 20331.3 20417.0 20425.3 20438.1 20713.1 5773.9 5803.9 5875.5 5936.1 5960.3 5850.4 5870.8 5881.3 5889.8 5899.4 5769.8 5866.3 5870.0 5892.3 5895.1 5788.1 5822.9 5868.1 5889.9 5920.8 5233.9 5308.4 5340.4 5340.4 5343.7 21274.3 23795.9 23853.8 24371.5 24547.9 2335.8 2510.4 2580.5 2601.9 2949.2 10989.7 11336.2 11351.1 11421.4 11593.6 2052.2 2088.3 2106.8 2128.7 2247.0 82676.0 84186.7 84782.2 86728.6 88982.6 11677.4 11762.2 11791.6 11841.2 11919.6 16773.4 16803.9 16807.7 16812.7 16813.8 7726.8 7965.8 7969.6 7973.7 8212.0 7181.3 7468.2 7508.4 7569.4 7724.9 5020.5 5059.3 5084.4 5163.1 5210.8 2040.7 2115.4 2157.6 2167.5 2200.6 458.8 486.8 502.5 921.9 983.7 12446.4 12466.9 12827.5 12905.5 13417.1 494.2 504.0 510.3 511.1 520.8 6881.1 6974.1 7051.7 7154.9 7169.6 526821.0 528172.0 528986.0 533183.0 550387.0 61268.0 83113.6 95631.5 96266.0 96519.5 499.7 508.5 509.6 511.5 512.3 16922.8 17493.7 18344.4 19050.5 19455.6 41122.6 41560.0 41630.4 41792.8 42629.9 50783.5 56568.0 57778.4 58751.2 59481.7 8837.5 8853.1 8907.4 9000.9 9146.8 12194.5 12698.7 12859.7 13486.9 14609.8 11520.2 11839.5 11917.3 11936.0 12719.4 11835.5 12118.8 12272.8 12434.3 12662.1 11348.1 11941.3 12356.4 12432.4 12820.4 7928.7 8035.6 8168.6 8483.5 9090.4 11506.7 11656.3 11856.5 11951.3 12412.6 03:41:06 INFO - PROCESS | 24108 | 03:41:06 INFO - PROCESS | 24108 | [#3] mootools.html Cycles:180 Average:6224.83 Median:2500.35 stddev:3672.73 (146.9%) stddev-sans-first:3666.13 03:41:06 INFO - PROCESS | 24108 | Values: 1535.5 1593.0 1769.4 1828.6 1880.4 9259.0 9962.1 9962.2 9968.9 9971.9 8342.8 9121.8 9451.3 9470.8 9756.2 2409.4 2456.4 2458.5 2458.5 2461.0 2158.6 2207.9 2245.4 2251.6 2256.1 2466.9 2475.4 2489.6 2493.8 2494.5 2407.8 2408.2 2413.9 2416.4 2448.2 2408.8 2411.7 2411.9 2414.2 2417.8 9650.0 9816.3 9851.5 9854.0 9864.9 5375.3 5521.7 5524.8 5530.4 5539.8 3296.5 3333.3 3357.6 3386.6 3388.2 1134.4 1153.3 1153.6 1158.1 1164.2 13662.7 13668.8 13716.4 13724.5 13734.5 4735.4 4755.8 4818.3 4832.3 4920.3 11250.6 11256.4 11293.5 11315.3 11318.3 5489.3 5529.3 5534.6 5555.1 5555.4 4422.2 4661.1 4661.7 4731.5 5058.4 4017.3 4026.2 4112.3 4113.7 4118.6 1328.6 1338.8 1343.8 1348.2 1356.7 1018.0 1034.2 1053.2 1059.2 1070.3 6276.7 6277.4 6291.8 6497.7 6576.4 444.8 453.8 454.5 460.5 468.1 4501.4 4512.2 4546.2 4572.7 4623.4 11402.0 11481.7 11818.6 11825.6 12040.5 12225.3 12253.5 12269.7 12270.3 12291.7 8881.1 9008.1 9033.5 9046.6 9064.0 6346.1 6465.0 6559.6 6576.1 6647.6 10596.7 10708.4 10720.0 10731.5 10765.6 10077.3 10489.6 10786.9 10800.7 10932.3 8000.1 8197.7 8368.0 8381.2 8381.3 9364.4 9576.4 9626.3 9638.6 9643.8 8232.0 8238.6 8300.5 8401.2 8739.5 7827.6 8014.6 8110.7 8241.1 8461.8 7704.5 7713.6 7827.2 7922.5 7928.2 5053.5 5103.2 5125.7 5235.0 5400.5 5316.2 5419.1 5419.9 5479.6 5589.6 03:41:06 INFO - PROCESS | 24108 | 03:41:06 INFO - PROCESS | 24108 | [#4] prototype.html Cycles:180 Average:4858.68 Median:5551.21 stddev:1415.58 (25.5%) stddev-sans-first:1378.12 03:41:06 INFO - PROCESS | 24108 | Values: 329.4 344.4 357.8 373.4 374.5 5475.3 5494.5 5551.5 5571.5 5586.5 5119.7 5233.5 5395.4 5398.2 5414.0 4292.0 4294.7 4294.8 4303.7 4308.6 4353.5 4362.3 4369.1 4372.4 4398.6 4099.1 4245.7 4264.9 4269.2 4328.5 4223.9 4237.9 4238.9 4242.6 4250.8 3753.0 3753.8 3756.5 3762.5 3780.4 5251.3 5339.9 5342.3 5365.9 5397.6 4811.5 4837.1 4857.3 4864.5 4878.6 5659.7 5662.2 5702.6 5705.3 5706.9 4050.4 4123.7 4131.8 4158.0 4183.0 5882.6 5925.9 5933.7 5942.7 5963.5 4305.9 4326.4 4328.7 4334.3 4337.8 4161.0 4372.2 4383.2 4393.7 4403.3 4915.6 4933.2 4936.6 4944.7 4998.0 5822.1 5830.3 5835.4 5848.4 5890.6 1425.2 1429.8 1454.6 1490.1 1503.9 1020.9 1024.7 1049.2 1049.7 1051.1 5508.8 5550.9 5560.7 5576.5 5598.7 5829.9 5836.8 5837.2 5861.9 5874.5 5406.4 5531.0 5552.6 5554.8 5641.8 3101.7 3138.7 3140.1 3172.8 3173.9 6045.7 6131.7 6145.2 6145.4 6169.3 5806.5 5964.7 5972.5 6008.3 6016.3 6046.7 6048.4 6080.7 6090.5 6100.2 5622.5 5886.7 5887.5 5893.5 5921.4 5846.9 5847.3 5860.4 5877.9 5888.3 5863.6 6124.6 6134.5 6141.5 6166.8 4250.4 4287.0 4302.8 4320.0 4339.2 5999.9 6019.7 6024.5 6042.9 6045.8 5605.4 5682.1 5683.5 5720.3 5763.6 5736.8 5744.5 5755.8 5765.0 5765.6 5560.4 5685.6 5725.6 5728.8 5729.1 5741.1 5777.9 5780.9 5784.7 5789.3 5605.3 5622.4 5622.7 5635.9 5676.4 03:41:06 INFO - PROCESS | 24108 | 03:41:06 INFO - PROCESS | 24108 | [#5] yui.html Cycles:180 Average:22776.40 Median:5032.10 stddev:34612.87 (687.8%) stddev-sans-first:34670.45 03:41:06 INFO - PROCESS | 24108 | Values: 746.5 751.4 768.0 819.5 923.9 16457.7 17225.6 17251.4 17269.3 17309.0 14562.6 14732.2 14786.9 14811.4 15188.1 720.5 834.6 860.0 866.7 870.3 872.5 878.7 878.7 879.1 880.2 923.8 925.2 925.3 926.5 927.2 749.6 878.9 902.2 906.7 911.3 661.1 661.8 662.2 662.4 662.5 14810.7 14813.1 14818.9 14827.0 14840.0 14278.2 14340.8 14567.8 14658.2 14982.6 12992.4 13051.0 13129.9 13227.7 13367.7 4521.8 4574.8 4633.1 4648.1 4649.0 78886.0 79526.0 80260.8 80715.6 82754.0 12197.3 12221.3 12231.3 12363.9 12577.3 22893.3 22953.7 22991.1 23012.1 23023.0 8769.7 8989.3 9050.8 9291.4 9384.9 4926.2 5028.7 5118.6 5151.2 5277.4 3781.8 3875.4 3901.6 3905.0 3910.1 643.5 647.3 659.4 663.4 665.1 631.8 659.0 685.5 726.7 757.1 9786.7 9831.6 9958.9 10153.6 10215.5 543.3 586.6 653.7 729.2 760.0 4856.7 5027.6 5035.5 5054.7 5081.9 105888.5 134171.3 134767.0 136076.0 138941.0 112794.0 115004.4 118507.4 118692.0 119138.4 95962.0 97249.0 99653.5 99912.0 100916.5 9583.7 9631.4 9734.2 9765.4 9782.0 59684.4 60513.7 60670.0 62093.4 63996.4 84434.0 87413.0 88578.6 89475.0 91009.5 12049.6 12389.3 12552.1 12584.7 12608.4 12273.4 12538.2 12596.5 12698.7 13188.5 12279.9 12305.3 12417.5 12955.7 13093.3 11177.9 11298.2 11369.6 11436.5 11464.3 11011.7 11042.1 11058.4 11272.8 11290.3 9817.5 10134.7 10322.3 10518.0 10664.7 9657.3 9799.4 9870.0 9904.9 9925.0 03:41:06 INFO - PROCESS | 24108 | -------- Summary: end -------- 03:41:06 INFO - PROCESS | 24108 | 03:41:07 INFO - TEST-INFO | 24108: exit 0 03:41:07 INFO - TEST-OK | dromaeo_css | took 1114058ms 03:41:07 INFO - TEST-START | kraken 03:41:07 INFO - operating with platform_type : linux_ 03:41:07 INFO - Initialising browser for kraken test... 03:41:07 INFO - TEST-INFO | started process 24312 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUOF_jw/profile http://localhost:59763/getInfo.html) 03:41:11 INFO - PROCESS | 24312 | __metrics Screen width/height:1600/1200 03:41:11 INFO - PROCESS | 24312 | colorDepth:24 03:41:11 INFO - PROCESS | 24312 | Browser inner width/height: 1024/697 03:41:11 INFO - PROCESS | 24312 | __metrics 03:41:12 INFO - PROCESS | 24312 | 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" 03:41:12 INFO - PROCESS | 24312 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:41:13 INFO - TEST-INFO | 24312: exit 0 03:41:13 INFO - Browser initialized. 03:41:13 INFO - Running cycle 1/1 for kraken test... 03:41:13 INFO - TEST-INFO | started process 24396 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUOF_jw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:41:25 INFO - PROCESS | 24396 | RSS: Main: 145088512 03:41:25 INFO - PROCESS | 24396 | 03:41:27 INFO - PROCESS | 24396 | Cycle 1(1): loaded http://localhost:59763/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59763/tests/kraken/driver.html?testName=audio-beat-detection) 03:41:28 INFO - PROCESS | 24396 | RSS: Main: 191639552 03:41:28 INFO - PROCESS | 24396 | 03:41:31 INFO - PROCESS | 24396 | Cycle 1(1): loaded http://localhost:59763/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59763/tests/kraken/driver.html?testName=audio-dft) 03:41:31 INFO - PROCESS | 24396 | RSS: Main: 180772864 03:41:31 INFO - PROCESS | 24396 | 03:41:34 INFO - PROCESS | 24396 | Cycle 1(1): loaded http://localhost:59763/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59763/tests/kraken/driver.html?testName=audio-fft) 03:41:35 INFO - PROCESS | 24396 | RSS: Main: 269688832 03:41:35 INFO - PROCESS | 24396 | 03:41:37 INFO - PROCESS | 24396 | Cycle 1(1): loaded http://localhost:59763/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59763/tests/kraken/driver.html?testName=audio-oscillator) 03:41:37 INFO - PROCESS | 24396 | RSS: Main: 175382528 03:41:37 INFO - PROCESS | 24396 | 03:41:40 INFO - PROCESS | 24396 | Cycle 1(1): loaded http://localhost:59763/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59763/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:41:40 INFO - PROCESS | 24396 | RSS: Main: 177426432 03:41:40 INFO - PROCESS | 24396 | 03:41:43 INFO - PROCESS | 24396 | Cycle 1(1): loaded http://localhost:59763/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59763/tests/kraken/driver.html?testName=imaging-darkroom) 03:41:44 INFO - PROCESS | 24396 | RSS: Main: 213270528 03:41:44 INFO - PROCESS | 24396 | 03:41:47 INFO - PROCESS | 24396 | Cycle 1(1): loaded http://localhost:59763/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59763/tests/kraken/driver.html?testName=imaging-desaturate) 03:41:48 INFO - PROCESS | 24396 | RSS: Main: 211832832 03:41:48 INFO - PROCESS | 24396 | 03:41:50 INFO - PROCESS | 24396 | Cycle 1(1): loaded http://localhost:59763/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59763/tests/kraken/driver.html?testName=json-parse-financial) 03:41:51 INFO - PROCESS | 24396 | RSS: Main: 212066304 03:41:51 INFO - PROCESS | 24396 | 03:41:53 INFO - PROCESS | 24396 | Cycle 1(1): loaded http://localhost:59763/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59763/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:41:53 INFO - PROCESS | 24396 | RSS: Main: 176463872 03:41:53 INFO - PROCESS | 24396 | 03:41:55 INFO - PROCESS | 24396 | Cycle 1(1): loaded http://localhost:59763/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59763/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:41:55 INFO - PROCESS | 24396 | RSS: Main: 181780480 03:41:55 INFO - PROCESS | 24396 | 03:41:57 INFO - PROCESS | 24396 | Cycle 1(1): loaded http://localhost:59763/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59763/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:41:58 INFO - PROCESS | 24396 | RSS: Main: 186851328 03:41:58 INFO - PROCESS | 24396 | 03:42:01 INFO - PROCESS | 24396 | Cycle 1(1): loaded http://localhost:59763/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59763/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:42:01 INFO - PROCESS | 24396 | RSS: Main: 188497920 03:42:01 INFO - PROCESS | 24396 | 03:42:04 INFO - PROCESS | 24396 | Cycle 1(1): loaded http://localhost:59763/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59763/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:42:04 INFO - PROCESS | 24396 | RSS: Main: 185569280 03:42:04 INFO - PROCESS | 24396 | 03:42:06 INFO - PROCESS | 24396 | Cycle 1(1): loaded http://localhost:59763/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59763/tests/kraken/driver.html?testName=ai-astar) 03:42:06 INFO - PROCESS | 24396 | RSS: Main: 236761088 03:42:06 INFO - PROCESS | 24396 | 03:42:06 INFO - PROCESS | 24396 | __start_tp_report 03:42:06 INFO - PROCESS | 24396 | _x_x_mozilla_page_load 03:42:06 INFO - PROCESS | 24396 | _x_x_mozilla_page_load_details 03:42:06 INFO - PROCESS | 24396 | |i|pagename|runs| 03:42:06 INFO - PROCESS | 24396 | |0;ai-astar;103;110;110;110;111;109;110;108;109;109 03:42:06 INFO - PROCESS | 24396 | |1;audio-beat-detection;141;115;123;182;120;117;145;115;143;115 03:42:06 INFO - PROCESS | 24396 | |2;audio-dft;160;160;161;160;160;159;159;159;160;160 03:42:06 INFO - PROCESS | 24396 | |3;audio-fft;74;74;75;119;74;77;74;74;101;76 03:42:06 INFO - PROCESS | 24396 | |4;audio-oscillator;83;83;118;84;84;82;114;83;84;132 03:42:06 INFO - PROCESS | 24396 | |5;imaging-gaussian-blur;116;117;117;117;117;117;117;117;116;117 03:42:06 INFO - PROCESS | 24396 | |6;imaging-darkroom;147;146;146;156;146;146;146;146;145;145 03:42:06 INFO - PROCESS | 24396 | |7;imaging-desaturate;95;94;97;95;94;95;95;95;95;95 03:42:06 INFO - PROCESS | 24396 | |8;json-parse-financial;50;50;50;51;52;51;52;51;51;50 03:42:06 INFO - PROCESS | 24396 | |9;json-stringify-tinderbox;59;61;59;59;59;63;59;59;59;59 03:42:06 INFO - PROCESS | 24396 | |10;stanford-crypto-aes;73;76;73;73;74;82;81;72;72;77 03:42:06 INFO - PROCESS | 24396 | |11;stanford-crypto-ccm;129;122;119;116;115;114;119;119;145;115 03:42:06 INFO - PROCESS | 24396 | |12;stanford-crypto-pbkdf2;156;150;149;149;151;150;151;152;154;154 03:42:06 INFO - PROCESS | 24396 | |13;stanford-crypto-sha256-iterative;62;61;62;61;64;61;62;59;60;64 03:42:06 INFO - PROCESS | 24396 | __end_tp_report 03:42:06 INFO - PROCESS | 24396 | __start_cc_report 03:42:06 INFO - PROCESS | 24396 | _x_x_mozilla_cycle_collect,1638 03:42:06 INFO - PROCESS | 24396 | __end_cc_report 03:42:06 INFO - PROCESS | 24396 | __startTimestamp1470134526747__endTimestamp 03:42:06 INFO - PROCESS | 24396 | 03:42:06 INFO - PROCESS | 24396 | ------- Summary: start ------- 03:42:06 INFO - PROCESS | 24396 | Number of tests: 14 03:42:06 INFO - PROCESS | 24396 | 03:42:06 INFO - PROCESS | 24396 | [#0] ai-astar Cycles:10 Average:108.90 Median:110.00 stddev:2.23 (2.0%) stddev-sans-first:0.88 03:42:06 INFO - PROCESS | 24396 | Values: 103.0 110.0 110.0 110.0 111.0 109.0 110.0 108.0 109.0 109.0 03:42:06 INFO - PROCESS | 24396 | 03:42:06 INFO - PROCESS | 24396 | [#1] audio-beat-detection Cycles:10 Average:131.60 Median:132.00 stddev:21.57 (16.3%) stddev-sans-first:22.61 03:42:06 INFO - PROCESS | 24396 | Values: 141.0 115.0 123.0 182.0 120.0 117.0 145.0 115.0 143.0 115.0 03:42:06 INFO - PROCESS | 24396 | 03:42:06 INFO - PROCESS | 24396 | [#2] audio-dft Cycles:10 Average:159.80 Median:160.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 03:42:06 INFO - PROCESS | 24396 | Values: 160.0 160.0 161.0 160.0 160.0 159.0 159.0 159.0 160.0 160.0 03:42:06 INFO - PROCESS | 24396 | 03:42:06 INFO - PROCESS | 24396 | [#3] audio-fft Cycles:10 Average:81.80 Median:74.00 stddev:15.49 (20.9%) stddev-sans-first:16.17 03:42:06 INFO - PROCESS | 24396 | Values: 74.0 74.0 75.0 119.0 74.0 77.0 74.0 74.0 101.0 76.0 03:42:06 INFO - PROCESS | 24396 | 03:42:06 INFO - PROCESS | 24396 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:83.00 stddev:18.92 (22.8%) stddev-sans-first:19.59 03:42:06 INFO - PROCESS | 24396 | Values: 83.0 83.0 118.0 84.0 84.0 82.0 114.0 83.0 84.0 132.0 03:42:06 INFO - PROCESS | 24396 | 03:42:06 INFO - PROCESS | 24396 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 03:42:06 INFO - PROCESS | 24396 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 03:42:06 INFO - PROCESS | 24396 | 03:42:06 INFO - PROCESS | 24396 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:146.00 stddev:3.25 (2.2%) stddev-sans-first:3.44 03:42:06 INFO - PROCESS | 24396 | Values: 147.0 146.0 146.0 156.0 146.0 146.0 146.0 146.0 145.0 145.0 03:42:06 INFO - PROCESS | 24396 | 03:42:06 INFO - PROCESS | 24396 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 03:42:06 INFO - PROCESS | 24396 | Values: 95.0 94.0 97.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 03:42:06 INFO - PROCESS | 24396 | 03:42:06 INFO - PROCESS | 24396 | [#8] json-parse-financial Cycles:10 Average:50.80 Median:51.00 stddev:0.79 (1.5%) stddev-sans-first:0.78 03:42:06 INFO - PROCESS | 24396 | Values: 50.0 50.0 50.0 51.0 52.0 51.0 52.0 51.0 51.0 50.0 03:42:06 INFO - PROCESS | 24396 | 03:42:06 INFO - PROCESS | 24396 | [#9] json-stringify-tinderbox Cycles:10 Average:59.60 Median:59.00 stddev:1.35 (2.3%) stddev-sans-first:1.41 03:42:06 INFO - PROCESS | 24396 | Values: 59.0 61.0 59.0 59.0 59.0 63.0 59.0 59.0 59.0 59.0 03:42:06 INFO - PROCESS | 24396 | 03:42:06 INFO - PROCESS | 24396 | [#10] stanford-crypto-aes Cycles:10 Average:75.30 Median:75.00 stddev:3.65 (4.9%) stddev-sans-first:3.78 03:42:06 INFO - PROCESS | 24396 | Values: 73.0 76.0 73.0 73.0 74.0 82.0 81.0 72.0 72.0 77.0 03:42:06 INFO - PROCESS | 24396 | 03:42:06 INFO - PROCESS | 24396 | [#11] stanford-crypto-ccm Cycles:10 Average:121.30 Median:119.00 stddev:9.42 (7.9%) stddev-sans-first:9.57 03:42:06 INFO - PROCESS | 24396 | Values: 129.0 122.0 119.0 116.0 115.0 114.0 119.0 119.0 145.0 115.0 03:42:06 INFO - PROCESS | 24396 | 03:42:06 INFO - PROCESS | 24396 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.60 Median:151.50 stddev:2.37 (1.6%) stddev-sans-first:1.90 03:42:06 INFO - PROCESS | 24396 | Values: 156.0 150.0 149.0 149.0 151.0 150.0 151.0 152.0 154.0 154.0 03:42:06 INFO - PROCESS | 24396 | 03:42:06 INFO - PROCESS | 24396 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.60 Median:62.00 stddev:1.58 (2.5%) stddev-sans-first:1.67 03:42:06 INFO - PROCESS | 24396 | Values: 62.0 61.0 62.0 61.0 64.0 61.0 62.0 59.0 60.0 64.0 03:42:06 INFO - PROCESS | 24396 | -------- Summary: end -------- 03:42:06 INFO - PROCESS | 24396 | 03:42:07 INFO - TEST-INFO | 24396: exit 0 03:42:07 INFO - TEST-OK | kraken | took 60514ms 03:42:07 INFO - SUITE-END | took 1174s 03:42:07 INFO - Completed test suite (00:19:34) 03:42:07 INFO - javascript benchmark 03:42:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3236.126245913603, 3243.886463973761, 3246.9837650811755, 3291.2923721399893, 3309.966900330996, 5530.032244357237, 5608.270924779783, 5620.943790562093, 5639.5770317226215, 5664.830055098349, 5630.971845140769, 5747.568932330081, 5754.367019627837, 5767.740451679674, 5806.071028635419, 5052.520010598987, 5104.183330667094, 5110.386753589574, 5157.76790044447, 5220.321358223445, 5074.2895994560795, 5091.694498330112, 5189.714565698904, 5235.86910327243, 5245.606579506533, 5095.847124586268, 5137.332146820908, 5153.896922061556, 5156.69059856408, 5160.303359046518, 5160.5097515736325, 5162.1482455395, 5163.690178589297, 5174.870628234286, 5185.377754669464, 5029.547340739351, 5080.923786143211, 5092.0579692756955, 5097.643164978453, 5138.2806407103035, 5543.168524721284, 5550.555955523589, 5586.0, 5591.580631452657, 5613.354464236624, 6059.939400606026, 6071.071345040884, 6071.8495565978255, 6108.511319094506, 6111.052786818006, 6077.483413909823, 6086.666898653316, 6116.7553297868035, 6133.78531751391, 6181.938180618181, 5743.310802703661, 5795.710214489259, 5809.2738407699035, 5813.447722466359, 5813.854653633608, 6055.909161362583, 6276.592021518587, 6289.5911765736, 6290.779822706183, 6300.30696623371, 5839.620424672383, 5892.0, 5894.233749612523, 5944.048952167633, 5969.701514924236, 6004.279486461653, 6009.759609615654, 6037.607555508878, 6050.788222412282, 6052.213212282375, 5958.344582095966, 6006.579539432198, 6007.15899774032, 6020.729067191987, 6021.337652858182, 5987.401259873977, 6080.908786368208, 6093.695315234309, 6164.4760195383, 6166.753329866755, 4663.790129444184, 4695.460022097503, 4698.177818881751, 4715.693479923794, 4727.858164255009, 4127.979360103241, 4173.10278290163, 4191.937120943188, 4218.535961044283, 4227.725197862129, 5741.1388291756575, 5818.21454103699, 5819.4762471376935, 5868.677222752704, 5893.528517718572, 6172.938270617236, 6177.505799536027, 6180.505559555315, 6187.071939209155, 6199.473044791153, 5665.0, 5853.063509838491, 5857.26784151981, 5862.618929769551, 5887.558433117448, 5187.610929180327, 5288.2596436498925, 5298.6290959633225, 5344.5724342052545, 5368.275282836845, 6276.529260305495, 6310.368963103653, 6343.365663433712, 6347.079673447324, 6351.491880649537, 5945.464908158287, 6151.108089327112, 6156.445919867234, 6161.507079433724, 6166.568340216142, 6186.721597528032, 6252.5935814171935, 6262.405071518198, 6363.5227357947415, 6376.776812811529, 6044.942135126247, 6047.0, 6054.545909056927, 6054.848628784315, 6060.090986352083, 5992.400759923973, 6149.292831324455, 6159.81520554384, 6163.137160797582, 6166.475849552839, 5851.858887516893, 5896.64620122794, 5904.704764761659, 5923.052311630118, 5952.702364881652, 5856.590038697421, 5896.351401345934, 5903.203067585821, 5906.970465147647, 5958.821235362946, 5806.332271788799, 5833.416658334133, 5882.941170588239, 5889.440503152194, 5907.025340818888, 5947.91078133837, 5967.134765459071, 6026.487748541423, 6100.450959413674, 6101.267847858286, 5897.144913987534, 5907.17299578068, 5911.733971971357, 5912.615679980788, 5917.881642367214], "value": 5613.820029063572, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [604.9818505444838, 622.2470810319516, 626.2359920896507, 637.6142433827531, 647.873664635396, 34883.99999999997, 37756.81121594392, 37860.81069594648, 37933.0, 37991.43012854809, 38016.0, 47928.76035619817, 48829.51170488294, 48952.51047489524, 52383.21425178625, 9194.494302813342, 9291.349605527615, 9302.720918372459, 9304.953475232614, 9308.301877359192, 8702.390832641717, 9260.073992600719, 9340.859887101698, 9355.532223388804, 9356.719298421025, 11054.889451105506, 11289.887101129007, 11304.208705390625, 11695.122865785057, 11699.473523691455, 11426.485808138654, 11479.36863472517, 11521.078313734964, 11523.711907202303, 11531.827022594667, 8432.957835210786, 10930.398828064453, 11195.384253866034, 11268.774624507463, 11274.661760147126, 46002.30996535055, 46714.766426167655, 46742.29886551671, 46746.0, 46802.531974680496, 3674.0998455378603, 3928.862489812843, 3963.7225394222414, 4060.3909413587903, 4491.887702807423, 34939.0, 35096.47355289673, 35105.718128321576, 35109.82445087784, 35326.0, 4540.500544940054, 4578.679492435531, 4610.76946152691, 4637.5594318540025, 4662.230731929228, 375434.0, 376845.0, 377489.0, 378483.0, 379530.0, 63467.365326346146, 63561.68219158967, 63730.36269637337, 63964.36035639677, 64071.67964160242, 65825.0, 65847.34152658508, 65867.0, 66488.0, 66695.0, 13966.86033139676, 14097.295135243197, 14155.150690958575, 14189.78715319271, 14219.075760075562, 11234.49444774987, 11260.831087533694, 11291.54833806655, 11301.547938082549, 11303.547858085749, 15928.442504512286, 16385.0, 16401.83598164027, 17713.0, 17805.287788488575, 5313.973430132902, 6200.968995154995, 6205.314987184646, 6310.337414571496, 6312.905306420407, 1011.716719318592, 1096.572336788653, 1117.6982214801958, 1118.3178261260625, 1198.4726720243066, 35299.0, 35744.82127589398, 35751.28497430037, 35933.28133437317, 36021.0, 1174.8531433570804, 1193.8388317577017, 1208.5045131496045, 1225.3383173086434, 1231.2489381477292, 17489.56276093108, 18589.814101858807, 18691.345802896834, 18714.625707486048, 18777.0, 619050.0, 622862.0, 624259.0, 625033.0, 625708.0, 56854.43145568574, 63428.68285658542, 64307.67846160739, 64813.0, 65187.0, 1409.7603407420763, 1423.181670539444, 1426.4436869620856, 1429.7712366021387, 1462.824461064679, 33704.66295337015, 36797.44803827998, 36813.63186368102, 36829.0, 37038.25923481569, 55540.16689749738, 55988.0, 56025.0, 56042.43957560372, 56060.43939560552, 552297.0, 560946.0, 561707.0, 831446.0, 833357.0, 30672.233194170323, 30701.23246918845, 30736.23159420943, 30960.69039309578, 31103.68896311008, 52159.0, 52316.47683523116, 52583.73708131588, 52867.20699189438, 53840.730796345764, 44831.77584112059, 44868.55131448644, 44928.10143797171, 45552.54447455483, 46785.766071169426, 44118.77940610277, 45864.0, 45892.54107458883, 46030.53969460396, 46968.29547556858, 44084.0, 45038.77480612576, 45080.323795143755, 45684.0, 45786.0, 35901.28197436089, 39964.20071598494, 40585.79707101446, 40878.59121408748, 41157.794211028755, 29344.0, 30468.238294042825, 30492.847535763067, 30840.845795770878, 30904.227394315323], "value": 21693.57224969448, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.1093129527271, 426.7021128015449, 432.4983019697151, 434.15990059235384, 435.72331569453405, 15900.681986360265, 19562.510937226576, 20125.19499220031, 20191.798082019177, 21037.789622103774, 20331.28840490583, 20417.0, 20425.28511502098, 20438.08028638711, 20713.067911943963, 5773.9422605773825, 5803.883922321562, 5875.471207591316, 5936.109583562457, 5960.344362120163, 5850.414958504158, 5870.794522191724, 5881.323647780518, 5889.793857214999, 5899.439553242435, 5769.82690519283, 5866.325372582165, 5870.0314448116005, 5892.322382925976, 5895.145203945425, 5788.102844059156, 5822.941770582324, 5868.149118377854, 5889.941100589003, 5920.763169473237, 5233.895322093575, 5308.416074231832, 5340.359156901158, 5340.412554618989, 5343.652662576959, 21274.255401061044, 23795.881020594785, 23853.761462385326, 24371.512569748684, 24547.87726061376, 2335.801456876168, 2510.364346647527, 2580.548404029287, 2601.8959241630314, 2949.218457108868, 10989.670309890636, 11336.206465547415, 11351.091912646969, 11421.42892855354, 11593.60876694802, 2052.1791283486577, 2088.321295578943, 2106.820920221783, 2128.6806978953127, 2247.0225451928463, 82676.0, 84186.73945866011, 84782.15217847805, 86728.56635716844, 88982.5550872248, 11677.416129193507, 11762.176647634584, 11791.587294444653, 11841.23032002917, 11919.642410727693, 16773.412930547373, 16803.907745996472, 16807.747883781754, 16812.74780878288, 16813.831861681472, 7726.806829829299, 7965.761027169194, 7969.561674107979, 7973.681052757941, 8211.95894020538, 7181.281871812777, 7468.178500364956, 7508.43686723487, 7569.425920986368, 7724.871427072045, 5020.472850350734, 5059.266406371129, 5084.3898732152375, 5163.148080566664, 5210.791568337224, 2040.734704488407, 2115.365390382879, 2157.5769672172296, 2167.4581354661336, 2200.592890315265, 458.7706146926537, 486.7809485731435, 502.5000124875699, 921.9124183202586, 983.6606370802061, 12446.37768111609, 12466.920319162624, 12827.486900524062, 12905.483780648668, 13417.127886687334, 494.2339373970332, 503.9571636410946, 510.2932438572604, 511.05709965114306, 520.8255234496486, 6881.10545629065, 6974.058502102152, 7051.717931282794, 7154.892676609855, 7169.5698258104685, 526821.0, 528172.0, 528986.0, 533183.0, 550387.0, 61268.0, 83113.58443207866, 95631.52184239174, 96266.0, 96519.51740241394, 499.73264303597404, 508.524529564858, 509.56432250425354, 511.4578546740467, 512.2751306900768, 16922.830771692126, 17493.650126997643, 18344.357947471774, 19050.52373690669, 19455.61088778188, 41122.58877411188, 41560.0, 41630.37554436747, 41792.791036044626, 42629.93425164396, 50783.492165079355, 56568.0, 57778.422215777304, 58751.23746287618, 59481.70259148676, 8837.469751814655, 8853.114688531095, 8907.421017633833, 9000.86498702533, 9146.817063658556, 12194.512219511475, 12698.746025079261, 12859.678508037374, 13486.86513134856, 14609.780853287422, 11520.193586448868, 11839.467223975114, 11917.34454605005, 11936.0, 12719.364031798188, 11835.467403967014, 12118.818217726917, 12272.815907761213, 12434.253944763343, 12662.113652044269, 11348.092152627605, 11941.343226122646, 12356.443960022001, 12432.378381080729, 12820.358982051046, 7928.722494712888, 8035.598220089089, 8168.550729709923, 8483.490990540588, 9090.36367454272, 11506.654800356002, 11656.30062196271, 11856.525738970344, 11951.282923024646, 12412.62762117138], "value": 8829.49577030905, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1535.470262759348, 1592.9601759956, 1769.3807167491373, 1828.615990641965, 1880.435869239228, 9258.981512033672, 9962.053604907522, 9962.153216976547, 9968.850467242997, 9971.850422243671, 8342.791430214247, 9121.771955701111, 9451.33840631156, 9470.76323091923, 9756.219502439806, 2409.4337830609793, 2456.435019945414, 2458.4591389894285, 2458.50829834033, 2460.9786938420534, 2158.568286342738, 2207.8896055197256, 2245.438640339915, 2251.583457060449, 2256.0524579676576, 2466.8643224622638, 2475.393528585499, 2489.5643262429094, 2493.8254322197454, 2494.5260400523844, 2407.8194135439912, 2408.205292253552, 2413.9396515087087, 2416.4442178299, 2448.20433359159, 2408.759124087577, 2411.7105947286263, 2411.9035238590436, 2414.2395145529104, 2417.830751847371, 9650.0, 9816.26378021644, 9851.50742462874, 9854.0, 9864.901350986542, 5375.301210842605, 5521.723913804293, 5524.806631767909, 5530.446955304477, 5539.750711217965, 3296.456084746014, 3333.250018745787, 3357.6306606273533, 3386.610539787907, 3388.203772113576, 1134.387430787382, 1153.26191237608, 1153.6423708650345, 1158.1314014489133, 1164.2025212729307, 13662.726745465035, 13668.794968075486, 13716.354037515563, 13724.519641812589, 13734.519291824838, 4735.384400027974, 4755.7872742451145, 4818.277258411266, 4832.275158726219, 4920.335754673145, 11250.606228781953, 11256.380899050631, 11293.491792869341, 11315.321080735182, 11318.26431281964, 5489.313835770528, 5529.281193444826, 5534.640248383923, 5555.0834112371, 5555.416681248492, 4422.226110430726, 4661.137689527448, 4661.720296782204, 4731.493362346104, 5058.4435712071645, 4017.276890159799, 4026.214888096793, 4112.3420252759415, 4113.691473139526, 4118.6499147572795, 1328.554934097069, 1338.8259526261525, 1343.7715588349809, 1348.1776116568885, 1356.7422189783908, 1017.9643712470177, 1034.1519953637944, 1053.2153545608571, 1059.1999364082608, 1070.314998401024, 6276.6547839869245, 6277.435030847246, 6291.811245662638, 6497.740090396331, 6576.4410025147445, 444.76872026546664, 453.80940005197897, 454.46373279530474, 460.53946053946055, 468.1129260052182, 4501.392312037899, 4512.2329204035395, 4546.227141385973, 4572.74849883253, 4623.352730617717, 11402.0, 11481.655550333504, 11818.586349477728, 11825.586104486301, 12040.518379264906, 12225.327606981702, 12253.509859605694, 12269.69325766845, 12270.2637841728, 12291.692707682201, 8881.067487913677, 9008.144226298491, 9033.548322583976, 9046.638134474679, 9064.048274931169, 6346.079818426395, 6464.967675161594, 6559.639219842955, 6576.145101136822, 6647.634380109141, 10596.682099537025, 10708.357498550113, 10720.0, 10731.517081731185, 10765.569377224823, 10077.344972576759, 10489.632862849763, 10786.946065269938, 10800.675979720621, 10932.344059356465, 8000.079990801132, 8197.71308004241, 8367.95816020916, 8381.203785640355, 8381.329493640616, 9364.438133712, 9576.377535460173, 9626.278029147701, 9638.566264517973, 9643.758906027406, 8232.0, 8238.629261683118, 8300.501969881827, 8401.201885820838, 8739.475631462132, 7827.647755850887, 8014.559199244098, 8110.716124935835, 8241.093479717347, 8461.788455288666, 7704.460687751804, 7713.6143192841255, 7827.178146294557, 7922.524648520876, 7928.167542407964, 5053.545180933734, 5103.157978933435, 5125.74371281427, 5235.0, 5400.486953739389, 5316.229146773619, 5419.105847535113, 5419.945800541944, 5479.643823151482, 5589.55283577321], "value": 4834.49896675362, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.38733954843985, 344.4402845376264, 357.8461261657488, 373.3522338742283, 374.53931664053215, 5475.260839786628, 5494.478024587663, 5551.528120109796, 5571.470710282521, 5586.525145362649, 5119.744012799364, 5233.528982391584, 5395.352557693082, 5398.24424580559, 5413.972930135344, 4292.0, 4294.720843145185, 4294.785260736966, 4303.6772242081815, 4308.633766129867, 4353.45322986052, 4362.345648152771, 4369.1480161368545, 4372.409724687174, 4398.560143985608, 4099.077707515815, 4245.681573881956, 4264.87205383839, 4269.188854117723, 4328.502222244435, 4223.87328380146, 4237.894052648678, 4238.922927765404, 4242.575742425764, 4250.766207858566, 3752.9812350938346, 3753.8123093845197, 3756.530433695788, 3762.529683789526, 3780.372641014496, 5251.291075704769, 5339.919901201485, 5342.332208473941, 5365.865853353658, 5397.62216644835, 4811.4707382187935, 4837.129316722989, 4857.304196171123, 4864.537868902484, 4878.560929516325, 5659.689081887101, 5662.207290979266, 5702.6293290935955, 5705.315362156526, 5706.887157004386, 4050.392441133824, 4123.711340206187, 4131.814068366931, 4157.97921010396, 4182.975171083104, 5882.6470411775, 5925.8814823703715, 5933.673647949361, 5942.70286485674, 5963.46328830403, 4305.892352691208, 4326.3510473428605, 4328.718633288826, 4334.28484300087, 4337.8481753138485, 4160.981923766971, 4372.1692878353015, 4383.167198232326, 4393.714408563433, 4403.2734598791485, 4915.557599816034, 4933.161362568372, 4936.580390666762, 4944.678595891256, 4998.0, 5822.126680997884, 5830.271216097988, 5835.416458354215, 5848.415158484203, 5890.646561206341, 1425.1947649577955, 1429.756941319978, 1454.5781723300336, 1490.0835985868612, 1503.8570686278508, 1020.8570800087994, 1024.7489365105596, 1049.2445439283856, 1049.679847646475, 1051.1328154272755, 5508.779648814003, 5550.888982220333, 5560.693237089281, 5576.498115169654, 5598.664080155204, 5829.9101476217675, 5836.795712150054, 5837.153612726131, 5861.88276234473, 5874.530037597067, 5406.4321346809775, 5530.972345138249, 5552.611317207838, 5554.833354999357, 5641.774329026793, 3101.72084512395, 3138.717515423623, 3140.136462472838, 3172.8413579321405, 3173.904782856518, 6045.732191020174, 6131.724072416752, 6145.201123853871, 6145.354737752472, 6169.290531588835, 5806.516090345844, 5964.671943043088, 5972.50687328168, 6008.3390827009, 6016.338202797689, 6046.727897244635, 6048.395160483917, 6080.69596520181, 6090.482309003784, 6100.206973093469, 5622.493975542221, 5886.676232807236, 5887.499562537061, 5893.499052580407, 5921.437463440966, 5846.859862326975, 5847.327557330961, 5860.413958604276, 5877.882442351214, 5888.293404791452, 5863.618864773776, 6124.6325220486915, 6134.539909506716, 6141.47797437205, 6166.845828854314, 4250.383694364238, 4286.957130428656, 4302.82788688449, 4319.984803571221, 4339.218940590724, 5999.88000239984, 6019.668918209541, 6024.457798798129, 6042.879142417215, 6045.848853778691, 5605.439456054362, 5682.119271512922, 5683.5453163747625, 5720.313562372542, 5763.567732420001, 5736.799212027559, 5744.4829965303325, 5755.820056888244, 5764.9711751442655, 5765.625234359753, 5560.36055853582, 5685.602007859576, 5725.599208055396, 5728.828135155952, 5729.140628905698, 5741.110127930177, 5777.9133313001175, 5780.8554786129, 5784.739686714024, 5789.33422656383, 5605.271314729059, 5622.381538030895, 5622.718864056863, 5635.8591035224445, 5676.360492371067], "value": 4413.32576205779, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [746.4998451037804, 751.3538357012966, 767.992320076799, 819.4714409206063, 923.8752768376268, 16457.670846583074, 17225.56936076599, 17251.396201132964, 17269.30922763091, 17309.0, 14562.563123106298, 14732.18972956487, 14786.926065369686, 14811.407543698238, 15188.088714677127, 720.5388551327142, 834.6369329341726, 860.0324634785866, 866.7399780065987, 870.2863651805491, 872.5026734761188, 878.6529320918233, 878.6748902905902, 879.0857508191473, 880.1594477274188, 923.7921467669754, 925.2366797392144, 925.3013974449282, 926.5089502563618, 927.2165020557618, 749.632679986808, 878.9296856251517, 902.2285945516587, 906.7415786500882, 911.3301723233418, 661.0876989754156, 661.7981515637777, 662.2318110991228, 662.3773652766432, 662.4965026579835, 14810.703785924328, 14813.111213327127, 14818.925905370512, 14827.0362426443, 14840.0, 14278.214698191596, 14340.784888226684, 14567.781483277759, 14658.193799341032, 14982.550523484313, 12992.350382480838, 13051.0, 13129.86870131296, 13227.669308267274, 13367.665808354868, 4521.7739113044545, 4574.794134263966, 4633.096546173498, 4648.093621743761, 4648.976755116203, 78886.0, 79526.0, 80260.79608805872, 80715.5964220181, 82754.0, 12197.268163910016, 12221.327826969424, 12231.327276999673, 12363.93818030904, 12577.308248046262, 22893.313200604007, 22953.655695164587, 22991.080356785875, 23012.07951681914, 23023.0, 8769.693060742844, 8989.280857531381, 9050.773730656787, 9291.442513449214, 9384.90615093854, 4926.187179115406, 5028.698278103326, 5118.616103792156, 5151.201563757623, 5277.445868183862, 3781.8487260509823, 3875.418687196887, 3901.6098390161324, 3904.9804750976064, 3910.081130934228, 643.4980715042275, 647.3170804800981, 659.3670076726396, 663.3731124087788, 665.0987911380107, 631.8136149835717, 659.0213532903634, 685.530411668009, 726.6512074204411, 757.1141764135974, 9786.706398808046, 9831.557579908778, 9958.900410995797, 10153.593856245816, 10215.540300686338, 543.2747282377991, 586.6362855029909, 653.7189008726293, 729.1687476277049, 760.0309605253236, 4856.739174933497, 5027.572656324253, 5035.496450354935, 5054.671446356048, 5081.898362032739, 105888.47055764672, 134171.30400436133, 134767.0, 136076.0, 138941.0, 112794.0, 115004.42497787625, 118507.40746296386, 118692.0, 119138.40430797964, 95962.0, 97249.0, 99653.50173249087, 99912.0, 100916.49541752244, 9583.664571739955, 9631.422114673142, 9734.172595329193, 9765.414075155513, 9782.0, 59684.40315596962, 60513.69743151256, 60670.0, 62093.37906620876, 63996.36003639904, 84434.0, 87413.0, 88578.55710721404, 89475.0, 91009.54495227481, 12049.638510844688, 12389.318587477776, 12552.121351505672, 12584.685382865502, 12608.432620531914, 12273.386330683608, 12538.185017973803, 12596.496140154291, 12698.68253293638, 13188.472461101448, 12279.877201227873, 12305.26168429897, 12417.503299867903, 12955.676108097374, 13093.279869607262, 11177.871441524965, 11298.209125361145, 11369.602063927723, 11436.542538298374, 11464.25482343645, 11011.724706882393, 11042.116630669367, 11058.447077646246, 11272.83090753623, 11290.266132701348, 9817.509124543887, 10134.695959121238, 10322.329048612117, 10518.0, 10664.680059598224, 9657.275704322063, 9799.363041402286, 9870.0, 9904.851427228454, 9924.955236021464], "value": 7793.770225345127, "unit": "score"}], "name": "dromaeo_css", "value": 7505.9496288326645, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 110.0, 110.0, 110.0, 111.0, 109.0, 110.0, 108.0, 109.0, 109.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 115.0, 123.0, 182.0, 120.0, 117.0, 145.0, 115.0, 143.0, 115.0], "value": 131.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 160.0, 160.0, 159.0, 159.0, 159.0, 160.0, 160.0], "value": 159.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 119.0, 74.0, 77.0, 74.0, 74.0, 101.0, 76.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 118.0, 84.0, 84.0, 82.0, 114.0, 83.0, 84.0, 132.0], "value": 94.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 156.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 97.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 50.0, 51.0, 52.0, 51.0, 52.0, 51.0, 51.0, 50.0], "value": 50.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 59.0, 59.0, 59.0, 63.0, 59.0, 59.0, 59.0, 59.0], "value": 59.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 73.0, 73.0, 74.0, 82.0, 81.0, 72.0, 72.0, 77.0], "value": 75.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 122.0, 119.0, 116.0, 115.0, 114.0, 119.0, 119.0, 145.0, 115.0], "value": 121.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 150.0, 149.0, 149.0, 151.0, 150.0, 151.0, 152.0, 154.0, 154.0], "value": 151.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 62.0, 61.0, 64.0, 61.0, 62.0, 59.0, 60.0, 64.0], "value": 61.6, "unit": "score"}], "name": "kraken", "value": 1455.6999999999996, "alertThreshold": 2.0}]} 03:42:07 INFO - Return code: 0 03:42:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:42:08 INFO - # TBPL SUCCESS # 03:42:08 INFO - Running post-action listener: _resource_record_post_action 03:42:08 INFO - [mozharness: 2016-08-02 10:42:08.047694Z] Finished run-tests step (success) 03:42:08 INFO - Running post-run listener: _resource_record_post_run 03:42:08 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 513798144; Read time: 8; Write time: 371352 03:42:08 INFO - TinderboxPrint: CPU usage
12.9% 03:42:08 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 03:42:08 INFO - TinderboxPrint: I/O write bytes / time
513,798,144 / 371,352 03:42:08 INFO - TinderboxPrint: CPU idle
8,277.1 (87.1%) 03:42:08 INFO - TinderboxPrint: CPU user
1,181.1 (12.4%) 03:42:08 INFO - TinderboxPrint: Swap in / out
0 / 0 03:42:08 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 264704000; Read time: 0; Write time: 220120 03:42:08 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 249094144; Read time: 0; Write time: 151232 03:42:08 INFO - Running post-run listener: _upload_blobber_files 03:42:08 INFO - Blob upload gear active. 03:42:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:42:08 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 03:42:08 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:42:08 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:42:09 INFO - (blobuploader) - INFO - Open directory for files ... 03:42:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:42:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:42:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:42:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:42:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:42:09 INFO - (blobuploader) - INFO - Done attempting. 03:42:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:42:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:42:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:42:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:42:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:42:10 INFO - (blobuploader) - INFO - Done attempting. 03:42:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:42:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:42:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:42:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:42:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:42:15 INFO - (blobuploader) - INFO - Done attempting. 03:42:15 INFO - (blobuploader) - INFO - Iteration through files over. 03:42:15 INFO - Return code: 0 03:42:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:42:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:42:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b3edb22177c3795fdc0b0821a7b5560b93442ca803ef2f7147d333000c520af696aecafd0aba3a7a70caca08a4a65a593db704bd53cea1df2e57ed0754bcb276", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0dcd2946be43e4ef2e2acb45bbd218d78f44f079f022bae791674fb5ce71f532c2a3559728a17ff81d0810066c51eeb17f05916a8bf89609841c34ef06490658", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e582e47288e865c84bd06267a6df4d4f2ac6547ce5aa3de954a8852fa6680f4e3fe333990d7d717d3fd2bf9b1abd09671f68b759ab38428c12859e674b61d618"} 03:42:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:42:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:42:15 INFO - Contents: 03:42:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b3edb22177c3795fdc0b0821a7b5560b93442ca803ef2f7147d333000c520af696aecafd0aba3a7a70caca08a4a65a593db704bd53cea1df2e57ed0754bcb276", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0dcd2946be43e4ef2e2acb45bbd218d78f44f079f022bae791674fb5ce71f532c2a3559728a17ff81d0810066c51eeb17f05916a8bf89609841c34ef06490658", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e582e47288e865c84bd06267a6df4d4f2ac6547ce5aa3de954a8852fa6680f4e3fe333990d7d717d3fd2bf9b1abd09671f68b759ab38428c12859e674b61d618"} 03:42:15 INFO - Running post-run listener: copy_logs_to_upload_dir 03:42:15 INFO - Copying logs to upload dir... 03:42:15 INFO - mkdir: /builds/slave/test/build/upload/logs 03:42:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.078121 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-08-02 03:42:15.305069) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-02 03:42:15.308719) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1470133305.66338-1953637177 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b3edb22177c3795fdc0b0821a7b5560b93442ca803ef2f7147d333000c520af696aecafd0aba3a7a70caca08a4a65a593db704bd53cea1df2e57ed0754bcb276", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0dcd2946be43e4ef2e2acb45bbd218d78f44f079f022bae791674fb5ce71f532c2a3559728a17ff81d0810066c51eeb17f05916a8bf89609841c34ef06490658", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e582e47288e865c84bd06267a6df4d4f2ac6547ce5aa3de954a8852fa6680f4e3fe333990d7d717d3fd2bf9b1abd09671f68b759ab38428c12859e674b61d618"} build_url:https://queue.taskcluster.net/v1/task/Ap0rsVMFRIipaeFevlR8fQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011459 build_url: 'https://queue.taskcluster.net/v1/task/Ap0rsVMFRIipaeFevlR8fQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b3edb22177c3795fdc0b0821a7b5560b93442ca803ef2f7147d333000c520af696aecafd0aba3a7a70caca08a4a65a593db704bd53cea1df2e57ed0754bcb276", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0dcd2946be43e4ef2e2acb45bbd218d78f44f079f022bae791674fb5ce71f532c2a3559728a17ff81d0810066c51eeb17f05916a8bf89609841c34ef06490658", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e582e47288e865c84bd06267a6df4d4f2ac6547ce5aa3de954a8852fa6680f4e3fe333990d7d717d3fd2bf9b1abd09671f68b759ab38428c12859e674b61d618"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-02 03:42:15.334615) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 03:42:15.334967) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1470133305.66338-1953637177 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004482 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 03:42:15.418137) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-02 03:42:15.418471) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-02 03:42:15.418836) ========= ========= Total master_lag: 0.17 =========