builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-003 starttime: 1469632618.0 results: success (0) buildid: 20160727053024 builduid: 69a2d48d07c349f28216930a9ef91c08 revision: 4b767c8f023685e9e598f026453fbd906e0e8d1f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 08:16:58.003954) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 08:16:58.004804) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 08:16:58.005135) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 08:16:58.037874) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 08:16:58.038193) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7de08804244eb36560b44971000001c3-1469631595.896845-1471727622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-27 08:16:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.0M=0s 2016-07-27 08:16:58 (43.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119450 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 08:16:58.175812) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 08:16:58.176194) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7de08804244eb36560b44971000001c3-1469631595.896845-1471727622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015969 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 08:16:58.226548) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-27 08:16:58.226953) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4b767c8f023685e9e598f026453fbd906e0e8d1f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 4b767c8f023685e9e598f026453fbd906e0e8d1f --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7de08804244eb36560b44971000001c3-1469631595.896845-1471727622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-27 08:16:58,671 truncating revision to first 12 chars 2016-07-27 08:16:58,671 Setting DEBUG logging. 2016-07-27 08:16:58,671 attempt 1/10 2016-07-27 08:16:58,672 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4b767c8f0236?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-27 08:16:59,667 unpacking tar archive at: fx-team-4b767c8f0236/testing/mozharness/ program finished with exit code 0 elapsedTime=1.346015 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-27 08:16:59.589388) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 08:16:59.590024) ========= script_repo_revision: 4b767c8f023685e9e598f026453fbd906e0e8d1f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 08:16:59.590830) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 08:16:59.591351) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 08:16:59.602717) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-07-27 08:16:59.603048) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7de08804244eb36560b44971000001c3-1469631595.896845-1471727622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:17:00 INFO - MultiFileLogger online at 20160727 08:17:00 in /builds/slave/test 08:17:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:17:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:17:00 INFO - {'append_to_log': False, 08:17:00 INFO - 'base_work_dir': '/builds/slave/test', 08:17:00 INFO - 'blob_upload_branch': 'Fx-Team', 08:17:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:17:00 INFO - 'branch': 'Fx-Team', 08:17:00 INFO - 'buildbot_json_path': 'buildprops.json', 08:17:00 INFO - 'config_files': ('talos/linux_config.py',), 08:17:00 INFO - 'default_actions': ('clobber', 08:17:00 INFO - 'read-buildbot-config', 08:17:00 INFO - 'download-and-extract', 08:17:00 INFO - 'populate-webroot', 08:17:00 INFO - 'create-virtualenv', 08:17:00 INFO - 'install', 08:17:00 INFO - 'run-tests'), 08:17:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:17:00 INFO - 'download_minidump_stackwalk': True, 08:17:00 INFO - 'download_symbols': 'ondemand', 08:17:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:17:00 INFO - 'tooltool.py': '/tools/tooltool.py', 08:17:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:17:00 INFO - '/tools/misc-python/virtualenv.py')}, 08:17:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:17:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:17:00 INFO - 'installer_path': 'installer.exe', 08:17:00 INFO - 'log_level': 'info', 08:17:00 INFO - 'log_name': 'talos', 08:17:00 INFO - 'log_to_console': True, 08:17:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:17:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:17:00 INFO - 'opt_config_files': (), 08:17:00 INFO - 'pip_index': False, 08:17:00 INFO - 'sps_profile': False, 08:17:00 INFO - 'sps_profile_interval': 0, 08:17:00 INFO - 'suite': 'dromaeojs', 08:17:00 INFO - 'system_bits': '32', 08:17:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:17:00 INFO - 'title': 'talos-linux64-ix-003', 08:17:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:17:00 INFO - 'use_talos_json': True, 08:17:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:17:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:17:00 INFO - 'work_dir': 'build'} 08:17:00 INFO - [mozharness: 2016-07-27 15:17:00.133652Z] Running clobber step. 08:17:00 INFO - Running pre-action listener: _resource_record_pre_action 08:17:00 INFO - Running main action method: clobber 08:17:00 INFO - rmtree: /builds/slave/test/build 08:17:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:17:01 INFO - Running post-action listener: _resource_record_post_action 08:17:01 INFO - [mozharness: 2016-07-27 15:17:01.120527Z] Finished clobber step (success) 08:17:01 INFO - [mozharness: 2016-07-27 15:17:01.120638Z] Running read-buildbot-config step. 08:17:01 INFO - Running pre-action listener: _resource_record_pre_action 08:17:01 INFO - Running main action method: read_buildbot_config 08:17:01 INFO - Using buildbot properties: 08:17:01 INFO - { 08:17:01 INFO - "project": "", 08:17:01 INFO - "product": "firefox", 08:17:01 INFO - "script_repo_revision": "production", 08:17:01 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:17:01 INFO - "repository": "", 08:17:01 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:17:01 INFO - "buildid": "20160727053024", 08:17:01 INFO - "pgo_build": "True", 08:17:01 INFO - "basedir": "/builds/slave/test", 08:17:01 INFO - "buildnumber": 1371, 08:17:01 INFO - "slavename": "talos-linux64-ix-003", 08:17:01 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:17:01 INFO - "platform": "ubuntu64_hw", 08:17:01 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:17:01 INFO - "branch": "fx-team", 08:17:01 INFO - "repo_path": "integration/fx-team", 08:17:01 INFO - "revision": "4b767c8f023685e9e598f026453fbd906e0e8d1f", 08:17:01 INFO - "stage_platform": "linux64-pgo", 08:17:01 INFO - "builduid": "69a2d48d07c349f28216930a9ef91c08", 08:17:01 INFO - "slavebuilddir": "test" 08:17:01 INFO - } 08:17:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/UpAXm9HORO2hg6hi4sbyjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:17:01 INFO - Running post-action listener: _resource_record_post_action 08:17:01 INFO - [mozharness: 2016-07-27 15:17:01.123135Z] Finished read-buildbot-config step (success) 08:17:01 INFO - [mozharness: 2016-07-27 15:17:01.123225Z] Running download-and-extract step. 08:17:01 INFO - Running pre-action listener: _resource_record_pre_action 08:17:01 INFO - Running main action method: download_and_extract 08:17:01 INFO - mkdir: /builds/slave/test/build/tests 08:17:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:17:01 INFO - https://queue.taskcluster.net/v1/task/UpAXm9HORO2hg6hi4sbyjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:17:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UpAXm9HORO2hg6hi4sbyjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:17:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UpAXm9HORO2hg6hi4sbyjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:17:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UpAXm9HORO2hg6hi4sbyjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:17:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UpAXm9HORO2hg6hi4sbyjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:17:02 INFO - Downloaded 1361 bytes. 08:17:02 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:17:02 INFO - Using the following test package requirements: 08:17:02 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:17:02 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:17:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:17:02 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:17:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:17:02 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:17:02 INFO - u'jsshell-linux-x86_64.zip'], 08:17:02 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:17:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:17:02 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:17:02 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:17:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:17:02 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:17:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:17:02 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:17:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:17:02 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:17:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:17:02 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:17: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')]} 08:17:02 INFO - https://queue.taskcluster.net/v1/task/UpAXm9HORO2hg6hi4sbyjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:17:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UpAXm9HORO2hg6hi4sbyjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:17:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UpAXm9HORO2hg6hi4sbyjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:17:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UpAXm9HORO2hg6hi4sbyjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:17:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UpAXm9HORO2hg6hi4sbyjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:17:03 INFO - Downloaded 24315124 bytes. 08:17:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:17:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:17:05 INFO - Return code: 0 08:17:05 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:17:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:17:05 INFO - https://queue.taskcluster.net/v1/task/UpAXm9HORO2hg6hi4sbyjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:17:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UpAXm9HORO2hg6hi4sbyjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:17:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UpAXm9HORO2hg6hi4sbyjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:17:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UpAXm9HORO2hg6hi4sbyjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:17:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UpAXm9HORO2hg6hi4sbyjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:17:14 INFO - Downloaded 24315124 bytes. 08:17:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:17:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:17:16 INFO - Return code: 0 08:17: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')]} 08:17:16 INFO - https://queue.taskcluster.net/v1/task/UpAXm9HORO2hg6hi4sbyjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:17:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UpAXm9HORO2hg6hi4sbyjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:17:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UpAXm9HORO2hg6hi4sbyjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:17:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UpAXm9HORO2hg6hi4sbyjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:17:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UpAXm9HORO2hg6hi4sbyjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:17:17 INFO - Downloaded 14413725 bytes. 08:17:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:17:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:17:18 INFO - Return code: 0 08:17:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:17:18 INFO - https://queue.taskcluster.net/v1/task/UpAXm9HORO2hg6hi4sbyjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:17:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UpAXm9HORO2hg6hi4sbyjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:17:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UpAXm9HORO2hg6hi4sbyjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:17:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UpAXm9HORO2hg6hi4sbyjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:17:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UpAXm9HORO2hg6hi4sbyjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:17:19 INFO - Downloaded 60900813 bytes. 08:17:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UpAXm9HORO2hg6hi4sbyjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:17:19 INFO - mkdir: /builds/slave/test/properties 08:17:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:17:19 INFO - Writing to file /builds/slave/test/properties/build_url 08:17:19 INFO - Contents: 08:17:19 INFO - build_url:https://queue.taskcluster.net/v1/task/UpAXm9HORO2hg6hi4sbyjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:17:19 INFO - Running post-action listener: _resource_record_post_action 08:17:20 INFO - Running post-action listener: set_extra_try_arguments 08:17:20 INFO - [mozharness: 2016-07-27 15:17:20.081752Z] Finished download-and-extract step (success) 08:17:20 INFO - [mozharness: 2016-07-27 15:17:20.081991Z] Running populate-webroot step. 08:17:20 INFO - Running pre-action listener: _resource_record_pre_action 08:17:20 INFO - Running main action method: populate_webroot 08:17:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:17:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:17:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:17:20 INFO - '--tppagecycles', 08:17:20 INFO - '7'], 08:17:20 INFO - 'tests': ['tsvgm']}}, 08:17:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:17:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:17:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:17:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:17:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:17:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:17:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:17:20 INFO - 'talos_options': ['--disable-e10s'], 08:17:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:17:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:17:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:17:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:17:20 INFO - 'talos_options': ['--disable-e10s'], 08:17:20 INFO - 'tests': ['damp', 'tps']}, 08:17:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:17:20 INFO - 'tests': ['damp', 'tps']}, 08:17:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:17:20 INFO - 'tests': ['dromaeo_dom']}, 08:17:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:17:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:17:20 INFO - 'tests': ['basic_compositor_video']}, 08:17:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:17:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:17:20 INFO - 'tests': ['a11yr', 08:17:20 INFO - 'ts_paint', 08:17:20 INFO - 'tpaint', 08:17:20 INFO - 'sessionrestore', 08:17:20 INFO - 'sessionrestore_no_auto_restore', 08:17:20 INFO - 'tabpaint']}, 08:17:20 INFO - 'other-e10s': {'tests': ['a11yr', 08:17:20 INFO - 'ts_paint', 08:17:20 INFO - 'tpaint', 08:17:20 INFO - 'sessionrestore', 08:17:20 INFO - 'sessionrestore_no_auto_restore', 08:17:20 INFO - 'tabpaint']}, 08:17:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:17:20 INFO - 'ts_paint', 08:17:20 INFO - 'tpaint', 08:17:20 INFO - 'sessionrestore', 08:17:20 INFO - 'sessionrestore_no_auto_restore', 08:17:20 INFO - 'tabpaint']}, 08:17:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:17:20 INFO - 'ts_paint', 08:17:20 INFO - 'tpaint', 08:17:20 INFO - 'sessionrestore', 08:17:20 INFO - 'sessionrestore_no_auto_restore', 08:17:20 INFO - 'tabpaint']}, 08:17:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:17:20 INFO - 'tests': ['a11yr', 08:17:20 INFO - 'ts_paint', 08:17:20 INFO - 'tpaint', 08:17:20 INFO - 'sessionrestore', 08:17:20 INFO - 'sessionrestore_no_auto_restore', 08:17:20 INFO - 'tabpaint']}, 08:17:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:17:20 INFO - 'tests': ['a11yr', 08:17:20 INFO - 'ts_paint', 08:17:20 INFO - 'tpaint', 08:17:20 INFO - 'sessionrestore', 08:17:20 INFO - 'sessionrestore_no_auto_restore', 08:17:20 INFO - 'tabpaint']}, 08:17:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:17:20 INFO - 'tests': ['tsvgx', 08:17:20 INFO - 'tsvgr_opacity', 08:17:20 INFO - 'tart', 08:17:20 INFO - 'tscrollx', 08:17:20 INFO - 'cart']}, 08:17:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:17:20 INFO - 'tsvgr_opacity', 08:17:20 INFO - 'tart', 08:17:20 INFO - 'tscrollx', 08:17:20 INFO - 'cart']}, 08:17:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:17:20 INFO - 'talos_options': ['--disable-e10s'], 08:17:20 INFO - 'tests': ['tp5o']}, 08:17:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:17:20 INFO - 'tests': ['tp5o']}, 08:17:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:17:20 INFO - 'talos_options': ['--disable-e10s', 08:17:20 INFO - '--xperf_path', 08:17:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:17:20 INFO - 'tests': ['tp5n']}, 08:17:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:17:20 INFO - 'talos_options': ['--xperf_path', 08:17:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:17:20 INFO - 'tests': ['tp5n']}}, 08:17:20 INFO - 'talos.zip': {'path': '', 08:17:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:17:20 INFO - Running post-action listener: _resource_record_post_action 08:17:20 INFO - [mozharness: 2016-07-27 15:17:20.099562Z] Finished populate-webroot step (success) 08:17:20 INFO - [mozharness: 2016-07-27 15:17:20.099650Z] Running create-virtualenv step. 08:17:20 INFO - Running pre-action listener: _resource_record_pre_action 08:17:20 INFO - Running main action method: create_virtualenv 08:17:20 INFO - Creating virtualenv /builds/slave/test/build/venv 08:17:20 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:17:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:17:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:17:20 INFO - Using real prefix '/usr' 08:17:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:17:20 INFO - Installing distribute.............................................................................................................................................................................................done. 08:17:22 INFO - Installing pip.................done. 08:17:22 INFO - Return code: 0 08:17:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:17:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:17:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:22 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 0x131d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15de180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15dc3b0>, '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 0x15dd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15dd740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1469631595.896845-1471727622', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:17:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:17:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:17:22 INFO - Using env: {'DISPLAY': ':0', 08:17:22 INFO - 'HOME': '/home/cltbld', 08:17:22 INFO - 'LANG': 'en_US.UTF-8', 08:17:22 INFO - 'LANGUAGE': 'en_US:en', 08:17:22 INFO - 'LOGNAME': 'cltbld', 08:17:22 INFO - 'MAIL': '/var/mail/cltbld', 08:17:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:22 INFO - 'MOZ_NO_REMOTE': '1', 08:17:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:22 INFO - 'NO_EM_RESTART': '1', 08:17:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:22 INFO - 'PWD': '/builds/slave/test', 08:17:22 INFO - 'SHELL': '/bin/bash', 08:17:22 INFO - 'SHLVL': '1', 08:17:22 INFO - 'TERM': 'linux', 08:17:22 INFO - 'TMOUT': '86400', 08:17:22 INFO - 'USER': 'cltbld', 08:17:22 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1469631595.896845-1471727622', 08:17:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:22 INFO - '_': '/tools/buildbot/bin/python'} 08:17:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:22 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:17:22 INFO - Cleaning up... 08:17:22 INFO - Return code: 0 08:17:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:17:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:17:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:22 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 0x131d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15de180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15dc3b0>, '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 0x15dd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15dd740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1469631595.896845-1471727622', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:17:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:17:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:17:22 INFO - Using env: {'DISPLAY': ':0', 08:17:22 INFO - 'HOME': '/home/cltbld', 08:17:22 INFO - 'LANG': 'en_US.UTF-8', 08:17:22 INFO - 'LANGUAGE': 'en_US:en', 08:17:22 INFO - 'LOGNAME': 'cltbld', 08:17:22 INFO - 'MAIL': '/var/mail/cltbld', 08:17:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:22 INFO - 'MOZ_NO_REMOTE': '1', 08:17:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:22 INFO - 'NO_EM_RESTART': '1', 08:17:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:22 INFO - 'PWD': '/builds/slave/test', 08:17:22 INFO - 'SHELL': '/bin/bash', 08:17:22 INFO - 'SHLVL': '1', 08:17:22 INFO - 'TERM': 'linux', 08:17:22 INFO - 'TMOUT': '86400', 08:17:22 INFO - 'USER': 'cltbld', 08:17:22 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1469631595.896845-1471727622', 08:17:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:22 INFO - '_': '/tools/buildbot/bin/python'} 08:17:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:23 INFO - Downloading/unpacking psutil>=3.1.1 08:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:17:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:17:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:17:25 INFO - Installing collected packages: psutil 08:17:25 INFO - Running setup.py install for psutil 08:17:25 INFO - building 'psutil._psutil_linux' extension 08:17:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:17:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:17:25 INFO - building 'psutil._psutil_posix' extension 08:17:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:17:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:17:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:17:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:17:25 INFO - Successfully installed psutil 08:17:25 INFO - Cleaning up... 08:17:25 INFO - Return code: 0 08:17:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:17:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:17:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:17:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:25 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 0x131d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15de180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15dc3b0>, '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 0x15dd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15dd740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1469631595.896845-1471727622', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:17:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:17:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:17:25 INFO - Using env: {'DISPLAY': ':0', 08:17:25 INFO - 'HOME': '/home/cltbld', 08:17:25 INFO - 'LANG': 'en_US.UTF-8', 08:17:25 INFO - 'LANGUAGE': 'en_US:en', 08:17:25 INFO - 'LOGNAME': 'cltbld', 08:17:25 INFO - 'MAIL': '/var/mail/cltbld', 08:17:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:25 INFO - 'MOZ_NO_REMOTE': '1', 08:17:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:25 INFO - 'NO_EM_RESTART': '1', 08:17:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:25 INFO - 'PWD': '/builds/slave/test', 08:17:25 INFO - 'SHELL': '/bin/bash', 08:17:25 INFO - 'SHLVL': '1', 08:17:25 INFO - 'TERM': 'linux', 08:17:25 INFO - 'TMOUT': '86400', 08:17:25 INFO - 'USER': 'cltbld', 08:17:25 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1469631595.896845-1471727622', 08:17:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:25 INFO - '_': '/tools/buildbot/bin/python'} 08:17:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:17:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:17:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:17:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:17:27 INFO - Installing collected packages: mozsystemmonitor 08:17:27 INFO - Running setup.py install for mozsystemmonitor 08:17:27 INFO - Successfully installed mozsystemmonitor 08:17:27 INFO - Cleaning up... 08:17:28 INFO - Return code: 0 08:17:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:17:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:17:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15de180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15dc3b0>, '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 0x15dd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15dd740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1469631595.896845-1471727622', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:17:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:17:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:17:28 INFO - Using env: {'DISPLAY': ':0', 08:17:28 INFO - 'HOME': '/home/cltbld', 08:17:28 INFO - 'LANG': 'en_US.UTF-8', 08:17:28 INFO - 'LANGUAGE': 'en_US:en', 08:17:28 INFO - 'LOGNAME': 'cltbld', 08:17:28 INFO - 'MAIL': '/var/mail/cltbld', 08:17:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:28 INFO - 'MOZ_NO_REMOTE': '1', 08:17:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:28 INFO - 'NO_EM_RESTART': '1', 08:17:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:28 INFO - 'PWD': '/builds/slave/test', 08:17:28 INFO - 'SHELL': '/bin/bash', 08:17:28 INFO - 'SHLVL': '1', 08:17:28 INFO - 'TERM': 'linux', 08:17:28 INFO - 'TMOUT': '86400', 08:17:28 INFO - 'USER': 'cltbld', 08:17:28 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1469631595.896845-1471727622', 08:17:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:28 INFO - '_': '/tools/buildbot/bin/python'} 08:17:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:28 INFO - Downloading/unpacking jsonschema==2.5.1 08:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:17:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:30 INFO - Downloading functools32-3.2.3-2.tar.gz 08:17:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:17:30 INFO - warning: no files found matching '*.txt' 08:17:30 INFO - no previously-included directories found matching 'build' 08:17:30 INFO - no previously-included directories found matching 'dist' 08:17:30 INFO - no previously-included directories found matching '.git*' 08:17:30 INFO - Installing collected packages: jsonschema, functools32 08:17:30 INFO - Running setup.py install for functools32 08:17:30 INFO - warning: no files found matching '*.txt' 08:17:30 INFO - no previously-included directories found matching 'build' 08:17:30 INFO - no previously-included directories found matching 'dist' 08:17:30 INFO - no previously-included directories found matching '.git*' 08:17:30 INFO - Successfully installed jsonschema functools32 08:17:30 INFO - Cleaning up... 08:17:30 INFO - Return code: 0 08:17:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:17:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:17:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15de180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15dc3b0>, '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 0x15dd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15dd740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1469631595.896845-1471727622', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:17:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:17:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:17:30 INFO - Using env: {'DISPLAY': ':0', 08:17:30 INFO - 'HOME': '/home/cltbld', 08:17:30 INFO - 'LANG': 'en_US.UTF-8', 08:17:30 INFO - 'LANGUAGE': 'en_US:en', 08:17:30 INFO - 'LOGNAME': 'cltbld', 08:17:30 INFO - 'MAIL': '/var/mail/cltbld', 08:17:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:30 INFO - 'MOZ_NO_REMOTE': '1', 08:17:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:30 INFO - 'NO_EM_RESTART': '1', 08:17:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:30 INFO - 'PWD': '/builds/slave/test', 08:17:30 INFO - 'SHELL': '/bin/bash', 08:17:30 INFO - 'SHLVL': '1', 08:17:30 INFO - 'TERM': 'linux', 08:17:30 INFO - 'TMOUT': '86400', 08:17:30 INFO - 'USER': 'cltbld', 08:17:30 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1469631595.896845-1471727622', 08:17:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:30 INFO - '_': '/tools/buildbot/bin/python'} 08:17:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:17:30 INFO - Cleaning up... 08:17:30 INFO - Return code: 0 08:17:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:17:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:17:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x131d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15de180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15dc3b0>, '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 0x15dd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15dd740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1469631595.896845-1471727622', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:17:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:17:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:17:30 INFO - Using env: {'DISPLAY': ':0', 08:17:30 INFO - 'HOME': '/home/cltbld', 08:17:30 INFO - 'LANG': 'en_US.UTF-8', 08:17:30 INFO - 'LANGUAGE': 'en_US:en', 08:17:30 INFO - 'LOGNAME': 'cltbld', 08:17:30 INFO - 'MAIL': '/var/mail/cltbld', 08:17:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:30 INFO - 'MOZ_NO_REMOTE': '1', 08:17:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:30 INFO - 'NO_EM_RESTART': '1', 08:17:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:30 INFO - 'PWD': '/builds/slave/test', 08:17:30 INFO - 'SHELL': '/bin/bash', 08:17:30 INFO - 'SHLVL': '1', 08:17:30 INFO - 'TERM': 'linux', 08:17:30 INFO - 'TMOUT': '86400', 08:17:30 INFO - 'USER': 'cltbld', 08:17:30 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1469631595.896845-1471727622', 08:17:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:30 INFO - '_': '/tools/buildbot/bin/python'} 08:17:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:30 INFO - Downloading/unpacking blobuploader==1.2.4 08:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:32 INFO - Downloading blobuploader-1.2.4.tar.gz 08:17:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:17:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:17:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:17:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:17:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:33 INFO - Downloading docopt-0.6.1.tar.gz 08:17:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:17:33 INFO - Installing collected packages: blobuploader, requests, docopt 08:17:33 INFO - Running setup.py install for blobuploader 08:17:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:17:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:17:33 INFO - Running setup.py install for requests 08:17:34 INFO - Running setup.py install for docopt 08:17:34 INFO - Successfully installed blobuploader requests docopt 08:17:34 INFO - Cleaning up... 08:17:34 INFO - Return code: 0 08:17:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:17:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:17:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15de180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15dc3b0>, '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 0x15dd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15dd740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1469631595.896845-1471727622', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:17:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:17:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:17:34 INFO - Using env: {'DISPLAY': ':0', 08:17:34 INFO - 'HOME': '/home/cltbld', 08:17:34 INFO - 'LANG': 'en_US.UTF-8', 08:17:34 INFO - 'LANGUAGE': 'en_US:en', 08:17:34 INFO - 'LOGNAME': 'cltbld', 08:17:34 INFO - 'MAIL': '/var/mail/cltbld', 08:17:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:34 INFO - 'MOZ_NO_REMOTE': '1', 08:17:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:34 INFO - 'NO_EM_RESTART': '1', 08:17:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:34 INFO - 'PWD': '/builds/slave/test', 08:17:34 INFO - 'SHELL': '/bin/bash', 08:17:34 INFO - 'SHLVL': '1', 08:17:34 INFO - 'TERM': 'linux', 08:17:34 INFO - 'TMOUT': '86400', 08:17:34 INFO - 'USER': 'cltbld', 08:17:34 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1469631595.896845-1471727622', 08:17:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:34 INFO - '_': '/tools/buildbot/bin/python'} 08:17:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:17:34 INFO - Running setup.py (path:/tmp/pip-Q00ge2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:17:34 INFO - Running setup.py (path:/tmp/pip-RSnBmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:17:34 INFO - Running setup.py (path:/tmp/pip-j7zgBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:17:34 INFO - Running setup.py (path:/tmp/pip-57D34J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:17:34 INFO - Running setup.py (path:/tmp/pip-PpWWmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:17:34 INFO - Running setup.py (path:/tmp/pip-Nd17JN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:17:34 INFO - Running setup.py (path:/tmp/pip-o8EFEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:17:34 INFO - Running setup.py (path:/tmp/pip-5fug32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:17:35 INFO - Running setup.py (path:/tmp/pip-gd_6YO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:17:35 INFO - Running setup.py (path:/tmp/pip-ceMJB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:17:35 INFO - Running setup.py (path:/tmp/pip-cv6sf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:17:35 INFO - Running setup.py (path:/tmp/pip-KwNB4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:17:35 INFO - Running setup.py (path:/tmp/pip-Z3HyBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:17:35 INFO - Running setup.py (path:/tmp/pip-lFl7ZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:17:35 INFO - Running setup.py (path:/tmp/pip-9QGPv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:17:35 INFO - Running setup.py (path:/tmp/pip-cz2YAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:17:35 INFO - Running setup.py (path:/tmp/pip-i0pzUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:17:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:17:35 INFO - Running setup.py install for manifestparser 08:17:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:17:35 INFO - Running setup.py install for mozcrash 08:17:35 INFO - Running setup.py install for mozdebug 08:17:36 INFO - Running setup.py install for mozdevice 08:17:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:17:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:17:36 INFO - Running setup.py install for mozfile 08:17:36 INFO - Running setup.py install for mozhttpd 08:17:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:17:36 INFO - Running setup.py install for mozinfo 08:17:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:17:36 INFO - Running setup.py install for mozInstall 08:17:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:17:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:17:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:17:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:17:36 INFO - Running setup.py install for mozleak 08:17:36 INFO - Running setup.py install for mozlog 08:17:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:17:36 INFO - Running setup.py install for moznetwork 08:17:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:17:36 INFO - Running setup.py install for mozprocess 08:17:36 INFO - Running setup.py install for mozprofile 08:17:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:17:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:17:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:17:37 INFO - Running setup.py install for mozrunner 08:17:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:17:37 INFO - Running setup.py install for mozscreenshot 08:17:37 INFO - Running setup.py install for moztest 08:17:37 INFO - Running setup.py install for mozversion 08:17:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:17:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:17:37 INFO - Cleaning up... 08:17:37 INFO - Return code: 0 08:17:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:17:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:17:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15de180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15dc3b0>, '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 0x15dd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15dd740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1469631595.896845-1471727622', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:17:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:17:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:17:37 INFO - Using env: {'DISPLAY': ':0', 08:17:37 INFO - 'HOME': '/home/cltbld', 08:17:37 INFO - 'LANG': 'en_US.UTF-8', 08:17:37 INFO - 'LANGUAGE': 'en_US:en', 08:17:37 INFO - 'LOGNAME': 'cltbld', 08:17:37 INFO - 'MAIL': '/var/mail/cltbld', 08:17:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:37 INFO - 'MOZ_NO_REMOTE': '1', 08:17:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:37 INFO - 'NO_EM_RESTART': '1', 08:17:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:37 INFO - 'PWD': '/builds/slave/test', 08:17:37 INFO - 'SHELL': '/bin/bash', 08:17:37 INFO - 'SHLVL': '1', 08:17:37 INFO - 'TERM': 'linux', 08:17:37 INFO - 'TMOUT': '86400', 08:17:37 INFO - 'USER': 'cltbld', 08:17:37 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1469631595.896845-1471727622', 08:17:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:37 INFO - '_': '/tools/buildbot/bin/python'} 08:17:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:17:37 INFO - Running setup.py (path:/tmp/pip-LAZ_DO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:17:37 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:17:37 INFO - Running setup.py (path:/tmp/pip-zdntv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:17:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:17:37 INFO - Running setup.py (path:/tmp/pip-uoFdzx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:17:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:17:37 INFO - Running setup.py (path:/tmp/pip-9OyC6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:17:38 INFO - Running setup.py (path:/tmp/pip-OdNiGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:17:38 INFO - Running setup.py (path:/tmp/pip-Cg1Jp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:17:38 INFO - Running setup.py (path:/tmp/pip-jnMQqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:17:38 INFO - Running setup.py (path:/tmp/pip-b34pIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:17:38 INFO - Running setup.py (path:/tmp/pip-JX6dAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:17:38 INFO - Running setup.py (path:/tmp/pip-9WHc6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:17:38 INFO - Running setup.py (path:/tmp/pip-Ei6QIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:17:38 INFO - Running setup.py (path:/tmp/pip-7lpAlH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:17:38 INFO - Running setup.py (path:/tmp/pip-qKkS9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:17:38 INFO - Running setup.py (path:/tmp/pip-uZlzRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:17:38 INFO - Running setup.py (path:/tmp/pip-4Qez3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:17:38 INFO - Running setup.py (path:/tmp/pip-YHNy4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:17:38 INFO - Running setup.py (path:/tmp/pip-FwO02O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:17:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:40 INFO - Downloading blessings-1.6.tar.gz 08:17:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:17:40 INFO - Installing collected packages: blessings 08:17:40 INFO - Running setup.py install for blessings 08:17:41 INFO - Successfully installed blessings 08:17:41 INFO - Cleaning up... 08:17:41 INFO - Return code: 0 08:17:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:17:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:17:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:17:41 INFO - Reading from file tmpfile_stdout 08:17:41 INFO - Current package versions: 08:17:41 INFO - argparse == 1.2.1 08:17:41 INFO - blessings == 1.6 08:17:41 INFO - blobuploader == 1.2.4 08:17:41 INFO - docopt == 0.6.1 08:17:41 INFO - functools32 == 3.2.3-2 08:17:41 INFO - jsonschema == 2.5.1 08:17:41 INFO - manifestparser == 1.1 08:17:41 INFO - mozInstall == 1.12 08:17:41 INFO - mozcrash == 0.17 08:17:41 INFO - mozdebug == 0.1 08:17:41 INFO - mozdevice == 0.48 08:17:41 INFO - mozfile == 1.2 08:17:41 INFO - mozhttpd == 0.7 08:17:41 INFO - mozinfo == 0.9 08:17:41 INFO - mozleak == 0.1 08:17:41 INFO - mozlog == 3.3 08:17:41 INFO - moznetwork == 0.27 08:17:41 INFO - mozprocess == 0.23 08:17:41 INFO - mozprofile == 0.28 08:17:41 INFO - mozrunner == 6.12 08:17:41 INFO - mozscreenshot == 0.1 08:17:41 INFO - mozsystemmonitor == 0.3 08:17:41 INFO - moztest == 0.7 08:17:41 INFO - mozversion == 1.4 08:17:41 INFO - psutil == 3.1.1 08:17:41 INFO - requests == 1.2.3 08:17:41 INFO - wsgiref == 0.1.2 08:17:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:17:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15de180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15dc3b0>, '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 0x15dd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15dd740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1469631595.896845-1471727622', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:17:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:17:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:17:41 INFO - Using env: {'DISPLAY': ':0', 08:17:41 INFO - 'HOME': '/home/cltbld', 08:17:41 INFO - 'LANG': 'en_US.UTF-8', 08:17:41 INFO - 'LANGUAGE': 'en_US:en', 08:17:41 INFO - 'LOGNAME': 'cltbld', 08:17:41 INFO - 'MAIL': '/var/mail/cltbld', 08:17:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:41 INFO - 'MOZ_NO_REMOTE': '1', 08:17:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:41 INFO - 'NO_EM_RESTART': '1', 08:17:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:41 INFO - 'PWD': '/builds/slave/test', 08:17:41 INFO - 'SHELL': '/bin/bash', 08:17:41 INFO - 'SHLVL': '1', 08:17:41 INFO - 'TERM': 'linux', 08:17:41 INFO - 'TMOUT': '86400', 08:17:41 INFO - 'USER': 'cltbld', 08:17:41 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1469631595.896845-1471727622', 08:17:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:41 INFO - '_': '/tools/buildbot/bin/python'} 08:17:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:17:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:17:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:17:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:17:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:17:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:17:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:17:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:17:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:17:41 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:17:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:17:41 INFO - Cleaning up... 08:17:41 INFO - Return code: 0 08:17:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:17:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15de180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15dc3b0>, '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 0x15dd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15dd740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1469631595.896845-1471727622', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:17:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:17:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:17:41 INFO - Using env: {'DISPLAY': ':0', 08:17:41 INFO - 'HOME': '/home/cltbld', 08:17:41 INFO - 'LANG': 'en_US.UTF-8', 08:17:41 INFO - 'LANGUAGE': 'en_US:en', 08:17:41 INFO - 'LOGNAME': 'cltbld', 08:17:41 INFO - 'MAIL': '/var/mail/cltbld', 08:17:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:41 INFO - 'MOZ_NO_REMOTE': '1', 08:17:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:41 INFO - 'NO_EM_RESTART': '1', 08:17:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:41 INFO - 'PWD': '/builds/slave/test', 08:17:41 INFO - 'SHELL': '/bin/bash', 08:17:41 INFO - 'SHLVL': '1', 08:17:41 INFO - 'TERM': 'linux', 08:17:41 INFO - 'TMOUT': '86400', 08:17:41 INFO - 'USER': 'cltbld', 08:17:41 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1469631595.896845-1471727622', 08:17:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:41 INFO - '_': '/tools/buildbot/bin/python'} 08:17:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:17:41 INFO - Cleaning up... 08:17:41 INFO - Return code: 0 08:17:41 INFO - Running post-action listener: _resource_record_post_action 08:17:41 INFO - Running post-action listener: _start_resource_monitoring 08:17:41 INFO - Starting resource monitoring. 08:17:41 INFO - [mozharness: 2016-07-27 15:17:41.815360Z] Finished create-virtualenv step (success) 08:17:41 INFO - [mozharness: 2016-07-27 15:17:41.815841Z] Running install step. 08:17:41 INFO - Running pre-action listener: _resource_record_pre_action 08:17:41 INFO - Running main action method: install 08:17:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:17:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:17:42 INFO - Reading from file tmpfile_stdout 08:17:42 INFO - Detecting whether we're running mozinstall >=1.0... 08:17:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:17:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:17:42 INFO - Reading from file tmpfile_stdout 08:17:42 INFO - Output received: 08:17:42 INFO - Usage: mozinstall [options] installer 08:17:42 INFO - Options: 08:17:42 INFO - -h, --help show this help message and exit 08:17:42 INFO - -d DEST, --destination=DEST 08:17:42 INFO - Directory to install application into. [default: 08:17:42 INFO - "/builds/slave/test"] 08:17:42 INFO - --app=APP Application being installed. [default: firefox] 08:17:42 INFO - mkdir: /builds/slave/test/build/application 08:17:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:17:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:17:59 INFO - Reading from file tmpfile_stdout 08:17:59 INFO - Output received: 08:17:59 INFO - /builds/slave/test/build/application/firefox/firefox 08:17:59 INFO - Running post-action listener: _resource_record_post_action 08:17:59 INFO - [mozharness: 2016-07-27 15:17:59.355010Z] Finished install step (success) 08:17:59 INFO - [mozharness: 2016-07-27 15:17:59.355286Z] Running run-tests step. 08:17:59 INFO - Running pre-action listener: _resource_record_pre_action 08:17:59 INFO - Running main action method: run_tests 08:17:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:17:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:17:59 INFO - Python 2.7.3 08:17:59 INFO - Return code: 0 08:17:59 INFO - grabbing minidump binary from tooltool 08:17:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:17:59 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15dc3b0>, '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 0x15dd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15dd740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:17:59 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:17:59 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:17:59 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:17:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:17:59 INFO - Return code: 0 08:17:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:17:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:17:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:17:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:17:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:17:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UpAXm9HORO2hg6hi4sbyjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:17:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UpAXm9HORO2hg6hi4sbyjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:17:59 INFO - Using env: {'DISPLAY': ':0', 08:17:59 INFO - 'HOME': '/home/cltbld', 08:17:59 INFO - 'LANG': 'en_US.UTF-8', 08:17:59 INFO - 'LANGUAGE': 'en_US:en', 08:17:59 INFO - 'LOGNAME': 'cltbld', 08:17:59 INFO - 'MAIL': '/var/mail/cltbld', 08:17:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:17:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:17:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:59 INFO - 'MOZ_NO_REMOTE': '1', 08:17:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:17:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:59 INFO - 'NO_EM_RESTART': '1', 08:17:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:59 INFO - 'PWD': '/builds/slave/test', 08:17:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:17:59 INFO - 'SHELL': '/bin/bash', 08:17:59 INFO - 'SHLVL': '1', 08:17:59 INFO - 'TERM': 'linux', 08:17:59 INFO - 'TMOUT': '86400', 08:17:59 INFO - 'USER': 'cltbld', 08:17:59 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1469631595.896845-1471727622', 08:17:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:59 INFO - '_': '/tools/buildbot/bin/python'} 08:17:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UpAXm9HORO2hg6hi4sbyjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:17:59 INFO - mozversion application_buildid: 20160727053024 08:17:59 INFO - mozversion application_changeset: 4b767c8f023685e9e598f026453fbd906e0e8d1f 08:17:59 INFO - mozversion application_display_name: Nightly 08:17:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:17:59 INFO - mozversion application_name: Firefox 08:17:59 INFO - mozversion application_remotingname: firefox 08:17:59 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:17:59 INFO - mozversion application_vendor: Mozilla 08:17:59 INFO - mozversion application_version: 50.0a1 08:17:59 INFO - mozversion platform_buildid: 20160727053024 08:17:59 INFO - mozversion platform_changeset: 4b767c8f023685e9e598f026453fbd906e0e8d1f 08:17:59 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:17:59 INFO - mozversion platform_version: 50.0a1 08:17:59 INFO - using testdate: 1469632679 08:17:59 INFO - actual date: 1469632679 08:17:59 INFO - starting webserver on 'localhost:60242' 08:17:59 INFO - SUITE-START | Running 2 tests 08:17:59 INFO - TEST-START | dromaeo_css 08:17:59 INFO - operating with platform_type : linux_ 08:17:59 INFO - Initialising browser for dromaeo_css test... 08:17:59 INFO - TEST-INFO | started process 32495 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfqIb5y/profile http://localhost:60242/getInfo.html) 08:18:03 INFO - PROCESS | 32495 | JavaScript error: , line 0: uncaught exception: undefined 08:18:04 INFO - PROCESS | 32495 | __metrics Screen width/height:1600/1200 08:18:04 INFO - PROCESS | 32495 | colorDepth:24 08:18:04 INFO - PROCESS | 32495 | Browser inner width/height: 1024/697 08:18:04 INFO - PROCESS | 32495 | __metrics 08:18:04 INFO - PROCESS | 32495 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:18:04 INFO - PROCESS | 32495 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:18:05 INFO - TEST-INFO | 32495: exit 0 08:18:05 INFO - Browser initialized. 08:18:05 INFO - Running cycle 1/1 for dromaeo_css test... 08:18:05 INFO - TEST-INFO | started process 32577 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfqIb5y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:18:17 INFO - PROCESS | 32577 | RSS: Main: 157908992 08:18:17 INFO - PROCESS | 32577 | 08:19:09 INFO - PROCESS | 32577 | 1469632749342 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:21:17 INFO - PROCESS | 32577 | Cycle 1(1): loaded http://localhost:60242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60242/tests/dromaeo/cssquery-ext.html) 08:21:18 INFO - PROCESS | 32577 | RSS: Main: 264708096 08:21:18 INFO - PROCESS | 32577 | 08:24:20 INFO - PROCESS | 32577 | Cycle 1(1): loaded http://localhost:60242/tests/dromaeo/cssquery-ext.html (next: http://localhost:60242/tests/dromaeo/cssquery-jquery.html) 08:24:21 INFO - PROCESS | 32577 | RSS: Main: 243400704 08:24:21 INFO - PROCESS | 32577 | 08:27:23 INFO - PROCESS | 32577 | Cycle 1(1): loaded http://localhost:60242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60242/tests/dromaeo/cssquery-mootools.html) 08:27:24 INFO - PROCESS | 32577 | RSS: Main: 230969344 08:27:24 INFO - PROCESS | 32577 | 08:30:25 INFO - PROCESS | 32577 | Cycle 1(1): loaded http://localhost:60242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60242/tests/dromaeo/cssquery-prototype.html) 08:30:26 INFO - PROCESS | 32577 | RSS: Main: 186314752 08:30:26 INFO - PROCESS | 32577 | 08:33:29 INFO - PROCESS | 32577 | Cycle 1(1): loaded http://localhost:60242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60242/tests/dromaeo/cssquery-yui.html) 08:33:29 INFO - PROCESS | 32577 | RSS: Main: 187920384 08:33:29 INFO - PROCESS | 32577 | 08:36:32 INFO - PROCESS | 32577 | Cycle 1(1): loaded http://localhost:60242/tests/dromaeo/cssquery-yui.html (next: http://localhost:60242/tests/dromaeo/cssquery-dojo.html) 08:36:32 INFO - PROCESS | 32577 | RSS: Main: 295436288 08:36:32 INFO - PROCESS | 32577 | 08:36:32 INFO - PROCESS | 32577 | __start_tp_report 08:36:32 INFO - PROCESS | 32577 | _x_x_mozilla_page_load 08:36:32 INFO - PROCESS | 32577 | _x_x_mozilla_page_load_details 08:36:32 INFO - PROCESS | 32577 | |i|pagename|runs| 08:36:32 INFO - PROCESS | 32577 | |0;dojo.html;3048.588440560524;3082.5684404183403;3097.6127984002;3128.139761565568;3138.811671299722;5316.49493298137;5326.520613144821;5375.543078838294;5390.838274851756;5424.864378390537;5369.5704343652515;5422.6475279106835;5432.75552600133;5494;5505.421930697269;4823.951760482394;4857.198562237227;4893.4617192108835;4907.484714105021;5059.266406371074;4980.576650984653;5011.523905228997;5024.271480635306;5031.723255220962;5041.899162016757;4831.565159135677;4837.153498137847;4868.1237377272255;4873.269009648546;4940.431850337203;4874.293227481995;4877.8780530486665;4879.268109783526;4939.703617782944;4958.355413796219;4875.902481950377;4895.241237608177;4915.950840491585;4934.062528119646;4948.307236986825;5287.603429742785;5310.0441920454305;5357.678539287655;5448.237246785453;5460.918086228709;5752.741126649311;5792.913106303409;5805.651660900359;5806.5645076619;5807.941920580783;5784.363719990798;5821;5845.766169353221;5850.414958504158;5850.473457388855;5273.314469119028;5300.337457817773;5382.300300960928;5385.703786291791;5412.864678383072;5920.111983202554;5962.433568810956;5976.790812321635;5983.311919129356;5984.132300816357;5715.799947001919;5717.37108918027;5720.256366672306;5721.141828725725;5721.713914304268;5643.887122257532;5705.942940570541;5759.510441612426;5760.53915686744;5796.188533605215;5754.6547207167705;5780.132980053026;5800.5939584229545;5805.912911306334;5811.3316968548315;5727.5131613812455;5778.162166485836;5784.797532086357;5785.884282314414;5790.681512516768;4333.826646934087;4372.584604462634;4377.299632058919;4403.779811009436;4464.3973063635995;3905.082305658168;3952.4268980997595;3968.7817170055923;3973.900652483711;3990.4213888985932;5546.694931778791;5555.861103472445;5557.055300598827;5570.721463926788;5573.219749235111;5728.856778580569;5759.308882934075;5848.2397288353095;5855.414458554195;5912.615679980788;5485.314335708036;5512.476314750093;5514.558835293167;5536.52939500147;5567.164925261162;4921.7785199666105;4928;4928.334674818925;4928.433230178575;4971.130052240844;5878.2064421302575;5910.822675319747;6002.009668404664;6011.3086994995265;6011.458968692751;5738.626989245686;5750.25246717924;5796.478316951495;5844.970775146097;5847.1229315603;5983.9401605983385;5984.281886173513;5989.2812862456785;5989.670568118621;5989.8203053908455;5569.359523654832;5603.243562119224;5650.491455769001;5656.37779844225;5668.829935101953;5813.94186058134;5825.79609713658;5863.706814659165;5895;5899.380565040609;5697.259356283656;5715.085586306171;5715.485606295453;5715.971420142872;5720.570957178312;5513.090340094;5648.378678345297;5704.771809127588;5708.714564271853;5713.771449142154;5628.802991895264;5650.23721797552;5656.123300888369;5700.885982280414;5706.9714651426475;5774.989376858949;5782.392848750989;5826.271716035496;5838.620489668158;5840.415958404125;5534.584906132137;5560.944390556205;5651.350094739158;5656.745446455002;5665.66006039639 08:36:32 INFO - PROCESS | 32577 | |1;ext.html;603.8339456649421;621.3537920562615;634.5621521150409;645.3610925184067;662.9436497897678;44160.77919610401;45669.543304566985;45674;48400.67592564815;48577.51422485774;46163.30755038677;46410.07179856401;46647.533524664745;46673;46674.53325466744;8345.54099524526;9060.909390906088;9238.86141707875;9246.86129708055;10838.187135964834;10694.144468442544;11108.16688748347;11112.555497780078;11113.499892504817;11114.722131946726;11155.107591392709;11198.104151667887;11201.04791092758;11206.327620342805;11210.103191744682;11079.390633515153;11106.222564420494;11153.776924461547;11162.218644694874;11164.051055660279;10913.563457461692;10958.890411095947;11011.504482298316;11022.173336999756;11030.613928512463;43197.35203971943;43240;43496;43705.34441983373;43744.78127609374;3677.8161091945294;3770.3213421584105;3845.1732877431205;3871.593482684306;4187.455630768011;33173.17047614761;33317.66682333194;33881.32237355239;33893.46295010421;34310.82844585761;4404.559544045602;4465.821367145343;4476.440444944382;4482.618977386926;4490.101979604092;242676.99999999822;244897;244960;246491.74557780963;246638;34391.82804085963;59435;59659.70170149121;59713;59968.400315997154;35523;37474.43788343177;37662.24675506475;37744.811275944;37762.62237377646;13377.197368157942;13457.394417251247;13458.663533411744;13465.730685386237;13476;11078.612248571262;11260.831087533694;11261.155413344031;11905.64283071492;12339.568115116108;8275.420720549624;8286.792830179173;8470.957645211858;8502.06477287498;8506.36202284831;3222.194451387153;3283.097148284241;3292.0782180989363;3299.307145499472;3323.7673362864366;1048.030571721155;1111.7387413957713;1154.215133709069;1169.0822704177351;1183.331417748969;33003.339933201205;33023.174420639196;33287.83356083204;33340;33676.831615841766;1089.6186334782763;1098.9010989011028;1132.1621999720148;1151.6832870960552;1179.6107284596235;16975.405860794814;17320.566985825455;17437;17503.73744393835;17565.20956556958;570340;602347;609804;610016;888403;62548.687256563426;63120;63141;63149;63333.36666633367;1237.2267332916927;1363.9045266831424;1366.6241783509415;1376.0917794255943;1419.3825685826698;32320.83839580787;33934.83032584821;34415.311693765485;34437.65562344445;34528.30943381068;52118.47881521136;52722.736386317825;52992.73503632457;53002.734986324824;53010.46989530209;466070;470888;471229;471406;472424;29119.85440072871;29183.85408072946;29980.102586663594;30024.099277021724;30419.847900760353;50446.74776626093;50688;51062;51238;51576;42878.571214287454;43831.78084109559;44467;44529.777351113036;44953.55046449624;42604.36093458663;43096.13807723891;43267.13465730605;44540;44854.55145448504;41659.7917010413;43088.78455607702;43503.34744978891;43991.78004109959;44070;36251;37580.624193757714;38333;38381.2323753529;38867.80566097151;29018.27454313659;29037.564436533892;29124;29171.708282916898;29539.556906645987 08:36:32 INFO - PROCESS | 32577 | |2;jquery.html;370.5590347486489;385.7164983736951;397.38802244543405;400.7835768684909;421.3721554883223;14357.497487587936;17220.65558688827;19427.805721942776;19758.110885010192;19762;18767.812321876776;18810.529736756554;18845;19035.809641903576;19064.71402928954;4201.516825565069;5667.064934285848;5859.1797148399255;5868.383819698913;5869.706514674271;6318;6590.209174899019;6638.203415590112;6646.0363247329105;6651.2018557773135;6367.267764207106;6496.447801936841;6555.50833687473;6605.372489613503;6614.8677026459445;6391.808245752635;6595.505337099713;6612.900806487906;6620.304867988864;6631.502637302197;5789.855253618651;5822.883542329129;5834.474897259267;5836.737346819404;5843.444872737083;22993.77006229933;22998.08007679691;23185.884070579537;23202.41993950148;23256.4185895354;2320.8375413721046;2406.6510355998457;2454.0674543673467;2467.346153269385;2570.717221105677;14016.43934242629;14534.418623255056;14566.781498277534;15159.393624255017;15392.076475411399;1893.5266183454137;1894.2517705506386;1948.2109745553073;1956.2370675436591;1979.1786408640542;54203.18695219575;54533.45466545323;54841.451585484036;60317.99999999956;68069;10469.738256543647;10495;10676.145908327315;10752.408617525954;11000.339979601249;14934.551963441114;14953.775693364609;14980.1011939284;15008.849911500745;15018.624534386729;7810.882836757453;7893.842123157505;7962.3630109591095;8020.679172833138;8115.229053240051;7465.514741541782;7519.548827070394;7540.622968851536;7737.767866964;7756.069271687434;6443.194600674916;6530.836729081716;6575.868482630321;6643.368879956396;6778.72885084601;1942.8445724342018;1982.89094099823;1987.807315610651;1989.518342899925;2005.8997050147725;880.6477409036308;902.4585248850638;927.174814415171;946.4699768129869;974.6150270643057;17142;17910.91044544795;18066.548336291697;18254;18457;874.7856775090144;904.1004200820095;927.3230541704594;944.7449188719007;948.5399581203111;9831.80336393268;10453.738656533495;10532.10477109439;10551.736206594896;10621.628243011612;459597;466186;467420;474188;475716;81681;82104;83577;84087.5795621018;85124.57437712772;851.2508992086924;873.9737807865774;875.1292463998362;875.1948207648978;875.4440930009363;15559.533214003599;16206.594835128744;16350.345986160895;16432.424865129662;16485.423010194587;42396.36405453982;42831;43011.569884300756;43390.566094338654;44351.89120272019;56880.146797797235;57764.09005234602;58744.70627646834;58750.412495874494;58919.41080589139;8215.917840821516;8227.753167404988;8635;8675.045744968174;8684.392092553713;12974.935125324313;13651.249181295125;13738.450461981809;13779.311034448438;13821.516246931309;11459.4270286487;11979.101567382308;12013;12096.274223546616;12375.814362784746;11488.94255528717;11759.588414405454;12027.75944481088;12085.335306558223;12542.811857821958;12119.212251203644;12160.75678486443;12240.938795306323;12241.571544995883;12488.875111249135;8116.513009219466;8359.373047021376;8368.623411946355;8465.449745766751;8913.821723565363;11035.227534072537;11472.426378680866;11493.770124597628;11804.409779511161;11878.287302761517 08:36:32 INFO - PROCESS | 32577 | |3;mootools.html;1340.8592097829733;1466.7139907717992;1541.8997765145264;1680.1851102215423;1819.6360727854433;8444.746657600273;8753.64985400584;8855.158759917806;9016.54917254138;9032.90967090329;8898;8979.551022448884;8986.86519702205;9001.099890010995;9012.819743605123;2345.718513778345;2375.2043065573052;2375.5367703297866;2378.7502312257225;2381.3808409813487;2291.59897018022;2339.7192336919593;2360.6223004319313;2369.4194922244073;2370.644403339504;2303.585354636165;2312.81497480202;2315.0392587076344;2358.740538540759;2362.716474023111;2260.2541161416693;2271.2618399020303;2304.8501847379866;2305.688732021181;2322.15241436876;2293.8050265727265;2306.042992158252;2311.953760924789;2313.363824948136;2313.6298192289155;8694.565271736452;8941.6870409536;8991.190792828611;8996.955015224881;9002.774930626721;5188;5264.447233040552;5264.552513036397;5306.044911915854;5313.362396512404;3442.5524681791208;3475.8435870385892;3494.2312691207894;3544.043108360728;3553.7157027437743;1102.514893446889;1156.7512984708328;1158.0966845860157;1158.536585365852;1174.4656181437426;12259.69350766229;12326.445309961073;12329.69175770604;12361;12385.690357741038;4238.830446782156;4319.200947824663;4410.117976404732;4422.137683151819;4526.253168227206;9568.856467152998;9607.087326704092;9638.90361096394;9640.084192001748;9646.372985755903;5121.334226550524;5144.6655967362;5155.948440515547;5163.096458119814;5164.92252616211;4266.829326826892;4331.5884990925815;4470.687051906335;4766.237402015661;4854.441739200037;3764.4917936078828;3775.5469343678933;3926.4895563577124;3931.941020884689;3952.3478626026385;1123.4045955643358;1148.0872706198593;1149.0692539043234;1154.5439551377326;1156.9710757230969;890.8173824365989;999.4253304350028;1001.2590682894605;1005.8340373838381;1018.8267994440963;6009.278886533644;6012.218411606463;6215.782447614311;6223;6243.531735119885;443.57195306529354;445.1519854676846;446.2391622283998;454.44330694899145;464.2386486162696;3954.8615798446917;4266.0188156724125;4283.850065247701;4299.828006879752;4373.278409062533;10925.726856828644;11220.66338009861;11269.211155219056;11301.773964520664;11317.151213659008;10437.425941573287;10753.301035432829;10804.729881753019;11093.1125509959;11226.7193320166;8225.753227403187;8400.075991640915;8429.747107586782;8431;8434.072252052269;5972.223610930551;6074.088886667036;6160.661163636043;6212.316645168938;6261.686915654108;10242.539085741011;10301.690949271533;10329.535170917177;10390.116840068678;10397.740056498647;10011.299209055587;10236.539355729159;10307.536160872929;10423.374597524173;10563.788724225318;7125.5368401053765;7459;7756.3019328260725;7931.801704957192;7954.880676789969;8484.363672724447;8855.114488551351;8858.822823543622;8864.955675221583;8869.157430044135;7672.769816905502;7704.961475192588;7866.213378662088;7937.166597507409;8008.519488830689;7398.852022959403;7549.773506794805;7714.1128770192145;7764;8055.83888322242;6808.727650894107;6902.482313826584;6911;6911.274316196928;6912.792616221522;4931.4328852181025;5035.798568057383;5174.560162386239;5242.816501422432;5387.353517577916;5238.738063096754;5282.075636763628;5299.178627312773;5324.041672498987;5336.866578335573 08:36:32 INFO - PROCESS | 32577 | |4;prototype.html;331.93859136059825;338.62412721878724;341.6668747970728;342.9125572978892;344.3594913460964;5392.56859451244;5398.865028374287;5415.458454154587;5417.6478528895595;5443.346798384199;5301.655392399492;5307.469253074691;5362.544183744377;5399.19012148178;5403.864903377417;3989.2619865324937;4075.9592404075875;4150.8132134053885;4188.162367526492;4201.957980420188;4164.895877603054;4178.415021896937;4192.413062171298;4196.475440569929;4208.705390622657;4126.5667104954;4128.985840336556;4130.938035929448;4141.979290103545;4149.278049609424;3925.9803700981456;3950.288947989375;4129.8967525811795;4179.456670632829;4180.26845302074;3659.9634003660153;3662.688671462902;3670.100825297819;3674.889753307405;3679.19057807282;5157.58739300855;5164.535191832715;5182.4299327073995;5199.220116982445;5217.938914128936;4503.864884053451;4704.553067458586;4728.550787675165;4736.52634736527;4791.257355109963;5522.66863988162;5562.9443705562835;5563.248961390242;5578.888422231573;5603.355614104389;4022.8994275143064;4023.436718859333;4026.6577340926056;4027;4042.3734321180264;5596.188552659842;5771.172125658397;5787.536997040227;5844.766209351621;5866.9706651466895;4071.206114807584;4075.694322925792;4079.3676980068135;4084.1831633673382;4092.8976775580254;4158.979205103955;4166.437530933345;4174.227767862894;4177.561356057631;4183.414321994923;4513.796879140446;4650.325702773079;4743.691660042086;4788.545088216614;4801.159797035505;5570.275864137636;5577.386487486373;5587.497125258747;5610.214569960209;5631.155326701028;1419.9989007749512;1446.5081872163514;1447.3559266126683;1448.2686243446992;1449.3622805965342;930.7952250504878;936.489613160829;944.5230158769915;949.3639261694543;999.4203362049993;5425.593080518976;5461.262729531462;5461.4811592899405;5461.863453413617;5519.862003449865;5679.545636349082;5680.5171560417;5686.886262274731;5691.203231547586;5699.344575373802;5186.418142466584;5440.755166017539;5449.4005659377435;5484.122540393518;5517.36550296713;3021.4108248891257;3041.1788817019283;3044.725974662291;3056.5262384330463;3057.8623961921767;5715.742791574389;5938.673372964442;6002.849928751729;6011.338752737195;6024.192742177329;5760.308762948473;5779.479846813723;5821.592488525763;5829.09649004405;5834.191400665807;5963;5977.671228082497;5986.401359864066;6030.336662966983;6041.486473649701;5653.2085508028085;5679.148127780866;5731.8567035824435;5757.733298674285;5820.883582328245;5640;5681.488666020078;5702.372738998624;5710.2576665033275;5744.569157313134;5798.5651076168615;6022.7289771959495;6025.969870150621;6042.758289668364;6042.879142417215;4039.515258168921;4068.5727998559723;4084.550699423002;4085.71400001997;4094.181163767318;5735.225744524436;5752.539796816328;5759.452851979056;5763.51010164124;5780.508656764054;5364.81973965727;5460.208269800777;5560.5551555876245;5567.777288908398;5577.860553486195;5545.779928415742;5546.473085056913;5548;5561.777528898799;5563.638363506359;5329.9467005331;5510.201020852034;5514.5864060194845;5550.916736249041;5561.5272701820795;5645.858853528531;5667.234923285304;5680.488756011979;5685.573581981451;5704.657720536781;5460.399356070909;5533.806316778893;5559.24950131727;5576.693281869374;5584.944150558443 08:36:32 INFO - PROCESS | 32577 | |5;yui.html;794.7139029949221;796.5937371940308;799.3085980626756;813.4793732011511;839.4837175137291;16001.599960001005;17206.483805485823;17229;17232.82767172328;17256.39602613907;14745.115293082396;14798.556043318691;14899.553013409588;14908.329125189366;14927.253637318117;676.0636518421984;800.1078797141204;814.0516298512256;823.423603477565;827.4786884262905;826.0582935453588;826.2439867521241;828.0187977246951;828.2338836576173;828.3414685325181;869.678219058949;871.8735783311416;873.0265753684628;874.1215078845783;874.2699845628875;696.7874798186551;825.6532256452305;846.0989046665312;848.825990671917;850.698002209213;626.6991843914901;629.3894921925724;629.568745409396;630.492453574872;630.6342321453546;15224.619384515365;15228.390864365412;15243.542693719206;15244.161571113584;15248.23758812055;14588.854111458855;14662.853371466255;14681.486147984877;14763.77854332186;14822.332995015251;12025.93987030068;12122.818157727641;13798.103123296954;13873.722525549534;14017.229052402114;4565.543445655441;4622;4641.2109941310055;4646.697964632288;4737.549932756418;78519.08487905614;78948.60525697393;79646.60176699137;80882.59558702228;82102.25284230107;11522.942385288019;11751.823722644167;11806.409679516162;11858.347790871585;12016.75966480683;19780.60438791216;19787.901060494605;19796.10917508687;19814.801851981585;19847.30534431288;8750.431221970679;8863.379563430499;8872.467651940775;9164.495952722664;9176.8623470648;4726.598239149711;4825.883743685777;4867.9269810952865;4970.428400733889;4971.975140124277;3499.33512632599;3594.4788005739542;3596.0470475323536;3596.8741094061584;3602.9191242627107;639.3127388057857;641.2145122225237;642.4346575013958;648.6011103171516;664.8204984654213;613.4601550635413;664.372168300951;689.6861927822829;712.9073220481304;743.8586668532961;9867.851982220272;10016;10163.69508914719;10215.182785377152;10314.27800054004;602.1690067706625;646.2723053018152;712.7362875736011;728.7445356621249;741.3587247031279;4428.535003824616;4696.929546056812;4724.362211101526;4906.656534042583;4921.286413470027;69017.3098269021;69260;69520.30479695239;70683.2931670687;84059.5797021011;95367.04632953582;95441.5227923856;96513.5174324124;96656.51671741596;97675.51162244144;81938.59030704689;82487.3502529946;83329.16670833336;83887.5805620968;87523;9120.224780893433;9310.95344523273;9333.113354231336;9490.240780737662;9567.61729530811;37472.555985788684;50181.74909125577;50962.74518627383;51182.440877956695;51985.48014519957;44201;66023.33976660173;68343;68852.655736723;70166.29833701598;13752.449902003807;14193.432262709788;14211.147331160164;14351.641208969859;14356.641083972985;15354.846451535788;15383.384664613737;15722.842771572137;15862;16325.918370408071;14253.71492570122;14453.848253952161;14950.626234344229;15170.238463611784;15604.531864044096;14460.59259333081;14874.77687834705;14937.576841958062;15176.24118794078;15232.543023709306;13252.536161234697;13344.532941347006;13437.462501500222;14358.856755422867;14508.927455362656;11339.919021896014;11910.225835320676;11968.521259149884;12158.289405301202;12268.44791984345;11625.885846812522;11699.649010529698;11921.403929803302;12037.157398981988;12219.389030548615 08:36:32 INFO - PROCESS | 32577 | __end_tp_report 08:36:32 INFO - PROCESS | 32577 | __start_cc_report 08:36:32 INFO - PROCESS | 32577 | _x_x_mozilla_cycle_collect,1033 08:36:32 INFO - PROCESS | 32577 | __end_cc_report 08:36:32 INFO - PROCESS | 32577 | __startTimestamp1469633792827__endTimestamp 08:36:32 INFO - PROCESS | 32577 | 08:36:32 INFO - PROCESS | 32577 | ------- Summary: start ------- 08:36:32 INFO - PROCESS | 32577 | Number of tests: 6 08:36:32 INFO - PROCESS | 32577 | 08:36:32 INFO - PROCESS | 32577 | [#0] dojo.html Cycles:165 Average:5386.23 Median:5648.38 stddev:622.98 (11.0%) stddev-sans-first:597.29 08:36:32 INFO - PROCESS | 32577 | Values: 3048.6 3082.6 3097.6 3128.1 3138.8 5316.5 5326.5 5375.5 5390.8 5424.9 5369.6 5422.6 5432.8 5494.0 5505.4 4824.0 4857.2 4893.5 4907.5 5059.3 4980.6 5011.5 5024.3 5031.7 5041.9 4831.6 4837.2 4868.1 4873.3 4940.4 4874.3 4877.9 4879.3 4939.7 4958.4 4875.9 4895.2 4916.0 4934.1 4948.3 5287.6 5310.0 5357.7 5448.2 5460.9 5752.7 5792.9 5805.7 5806.6 5807.9 5784.4 5821.0 5845.8 5850.4 5850.5 5273.3 5300.3 5382.3 5385.7 5412.9 5920.1 5962.4 5976.8 5983.3 5984.1 5715.8 5717.4 5720.3 5721.1 5721.7 5643.9 5705.9 5759.5 5760.5 5796.2 5754.7 5780.1 5800.6 5805.9 5811.3 5727.5 5778.2 5784.8 5785.9 5790.7 4333.8 4372.6 4377.3 4403.8 4464.4 3905.1 3952.4 3968.8 3973.9 3990.4 5546.7 5555.9 5557.1 5570.7 5573.2 5728.9 5759.3 5848.2 5855.4 5912.6 5485.3 5512.5 5514.6 5536.5 5567.2 4921.8 4928.0 4928.3 4928.4 4971.1 5878.2 5910.8 6002.0 6011.3 6011.5 5738.6 5750.3 5796.5 5845.0 5847.1 5983.9 5984.3 5989.3 5989.7 5989.8 5569.4 5603.2 5650.5 5656.4 5668.8 5813.9 5825.8 5863.7 5895.0 5899.4 5697.3 5715.1 5715.5 5716.0 5720.6 5513.1 5648.4 5704.8 5708.7 5713.8 5628.8 5650.2 5656.1 5700.9 5707.0 5775.0 5782.4 5826.3 5838.6 5840.4 5534.6 5560.9 5651.4 5656.7 5665.7 08:36:32 INFO - PROCESS | 32577 | 08:36:32 INFO - PROCESS | 32577 | [#1] ext.html Cycles:180 Average:61556.32 Median:37527.53 stddev:131907.49 (351.5%) stddev-sans-first:132198.14 08:36:32 INFO - PROCESS | 32577 | Values: 603.8 621.4 634.6 645.4 662.9 44160.8 45669.5 45674.0 48400.7 48577.5 46163.3 46410.1 46647.5 46673.0 46674.5 8345.5 9060.9 9238.9 9246.9 10838.2 10694.1 11108.2 11112.6 11113.5 11114.7 11155.1 11198.1 11201.0 11206.3 11210.1 11079.4 11106.2 11153.8 11162.2 11164.1 10913.6 10958.9 11011.5 11022.2 11030.6 43197.4 43240.0 43496.0 43705.3 43744.8 3677.8 3770.3 3845.2 3871.6 4187.5 33173.2 33317.7 33881.3 33893.5 34310.8 4404.6 4465.8 4476.4 4482.6 4490.1 242677.0 244897.0 244960.0 246491.7 246638.0 34391.8 59435.0 59659.7 59713.0 59968.4 35523.0 37474.4 37662.2 37744.8 37762.6 13377.2 13457.4 13458.7 13465.7 13476.0 11078.6 11260.8 11261.2 11905.6 12339.6 8275.4 8286.8 8471.0 8502.1 8506.4 3222.2 3283.1 3292.1 3299.3 3323.8 1048.0 1111.7 1154.2 1169.1 1183.3 33003.3 33023.2 33287.8 33340.0 33676.8 1089.6 1098.9 1132.2 1151.7 1179.6 16975.4 17320.6 17437.0 17503.7 17565.2 570340.0 602347.0 609804.0 610016.0 888403.0 62548.7 63120.0 63141.0 63149.0 63333.4 1237.2 1363.9 1366.6 1376.1 1419.4 32320.8 33934.8 34415.3 34437.7 34528.3 52118.5 52722.7 52992.7 53002.7 53010.5 466070.0 470888.0 471229.0 471406.0 472424.0 29119.9 29183.9 29980.1 30024.1 30419.8 50446.7 50688.0 51062.0 51238.0 51576.0 42878.6 43831.8 44467.0 44529.8 44953.6 42604.4 43096.1 43267.1 44540.0 44854.6 41659.8 43088.8 43503.3 43991.8 44070.0 36251.0 37580.6 38333.0 38381.2 38867.8 29018.3 29037.6 29124.0 29171.7 29539.6 08:36:32 INFO - PROCESS | 32577 | 08:36:32 INFO - PROCESS | 32577 | [#2] jquery.html Cycles:180 Average:27714.77 Median:42613.68 stddev:76839.21 (180.3%) stddev-sans-first:77027.33 08:36:32 INFO - PROCESS | 32577 | Values: 370.6 385.7 397.4 400.8 421.4 14357.5 17220.7 19427.8 19758.1 19762.0 18767.8 18810.5 18845.0 19035.8 19064.7 4201.5 5667.1 5859.2 5868.4 5869.7 6318.0 6590.2 6638.2 6646.0 6651.2 6367.3 6496.4 6555.5 6605.4 6614.9 6391.8 6595.5 6612.9 6620.3 6631.5 5789.9 5822.9 5834.5 5836.7 5843.4 22993.8 22998.1 23185.9 23202.4 23256.4 2320.8 2406.7 2454.1 2467.3 2570.7 14016.4 14534.4 14566.8 15159.4 15392.1 1893.5 1894.3 1948.2 1956.2 1979.2 54203.2 54533.5 54841.5 60318.0 68069.0 10469.7 10495.0 10676.1 10752.4 11000.3 14934.6 14953.8 14980.1 15008.8 15018.6 7810.9 7893.8 7962.4 8020.7 8115.2 7465.5 7519.5 7540.6 7737.8 7756.1 6443.2 6530.8 6575.9 6643.4 6778.7 1942.8 1982.9 1987.8 1989.5 2005.9 880.6 902.5 927.2 946.5 974.6 17142.0 17910.9 18066.5 18254.0 18457.0 874.8 904.1 927.3 944.7 948.5 9831.8 10453.7 10532.1 10551.7 10621.6 459597.0 466186.0 467420.0 474188.0 475716.0 81681.0 82104.0 83577.0 84087.6 85124.6 851.3 874.0 875.1 875.2 875.4 15559.5 16206.6 16350.3 16432.4 16485.4 42396.4 42831.0 43011.6 43390.6 44351.9 56880.1 57764.1 58744.7 58750.4 58919.4 8215.9 8227.8 8635.0 8675.0 8684.4 12974.9 13651.2 13738.5 13779.3 13821.5 11459.4 11979.1 12013.0 12096.3 12375.8 11488.9 11759.6 12027.8 12085.3 12542.8 12119.2 12160.8 12240.9 12241.6 12488.9 8116.5 8359.4 8368.6 8465.4 8913.8 11035.2 11472.4 11493.8 11804.4 11878.3 08:36:32 INFO - PROCESS | 32577 | 08:36:32 INFO - PROCESS | 32577 | [#3] mootools.html Cycles:180 Average:5812.45 Median:445.70 stddev:3344.09 (750.3%) stddev-sans-first:3336.59 08:36:32 INFO - PROCESS | 32577 | Values: 1340.9 1466.7 1541.9 1680.2 1819.6 8444.7 8753.6 8855.2 9016.5 9032.9 8898.0 8979.6 8986.9 9001.1 9012.8 2345.7 2375.2 2375.5 2378.8 2381.4 2291.6 2339.7 2360.6 2369.4 2370.6 2303.6 2312.8 2315.0 2358.7 2362.7 2260.3 2271.3 2304.9 2305.7 2322.2 2293.8 2306.0 2312.0 2313.4 2313.6 8694.6 8941.7 8991.2 8997.0 9002.8 5188.0 5264.4 5264.6 5306.0 5313.4 3442.6 3475.8 3494.2 3544.0 3553.7 1102.5 1156.8 1158.1 1158.5 1174.5 12259.7 12326.4 12329.7 12361.0 12385.7 4238.8 4319.2 4410.1 4422.1 4526.3 9568.9 9607.1 9638.9 9640.1 9646.4 5121.3 5144.7 5155.9 5163.1 5164.9 4266.8 4331.6 4470.7 4766.2 4854.4 3764.5 3775.5 3926.5 3931.9 3952.3 1123.4 1148.1 1149.1 1154.5 1157.0 890.8 999.4 1001.3 1005.8 1018.8 6009.3 6012.2 6215.8 6223.0 6243.5 443.6 445.2 446.2 454.4 464.2 3954.9 4266.0 4283.9 4299.8 4373.3 10925.7 11220.7 11269.2 11301.8 11317.2 10437.4 10753.3 10804.7 11093.1 11226.7 8225.8 8400.1 8429.7 8431.0 8434.1 5972.2 6074.1 6160.7 6212.3 6261.7 10242.5 10301.7 10329.5 10390.1 10397.7 10011.3 10236.5 10307.5 10423.4 10563.8 7125.5 7459.0 7756.3 7931.8 7954.9 8484.4 8855.1 8858.8 8865.0 8869.2 7672.8 7705.0 7866.2 7937.2 8008.5 7398.9 7549.8 7714.1 7764.0 8055.8 6808.7 6902.5 6911.0 6911.3 6912.8 4931.4 5035.8 5174.6 5242.8 5387.4 5238.7 5282.1 5299.2 5324.0 5336.9 08:36:32 INFO - PROCESS | 32577 | 08:36:32 INFO - PROCESS | 32577 | [#4] prototype.html Cycles:180 Average:4718.23 Median:5454.80 stddev:1391.12 (25.5%) stddev-sans-first:1355.51 08:36:32 INFO - PROCESS | 32577 | Values: 331.9 338.6 341.7 342.9 344.4 5392.6 5398.9 5415.5 5417.6 5443.3 5301.7 5307.5 5362.5 5399.2 5403.9 3989.3 4076.0 4150.8 4188.2 4202.0 4164.9 4178.4 4192.4 4196.5 4208.7 4126.6 4129.0 4130.9 4142.0 4149.3 3926.0 3950.3 4129.9 4179.5 4180.3 3660.0 3662.7 3670.1 3674.9 3679.2 5157.6 5164.5 5182.4 5199.2 5217.9 4503.9 4704.6 4728.6 4736.5 4791.3 5522.7 5562.9 5563.2 5578.9 5603.4 4022.9 4023.4 4026.7 4027.0 4042.4 5596.2 5771.2 5787.5 5844.8 5867.0 4071.2 4075.7 4079.4 4084.2 4092.9 4159.0 4166.4 4174.2 4177.6 4183.4 4513.8 4650.3 4743.7 4788.5 4801.2 5570.3 5577.4 5587.5 5610.2 5631.2 1420.0 1446.5 1447.4 1448.3 1449.4 930.8 936.5 944.5 949.4 999.4 5425.6 5461.3 5461.5 5461.9 5519.9 5679.5 5680.5 5686.9 5691.2 5699.3 5186.4 5440.8 5449.4 5484.1 5517.4 3021.4 3041.2 3044.7 3056.5 3057.9 5715.7 5938.7 6002.8 6011.3 6024.2 5760.3 5779.5 5821.6 5829.1 5834.2 5963.0 5977.7 5986.4 6030.3 6041.5 5653.2 5679.1 5731.9 5757.7 5820.9 5640.0 5681.5 5702.4 5710.3 5744.6 5798.6 6022.7 6026.0 6042.8 6042.9 4039.5 4068.6 4084.6 4085.7 4094.2 5735.2 5752.5 5759.5 5763.5 5780.5 5364.8 5460.2 5560.6 5567.8 5577.9 5545.8 5546.5 5548.0 5561.8 5563.6 5329.9 5510.2 5514.6 5550.9 5561.5 5645.9 5667.2 5680.5 5685.6 5704.7 5460.4 5533.8 5559.2 5576.7 5584.9 08:36:32 INFO - PROCESS | 32577 | 08:36:32 INFO - PROCESS | 32577 | [#5] yui.html Cycles:180 Average:19485.59 Median:4846.91 stddev:26012.78 (536.7%) stddev-sans-first:26047.89 08:36:32 INFO - PROCESS | 32577 | Values: 794.7 796.6 799.3 813.5 839.5 16001.6 17206.5 17229.0 17232.8 17256.4 14745.1 14798.6 14899.6 14908.3 14927.3 676.1 800.1 814.1 823.4 827.5 826.1 826.2 828.0 828.2 828.3 869.7 871.9 873.0 874.1 874.3 696.8 825.7 846.1 848.8 850.7 626.7 629.4 629.6 630.5 630.6 15224.6 15228.4 15243.5 15244.2 15248.2 14588.9 14662.9 14681.5 14763.8 14822.3 12025.9 12122.8 13798.1 13873.7 14017.2 4565.5 4622.0 4641.2 4646.7 4737.5 78519.1 78948.6 79646.6 80882.6 82102.3 11522.9 11751.8 11806.4 11858.3 12016.8 19780.6 19787.9 19796.1 19814.8 19847.3 8750.4 8863.4 8872.5 9164.5 9176.9 4726.6 4825.9 4867.9 4970.4 4972.0 3499.3 3594.5 3596.0 3596.9 3602.9 639.3 641.2 642.4 648.6 664.8 613.5 664.4 689.7 712.9 743.9 9867.9 10016.0 10163.7 10215.2 10314.3 602.2 646.3 712.7 728.7 741.4 4428.5 4696.9 4724.4 4906.7 4921.3 69017.3 69260.0 69520.3 70683.3 84059.6 95367.0 95441.5 96513.5 96656.5 97675.5 81938.6 82487.4 83329.2 83887.6 87523.0 9120.2 9311.0 9333.1 9490.2 9567.6 37472.6 50181.7 50962.7 51182.4 51985.5 44201.0 66023.3 68343.0 68852.7 70166.3 13752.4 14193.4 14211.1 14351.6 14356.6 15354.8 15383.4 15722.8 15862.0 16325.9 14253.7 14453.8 14950.6 15170.2 15604.5 14460.6 14874.8 14937.6 15176.2 15232.5 13252.5 13344.5 13437.5 14358.9 14508.9 11339.9 11910.2 11968.5 12158.3 12268.4 11625.9 11699.6 11921.4 12037.2 12219.4 08:36:32 INFO - PROCESS | 32577 | -------- Summary: end -------- 08:36:32 INFO - PROCESS | 32577 | 08:36:33 INFO - TEST-INFO | 32577: exit 0 08:36:33 INFO - TEST-OK | dromaeo_css | took 1113984ms 08:36:33 INFO - TEST-START | kraken 08:36:33 INFO - operating with platform_type : linux_ 08:36:33 INFO - Initialising browser for kraken test... 08:36:33 INFO - TEST-INFO | started process 32765 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph4KUL7/profile http://localhost:60242/getInfo.html) 08:36:37 INFO - PROCESS | 32765 | JavaScript error: , line 0: uncaught exception: undefined 08:36:37 INFO - PROCESS | 32765 | __metrics Screen width/height:1600/1200 08:36:37 INFO - PROCESS | 32765 | colorDepth:24 08:36:37 INFO - PROCESS | 32765 | Browser inner width/height: 1024/697 08:36:37 INFO - PROCESS | 32765 | __metrics 08:36:38 INFO - PROCESS | 32765 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:36:38 INFO - PROCESS | 32765 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:36:39 INFO - TEST-INFO | 32765: exit 0 08:36:39 INFO - Browser initialized. 08:36:39 INFO - Running cycle 1/1 for kraken test... 08:36:39 INFO - TEST-INFO | started process 380 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph4KUL7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:36:51 INFO - PROCESS | 380 | RSS: Main: 157462528 08:36:51 INFO - PROCESS | 380 | 08:36:54 INFO - PROCESS | 380 | Cycle 1(1): loaded http://localhost:60242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60242/tests/kraken/driver.html?testName=audio-beat-detection) 08:36:55 INFO - PROCESS | 380 | RSS: Main: 214781952 08:36:55 INFO - PROCESS | 380 | 08:36:57 INFO - PROCESS | 380 | Cycle 1(1): loaded http://localhost:60242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60242/tests/kraken/driver.html?testName=audio-dft) 08:36:58 INFO - PROCESS | 380 | RSS: Main: 192524288 08:36:58 INFO - PROCESS | 380 | 08:37:01 INFO - PROCESS | 380 | Cycle 1(1): loaded http://localhost:60242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60242/tests/kraken/driver.html?testName=audio-fft) 08:37:02 INFO - PROCESS | 380 | RSS: Main: 270569472 08:37:02 INFO - PROCESS | 380 | 08:37:04 INFO - PROCESS | 380 | Cycle 1(1): loaded http://localhost:60242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60242/tests/kraken/driver.html?testName=audio-oscillator) 08:37:04 INFO - PROCESS | 380 | RSS: Main: 180551680 08:37:04 INFO - PROCESS | 380 | 08:37:06 INFO - PROCESS | 380 | Cycle 1(1): loaded http://localhost:60242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:37:07 INFO - PROCESS | 380 | RSS: Main: 185454592 08:37:07 INFO - PROCESS | 380 | 08:37:10 INFO - PROCESS | 380 | Cycle 1(1): loaded http://localhost:60242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60242/tests/kraken/driver.html?testName=imaging-darkroom) 08:37:11 INFO - PROCESS | 380 | RSS: Main: 220352512 08:37:11 INFO - PROCESS | 380 | 08:37:14 INFO - PROCESS | 380 | Cycle 1(1): loaded http://localhost:60242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60242/tests/kraken/driver.html?testName=imaging-desaturate) 08:37:15 INFO - PROCESS | 380 | RSS: Main: 221757440 08:37:15 INFO - PROCESS | 380 | 08:37:17 INFO - PROCESS | 380 | Cycle 1(1): loaded http://localhost:60242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60242/tests/kraken/driver.html?testName=json-parse-financial) 08:37:18 INFO - PROCESS | 380 | RSS: Main: 221073408 08:37:18 INFO - PROCESS | 380 | 08:37:20 INFO - PROCESS | 380 | Cycle 1(1): loaded http://localhost:60242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:37:20 INFO - PROCESS | 380 | RSS: Main: 185602048 08:37:20 INFO - PROCESS | 380 | 08:37:22 INFO - PROCESS | 380 | Cycle 1(1): loaded http://localhost:60242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60242/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:37:23 INFO - PROCESS | 380 | RSS: Main: 190230528 08:37:23 INFO - PROCESS | 380 | 08:37:25 INFO - PROCESS | 380 | Cycle 1(1): loaded http://localhost:60242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:37:25 INFO - PROCESS | 380 | RSS: Main: 195112960 08:37:25 INFO - PROCESS | 380 | 08:37:28 INFO - PROCESS | 380 | Cycle 1(1): loaded http://localhost:60242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:37:28 INFO - PROCESS | 380 | RSS: Main: 189558784 08:37:28 INFO - PROCESS | 380 | 08:37:31 INFO - PROCESS | 380 | Cycle 1(1): loaded http://localhost:60242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:37:32 INFO - PROCESS | 380 | RSS: Main: 194035712 08:37:32 INFO - PROCESS | 380 | 08:37:33 INFO - PROCESS | 380 | Cycle 1(1): loaded http://localhost:60242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60242/tests/kraken/driver.html?testName=ai-astar) 08:37:34 INFO - PROCESS | 380 | RSS: Main: 243736576 08:37:34 INFO - PROCESS | 380 | 08:37:34 INFO - PROCESS | 380 | __start_tp_report 08:37:34 INFO - PROCESS | 380 | _x_x_mozilla_page_load 08:37:34 INFO - PROCESS | 380 | _x_x_mozilla_page_load_details 08:37:34 INFO - PROCESS | 380 | |i|pagename|runs| 08:37:34 INFO - PROCESS | 380 | |0;ai-astar;102;111;111;111;113;111;110;110;111;111 08:37:34 INFO - PROCESS | 380 | |1;audio-beat-detection;146;117;118;174;120;120;148;120;168;117 08:37:34 INFO - PROCESS | 380 | |2;audio-dft;160;160;160;159;162;161;160;162;160;161 08:37:34 INFO - PROCESS | 380 | |3;audio-fft;75;75;73;108;74;75;75;75;112;73 08:37:34 INFO - PROCESS | 380 | |4;audio-oscillator;83;84;123;84;84;83;128;83;84;123 08:37:34 INFO - PROCESS | 380 | |5;imaging-gaussian-blur;117;117;117;117;116;116;116;118;117;116 08:37:34 INFO - PROCESS | 380 | |6;imaging-darkroom;145;146;145;145;145;155;146;146;146;145 08:37:34 INFO - PROCESS | 380 | |7;imaging-desaturate;95;95;94;94;95;94;95;95;95;95 08:37:34 INFO - PROCESS | 380 | |8;json-parse-financial;51;50;52;52;55;51;51;51;51;50 08:37:34 INFO - PROCESS | 380 | |9;json-stringify-tinderbox;61;62;62;61;61;62;62;61;62;62 08:37:34 INFO - PROCESS | 380 | |10;stanford-crypto-aes;76;85;76;76;76;79;81;77;76;80 08:37:34 INFO - PROCESS | 380 | |11;stanford-crypto-ccm;121;122;127;119;119;119;130;118;158;122 08:37:34 INFO - PROCESS | 380 | |12;stanford-crypto-pbkdf2;156;166;155;158;153;154;155;154;160;157 08:37:34 INFO - PROCESS | 380 | |13;stanford-crypto-sha256-iterative;63;64;64;63;64;67;63;63;65;66 08:37:34 INFO - PROCESS | 380 | __end_tp_report 08:37:34 INFO - PROCESS | 380 | __start_cc_report 08:37:34 INFO - PROCESS | 380 | _x_x_mozilla_cycle_collect,1693 08:37:34 INFO - PROCESS | 380 | __end_cc_report 08:37:34 INFO - PROCESS | 380 | __startTimestamp1469633854061__endTimestamp 08:37:34 INFO - PROCESS | 380 | 08:37:34 INFO - PROCESS | 380 | ------- Summary: start ------- 08:37:34 INFO - PROCESS | 380 | Number of tests: 14 08:37:34 INFO - PROCESS | 380 | 08:37:34 INFO - PROCESS | 380 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:2.96 (2.7%) stddev-sans-first:0.87 08:37:34 INFO - PROCESS | 380 | Values: 102.0 111.0 111.0 111.0 113.0 111.0 110.0 110.0 111.0 111.0 08:37:34 INFO - PROCESS | 380 | 08:37:34 INFO - PROCESS | 380 | [#1] audio-beat-detection Cycles:10 Average:134.80 Median:133.00 stddev:22.39 (16.8%) stddev-sans-first:23.38 08:37:34 INFO - PROCESS | 380 | Values: 146.0 117.0 118.0 174.0 120.0 120.0 148.0 120.0 168.0 117.0 08:37:34 INFO - PROCESS | 380 | 08:37:34 INFO - PROCESS | 380 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.50 stddev:0.97 (0.6%) stddev-sans-first:1.01 08:37:34 INFO - PROCESS | 380 | Values: 160.0 160.0 160.0 159.0 162.0 161.0 160.0 162.0 160.0 161.0 08:37:34 INFO - PROCESS | 380 | 08:37:34 INFO - PROCESS | 380 | [#3] audio-fft Cycles:10 Average:81.50 Median:75.00 stddev:15.07 (20.1%) stddev-sans-first:15.80 08:37:34 INFO - PROCESS | 380 | Values: 75.0 75.0 73.0 108.0 74.0 75.0 75.0 75.0 112.0 73.0 08:37:34 INFO - PROCESS | 380 | 08:37:34 INFO - PROCESS | 380 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:83.50 stddev:19.90 (23.8%) stddev-sans-first:20.55 08:37:34 INFO - PROCESS | 380 | Values: 83.0 84.0 123.0 84.0 84.0 83.0 128.0 83.0 84.0 123.0 08:37:34 INFO - PROCESS | 380 | 08:37:34 INFO - PROCESS | 380 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 08:37:34 INFO - PROCESS | 380 | Values: 117.0 117.0 117.0 117.0 116.0 116.0 116.0 118.0 117.0 116.0 08:37:34 INFO - PROCESS | 380 | 08:37:34 INFO - PROCESS | 380 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:3.06 (2.1%) stddev-sans-first:3.21 08:37:34 INFO - PROCESS | 380 | Values: 145.0 146.0 145.0 145.0 145.0 155.0 146.0 146.0 146.0 145.0 08:37:34 INFO - PROCESS | 380 | 08:37:34 INFO - PROCESS | 380 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 08:37:34 INFO - PROCESS | 380 | Values: 95.0 95.0 94.0 94.0 95.0 94.0 95.0 95.0 95.0 95.0 08:37:34 INFO - PROCESS | 380 | 08:37:34 INFO - PROCESS | 380 | [#8] json-parse-financial Cycles:10 Average:51.40 Median:51.00 stddev:1.43 (2.8%) stddev-sans-first:1.51 08:37:34 INFO - PROCESS | 380 | Values: 51.0 50.0 52.0 52.0 55.0 51.0 51.0 51.0 51.0 50.0 08:37:34 INFO - PROCESS | 380 | 08:37:34 INFO - PROCESS | 380 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:62.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 08:37:34 INFO - PROCESS | 380 | Values: 61.0 62.0 62.0 61.0 61.0 62.0 62.0 61.0 62.0 62.0 08:37:34 INFO - PROCESS | 380 | 08:37:34 INFO - PROCESS | 380 | [#10] stanford-crypto-aes Cycles:10 Average:78.20 Median:78.00 stddev:3.05 (3.9%) stddev-sans-first:3.13 08:37:34 INFO - PROCESS | 380 | Values: 76.0 85.0 76.0 76.0 76.0 79.0 81.0 77.0 76.0 80.0 08:37:34 INFO - PROCESS | 380 | 08:37:34 INFO - PROCESS | 380 | [#11] stanford-crypto-ccm Cycles:10 Average:125.50 Median:122.00 stddev:12.05 (9.9%) stddev-sans-first:12.67 08:37:34 INFO - PROCESS | 380 | Values: 121.0 122.0 127.0 119.0 119.0 119.0 130.0 118.0 158.0 122.0 08:37:34 INFO - PROCESS | 380 | 08:37:34 INFO - PROCESS | 380 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.80 Median:156.50 stddev:3.85 (2.5%) stddev-sans-first:4.08 08:37:34 INFO - PROCESS | 380 | Values: 156.0 166.0 155.0 158.0 153.0 154.0 155.0 154.0 160.0 157.0 08:37:34 INFO - PROCESS | 380 | 08:37:34 INFO - PROCESS | 380 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:64.00 stddev:1.40 (2.2%) stddev-sans-first:1.41 08:37:34 INFO - PROCESS | 380 | Values: 63.0 64.0 64.0 63.0 64.0 67.0 63.0 63.0 65.0 66.0 08:37:34 INFO - PROCESS | 380 | -------- Summary: end -------- 08:37:34 INFO - PROCESS | 380 | 08:37:35 INFO - TEST-INFO | 380: exit 0 08:37:35 INFO - TEST-OK | kraken | took 61486ms 08:37:35 INFO - SUITE-END | took 1175s 08:37:35 INFO - Completed test suite (00:19:35) 08:37:35 INFO - javascript benchmark 08:37:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3048.588440560524, 3082.5684404183403, 3097.6127984002, 3128.139761565568, 3138.811671299722, 5316.49493298137, 5326.520613144821, 5375.543078838294, 5390.838274851756, 5424.864378390537, 5369.5704343652515, 5422.6475279106835, 5432.75552600133, 5494.0, 5505.421930697269, 4823.951760482394, 4857.198562237227, 4893.4617192108835, 4907.484714105021, 5059.266406371074, 4980.576650984653, 5011.523905228997, 5024.271480635306, 5031.723255220962, 5041.899162016757, 4831.565159135677, 4837.153498137847, 4868.1237377272255, 4873.269009648546, 4940.431850337203, 4874.293227481995, 4877.8780530486665, 4879.268109783526, 4939.703617782944, 4958.355413796219, 4875.902481950377, 4895.241237608177, 4915.950840491585, 4934.062528119646, 4948.307236986825, 5287.603429742785, 5310.0441920454305, 5357.678539287655, 5448.237246785453, 5460.918086228709, 5752.741126649311, 5792.913106303409, 5805.651660900359, 5806.5645076619, 5807.941920580783, 5784.363719990798, 5821.0, 5845.766169353221, 5850.414958504158, 5850.473457388855, 5273.314469119028, 5300.337457817773, 5382.300300960928, 5385.703786291791, 5412.864678383072, 5920.111983202554, 5962.433568810956, 5976.790812321635, 5983.311919129356, 5984.132300816357, 5715.799947001919, 5717.37108918027, 5720.256366672306, 5721.141828725725, 5721.713914304268, 5643.887122257532, 5705.942940570541, 5759.510441612426, 5760.53915686744, 5796.188533605215, 5754.6547207167705, 5780.132980053026, 5800.5939584229545, 5805.912911306334, 5811.3316968548315, 5727.5131613812455, 5778.162166485836, 5784.797532086357, 5785.884282314414, 5790.681512516768, 4333.826646934087, 4372.584604462634, 4377.299632058919, 4403.779811009436, 4464.3973063635995, 3905.082305658168, 3952.4268980997595, 3968.7817170055923, 3973.900652483711, 3990.4213888985932, 5546.694931778791, 5555.861103472445, 5557.055300598827, 5570.721463926788, 5573.219749235111, 5728.856778580569, 5759.308882934075, 5848.2397288353095, 5855.414458554195, 5912.615679980788, 5485.314335708036, 5512.476314750093, 5514.558835293167, 5536.52939500147, 5567.164925261162, 4921.7785199666105, 4928.0, 4928.334674818925, 4928.433230178575, 4971.130052240844, 5878.2064421302575, 5910.822675319747, 6002.009668404664, 6011.3086994995265, 6011.458968692751, 5738.626989245686, 5750.25246717924, 5796.478316951495, 5844.970775146097, 5847.1229315603, 5983.9401605983385, 5984.281886173513, 5989.2812862456785, 5989.670568118621, 5989.8203053908455, 5569.359523654832, 5603.243562119224, 5650.491455769001, 5656.37779844225, 5668.829935101953, 5813.94186058134, 5825.79609713658, 5863.706814659165, 5895.0, 5899.380565040609, 5697.259356283656, 5715.085586306171, 5715.485606295453, 5715.971420142872, 5720.570957178312, 5513.090340094, 5648.378678345297, 5704.771809127588, 5708.714564271853, 5713.771449142154, 5628.802991895264, 5650.23721797552, 5656.123300888369, 5700.885982280414, 5706.9714651426475, 5774.989376858949, 5782.392848750989, 5826.271716035496, 5838.620489668158, 5840.415958404125, 5534.584906132137, 5560.944390556205, 5651.350094739158, 5656.745446455002, 5665.66006039639], "value": 5343.127974558462, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.8339456649421, 621.3537920562615, 634.5621521150409, 645.3610925184067, 662.9436497897678, 44160.77919610401, 45669.543304566985, 45674.0, 48400.67592564815, 48577.51422485774, 46163.30755038677, 46410.07179856401, 46647.533524664745, 46673.0, 46674.53325466744, 8345.54099524526, 9060.909390906088, 9238.86141707875, 9246.86129708055, 10838.187135964834, 10694.144468442544, 11108.16688748347, 11112.555497780078, 11113.499892504817, 11114.722131946726, 11155.107591392709, 11198.104151667887, 11201.04791092758, 11206.327620342805, 11210.103191744682, 11079.390633515153, 11106.222564420494, 11153.776924461547, 11162.218644694874, 11164.051055660279, 10913.563457461692, 10958.890411095947, 11011.504482298316, 11022.173336999756, 11030.613928512463, 43197.35203971943, 43240.0, 43496.0, 43705.34441983373, 43744.78127609374, 3677.8161091945294, 3770.3213421584105, 3845.1732877431205, 3871.593482684306, 4187.455630768011, 33173.17047614761, 33317.66682333194, 33881.32237355239, 33893.46295010421, 34310.82844585761, 4404.559544045602, 4465.821367145343, 4476.440444944382, 4482.618977386926, 4490.101979604092, 242676.99999999822, 244897.0, 244960.0, 246491.74557780963, 246638.0, 34391.82804085963, 59435.0, 59659.70170149121, 59713.0, 59968.400315997154, 35523.0, 37474.43788343177, 37662.24675506475, 37744.811275944, 37762.62237377646, 13377.197368157942, 13457.394417251247, 13458.663533411744, 13465.730685386237, 13476.0, 11078.612248571262, 11260.831087533694, 11261.155413344031, 11905.64283071492, 12339.568115116108, 8275.420720549624, 8286.792830179173, 8470.957645211858, 8502.06477287498, 8506.36202284831, 3222.194451387153, 3283.097148284241, 3292.0782180989363, 3299.307145499472, 3323.7673362864366, 1048.030571721155, 1111.7387413957713, 1154.215133709069, 1169.0822704177351, 1183.331417748969, 33003.339933201205, 33023.174420639196, 33287.83356083204, 33340.0, 33676.831615841766, 1089.6186334782763, 1098.9010989011028, 1132.1621999720148, 1151.6832870960552, 1179.6107284596235, 16975.405860794814, 17320.566985825455, 17437.0, 17503.73744393835, 17565.20956556958, 570340.0, 602347.0, 609804.0, 610016.0, 888403.0, 62548.687256563426, 63120.0, 63141.0, 63149.0, 63333.36666633367, 1237.2267332916927, 1363.9045266831424, 1366.6241783509415, 1376.0917794255943, 1419.3825685826698, 32320.83839580787, 33934.83032584821, 34415.311693765485, 34437.65562344445, 34528.30943381068, 52118.47881521136, 52722.736386317825, 52992.73503632457, 53002.734986324824, 53010.46989530209, 466070.0, 470888.0, 471229.0, 471406.0, 472424.0, 29119.85440072871, 29183.85408072946, 29980.102586663594, 30024.099277021724, 30419.847900760353, 50446.74776626093, 50688.0, 51062.0, 51238.0, 51576.0, 42878.571214287454, 43831.78084109559, 44467.0, 44529.777351113036, 44953.55046449624, 42604.36093458663, 43096.13807723891, 43267.13465730605, 44540.0, 44854.55145448504, 41659.7917010413, 43088.78455607702, 43503.34744978891, 43991.78004109959, 44070.0, 36251.0, 37580.624193757714, 38333.0, 38381.2323753529, 38867.80566097151, 29018.27454313659, 29037.564436533892, 29124.0, 29171.708282916898, 29539.556906645987], "value": 19839.13201853653, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.5590347486489, 385.7164983736951, 397.38802244543405, 400.7835768684909, 421.3721554883223, 14357.497487587936, 17220.65558688827, 19427.805721942776, 19758.110885010192, 19762.0, 18767.812321876776, 18810.529736756554, 18845.0, 19035.809641903576, 19064.71402928954, 4201.516825565069, 5667.064934285848, 5859.1797148399255, 5868.383819698913, 5869.706514674271, 6318.0, 6590.209174899019, 6638.203415590112, 6646.0363247329105, 6651.2018557773135, 6367.267764207106, 6496.447801936841, 6555.50833687473, 6605.372489613503, 6614.8677026459445, 6391.808245752635, 6595.505337099713, 6612.900806487906, 6620.304867988864, 6631.502637302197, 5789.855253618651, 5822.883542329129, 5834.474897259267, 5836.737346819404, 5843.444872737083, 22993.77006229933, 22998.08007679691, 23185.884070579537, 23202.41993950148, 23256.4185895354, 2320.8375413721046, 2406.6510355998457, 2454.0674543673467, 2467.346153269385, 2570.717221105677, 14016.43934242629, 14534.418623255056, 14566.781498277534, 15159.393624255017, 15392.076475411399, 1893.5266183454137, 1894.2517705506386, 1948.2109745553073, 1956.2370675436591, 1979.1786408640542, 54203.18695219575, 54533.45466545323, 54841.451585484036, 60317.99999999956, 68069.0, 10469.738256543647, 10495.0, 10676.145908327315, 10752.408617525954, 11000.339979601249, 14934.551963441114, 14953.775693364609, 14980.1011939284, 15008.849911500745, 15018.624534386729, 7810.882836757453, 7893.842123157505, 7962.3630109591095, 8020.679172833138, 8115.229053240051, 7465.514741541782, 7519.548827070394, 7540.622968851536, 7737.767866964, 7756.069271687434, 6443.194600674916, 6530.836729081716, 6575.868482630321, 6643.368879956396, 6778.72885084601, 1942.8445724342018, 1982.89094099823, 1987.807315610651, 1989.518342899925, 2005.8997050147725, 880.6477409036308, 902.4585248850638, 927.174814415171, 946.4699768129869, 974.6150270643057, 17142.0, 17910.91044544795, 18066.548336291697, 18254.0, 18457.0, 874.7856775090144, 904.1004200820095, 927.3230541704594, 944.7449188719007, 948.5399581203111, 9831.80336393268, 10453.738656533495, 10532.10477109439, 10551.736206594896, 10621.628243011612, 459597.0, 466186.0, 467420.0, 474188.0, 475716.0, 81681.0, 82104.0, 83577.0, 84087.5795621018, 85124.57437712772, 851.2508992086924, 873.9737807865774, 875.1292463998362, 875.1948207648978, 875.4440930009363, 15559.533214003599, 16206.594835128744, 16350.345986160895, 16432.424865129662, 16485.423010194587, 42396.36405453982, 42831.0, 43011.569884300756, 43390.566094338654, 44351.89120272019, 56880.146797797235, 57764.09005234602, 58744.70627646834, 58750.412495874494, 58919.41080589139, 8215.917840821516, 8227.753167404988, 8635.0, 8675.045744968174, 8684.392092553713, 12974.935125324313, 13651.249181295125, 13738.450461981809, 13779.311034448438, 13821.516246931309, 11459.4270286487, 11979.101567382308, 12013.0, 12096.274223546616, 12375.814362784746, 11488.94255528717, 11759.588414405454, 12027.75944481088, 12085.335306558223, 12542.811857821958, 12119.212251203644, 12160.75678486443, 12240.938795306323, 12241.571544995883, 12488.875111249135, 8116.513009219466, 8359.373047021376, 8368.623411946355, 8465.449745766751, 8913.821723565363, 11035.227534072537, 11472.426378680866, 11493.770124597628, 11804.409779511161, 11878.287302761517], "value": 9263.32295210478, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1340.8592097829733, 1466.7139907717992, 1541.8997765145264, 1680.1851102215423, 1819.6360727854433, 8444.746657600273, 8753.64985400584, 8855.158759917806, 9016.54917254138, 9032.90967090329, 8898.0, 8979.551022448884, 8986.86519702205, 9001.099890010995, 9012.819743605123, 2345.718513778345, 2375.2043065573052, 2375.5367703297866, 2378.7502312257225, 2381.3808409813487, 2291.59897018022, 2339.7192336919593, 2360.6223004319313, 2369.4194922244073, 2370.644403339504, 2303.585354636165, 2312.81497480202, 2315.0392587076344, 2358.740538540759, 2362.716474023111, 2260.2541161416693, 2271.2618399020303, 2304.8501847379866, 2305.688732021181, 2322.15241436876, 2293.8050265727265, 2306.042992158252, 2311.953760924789, 2313.363824948136, 2313.6298192289155, 8694.565271736452, 8941.6870409536, 8991.190792828611, 8996.955015224881, 9002.774930626721, 5188.0, 5264.447233040552, 5264.552513036397, 5306.044911915854, 5313.362396512404, 3442.5524681791208, 3475.8435870385892, 3494.2312691207894, 3544.043108360728, 3553.7157027437743, 1102.514893446889, 1156.7512984708328, 1158.0966845860157, 1158.536585365852, 1174.4656181437426, 12259.69350766229, 12326.445309961073, 12329.69175770604, 12361.0, 12385.690357741038, 4238.830446782156, 4319.200947824663, 4410.117976404732, 4422.137683151819, 4526.253168227206, 9568.856467152998, 9607.087326704092, 9638.90361096394, 9640.084192001748, 9646.372985755903, 5121.334226550524, 5144.6655967362, 5155.948440515547, 5163.096458119814, 5164.92252616211, 4266.829326826892, 4331.5884990925815, 4470.687051906335, 4766.237402015661, 4854.441739200037, 3764.4917936078828, 3775.5469343678933, 3926.4895563577124, 3931.941020884689, 3952.3478626026385, 1123.4045955643358, 1148.0872706198593, 1149.0692539043234, 1154.5439551377326, 1156.9710757230969, 890.8173824365989, 999.4253304350028, 1001.2590682894605, 1005.8340373838381, 1018.8267994440963, 6009.278886533644, 6012.218411606463, 6215.782447614311, 6223.0, 6243.531735119885, 443.57195306529354, 445.1519854676846, 446.2391622283998, 454.44330694899145, 464.2386486162696, 3954.8615798446917, 4266.0188156724125, 4283.850065247701, 4299.828006879752, 4373.278409062533, 10925.726856828644, 11220.66338009861, 11269.211155219056, 11301.773964520664, 11317.151213659008, 10437.425941573287, 10753.301035432829, 10804.729881753019, 11093.1125509959, 11226.7193320166, 8225.753227403187, 8400.075991640915, 8429.747107586782, 8431.0, 8434.072252052269, 5972.223610930551, 6074.088886667036, 6160.661163636043, 6212.316645168938, 6261.686915654108, 10242.539085741011, 10301.690949271533, 10329.535170917177, 10390.116840068678, 10397.740056498647, 10011.299209055587, 10236.539355729159, 10307.536160872929, 10423.374597524173, 10563.788724225318, 7125.5368401053765, 7459.0, 7756.3019328260725, 7931.801704957192, 7954.880676789969, 8484.363672724447, 8855.114488551351, 8858.822823543622, 8864.955675221583, 8869.157430044135, 7672.769816905502, 7704.961475192588, 7866.213378662088, 7937.166597507409, 8008.519488830689, 7398.852022959403, 7549.773506794805, 7714.1128770192145, 7764.0, 8055.83888322242, 6808.727650894107, 6902.482313826584, 6911.0, 6911.274316196928, 6912.792616221522, 4931.4328852181025, 5035.798568057383, 5174.560162386239, 5242.816501422432, 5387.353517577916, 5238.738063096754, 5282.075636763628, 5299.178627312773, 5324.041672498987, 5336.866578335573], "value": 4556.136654859177, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.93859136059825, 338.62412721878724, 341.6668747970728, 342.9125572978892, 344.3594913460964, 5392.56859451244, 5398.865028374287, 5415.458454154587, 5417.6478528895595, 5443.346798384199, 5301.655392399492, 5307.469253074691, 5362.544183744377, 5399.19012148178, 5403.864903377417, 3989.2619865324937, 4075.9592404075875, 4150.8132134053885, 4188.162367526492, 4201.957980420188, 4164.895877603054, 4178.415021896937, 4192.413062171298, 4196.475440569929, 4208.705390622657, 4126.5667104954, 4128.985840336556, 4130.938035929448, 4141.979290103545, 4149.278049609424, 3925.9803700981456, 3950.288947989375, 4129.8967525811795, 4179.456670632829, 4180.26845302074, 3659.9634003660153, 3662.688671462902, 3670.100825297819, 3674.889753307405, 3679.19057807282, 5157.58739300855, 5164.535191832715, 5182.4299327073995, 5199.220116982445, 5217.938914128936, 4503.864884053451, 4704.553067458586, 4728.550787675165, 4736.52634736527, 4791.257355109963, 5522.66863988162, 5562.9443705562835, 5563.248961390242, 5578.888422231573, 5603.355614104389, 4022.8994275143064, 4023.436718859333, 4026.6577340926056, 4027.0, 4042.3734321180264, 5596.188552659842, 5771.172125658397, 5787.536997040227, 5844.766209351621, 5866.9706651466895, 4071.206114807584, 4075.694322925792, 4079.3676980068135, 4084.1831633673382, 4092.8976775580254, 4158.979205103955, 4166.437530933345, 4174.227767862894, 4177.561356057631, 4183.414321994923, 4513.796879140446, 4650.325702773079, 4743.691660042086, 4788.545088216614, 4801.159797035505, 5570.275864137636, 5577.386487486373, 5587.497125258747, 5610.214569960209, 5631.155326701028, 1419.9989007749512, 1446.5081872163514, 1447.3559266126683, 1448.2686243446992, 1449.3622805965342, 930.7952250504878, 936.489613160829, 944.5230158769915, 949.3639261694543, 999.4203362049993, 5425.593080518976, 5461.262729531462, 5461.4811592899405, 5461.863453413617, 5519.862003449865, 5679.545636349082, 5680.5171560417, 5686.886262274731, 5691.203231547586, 5699.344575373802, 5186.418142466584, 5440.755166017539, 5449.4005659377435, 5484.122540393518, 5517.36550296713, 3021.4108248891257, 3041.1788817019283, 3044.725974662291, 3056.5262384330463, 3057.8623961921767, 5715.742791574389, 5938.673372964442, 6002.849928751729, 6011.338752737195, 6024.192742177329, 5760.308762948473, 5779.479846813723, 5821.592488525763, 5829.09649004405, 5834.191400665807, 5963.0, 5977.671228082497, 5986.401359864066, 6030.336662966983, 6041.486473649701, 5653.2085508028085, 5679.148127780866, 5731.8567035824435, 5757.733298674285, 5820.883582328245, 5640.0, 5681.488666020078, 5702.372738998624, 5710.2576665033275, 5744.569157313134, 5798.5651076168615, 6022.7289771959495, 6025.969870150621, 6042.758289668364, 6042.879142417215, 4039.515258168921, 4068.5727998559723, 4084.550699423002, 4085.71400001997, 4094.181163767318, 5735.225744524436, 5752.539796816328, 5759.452851979056, 5763.51010164124, 5780.508656764054, 5364.81973965727, 5460.208269800777, 5560.5551555876245, 5567.777288908398, 5577.860553486195, 5545.779928415742, 5546.473085056913, 5548.0, 5561.777528898799, 5563.638363506359, 5329.9467005331, 5510.201020852034, 5514.5864060194845, 5550.916736249041, 5561.5272701820795, 5645.858853528531, 5667.234923285304, 5680.488756011979, 5685.573581981451, 5704.657720536781, 5460.399356070909, 5533.806316778893, 5559.24950131727, 5576.693281869374, 5584.944150558443], "value": 4276.5975402293025, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [794.7139029949221, 796.5937371940308, 799.3085980626756, 813.4793732011511, 839.4837175137291, 16001.599960001005, 17206.483805485823, 17229.0, 17232.82767172328, 17256.39602613907, 14745.115293082396, 14798.556043318691, 14899.553013409588, 14908.329125189366, 14927.253637318117, 676.0636518421984, 800.1078797141204, 814.0516298512256, 823.423603477565, 827.4786884262905, 826.0582935453588, 826.2439867521241, 828.0187977246951, 828.2338836576173, 828.3414685325181, 869.678219058949, 871.8735783311416, 873.0265753684628, 874.1215078845783, 874.2699845628875, 696.7874798186551, 825.6532256452305, 846.0989046665312, 848.825990671917, 850.698002209213, 626.6991843914901, 629.3894921925724, 629.568745409396, 630.492453574872, 630.6342321453546, 15224.619384515365, 15228.390864365412, 15243.542693719206, 15244.161571113584, 15248.23758812055, 14588.854111458855, 14662.853371466255, 14681.486147984877, 14763.77854332186, 14822.332995015251, 12025.93987030068, 12122.818157727641, 13798.103123296954, 13873.722525549534, 14017.229052402114, 4565.543445655441, 4622.0, 4641.2109941310055, 4646.697964632288, 4737.549932756418, 78519.08487905614, 78948.60525697393, 79646.60176699137, 80882.59558702228, 82102.25284230107, 11522.942385288019, 11751.823722644167, 11806.409679516162, 11858.347790871585, 12016.75966480683, 19780.60438791216, 19787.901060494605, 19796.10917508687, 19814.801851981585, 19847.30534431288, 8750.431221970679, 8863.379563430499, 8872.467651940775, 9164.495952722664, 9176.8623470648, 4726.598239149711, 4825.883743685777, 4867.9269810952865, 4970.428400733889, 4971.975140124277, 3499.33512632599, 3594.4788005739542, 3596.0470475323536, 3596.8741094061584, 3602.9191242627107, 639.3127388057857, 641.2145122225237, 642.4346575013958, 648.6011103171516, 664.8204984654213, 613.4601550635413, 664.372168300951, 689.6861927822829, 712.9073220481304, 743.8586668532961, 9867.851982220272, 10016.0, 10163.69508914719, 10215.182785377152, 10314.27800054004, 602.1690067706625, 646.2723053018152, 712.7362875736011, 728.7445356621249, 741.3587247031279, 4428.535003824616, 4696.929546056812, 4724.362211101526, 4906.656534042583, 4921.286413470027, 69017.3098269021, 69260.0, 69520.30479695239, 70683.2931670687, 84059.5797021011, 95367.04632953582, 95441.5227923856, 96513.5174324124, 96656.51671741596, 97675.51162244144, 81938.59030704689, 82487.3502529946, 83329.16670833336, 83887.5805620968, 87523.0, 9120.224780893433, 9310.95344523273, 9333.113354231336, 9490.240780737662, 9567.61729530811, 37472.555985788684, 50181.74909125577, 50962.74518627383, 51182.440877956695, 51985.48014519957, 44201.0, 66023.33976660173, 68343.0, 68852.655736723, 70166.29833701598, 13752.449902003807, 14193.432262709788, 14211.147331160164, 14351.641208969859, 14356.641083972985, 15354.846451535788, 15383.384664613737, 15722.842771572137, 15862.0, 16325.918370408071, 14253.71492570122, 14453.848253952161, 14950.626234344229, 15170.238463611784, 15604.531864044096, 14460.59259333081, 14874.77687834705, 14937.576841958062, 15176.24118794078, 15232.543023709306, 13252.536161234697, 13344.532941347006, 13437.462501500222, 14358.856755422867, 14508.927455362656, 11339.919021896014, 11910.225835320676, 11968.521259149884, 12158.289405301202, 12268.44791984345, 11625.885846812522, 11699.649010529698, 11921.403929803302, 12037.157398981988, 12219.389030548615], "value": 7623.317254136904, "unit": "score"}], "name": "dromaeo_css", "value": 7255.4020552074235, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 111.0, 111.0, 113.0, 111.0, 110.0, 110.0, 111.0, 111.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 117.0, 118.0, 174.0, 120.0, 120.0, 148.0, 120.0, 168.0, 117.0], "value": 134.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 159.0, 162.0, 161.0, 160.0, 162.0, 160.0, 161.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 73.0, 108.0, 74.0, 75.0, 75.0, 75.0, 112.0, 73.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 123.0, 84.0, 84.0, 83.0, 128.0, 83.0, 84.0, 123.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 118.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 145.0, 145.0, 155.0, 146.0, 146.0, 146.0, 145.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 52.0, 52.0, 55.0, 51.0, 51.0, 51.0, 51.0, 50.0], "value": 51.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 61.0, 61.0, 62.0, 62.0, 61.0, 62.0, 62.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 85.0, 76.0, 76.0, 76.0, 79.0, 81.0, 77.0, 76.0, 80.0], "value": 78.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 122.0, 127.0, 119.0, 119.0, 119.0, 130.0, 118.0, 158.0, 122.0], "value": 125.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 166.0, 155.0, 158.0, 153.0, 154.0, 155.0, 154.0, 160.0, 157.0], "value": 156.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 63.0, 64.0, 67.0, 63.0, 63.0, 65.0, 66.0], "value": 64.2, "unit": "score"}], "name": "kraken", "value": 1478.3, "alertThreshold": 2.0}]} 08:37:35 INFO - Return code: 0 08:37:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:37:35 INFO - # TBPL SUCCESS # 08:37:35 INFO - Running post-action listener: _resource_record_post_action 08:37:35 INFO - [mozharness: 2016-07-27 15:37:35.369985Z] Finished run-tests step (success) 08:37:35 INFO - Running post-run listener: _resource_record_post_run 08:37:35 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 552136704; Read time: 12; Write time: 618644 08:37:35 INFO - TinderboxPrint: CPU usage
13.0% 08:37:35 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 08:37:35 INFO - TinderboxPrint: I/O write bytes / time
552,136,704 / 618,644 08:37:35 INFO - TinderboxPrint: CPU idle
8,281.9 (87.0%) 08:37:35 INFO - TinderboxPrint: CPU user
1,192.3 (12.5%) 08:37:35 INFO - TinderboxPrint: Swap in / out
0 / 0 08:37:35 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 256831488; Read time: 0; Write time: 307916 08:37:35 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 295305216; Read time: 0; Write time: 310728 08:37:36 INFO - Running post-run listener: _upload_blobber_files 08:37:36 INFO - Blob upload gear active. 08:37:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:37:36 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:37:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:37:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:37:36 INFO - (blobuploader) - INFO - Open directory for files ... 08:37:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:37:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:37:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:37:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:37:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:37:37 INFO - (blobuploader) - INFO - Done attempting. 08:37:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:37:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:37:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:37:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:37:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:37:38 INFO - (blobuploader) - INFO - Done attempting. 08:37:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:37:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:37:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:37:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:37:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:37:42 INFO - (blobuploader) - INFO - Done attempting. 08:37:42 INFO - (blobuploader) - INFO - Iteration through files over. 08:37:42 INFO - Return code: 0 08:37:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:37:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:37:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/136514603ec2e42ea8cbecbd702015d878752d749da1033d9bfcf5d678fe998ce97e3402b102f1e2e7c7cc868bc9ddcf5246450c06255bc7cda7bc0d11c9bf52", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e319940599613a52e4178c4d3357d4194527169655244fbf78e6927a9d3a6470337ac46a3fd784077da7b2cd2edaf8b4b822397b066d0a565ad55c012de9bb7e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a8d3ab85c843bc8d1584f8160cbed3f4c2f9593d3c05fabe1429ec06c77fc25c5aab29b92fab33a43893f2592307cb1481a80dba232a1d880ac651a7f283eb89"} 08:37:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:37:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:37:42 INFO - Contents: 08:37:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/136514603ec2e42ea8cbecbd702015d878752d749da1033d9bfcf5d678fe998ce97e3402b102f1e2e7c7cc868bc9ddcf5246450c06255bc7cda7bc0d11c9bf52", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e319940599613a52e4178c4d3357d4194527169655244fbf78e6927a9d3a6470337ac46a3fd784077da7b2cd2edaf8b4b822397b066d0a565ad55c012de9bb7e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a8d3ab85c843bc8d1584f8160cbed3f4c2f9593d3c05fabe1429ec06c77fc25c5aab29b92fab33a43893f2592307cb1481a80dba232a1d880ac651a7f283eb89"} 08:37:42 INFO - Running post-run listener: copy_logs_to_upload_dir 08:37:42 INFO - Copying logs to upload dir... 08:37:42 INFO - mkdir: /builds/slave/test/build/upload/logs 08:37:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.902999 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-07-27 08:37:42.539625) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 08:37:42.546693) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7de08804244eb36560b44971000001c3-1469631595.896845-1471727622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/136514603ec2e42ea8cbecbd702015d878752d749da1033d9bfcf5d678fe998ce97e3402b102f1e2e7c7cc868bc9ddcf5246450c06255bc7cda7bc0d11c9bf52", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e319940599613a52e4178c4d3357d4194527169655244fbf78e6927a9d3a6470337ac46a3fd784077da7b2cd2edaf8b4b822397b066d0a565ad55c012de9bb7e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a8d3ab85c843bc8d1584f8160cbed3f4c2f9593d3c05fabe1429ec06c77fc25c5aab29b92fab33a43893f2592307cb1481a80dba232a1d880ac651a7f283eb89"} build_url:https://queue.taskcluster.net/v1/task/UpAXm9HORO2hg6hi4sbyjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011221 build_url: 'https://queue.taskcluster.net/v1/task/UpAXm9HORO2hg6hi4sbyjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/136514603ec2e42ea8cbecbd702015d878752d749da1033d9bfcf5d678fe998ce97e3402b102f1e2e7c7cc868bc9ddcf5246450c06255bc7cda7bc0d11c9bf52", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e319940599613a52e4178c4d3357d4194527169655244fbf78e6927a9d3a6470337ac46a3fd784077da7b2cd2edaf8b4b822397b066d0a565ad55c012de9bb7e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a8d3ab85c843bc8d1584f8160cbed3f4c2f9593d3c05fabe1429ec06c77fc25c5aab29b92fab33a43893f2592307cb1481a80dba232a1d880ac651a7f283eb89"}' ========= master_lag: 0.09 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 08:37:42.651368) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 08:37:42.651705) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7de08804244eb36560b44971000001c3-1469631595.896845-1471727622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.14 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 08:37:42.792118) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 08:37:42.792471) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 08:37:42.792743) ========= ========= Total master_lag: 0.33 =========