builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-048 starttime: 1470228600.36 results: success (0) buildid: 20160803030226 builduid: 288be1fd2549412fbe840120c75d2e50 revision: 6608e5864780589b25d5421c3d3673ab30c4c318 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-03 05:50:00.360092) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-03 05:50:00.360575) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-03 05:50:00.360899) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-03 05:50:00.410060) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 05:50:00.410420) ========= 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=fa44defc139c4ba8574fe040000001db-1470227305.158810-935586441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-03 05:50:00-- 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% 45.5M=0s 2016-08-03 05:50:00 (45.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.183401 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 05:50:00.636864) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 05:50:00.637141) ========= 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=fa44defc139c4ba8574fe040000001db-1470227305.158810-935586441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.081329 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 05:50:00.764505) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 05:50:00.764853) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6608e5864780589b25d5421c3d3673ab30c4c318 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 6608e5864780589b25d5421c3d3673ab30c4c318 --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=fa44defc139c4ba8574fe040000001db-1470227305.158810-935586441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-03 05:50:00,842 truncating revision to first 12 chars 2016-08-03 05:50:00,842 Setting DEBUG logging. 2016-08-03 05:50:00,842 attempt 1/10 2016-08-03 05:50:00,842 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6608e5864780?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-03 05:50:01,145 unpacking tar archive at: mozilla-central-6608e5864780/testing/mozharness/ program finished with exit code 0 elapsedTime=0.624148 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 05:50:01.401508) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-03 05:50:01.401811) ========= script_repo_revision: 6608e5864780589b25d5421c3d3673ab30c4c318 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-03 05:50:01.402263) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-03 05:50:01.402537) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-03 05:50:01.412043) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-08-03 05:50:01.412420) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=fa44defc139c4ba8574fe040000001db-1470227305.158810-935586441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:50:01 INFO - MultiFileLogger online at 20160803 05:50:01 in /builds/slave/test 05:50:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:50:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:50:01 INFO - {'append_to_log': False, 05:50:01 INFO - 'base_work_dir': '/builds/slave/test', 05:50:01 INFO - 'blob_upload_branch': 'Firefox', 05:50:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:50:01 INFO - 'branch': 'Firefox', 05:50:01 INFO - 'buildbot_json_path': 'buildprops.json', 05:50:01 INFO - 'config_files': ('talos/linux_config.py',), 05:50:01 INFO - 'default_actions': ('clobber', 05:50:01 INFO - 'read-buildbot-config', 05:50:01 INFO - 'download-and-extract', 05:50:01 INFO - 'populate-webroot', 05:50:01 INFO - 'create-virtualenv', 05:50:01 INFO - 'install', 05:50:01 INFO - 'run-tests'), 05:50:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:50:01 INFO - 'download_minidump_stackwalk': True, 05:50:01 INFO - 'download_symbols': 'ondemand', 05:50:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:50:01 INFO - 'tooltool.py': '/tools/tooltool.py', 05:50:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:50:01 INFO - '/tools/misc-python/virtualenv.py')}, 05:50:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:50:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:50:01 INFO - 'installer_path': 'installer.exe', 05:50:01 INFO - 'log_level': 'info', 05:50:01 INFO - 'log_name': 'talos', 05:50:01 INFO - 'log_to_console': True, 05:50:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:50:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:50:01 INFO - 'opt_config_files': (), 05:50:01 INFO - 'pip_index': False, 05:50:01 INFO - 'sps_profile': False, 05:50:01 INFO - 'sps_profile_interval': 0, 05:50:01 INFO - 'suite': 'dromaeojs', 05:50:01 INFO - 'system_bits': '32', 05:50:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:50:01 INFO - 'title': 'talos-linux64-ix-048', 05:50:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:50:01 INFO - 'use_talos_json': True, 05:50:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:50:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:50:01 INFO - 'work_dir': 'build'} 05:50:01 INFO - [mozharness: 2016-08-03 12:50:01.711573Z] Running clobber step. 05:50:01 INFO - Running pre-action listener: _resource_record_pre_action 05:50:01 INFO - Running main action method: clobber 05:50:01 INFO - rmtree: /builds/slave/test/build 05:50:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:50:02 INFO - Running post-action listener: _resource_record_post_action 05:50:02 INFO - [mozharness: 2016-08-03 12:50:02.735565Z] Finished clobber step (success) 05:50:02 INFO - [mozharness: 2016-08-03 12:50:02.735743Z] Running read-buildbot-config step. 05:50:02 INFO - Running pre-action listener: _resource_record_pre_action 05:50:02 INFO - Running main action method: read_buildbot_config 05:50:02 INFO - Using buildbot properties: 05:50:02 INFO - { 05:50:02 INFO - "project": "", 05:50:02 INFO - "product": "firefox", 05:50:02 INFO - "script_repo_revision": "production", 05:50:02 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:50:02 INFO - "repository": "", 05:50:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:50:02 INFO - "buildid": "20160803030226", 05:50:02 INFO - "stage_platform": "linux64-pgo", 05:50:02 INFO - "basedir": "/builds/slave/test", 05:50:02 INFO - "nightly_build": "True", 05:50:02 INFO - "buildnumber": 412, 05:50:02 INFO - "slavename": "talos-linux64-ix-048", 05:50:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:50:02 INFO - "platform": "ubuntu64_hw", 05:50:02 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:50:02 INFO - "branch": "mozilla-central", 05:50:02 INFO - "repo_path": "mozilla-central", 05:50:02 INFO - "revision": "6608e5864780589b25d5421c3d3673ab30c4c318", 05:50:02 INFO - "pgo_build": "True", 05:50:02 INFO - "builduid": "288be1fd2549412fbe840120c75d2e50", 05:50:02 INFO - "slavebuilddir": "test" 05:50:02 INFO - } 05:50:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/DnRNppcuSFqs8f3Yb-tdog/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 05:50:02 INFO - Running post-action listener: _resource_record_post_action 05:50:02 INFO - [mozharness: 2016-08-03 12:50:02.740422Z] Finished read-buildbot-config step (success) 05:50:02 INFO - [mozharness: 2016-08-03 12:50:02.740585Z] Running download-and-extract step. 05:50:02 INFO - Running pre-action listener: _resource_record_pre_action 05:50:02 INFO - Running main action method: download_and_extract 05:50:02 INFO - mkdir: /builds/slave/test/build/tests 05:50: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')]} 05:50:02 INFO - https://queue.taskcluster.net/v1/task/DnRNppcuSFqs8f3Yb-tdog/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:50:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DnRNppcuSFqs8f3Yb-tdog/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:50:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DnRNppcuSFqs8f3Yb-tdog/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:50:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DnRNppcuSFqs8f3Yb-tdog/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:50:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DnRNppcuSFqs8f3Yb-tdog/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:50:08 INFO - Downloaded 1361 bytes. 05:50:08 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:50:08 INFO - Using the following test package requirements: 05:50:08 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:50:08 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:08 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:50:08 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:08 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:50:08 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:08 INFO - u'jsshell-linux-x86_64.zip'], 05:50:08 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:08 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:50:08 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:50:08 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:08 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:50:08 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:08 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:50:08 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:08 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:50:08 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:08 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:50:08 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:50:08 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')]} 05:50:08 INFO - https://queue.taskcluster.net/v1/task/DnRNppcuSFqs8f3Yb-tdog/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:50:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DnRNppcuSFqs8f3Yb-tdog/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:50:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DnRNppcuSFqs8f3Yb-tdog/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:50:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DnRNppcuSFqs8f3Yb-tdog/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:50:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DnRNppcuSFqs8f3Yb-tdog/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:50:14 INFO - Downloaded 21810503 bytes. 05:50:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:50:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:50:16 INFO - Return code: 0 05:50:16 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:50: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')]} 05:50:16 INFO - https://queue.taskcluster.net/v1/task/DnRNppcuSFqs8f3Yb-tdog/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:50:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DnRNppcuSFqs8f3Yb-tdog/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:50:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DnRNppcuSFqs8f3Yb-tdog/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:50:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DnRNppcuSFqs8f3Yb-tdog/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:50:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DnRNppcuSFqs8f3Yb-tdog/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:50:17 INFO - Downloaded 21810503 bytes. 05:50:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:50:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:50:18 INFO - Return code: 0 05:50: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')]} 05:50:18 INFO - https://queue.taskcluster.net/v1/task/DnRNppcuSFqs8f3Yb-tdog/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:50:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DnRNppcuSFqs8f3Yb-tdog/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:50:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DnRNppcuSFqs8f3Yb-tdog/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:50:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DnRNppcuSFqs8f3Yb-tdog/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:50:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DnRNppcuSFqs8f3Yb-tdog/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:50:19 INFO - Downloaded 14413723 bytes. 05:50:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:50:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:50:19 INFO - Return code: 0 05:50:19 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')]} 05:50:19 INFO - https://queue.taskcluster.net/v1/task/DnRNppcuSFqs8f3Yb-tdog/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:50:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DnRNppcuSFqs8f3Yb-tdog/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:50:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DnRNppcuSFqs8f3Yb-tdog/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:50:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DnRNppcuSFqs8f3Yb-tdog/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:50:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DnRNppcuSFqs8f3Yb-tdog/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:50:21 INFO - Downloaded 59389314 bytes. 05:50:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DnRNppcuSFqs8f3Yb-tdog/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:50:21 INFO - mkdir: /builds/slave/test/properties 05:50:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:50:21 INFO - Writing to file /builds/slave/test/properties/build_url 05:50:21 INFO - Contents: 05:50:21 INFO - build_url:https://queue.taskcluster.net/v1/task/DnRNppcuSFqs8f3Yb-tdog/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:50:21 INFO - Running post-action listener: _resource_record_post_action 05:50:21 INFO - Running post-action listener: set_extra_try_arguments 05:50:21 INFO - [mozharness: 2016-08-03 12:50:21.887935Z] Finished download-and-extract step (success) 05:50:21 INFO - [mozharness: 2016-08-03 12:50:21.888170Z] Running populate-webroot step. 05:50:21 INFO - Running pre-action listener: _resource_record_pre_action 05:50:21 INFO - Running main action method: populate_webroot 05:50:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:50:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:50:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:50:21 INFO - '--tppagecycles', 05:50:21 INFO - '7'], 05:50:21 INFO - 'tests': ['tsvgm']}}, 05:50:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:50:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:50:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:50:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:50:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:50:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:50:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:21 INFO - 'talos_options': ['--disable-e10s'], 05:50:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:50:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:50:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:21 INFO - 'talos_options': ['--disable-e10s'], 05:50:21 INFO - 'tests': ['damp', 'tps']}, 05:50:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:21 INFO - 'tests': ['damp', 'tps']}, 05:50:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:50:21 INFO - 'tests': ['dromaeo_dom']}, 05:50:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:50:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:50:21 INFO - 'tests': ['basic_compositor_video']}, 05:50:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:50:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:50:21 INFO - 'tests': ['a11yr', 05:50:21 INFO - 'ts_paint', 05:50:21 INFO - 'tpaint', 05:50:21 INFO - 'sessionrestore', 05:50:21 INFO - 'sessionrestore_no_auto_restore', 05:50:21 INFO - 'tabpaint']}, 05:50:21 INFO - 'other-e10s': {'tests': ['a11yr', 05:50:21 INFO - 'ts_paint', 05:50:21 INFO - 'tpaint', 05:50:21 INFO - 'sessionrestore', 05:50:21 INFO - 'sessionrestore_no_auto_restore', 05:50:21 INFO - 'tabpaint']}, 05:50:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:50:21 INFO - 'ts_paint', 05:50:21 INFO - 'tpaint', 05:50:21 INFO - 'sessionrestore', 05:50:21 INFO - 'sessionrestore_no_auto_restore', 05:50:21 INFO - 'tabpaint']}, 05:50:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:50:21 INFO - 'ts_paint', 05:50:21 INFO - 'tpaint', 05:50:21 INFO - 'sessionrestore', 05:50:21 INFO - 'sessionrestore_no_auto_restore', 05:50:21 INFO - 'tabpaint']}, 05:50:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:50:21 INFO - 'tests': ['a11yr', 05:50:21 INFO - 'ts_paint', 05:50:21 INFO - 'tpaint', 05:50:21 INFO - 'sessionrestore', 05:50:21 INFO - 'sessionrestore_no_auto_restore', 05:50:21 INFO - 'tabpaint']}, 05:50:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:50:21 INFO - 'tests': ['a11yr', 05:50:21 INFO - 'ts_paint', 05:50:21 INFO - 'tpaint', 05:50:21 INFO - 'sessionrestore', 05:50:21 INFO - 'sessionrestore_no_auto_restore', 05:50:21 INFO - 'tabpaint']}, 05:50:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:50:21 INFO - 'tests': ['tsvgx', 05:50:21 INFO - 'tsvgr_opacity', 05:50:21 INFO - 'tart', 05:50:21 INFO - 'tscrollx', 05:50:21 INFO - 'cart']}, 05:50:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:50:21 INFO - 'tsvgr_opacity', 05:50:21 INFO - 'tart', 05:50:21 INFO - 'tscrollx', 05:50:21 INFO - 'cart']}, 05:50:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:21 INFO - 'talos_options': ['--disable-e10s'], 05:50:21 INFO - 'tests': ['tp5o']}, 05:50:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:21 INFO - 'tests': ['tp5o']}, 05:50:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:21 INFO - 'talos_options': ['--disable-e10s', 05:50:21 INFO - '--xperf_path', 05:50:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:50:21 INFO - 'tests': ['tp5n']}, 05:50:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:21 INFO - 'talos_options': ['--xperf_path', 05:50:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:50:21 INFO - 'tests': ['tp5n']}}, 05:50:21 INFO - 'talos.zip': {'path': '', 05:50:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:50:21 INFO - Running post-action listener: _resource_record_post_action 05:50:21 INFO - [mozharness: 2016-08-03 12:50:21.905579Z] Finished populate-webroot step (success) 05:50:21 INFO - [mozharness: 2016-08-03 12:50:21.905667Z] Running create-virtualenv step. 05:50:21 INFO - Running pre-action listener: _resource_record_pre_action 05:50:21 INFO - Running main action method: create_virtualenv 05:50:21 INFO - Creating virtualenv /builds/slave/test/build/venv 05:50:21 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 05:50:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:50:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:50:22 INFO - Using real prefix '/usr' 05:50:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:50:23 INFO - Installing distribute.............................................................................................................................................................................................done. 05:50:25 INFO - Installing pip.................done. 05:50:25 INFO - Return code: 0 05:50:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:50: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')]} 05:50:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50: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')]} 05:50:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbe180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dbc3b0>, '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 0x1dbd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbd740>, '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': 'fa44defc139c4ba8574fe040000001db-1470227305.158810-935586441', '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 05:50: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', 'pip>=1.5'] in /builds/slave/test/build 05:50: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 pip>=1.5 05:50:25 INFO - Using env: {'DISPLAY': ':0', 05:50:25 INFO - 'HOME': '/home/cltbld', 05:50:25 INFO - 'LANG': 'en_US.UTF-8', 05:50:25 INFO - 'LANGUAGE': 'en_US:en', 05:50:25 INFO - 'LOGNAME': 'cltbld', 05:50:25 INFO - 'MAIL': '/var/mail/cltbld', 05:50:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:25 INFO - 'MOZ_NO_REMOTE': '1', 05:50:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:25 INFO - 'NO_EM_RESTART': '1', 05:50:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:25 INFO - 'PWD': '/builds/slave/test', 05:50:25 INFO - 'SHELL': '/bin/bash', 05:50:25 INFO - 'SHLVL': '1', 05:50:25 INFO - 'TERM': 'linux', 05:50:25 INFO - 'TMOUT': '86400', 05:50:25 INFO - 'USER': 'cltbld', 05:50:25 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1470227305.158810-935586441', 05:50:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:25 INFO - '_': '/tools/buildbot/bin/python'} 05:50:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:25 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 05:50:25 INFO - Cleaning up... 05:50:25 INFO - Return code: 0 05:50:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:50: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')]} 05:50:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50: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')]} 05:50:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50: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', '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 0x1afd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbe180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dbc3b0>, '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 0x1dbd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbd740>, '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': 'fa44defc139c4ba8574fe040000001db-1470227305.158810-935586441', '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 05:50: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', 'psutil>=3.1.1'] in /builds/slave/test/build 05:50: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 psutil>=3.1.1 05:50:25 INFO - Using env: {'DISPLAY': ':0', 05:50:25 INFO - 'HOME': '/home/cltbld', 05:50:25 INFO - 'LANG': 'en_US.UTF-8', 05:50:25 INFO - 'LANGUAGE': 'en_US:en', 05:50:25 INFO - 'LOGNAME': 'cltbld', 05:50:25 INFO - 'MAIL': '/var/mail/cltbld', 05:50:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:25 INFO - 'MOZ_NO_REMOTE': '1', 05:50:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:25 INFO - 'NO_EM_RESTART': '1', 05:50:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:25 INFO - 'PWD': '/builds/slave/test', 05:50:25 INFO - 'SHELL': '/bin/bash', 05:50:25 INFO - 'SHLVL': '1', 05:50:25 INFO - 'TERM': 'linux', 05:50:25 INFO - 'TMOUT': '86400', 05:50:25 INFO - 'USER': 'cltbld', 05:50:25 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1470227305.158810-935586441', 05:50:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:25 INFO - '_': '/tools/buildbot/bin/python'} 05:50:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:25 INFO - Downloading/unpacking psutil>=3.1.1 05:50: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 05:50: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 05:50: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 05:50: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 05:50: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 05:50: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 05:50:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:50:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:50:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:50:28 INFO - Installing collected packages: psutil 05:50:28 INFO - Running setup.py install for psutil 05:50:28 INFO - building 'psutil._psutil_linux' extension 05:50:28 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 05:50:29 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 05:50:29 INFO - building 'psutil._psutil_posix' extension 05:50:29 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 05:50:29 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 05:50:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:50:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:50:29 INFO - Successfully installed psutil 05:50:29 INFO - Cleaning up... 05:50:29 INFO - Return code: 0 05:50:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:50:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1afd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbe180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dbc3b0>, '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 0x1dbd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbd740>, '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': 'fa44defc139c4ba8574fe040000001db-1470227305.158810-935586441', '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 05:50:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:50:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:50:29 INFO - Using env: {'DISPLAY': ':0', 05:50:29 INFO - 'HOME': '/home/cltbld', 05:50:29 INFO - 'LANG': 'en_US.UTF-8', 05:50:29 INFO - 'LANGUAGE': 'en_US:en', 05:50:29 INFO - 'LOGNAME': 'cltbld', 05:50:29 INFO - 'MAIL': '/var/mail/cltbld', 05:50:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:29 INFO - 'MOZ_NO_REMOTE': '1', 05:50:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:29 INFO - 'NO_EM_RESTART': '1', 05:50:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:29 INFO - 'PWD': '/builds/slave/test', 05:50:29 INFO - 'SHELL': '/bin/bash', 05:50:29 INFO - 'SHLVL': '1', 05:50:29 INFO - 'TERM': 'linux', 05:50:29 INFO - 'TMOUT': '86400', 05:50:29 INFO - 'USER': 'cltbld', 05:50:29 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1470227305.158810-935586441', 05:50:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:29 INFO - '_': '/tools/buildbot/bin/python'} 05:50:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:50:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:50:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:50:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:50:31 INFO - Installing collected packages: mozsystemmonitor 05:50:31 INFO - Running setup.py install for mozsystemmonitor 05:50:31 INFO - Successfully installed mozsystemmonitor 05:50:31 INFO - Cleaning up... 05:50:31 INFO - Return code: 0 05:50:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:50:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1afd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbe180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dbc3b0>, '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 0x1dbd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbd740>, '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': 'fa44defc139c4ba8574fe040000001db-1470227305.158810-935586441', '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 05:50:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:50:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:50:31 INFO - Using env: {'DISPLAY': ':0', 05:50:31 INFO - 'HOME': '/home/cltbld', 05:50:31 INFO - 'LANG': 'en_US.UTF-8', 05:50:31 INFO - 'LANGUAGE': 'en_US:en', 05:50:31 INFO - 'LOGNAME': 'cltbld', 05:50:31 INFO - 'MAIL': '/var/mail/cltbld', 05:50:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:31 INFO - 'MOZ_NO_REMOTE': '1', 05:50:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:31 INFO - 'NO_EM_RESTART': '1', 05:50:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:31 INFO - 'PWD': '/builds/slave/test', 05:50:31 INFO - 'SHELL': '/bin/bash', 05:50:31 INFO - 'SHLVL': '1', 05:50:31 INFO - 'TERM': 'linux', 05:50:31 INFO - 'TMOUT': '86400', 05:50:31 INFO - 'USER': 'cltbld', 05:50:31 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1470227305.158810-935586441', 05:50:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:31 INFO - '_': '/tools/buildbot/bin/python'} 05:50:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:32 INFO - Downloading/unpacking jsonschema==2.5.1 05:50: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 05:50: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 05:50: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 05:50: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 05:50: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 05:50: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 05:50:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:50:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:50:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:34 INFO - Downloading functools32-3.2.3-2.tar.gz 05:50:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:50:34 INFO - warning: no files found matching '*.txt' 05:50:34 INFO - no previously-included directories found matching 'build' 05:50:34 INFO - no previously-included directories found matching 'dist' 05:50:34 INFO - no previously-included directories found matching '.git*' 05:50:34 INFO - Installing collected packages: jsonschema, functools32 05:50:34 INFO - Running setup.py install for functools32 05:50:34 INFO - warning: no files found matching '*.txt' 05:50:34 INFO - no previously-included directories found matching 'build' 05:50:34 INFO - no previously-included directories found matching 'dist' 05:50:34 INFO - no previously-included directories found matching '.git*' 05:50:34 INFO - Successfully installed jsonschema functools32 05:50:34 INFO - Cleaning up... 05:50:34 INFO - Return code: 0 05:50:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:50: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')]} 05:50:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50: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')]} 05:50:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:34 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 0x1afd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbe180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dbc3b0>, '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 0x1dbd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbd740>, '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': 'fa44defc139c4ba8574fe040000001db-1470227305.158810-935586441', '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 05:50:34 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 05:50:34 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 05:50:34 INFO - Using env: {'DISPLAY': ':0', 05:50:34 INFO - 'HOME': '/home/cltbld', 05:50:34 INFO - 'LANG': 'en_US.UTF-8', 05:50:34 INFO - 'LANGUAGE': 'en_US:en', 05:50:34 INFO - 'LOGNAME': 'cltbld', 05:50:34 INFO - 'MAIL': '/var/mail/cltbld', 05:50:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:34 INFO - 'MOZ_NO_REMOTE': '1', 05:50:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:34 INFO - 'NO_EM_RESTART': '1', 05:50:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:34 INFO - 'PWD': '/builds/slave/test', 05:50:34 INFO - 'SHELL': '/bin/bash', 05:50:34 INFO - 'SHLVL': '1', 05:50:34 INFO - 'TERM': 'linux', 05:50:34 INFO - 'TMOUT': '86400', 05:50:34 INFO - 'USER': 'cltbld', 05:50:34 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1470227305.158810-935586441', 05:50:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:34 INFO - '_': '/tools/buildbot/bin/python'} 05:50:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:50:35 INFO - Cleaning up... 05:50:35 INFO - Return code: 0 05:50:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:50:35 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')]} 05:50:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:35 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')]} 05:50:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:35 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 0x1afd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbe180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dbc3b0>, '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 0x1dbd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbd740>, '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': 'fa44defc139c4ba8574fe040000001db-1470227305.158810-935586441', '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 05:50:35 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 05:50:35 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 05:50:35 INFO - Using env: {'DISPLAY': ':0', 05:50:35 INFO - 'HOME': '/home/cltbld', 05:50:35 INFO - 'LANG': 'en_US.UTF-8', 05:50:35 INFO - 'LANGUAGE': 'en_US:en', 05:50:35 INFO - 'LOGNAME': 'cltbld', 05:50:35 INFO - 'MAIL': '/var/mail/cltbld', 05:50:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:35 INFO - 'MOZ_NO_REMOTE': '1', 05:50:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:35 INFO - 'NO_EM_RESTART': '1', 05:50:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:35 INFO - 'PWD': '/builds/slave/test', 05:50:35 INFO - 'SHELL': '/bin/bash', 05:50:35 INFO - 'SHLVL': '1', 05:50:35 INFO - 'TERM': 'linux', 05:50:35 INFO - 'TMOUT': '86400', 05:50:35 INFO - 'USER': 'cltbld', 05:50:35 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1470227305.158810-935586441', 05:50:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:35 INFO - '_': '/tools/buildbot/bin/python'} 05:50:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:35 INFO - Downloading/unpacking blobuploader==1.2.4 05:50:35 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 05:50:35 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 05:50:35 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 05:50:35 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 05:50:35 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 05:50:35 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 05:50:37 INFO - Downloading blobuploader-1.2.4.tar.gz 05:50:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:50:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:50:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:50:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:50:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:37 INFO - Downloading docopt-0.6.1.tar.gz 05:50:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:50:37 INFO - Installing collected packages: blobuploader, requests, docopt 05:50:37 INFO - Running setup.py install for blobuploader 05:50:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:50:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:50:37 INFO - Running setup.py install for requests 05:50:38 INFO - Running setup.py install for docopt 05:50:38 INFO - Successfully installed blobuploader requests docopt 05:50:38 INFO - Cleaning up... 05:50:38 INFO - Return code: 0 05:50:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:50:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:38 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 0x1afd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbe180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dbc3b0>, '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 0x1dbd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbd740>, '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': 'fa44defc139c4ba8574fe040000001db-1470227305.158810-935586441', '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 05:50:38 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 05:50:38 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 05:50:38 INFO - Using env: {'DISPLAY': ':0', 05:50:38 INFO - 'HOME': '/home/cltbld', 05:50:38 INFO - 'LANG': 'en_US.UTF-8', 05:50:38 INFO - 'LANGUAGE': 'en_US:en', 05:50:38 INFO - 'LOGNAME': 'cltbld', 05:50:38 INFO - 'MAIL': '/var/mail/cltbld', 05:50:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:38 INFO - 'MOZ_NO_REMOTE': '1', 05:50:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:38 INFO - 'NO_EM_RESTART': '1', 05:50:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:38 INFO - 'PWD': '/builds/slave/test', 05:50:38 INFO - 'SHELL': '/bin/bash', 05:50:38 INFO - 'SHLVL': '1', 05:50:38 INFO - 'TERM': 'linux', 05:50:38 INFO - 'TMOUT': '86400', 05:50:38 INFO - 'USER': 'cltbld', 05:50:38 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1470227305.158810-935586441', 05:50:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:38 INFO - '_': '/tools/buildbot/bin/python'} 05:50:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:50:38 INFO - Running setup.py (path:/tmp/pip-PRlpAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:50:38 INFO - Running setup.py (path:/tmp/pip-TnD4vO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:50:38 INFO - Running setup.py (path:/tmp/pip-atYEoc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:50:38 INFO - Running setup.py (path:/tmp/pip-9NU34X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:50:38 INFO - Running setup.py (path:/tmp/pip-4jIuEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:50:39 INFO - Running setup.py (path:/tmp/pip-WZrh0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:50:39 INFO - Running setup.py (path:/tmp/pip-JH7Bo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:50:39 INFO - Running setup.py (path:/tmp/pip-9kfS64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:50:39 INFO - Running setup.py (path:/tmp/pip-qXH3di-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:50:39 INFO - Running setup.py (path:/tmp/pip-aY5u6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:50:39 INFO - Running setup.py (path:/tmp/pip-lMhFdr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:50:39 INFO - Running setup.py (path:/tmp/pip-hx47I3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:50:39 INFO - Running setup.py (path:/tmp/pip-6q5ysR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:50:39 INFO - Running setup.py (path:/tmp/pip-FvEsSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:50:39 INFO - Running setup.py (path:/tmp/pip-jmrW3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:50:39 INFO - Running setup.py (path:/tmp/pip-LS2Qvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:50:39 INFO - Running setup.py (path:/tmp/pip-zya4TR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:50:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:50:39 INFO - Running setup.py install for manifestparser 05:50:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:50:40 INFO - Running setup.py install for mozcrash 05:50:40 INFO - Running setup.py install for mozdebug 05:50:40 INFO - Running setup.py install for mozdevice 05:50:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:50:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:50:40 INFO - Running setup.py install for mozfile 05:50:40 INFO - Running setup.py install for mozhttpd 05:50:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:50:40 INFO - Running setup.py install for mozinfo 05:50:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:50:40 INFO - Running setup.py install for mozInstall 05:50:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:50:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:50:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:50:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:50:40 INFO - Running setup.py install for mozleak 05:50:40 INFO - Running setup.py install for mozlog 05:50:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:50:40 INFO - Running setup.py install for moznetwork 05:50:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:50:41 INFO - Running setup.py install for mozprocess 05:50:41 INFO - Running setup.py install for mozprofile 05:50:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:50:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:50:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:50:41 INFO - Running setup.py install for mozrunner 05:50:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:50:41 INFO - Running setup.py install for mozscreenshot 05:50:41 INFO - Running setup.py install for moztest 05:50:41 INFO - Running setup.py install for mozversion 05:50:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:50:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:50:41 INFO - Cleaning up... 05:50:41 INFO - Return code: 0 05:50:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:50: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')]} 05:50:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50: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')]} 05:50:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:41 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 0x1afd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbe180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dbc3b0>, '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 0x1dbd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbd740>, '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': 'fa44defc139c4ba8574fe040000001db-1470227305.158810-935586441', '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 05:50:41 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 05:50:41 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 05:50:41 INFO - Using env: {'DISPLAY': ':0', 05:50:41 INFO - 'HOME': '/home/cltbld', 05:50:41 INFO - 'LANG': 'en_US.UTF-8', 05:50:41 INFO - 'LANGUAGE': 'en_US:en', 05:50:41 INFO - 'LOGNAME': 'cltbld', 05:50:41 INFO - 'MAIL': '/var/mail/cltbld', 05:50:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:41 INFO - 'MOZ_NO_REMOTE': '1', 05:50:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:41 INFO - 'NO_EM_RESTART': '1', 05:50:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:41 INFO - 'PWD': '/builds/slave/test', 05:50:41 INFO - 'SHELL': '/bin/bash', 05:50:41 INFO - 'SHLVL': '1', 05:50:41 INFO - 'TERM': 'linux', 05:50:41 INFO - 'TMOUT': '86400', 05:50:41 INFO - 'USER': 'cltbld', 05:50:41 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1470227305.158810-935586441', 05:50:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:41 INFO - '_': '/tools/buildbot/bin/python'} 05:50:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:50:41 INFO - Running setup.py (path:/tmp/pip-2dBrSU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:50:41 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)) 05:50:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:50:41 INFO - Running setup.py (path:/tmp/pip-kM6EbV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:50:42 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)) 05:50:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:50:42 INFO - Running setup.py (path:/tmp/pip-OJknka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:50:42 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)) 05:50:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:50:42 INFO - Running setup.py (path:/tmp/pip-iYWrzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:50:42 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)) 05:50:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:50:42 INFO - Running setup.py (path:/tmp/pip-IvLpD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:50:42 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)) 05:50:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:50:42 INFO - Running setup.py (path:/tmp/pip-diu4bZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:50:42 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)) 05:50:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:50:42 INFO - Running setup.py (path:/tmp/pip-iJRGG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:50:42 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)) 05:50:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:50:42 INFO - Running setup.py (path:/tmp/pip-UckJHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:50:42 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)) 05:50:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:50:42 INFO - Running setup.py (path:/tmp/pip-yYBi19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:50:42 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)) 05:50:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:50:42 INFO - Running setup.py (path:/tmp/pip-Jlso4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:50:42 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)) 05:50:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:50:42 INFO - Running setup.py (path:/tmp/pip-sYvG5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:50:42 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)) 05:50:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:50:42 INFO - Running setup.py (path:/tmp/pip-APGLBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:50:42 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)) 05:50:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:50:42 INFO - Running setup.py (path:/tmp/pip-bdJmEr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:50:42 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)) 05:50:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:50:42 INFO - Running setup.py (path:/tmp/pip-5wvEbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:50:42 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)) 05:50:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:50:42 INFO - Running setup.py (path:/tmp/pip-AzCuwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:50:42 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)) 05:50:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:50:43 INFO - Running setup.py (path:/tmp/pip-bID8Et-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:50:43 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)) 05:50:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:50:43 INFO - Running setup.py (path:/tmp/pip-0HPAfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:50:43 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)) 05:50:43 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)) 05:50:43 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)) 05:50:43 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)) 05:50:43 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)) 05:50:43 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)) 05:50:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:50:43 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 05:50:43 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 05:50:43 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 05:50:43 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 05:50:43 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 05:50:43 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 05:50:45 INFO - Downloading blessings-1.6.tar.gz 05:50:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:50:45 INFO - Installing collected packages: blessings 05:50:45 INFO - Running setup.py install for blessings 05:50:45 INFO - Successfully installed blessings 05:50:45 INFO - Cleaning up... 05:50:45 INFO - Return code: 0 05:50:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:50:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:50:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:50:45 INFO - Reading from file tmpfile_stdout 05:50:45 INFO - Current package versions: 05:50:45 INFO - argparse == 1.2.1 05:50:45 INFO - blessings == 1.6 05:50:45 INFO - blobuploader == 1.2.4 05:50:45 INFO - docopt == 0.6.1 05:50:45 INFO - functools32 == 3.2.3-2 05:50:45 INFO - jsonschema == 2.5.1 05:50:45 INFO - manifestparser == 1.1 05:50:45 INFO - mozInstall == 1.12 05:50:45 INFO - mozcrash == 0.17 05:50:45 INFO - mozdebug == 0.1 05:50:45 INFO - mozdevice == 0.48 05:50:45 INFO - mozfile == 1.2 05:50:45 INFO - mozhttpd == 0.7 05:50:45 INFO - mozinfo == 0.9 05:50:45 INFO - mozleak == 0.1 05:50:45 INFO - mozlog == 3.3 05:50:45 INFO - moznetwork == 0.27 05:50:45 INFO - mozprocess == 0.23 05:50:45 INFO - mozprofile == 0.28 05:50:45 INFO - mozrunner == 6.12 05:50:45 INFO - mozscreenshot == 0.1 05:50:45 INFO - mozsystemmonitor == 0.3 05:50:45 INFO - moztest == 0.7 05:50:45 INFO - mozversion == 1.4 05:50:45 INFO - psutil == 3.1.1 05:50:45 INFO - requests == 1.2.3 05:50:45 INFO - wsgiref == 0.1.2 05:50:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:50:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:45 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 0x1afd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbe180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dbc3b0>, '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 0x1dbd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbd740>, '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': 'fa44defc139c4ba8574fe040000001db-1470227305.158810-935586441', '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 05:50:45 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 05:50:45 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 05:50:45 INFO - Using env: {'DISPLAY': ':0', 05:50:45 INFO - 'HOME': '/home/cltbld', 05:50:45 INFO - 'LANG': 'en_US.UTF-8', 05:50:45 INFO - 'LANGUAGE': 'en_US:en', 05:50:45 INFO - 'LOGNAME': 'cltbld', 05:50:45 INFO - 'MAIL': '/var/mail/cltbld', 05:50:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:45 INFO - 'MOZ_NO_REMOTE': '1', 05:50:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:45 INFO - 'NO_EM_RESTART': '1', 05:50:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:45 INFO - 'PWD': '/builds/slave/test', 05:50:45 INFO - 'SHELL': '/bin/bash', 05:50:45 INFO - 'SHLVL': '1', 05:50:45 INFO - 'TERM': 'linux', 05:50:45 INFO - 'TMOUT': '86400', 05:50:45 INFO - 'USER': 'cltbld', 05:50:45 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1470227305.158810-935586441', 05:50:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:45 INFO - '_': '/tools/buildbot/bin/python'} 05:50:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:45 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)) 05:50:45 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)) 05:50:45 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)) 05:50:45 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)) 05:50:45 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)) 05:50:45 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)) 05:50:45 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)) 05:50:45 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)) 05:50:45 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)) 05:50:45 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)) 05:50:45 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)) 05:50:45 INFO - Cleaning up... 05:50:45 INFO - Return code: 0 05:50:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:50:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:45 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 0x1afd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbe180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dbc3b0>, '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 0x1dbd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbd740>, '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': 'fa44defc139c4ba8574fe040000001db-1470227305.158810-935586441', '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 05:50:45 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 05:50:45 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 05:50:45 INFO - Using env: {'DISPLAY': ':0', 05:50:45 INFO - 'HOME': '/home/cltbld', 05:50:45 INFO - 'LANG': 'en_US.UTF-8', 05:50:45 INFO - 'LANGUAGE': 'en_US:en', 05:50:45 INFO - 'LOGNAME': 'cltbld', 05:50:45 INFO - 'MAIL': '/var/mail/cltbld', 05:50:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:45 INFO - 'MOZ_NO_REMOTE': '1', 05:50:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:45 INFO - 'NO_EM_RESTART': '1', 05:50:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:45 INFO - 'PWD': '/builds/slave/test', 05:50:45 INFO - 'SHELL': '/bin/bash', 05:50:45 INFO - 'SHLVL': '1', 05:50:45 INFO - 'TERM': 'linux', 05:50:45 INFO - 'TMOUT': '86400', 05:50:45 INFO - 'USER': 'cltbld', 05:50:45 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1470227305.158810-935586441', 05:50:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:45 INFO - '_': '/tools/buildbot/bin/python'} 05:50:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:50:45 INFO - Cleaning up... 05:50:45 INFO - Return code: 0 05:50:45 INFO - Running post-action listener: _resource_record_post_action 05:50:45 INFO - Running post-action listener: _start_resource_monitoring 05:50:45 INFO - Starting resource monitoring. 05:50:45 INFO - [mozharness: 2016-08-03 12:50:45.992911Z] Finished create-virtualenv step (success) 05:50:45 INFO - [mozharness: 2016-08-03 12:50:45.993861Z] Running install step. 05:50:45 INFO - Running pre-action listener: _resource_record_pre_action 05:50:45 INFO - Running main action method: install 05:50:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:50:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:50:46 INFO - Reading from file tmpfile_stdout 05:50:46 INFO - Detecting whether we're running mozinstall >=1.0... 05:50:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:50:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:50:46 INFO - Reading from file tmpfile_stdout 05:50:46 INFO - Output received: 05:50:46 INFO - Usage: mozinstall [options] installer 05:50:46 INFO - Options: 05:50:46 INFO - -h, --help show this help message and exit 05:50:46 INFO - -d DEST, --destination=DEST 05:50:46 INFO - Directory to install application into. [default: 05:50:46 INFO - "/builds/slave/test"] 05:50:46 INFO - --app=APP Application being installed. [default: firefox] 05:50:46 INFO - mkdir: /builds/slave/test/build/application 05:50:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:50:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:51:03 INFO - Reading from file tmpfile_stdout 05:51:03 INFO - Output received: 05:51:03 INFO - /builds/slave/test/build/application/firefox/firefox 05:51:03 INFO - Running post-action listener: _resource_record_post_action 05:51:03 INFO - [mozharness: 2016-08-03 12:51:03.253778Z] Finished install step (success) 05:51:03 INFO - [mozharness: 2016-08-03 12:51:03.254057Z] Running run-tests step. 05:51:03 INFO - Running pre-action listener: _resource_record_pre_action 05:51:03 INFO - Running main action method: run_tests 05:51:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:51:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:51:03 INFO - Python 2.7.3 05:51:03 INFO - Return code: 0 05:51:03 INFO - grabbing minidump binary from tooltool 05:51:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:03 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 0x1dbc3b0>, '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 0x1dbd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbd740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:51:03 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 05:51:03 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 05:51:03 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 05:51:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:51:03 INFO - Return code: 0 05:51:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:51:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:51:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:51:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:51:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:51:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DnRNppcuSFqs8f3Yb-tdog/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 05:51:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DnRNppcuSFqs8f3Yb-tdog/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --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 05:51:03 INFO - Using env: {'DISPLAY': ':0', 05:51:03 INFO - 'HOME': '/home/cltbld', 05:51:03 INFO - 'LANG': 'en_US.UTF-8', 05:51:03 INFO - 'LANGUAGE': 'en_US:en', 05:51:03 INFO - 'LOGNAME': 'cltbld', 05:51:03 INFO - 'MAIL': '/var/mail/cltbld', 05:51:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:51:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:51:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:03 INFO - 'MOZ_NO_REMOTE': '1', 05:51:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:51:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:03 INFO - 'NO_EM_RESTART': '1', 05:51:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:03 INFO - 'PWD': '/builds/slave/test', 05:51:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:51:03 INFO - 'SHELL': '/bin/bash', 05:51:03 INFO - 'SHLVL': '1', 05:51:03 INFO - 'TERM': 'linux', 05:51:03 INFO - 'TMOUT': '86400', 05:51:03 INFO - 'USER': 'cltbld', 05:51:03 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1470227305.158810-935586441', 05:51:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:03 INFO - '_': '/tools/buildbot/bin/python'} 05:51:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DnRNppcuSFqs8f3Yb-tdog/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 05:51:03 INFO - mozversion application_buildid: 20160803030226 05:51:03 INFO - mozversion application_changeset: 6608e5864780589b25d5421c3d3673ab30c4c318 05:51:03 INFO - mozversion application_display_name: Nightly 05:51:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:51:03 INFO - mozversion application_name: Firefox 05:51:03 INFO - mozversion application_remotingname: firefox 05:51:03 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:51:03 INFO - mozversion application_vendor: Mozilla 05:51:03 INFO - mozversion application_version: 51.0a1 05:51:03 INFO - mozversion platform_buildid: 20160803030226 05:51:03 INFO - mozversion platform_changeset: 6608e5864780589b25d5421c3d3673ab30c4c318 05:51:03 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:51:03 INFO - mozversion platform_version: 51.0a1 05:51:03 INFO - using testdate: 1470228663 05:51:03 INFO - actual date: 1470228663 05:51:03 INFO - starting webserver on 'localhost:40989' 05:51:03 INFO - SUITE-START | Running 2 tests 05:51:03 INFO - TEST-START | dromaeo_css 05:51:03 INFO - operating with platform_type : linux_ 05:51:03 INFO - Initialising browser for dromaeo_css test... 05:51:04 INFO - TEST-INFO | started process 3333 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyRQcuC/profile http://localhost:40989/getInfo.html) 05:51:10 INFO - PROCESS | 3333 | __metrics Screen width/height:1600/1200 05:51:10 INFO - PROCESS | 3333 | colorDepth:24 05:51:10 INFO - PROCESS | 3333 | Browser inner width/height: 1024/697 05:51:10 INFO - PROCESS | 3333 | __metrics 05:51:11 INFO - PROCESS | 3333 | 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" 05:51:11 INFO - PROCESS | 3333 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:51:11 INFO - PROCESS | 3333 | console.error: PushService: 05:51:11 INFO - PROCESS | 3333 | stateChangeProcessEnqueue: Error transitioning state 05:51:11 INFO - PROCESS | 3333 | UnknownError 05:51:12 INFO - TEST-INFO | 3333: exit 0 05:51:12 INFO - Browser initialized. 05:51:12 INFO - Running cycle 1/1 for dromaeo_css test... 05:51:12 INFO - TEST-INFO | started process 3416 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyRQcuC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:51:24 INFO - PROCESS | 3416 | RSS: Main: 155914240 05:51:24 INFO - PROCESS | 3416 | 05:52:15 INFO - PROCESS | 3416 | 1470228735033 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] 05:54:24 INFO - PROCESS | 3416 | Cycle 1(1): loaded http://localhost:40989/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40989/tests/dromaeo/cssquery-ext.html) 05:54:25 INFO - PROCESS | 3416 | RSS: Main: 268582912 05:54:25 INFO - PROCESS | 3416 | 05:57:27 INFO - PROCESS | 3416 | Cycle 1(1): loaded http://localhost:40989/tests/dromaeo/cssquery-ext.html (next: http://localhost:40989/tests/dromaeo/cssquery-jquery.html) 05:57:28 INFO - PROCESS | 3416 | RSS: Main: 237547520 05:57:28 INFO - PROCESS | 3416 | 06:00:30 INFO - PROCESS | 3416 | Cycle 1(1): loaded http://localhost:40989/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40989/tests/dromaeo/cssquery-mootools.html) 06:00:30 INFO - PROCESS | 3416 | RSS: Main: 185106432 06:00:30 INFO - PROCESS | 3416 | 06:03:32 INFO - PROCESS | 3416 | Cycle 1(1): loaded http://localhost:40989/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40989/tests/dromaeo/cssquery-prototype.html) 06:03:33 INFO - PROCESS | 3416 | RSS: Main: 215478272 06:03:33 INFO - PROCESS | 3416 | 06:06:36 INFO - PROCESS | 3416 | Cycle 1(1): loaded http://localhost:40989/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40989/tests/dromaeo/cssquery-yui.html) 06:06:36 INFO - PROCESS | 3416 | RSS: Main: 185724928 06:06:36 INFO - PROCESS | 3416 | 06:09:39 INFO - PROCESS | 3416 | Cycle 1(1): loaded http://localhost:40989/tests/dromaeo/cssquery-yui.html (next: http://localhost:40989/tests/dromaeo/cssquery-dojo.html) 06:09:39 INFO - PROCESS | 3416 | RSS: Main: 292823040 06:09:39 INFO - PROCESS | 3416 | 06:09:39 INFO - PROCESS | 3416 | __start_tp_report 06:09:39 INFO - PROCESS | 3416 | _x_x_mozilla_page_load 06:09:39 INFO - PROCESS | 3416 | _x_x_mozilla_page_load_details 06:09:39 INFO - PROCESS | 3416 | |i|pagename|runs| 06:09:39 INFO - PROCESS | 3416 | |0;dojo.html;3057.862396192171;3063.3873225354905;3090.0266416078935;3095.3345030818377;3107.0368185862385;5266.657667251636;5332.466753324666;5360.115580929147;5431.511163995239;5446.809361672343;5303.628745987782;5346.304980352549;5391.649542779716;5407.242985981966;5454.045542030139;4850.53919877611;4921.261810728383;4928.802847886081;4943.901121977558;5112.872178195537;5027.597792176635;5059.494050594948;5076.111680455924;5090.109230884599;5093.083245015896;4827.10698520773;4840.056189043138;4874.317595536628;4895.706257624518;4995.325631039817;4909.68087074339;4917.877053073702;4927.728974906378;4971.602271818282;4975.7263350515705;4924.704517728947;4959.776810043557;4965.702057876539;4982.800687972477;5006.799728010875;5264;5313.149896016657;5375.650582712111;5437.918431223535;5479.4520547945285;5791.681457519835;5793.536517078624;5838.620489668158;5842.970785146047;5849.736761845727;5828.0966450200285;5830.154627578977;5834.795782147605;5835.5915085944;5839.941600584025;5321.095413779705;5327.041132596131;5380.21986811914;5396.08266594672;5399.406065332811;5982.192404025401;5982.880342393128;5984.311804142492;5993.370696076936;5993.400659933972;5748.425157484302;5752.539796816328;5757.0788673811985;5776.711164441761;5781.075027995501;5633.915491267634;5720.42795720433;5784.2769653793275;5836.649801011953;5849.678267695318;5817.185594016841;5823.854403639943;5854.443827836349;5876.529877609781;5878.911816322759;5768.423157684282;5789.565782566325;5837.766489340379;5840.415958404125;5854.092615644582;4351.4995775485595;4414.602685758297;4463.776811159429;4475.7985890635;4487.842925497592;3957.940630890539;3976.76139431635;4001.919961600752;4013.2776100302226;4024.4164596133396;5538.390777014525;5541.778328866801;5543.722813859291;5543.805966791143;5544.63959842609;5705.600607957404;5798.420157984252;5808.941910580925;5882.264716910387;5939.554533410012;5479.6164268500825;5488.780448782084;5498.45015498455;5508.724563771795;5514.338279406416;4965.32968049316;4974.77613507393;4980.252962055721;4994;5026.095302845523;5882.735276912464;5908.911366329508;5973.790917317873;6051.031834906394;6058.636481811105;5797;5797.536197104306;5805.216295800013;5808.5643576732755;5849.883002339844;5937.317208521075;5939.910901336397;5944.910826337522;5946.197263369563;5957.4042595740075;5604.943950560605;5611;5616.550675945833;5656.23640808502;5684.431556844283;5766.221560089334;5804.1874137619925;5813.186153938367;5852.882942341214;5871;5608.439156084359;5631.324241091095;5675.631083979528;5678.716064196691;5690.544756419394;5499.972500137474;5594.916076258941;5597.356304024926;5600;5607.411221821813;5653.717314134359;5658.660480371191;5664.235328230636;5668.829935101953;5718.370979192202;5766.711664416846;5782.421757824184;5825.912611310919;5828.970855145697;5837.09525023622;5402.189671549299;5406.648567843077;5583.050881350099;5637.887242255214;5646.3788983212635 06:09:39 INFO - PROCESS | 3416 | |1;ext.html;594.4649815166352;610.0422336931018;616.1650962945206;620.4942971478247;635.9745610175587;41726.58273417265;43130.784346078224;43243;43329.35005974909;46817.29774053392;44533.10933781322;44915.55084449155;44923.77538112313;44961.10077798442;44998.775006125004;8705.347098967586;8844.778880527974;8846.292296616288;8852.51311177885;8852.911470885274;8812.1187881212;8834.779130521723;8838.33712471564;8884.955575222148;8897.466152030898;8902.109789021111;8994.10058994102;8994.865077023816;9005.369624126313;9005.54972251388;8866.335024873128;8903.06517815633;8905.421147625448;8910.064443233432;8917.554122293925;8765.605547750367;8868.645254189825;8869.512176830272;8871.112888711143;8877.778055548599;42266.577334226575;42560.78719606413;42571.57428425707;42586.57413425888;42636;3327.1349449143154;3370.6123795763556;3455.6026057003514;3560.768550044239;3845.576986531479;32235.516467253008;32570.511442328385;33334.83332583346;33466.330673386394;33600.663993359994;4272.33778764292;4383.473983122046;4402.449693788277;4503.206965119599;4531.388262584542;343924;343925;344477;346137;346398;54603;54783.726081370136;54954.45045549573;54975.17537236945;55038;58010.70994645;58105.70947145237;58110.418895811345;58165.41834581685;58198.41801582015;14002.159870407808;14125.152490850582;14138.64653383653;14141.646458838406;14148.717025659429;11406.08751299894;11450.770984580427;11496.77006459866;11508.712282193012;11523.135764817673;13886.375113119933;15559.144247066293;15613.68772624541;15687.372505099896;15863.20683965797;5500.917486237709;5721.427857214246;5737.196792449061;5861.20873682056;5883.588148829541;913.6025828764509;947.166493485742;993.9552720127612;1038.6832016234969;1122.764219513895;31463.52804707931;31915.202119946724;31972;32025.839870800497;32290.67709322924;899.910008999108;1089.1885545268826;1089.319175515303;1132.8867113288604;1203.2179083595558;15647.765283520755;16508.17459127039;16525.752113718303;16571;16819.83180168207;504230;509473;510627;511163;511310;55236;55436.445635543125;55525.16712249319;55652.44347556554;55686.44313556894;1187.3080859774786;1290.6063650586661;1325.2313658078483;1329.1759109352263;1339.7588434081958;31362.686373135977;32911.50632740559;32979.175520612174;33077;33548;47909.5209047919;48208.517914820404;48416.5158348412;48429.5157048425;48497;382821;384326;385536;385808;386274;27301.86349068242;27967;28150.155495335173;29801.27484064492;40234;45176.77411612921;45420.772896135306;45439.88728089966;46606.30090548712;46727;39380.606193937696;39396.60603393929;40311.59688403078;40496;41568.376474353514;38565.6143438562;39494.60505394909;40257.873242168294;40630.79684601558;41216.38175427311;39465.40801887916;39782.80108599438;40251.79874100611;40643;40815.7959210202;34032.65967340295;35862.820685896404;36026.4596031065;36540.634593653725;36583.08542286464;27069;27448.313792155357;27502.724972750017;27618.171454856387;27649.308767280978 06:09:39 INFO - PROCESS | 3416 | |2;jquery.html;386.75441094904727;395.4325542846018;396.8868872371375;402.61952454930093;427.8096247170009;14200.218987955659;18796;19795.505112372197;20087.196512139533;20110.798892011077;12586.685332866682;12861.228326300428;12889.871101288983;12941.805872911913;13008.34958252086;4059.8985025374304;5335.973320133413;5455.345358556979;5482.80810171644;5491.258680078198;3585.1395665040463;3643.471696603991;3649.4160934250526;6358.650274234915;6595.6372399518;6440.323766004549;6630.93369066308;6694.2970988046045;6700.765473208438;6705.6982435790505;6599.043138744879;6611.23970743361;6612.107365505667;6635.43598794103;6658.667066646648;5706.514946229576;5836.649801011953;5906.675132867691;5933.61431506955;5936.792212272593;14433.855661443356;14572.927135364256;16748.665026699397;24168.395790105387;24355;2314.680632039738;2347.2019513365367;2379.6906402167606;2543.707473640518;2924.1812292558116;10061.490776383527;10159.4920253987;10291.125254353388;10660.573577056908;10838.512266947928;1850.8149185081518;1913.980860191408;1925.1529327096032;1938.030984507746;1994.6609076457037;85936;86304;86884.56557717234;87055.56472217599;88150.559247204;11164.10210264257;11299.604513842141;11448.484818183202;11481.827772583418;11521;16090.195490225677;16105.919470402572;16111.758323625156;16114.435994740128;16115.516534503984;7412.1476030256135;7560.924390756132;7719.150893401721;7788.883166752503;7870.370370370357;6911.619860907598;7141.642917854087;7171.497995140395;7187.281271872876;7419.29516695913;4812.831550895772;4836;4894.241392584155;4908.607311415079;5051.191809310566;1751.5183324585842;1842.3920106364867;1854.2212270846007;1897.4971632517395;1911.1113332300547;868.700298397052;952.2191802721702;1019.0573719309609;1033.503918119292;1051.3481641382239;19406.902965485366;20249.291274805604;20688.379348619565;20979.895100524398;21108;967.1150896929231;976.3604838830578;978.8287049766262;993.2947607198826;1009.3287963504334;10535.262531622713;11516.94241528787;11580.536778528933;11597.304161750322;11597.942010289895;475236;476292;487928.54770838015;490516;492315;92031.5398423017;94026;94280;95910;95946;974.65886939572;987.244757760314;990.7424069741919;1010.6412223660642;1017.5370206555999;17548.473545793648;18109.909450452662;18343.63312733711;18419.355322563646;18492.167852446943;43273;43848.780756096014;44011.33982990322;45022.77488612536;46134.76932615315;56433.71783141058;58481.70759146177;60904.25930833034;60959;61588.69205654122;5674.120511320752;5942.64344139353;8496.362772791941;8596.339925322782;8709.477431354138;9113.906331240294;10950.233483656068;12662.176958497668;12675.985921126472;12740.235585864877;11188.66434006981;12013.519459221534;12216.328101954477;12229.205101668364;12376.319302438453;11002.614908478165;11502.597409090642;12189.390530473263;12222.572209972608;12541.74916501683;12450.439730211981;12461.252324860538;12463.127581069239;12508.186312984384;12589.559365422167;8714.825703486022;8855.512946787989;8915.42049766763;8918.152775486318;8989.640414383352;9161.221296189899;12001;12163.2702037878;12249.571265005681;12289.38553072325 06:09:39 INFO - PROCESS | 3416 | |3;mootools.html;1289.684027413284;1467.2956980649292;1536.377767004363;1641.9589510262242;1796.4700413378043;8414.116517765631;8808.647654093837;8857.247133993602;9116.544172791351;9152.588133534007;8873.511956842387;8885.68900088497;8993.59528821203;8994;8996.415233009866;2412.2401443545273;2453.276283496364;2455.2020593307157;2458.2625212436287;2459.2376363327335;2369.0286982337243;2371.1819422299277;2378.4830932999334;2378.5124049569795;2381.130887226159;2379.9881000594974;2393.808495320379;2404.230646193219;2411.7949974252124;2414.3239892829947;2339.02930283932;2365.042157926043;2371.584972629783;2376.702912135983;2383.892724827387;2296.644020176875;2305.30840747775;2311.6301391777233;2312.4450131968206;2314.36355002374;8792.296616270683;8929.241014513775;8935.68725094625;8984.056674049196;9051.27589792815;5352.812651557177;5586.24585680932;5590.580706447033;5604.943950560483;5605.047141985872;3675.1547144156993;3724.1248306647917;3742.0644838790304;3766.773993560395;3782.8108594570162;1211.6970757310673;1212.7574485103014;1219.7987332090195;1255.2844878419305;1255.7174635706892;11813.704657383549;11887.88112118885;11888.10839187073;11903.16677832552;11906.821397679041;4330.133973205371;4556.703814252063;4604.447466304065;4619.745913974763;4623.052274283764;9458.148766611039;9463.621455141718;9467.195288400426;9484;9585.041495850359;5263.7104959226845;5280.102382594968;5285.07511185541;5290.259363689087;5291.100512912814;4092.508898932147;4430.579094985971;4570.314452832102;4844.612431005511;4899.118158731391;3777.9244415112094;3809.3714537101623;3905.7656540607654;3906.7069969751815;3936.2127574485216;1218.6405010521917;1260.4517035089766;1260.9117361784588;1266.7909794883926;1272.395612084271;868.9572512984444;897.3852910756153;943.565959658551;959.7264779537799;966.4298064142049;5401.189821526802;5556.944430555724;5797.710114494258;6029.155918171459;6112.449879510866;467.86665800246766;478.4330568276534;483.92741088836254;484.2179879494591;486.0619005319767;3979.263836190314;4142.896427589274;4146.357314616239;4150.372334846685;4158.708890377705;11005.779884402427;11205.831912521318;11281.60514382009;11304.208705390543;11427.257228280136;11214.383208923588;11224.102071834233;11256.887431125748;11277.379744114152;11289.71775705614;8455.788605284917;8530.445521041112;8532.402731808837;8533.871991920127;8537.274331681876;5807.157962095388;5811.476967072984;5965.105234214902;5975.521958243243;6077.51379889599;10111.54498047575;10295.330803497749;10296.433696146783;10302.381857088598;10469.633562825264;8993;10632.52153653072;10636.734081648021;10643.467826608794;10648.84026739584;7204.423646108194;7329.596872172082;7409.592472414069;7520.7367742130955;7582.696692132253;8745.125487451203;8752.168543988311;8814.118588141135;8842.602082906156;8917.197452229331;7834.373250140089;7918.762437126896;7940.722074727357;8016.7194148204535;8125.79685507867;7730.994970653779;7829.725959591615;7832.960835195788;7839.216078392115;7888.211178882066;7189.352958233784;7379.372753316028;7429.851402972018;7445.181030086578;7449;4950.504949505021;4962.751862406937;5241.292425522658;5267.157254839208;5321.866953326198;5146.76839542229;5199.66202196856;5323.733813309396;5343.332083489564;5414.7021913795115 06:09:39 INFO - PROCESS | 3416 | |4;prototype.html;328.9903383278582;337.4802803682329;345.2387485594264;346.9653034696529;348.61129840228153;5082.949170508303;5244.580433565315;5252.474752524746;5292.338457692788;5292.603054770893;5203.4536373680785;5207.895842083156;5233.973830130844;5261.2371206175085;5263.894722105556;4149.398337241106;4173.520045194796;4175.248455278049;4180.226658068252;4220.3036498977635;4042.454268673721;4184.267753143188;4190.685698572604;4200.978995105035;4208.347706105543;4160.958390416103;4166.000159961603;4169.62473377396;4177.268977928866;4188.1204946961025;4151.858238984273;4153.376993450976;4158;4172.603602657728;4175.770332631704;3630.3828349180703;3729.9813500932323;3749.981250093759;3751.8686845960533;3778.8677396290996;5090;5092.79628814847;5107.974460127675;5109.540141387293;5113.954418232699;4743.573078422924;4751.904961900743;4753.3582966299455;4758.191107511731;4758.2624693172265;5346.786128554853;5451.754671039813;5455.972720136414;5466.371367292772;5495.2856128703415;4070.674346052309;4073.918521629551;4075.510938687347;4076.4700588923547;4088.9164371441593;5641.746121424505;5653.660780353192;5658.151277308354;5674.631148975344;5685.54515638752;4029.536603290659;4165.708400411942;4205.76868272248;4205.894852628648;4213.1784302061415;4280.67894907877;4285.421468101767;4286.971126929577;4289.442372491556;4290;4763.333133361332;4789.425268967746;4791.6885402449425;4811.350467686818;4821.9035619287415;5382.650127741685;5443.755031023614;5501.614886957875;5599.80400685974;5605.299337582802;1378.2626294932163;1429.1567974894863;1431;1457.8323492798463;1459.6350912271932;994.5474808961905;1004.5027711282962;1033.612395351743;1036.984445233322;1037.994810025945;5238.68567885928;5241.816536421207;5244.842654720364;5266.131088370376;5275.947240527546;5551.139573366135;5555.944440555623;5562.082256427725;5572.3034620672415;5634.32388113429;5065.822696205689;5157.510036546522;5194.948050519522;5286.259923610698;5329.493698098752;2549.515592037507;2566.7561581649716;2569.8435703933305;2578.3296342950966;2621.698504671987;4993.6005119590345;5016.598672106223;5056.57019153376;5070.112730272188;5074.517920797518;4972.627052971042;4977.40271167455;5397.379301380313;5840.5035571976005;5841.532677385799;5809.82570522885;5866.735996880066;5877.676727779927;5883.029185222998;5907.291125064934;5432.674039557639;5704.8003319885265;5731.140328950691;5736.741846616829;5752.367239603556;5595.272614560081;5626.88746225065;5626.915596265977;5645.802396916089;5653.491185793298;5838.299404071538;5842.458530539229;5855.238818953509;5873.563965080476;5935.34711181761;3859;4036.535798383106;4092.9358366825436;4099.692523060842;4119.567445418308;5365.678059316453;5523.701930046355;5581.469760372758;5608.971955140199;5635.408282130481;5480.3971563128825;5504.972475137599;5516.117421212587;5540.612157148961;5552.305961754781;5516.200150978166;5520.503154716095;5523.6685798852195;5536.86157846041;5540.22436858832;5240.502152295526;5416.83749487516;5450.127979523416;5466.753996070107;5491.423400543045;5565.30433695788;5576.2676288619095;5578.497935185853;5582.385937546947;5591.518247664291;5222.843314700565;5410.377806552139;5444.863878403072;5485.561155107502;5490.423505531861 06:09:39 INFO - PROCESS | 3416 | |5;yui.html;760.5094713909529;769.0463824857179;793.4842352470894;836.2557323981662;858.4934888415835;15115.546533603996;16195.514134575953;16226.432074877383;16252;16293.511194664165;15144.394224231046;15296.388144474235;15304.84695153051;15313.693726125499;15322.310496027678;661.6526323680058;789.4118881433311;801.7755028591989;805.556943680976;806.753940048285;827.0902007791442;828.9129641387627;831.3100126894693;831.733845169546;832.3258160889668;873.5501216873315;874.8731433942074;874.9125087491263;877.7103555826594;877.784942689042;708.355396589104;865.1996902864856;871.0331531999476;878.1350369885657;896.5472436419632;611.6574718157846;615.9106929495198;616.7872084130968;618.554640658725;620.1163342237339;14962.251887405586;14965.102093874402;14980.325885335185;14984.100953942798;14987.175705336202;15228.847711522965;15409.306581203873;15455.845441545553;15475.922620386938;15505.457308994244;13017.28404937728;13095.214287142802;13207.471701131943;13218.206907585576;13225.537106201236;3972.803493275645;3981.3231750602467;3982.6415622594104;3985.322495175827;4036.4348991141264;82381;82770;83699;84260.57869710673;89213.55393222993;12099.637010889688;12188;12310.938445307716;12334.136610437183;12434.62696119118;23913.282601521983;24079.638805417933;24110.87944560266;24111.638325425134;24237;8184.2224988625985;8517.44636598619;8577.571121444027;8995.145461181308;9010.59452324647;4662.696924699883;4670;4760.7619619018915;4778.546038126373;4834.758262086882;3661.908452288714;3781.3193625147187;3782.867599634;3783.394656854945;3783.7729736215915;613.6042252746953;617.6664601115438;618.3908849782961;635.7457017193067;637.486823107403;606.254307202135;627.1533429869639;701.694762778183;739.1721272175198;756.1644382956863;9451.527423628928;9499.620015199453;9740.220782337396;9960.950195249123;9993.650222242186;695.3984803145344;728.0753443127304;737.6053811211084;753.1865585168006;776.7592046465613;4644.164050470948;4779.545943135397;4780.163471392492;4783.784729687172;4799.512455853788;72181;72849.2715072853;72939;101123;113990.86009139968;107475.47671662908;108246.45876770723;110298;112436;114728.42635786935;80487.59756201181;81897.59051204706;88771.22457550812;98323.50838245905;99185.50407247918;9233.907660923305;9483.28875334339;9563.234941204548;9586.520673966414;9894.703158905244;52734.20898686446;53634.463655362946;54299;54904.450955491535;54918.725406372716;69426.305736944;71372;77938.2206177931;78276;86855.56572217098;12269.561248586284;12620.053495987653;12769.8084528734;12830.486780528674;13190.472381104648;14832.777508337167;14874.405023798927;15016.924915375354;15024.399024038916;15629.609259768142;14255.714885702435;14352.712945741236;14926.552203433914;14977.176255306063;15530.068195908281;14298.857011429753;14406.927965360106;14427.42290308376;14848.62878428048;15363.61590960235;14144.22206778637;14245.572632821031;14501.78247326312;14585.197814119902;15169.696606068037;11437.199396042197;11617.6514704559;11657.475413606579;11717.453855715728;12109.152359335114;11110.500027498943;11441.256318339281;11488.865175374827;11686.94156529212;11841 06:09:39 INFO - PROCESS | 3416 | __end_tp_report 06:09:39 INFO - PROCESS | 3416 | __start_cc_report 06:09:39 INFO - PROCESS | 3416 | _x_x_mozilla_cycle_collect,971 06:09:39 INFO - PROCESS | 3416 | __end_cc_report 06:09:39 INFO - PROCESS | 3416 | __startTimestamp1470229779654__endTimestamp 06:09:39 INFO - PROCESS | 3416 | 06:09:39 INFO - PROCESS | 3416 | ------- Summary: start ------- 06:09:39 INFO - PROCESS | 3416 | Number of tests: 6 06:09:39 INFO - PROCESS | 3416 | 06:09:39 INFO - PROCESS | 3416 | [#0] dojo.html Cycles:165 Average:5392.61 Median:5604.94 stddev:615.77 (11.0%) stddev-sans-first:589.79 06:09:39 INFO - PROCESS | 3416 | Values: 3057.9 3063.4 3090.0 3095.3 3107.0 5266.7 5332.5 5360.1 5431.5 5446.8 5303.6 5346.3 5391.6 5407.2 5454.0 4850.5 4921.3 4928.8 4943.9 5112.9 5027.6 5059.5 5076.1 5090.1 5093.1 4827.1 4840.1 4874.3 4895.7 4995.3 4909.7 4917.9 4927.7 4971.6 4975.7 4924.7 4959.8 4965.7 4982.8 5006.8 5264.0 5313.1 5375.7 5437.9 5479.5 5791.7 5793.5 5838.6 5843.0 5849.7 5828.1 5830.2 5834.8 5835.6 5839.9 5321.1 5327.0 5380.2 5396.1 5399.4 5982.2 5982.9 5984.3 5993.4 5993.4 5748.4 5752.5 5757.1 5776.7 5781.1 5633.9 5720.4 5784.3 5836.6 5849.7 5817.2 5823.9 5854.4 5876.5 5878.9 5768.4 5789.6 5837.8 5840.4 5854.1 4351.5 4414.6 4463.8 4475.8 4487.8 3957.9 3976.8 4001.9 4013.3 4024.4 5538.4 5541.8 5543.7 5543.8 5544.6 5705.6 5798.4 5808.9 5882.3 5939.6 5479.6 5488.8 5498.5 5508.7 5514.3 4965.3 4974.8 4980.3 4994.0 5026.1 5882.7 5908.9 5973.8 6051.0 6058.6 5797.0 5797.5 5805.2 5808.6 5849.9 5937.3 5939.9 5944.9 5946.2 5957.4 5604.9 5611.0 5616.6 5656.2 5684.4 5766.2 5804.2 5813.2 5852.9 5871.0 5608.4 5631.3 5675.6 5678.7 5690.5 5500.0 5594.9 5597.4 5600.0 5607.4 5653.7 5658.7 5664.2 5668.8 5718.4 5766.7 5782.4 5825.9 5829.0 5837.1 5402.2 5406.6 5583.1 5637.9 5646.4 06:09:39 INFO - PROCESS | 3416 | 06:09:39 INFO - PROCESS | 3416 | [#1] ext.html Cycles:180 Average:57348.60 Median:41647.48 stddev:110889.80 (266.3%) stddev-sans-first:111119.00 06:09:39 INFO - PROCESS | 3416 | Values: 594.5 610.0 616.2 620.5 636.0 41726.6 43130.8 43243.0 43329.4 46817.3 44533.1 44915.6 44923.8 44961.1 44998.8 8705.3 8844.8 8846.3 8852.5 8852.9 8812.1 8834.8 8838.3 8885.0 8897.5 8902.1 8994.1 8994.9 9005.4 9005.5 8866.3 8903.1 8905.4 8910.1 8917.6 8765.6 8868.6 8869.5 8871.1 8877.8 42266.6 42560.8 42571.6 42586.6 42636.0 3327.1 3370.6 3455.6 3560.8 3845.6 32235.5 32570.5 33334.8 33466.3 33600.7 4272.3 4383.5 4402.4 4503.2 4531.4 343924.0 343925.0 344477.0 346137.0 346398.0 54603.0 54783.7 54954.5 54975.2 55038.0 58010.7 58105.7 58110.4 58165.4 58198.4 14002.2 14125.2 14138.6 14141.6 14148.7 11406.1 11450.8 11496.8 11508.7 11523.1 13886.4 15559.1 15613.7 15687.4 15863.2 5500.9 5721.4 5737.2 5861.2 5883.6 913.6 947.2 994.0 1038.7 1122.8 31463.5 31915.2 31972.0 32025.8 32290.7 899.9 1089.2 1089.3 1132.9 1203.2 15647.8 16508.2 16525.8 16571.0 16819.8 504230.0 509473.0 510627.0 511163.0 511310.0 55236.0 55436.4 55525.2 55652.4 55686.4 1187.3 1290.6 1325.2 1329.2 1339.8 31362.7 32911.5 32979.2 33077.0 33548.0 47909.5 48208.5 48416.5 48429.5 48497.0 382821.0 384326.0 385536.0 385808.0 386274.0 27301.9 27967.0 28150.2 29801.3 40234.0 45176.8 45420.8 45439.9 46606.3 46727.0 39380.6 39396.6 40311.6 40496.0 41568.4 38565.6 39494.6 40257.9 40630.8 41216.4 39465.4 39782.8 40251.8 40643.0 40815.8 34032.7 35862.8 36026.5 36540.6 36583.1 27069.0 27448.3 27502.7 27618.2 27649.3 06:09:39 INFO - PROCESS | 3416 | 06:09:39 INFO - PROCESS | 3416 | [#2] jquery.html Cycles:180 Average:28959.00 Median:3646.44 stddev:80156.29 (2198.2%) stddev-sans-first:80352.44 06:09:39 INFO - PROCESS | 3416 | Values: 386.8 395.4 396.9 402.6 427.8 14200.2 18796.0 19795.5 20087.2 20110.8 12586.7 12861.2 12889.9 12941.8 13008.3 4059.9 5336.0 5455.3 5482.8 5491.3 3585.1 3643.5 3649.4 6358.7 6595.6 6440.3 6630.9 6694.3 6700.8 6705.7 6599.0 6611.2 6612.1 6635.4 6658.7 5706.5 5836.6 5906.7 5933.6 5936.8 14433.9 14572.9 16748.7 24168.4 24355.0 2314.7 2347.2 2379.7 2543.7 2924.2 10061.5 10159.5 10291.1 10660.6 10838.5 1850.8 1914.0 1925.2 1938.0 1994.7 85936.0 86304.0 86884.6 87055.6 88150.6 11164.1 11299.6 11448.5 11481.8 11521.0 16090.2 16105.9 16111.8 16114.4 16115.5 7412.1 7560.9 7719.2 7788.9 7870.4 6911.6 7141.6 7171.5 7187.3 7419.3 4812.8 4836.0 4894.2 4908.6 5051.2 1751.5 1842.4 1854.2 1897.5 1911.1 868.7 952.2 1019.1 1033.5 1051.3 19406.9 20249.3 20688.4 20979.9 21108.0 967.1 976.4 978.8 993.3 1009.3 10535.3 11516.9 11580.5 11597.3 11597.9 475236.0 476292.0 487928.5 490516.0 492315.0 92031.5 94026.0 94280.0 95910.0 95946.0 974.7 987.2 990.7 1010.6 1017.5 17548.5 18109.9 18343.6 18419.4 18492.2 43273.0 43848.8 44011.3 45022.8 46134.8 56433.7 58481.7 60904.3 60959.0 61588.7 5674.1 5942.6 8496.4 8596.3 8709.5 9113.9 10950.2 12662.2 12676.0 12740.2 11188.7 12013.5 12216.3 12229.2 12376.3 11002.6 11502.6 12189.4 12222.6 12541.7 12450.4 12461.3 12463.1 12508.2 12589.6 8714.8 8855.5 8915.4 8918.2 8989.6 9161.2 12001.0 12163.3 12249.6 12289.4 06:09:39 INFO - PROCESS | 3416 | 06:09:39 INFO - PROCESS | 3416 | [#3] mootools.html Cycles:180 Average:5841.39 Median:2664.42 stddev:3325.78 (124.8%) stddev-sans-first:3317.51 06:09:39 INFO - PROCESS | 3416 | Values: 1289.7 1467.3 1536.4 1642.0 1796.5 8414.1 8808.6 8857.2 9116.5 9152.6 8873.5 8885.7 8993.6 8994.0 8996.4 2412.2 2453.3 2455.2 2458.3 2459.2 2369.0 2371.2 2378.5 2378.5 2381.1 2380.0 2393.8 2404.2 2411.8 2414.3 2339.0 2365.0 2371.6 2376.7 2383.9 2296.6 2305.3 2311.6 2312.4 2314.4 8792.3 8929.2 8935.7 8984.1 9051.3 5352.8 5586.2 5590.6 5604.9 5605.0 3675.2 3724.1 3742.1 3766.8 3782.8 1211.7 1212.8 1219.8 1255.3 1255.7 11813.7 11887.9 11888.1 11903.2 11906.8 4330.1 4556.7 4604.4 4619.7 4623.1 9458.1 9463.6 9467.2 9484.0 9585.0 5263.7 5280.1 5285.1 5290.3 5291.1 4092.5 4430.6 4570.3 4844.6 4899.1 3777.9 3809.4 3905.8 3906.7 3936.2 1218.6 1260.5 1260.9 1266.8 1272.4 869.0 897.4 943.6 959.7 966.4 5401.2 5556.9 5797.7 6029.2 6112.4 467.9 478.4 483.9 484.2 486.1 3979.3 4142.9 4146.4 4150.4 4158.7 11005.8 11205.8 11281.6 11304.2 11427.3 11214.4 11224.1 11256.9 11277.4 11289.7 8455.8 8530.4 8532.4 8533.9 8537.3 5807.2 5811.5 5965.1 5975.5 6077.5 10111.5 10295.3 10296.4 10302.4 10469.6 8993.0 10632.5 10636.7 10643.5 10648.8 7204.4 7329.6 7409.6 7520.7 7582.7 8745.1 8752.2 8814.1 8842.6 8917.2 7834.4 7918.8 7940.7 8016.7 8125.8 7731.0 7829.7 7833.0 7839.2 7888.2 7189.4 7379.4 7429.9 7445.2 7449.0 4950.5 4962.8 5241.3 5267.2 5321.9 5146.8 5199.7 5323.7 5343.3 5414.7 06:09:39 INFO - PROCESS | 3416 | 06:09:39 INFO - PROCESS | 3416 | [#4] prototype.html Cycles:180 Average:4627.63 Median:5205.67 stddev:1340.56 (25.8%) stddev-sans-first:1304.92 06:09:39 INFO - PROCESS | 3416 | Values: 329.0 337.5 345.2 347.0 348.6 5082.9 5244.6 5252.5 5292.3 5292.6 5203.5 5207.9 5234.0 5261.2 5263.9 4149.4 4173.5 4175.2 4180.2 4220.3 4042.5 4184.3 4190.7 4201.0 4208.3 4161.0 4166.0 4169.6 4177.3 4188.1 4151.9 4153.4 4158.0 4172.6 4175.8 3630.4 3730.0 3750.0 3751.9 3778.9 5090.0 5092.8 5108.0 5109.5 5114.0 4743.6 4751.9 4753.4 4758.2 4758.3 5346.8 5451.8 5456.0 5466.4 5495.3 4070.7 4073.9 4075.5 4076.5 4088.9 5641.7 5653.7 5658.2 5674.6 5685.5 4029.5 4165.7 4205.8 4205.9 4213.2 4280.7 4285.4 4287.0 4289.4 4290.0 4763.3 4789.4 4791.7 4811.4 4821.9 5382.7 5443.8 5501.6 5599.8 5605.3 1378.3 1429.2 1431.0 1457.8 1459.6 994.5 1004.5 1033.6 1037.0 1038.0 5238.7 5241.8 5244.8 5266.1 5275.9 5551.1 5555.9 5562.1 5572.3 5634.3 5065.8 5157.5 5194.9 5286.3 5329.5 2549.5 2566.8 2569.8 2578.3 2621.7 4993.6 5016.6 5056.6 5070.1 5074.5 4972.6 4977.4 5397.4 5840.5 5841.5 5809.8 5866.7 5877.7 5883.0 5907.3 5432.7 5704.8 5731.1 5736.7 5752.4 5595.3 5626.9 5626.9 5645.8 5653.5 5838.3 5842.5 5855.2 5873.6 5935.3 3859.0 4036.5 4092.9 4099.7 4119.6 5365.7 5523.7 5581.5 5609.0 5635.4 5480.4 5505.0 5516.1 5540.6 5552.3 5516.2 5520.5 5523.7 5536.9 5540.2 5240.5 5416.8 5450.1 5466.8 5491.4 5565.3 5576.3 5578.5 5582.4 5591.5 5222.8 5410.4 5444.9 5485.6 5490.4 06:09:39 INFO - PROCESS | 3416 | 06:09:39 INFO - PROCESS | 3416 | [#5] yui.html Cycles:180 Average:21126.20 Median:4769.65 stddev:29713.90 (623.0%) stddev-sans-first:29757.91 06:09:39 INFO - PROCESS | 3416 | Values: 760.5 769.0 793.5 836.3 858.5 15115.5 16195.5 16226.4 16252.0 16293.5 15144.4 15296.4 15304.8 15313.7 15322.3 661.7 789.4 801.8 805.6 806.8 827.1 828.9 831.3 831.7 832.3 873.6 874.9 874.9 877.7 877.8 708.4 865.2 871.0 878.1 896.5 611.7 615.9 616.8 618.6 620.1 14962.3 14965.1 14980.3 14984.1 14987.2 15228.8 15409.3 15455.8 15475.9 15505.5 13017.3 13095.2 13207.5 13218.2 13225.5 3972.8 3981.3 3982.6 3985.3 4036.4 82381.0 82770.0 83699.0 84260.6 89213.6 12099.6 12188.0 12310.9 12334.1 12434.6 23913.3 24079.6 24110.9 24111.6 24237.0 8184.2 8517.4 8577.6 8995.1 9010.6 4662.7 4670.0 4760.8 4778.5 4834.8 3661.9 3781.3 3782.9 3783.4 3783.8 613.6 617.7 618.4 635.7 637.5 606.3 627.2 701.7 739.2 756.2 9451.5 9499.6 9740.2 9961.0 9993.7 695.4 728.1 737.6 753.2 776.8 4644.2 4779.5 4780.2 4783.8 4799.5 72181.0 72849.3 72939.0 101123.0 113990.9 107475.5 108246.5 110298.0 112436.0 114728.4 80487.6 81897.6 88771.2 98323.5 99185.5 9233.9 9483.3 9563.2 9586.5 9894.7 52734.2 53634.5 54299.0 54904.5 54918.7 69426.3 71372.0 77938.2 78276.0 86855.6 12269.6 12620.1 12769.8 12830.5 13190.5 14832.8 14874.4 15016.9 15024.4 15629.6 14255.7 14352.7 14926.6 14977.2 15530.1 14298.9 14406.9 14427.4 14848.6 15363.6 14144.2 14245.6 14501.8 14585.2 15169.7 11437.2 11617.7 11657.5 11717.5 12109.2 11110.5 11441.3 11488.9 11686.9 11841.0 06:09:39 INFO - PROCESS | 3416 | -------- Summary: end -------- 06:09:39 INFO - PROCESS | 3416 | 06:09:40 INFO - TEST-INFO | 3416: exit 0 06:09:40 INFO - TEST-OK | dromaeo_css | took 1116524ms 06:09:40 INFO - TEST-START | kraken 06:09:40 INFO - operating with platform_type : linux_ 06:09:40 INFO - Initialising browser for kraken test... 06:09:40 INFO - TEST-INFO | started process 3607 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpatw1Lz/profile http://localhost:40989/getInfo.html) 06:09:44 INFO - PROCESS | 3607 | __metrics Screen width/height:1600/1200 06:09:44 INFO - PROCESS | 3607 | colorDepth:24 06:09:44 INFO - PROCESS | 3607 | Browser inner width/height: 1024/697 06:09:44 INFO - PROCESS | 3607 | __metrics 06:09:45 INFO - PROCESS | 3607 | 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" 06:09:45 INFO - PROCESS | 3607 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:09:46 INFO - TEST-INFO | 3607: exit 0 06:09:46 INFO - Browser initialized. 06:09:46 INFO - Running cycle 1/1 for kraken test... 06:09:46 INFO - TEST-INFO | started process 3688 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpatw1Lz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:09:58 INFO - PROCESS | 3688 | RSS: Main: 156676096 06:09:58 INFO - PROCESS | 3688 | 06:10:01 INFO - PROCESS | 3688 | Cycle 1(1): loaded http://localhost:40989/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40989/tests/kraken/driver.html?testName=audio-beat-detection) 06:10:01 INFO - PROCESS | 3688 | RSS: Main: 212877312 06:10:01 INFO - PROCESS | 3688 | 06:10:04 INFO - PROCESS | 3688 | Cycle 1(1): loaded http://localhost:40989/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40989/tests/kraken/driver.html?testName=audio-dft) 06:10:05 INFO - PROCESS | 3688 | RSS: Main: 190795776 06:10:05 INFO - PROCESS | 3688 | 06:10:08 INFO - PROCESS | 3688 | Cycle 1(1): loaded http://localhost:40989/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40989/tests/kraken/driver.html?testName=audio-fft) 06:10:08 INFO - PROCESS | 3688 | RSS: Main: 270147584 06:10:08 INFO - PROCESS | 3688 | 06:10:10 INFO - PROCESS | 3688 | Cycle 1(1): loaded http://localhost:40989/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40989/tests/kraken/driver.html?testName=audio-oscillator) 06:10:11 INFO - PROCESS | 3688 | RSS: Main: 179630080 06:10:11 INFO - PROCESS | 3688 | 06:10:13 INFO - PROCESS | 3688 | Cycle 1(1): loaded http://localhost:40989/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40989/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:10:14 INFO - PROCESS | 3688 | RSS: Main: 184201216 06:10:14 INFO - PROCESS | 3688 | 06:10:17 INFO - PROCESS | 3688 | Cycle 1(1): loaded http://localhost:40989/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40989/tests/kraken/driver.html?testName=imaging-darkroom) 06:10:17 INFO - PROCESS | 3688 | RSS: Main: 218710016 06:10:17 INFO - PROCESS | 3688 | 06:10:21 INFO - PROCESS | 3688 | Cycle 1(1): loaded http://localhost:40989/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40989/tests/kraken/driver.html?testName=imaging-desaturate) 06:10:22 INFO - PROCESS | 3688 | RSS: Main: 219787264 06:10:22 INFO - PROCESS | 3688 | 06:10:24 INFO - PROCESS | 3688 | Cycle 1(1): loaded http://localhost:40989/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40989/tests/kraken/driver.html?testName=json-parse-financial) 06:10:25 INFO - PROCESS | 3688 | RSS: Main: 219959296 06:10:25 INFO - PROCESS | 3688 | 06:10:26 INFO - PROCESS | 3688 | Cycle 1(1): loaded http://localhost:40989/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40989/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:10:27 INFO - PROCESS | 3688 | RSS: Main: 184356864 06:10:27 INFO - PROCESS | 3688 | 06:10:29 INFO - PROCESS | 3688 | Cycle 1(1): loaded http://localhost:40989/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40989/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:10:29 INFO - PROCESS | 3688 | RSS: Main: 189161472 06:10:29 INFO - PROCESS | 3688 | 06:10:32 INFO - PROCESS | 3688 | Cycle 1(1): loaded http://localhost:40989/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40989/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:10:33 INFO - PROCESS | 3688 | RSS: Main: 194723840 06:10:33 INFO - PROCESS | 3688 | 06:10:35 INFO - PROCESS | 3688 | Cycle 1(1): loaded http://localhost:40989/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40989/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:10:36 INFO - PROCESS | 3688 | RSS: Main: 189607936 06:10:36 INFO - PROCESS | 3688 | 06:10:38 INFO - PROCESS | 3688 | Cycle 1(1): loaded http://localhost:40989/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40989/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:10:39 INFO - PROCESS | 3688 | RSS: Main: 192524288 06:10:39 INFO - PROCESS | 3688 | 06:10:41 INFO - PROCESS | 3688 | Cycle 1(1): loaded http://localhost:40989/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40989/tests/kraken/driver.html?testName=ai-astar) 06:10:41 INFO - PROCESS | 3688 | RSS: Main: 243027968 06:10:41 INFO - PROCESS | 3688 | 06:10:41 INFO - PROCESS | 3688 | __start_tp_report 06:10:41 INFO - PROCESS | 3688 | _x_x_mozilla_page_load 06:10:41 INFO - PROCESS | 3688 | _x_x_mozilla_page_load_details 06:10:41 INFO - PROCESS | 3688 | |i|pagename|runs| 06:10:41 INFO - PROCESS | 3688 | |0;ai-astar;103;113;110;113;112;111;110;111;110;110 06:10:41 INFO - PROCESS | 3688 | |1;audio-beat-detection;140;118;119;188;119;121;150;118;147;122 06:10:41 INFO - PROCESS | 3688 | |2;audio-dft;161;159;160;161;160;162;159;160;161;161 06:10:41 INFO - PROCESS | 3688 | |3;audio-fft;73;75;75;112;75;75;74;74;103;75 06:10:41 INFO - PROCESS | 3688 | |4;audio-oscillator;84;84;127;84;83;85;128;84;83;133 06:10:41 INFO - PROCESS | 3688 | |5;imaging-gaussian-blur;117;116;116;117;117;117;116;116;117;116 06:10:41 INFO - PROCESS | 3688 | |6;imaging-darkroom;146;147;146;146;147;146;146;146;146;146 06:10:41 INFO - PROCESS | 3688 | |7;imaging-desaturate;96;95;95;95;95;95;96;96;95;95 06:10:41 INFO - PROCESS | 3688 | |8;json-parse-financial;51;51;49;50;50;51;51;50;50;50 06:10:41 INFO - PROCESS | 3688 | |9;json-stringify-tinderbox;61;60;60;60;59;60;60;60;61;60 06:10:41 INFO - PROCESS | 3688 | |10;stanford-crypto-aes;86;77;78;76;76;75;78;85;82;75 06:10:41 INFO - PROCESS | 3688 | |11;stanford-crypto-ccm;124;120;121;124;120;130;120;125;158;136 06:10:41 INFO - PROCESS | 3688 | |12;stanford-crypto-pbkdf2;165;161;165;163;160;161;162;159;160;160 06:10:41 INFO - PROCESS | 3688 | |13;stanford-crypto-sha256-iterative;64;64;63;63;64;63;63;63;69;63 06:10:41 INFO - PROCESS | 3688 | __end_tp_report 06:10:41 INFO - PROCESS | 3688 | __start_cc_report 06:10:41 INFO - PROCESS | 3688 | _x_x_mozilla_cycle_collect,1654 06:10:41 INFO - PROCESS | 3688 | __end_cc_report 06:10:41 INFO - PROCESS | 3688 | __startTimestamp1470229841493__endTimestamp 06:10:41 INFO - PROCESS | 3688 | 06:10:41 INFO - PROCESS | 3688 | ------- Summary: start ------- 06:10:41 INFO - PROCESS | 3688 | Number of tests: 14 06:10:41 INFO - PROCESS | 3688 | 06:10:41 INFO - PROCESS | 3688 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:2.83 (2.5%) stddev-sans-first:1.27 06:10:41 INFO - PROCESS | 3688 | Values: 103.0 113.0 110.0 113.0 112.0 111.0 110.0 111.0 110.0 110.0 06:10:41 INFO - PROCESS | 3688 | 06:10:41 INFO - PROCESS | 3688 | [#1] audio-beat-detection Cycles:10 Average:134.20 Median:131.00 stddev:22.73 (17.4%) stddev-sans-first:24.02 06:10:41 INFO - PROCESS | 3688 | Values: 140.0 118.0 119.0 188.0 119.0 121.0 150.0 118.0 147.0 122.0 06:10:41 INFO - PROCESS | 3688 | 06:10:41 INFO - PROCESS | 3688 | [#2] audio-dft Cycles:10 Average:160.40 Median:161.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 06:10:41 INFO - PROCESS | 3688 | Values: 161.0 159.0 160.0 161.0 160.0 162.0 159.0 160.0 161.0 161.0 06:10:41 INFO - PROCESS | 3688 | 06:10:41 INFO - PROCESS | 3688 | [#3] audio-fft Cycles:10 Average:81.10 Median:75.00 stddev:14.09 (18.8%) stddev-sans-first:14.64 06:10:41 INFO - PROCESS | 3688 | Values: 73.0 75.0 75.0 112.0 75.0 75.0 74.0 74.0 103.0 75.0 06:10:41 INFO - PROCESS | 3688 | 06:10:41 INFO - PROCESS | 3688 | [#4] audio-oscillator Cycles:10 Average:97.50 Median:84.00 stddev:22.03 (26.2%) stddev-sans-first:22.81 06:10:41 INFO - PROCESS | 3688 | Values: 84.0 84.0 127.0 84.0 83.0 85.0 128.0 84.0 83.0 133.0 06:10:41 INFO - PROCESS | 3688 | 06:10:41 INFO - PROCESS | 3688 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 06:10:41 INFO - PROCESS | 3688 | Values: 117.0 116.0 116.0 117.0 117.0 117.0 116.0 116.0 117.0 116.0 06:10:41 INFO - PROCESS | 3688 | 06:10:41 INFO - PROCESS | 3688 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 06:10:41 INFO - PROCESS | 3688 | Values: 146.0 147.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 06:10:41 INFO - PROCESS | 3688 | 06:10:41 INFO - PROCESS | 3688 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 06:10:41 INFO - PROCESS | 3688 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 06:10:41 INFO - PROCESS | 3688 | 06:10:41 INFO - PROCESS | 3688 | [#8] json-parse-financial Cycles:10 Average:50.30 Median:50.50 stddev:0.67 (1.3%) stddev-sans-first:0.67 06:10:41 INFO - PROCESS | 3688 | Values: 51.0 51.0 49.0 50.0 50.0 51.0 51.0 50.0 50.0 50.0 06:10:41 INFO - PROCESS | 3688 | 06:10:41 INFO - PROCESS | 3688 | [#9] json-stringify-tinderbox Cycles:10 Average:60.10 Median:60.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 06:10:41 INFO - PROCESS | 3688 | Values: 61.0 60.0 60.0 60.0 59.0 60.0 60.0 60.0 61.0 60.0 06:10:41 INFO - PROCESS | 3688 | 06:10:41 INFO - PROCESS | 3688 | [#10] stanford-crypto-aes Cycles:10 Average:78.80 Median:78.00 stddev:4.08 (5.2%) stddev-sans-first:3.39 06:10:41 INFO - PROCESS | 3688 | Values: 86.0 77.0 78.0 76.0 76.0 75.0 78.0 85.0 82.0 75.0 06:10:41 INFO - PROCESS | 3688 | 06:10:41 INFO - PROCESS | 3688 | [#11] stanford-crypto-ccm Cycles:10 Average:127.80 Median:124.50 stddev:11.78 (9.5%) stddev-sans-first:12.42 06:10:41 INFO - PROCESS | 3688 | Values: 124.0 120.0 121.0 124.0 120.0 130.0 120.0 125.0 158.0 136.0 06:10:41 INFO - PROCESS | 3688 | 06:10:41 INFO - PROCESS | 3688 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.60 Median:161.50 stddev:2.12 (1.3%) stddev-sans-first:1.86 06:10:41 INFO - PROCESS | 3688 | Values: 165.0 161.0 165.0 163.0 160.0 161.0 162.0 159.0 160.0 160.0 06:10:41 INFO - PROCESS | 3688 | 06:10:41 INFO - PROCESS | 3688 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:63.50 stddev:1.85 (2.9%) stddev-sans-first:1.96 06:10:41 INFO - PROCESS | 3688 | Values: 64.0 64.0 63.0 63.0 64.0 63.0 63.0 63.0 69.0 63.0 06:10:41 INFO - PROCESS | 3688 | -------- Summary: end -------- 06:10:41 INFO - PROCESS | 3688 | 06:10:42 INFO - TEST-INFO | 3688: exit 0 06:10:42 INFO - TEST-OK | kraken | took 61929ms 06:10:42 INFO - SUITE-END | took 1178s 06:10:42 INFO - Completed test suite (00:19:38) 06:10:42 INFO - javascript benchmark 06:10:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3057.862396192171, 3063.3873225354905, 3090.0266416078935, 3095.3345030818377, 3107.0368185862385, 5266.657667251636, 5332.466753324666, 5360.115580929147, 5431.511163995239, 5446.809361672343, 5303.628745987782, 5346.304980352549, 5391.649542779716, 5407.242985981966, 5454.045542030139, 4850.53919877611, 4921.261810728383, 4928.802847886081, 4943.901121977558, 5112.872178195537, 5027.597792176635, 5059.494050594948, 5076.111680455924, 5090.109230884599, 5093.083245015896, 4827.10698520773, 4840.056189043138, 4874.317595536628, 4895.706257624518, 4995.325631039817, 4909.68087074339, 4917.877053073702, 4927.728974906378, 4971.602271818282, 4975.7263350515705, 4924.704517728947, 4959.776810043557, 4965.702057876539, 4982.800687972477, 5006.799728010875, 5264.0, 5313.149896016657, 5375.650582712111, 5437.918431223535, 5479.4520547945285, 5791.681457519835, 5793.536517078624, 5838.620489668158, 5842.970785146047, 5849.736761845727, 5828.0966450200285, 5830.154627578977, 5834.795782147605, 5835.5915085944, 5839.941600584025, 5321.095413779705, 5327.041132596131, 5380.21986811914, 5396.08266594672, 5399.406065332811, 5982.192404025401, 5982.880342393128, 5984.311804142492, 5993.370696076936, 5993.400659933972, 5748.425157484302, 5752.539796816328, 5757.0788673811985, 5776.711164441761, 5781.075027995501, 5633.915491267634, 5720.42795720433, 5784.2769653793275, 5836.649801011953, 5849.678267695318, 5817.185594016841, 5823.854403639943, 5854.443827836349, 5876.529877609781, 5878.911816322759, 5768.423157684282, 5789.565782566325, 5837.766489340379, 5840.415958404125, 5854.092615644582, 4351.4995775485595, 4414.602685758297, 4463.776811159429, 4475.7985890635, 4487.842925497592, 3957.940630890539, 3976.76139431635, 4001.919961600752, 4013.2776100302226, 4024.4164596133396, 5538.390777014525, 5541.778328866801, 5543.722813859291, 5543.805966791143, 5544.63959842609, 5705.600607957404, 5798.420157984252, 5808.941910580925, 5882.264716910387, 5939.554533410012, 5479.6164268500825, 5488.780448782084, 5498.45015498455, 5508.724563771795, 5514.338279406416, 4965.32968049316, 4974.77613507393, 4980.252962055721, 4994.0, 5026.095302845523, 5882.735276912464, 5908.911366329508, 5973.790917317873, 6051.031834906394, 6058.636481811105, 5797.0, 5797.536197104306, 5805.216295800013, 5808.5643576732755, 5849.883002339844, 5937.317208521075, 5939.910901336397, 5944.910826337522, 5946.197263369563, 5957.4042595740075, 5604.943950560605, 5611.0, 5616.550675945833, 5656.23640808502, 5684.431556844283, 5766.221560089334, 5804.1874137619925, 5813.186153938367, 5852.882942341214, 5871.0, 5608.439156084359, 5631.324241091095, 5675.631083979528, 5678.716064196691, 5690.544756419394, 5499.972500137474, 5594.916076258941, 5597.356304024926, 5600.0, 5607.411221821813, 5653.717314134359, 5658.660480371191, 5664.235328230636, 5668.829935101953, 5718.370979192202, 5766.711664416846, 5782.421757824184, 5825.912611310919, 5828.970855145697, 5837.09525023622, 5402.189671549299, 5406.648567843077, 5583.050881350099, 5637.887242255214, 5646.3788983212635], "value": 5350.389354645259, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.4649815166352, 610.0422336931018, 616.1650962945206, 620.4942971478247, 635.9745610175587, 41726.58273417265, 43130.784346078224, 43243.0, 43329.35005974909, 46817.29774053392, 44533.10933781322, 44915.55084449155, 44923.77538112313, 44961.10077798442, 44998.775006125004, 8705.347098967586, 8844.778880527974, 8846.292296616288, 8852.51311177885, 8852.911470885274, 8812.1187881212, 8834.779130521723, 8838.33712471564, 8884.955575222148, 8897.466152030898, 8902.109789021111, 8994.10058994102, 8994.865077023816, 9005.369624126313, 9005.54972251388, 8866.335024873128, 8903.06517815633, 8905.421147625448, 8910.064443233432, 8917.554122293925, 8765.605547750367, 8868.645254189825, 8869.512176830272, 8871.112888711143, 8877.778055548599, 42266.577334226575, 42560.78719606413, 42571.57428425707, 42586.57413425888, 42636.0, 3327.1349449143154, 3370.6123795763556, 3455.6026057003514, 3560.768550044239, 3845.576986531479, 32235.516467253008, 32570.511442328385, 33334.83332583346, 33466.330673386394, 33600.663993359994, 4272.33778764292, 4383.473983122046, 4402.449693788277, 4503.206965119599, 4531.388262584542, 343924.0, 343925.0, 344477.0, 346137.0, 346398.0, 54603.0, 54783.726081370136, 54954.45045549573, 54975.17537236945, 55038.0, 58010.70994645, 58105.70947145237, 58110.418895811345, 58165.41834581685, 58198.41801582015, 14002.159870407808, 14125.152490850582, 14138.64653383653, 14141.646458838406, 14148.717025659429, 11406.08751299894, 11450.770984580427, 11496.77006459866, 11508.712282193012, 11523.135764817673, 13886.375113119933, 15559.144247066293, 15613.68772624541, 15687.372505099896, 15863.20683965797, 5500.917486237709, 5721.427857214246, 5737.196792449061, 5861.20873682056, 5883.588148829541, 913.6025828764509, 947.166493485742, 993.9552720127612, 1038.6832016234969, 1122.764219513895, 31463.52804707931, 31915.202119946724, 31972.0, 32025.839870800497, 32290.67709322924, 899.910008999108, 1089.1885545268826, 1089.319175515303, 1132.8867113288604, 1203.2179083595558, 15647.765283520755, 16508.17459127039, 16525.752113718303, 16571.0, 16819.83180168207, 504230.0, 509473.0, 510627.0, 511163.0, 511310.0, 55236.0, 55436.445635543125, 55525.16712249319, 55652.44347556554, 55686.44313556894, 1187.3080859774786, 1290.6063650586661, 1325.2313658078483, 1329.1759109352263, 1339.7588434081958, 31362.686373135977, 32911.50632740559, 32979.175520612174, 33077.0, 33548.0, 47909.5209047919, 48208.517914820404, 48416.5158348412, 48429.5157048425, 48497.0, 382821.0, 384326.0, 385536.0, 385808.0, 386274.0, 27301.86349068242, 27967.0, 28150.155495335173, 29801.27484064492, 40234.0, 45176.77411612921, 45420.772896135306, 45439.88728089966, 46606.30090548712, 46727.0, 39380.606193937696, 39396.60603393929, 40311.59688403078, 40496.0, 41568.376474353514, 38565.6143438562, 39494.60505394909, 40257.873242168294, 40630.79684601558, 41216.38175427311, 39465.40801887916, 39782.80108599438, 40251.79874100611, 40643.0, 40815.7959210202, 34032.65967340295, 35862.820685896404, 36026.4596031065, 36540.634593653725, 36583.08542286464, 27069.0, 27448.313792155357, 27502.724972750017, 27618.171454856387, 27649.308767280978], "value": 19467.33723246481, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.75441094904727, 395.4325542846018, 396.8868872371375, 402.61952454930093, 427.8096247170009, 14200.218987955659, 18796.0, 19795.505112372197, 20087.196512139533, 20110.798892011077, 12586.685332866682, 12861.228326300428, 12889.871101288983, 12941.805872911913, 13008.34958252086, 4059.8985025374304, 5335.973320133413, 5455.345358556979, 5482.80810171644, 5491.258680078198, 3585.1395665040463, 3643.471696603991, 3649.4160934250526, 6358.650274234915, 6595.6372399518, 6440.323766004549, 6630.93369066308, 6694.2970988046045, 6700.765473208438, 6705.6982435790505, 6599.043138744879, 6611.23970743361, 6612.107365505667, 6635.43598794103, 6658.667066646648, 5706.514946229576, 5836.649801011953, 5906.675132867691, 5933.61431506955, 5936.792212272593, 14433.855661443356, 14572.927135364256, 16748.665026699397, 24168.395790105387, 24355.0, 2314.680632039738, 2347.2019513365367, 2379.6906402167606, 2543.707473640518, 2924.1812292558116, 10061.490776383527, 10159.4920253987, 10291.125254353388, 10660.573577056908, 10838.512266947928, 1850.8149185081518, 1913.980860191408, 1925.1529327096032, 1938.030984507746, 1994.6609076457037, 85936.0, 86304.0, 86884.56557717234, 87055.56472217599, 88150.559247204, 11164.10210264257, 11299.604513842141, 11448.484818183202, 11481.827772583418, 11521.0, 16090.195490225677, 16105.919470402572, 16111.758323625156, 16114.435994740128, 16115.516534503984, 7412.1476030256135, 7560.924390756132, 7719.150893401721, 7788.883166752503, 7870.370370370357, 6911.619860907598, 7141.642917854087, 7171.497995140395, 7187.281271872876, 7419.29516695913, 4812.831550895772, 4836.0, 4894.241392584155, 4908.607311415079, 5051.191809310566, 1751.5183324585842, 1842.3920106364867, 1854.2212270846007, 1897.4971632517395, 1911.1113332300547, 868.700298397052, 952.2191802721702, 1019.0573719309609, 1033.503918119292, 1051.3481641382239, 19406.902965485366, 20249.291274805604, 20688.379348619565, 20979.895100524398, 21108.0, 967.1150896929231, 976.3604838830578, 978.8287049766262, 993.2947607198826, 1009.3287963504334, 10535.262531622713, 11516.94241528787, 11580.536778528933, 11597.304161750322, 11597.942010289895, 475236.0, 476292.0, 487928.54770838015, 490516.0, 492315.0, 92031.5398423017, 94026.0, 94280.0, 95910.0, 95946.0, 974.65886939572, 987.244757760314, 990.7424069741919, 1010.6412223660642, 1017.5370206555999, 17548.473545793648, 18109.909450452662, 18343.63312733711, 18419.355322563646, 18492.167852446943, 43273.0, 43848.780756096014, 44011.33982990322, 45022.77488612536, 46134.76932615315, 56433.71783141058, 58481.70759146177, 60904.25930833034, 60959.0, 61588.69205654122, 5674.120511320752, 5942.64344139353, 8496.362772791941, 8596.339925322782, 8709.477431354138, 9113.906331240294, 10950.233483656068, 12662.176958497668, 12675.985921126472, 12740.235585864877, 11188.66434006981, 12013.519459221534, 12216.328101954477, 12229.205101668364, 12376.319302438453, 11002.614908478165, 11502.597409090642, 12189.390530473263, 12222.572209972608, 12541.74916501683, 12450.439730211981, 12461.252324860538, 12463.127581069239, 12508.186312984384, 12589.559365422167, 8714.825703486022, 8855.512946787989, 8915.42049766763, 8918.152775486318, 8989.640414383352, 9161.221296189899, 12001.0, 12163.2702037878, 12249.571265005681, 12289.38553072325], "value": 9120.993138787762, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1289.684027413284, 1467.2956980649292, 1536.377767004363, 1641.9589510262242, 1796.4700413378043, 8414.116517765631, 8808.647654093837, 8857.247133993602, 9116.544172791351, 9152.588133534007, 8873.511956842387, 8885.68900088497, 8993.59528821203, 8994.0, 8996.415233009866, 2412.2401443545273, 2453.276283496364, 2455.2020593307157, 2458.2625212436287, 2459.2376363327335, 2369.0286982337243, 2371.1819422299277, 2378.4830932999334, 2378.5124049569795, 2381.130887226159, 2379.9881000594974, 2393.808495320379, 2404.230646193219, 2411.7949974252124, 2414.3239892829947, 2339.02930283932, 2365.042157926043, 2371.584972629783, 2376.702912135983, 2383.892724827387, 2296.644020176875, 2305.30840747775, 2311.6301391777233, 2312.4450131968206, 2314.36355002374, 8792.296616270683, 8929.241014513775, 8935.68725094625, 8984.056674049196, 9051.27589792815, 5352.812651557177, 5586.24585680932, 5590.580706447033, 5604.943950560483, 5605.047141985872, 3675.1547144156993, 3724.1248306647917, 3742.0644838790304, 3766.773993560395, 3782.8108594570162, 1211.6970757310673, 1212.7574485103014, 1219.7987332090195, 1255.2844878419305, 1255.7174635706892, 11813.704657383549, 11887.88112118885, 11888.10839187073, 11903.16677832552, 11906.821397679041, 4330.133973205371, 4556.703814252063, 4604.447466304065, 4619.745913974763, 4623.052274283764, 9458.148766611039, 9463.621455141718, 9467.195288400426, 9484.0, 9585.041495850359, 5263.7104959226845, 5280.102382594968, 5285.07511185541, 5290.259363689087, 5291.100512912814, 4092.508898932147, 4430.579094985971, 4570.314452832102, 4844.612431005511, 4899.118158731391, 3777.9244415112094, 3809.3714537101623, 3905.7656540607654, 3906.7069969751815, 3936.2127574485216, 1218.6405010521917, 1260.4517035089766, 1260.9117361784588, 1266.7909794883926, 1272.395612084271, 868.9572512984444, 897.3852910756153, 943.565959658551, 959.7264779537799, 966.4298064142049, 5401.189821526802, 5556.944430555724, 5797.710114494258, 6029.155918171459, 6112.449879510866, 467.86665800246766, 478.4330568276534, 483.92741088836254, 484.2179879494591, 486.0619005319767, 3979.263836190314, 4142.896427589274, 4146.357314616239, 4150.372334846685, 4158.708890377705, 11005.779884402427, 11205.831912521318, 11281.60514382009, 11304.208705390543, 11427.257228280136, 11214.383208923588, 11224.102071834233, 11256.887431125748, 11277.379744114152, 11289.71775705614, 8455.788605284917, 8530.445521041112, 8532.402731808837, 8533.871991920127, 8537.274331681876, 5807.157962095388, 5811.476967072984, 5965.105234214902, 5975.521958243243, 6077.51379889599, 10111.54498047575, 10295.330803497749, 10296.433696146783, 10302.381857088598, 10469.633562825264, 8993.0, 10632.52153653072, 10636.734081648021, 10643.467826608794, 10648.84026739584, 7204.423646108194, 7329.596872172082, 7409.592472414069, 7520.7367742130955, 7582.696692132253, 8745.125487451203, 8752.168543988311, 8814.118588141135, 8842.602082906156, 8917.197452229331, 7834.373250140089, 7918.762437126896, 7940.722074727357, 8016.7194148204535, 8125.79685507867, 7730.994970653779, 7829.725959591615, 7832.960835195788, 7839.216078392115, 7888.211178882066, 7189.352958233784, 7379.372753316028, 7429.851402972018, 7445.181030086578, 7449.0, 4950.504949505021, 4962.751862406937, 5241.292425522658, 5267.157254839208, 5321.866953326198, 5146.76839542229, 5199.66202196856, 5323.733813309396, 5343.332083489564, 5414.7021913795115], "value": 4605.686864684721, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.9903383278582, 337.4802803682329, 345.2387485594264, 346.9653034696529, 348.61129840228153, 5082.949170508303, 5244.580433565315, 5252.474752524746, 5292.338457692788, 5292.603054770893, 5203.4536373680785, 5207.895842083156, 5233.973830130844, 5261.2371206175085, 5263.894722105556, 4149.398337241106, 4173.520045194796, 4175.248455278049, 4180.226658068252, 4220.3036498977635, 4042.454268673721, 4184.267753143188, 4190.685698572604, 4200.978995105035, 4208.347706105543, 4160.958390416103, 4166.000159961603, 4169.62473377396, 4177.268977928866, 4188.1204946961025, 4151.858238984273, 4153.376993450976, 4158.0, 4172.603602657728, 4175.770332631704, 3630.3828349180703, 3729.9813500932323, 3749.981250093759, 3751.8686845960533, 3778.8677396290996, 5090.0, 5092.79628814847, 5107.974460127675, 5109.540141387293, 5113.954418232699, 4743.573078422924, 4751.904961900743, 4753.3582966299455, 4758.191107511731, 4758.2624693172265, 5346.786128554853, 5451.754671039813, 5455.972720136414, 5466.371367292772, 5495.2856128703415, 4070.674346052309, 4073.918521629551, 4075.510938687347, 4076.4700588923547, 4088.9164371441593, 5641.746121424505, 5653.660780353192, 5658.151277308354, 5674.631148975344, 5685.54515638752, 4029.536603290659, 4165.708400411942, 4205.76868272248, 4205.894852628648, 4213.1784302061415, 4280.67894907877, 4285.421468101767, 4286.971126929577, 4289.442372491556, 4290.0, 4763.333133361332, 4789.425268967746, 4791.6885402449425, 4811.350467686818, 4821.9035619287415, 5382.650127741685, 5443.755031023614, 5501.614886957875, 5599.80400685974, 5605.299337582802, 1378.2626294932163, 1429.1567974894863, 1431.0, 1457.8323492798463, 1459.6350912271932, 994.5474808961905, 1004.5027711282962, 1033.612395351743, 1036.984445233322, 1037.994810025945, 5238.68567885928, 5241.816536421207, 5244.842654720364, 5266.131088370376, 5275.947240527546, 5551.139573366135, 5555.944440555623, 5562.082256427725, 5572.3034620672415, 5634.32388113429, 5065.822696205689, 5157.510036546522, 5194.948050519522, 5286.259923610698, 5329.493698098752, 2549.515592037507, 2566.7561581649716, 2569.8435703933305, 2578.3296342950966, 2621.698504671987, 4993.6005119590345, 5016.598672106223, 5056.57019153376, 5070.112730272188, 5074.517920797518, 4972.627052971042, 4977.40271167455, 5397.379301380313, 5840.5035571976005, 5841.532677385799, 5809.82570522885, 5866.735996880066, 5877.676727779927, 5883.029185222998, 5907.291125064934, 5432.674039557639, 5704.8003319885265, 5731.140328950691, 5736.741846616829, 5752.367239603556, 5595.272614560081, 5626.88746225065, 5626.915596265977, 5645.802396916089, 5653.491185793298, 5838.299404071538, 5842.458530539229, 5855.238818953509, 5873.563965080476, 5935.34711181761, 3859.0, 4036.535798383106, 4092.9358366825436, 4099.692523060842, 4119.567445418308, 5365.678059316453, 5523.701930046355, 5581.469760372758, 5608.971955140199, 5635.408282130481, 5480.3971563128825, 5504.972475137599, 5516.117421212587, 5540.612157148961, 5552.305961754781, 5516.200150978166, 5520.503154716095, 5523.6685798852195, 5536.86157846041, 5540.22436858832, 5240.502152295526, 5416.83749487516, 5450.127979523416, 5466.753996070107, 5491.423400543045, 5565.30433695788, 5576.2676288619095, 5578.497935185853, 5582.385937546947, 5591.518247664291, 5222.843314700565, 5410.377806552139, 5444.863878403072, 5485.561155107502, 5490.423505531861], "value": 4207.714896662757, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [760.5094713909529, 769.0463824857179, 793.4842352470894, 836.2557323981662, 858.4934888415835, 15115.546533603996, 16195.514134575953, 16226.432074877383, 16252.0, 16293.511194664165, 15144.394224231046, 15296.388144474235, 15304.84695153051, 15313.693726125499, 15322.310496027678, 661.6526323680058, 789.4118881433311, 801.7755028591989, 805.556943680976, 806.753940048285, 827.0902007791442, 828.9129641387627, 831.3100126894693, 831.733845169546, 832.3258160889668, 873.5501216873315, 874.8731433942074, 874.9125087491263, 877.7103555826594, 877.784942689042, 708.355396589104, 865.1996902864856, 871.0331531999476, 878.1350369885657, 896.5472436419632, 611.6574718157846, 615.9106929495198, 616.7872084130968, 618.554640658725, 620.1163342237339, 14962.251887405586, 14965.102093874402, 14980.325885335185, 14984.100953942798, 14987.175705336202, 15228.847711522965, 15409.306581203873, 15455.845441545553, 15475.922620386938, 15505.457308994244, 13017.28404937728, 13095.214287142802, 13207.471701131943, 13218.206907585576, 13225.537106201236, 3972.803493275645, 3981.3231750602467, 3982.6415622594104, 3985.322495175827, 4036.4348991141264, 82381.0, 82770.0, 83699.0, 84260.57869710673, 89213.55393222993, 12099.637010889688, 12188.0, 12310.938445307716, 12334.136610437183, 12434.62696119118, 23913.282601521983, 24079.638805417933, 24110.87944560266, 24111.638325425134, 24237.0, 8184.2224988625985, 8517.44636598619, 8577.571121444027, 8995.145461181308, 9010.59452324647, 4662.696924699883, 4670.0, 4760.7619619018915, 4778.546038126373, 4834.758262086882, 3661.908452288714, 3781.3193625147187, 3782.867599634, 3783.394656854945, 3783.7729736215915, 613.6042252746953, 617.6664601115438, 618.3908849782961, 635.7457017193067, 637.486823107403, 606.254307202135, 627.1533429869639, 701.694762778183, 739.1721272175198, 756.1644382956863, 9451.527423628928, 9499.620015199453, 9740.220782337396, 9960.950195249123, 9993.650222242186, 695.3984803145344, 728.0753443127304, 737.6053811211084, 753.1865585168006, 776.7592046465613, 4644.164050470948, 4779.545943135397, 4780.163471392492, 4783.784729687172, 4799.512455853788, 72181.0, 72849.2715072853, 72939.0, 101123.0, 113990.86009139968, 107475.47671662908, 108246.45876770723, 110298.0, 112436.0, 114728.42635786935, 80487.59756201181, 81897.59051204706, 88771.22457550812, 98323.50838245905, 99185.50407247918, 9233.907660923305, 9483.28875334339, 9563.234941204548, 9586.520673966414, 9894.703158905244, 52734.20898686446, 53634.463655362946, 54299.0, 54904.450955491535, 54918.725406372716, 69426.305736944, 71372.0, 77938.2206177931, 78276.0, 86855.56572217098, 12269.561248586284, 12620.053495987653, 12769.8084528734, 12830.486780528674, 13190.472381104648, 14832.777508337167, 14874.405023798927, 15016.924915375354, 15024.399024038916, 15629.609259768142, 14255.714885702435, 14352.712945741236, 14926.552203433914, 14977.176255306063, 15530.068195908281, 14298.857011429753, 14406.927965360106, 14427.42290308376, 14848.62878428048, 15363.61590960235, 14144.22206778637, 14245.572632821031, 14501.78247326312, 14585.197814119902, 15169.696606068037, 11437.199396042197, 11617.6514704559, 11657.475413606579, 11717.453855715728, 12109.152359335114, 11110.500027498943, 11441.256318339281, 11488.865175374827, 11686.94156529212, 11841.0], "value": 7764.429162418462, "unit": "score"}], "name": "dromaeo_css", "value": 7231.106323759691, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 110.0, 113.0, 112.0, 111.0, 110.0, 111.0, 110.0, 110.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 118.0, 119.0, 188.0, 119.0, 121.0, 150.0, 118.0, 147.0, 122.0], "value": 134.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 160.0, 161.0, 160.0, 162.0, 159.0, 160.0, 161.0, 161.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 75.0, 112.0, 75.0, 75.0, 74.0, 74.0, 103.0, 75.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 127.0, 84.0, 83.0, 85.0, 128.0, 84.0, 83.0, 133.0], "value": 97.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 49.0, 50.0, 50.0, 51.0, 51.0, 50.0, 50.0, 50.0], "value": 50.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 60.0, 60.0, 59.0, 60.0, 60.0, 60.0, 61.0, 60.0], "value": 60.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 77.0, 78.0, 76.0, 76.0, 75.0, 78.0, 85.0, 82.0, 75.0], "value": 78.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 120.0, 121.0, 124.0, 120.0, 130.0, 120.0, 125.0, 158.0, 136.0], "value": 127.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 161.0, 165.0, 163.0, 160.0, 161.0, 162.0, 159.0, 160.0, 160.0], "value": 161.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 63.0, 64.0, 63.0, 63.0, 63.0, 69.0, 63.0], "value": 63.9, "unit": "score"}], "name": "kraken", "value": 1483.9999999999998, "alertThreshold": 2.0}]} 06:10:42 INFO - Return code: 0 06:10:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:10:42 INFO - # TBPL SUCCESS # 06:10:42 INFO - Running post-action listener: _resource_record_post_action 06:10:42 INFO - [mozharness: 2016-08-03 13:10:42.801983Z] Finished run-tests step (success) 06:10:42 INFO - Running post-run listener: _resource_record_post_run 06:10:42 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 7708672; Write bytes: 420941824; Read time: 1696; Write time: 466200 06:10:42 INFO - TinderboxPrint: CPU usage
13.0% 06:10:42 INFO - TinderboxPrint: I/O read bytes / time
7,708,672 / 1,696 06:10:42 INFO - TinderboxPrint: I/O write bytes / time
420,941,824 / 466,200 06:10:42 INFO - TinderboxPrint: CPU idle
8,303.5 (87.0%) 06:10:42 INFO - TinderboxPrint: CPU user
1,193.1 (12.5%) 06:10:42 INFO - TinderboxPrint: Swap in / out
0 / 0 06:10:42 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 59142144; Read time: 184; Write time: 33844 06:10:42 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 5513216; Write bytes: 328785920; Read time: 1016; Write time: 371376 06:10:43 INFO - Running post-run listener: _upload_blobber_files 06:10:43 INFO - Blob upload gear active. 06:10:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:10:43 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 06:10:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:10:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:10:44 INFO - (blobuploader) - INFO - Open directory for files ... 06:10:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:10:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:10:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:10:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:10:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:10:49 INFO - (blobuploader) - INFO - Done attempting. 06:10:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:10:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:10:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:10:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:10:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:10:50 INFO - (blobuploader) - INFO - Done attempting. 06:10:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:10:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:10:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:10:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:10:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:10:51 INFO - (blobuploader) - INFO - Done attempting. 06:10:51 INFO - (blobuploader) - INFO - Iteration through files over. 06:10:51 INFO - Return code: 0 06:10:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:10:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:10:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ac43587c4538439cd013b1cb5cc78bc65b291e77f86d9743aa838da6b746429e9f9f5ffd522fbbd29af8b4d6e5023ddc9be063de5cb219ae99a675cb7442016", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f17d80fe063d0d807a0586aae7e085c39d32aa9ae5fa2a47a31149480e93380a1b322f955f83c505d09b7e3c0f03d24ee6ed6eb9b763da091d8a3ff015306348", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2aef9eaa69269350c4b004742c3aec56afb828f4de4812690899b892a0e35fbcd895dd49d96fcc4a561d9be2457cf246bc83cb3f5ff7ac9ce835f8f6aad2d7ef"} 06:10:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:10:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:10:51 INFO - Contents: 06:10:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ac43587c4538439cd013b1cb5cc78bc65b291e77f86d9743aa838da6b746429e9f9f5ffd522fbbd29af8b4d6e5023ddc9be063de5cb219ae99a675cb7442016", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f17d80fe063d0d807a0586aae7e085c39d32aa9ae5fa2a47a31149480e93380a1b322f955f83c505d09b7e3c0f03d24ee6ed6eb9b763da091d8a3ff015306348", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2aef9eaa69269350c4b004742c3aec56afb828f4de4812690899b892a0e35fbcd895dd49d96fcc4a561d9be2457cf246bc83cb3f5ff7ac9ce835f8f6aad2d7ef"} 06:10:51 INFO - Running post-run listener: copy_logs_to_upload_dir 06:10:51 INFO - Copying logs to upload dir... 06:10:51 INFO - mkdir: /builds/slave/test/build/upload/logs 06:10:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.013174 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-08-03 06:10:51.436677) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-03 06:10:51.440691) ========= 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=fa44defc139c4ba8574fe040000001db-1470227305.158810-935586441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ac43587c4538439cd013b1cb5cc78bc65b291e77f86d9743aa838da6b746429e9f9f5ffd522fbbd29af8b4d6e5023ddc9be063de5cb219ae99a675cb7442016", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f17d80fe063d0d807a0586aae7e085c39d32aa9ae5fa2a47a31149480e93380a1b322f955f83c505d09b7e3c0f03d24ee6ed6eb9b763da091d8a3ff015306348", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2aef9eaa69269350c4b004742c3aec56afb828f4de4812690899b892a0e35fbcd895dd49d96fcc4a561d9be2457cf246bc83cb3f5ff7ac9ce835f8f6aad2d7ef"} build_url:https://queue.taskcluster.net/v1/task/DnRNppcuSFqs8f3Yb-tdog/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011164 build_url: 'https://queue.taskcluster.net/v1/task/DnRNppcuSFqs8f3Yb-tdog/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ac43587c4538439cd013b1cb5cc78bc65b291e77f86d9743aa838da6b746429e9f9f5ffd522fbbd29af8b4d6e5023ddc9be063de5cb219ae99a675cb7442016", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f17d80fe063d0d807a0586aae7e085c39d32aa9ae5fa2a47a31149480e93380a1b322f955f83c505d09b7e3c0f03d24ee6ed6eb9b763da091d8a3ff015306348", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2aef9eaa69269350c4b004742c3aec56afb828f4de4812690899b892a0e35fbcd895dd49d96fcc4a561d9be2457cf246bc83cb3f5ff7ac9ce835f8f6aad2d7ef"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-03 06:10:51.466713) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 06:10:51.467063) ========= 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=fa44defc139c4ba8574fe040000001db-1470227305.158810-935586441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004444 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 06:10:51.550341) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-03 06:10:51.550750) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-03 06:10:51.551293) ========= ========= Total master_lag: 0.21 =========