builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-019 starttime: 1470231060.29 results: success (0) buildid: 20160803051341 builduid: deb2f26910db4cadade72f6c0bacb25a revision: 8ab41761981936b5fb655e07f4d0d725ea514905 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-03 06:31:00.287564) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-03 06:31:00.288017) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-03 06:31:00.288557) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-03 06:31:00.360924) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 06:31:00.361259) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1470229579.484617-765975799 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-03 06:31: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% 42.9M=0s 2016-08-03 06:31:00 (42.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.106412 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 06:31:00.497158) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 06:31:00.500483) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1470229579.484617-765975799 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021030 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 06:31:00.549631) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 06:31:00.549945) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8ab41761981936b5fb655e07f4d0d725ea514905 --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 8ab41761981936b5fb655e07f4d0d725ea514905 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1470229579.484617-765975799 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-03 06:31:00,682 truncating revision to first 12 chars 2016-08-03 06:31:00,682 Setting DEBUG logging. 2016-08-03 06:31:00,682 attempt 1/10 2016-08-03 06:31:00,682 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8ab417619819?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-03 06:31:00,998 unpacking tar archive at: mozilla-central-8ab417619819/testing/mozharness/ program finished with exit code 0 elapsedTime=0.639198 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 06:31:01.218556) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-03 06:31:01.218827) ========= script_repo_revision: 8ab41761981936b5fb655e07f4d0d725ea514905 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-03 06:31:01.219186) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-03 06:31:01.222632) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-03 06:31:01.236359) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-08-03 06:31:01.236629) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1470229579.484617-765975799 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:31:01 INFO - MultiFileLogger online at 20160803 06:31:01 in /builds/slave/test 06:31:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 06:31:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:31:01 INFO - {'append_to_log': False, 06:31:01 INFO - 'base_work_dir': '/builds/slave/test', 06:31:01 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 06:31:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:31:01 INFO - 'branch': 'Firefox-Non-PGO', 06:31:01 INFO - 'buildbot_json_path': 'buildprops.json', 06:31:01 INFO - 'config_files': ('talos/linux_config.py',), 06:31:01 INFO - 'default_actions': ('clobber', 06:31:01 INFO - 'read-buildbot-config', 06:31:01 INFO - 'download-and-extract', 06:31:01 INFO - 'populate-webroot', 06:31:01 INFO - 'create-virtualenv', 06:31:01 INFO - 'install', 06:31:01 INFO - 'run-tests'), 06:31:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:31:01 INFO - 'download_minidump_stackwalk': True, 06:31:01 INFO - 'download_symbols': 'ondemand', 06:31:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:31:01 INFO - 'tooltool.py': '/tools/tooltool.py', 06:31:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:31:01 INFO - '/tools/misc-python/virtualenv.py')}, 06:31:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:31:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:31:01 INFO - 'installer_path': 'installer.exe', 06:31:01 INFO - 'log_level': 'info', 06:31:01 INFO - 'log_name': 'talos', 06:31:01 INFO - 'log_to_console': True, 06:31:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:31:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:31:01 INFO - 'opt_config_files': (), 06:31:01 INFO - 'pip_index': False, 06:31:01 INFO - 'sps_profile': False, 06:31:01 INFO - 'sps_profile_interval': 0, 06:31:01 INFO - 'suite': 'dromaeojs', 06:31:01 INFO - 'system_bits': '32', 06:31:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:31:01 INFO - 'title': 'talos-linux64-ix-019', 06:31:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:31:01 INFO - 'use_talos_json': True, 06:31:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:31:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:31:01 INFO - 'work_dir': 'build'} 06:31:01 INFO - [mozharness: 2016-08-03 13:31:01.458547Z] Running clobber step. 06:31:01 INFO - Running pre-action listener: _resource_record_pre_action 06:31:01 INFO - Running main action method: clobber 06:31:01 INFO - rmtree: /builds/slave/test/build 06:31:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:31:02 INFO - Running post-action listener: _resource_record_post_action 06:31:02 INFO - [mozharness: 2016-08-03 13:31:02.418403Z] Finished clobber step (success) 06:31:02 INFO - [mozharness: 2016-08-03 13:31:02.418504Z] Running read-buildbot-config step. 06:31:02 INFO - Running pre-action listener: _resource_record_pre_action 06:31:02 INFO - Running main action method: read_buildbot_config 06:31:02 INFO - Using buildbot properties: 06:31:02 INFO - { 06:31:02 INFO - "project": "", 06:31:02 INFO - "product": "firefox", 06:31:02 INFO - "script_repo_revision": "production", 06:31:02 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 06:31:02 INFO - "repository": "", 06:31:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 06:31:02 INFO - "buildid": "20160803051341", 06:31:02 INFO - "pgo_build": "False", 06:31:02 INFO - "basedir": "/builds/slave/test", 06:31:02 INFO - "buildnumber": 172, 06:31:02 INFO - "slavename": "talos-linux64-ix-019", 06:31:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:31:02 INFO - "platform": "ubuntu64_hw", 06:31:02 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 06:31:02 INFO - "branch": "mozilla-central", 06:31:02 INFO - "repo_path": "mozilla-central", 06:31:02 INFO - "revision": "8ab41761981936b5fb655e07f4d0d725ea514905", 06:31:02 INFO - "stage_platform": "linux64", 06:31:02 INFO - "builduid": "deb2f26910db4cadade72f6c0bacb25a", 06:31:02 INFO - "slavebuilddir": "test" 06:31:02 INFO - } 06:31:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/dxXKQZotRC--0uAvWQi4lA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 06:31:02 INFO - Running post-action listener: _resource_record_post_action 06:31:02 INFO - [mozharness: 2016-08-03 13:31:02.420917Z] Finished read-buildbot-config step (success) 06:31:02 INFO - [mozharness: 2016-08-03 13:31:02.421004Z] Running download-and-extract step. 06:31:02 INFO - Running pre-action listener: _resource_record_pre_action 06:31:02 INFO - Running main action method: download_and_extract 06:31:02 INFO - mkdir: /builds/slave/test/build/tests 06:31: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')]} 06:31:02 INFO - https://queue.taskcluster.net/v1/task/dxXKQZotRC--0uAvWQi4lA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:31:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxXKQZotRC--0uAvWQi4lA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 06:31:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxXKQZotRC--0uAvWQi4lA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 06:31:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxXKQZotRC--0uAvWQi4lA/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 06:31:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxXKQZotRC--0uAvWQi4lA/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 06:31:07 INFO - Downloaded 1361 bytes. 06:31:07 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 06:31:07 INFO - Using the following test package requirements: 06:31:07 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 06:31:07 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:31:07 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:31:07 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:31:07 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:31:07 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:31:07 INFO - u'jsshell-linux-x86_64.zip'], 06:31:07 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:31:07 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:31:07 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 06:31:07 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:31:07 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:31:07 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:31:07 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:31:07 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:31:07 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:31:07 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:31:07 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:31:07 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:31:07 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')]} 06:31:07 INFO - https://queue.taskcluster.net/v1/task/dxXKQZotRC--0uAvWQi4lA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:31:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxXKQZotRC--0uAvWQi4lA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 06:31:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxXKQZotRC--0uAvWQi4lA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 06:31:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxXKQZotRC--0uAvWQi4lA/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 06:31:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxXKQZotRC--0uAvWQi4lA/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 06:31:12 INFO - Downloaded 20239189 bytes. 06:31:12 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'] 06:31:12 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 06:31:14 INFO - Return code: 0 06:31:14 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 06:31:14 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')]} 06:31:14 INFO - https://queue.taskcluster.net/v1/task/dxXKQZotRC--0uAvWQi4lA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:31:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxXKQZotRC--0uAvWQi4lA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 06:31:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxXKQZotRC--0uAvWQi4lA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 06:31:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxXKQZotRC--0uAvWQi4lA/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 06:31:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxXKQZotRC--0uAvWQi4lA/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 06:31:15 INFO - Downloaded 20239189 bytes. 06:31:15 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'] 06:31:15 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 06:31:16 INFO - Return code: 0 06:31: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')]} 06:31:16 INFO - https://queue.taskcluster.net/v1/task/dxXKQZotRC--0uAvWQi4lA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:31:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxXKQZotRC--0uAvWQi4lA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 06:31:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxXKQZotRC--0uAvWQi4lA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 06:31:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxXKQZotRC--0uAvWQi4lA/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 06:31:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxXKQZotRC--0uAvWQi4lA/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 06:31:17 INFO - Downloaded 14413723 bytes. 06:31:17 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'] 06:31:17 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 06:31:18 INFO - Return code: 0 06:31: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')]} 06:31:18 INFO - https://queue.taskcluster.net/v1/task/dxXKQZotRC--0uAvWQi4lA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:31:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxXKQZotRC--0uAvWQi4lA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 06:31:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxXKQZotRC--0uAvWQi4lA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 06:31:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxXKQZotRC--0uAvWQi4lA/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 06:31:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxXKQZotRC--0uAvWQi4lA/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 06:31:19 INFO - Downloaded 55702781 bytes. 06:31:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dxXKQZotRC--0uAvWQi4lA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 06:31:19 INFO - mkdir: /builds/slave/test/properties 06:31:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:31:19 INFO - Writing to file /builds/slave/test/properties/build_url 06:31:19 INFO - Contents: 06:31:19 INFO - build_url:https://queue.taskcluster.net/v1/task/dxXKQZotRC--0uAvWQi4lA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 06:31:19 INFO - Running post-action listener: _resource_record_post_action 06:31:19 INFO - Running post-action listener: set_extra_try_arguments 06:31:19 INFO - [mozharness: 2016-08-03 13:31:19.953692Z] Finished download-and-extract step (success) 06:31:19 INFO - [mozharness: 2016-08-03 13:31:19.953953Z] Running populate-webroot step. 06:31:19 INFO - Running pre-action listener: _resource_record_pre_action 06:31:19 INFO - Running main action method: populate_webroot 06:31:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:31:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:31:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:31:19 INFO - '--tppagecycles', 06:31:19 INFO - '7'], 06:31:19 INFO - 'tests': ['tsvgm']}}, 06:31:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:31:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:31:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:31:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:31:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:31:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:31:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:31:19 INFO - 'talos_options': ['--disable-e10s'], 06:31:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:31:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:31:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:31:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:31:19 INFO - 'talos_options': ['--disable-e10s'], 06:31:19 INFO - 'tests': ['damp', 'tps']}, 06:31:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:31:19 INFO - 'tests': ['damp', 'tps']}, 06:31:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:31:19 INFO - 'tests': ['dromaeo_dom']}, 06:31:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:31:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:31:19 INFO - 'tests': ['basic_compositor_video']}, 06:31:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:31:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:31:19 INFO - 'tests': ['a11yr', 06:31:19 INFO - 'ts_paint', 06:31:19 INFO - 'tpaint', 06:31:19 INFO - 'sessionrestore', 06:31:19 INFO - 'sessionrestore_no_auto_restore', 06:31:19 INFO - 'tabpaint']}, 06:31:19 INFO - 'other-e10s': {'tests': ['a11yr', 06:31:19 INFO - 'ts_paint', 06:31:19 INFO - 'tpaint', 06:31:19 INFO - 'sessionrestore', 06:31:19 INFO - 'sessionrestore_no_auto_restore', 06:31:19 INFO - 'tabpaint']}, 06:31:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:31:19 INFO - 'ts_paint', 06:31:19 INFO - 'tpaint', 06:31:19 INFO - 'sessionrestore', 06:31:19 INFO - 'sessionrestore_no_auto_restore', 06:31:19 INFO - 'tabpaint']}, 06:31:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:31:19 INFO - 'ts_paint', 06:31:19 INFO - 'tpaint', 06:31:19 INFO - 'sessionrestore', 06:31:19 INFO - 'sessionrestore_no_auto_restore', 06:31:19 INFO - 'tabpaint']}, 06:31:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:31:19 INFO - 'tests': ['a11yr', 06:31:19 INFO - 'ts_paint', 06:31:19 INFO - 'tpaint', 06:31:19 INFO - 'sessionrestore', 06:31:19 INFO - 'sessionrestore_no_auto_restore', 06:31:19 INFO - 'tabpaint']}, 06:31:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:31:19 INFO - 'tests': ['a11yr', 06:31:19 INFO - 'ts_paint', 06:31:19 INFO - 'tpaint', 06:31:19 INFO - 'sessionrestore', 06:31:19 INFO - 'sessionrestore_no_auto_restore', 06:31:19 INFO - 'tabpaint']}, 06:31:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:31:19 INFO - 'tests': ['tsvgx', 06:31:19 INFO - 'tsvgr_opacity', 06:31:19 INFO - 'tart', 06:31:19 INFO - 'tscrollx', 06:31:19 INFO - 'cart']}, 06:31:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:31:19 INFO - 'tsvgr_opacity', 06:31:19 INFO - 'tart', 06:31:19 INFO - 'tscrollx', 06:31:19 INFO - 'cart']}, 06:31:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:31:19 INFO - 'talos_options': ['--disable-e10s'], 06:31:19 INFO - 'tests': ['tp5o']}, 06:31:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:31:19 INFO - 'tests': ['tp5o']}, 06:31:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:31:19 INFO - 'talos_options': ['--disable-e10s', 06:31:19 INFO - '--xperf_path', 06:31:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:31:19 INFO - 'tests': ['tp5n']}, 06:31:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:31:19 INFO - 'talos_options': ['--xperf_path', 06:31:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:31:19 INFO - 'tests': ['tp5n']}}, 06:31:19 INFO - 'talos.zip': {'path': '', 06:31:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:31:19 INFO - Running post-action listener: _resource_record_post_action 06:31:19 INFO - [mozharness: 2016-08-03 13:31:19.972371Z] Finished populate-webroot step (success) 06:31:19 INFO - [mozharness: 2016-08-03 13:31:19.972459Z] Running create-virtualenv step. 06:31:19 INFO - Running pre-action listener: _resource_record_pre_action 06:31:19 INFO - Running main action method: create_virtualenv 06:31:19 INFO - Creating virtualenv /builds/slave/test/build/venv 06:31:19 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 06:31:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:31:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:31:20 INFO - Using real prefix '/usr' 06:31:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:31:20 INFO - Installing distribute.............................................................................................................................................................................................done. 06:31:22 INFO - Installing pip.................done. 06:31:22 INFO - Return code: 0 06:31:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:31:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:31:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:31:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d61030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2022180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20203b0>, '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 0x20212b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2021740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470229579.484617-765975799', '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 06:31:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:31:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:31:22 INFO - Using env: {'DISPLAY': ':0', 06:31:22 INFO - 'HOME': '/home/cltbld', 06:31:22 INFO - 'LANG': 'en_US.UTF-8', 06:31:22 INFO - 'LANGUAGE': 'en_US:en', 06:31:22 INFO - 'LOGNAME': 'cltbld', 06:31:22 INFO - 'MAIL': '/var/mail/cltbld', 06:31:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:22 INFO - 'MOZ_NO_REMOTE': '1', 06:31:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:22 INFO - 'NO_EM_RESTART': '1', 06:31:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:22 INFO - 'PWD': '/builds/slave/test', 06:31:22 INFO - 'SHELL': '/bin/bash', 06:31:22 INFO - 'SHLVL': '1', 06:31:22 INFO - 'TERM': 'linux', 06:31:22 INFO - 'TMOUT': '86400', 06:31:22 INFO - 'USER': 'cltbld', 06:31:22 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470229579.484617-765975799', 06:31:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:22 INFO - '_': '/tools/buildbot/bin/python'} 06:31:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:22 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:31:22 INFO - Cleaning up... 06:31:22 INFO - Return code: 0 06:31:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:31:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:31:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:31:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d61030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2022180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20203b0>, '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 0x20212b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2021740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470229579.484617-765975799', '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 06:31:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:31:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:31:22 INFO - Using env: {'DISPLAY': ':0', 06:31:22 INFO - 'HOME': '/home/cltbld', 06:31:22 INFO - 'LANG': 'en_US.UTF-8', 06:31:22 INFO - 'LANGUAGE': 'en_US:en', 06:31:22 INFO - 'LOGNAME': 'cltbld', 06:31:22 INFO - 'MAIL': '/var/mail/cltbld', 06:31:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:22 INFO - 'MOZ_NO_REMOTE': '1', 06:31:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:22 INFO - 'NO_EM_RESTART': '1', 06:31:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:22 INFO - 'PWD': '/builds/slave/test', 06:31:22 INFO - 'SHELL': '/bin/bash', 06:31:22 INFO - 'SHLVL': '1', 06:31:22 INFO - 'TERM': 'linux', 06:31:22 INFO - 'TMOUT': '86400', 06:31:22 INFO - 'USER': 'cltbld', 06:31:22 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470229579.484617-765975799', 06:31:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:22 INFO - '_': '/tools/buildbot/bin/python'} 06:31:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:22 INFO - Downloading/unpacking psutil>=3.1.1 06:31:22 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 06:31:22 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 06:31:22 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 06:31:22 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 06:31:22 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 06:31:22 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 06:31:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:31:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:31:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:31:24 INFO - Installing collected packages: psutil 06:31:24 INFO - Running setup.py install for psutil 06:31:25 INFO - building 'psutil._psutil_linux' extension 06:31:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:31:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:31:25 INFO - building 'psutil._psutil_posix' extension 06:31:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:31:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:31:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:31:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:31:25 INFO - Successfully installed psutil 06:31:25 INFO - Cleaning up... 06:31:25 INFO - Return code: 0 06:31:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:31: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')]} 06:31:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31: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')]} 06:31:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d61030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2022180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20203b0>, '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 0x20212b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2021740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470229579.484617-765975799', '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 06:31:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:31:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:31:25 INFO - Using env: {'DISPLAY': ':0', 06:31:25 INFO - 'HOME': '/home/cltbld', 06:31:25 INFO - 'LANG': 'en_US.UTF-8', 06:31:25 INFO - 'LANGUAGE': 'en_US:en', 06:31:25 INFO - 'LOGNAME': 'cltbld', 06:31:25 INFO - 'MAIL': '/var/mail/cltbld', 06:31:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:25 INFO - 'MOZ_NO_REMOTE': '1', 06:31:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:25 INFO - 'NO_EM_RESTART': '1', 06:31:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:25 INFO - 'PWD': '/builds/slave/test', 06:31:25 INFO - 'SHELL': '/bin/bash', 06:31:25 INFO - 'SHLVL': '1', 06:31:25 INFO - 'TERM': 'linux', 06:31:25 INFO - 'TMOUT': '86400', 06:31:25 INFO - 'USER': 'cltbld', 06:31:25 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470229579.484617-765975799', 06:31:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:25 INFO - '_': '/tools/buildbot/bin/python'} 06:31:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:31: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 06:31: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 06:31: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 06:31: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 06:31: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 06:31: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 06:31:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:31:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:31:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:31:27 INFO - Installing collected packages: mozsystemmonitor 06:31:27 INFO - Running setup.py install for mozsystemmonitor 06:31:27 INFO - Successfully installed mozsystemmonitor 06:31:27 INFO - Cleaning up... 06:31:27 INFO - Return code: 0 06:31:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:31:27 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')]} 06:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:27 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')]} 06:31:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:27 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 0x1d61030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2022180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20203b0>, '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 0x20212b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2021740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470229579.484617-765975799', '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 06:31:27 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 06:31:27 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 06:31:27 INFO - Using env: {'DISPLAY': ':0', 06:31:27 INFO - 'HOME': '/home/cltbld', 06:31:27 INFO - 'LANG': 'en_US.UTF-8', 06:31:27 INFO - 'LANGUAGE': 'en_US:en', 06:31:27 INFO - 'LOGNAME': 'cltbld', 06:31:27 INFO - 'MAIL': '/var/mail/cltbld', 06:31:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:27 INFO - 'MOZ_NO_REMOTE': '1', 06:31:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:27 INFO - 'NO_EM_RESTART': '1', 06:31:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:27 INFO - 'PWD': '/builds/slave/test', 06:31:27 INFO - 'SHELL': '/bin/bash', 06:31:27 INFO - 'SHLVL': '1', 06:31:27 INFO - 'TERM': 'linux', 06:31:27 INFO - 'TMOUT': '86400', 06:31:27 INFO - 'USER': 'cltbld', 06:31:27 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470229579.484617-765975799', 06:31:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:27 INFO - '_': '/tools/buildbot/bin/python'} 06:31:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:28 INFO - Downloading/unpacking jsonschema==2.5.1 06:31:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:31:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:31:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:31:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:31:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:31:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:31:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:31:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:31: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 06:31: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 06:31: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 06:31: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 06:31: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 06:31: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 06:31:30 INFO - Downloading functools32-3.2.3-2.tar.gz 06:31:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:31:30 INFO - warning: no files found matching '*.txt' 06:31:30 INFO - no previously-included directories found matching 'build' 06:31:30 INFO - no previously-included directories found matching 'dist' 06:31:30 INFO - no previously-included directories found matching '.git*' 06:31:30 INFO - Installing collected packages: jsonschema, functools32 06:31:30 INFO - Running setup.py install for functools32 06:31:30 INFO - warning: no files found matching '*.txt' 06:31:30 INFO - no previously-included directories found matching 'build' 06:31:30 INFO - no previously-included directories found matching 'dist' 06:31:30 INFO - no previously-included directories found matching '.git*' 06:31:30 INFO - Successfully installed jsonschema functools32 06:31:30 INFO - Cleaning up... 06:31:30 INFO - Return code: 0 06:31:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:31:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:31:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:31:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d61030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2022180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20203b0>, '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 0x20212b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2021740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470229579.484617-765975799', '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 06:31:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:31:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:31:30 INFO - Using env: {'DISPLAY': ':0', 06:31:30 INFO - 'HOME': '/home/cltbld', 06:31:30 INFO - 'LANG': 'en_US.UTF-8', 06:31:30 INFO - 'LANGUAGE': 'en_US:en', 06:31:30 INFO - 'LOGNAME': 'cltbld', 06:31:30 INFO - 'MAIL': '/var/mail/cltbld', 06:31:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:30 INFO - 'MOZ_NO_REMOTE': '1', 06:31:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:30 INFO - 'NO_EM_RESTART': '1', 06:31:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:30 INFO - 'PWD': '/builds/slave/test', 06:31:30 INFO - 'SHELL': '/bin/bash', 06:31:30 INFO - 'SHLVL': '1', 06:31:30 INFO - 'TERM': 'linux', 06:31:30 INFO - 'TMOUT': '86400', 06:31:30 INFO - 'USER': 'cltbld', 06:31:30 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470229579.484617-765975799', 06:31:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:30 INFO - '_': '/tools/buildbot/bin/python'} 06:31:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:31:30 INFO - Cleaning up... 06:31:30 INFO - Return code: 0 06:31:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:31:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:31:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:31:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d61030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2022180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20203b0>, '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 0x20212b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2021740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470229579.484617-765975799', '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 06:31:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:31:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:31:30 INFO - Using env: {'DISPLAY': ':0', 06:31:30 INFO - 'HOME': '/home/cltbld', 06:31:30 INFO - 'LANG': 'en_US.UTF-8', 06:31:30 INFO - 'LANGUAGE': 'en_US:en', 06:31:30 INFO - 'LOGNAME': 'cltbld', 06:31:30 INFO - 'MAIL': '/var/mail/cltbld', 06:31:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:30 INFO - 'MOZ_NO_REMOTE': '1', 06:31:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:30 INFO - 'NO_EM_RESTART': '1', 06:31:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:30 INFO - 'PWD': '/builds/slave/test', 06:31:30 INFO - 'SHELL': '/bin/bash', 06:31:30 INFO - 'SHLVL': '1', 06:31:30 INFO - 'TERM': 'linux', 06:31:30 INFO - 'TMOUT': '86400', 06:31:30 INFO - 'USER': 'cltbld', 06:31:30 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470229579.484617-765975799', 06:31:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:30 INFO - '_': '/tools/buildbot/bin/python'} 06:31:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:30 INFO - Downloading/unpacking blobuploader==1.2.4 06:31:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:31:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:31:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:31:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:31:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:31:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:31:32 INFO - Downloading blobuploader-1.2.4.tar.gz 06:31:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:31:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:31: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 06:31: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 06:31: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 06:31: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 06:31: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 06:31: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 06:31:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:31:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:31:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:31:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:31:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:31:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:31:33 INFO - Downloading docopt-0.6.1.tar.gz 06:31:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:31:33 INFO - Installing collected packages: blobuploader, requests, docopt 06:31:33 INFO - Running setup.py install for blobuploader 06:31:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:31:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:31:33 INFO - Running setup.py install for requests 06:31:33 INFO - Running setup.py install for docopt 06:31:34 INFO - Successfully installed blobuploader requests docopt 06:31:34 INFO - Cleaning up... 06:31:34 INFO - Return code: 0 06:31:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:31: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')]} 06:31:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31: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')]} 06:31:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d61030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2022180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20203b0>, '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 0x20212b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2021740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470229579.484617-765975799', '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 06:31:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:31:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:31:34 INFO - Using env: {'DISPLAY': ':0', 06:31:34 INFO - 'HOME': '/home/cltbld', 06:31:34 INFO - 'LANG': 'en_US.UTF-8', 06:31:34 INFO - 'LANGUAGE': 'en_US:en', 06:31:34 INFO - 'LOGNAME': 'cltbld', 06:31:34 INFO - 'MAIL': '/var/mail/cltbld', 06:31:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:34 INFO - 'MOZ_NO_REMOTE': '1', 06:31:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:34 INFO - 'NO_EM_RESTART': '1', 06:31:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:34 INFO - 'PWD': '/builds/slave/test', 06:31:34 INFO - 'SHELL': '/bin/bash', 06:31:34 INFO - 'SHLVL': '1', 06:31:34 INFO - 'TERM': 'linux', 06:31:34 INFO - 'TMOUT': '86400', 06:31:34 INFO - 'USER': 'cltbld', 06:31:34 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470229579.484617-765975799', 06:31:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:34 INFO - '_': '/tools/buildbot/bin/python'} 06:31:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:31:34 INFO - Running setup.py (path:/tmp/pip-StBb70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:31:34 INFO - Running setup.py (path:/tmp/pip-TKLdtU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:31:34 INFO - Running setup.py (path:/tmp/pip-NLChvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:31:34 INFO - Running setup.py (path:/tmp/pip-E42x5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:31:34 INFO - Running setup.py (path:/tmp/pip-slsPlK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:31:34 INFO - Running setup.py (path:/tmp/pip-sEvpvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:31:34 INFO - Running setup.py (path:/tmp/pip-6urOZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:31:34 INFO - Running setup.py (path:/tmp/pip-1aWwHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:31:34 INFO - Running setup.py (path:/tmp/pip-VTqCyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:31:34 INFO - Running setup.py (path:/tmp/pip-jMsrU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:31:35 INFO - Running setup.py (path:/tmp/pip-qoV6_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:31:35 INFO - Running setup.py (path:/tmp/pip-4R3ElK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:31:35 INFO - Running setup.py (path:/tmp/pip-Srq2d0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:31:35 INFO - Running setup.py (path:/tmp/pip-1smmYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:31:35 INFO - Running setup.py (path:/tmp/pip-yl4yLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:31:35 INFO - Running setup.py (path:/tmp/pip-BRRYQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:31:35 INFO - Running setup.py (path:/tmp/pip-SYmBem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:31:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:31:35 INFO - Running setup.py install for manifestparser 06:31:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:31:35 INFO - Running setup.py install for mozcrash 06:31:35 INFO - Running setup.py install for mozdebug 06:31:35 INFO - Running setup.py install for mozdevice 06:31:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:31:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:31:35 INFO - Running setup.py install for mozfile 06:31:36 INFO - Running setup.py install for mozhttpd 06:31:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:31:36 INFO - Running setup.py install for mozinfo 06:31:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:31:36 INFO - Running setup.py install for mozInstall 06:31:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:31:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:31:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:31:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:31:36 INFO - Running setup.py install for mozleak 06:31:36 INFO - Running setup.py install for mozlog 06:31:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:31:36 INFO - Running setup.py install for moznetwork 06:31:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:31:36 INFO - Running setup.py install for mozprocess 06:31:36 INFO - Running setup.py install for mozprofile 06:31:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:31:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:31:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:31:36 INFO - Running setup.py install for mozrunner 06:31:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:31:37 INFO - Running setup.py install for mozscreenshot 06:31:37 INFO - Running setup.py install for moztest 06:31:37 INFO - Running setup.py install for mozversion 06:31:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:31:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:31:37 INFO - Cleaning up... 06:31:37 INFO - Return code: 0 06:31:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:31:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:31:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d61030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2022180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20203b0>, '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 0x20212b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2021740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470229579.484617-765975799', '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 06:31:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:31:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:31:37 INFO - Using env: {'DISPLAY': ':0', 06:31:37 INFO - 'HOME': '/home/cltbld', 06:31:37 INFO - 'LANG': 'en_US.UTF-8', 06:31:37 INFO - 'LANGUAGE': 'en_US:en', 06:31:37 INFO - 'LOGNAME': 'cltbld', 06:31:37 INFO - 'MAIL': '/var/mail/cltbld', 06:31:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:37 INFO - 'MOZ_NO_REMOTE': '1', 06:31:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:37 INFO - 'NO_EM_RESTART': '1', 06:31:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:37 INFO - 'PWD': '/builds/slave/test', 06:31:37 INFO - 'SHELL': '/bin/bash', 06:31:37 INFO - 'SHLVL': '1', 06:31:37 INFO - 'TERM': 'linux', 06:31:37 INFO - 'TMOUT': '86400', 06:31:37 INFO - 'USER': 'cltbld', 06:31:37 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470229579.484617-765975799', 06:31:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:37 INFO - '_': '/tools/buildbot/bin/python'} 06:31:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:31:37 INFO - Running setup.py (path:/tmp/pip-H7ZyDk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:31:37 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:31:37 INFO - Running setup.py (path:/tmp/pip-v18MuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:31:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:31:37 INFO - Running setup.py (path:/tmp/pip-IKybt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:31:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:31:37 INFO - Running setup.py (path:/tmp/pip-wPc3hN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:31:37 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)) 06:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:31:37 INFO - Running setup.py (path:/tmp/pip-hnmgwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:31:37 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)) 06:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:31:37 INFO - Running setup.py (path:/tmp/pip-0TM7BX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:31:37 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)) 06:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:31:37 INFO - Running setup.py (path:/tmp/pip-ZV8gtp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:31:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:31:38 INFO - Running setup.py (path:/tmp/pip-VC_B7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:31:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:31:38 INFO - Running setup.py (path:/tmp/pip-VJ3zhi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:31:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:31:38 INFO - Running setup.py (path:/tmp/pip-1uXQFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:31:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:31:38 INFO - Running setup.py (path:/tmp/pip-Ya30Ot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:31:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:31:38 INFO - Running setup.py (path:/tmp/pip-BvJeg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:31:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:31:38 INFO - Running setup.py (path:/tmp/pip-eUviom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:31:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:31:38 INFO - Running setup.py (path:/tmp/pip-RICV98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:31:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:31:38 INFO - Running setup.py (path:/tmp/pip-0laxNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:31:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:31:38 INFO - Running setup.py (path:/tmp/pip-MikHFI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:31:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:31:38 INFO - Running setup.py (path:/tmp/pip-SAeOZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:31:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:31:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:31:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:31:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:31:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:31:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:31:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:31:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:31:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:31:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:31:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:31:40 INFO - Downloading blessings-1.6.tar.gz 06:31:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:31:40 INFO - Installing collected packages: blessings 06:31:40 INFO - Running setup.py install for blessings 06:31:40 INFO - Successfully installed blessings 06:31:40 INFO - Cleaning up... 06:31:40 INFO - Return code: 0 06:31:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:31:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:31:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:31:41 INFO - Reading from file tmpfile_stdout 06:31:41 INFO - Current package versions: 06:31:41 INFO - argparse == 1.2.1 06:31:41 INFO - blessings == 1.6 06:31:41 INFO - blobuploader == 1.2.4 06:31:41 INFO - docopt == 0.6.1 06:31:41 INFO - functools32 == 3.2.3-2 06:31:41 INFO - jsonschema == 2.5.1 06:31:41 INFO - manifestparser == 1.1 06:31:41 INFO - mozInstall == 1.12 06:31:41 INFO - mozcrash == 0.17 06:31:41 INFO - mozdebug == 0.1 06:31:41 INFO - mozdevice == 0.48 06:31:41 INFO - mozfile == 1.2 06:31:41 INFO - mozhttpd == 0.7 06:31:41 INFO - mozinfo == 0.9 06:31:41 INFO - mozleak == 0.1 06:31:41 INFO - mozlog == 3.3 06:31:41 INFO - moznetwork == 0.27 06:31:41 INFO - mozprocess == 0.23 06:31:41 INFO - mozprofile == 0.28 06:31:41 INFO - mozrunner == 6.12 06:31:41 INFO - mozscreenshot == 0.1 06:31:41 INFO - mozsystemmonitor == 0.3 06:31:41 INFO - moztest == 0.7 06:31:41 INFO - mozversion == 1.4 06:31:41 INFO - psutil == 3.1.1 06:31:41 INFO - requests == 1.2.3 06:31:41 INFO - wsgiref == 0.1.2 06:31:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:31: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')]} 06:31:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31: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')]} 06:31:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d61030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2022180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20203b0>, '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 0x20212b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2021740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470229579.484617-765975799', '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 06:31:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:31:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:31:41 INFO - Using env: {'DISPLAY': ':0', 06:31:41 INFO - 'HOME': '/home/cltbld', 06:31:41 INFO - 'LANG': 'en_US.UTF-8', 06:31:41 INFO - 'LANGUAGE': 'en_US:en', 06:31:41 INFO - 'LOGNAME': 'cltbld', 06:31:41 INFO - 'MAIL': '/var/mail/cltbld', 06:31:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:41 INFO - 'MOZ_NO_REMOTE': '1', 06:31:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:41 INFO - 'NO_EM_RESTART': '1', 06:31:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:41 INFO - 'PWD': '/builds/slave/test', 06:31:41 INFO - 'SHELL': '/bin/bash', 06:31:41 INFO - 'SHLVL': '1', 06:31:41 INFO - 'TERM': 'linux', 06:31:41 INFO - 'TMOUT': '86400', 06:31:41 INFO - 'USER': 'cltbld', 06:31:41 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470229579.484617-765975799', 06:31:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:41 INFO - '_': '/tools/buildbot/bin/python'} 06:31:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:31:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:31:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:31:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:31:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:31:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:31:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:31:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:31:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:31:41 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:31:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:31:41 INFO - Cleaning up... 06:31:41 INFO - Return code: 0 06:31:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:31: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')]} 06:31:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31: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')]} 06:31:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d61030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2022180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20203b0>, '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 0x20212b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2021740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470229579.484617-765975799', '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 06:31:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:31:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:31:41 INFO - Using env: {'DISPLAY': ':0', 06:31:41 INFO - 'HOME': '/home/cltbld', 06:31:41 INFO - 'LANG': 'en_US.UTF-8', 06:31:41 INFO - 'LANGUAGE': 'en_US:en', 06:31:41 INFO - 'LOGNAME': 'cltbld', 06:31:41 INFO - 'MAIL': '/var/mail/cltbld', 06:31:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:41 INFO - 'MOZ_NO_REMOTE': '1', 06:31:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:41 INFO - 'NO_EM_RESTART': '1', 06:31:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:41 INFO - 'PWD': '/builds/slave/test', 06:31:41 INFO - 'SHELL': '/bin/bash', 06:31:41 INFO - 'SHLVL': '1', 06:31:41 INFO - 'TERM': 'linux', 06:31:41 INFO - 'TMOUT': '86400', 06:31:41 INFO - 'USER': 'cltbld', 06:31:41 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470229579.484617-765975799', 06:31:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:41 INFO - '_': '/tools/buildbot/bin/python'} 06:31:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:31:41 INFO - Cleaning up... 06:31:41 INFO - Return code: 0 06:31:41 INFO - Running post-action listener: _resource_record_post_action 06:31:41 INFO - Running post-action listener: _start_resource_monitoring 06:31:41 INFO - Starting resource monitoring. 06:31:41 INFO - [mozharness: 2016-08-03 13:31:41.628016Z] Finished create-virtualenv step (success) 06:31:41 INFO - [mozharness: 2016-08-03 13:31:41.628496Z] Running install step. 06:31:41 INFO - Running pre-action listener: _resource_record_pre_action 06:31:41 INFO - Running main action method: install 06:31:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:31:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:31:41 INFO - Reading from file tmpfile_stdout 06:31:41 INFO - Detecting whether we're running mozinstall >=1.0... 06:31:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:31:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:31:41 INFO - Reading from file tmpfile_stdout 06:31:41 INFO - Output received: 06:31:41 INFO - Usage: mozinstall [options] installer 06:31:41 INFO - Options: 06:31:41 INFO - -h, --help show this help message and exit 06:31:41 INFO - -d DEST, --destination=DEST 06:31:41 INFO - Directory to install application into. [default: 06:31:41 INFO - "/builds/slave/test"] 06:31:41 INFO - --app=APP Application being installed. [default: firefox] 06:31:41 INFO - mkdir: /builds/slave/test/build/application 06:31:41 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'] 06:31:41 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 06:31:58 INFO - Reading from file tmpfile_stdout 06:31:58 INFO - Output received: 06:31:58 INFO - /builds/slave/test/build/application/firefox/firefox 06:31:58 INFO - Running post-action listener: _resource_record_post_action 06:31:58 INFO - [mozharness: 2016-08-03 13:31:58.021257Z] Finished install step (success) 06:31:58 INFO - [mozharness: 2016-08-03 13:31:58.021534Z] Running run-tests step. 06:31:58 INFO - Running pre-action listener: _resource_record_pre_action 06:31:58 INFO - Running main action method: run_tests 06:31:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:31:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:31:58 INFO - Python 2.7.3 06:31:58 INFO - Return code: 0 06:31:58 INFO - grabbing minidump binary from tooltool 06:31:58 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')]} 06:31:58 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 0x20203b0>, '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 0x20212b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2021740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:31:58 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 06:31:58 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 06:31:58 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 06:31:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:31:58 INFO - Return code: 0 06:31:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:31:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:31:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:31:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:31:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:31:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dxXKQZotRC--0uAvWQi4lA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:31:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dxXKQZotRC--0uAvWQi4lA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:31:58 INFO - Using env: {'DISPLAY': ':0', 06:31:58 INFO - 'HOME': '/home/cltbld', 06:31:58 INFO - 'LANG': 'en_US.UTF-8', 06:31:58 INFO - 'LANGUAGE': 'en_US:en', 06:31:58 INFO - 'LOGNAME': 'cltbld', 06:31:58 INFO - 'MAIL': '/var/mail/cltbld', 06:31:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:31:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:31:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:58 INFO - 'MOZ_NO_REMOTE': '1', 06:31:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:31:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:58 INFO - 'NO_EM_RESTART': '1', 06:31:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:58 INFO - 'PWD': '/builds/slave/test', 06:31:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:31:58 INFO - 'SHELL': '/bin/bash', 06:31:58 INFO - 'SHLVL': '1', 06:31:58 INFO - 'TERM': 'linux', 06:31:58 INFO - 'TMOUT': '86400', 06:31:58 INFO - 'USER': 'cltbld', 06:31:58 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470229579.484617-765975799', 06:31:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:58 INFO - '_': '/tools/buildbot/bin/python'} 06:31:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dxXKQZotRC--0uAvWQi4lA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:31:58 INFO - mozversion application_buildid: 20160803051341 06:31:58 INFO - mozversion application_changeset: 8ab41761981936b5fb655e07f4d0d725ea514905 06:31:58 INFO - mozversion application_display_name: Nightly 06:31:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:31:58 INFO - mozversion application_name: Firefox 06:31:58 INFO - mozversion application_remotingname: firefox 06:31:58 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:31:58 INFO - mozversion application_vendor: Mozilla 06:31:58 INFO - mozversion application_version: 51.0a1 06:31:58 INFO - mozversion platform_buildid: 20160803051341 06:31:58 INFO - mozversion platform_changeset: 8ab41761981936b5fb655e07f4d0d725ea514905 06:31:58 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:31:58 INFO - mozversion platform_version: 51.0a1 06:31:58 INFO - using testdate: 1470231118 06:31:58 INFO - actual date: 1470231118 06:31:58 INFO - starting webserver on 'localhost:35772' 06:31:58 INFO - SUITE-START | Running 2 tests 06:31:58 INFO - TEST-START | dromaeo_css 06:31:58 INFO - operating with platform_type : linux_ 06:31:58 INFO - Initialising browser for dromaeo_css test... 06:31:58 INFO - TEST-INFO | started process 15090 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYZKqeY/profile http://localhost:35772/getInfo.html) 06:32:02 INFO - PROCESS | 15090 | __metrics Screen width/height:1600/1200 06:32:02 INFO - PROCESS | 15090 | colorDepth:24 06:32:02 INFO - PROCESS | 15090 | Browser inner width/height: 1024/697 06:32:02 INFO - PROCESS | 15090 | __metrics 06:32:03 INFO - PROCESS | 15090 | 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:32:03 INFO - PROCESS | 15090 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:32:04 INFO - TEST-INFO | 15090: exit 0 06:32:04 INFO - Browser initialized. 06:32:04 INFO - Running cycle 1/1 for dromaeo_css test... 06:32:04 INFO - TEST-INFO | started process 15167 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYZKqeY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:32:16 INFO - PROCESS | 15167 | RSS: Main: 157511680 06:32:16 INFO - PROCESS | 15167 | 06:33:07 INFO - PROCESS | 15167 | 1470231187578 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] 06:35:20 INFO - PROCESS | 15167 | Cycle 1(1): loaded http://localhost:35772/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35772/tests/dromaeo/cssquery-ext.html) 06:35:21 INFO - PROCESS | 15167 | RSS: Main: 239697920 06:35:21 INFO - PROCESS | 15167 | 06:38:24 INFO - PROCESS | 15167 | Cycle 1(1): loaded http://localhost:35772/tests/dromaeo/cssquery-ext.html (next: http://localhost:35772/tests/dromaeo/cssquery-jquery.html) 06:38:25 INFO - PROCESS | 15167 | RSS: Main: 244908032 06:38:25 INFO - PROCESS | 15167 | 06:41:27 INFO - PROCESS | 15167 | Cycle 1(1): loaded http://localhost:35772/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35772/tests/dromaeo/cssquery-mootools.html) 06:41:27 INFO - PROCESS | 15167 | RSS: Main: 190599168 06:41:27 INFO - PROCESS | 15167 | 06:44:29 INFO - PROCESS | 15167 | Cycle 1(1): loaded http://localhost:35772/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35772/tests/dromaeo/cssquery-prototype.html) 06:44:30 INFO - PROCESS | 15167 | RSS: Main: 189874176 06:44:30 INFO - PROCESS | 15167 | 06:47:33 INFO - PROCESS | 15167 | Cycle 1(1): loaded http://localhost:35772/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35772/tests/dromaeo/cssquery-yui.html) 06:47:34 INFO - PROCESS | 15167 | RSS: Main: 191275008 06:47:34 INFO - PROCESS | 15167 | 06:50:36 INFO - PROCESS | 15167 | Cycle 1(1): loaded http://localhost:35772/tests/dromaeo/cssquery-yui.html (next: http://localhost:35772/tests/dromaeo/cssquery-dojo.html) 06:50:37 INFO - PROCESS | 15167 | RSS: Main: 279924736 06:50:37 INFO - PROCESS | 15167 | 06:50:37 INFO - PROCESS | 15167 | __start_tp_report 06:50:37 INFO - PROCESS | 15167 | _x_x_mozilla_page_load 06:50:37 INFO - PROCESS | 15167 | _x_x_mozilla_page_load_details 06:50:37 INFO - PROCESS | 15167 | |i|pagename|runs| 06:50:37 INFO - PROCESS | 15167 | |0;dojo.html;2639.6436481075057;2648.3246772073117;2674.5720684690455;2680.4103097318584;2687.650605421295;4644.651651126171;4700.0599880023965;4779.115863565238;4913.656044076921;4921.5078492150815;4711.78796954137;4723.952760472403;4731.124741922747;4747.857564273068;4773.212419950704;4323.308270676693;4371.4098596689355;4373.825046998132;4391.363252328419;4426.97786511067;4359.716618419809;4394.47266328041;4418.491873434548;4426.247537918545;4472.016156445577;4512.887177820564;4534.8186072557055;4536.092781443708;4546.613537849286;4553.134904368176;4269.551697071794;4321.524632290446;4369.6285815705705;4422.867313980586;4485.013297074638;4320.82716691332;4331.97834010828;4340.13197360526;4397.714148580332;4480.19356515827;4796.496367881392;4816.927746083811;4847.75761211938;4848.12733707936;4848.224284114524;4919.458859525449;5060.974695126501;5166.9224961625605;5174.456682048369;5226.97386513065;5104.744762761884;5185.222216667492;5196.58427325813;5198.428172900978;5201.375834899836;4766.285057241372;4800.039992001613;4812.422509298906;4813.7593120344545;4844.370231869834;5008.949910500921;5235.790568377222;5278.81524146653;5312.628116031918;5321.547668448148;5082.059818933509;5106.412762532356;5148.279240906276;5151.922721159186;5156.92264616031;5153.227015947563;5153.2785410042625;5153.845384638467;5154.845354639367;5193.766280517386;4860.149473842063;4906.092372911023;4962.379702537183;5139.22911563261;5202.219667049897;5016.272640467112;5050.873728156752;5081.2378143278065;5105.7191854448365;5113.795448182031;4315.395844581761;4322.459692538433;4324.070324880166;4326.069894972596;4363.563643635674;3765.8305376258136;3779.7732136071922;3831.5976822433245;3840.462335273064;3845.480860083853;4359.324304732771;4401.053773438662;4404.471463424409;4418.072204836956;4459.397981272552;5129;5138.38339399267;5142.357205349332;5145.382554093533;5191.143461328838;4179.791010449465;4389.824407023683;4395.516493185747;4404.1411924674385;4441.733495990251;4598.701084429501;4639.141758774637;4654.906901861944;4665.86002419928;4709.152352576501;4835.443923948791;4839.249916262985;4849.757512124309;4852.927206091982;4900.093482705711;4930;5151.124308867426;5178.43037265908;5192.636515443883;5244.344456942882;4757.09615173116;4836.12949669063;4847.127517046965;4852.539008794159;4857.295692124693;5080.568151706999;5093.2105523643895;5101;5103.081445339874;5152.76812543429;4889.168841296917;5161.277421160966;5178.741062946762;5182.507661772125;5228.37259528859;4909.091818013679;4944.8763780905765;4974.403071631427;4992.2761199626575;5015;4981.551660350586;4990.750462476934;4992.101421744121;4995.750212489288;5028.874278142929;4789.353437285922;4855.271709243641;4897;4908.263760435963;4948.257761335684;5010.824621138243;5070.797168113234;5078.08594453002;5085.923711144262;5119.6416250862085;4970.304157418037;4982.128127577732;4982.501749824988;4985.052839960396;5019.949800502094 06:50:37 INFO - PROCESS | 15167 | |1;ext.html;561.5703986450364;565.4938829747374;578.1356871477142;579.5537436174143;580.3036356372353;27975.300617484547;39775.602243977584;41040.17919641605;41089.794551027204;44380;41039.79480102603;41537.37693934586;41554.58445415545;41603.79198104013;41604.16791664165;7293.307135822101;7414;7425.628718564078;7432.442566807511;7432.925670743278;5957.136215248786;6015.157877897098;6016.789412370568;6021.789237376693;6030.66831324277;5992.131140984555;5998.730057147439;6011.969940150293;6012.969935150318;6029.366916473773;5950.642961422307;5957.731902064395;5958.106284057426;5959.22530071088;5965.403459654;7660.272274134004;7689.692412303501;7712.768616941501;7713;7725.922740772577;38665.80667096675;38869;38934.80532597347;38999.220015599814;39019.21961560753;2956.8521573921216;2999.875791827102;3073.017903452283;3204.3110731192905;3278.541004259406;29238.707612923812;30302.84848575743;30509.38981220363;31008.37983240345;31778;3106.766992475551;3249.2689144942437;3279.8688052477873;3281.721053710414;3307;189649;189802;190372;190454;190536;31839.204019899687;53830.7308463463;54051.18923216155;54052.72973635185;54173;32320.35359292801;34455.65544344525;34623.82688086594;34647.82676086603;34656.82671586626;12959;13062.477500900048;13067.869321306855;13082.345882705828;13090.410931507915;11167.888321116847;11191.888081119247;11221.943890280496;11266.155038372155;11303.886961130447;7876.881846772303;7906.248906353887;7928.246816552418;7958.124606293303;8009.479383840032;3091.397177550401;3117.8752849886205;3125.0312403155094;3142.858571364294;3222.3072039511617;825.7192554531488;870.1602953150241;880.7577916073132;938.6761567259284;954.9618015279311;28424.563625213614;28608.284792880346;28753.56869646957;28971.42057158887;29306.706932930825;747.3759410891967;947.313197931508;963.272729089533;968.1867231525553;995.681381957781;14339.211343376215;15044.398224071134;15234.162121083447;15380.92309538445;15503.5348939532;382370;384808;385052;386090;386511;50125.74937125291;50575.49424505782;50604.49395505998;50633.746831265606;50708.49291507112;1021.1218352217087;1157.5890558851654;1169.4036041618835;1180.4569897846916;1203.6750077479207;28705.856470717514;29501.85249073741;30132;30150.69849301479;30877.0736877894;41539.58460415357;42066.57933420627;42082.36876446917;42131.73604791861;42139.578604213566;306468;307612;307940;308365;309398;26804.927802887665;27757;27801.44397112087;27952.161435156977;28094.85952570224;42417.787911060244;42807;42920.141597168506;43896.56103438925;44753.77623111864;35978.64021359753;36130.45804312885;37276.25447491089;37980.62019379771;38092.80953595214;33461.498077529344;33873.15317117092;34196.48705269473;34389.828050859585;34692.653073468944;35904;36626.633733662326;36755.78790141897;36826.447603286506;37335.25329493449;31384.686153138176;32783.50824737583;33314.33371332608;33693.66306336905;33786.66213337934;25824.48351032931;25944.091956781424;26020;26026.60960085638;26054.34864128412 06:50:37 INFO - PROCESS | 15167 | |2;jquery.html;332.8834907782278;354.53201773658765;355.74564186606574;360.2884303500586;388.9008302882766;12699;16441.50675479736;16855.578610534743;17872.553186170353;18047.097645117756;16533.25600347984;17041.48875533733;17110.31558737649;17150.485485435456;17220.569485762862;4883.072216278913;4975.950240497585;4996.600271978233;4998.975005124969;5011.473795251501;3683.852645894174;5100.107481190796;5155.149400348938;5773.855653608673;6079.574429789916;6097.237845269341;6118.969405152968;6128.172696685957;6129.172561704179;6129.938700612981;5961.672108034057;6005.54958378119;6054.394560543955;6084.239470066242;6089.695515224221;5137.280780690707;5304.20436934459;5305.73471326436;5309.123994540896;5316.441773613792;17468.47594572165;17684.734728979074;17690.91154544219;17705.38031168903;21379.8931005344;1800.9369672061414;1828.8536917046604;1834.7614810074738;1845.769278840145;1851.2132343753985;13079.934600327033;13441.193528388329;13469.730605387836;13603.183808971395;14081.85918140826;1749;1797.9910100449545;1815.7276408538694;1818.927242910282;1859.0425930645729;66563.66718166426;71568;71639.28360716431;72028.27971720268;72170.63914680446;8443.155684431507;8602.87095693565;8714.128587141362;9416.858747118798;9798.951005245071;12941.417636206394;12942.805857912139;12954;12984.480620775063;13005.544805931748;6818.693158807866;7018.368346848706;7087.362137407555;7217.494775365779;7324.926750732531;6570.342965703391;6605.933940660628;6666.733330666719;6751.4261287790105;6752.155980502437;6038.396160383926;6044.365341639153;6066.75732970685;6081.726322315506;6090.939090609126;1707.3597400974634;1719.5443207550009;1725.6721222967597;1750.2561411400104;1784.7769028871392;692.6779047742824;857.8455877941906;872.6509396241554;905.6920646980059;911.5852287209303;17375.913120434318;17736.379226727262;18064.81935180658;18114;18658.34695785641;869.8477766390856;876.6931573949195;878.3939082033504;945.7937591564602;975.8731364922656;9912.306138570231;10301.9484902575;10395.584176633001;10404.68785936423;10452.111570516592;391219;396761;401563;403706;404448;68572;69220.65389673121;70872.58254834874;71624;73829.6308518454;907.0430695616188;919.2783664823082;931.0549791961165;933.7198840347869;935.2798345274101;15400.46098386551;15431.305591248196;15878;16142.435014774426;16218.270177841789;33842.15394615056;35762.960148386635;35976.82011589925;36166.27667446584;36898.815505923376;45409.54590454053;46313.76843115763;46440.53559464497;46474.30288545607;46719.532804672875;7170.282971702788;7408.592527411044;7498.58757768328;7522.285382888617;7618.961905190438;10799.783048958374;11846.170768046153;12447.688807779878;12536.561220357244;12551.811722824348;9335.626574936927;9814.705558833246;9990.900090998997;10029.846567644814;10161.84757228657;10524;10713.517891694737;10874;11022.338659680125;11353.318800871974;9870.210383169473;10036.447995360326;10045.748856278358;10299.021592948659;10368.896311037095;7612.505187162817;7679.692812287446;7751.379889608705;7754.263344982218;7996.520208787491;9640.276979226446;10120.139788118093;10202;10243.948780256349;10250.846237306298 06:50:37 INFO - PROCESS | 15167 | |3;mootools.html;1300.1938797945272;1301.5834932821494;1372.5264783649643;1592.21185513171;1601.9919900400503;7243.782686519399;7806.1413244543055;7809.062912450499;7812.882806757896;7817.335526480256;6564.081028655992;6770.3906648401635;6776.695048722807;6960.234374218832;7643.61781910905;1911.7132430135487;2194.572058448603;2236.8322375821876;2248.7976082152604;2261.977380226193;2209.801117899389;2218.245796429214;2219.889005549724;2221.7556068832414;2224.822014238865;2153.257126291427;2233.0955962834996;2239.3729755668355;2244.753077161511;2246.4945387287894;2152.0208305221086;2161.4056134563043;2194.0675213034397;2235.0277629231173;2237.3064350051536;2154.4613846538364;2155.95688086239;2162.4701948022835;2165.4261620670536;2165.7725938776516;7841.647125879349;7895.407844411692;7941.64262608184;7944.04671439431;7950.880736788953;4487.259602165639;4607;4620.376249206348;4622.745748983804;4624.537546245382;2810.5924640927155;2864.398476319975;2937.8384188869604;2954.7340739333563;2959.7632189424794;867.8090820019648;903.575319599787;906.5829718329576;906.5965645287849;909.1363204955319;10555.84166237507;10588.364698118137;10593.78812423755;10596.735081623021;10619.30974486656;3952.173400871687;4043.757374557536;4167.291560434734;4224.831006759757;4241.300185469363;8942.86585701215;9029.503377314311;9046.683366082287;9065.954670226738;9069;4601.28680054592;4601.309803529497;4605.332226827091;4613.146567884952;4624.421947256593;4117.91764164715;4227.556106608823;4227.852025179104;4234.576542345741;4240.982164280612;3656.8171591420323;3702.444633305026;3776.6412190842375;3782.130110074643;3790.8483660653815;1159.3449700919123;1178.1752773058893;1181.6218809980724;1187.7327601289642;1202.81957706343;650.9511786616023;663.3697986912356;684.1858188755365;708.2209569473538;713.561159886666;4816.470188279286;4878.780454879539;4937.901241975141;4965.503449655005;5046.7476626168545;806.1132753970703;809.7893648994791;843.2073850580434;843.2537204573873;850.9106543812934;3220.6457289698114;3352.2960178362327;3407.369636617234;3432.5880894292345;3473.975177322696;9564.4739539326;9987.051230133126;9989.60041598328;9992.200623950066;9995.750106247257;9901.15840153595;9926.751831204134;9958.053984871425;9964.302498825158;9970.45162516054;7131.1678651128195;7180.676869540883;7275.745348912763;7288.9271107289305;7292.416606671453;4873.147199240189;4899.681520701143;4917.926231106608;4937.802487900443;4995.900081998267;8595.82808343842;8700.260477859452;8800.823983520166;9062.22971047442;9070.365074444726;8746.51894145828;9107.134822191882;9166.450012999241;9228;9238.722838314861;6333.96833015832;6447.451966582893;6548.1814773153355;6669.7665581704405;6768.7292508299115;7511.887321690069;7556.622168891424;7567.583782891994;7582;7590.39276857839;6598.670066496752;6654.534182607171;6769.08617336673;6774.695138718868;6783.491238157059;6400.839979000562;6447.91131377922;6478.481721462366;6510.707018184098;6648.235452922976;5968.97015514937;6055.394460553909;6058.636481811105;6058.757649693963;6059.848503787441;4218.7468751874985;4340.500842403164;4348.065165989327;4421.204183247047;4423;4143.357779544175;4294.184105020036;4351.238533256731;4389.670774691847;4409.911801764011 06:50:37 INFO - PROCESS | 15167 | |4;prototype.html;283.05540933784897;289.7899023208174;290.91999700082476;299.44004711190075;301.9064090132059;4883.584895283901;4893.9934626803015;4906.31311616374;4917.680350777197;4918.114739346916;4839.8790030249265;4850.757462126889;4861.124997500448;4873.171560834658;4876.707397556149;3819.1597848473293;3835.4438606402123;3839.4048922416932;3840.961590384088;3855.3253180693405;3612.638736126393;3660.7125156123006;3816.2749077675294;3838.193979264358;3850.114473671057;2634.367751739578;3521;3593.3352329818936;3626.764260323084;3737.3272810894027;3605.9098522537147;3695.316366472211;3712.628737126293;3758.0416993666577;3758.8684396046006;3240.9142937116094;3244.253821621017;3248.2366643838914;3257.5765150530515;3283.770136090475;4454.37638730578;4524;4700.224462963607;4716.50476699945;4728.4798672146035;4217.3973889921945;4223.598758117974;4234.343676730081;4235.576442355739;4244.936325955113;5015.297858299841;5025.874353141164;5035.144025515671;5037.319961805146;5080.415752188509;3429.879954201591;3491;3517.66582174693;3518.6481351864863;3533.116720819795;5210.036143313499;5210.6613070150315;5211.817586384458;5226.216067589854;5228.947710522884;3594.6944509716445;3633.4004889193516;3634.109643137448;3635.4910312556262;3635.909102272464;3691.0956815579816;3693.8891833245048;3694.224212915264;3694.5012423323046;3700.296943580765;4039.313316736162;4222.78886055696;4227.556106608823;4235.047114399297;4258.488981322199;5014.342398528785;5016.774245158977;5024.79900803971;5056.140456122468;5082.669626474268;1264.134068163311;1276.412850088951;1281.7756892543769;1281.916675416095;1290.167841742071;822.5887056471764;822.6051495282298;838.5388036579857;840.1850205300848;865.1780808232205;4402.207602631557;4404.405405270248;4411.691181617256;4415.359772832921;4439.378487011821;5129.281900533928;5131.409887862869;5142.280080788692;5159.864829737452;5206;4264.914701705949;4392.616325857345;4396.625822056118;4399.670024748157;4412.183746006999;2709.4851978124093;2710.715374885648;2733.166384252822;2753.7796976241852;2753.9397332027315;4699.895524551727;4831.95168048322;4843.927341089887;4851.296561998491;4855.757212139379;4737.526247375235;5185.637005409661;5198.142306519458;5202.3497062867145;5233.581313494911;4832.685875418087;4840;4889.853304400874;4907.190313598217;4934.457209707001;5212.582993360598;5216.191490319006;5236.711980841091;5259.317018554026;5273.34083239595;4939.777710002986;5029.74851257443;5070.746462676778;5077.689651208618;5078.56832169255;4809.470958194665;4832.613390928787;4846.5638092571835;4873.658843881036;4883.658143929891;3594.640535946489;3602.2075143468396;3628.8185590720886;3647.8176091194805;3662.9450558241115;5114.718690471911;5238.266642670105;5243.842684719464;5246;5256.89486210266;5011.974940125276;5026.145555255688;5029.321041659329;5029.5221953914315;5045.344105266292;5026.145555255543;5029.245613158056;5042.29407882904;5046.646734728533;5098.388193416814;4759.214729569582;4982.128127577587;4989.35138432016;4990;5028.4663177731145;5041.361557493902;5075.543201111917;5077.213031980049;5092.2361645753435;5105.948940510547;4963.156263435152;4981.327520784793;4981.985898531337;5019.799208031784;5021.196608542616 06:50:37 INFO - PROCESS | 15167 | |5;yui.html;587.4301927130683;607;650.3399049964287;680.6630717794692;688.9355945064874;11690.47392867321;12306.138570300083;12328.938355308223;12791.104622676416;12871.227726336427;12049.15655904087;12518.374081295944;12601.495940162382;12620.684482887933;12681.112322137455;590.5010266324948;749.3518106837573;765.7281665008925;765.8889461028148;765.9617019149048;717.7810767715845;776.6932061835572;780.6838230516621;784.52928243054;785.8153333966513;814.9511029338229;816.742726041298;818.8198596308832;820.1552401026922;820.9712660056899;596.1058412381428;811.7686459359084;816;816.3346872299087;816.7223144130994;399.67626222759367;408.84055218464823;409.44111288091835;411.4096271849905;411.4445498576927;12399.814002789966;12412.944899683538;12416.689582760413;12435.191712538655;12470.314132722697;11230.382328971904;11855.881441185564;12046.277223366626;12254;12550.246985180918;8982.550872456417;9046.819063618757;11610.767784644344;11741.589044383405;11754.412279386082;4077.510698716173;4078.2047500737367;4092.406601042862;4110.815013324378;4271.722338048048;60759.69620151915;61754.38245617531;62009.689951550405;62927.37072629261;62975;9202.30982676302;9557.283203759745;9678.128968392879;9754.75613109678;9871.01289871007;15680.843191568167;16351.67296654084;16600.83399166017;16669.666606667797;16757.078360690037;6045.697715114315;6063.272407311063;6070.544709146831;6095.725692343855;6290.748370065237;3498.737594680409;3552.644735526478;3579.51676523666;3605.3149901518627;3617.222297206113;2552.706438759529;2626.4484458263596;2651.9337016574354;2652.82756620819;2658.6012098185042;490.8404768450268;492.3845193508115;492.4337012435656;495.58370968386726;503.5166240409175;410.4049128763305;430.0689008297064;455.6628095209587;465.8998315362213;486.5086262874522;6769.3907548320885;6923.9307606923285;6974.232834388214;7252.746153884589;7620.923790762022;451.3635773559331;465.9114768194032;469.4859129253462;482.7827477635008;489.2685435274288;3330.2506935939705;3417.1457135716073;3436.244026314207;3482.8084455355197;3668.156324045431;58028.419715803146;100530.49734751279;100725.99274007312;106065.46967265269;107697.4615126935;25519.87240063788;25562;78283.60858195672;88804.555977221;89008;79197.20802792013;80065.59967200126;80243;81614.59192704117;81720;6786.524943254122;7699.576523291273;7811.921880781119;7949.443538952218;7998.5600791957;31302.843485782425;31790.20524486814;36948.81525592462;43342;44056;41753.58246417497;42110.157796844505;53507.732461337444;62724.372756271856;65169.67415162894;10276.897231027893;10362.222833287382;10404.58381664725;10528.789424211625;10620.575176992834;11507.769844603228;11689.766204675689;11810;11949.342786146497;12405.503779848705;10326.586936522455;10351.948240258751;10874.510647020745;10903.073238774792;10966.232363734462;10173.23700722434;10408.47957602132;10583.417912014913;10598.841017384591;10815.837762433726;10876.673699789018;11329.263597866113;11453.770924581628;11504.309741415542;11592.768144636892;9344.439333640003;9443.291753118407;9535.38020028696;9741.366811157252;9978.451185184595;8848.424852384574;9647.662331818352;10041.748956276151;10053.69838904834;10056.798864022532 06:50:37 INFO - PROCESS | 15167 | __end_tp_report 06:50:37 INFO - PROCESS | 15167 | __start_cc_report 06:50:37 INFO - PROCESS | 15167 | _x_x_mozilla_cycle_collect,1143 06:50:37 INFO - PROCESS | 15167 | __end_cc_report 06:50:37 INFO - PROCESS | 15167 | __startTimestamp1470232237185__endTimestamp 06:50:37 INFO - PROCESS | 15167 | 06:50:37 INFO - PROCESS | 15167 | ------- Summary: start ------- 06:50:37 INFO - PROCESS | 15167 | Number of tests: 6 06:50:37 INFO - PROCESS | 15167 | 06:50:37 INFO - PROCESS | 15167 | [#0] dojo.html Cycles:165 Average:4742.08 Median:4855.27 stddev:503.06 (10.4%) stddev-sans-first:476.80 06:50:37 INFO - PROCESS | 15167 | Values: 2639.6 2648.3 2674.6 2680.4 2687.7 4644.7 4700.1 4779.1 4913.7 4921.5 4711.8 4724.0 4731.1 4747.9 4773.2 4323.3 4371.4 4373.8 4391.4 4427.0 4359.7 4394.5 4418.5 4426.2 4472.0 4512.9 4534.8 4536.1 4546.6 4553.1 4269.6 4321.5 4369.6 4422.9 4485.0 4320.8 4332.0 4340.1 4397.7 4480.2 4796.5 4816.9 4847.8 4848.1 4848.2 4919.5 5061.0 5166.9 5174.5 5227.0 5104.7 5185.2 5196.6 5198.4 5201.4 4766.3 4800.0 4812.4 4813.8 4844.4 5008.9 5235.8 5278.8 5312.6 5321.5 5082.1 5106.4 5148.3 5151.9 5156.9 5153.2 5153.3 5153.8 5154.8 5193.8 4860.1 4906.1 4962.4 5139.2 5202.2 5016.3 5050.9 5081.2 5105.7 5113.8 4315.4 4322.5 4324.1 4326.1 4363.6 3765.8 3779.8 3831.6 3840.5 3845.5 4359.3 4401.1 4404.5 4418.1 4459.4 5129.0 5138.4 5142.4 5145.4 5191.1 4179.8 4389.8 4395.5 4404.1 4441.7 4598.7 4639.1 4654.9 4665.9 4709.2 4835.4 4839.2 4849.8 4852.9 4900.1 4930.0 5151.1 5178.4 5192.6 5244.3 4757.1 4836.1 4847.1 4852.5 4857.3 5080.6 5093.2 5101.0 5103.1 5152.8 4889.2 5161.3 5178.7 5182.5 5228.4 4909.1 4944.9 4974.4 4992.3 5015.0 4981.6 4990.8 4992.1 4995.8 5028.9 4789.4 4855.3 4897.0 4908.3 4948.3 5010.8 5070.8 5078.1 5085.9 5119.6 4970.3 4982.1 4982.5 4985.1 5019.9 06:50:37 INFO - PROCESS | 15167 | 06:50:37 INFO - PROCESS | 15167 | [#1] ext.html Cycles:180 Average:44420.56 Median:36691.21 stddev:80633.19 (219.8%) stddev-sans-first:80792.14 06:50:37 INFO - PROCESS | 15167 | Values: 561.6 565.5 578.1 579.6 580.3 27975.3 39775.6 41040.2 41089.8 44380.0 41039.8 41537.4 41554.6 41603.8 41604.2 7293.3 7414.0 7425.6 7432.4 7432.9 5957.1 6015.2 6016.8 6021.8 6030.7 5992.1 5998.7 6012.0 6013.0 6029.4 5950.6 5957.7 5958.1 5959.2 5965.4 7660.3 7689.7 7712.8 7713.0 7725.9 38665.8 38869.0 38934.8 38999.2 39019.2 2956.9 2999.9 3073.0 3204.3 3278.5 29238.7 30302.8 30509.4 31008.4 31778.0 3106.8 3249.3 3279.9 3281.7 3307.0 189649.0 189802.0 190372.0 190454.0 190536.0 31839.2 53830.7 54051.2 54052.7 54173.0 32320.4 34455.7 34623.8 34647.8 34656.8 12959.0 13062.5 13067.9 13082.3 13090.4 11167.9 11191.9 11221.9 11266.2 11303.9 7876.9 7906.2 7928.2 7958.1 8009.5 3091.4 3117.9 3125.0 3142.9 3222.3 825.7 870.2 880.8 938.7 955.0 28424.6 28608.3 28753.6 28971.4 29306.7 747.4 947.3 963.3 968.2 995.7 14339.2 15044.4 15234.2 15380.9 15503.5 382370.0 384808.0 385052.0 386090.0 386511.0 50125.7 50575.5 50604.5 50633.7 50708.5 1021.1 1157.6 1169.4 1180.5 1203.7 28705.9 29501.9 30132.0 30150.7 30877.1 41539.6 42066.6 42082.4 42131.7 42139.6 306468.0 307612.0 307940.0 308365.0 309398.0 26804.9 27757.0 27801.4 27952.2 28094.9 42417.8 42807.0 42920.1 43896.6 44753.8 35978.6 36130.5 37276.3 37980.6 38092.8 33461.5 33873.2 34196.5 34389.8 34692.7 35904.0 36626.6 36755.8 36826.4 37335.3 31384.7 32783.5 33314.3 33693.7 33786.7 25824.5 25944.1 26020.0 26026.6 26054.3 06:50:37 INFO - PROCESS | 15167 | 06:50:37 INFO - PROCESS | 15167 | [#2] jquery.html Cycles:180 Average:24404.52 Median:45861.66 stddev:65728.36 (143.3%) stddev-sans-first:65887.89 06:50:37 INFO - PROCESS | 15167 | Values: 332.9 354.5 355.7 360.3 388.9 12699.0 16441.5 16855.6 17872.6 18047.1 16533.3 17041.5 17110.3 17150.5 17220.6 4883.1 4976.0 4996.6 4999.0 5011.5 3683.9 5100.1 5155.1 5773.9 6079.6 6097.2 6119.0 6128.2 6129.2 6129.9 5961.7 6005.5 6054.4 6084.2 6089.7 5137.3 5304.2 5305.7 5309.1 5316.4 17468.5 17684.7 17690.9 17705.4 21379.9 1800.9 1828.9 1834.8 1845.8 1851.2 13079.9 13441.2 13469.7 13603.2 14081.9 1749.0 1798.0 1815.7 1818.9 1859.0 66563.7 71568.0 71639.3 72028.3 72170.6 8443.2 8602.9 8714.1 9416.9 9799.0 12941.4 12942.8 12954.0 12984.5 13005.5 6818.7 7018.4 7087.4 7217.5 7324.9 6570.3 6605.9 6666.7 6751.4 6752.2 6038.4 6044.4 6066.8 6081.7 6090.9 1707.4 1719.5 1725.7 1750.3 1784.8 692.7 857.8 872.7 905.7 911.6 17375.9 17736.4 18064.8 18114.0 18658.3 869.8 876.7 878.4 945.8 975.9 9912.3 10301.9 10395.6 10404.7 10452.1 391219.0 396761.0 401563.0 403706.0 404448.0 68572.0 69220.7 70872.6 71624.0 73829.6 907.0 919.3 931.1 933.7 935.3 15400.5 15431.3 15878.0 16142.4 16218.3 33842.2 35763.0 35976.8 36166.3 36898.8 45409.5 46313.8 46440.5 46474.3 46719.5 7170.3 7408.6 7498.6 7522.3 7619.0 10799.8 11846.2 12447.7 12536.6 12551.8 9335.6 9814.7 9990.9 10029.8 10161.8 10524.0 10713.5 10874.0 11022.3 11353.3 9870.2 10036.4 10045.7 10299.0 10368.9 7612.5 7679.7 7751.4 7754.3 7996.5 9640.3 10120.1 10202.0 10243.9 10250.8 06:50:37 INFO - PROCESS | 15167 | 06:50:37 INFO - PROCESS | 15167 | [#3] mootools.html Cycles:180 Average:5073.77 Median:4937.85 stddev:2886.70 (58.5%) stddev-sans-first:2880.86 06:50:37 INFO - PROCESS | 15167 | Values: 1300.2 1301.6 1372.5 1592.2 1602.0 7243.8 7806.1 7809.1 7812.9 7817.3 6564.1 6770.4 6776.7 6960.2 7643.6 1911.7 2194.6 2236.8 2248.8 2262.0 2209.8 2218.2 2219.9 2221.8 2224.8 2153.3 2233.1 2239.4 2244.8 2246.5 2152.0 2161.4 2194.1 2235.0 2237.3 2154.5 2156.0 2162.5 2165.4 2165.8 7841.6 7895.4 7941.6 7944.0 7950.9 4487.3 4607.0 4620.4 4622.7 4624.5 2810.6 2864.4 2937.8 2954.7 2959.8 867.8 903.6 906.6 906.6 909.1 10555.8 10588.4 10593.8 10596.7 10619.3 3952.2 4043.8 4167.3 4224.8 4241.3 8942.9 9029.5 9046.7 9066.0 9069.0 4601.3 4601.3 4605.3 4613.1 4624.4 4117.9 4227.6 4227.9 4234.6 4241.0 3656.8 3702.4 3776.6 3782.1 3790.8 1159.3 1178.2 1181.6 1187.7 1202.8 651.0 663.4 684.2 708.2 713.6 4816.5 4878.8 4937.9 4965.5 5046.7 806.1 809.8 843.2 843.3 850.9 3220.6 3352.3 3407.4 3432.6 3474.0 9564.5 9987.1 9989.6 9992.2 9995.8 9901.2 9926.8 9958.1 9964.3 9970.5 7131.2 7180.7 7275.7 7288.9 7292.4 4873.1 4899.7 4917.9 4937.8 4995.9 8595.8 8700.3 8800.8 9062.2 9070.4 8746.5 9107.1 9166.5 9228.0 9238.7 6334.0 6447.5 6548.2 6669.8 6768.7 7511.9 7556.6 7567.6 7582.0 7590.4 6598.7 6654.5 6769.1 6774.7 6783.5 6400.8 6447.9 6478.5 6510.7 6648.2 5969.0 6055.4 6058.6 6058.8 6059.8 4218.7 4340.5 4348.1 4421.2 4423.0 4143.4 4294.2 4351.2 4389.7 4409.9 06:50:37 INFO - PROCESS | 15167 | 06:50:37 INFO - PROCESS | 15167 | [#4] prototype.html Cycles:180 Average:4163.21 Median:4832.65 stddev:1225.59 (25.4%) stddev-sans-first:1193.93 06:50:37 INFO - PROCESS | 15167 | Values: 283.1 289.8 290.9 299.4 301.9 4883.6 4894.0 4906.3 4917.7 4918.1 4839.9 4850.8 4861.1 4873.2 4876.7 3819.2 3835.4 3839.4 3841.0 3855.3 3612.6 3660.7 3816.3 3838.2 3850.1 2634.4 3521.0 3593.3 3626.8 3737.3 3605.9 3695.3 3712.6 3758.0 3758.9 3240.9 3244.3 3248.2 3257.6 3283.8 4454.4 4524.0 4700.2 4716.5 4728.5 4217.4 4223.6 4234.3 4235.6 4244.9 5015.3 5025.9 5035.1 5037.3 5080.4 3429.9 3491.0 3517.7 3518.6 3533.1 5210.0 5210.7 5211.8 5226.2 5228.9 3594.7 3633.4 3634.1 3635.5 3635.9 3691.1 3693.9 3694.2 3694.5 3700.3 4039.3 4222.8 4227.6 4235.0 4258.5 5014.3 5016.8 5024.8 5056.1 5082.7 1264.1 1276.4 1281.8 1281.9 1290.2 822.6 822.6 838.5 840.2 865.2 4402.2 4404.4 4411.7 4415.4 4439.4 5129.3 5131.4 5142.3 5159.9 5206.0 4264.9 4392.6 4396.6 4399.7 4412.2 2709.5 2710.7 2733.2 2753.8 2753.9 4699.9 4832.0 4843.9 4851.3 4855.8 4737.5 5185.6 5198.1 5202.3 5233.6 4832.7 4840.0 4889.9 4907.2 4934.5 5212.6 5216.2 5236.7 5259.3 5273.3 4939.8 5029.7 5070.7 5077.7 5078.6 4809.5 4832.6 4846.6 4873.7 4883.7 3594.6 3602.2 3628.8 3647.8 3662.9 5114.7 5238.3 5243.8 5246.0 5256.9 5012.0 5026.1 5029.3 5029.5 5045.3 5026.1 5029.2 5042.3 5046.6 5098.4 4759.2 4982.1 4989.4 4990.0 5028.5 5041.4 5075.5 5077.2 5092.2 5105.9 4963.2 4981.3 4982.0 5019.8 5021.2 06:50:37 INFO - PROCESS | 15167 | 06:50:37 INFO - PROCESS | 15167 | [#5] yui.html Cycles:180 Average:16378.21 Median:41931.87 stddev:24251.31 (57.8%) stddev-sans-first:24290.35 06:50:37 INFO - PROCESS | 15167 | Values: 587.4 607.0 650.3 680.7 688.9 11690.5 12306.1 12328.9 12791.1 12871.2 12049.2 12518.4 12601.5 12620.7 12681.1 590.5 749.4 765.7 765.9 766.0 717.8 776.7 780.7 784.5 785.8 815.0 816.7 818.8 820.2 821.0 596.1 811.8 816.0 816.3 816.7 399.7 408.8 409.4 411.4 411.4 12399.8 12412.9 12416.7 12435.2 12470.3 11230.4 11855.9 12046.3 12254.0 12550.2 8982.6 9046.8 11610.8 11741.6 11754.4 4077.5 4078.2 4092.4 4110.8 4271.7 60759.7 61754.4 62009.7 62927.4 62975.0 9202.3 9557.3 9678.1 9754.8 9871.0 15680.8 16351.7 16600.8 16669.7 16757.1 6045.7 6063.3 6070.5 6095.7 6290.7 3498.7 3552.6 3579.5 3605.3 3617.2 2552.7 2626.4 2651.9 2652.8 2658.6 490.8 492.4 492.4 495.6 503.5 410.4 430.1 455.7 465.9 486.5 6769.4 6923.9 6974.2 7252.7 7620.9 451.4 465.9 469.5 482.8 489.3 3330.3 3417.1 3436.2 3482.8 3668.2 58028.4 100530.5 100726.0 106065.5 107697.5 25519.9 25562.0 78283.6 88804.6 89008.0 79197.2 80065.6 80243.0 81614.6 81720.0 6786.5 7699.6 7811.9 7949.4 7998.6 31302.8 31790.2 36948.8 43342.0 44056.0 41753.6 42110.2 53507.7 62724.4 65169.7 10276.9 10362.2 10404.6 10528.8 10620.6 11507.8 11689.8 11810.0 11949.3 12405.5 10326.6 10351.9 10874.5 10903.1 10966.2 10173.2 10408.5 10583.4 10598.8 10815.8 10876.7 11329.3 11453.8 11504.3 11592.8 9344.4 9443.3 9535.4 9741.4 9978.5 8848.4 9647.7 10041.7 10053.7 10056.8 06:50:37 INFO - PROCESS | 15167 | -------- Summary: end -------- 06:50:37 INFO - PROCESS | 15167 | 06:50:38 INFO - TEST-INFO | 15167: exit 0 06:50:38 INFO - TEST-OK | dromaeo_css | took 1119740ms 06:50:38 INFO - TEST-START | kraken 06:50:38 INFO - operating with platform_type : linux_ 06:50:38 INFO - Initialising browser for kraken test... 06:50:38 INFO - TEST-INFO | started process 15352 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDWSVEh/profile http://localhost:35772/getInfo.html) 06:50:42 INFO - PROCESS | 15352 | __metrics Screen width/height:1600/1200 06:50:42 INFO - PROCESS | 15352 | colorDepth:24 06:50:42 INFO - PROCESS | 15352 | Browser inner width/height: 1024/697 06:50:42 INFO - PROCESS | 15352 | __metrics 06:50:43 INFO - PROCESS | 15352 | 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:50:43 INFO - PROCESS | 15352 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:50:44 INFO - TEST-INFO | 15352: exit 0 06:50:44 INFO - Browser initialized. 06:50:44 INFO - Running cycle 1/1 for kraken test... 06:50:44 INFO - TEST-INFO | started process 15430 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDWSVEh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:50:56 INFO - PROCESS | 15430 | RSS: Main: 158044160 06:50:56 INFO - PROCESS | 15430 | 06:50:59 INFO - PROCESS | 15430 | Cycle 1(1): loaded http://localhost:35772/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35772/tests/kraken/driver.html?testName=audio-beat-detection) 06:50:59 INFO - PROCESS | 15430 | RSS: Main: 213979136 06:50:59 INFO - PROCESS | 15430 | 06:51:02 INFO - PROCESS | 15430 | Cycle 1(1): loaded http://localhost:35772/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35772/tests/kraken/driver.html?testName=audio-dft) 06:51:03 INFO - PROCESS | 15430 | RSS: Main: 191344640 06:51:03 INFO - PROCESS | 15430 | 06:51:06 INFO - PROCESS | 15430 | Cycle 1(1): loaded http://localhost:35772/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35772/tests/kraken/driver.html?testName=audio-fft) 06:51:07 INFO - PROCESS | 15430 | RSS: Main: 271433728 06:51:07 INFO - PROCESS | 15430 | 06:51:09 INFO - PROCESS | 15430 | Cycle 1(1): loaded http://localhost:35772/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35772/tests/kraken/driver.html?testName=audio-oscillator) 06:51:10 INFO - PROCESS | 15430 | RSS: Main: 180142080 06:51:10 INFO - PROCESS | 15430 | 06:51:12 INFO - PROCESS | 15430 | Cycle 1(1): loaded http://localhost:35772/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35772/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:51:12 INFO - PROCESS | 15430 | RSS: Main: 185028608 06:51:12 INFO - PROCESS | 15430 | 06:51:16 INFO - PROCESS | 15430 | Cycle 1(1): loaded http://localhost:35772/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35772/tests/kraken/driver.html?testName=imaging-darkroom) 06:51:16 INFO - PROCESS | 15430 | RSS: Main: 220950528 06:51:16 INFO - PROCESS | 15430 | 06:51:20 INFO - PROCESS | 15430 | Cycle 1(1): loaded http://localhost:35772/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35772/tests/kraken/driver.html?testName=imaging-desaturate) 06:51:20 INFO - PROCESS | 15430 | RSS: Main: 214925312 06:51:20 INFO - PROCESS | 15430 | 06:51:23 INFO - PROCESS | 15430 | Cycle 1(1): loaded http://localhost:35772/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35772/tests/kraken/driver.html?testName=json-parse-financial) 06:51:24 INFO - PROCESS | 15430 | RSS: Main: 218468352 06:51:24 INFO - PROCESS | 15430 | 06:51:26 INFO - PROCESS | 15430 | Cycle 1(1): loaded http://localhost:35772/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35772/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:51:26 INFO - PROCESS | 15430 | RSS: Main: 184094720 06:51:26 INFO - PROCESS | 15430 | 06:51:28 INFO - PROCESS | 15430 | Cycle 1(1): loaded http://localhost:35772/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35772/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:51:29 INFO - PROCESS | 15430 | RSS: Main: 189079552 06:51:29 INFO - PROCESS | 15430 | 06:51:31 INFO - PROCESS | 15430 | Cycle 1(1): loaded http://localhost:35772/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35772/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:51:32 INFO - PROCESS | 15430 | RSS: Main: 193990656 06:51:32 INFO - PROCESS | 15430 | 06:51:34 INFO - PROCESS | 15430 | Cycle 1(1): loaded http://localhost:35772/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35772/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:51:35 INFO - PROCESS | 15430 | RSS: Main: 189382656 06:51:35 INFO - PROCESS | 15430 | 06:51:38 INFO - PROCESS | 15430 | Cycle 1(1): loaded http://localhost:35772/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35772/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:51:38 INFO - PROCESS | 15430 | RSS: Main: 192266240 06:51:38 INFO - PROCESS | 15430 | 06:51:40 INFO - PROCESS | 15430 | Cycle 1(1): loaded http://localhost:35772/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35772/tests/kraken/driver.html?testName=ai-astar) 06:51:40 INFO - PROCESS | 15430 | RSS: Main: 242937856 06:51:40 INFO - PROCESS | 15430 | 06:51:40 INFO - PROCESS | 15430 | __start_tp_report 06:51:40 INFO - PROCESS | 15430 | _x_x_mozilla_page_load 06:51:40 INFO - PROCESS | 15430 | _x_x_mozilla_page_load_details 06:51:40 INFO - PROCESS | 15430 | |i|pagename|runs| 06:51:40 INFO - PROCESS | 15430 | |0;ai-astar;107;119;116;115;124;115;114;115;115;114 06:51:40 INFO - PROCESS | 15430 | |1;audio-beat-detection;149;123;123;188;123;129;156;125;163;127 06:51:40 INFO - PROCESS | 15430 | |2;audio-dft;160;162;160;162;161;163;164;162;161;162 06:51:40 INFO - PROCESS | 15430 | |3;audio-fft;87;75;75;127;75;77;74;76;108;76 06:51:40 INFO - PROCESS | 15430 | |4;audio-oscillator;85;85;124;85;85;85;117;84;85;132 06:51:40 INFO - PROCESS | 15430 | |5;imaging-gaussian-blur;116;116;117;117;116;116;116;116;117;117 06:51:40 INFO - PROCESS | 15430 | |6;imaging-darkroom;147;146;146;146;148;146;146;147;146;146 06:51:40 INFO - PROCESS | 15430 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;96 06:51:40 INFO - PROCESS | 15430 | |8;json-parse-financial;64;62;69;63;64;63;63;62;62;63 06:51:40 INFO - PROCESS | 15430 | |9;json-stringify-tinderbox;65;66;65;64;65;64;65;66;66;65 06:51:40 INFO - PROCESS | 15430 | |10;stanford-crypto-aes;79;79;79;80;81;91;79;79;88;81 06:51:40 INFO - PROCESS | 15430 | |11;stanford-crypto-ccm;132;142;130;130;128;129;128;128;178;131 06:51:40 INFO - PROCESS | 15430 | |12;stanford-crypto-pbkdf2;171;165;166;166;161;163;163;165;170;173 06:51:40 INFO - PROCESS | 15430 | |13;stanford-crypto-sha256-iterative;67;68;67;66;70;66;67;66;68;70 06:51:40 INFO - PROCESS | 15430 | __end_tp_report 06:51:40 INFO - PROCESS | 15430 | __start_cc_report 06:51:40 INFO - PROCESS | 15430 | _x_x_mozilla_cycle_collect,1970 06:51:40 INFO - PROCESS | 15430 | __end_cc_report 06:51:40 INFO - PROCESS | 15430 | __startTimestamp1470232300892__endTimestamp 06:51:40 INFO - PROCESS | 15430 | 06:51:40 INFO - PROCESS | 15430 | ------- Summary: start ------- 06:51:40 INFO - PROCESS | 15430 | Number of tests: 14 06:51:40 INFO - PROCESS | 15430 | 06:51:40 INFO - PROCESS | 15430 | [#0] ai-astar Cycles:10 Average:115.40 Median:115.00 stddev:4.25 (3.7%) stddev-sans-first:3.24 06:51:40 INFO - PROCESS | 15430 | Values: 107.0 119.0 116.0 115.0 124.0 115.0 114.0 115.0 115.0 114.0 06:51:40 INFO - PROCESS | 15430 | 06:51:40 INFO - PROCESS | 15430 | [#1] audio-beat-detection Cycles:10 Average:140.60 Median:139.00 stddev:22.48 (16.2%) stddev-sans-first:23.64 06:51:40 INFO - PROCESS | 15430 | Values: 149.0 123.0 123.0 188.0 123.0 129.0 156.0 125.0 163.0 127.0 06:51:40 INFO - PROCESS | 15430 | 06:51:40 INFO - PROCESS | 15430 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.25 (0.8%) stddev-sans-first:1.17 06:51:40 INFO - PROCESS | 15430 | Values: 160.0 162.0 160.0 162.0 161.0 163.0 164.0 162.0 161.0 162.0 06:51:40 INFO - PROCESS | 15430 | 06:51:40 INFO - PROCESS | 15430 | [#3] audio-fft Cycles:10 Average:85.00 Median:75.50 stddev:18.09 (24.0%) stddev-sans-first:19.17 06:51:40 INFO - PROCESS | 15430 | Values: 87.0 75.0 75.0 127.0 75.0 77.0 74.0 76.0 108.0 76.0 06:51:40 INFO - PROCESS | 15430 | 06:51:40 INFO - PROCESS | 15430 | [#4] audio-oscillator Cycles:10 Average:96.70 Median:85.00 stddev:19.40 (22.8%) stddev-sans-first:20.11 06:51:40 INFO - PROCESS | 15430 | Values: 85.0 85.0 124.0 85.0 85.0 85.0 117.0 84.0 85.0 132.0 06:51:40 INFO - PROCESS | 15430 | 06:51:40 INFO - PROCESS | 15430 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 06:51:40 INFO - PROCESS | 15430 | Values: 116.0 116.0 117.0 117.0 116.0 116.0 116.0 116.0 117.0 117.0 06:51:40 INFO - PROCESS | 15430 | 06:51:40 INFO - PROCESS | 15430 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 06:51:40 INFO - PROCESS | 15430 | Values: 147.0 146.0 146.0 146.0 148.0 146.0 146.0 147.0 146.0 146.0 06:51:40 INFO - PROCESS | 15430 | 06:51:40 INFO - PROCESS | 15430 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 06:51:40 INFO - PROCESS | 15430 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 06:51:40 INFO - PROCESS | 15430 | 06:51:40 INFO - PROCESS | 15430 | [#8] json-parse-financial Cycles:10 Average:63.50 Median:63.00 stddev:2.07 (3.3%) stddev-sans-first:2.19 06:51:40 INFO - PROCESS | 15430 | Values: 64.0 62.0 69.0 63.0 64.0 63.0 63.0 62.0 62.0 63.0 06:51:40 INFO - PROCESS | 15430 | 06:51:40 INFO - PROCESS | 15430 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 06:51:40 INFO - PROCESS | 15430 | Values: 65.0 66.0 65.0 64.0 65.0 64.0 65.0 66.0 66.0 65.0 06:51:40 INFO - PROCESS | 15430 | 06:51:40 INFO - PROCESS | 15430 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:80.50 stddev:4.30 (5.3%) stddev-sans-first:4.46 06:51:40 INFO - PROCESS | 15430 | Values: 79.0 79.0 79.0 80.0 81.0 91.0 79.0 79.0 88.0 81.0 06:51:40 INFO - PROCESS | 15430 | 06:51:40 INFO - PROCESS | 15430 | [#11] stanford-crypto-ccm Cycles:10 Average:135.60 Median:130.50 stddev:15.46 (11.9%) stddev-sans-first:16.35 06:51:40 INFO - PROCESS | 15430 | Values: 132.0 142.0 130.0 130.0 128.0 129.0 128.0 128.0 178.0 131.0 06:51:40 INFO - PROCESS | 15430 | 06:51:40 INFO - PROCESS | 15430 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.30 Median:166.00 stddev:3.86 (2.3%) stddev-sans-first:3.70 06:51:40 INFO - PROCESS | 15430 | Values: 171.0 165.0 166.0 166.0 161.0 163.0 163.0 165.0 170.0 173.0 06:51:40 INFO - PROCESS | 15430 | 06:51:40 INFO - PROCESS | 15430 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.50 stddev:1.51 (2.2%) stddev-sans-first:1.59 06:51:40 INFO - PROCESS | 15430 | Values: 67.0 68.0 67.0 66.0 70.0 66.0 67.0 66.0 68.0 70.0 06:51:40 INFO - PROCESS | 15430 | -------- Summary: end -------- 06:51:40 INFO - PROCESS | 15430 | 06:51:41 INFO - TEST-INFO | 15430: exit 0 06:51:42 INFO - TEST-OK | kraken | took 64039ms 06:51:42 INFO - SUITE-END | took 1183s 06:51:42 INFO - Completed test suite (00:19:44) 06:51:42 INFO - javascript benchmark 06:51:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2639.6436481075057, 2648.3246772073117, 2674.5720684690455, 2680.4103097318584, 2687.650605421295, 4644.651651126171, 4700.0599880023965, 4779.115863565238, 4913.656044076921, 4921.5078492150815, 4711.78796954137, 4723.952760472403, 4731.124741922747, 4747.857564273068, 4773.212419950704, 4323.308270676693, 4371.4098596689355, 4373.825046998132, 4391.363252328419, 4426.97786511067, 4359.716618419809, 4394.47266328041, 4418.491873434548, 4426.247537918545, 4472.016156445577, 4512.887177820564, 4534.8186072557055, 4536.092781443708, 4546.613537849286, 4553.134904368176, 4269.551697071794, 4321.524632290446, 4369.6285815705705, 4422.867313980586, 4485.013297074638, 4320.82716691332, 4331.97834010828, 4340.13197360526, 4397.714148580332, 4480.19356515827, 4796.496367881392, 4816.927746083811, 4847.75761211938, 4848.12733707936, 4848.224284114524, 4919.458859525449, 5060.974695126501, 5166.9224961625605, 5174.456682048369, 5226.97386513065, 5104.744762761884, 5185.222216667492, 5196.58427325813, 5198.428172900978, 5201.375834899836, 4766.285057241372, 4800.039992001613, 4812.422509298906, 4813.7593120344545, 4844.370231869834, 5008.949910500921, 5235.790568377222, 5278.81524146653, 5312.628116031918, 5321.547668448148, 5082.059818933509, 5106.412762532356, 5148.279240906276, 5151.922721159186, 5156.92264616031, 5153.227015947563, 5153.2785410042625, 5153.845384638467, 5154.845354639367, 5193.766280517386, 4860.149473842063, 4906.092372911023, 4962.379702537183, 5139.22911563261, 5202.219667049897, 5016.272640467112, 5050.873728156752, 5081.2378143278065, 5105.7191854448365, 5113.795448182031, 4315.395844581761, 4322.459692538433, 4324.070324880166, 4326.069894972596, 4363.563643635674, 3765.8305376258136, 3779.7732136071922, 3831.5976822433245, 3840.462335273064, 3845.480860083853, 4359.324304732771, 4401.053773438662, 4404.471463424409, 4418.072204836956, 4459.397981272552, 5129.0, 5138.38339399267, 5142.357205349332, 5145.382554093533, 5191.143461328838, 4179.791010449465, 4389.824407023683, 4395.516493185747, 4404.1411924674385, 4441.733495990251, 4598.701084429501, 4639.141758774637, 4654.906901861944, 4665.86002419928, 4709.152352576501, 4835.443923948791, 4839.249916262985, 4849.757512124309, 4852.927206091982, 4900.093482705711, 4930.0, 5151.124308867426, 5178.43037265908, 5192.636515443883, 5244.344456942882, 4757.09615173116, 4836.12949669063, 4847.127517046965, 4852.539008794159, 4857.295692124693, 5080.568151706999, 5093.2105523643895, 5101.0, 5103.081445339874, 5152.76812543429, 4889.168841296917, 5161.277421160966, 5178.741062946762, 5182.507661772125, 5228.37259528859, 4909.091818013679, 4944.8763780905765, 4974.403071631427, 4992.2761199626575, 5015.0, 4981.551660350586, 4990.750462476934, 4992.101421744121, 4995.750212489288, 5028.874278142929, 4789.353437285922, 4855.271709243641, 4897.0, 4908.263760435963, 4948.257761335684, 5010.824621138243, 5070.797168113234, 5078.08594453002, 5085.923711144262, 5119.6416250862085, 4970.304157418037, 4982.128127577732, 4982.501749824988, 4985.052839960396, 5019.949800502094], "value": 4709.720990277032, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.5703986450364, 565.4938829747374, 578.1356871477142, 579.5537436174143, 580.3036356372353, 27975.300617484547, 39775.602243977584, 41040.17919641605, 41089.794551027204, 44380.0, 41039.79480102603, 41537.37693934586, 41554.58445415545, 41603.79198104013, 41604.16791664165, 7293.307135822101, 7414.0, 7425.628718564078, 7432.442566807511, 7432.925670743278, 5957.136215248786, 6015.157877897098, 6016.789412370568, 6021.789237376693, 6030.66831324277, 5992.131140984555, 5998.730057147439, 6011.969940150293, 6012.969935150318, 6029.366916473773, 5950.642961422307, 5957.731902064395, 5958.106284057426, 5959.22530071088, 5965.403459654, 7660.272274134004, 7689.692412303501, 7712.768616941501, 7713.0, 7725.922740772577, 38665.80667096675, 38869.0, 38934.80532597347, 38999.220015599814, 39019.21961560753, 2956.8521573921216, 2999.875791827102, 3073.017903452283, 3204.3110731192905, 3278.541004259406, 29238.707612923812, 30302.84848575743, 30509.38981220363, 31008.37983240345, 31778.0, 3106.766992475551, 3249.2689144942437, 3279.8688052477873, 3281.721053710414, 3307.0, 189649.0, 189802.0, 190372.0, 190454.0, 190536.0, 31839.204019899687, 53830.7308463463, 54051.18923216155, 54052.72973635185, 54173.0, 32320.35359292801, 34455.65544344525, 34623.82688086594, 34647.82676086603, 34656.82671586626, 12959.0, 13062.477500900048, 13067.869321306855, 13082.345882705828, 13090.410931507915, 11167.888321116847, 11191.888081119247, 11221.943890280496, 11266.155038372155, 11303.886961130447, 7876.881846772303, 7906.248906353887, 7928.246816552418, 7958.124606293303, 8009.479383840032, 3091.397177550401, 3117.8752849886205, 3125.0312403155094, 3142.858571364294, 3222.3072039511617, 825.7192554531488, 870.1602953150241, 880.7577916073132, 938.6761567259284, 954.9618015279311, 28424.563625213614, 28608.284792880346, 28753.56869646957, 28971.42057158887, 29306.706932930825, 747.3759410891967, 947.313197931508, 963.272729089533, 968.1867231525553, 995.681381957781, 14339.211343376215, 15044.398224071134, 15234.162121083447, 15380.92309538445, 15503.5348939532, 382370.0, 384808.0, 385052.0, 386090.0, 386511.0, 50125.74937125291, 50575.49424505782, 50604.49395505998, 50633.746831265606, 50708.49291507112, 1021.1218352217087, 1157.5890558851654, 1169.4036041618835, 1180.4569897846916, 1203.6750077479207, 28705.856470717514, 29501.85249073741, 30132.0, 30150.69849301479, 30877.0736877894, 41539.58460415357, 42066.57933420627, 42082.36876446917, 42131.73604791861, 42139.578604213566, 306468.0, 307612.0, 307940.0, 308365.0, 309398.0, 26804.927802887665, 27757.0, 27801.44397112087, 27952.161435156977, 28094.85952570224, 42417.787911060244, 42807.0, 42920.141597168506, 43896.56103438925, 44753.77623111864, 35978.64021359753, 36130.45804312885, 37276.25447491089, 37980.62019379771, 38092.80953595214, 33461.498077529344, 33873.15317117092, 34196.48705269473, 34389.828050859585, 34692.653073468944, 35904.0, 36626.633733662326, 36755.78790141897, 36826.447603286506, 37335.25329493449, 31384.686153138176, 32783.50824737583, 33314.33371332608, 33693.66306336905, 33786.66213337934, 25824.48351032931, 25944.091956781424, 26020.0, 26026.60960085638, 26054.34864128412], "value": 16026.857693295902, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.8834907782278, 354.53201773658765, 355.74564186606574, 360.2884303500586, 388.9008302882766, 12699.0, 16441.50675479736, 16855.578610534743, 17872.553186170353, 18047.097645117756, 16533.25600347984, 17041.48875533733, 17110.31558737649, 17150.485485435456, 17220.569485762862, 4883.072216278913, 4975.950240497585, 4996.600271978233, 4998.975005124969, 5011.473795251501, 3683.852645894174, 5100.107481190796, 5155.149400348938, 5773.855653608673, 6079.574429789916, 6097.237845269341, 6118.969405152968, 6128.172696685957, 6129.172561704179, 6129.938700612981, 5961.672108034057, 6005.54958378119, 6054.394560543955, 6084.239470066242, 6089.695515224221, 5137.280780690707, 5304.20436934459, 5305.73471326436, 5309.123994540896, 5316.441773613792, 17468.47594572165, 17684.734728979074, 17690.91154544219, 17705.38031168903, 21379.8931005344, 1800.9369672061414, 1828.8536917046604, 1834.7614810074738, 1845.769278840145, 1851.2132343753985, 13079.934600327033, 13441.193528388329, 13469.730605387836, 13603.183808971395, 14081.85918140826, 1749.0, 1797.9910100449545, 1815.7276408538694, 1818.927242910282, 1859.0425930645729, 66563.66718166426, 71568.0, 71639.28360716431, 72028.27971720268, 72170.63914680446, 8443.155684431507, 8602.87095693565, 8714.128587141362, 9416.858747118798, 9798.951005245071, 12941.417636206394, 12942.805857912139, 12954.0, 12984.480620775063, 13005.544805931748, 6818.693158807866, 7018.368346848706, 7087.362137407555, 7217.494775365779, 7324.926750732531, 6570.342965703391, 6605.933940660628, 6666.733330666719, 6751.4261287790105, 6752.155980502437, 6038.396160383926, 6044.365341639153, 6066.75732970685, 6081.726322315506, 6090.939090609126, 1707.3597400974634, 1719.5443207550009, 1725.6721222967597, 1750.2561411400104, 1784.7769028871392, 692.6779047742824, 857.8455877941906, 872.6509396241554, 905.6920646980059, 911.5852287209303, 17375.913120434318, 17736.379226727262, 18064.81935180658, 18114.0, 18658.34695785641, 869.8477766390856, 876.6931573949195, 878.3939082033504, 945.7937591564602, 975.8731364922656, 9912.306138570231, 10301.9484902575, 10395.584176633001, 10404.68785936423, 10452.111570516592, 391219.0, 396761.0, 401563.0, 403706.0, 404448.0, 68572.0, 69220.65389673121, 70872.58254834874, 71624.0, 73829.6308518454, 907.0430695616188, 919.2783664823082, 931.0549791961165, 933.7198840347869, 935.2798345274101, 15400.46098386551, 15431.305591248196, 15878.0, 16142.435014774426, 16218.270177841789, 33842.15394615056, 35762.960148386635, 35976.82011589925, 36166.27667446584, 36898.815505923376, 45409.54590454053, 46313.76843115763, 46440.53559464497, 46474.30288545607, 46719.532804672875, 7170.282971702788, 7408.592527411044, 7498.58757768328, 7522.285382888617, 7618.961905190438, 10799.783048958374, 11846.170768046153, 12447.688807779878, 12536.561220357244, 12551.811722824348, 9335.626574936927, 9814.705558833246, 9990.900090998997, 10029.846567644814, 10161.84757228657, 10524.0, 10713.517891694737, 10874.0, 11022.338659680125, 11353.318800871974, 9870.210383169473, 10036.447995360326, 10045.748856278358, 10299.021592948659, 10368.896311037095, 7612.505187162817, 7679.692812287446, 7751.379889608705, 7754.263344982218, 7996.520208787491, 9640.276979226446, 10120.139788118093, 10202.0, 10243.948780256349, 10250.846237306298], "value": 8309.720329027701, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1300.1938797945272, 1301.5834932821494, 1372.5264783649643, 1592.21185513171, 1601.9919900400503, 7243.782686519399, 7806.1413244543055, 7809.062912450499, 7812.882806757896, 7817.335526480256, 6564.081028655992, 6770.3906648401635, 6776.695048722807, 6960.234374218832, 7643.61781910905, 1911.7132430135487, 2194.572058448603, 2236.8322375821876, 2248.7976082152604, 2261.977380226193, 2209.801117899389, 2218.245796429214, 2219.889005549724, 2221.7556068832414, 2224.822014238865, 2153.257126291427, 2233.0955962834996, 2239.3729755668355, 2244.753077161511, 2246.4945387287894, 2152.0208305221086, 2161.4056134563043, 2194.0675213034397, 2235.0277629231173, 2237.3064350051536, 2154.4613846538364, 2155.95688086239, 2162.4701948022835, 2165.4261620670536, 2165.7725938776516, 7841.647125879349, 7895.407844411692, 7941.64262608184, 7944.04671439431, 7950.880736788953, 4487.259602165639, 4607.0, 4620.376249206348, 4622.745748983804, 4624.537546245382, 2810.5924640927155, 2864.398476319975, 2937.8384188869604, 2954.7340739333563, 2959.7632189424794, 867.8090820019648, 903.575319599787, 906.5829718329576, 906.5965645287849, 909.1363204955319, 10555.84166237507, 10588.364698118137, 10593.78812423755, 10596.735081623021, 10619.30974486656, 3952.173400871687, 4043.757374557536, 4167.291560434734, 4224.831006759757, 4241.300185469363, 8942.86585701215, 9029.503377314311, 9046.683366082287, 9065.954670226738, 9069.0, 4601.28680054592, 4601.309803529497, 4605.332226827091, 4613.146567884952, 4624.421947256593, 4117.91764164715, 4227.556106608823, 4227.852025179104, 4234.576542345741, 4240.982164280612, 3656.8171591420323, 3702.444633305026, 3776.6412190842375, 3782.130110074643, 3790.8483660653815, 1159.3449700919123, 1178.1752773058893, 1181.6218809980724, 1187.7327601289642, 1202.81957706343, 650.9511786616023, 663.3697986912356, 684.1858188755365, 708.2209569473538, 713.561159886666, 4816.470188279286, 4878.780454879539, 4937.901241975141, 4965.503449655005, 5046.7476626168545, 806.1132753970703, 809.7893648994791, 843.2073850580434, 843.2537204573873, 850.9106543812934, 3220.6457289698114, 3352.2960178362327, 3407.369636617234, 3432.5880894292345, 3473.975177322696, 9564.4739539326, 9987.051230133126, 9989.60041598328, 9992.200623950066, 9995.750106247257, 9901.15840153595, 9926.751831204134, 9958.053984871425, 9964.302498825158, 9970.45162516054, 7131.1678651128195, 7180.676869540883, 7275.745348912763, 7288.9271107289305, 7292.416606671453, 4873.147199240189, 4899.681520701143, 4917.926231106608, 4937.802487900443, 4995.900081998267, 8595.82808343842, 8700.260477859452, 8800.823983520166, 9062.22971047442, 9070.365074444726, 8746.51894145828, 9107.134822191882, 9166.450012999241, 9228.0, 9238.722838314861, 6333.96833015832, 6447.451966582893, 6548.1814773153355, 6669.7665581704405, 6768.7292508299115, 7511.887321690069, 7556.622168891424, 7567.583782891994, 7582.0, 7590.39276857839, 6598.670066496752, 6654.534182607171, 6769.08617336673, 6774.695138718868, 6783.491238157059, 6400.839979000562, 6447.91131377922, 6478.481721462366, 6510.707018184098, 6648.235452922976, 5968.97015514937, 6055.394460553909, 6058.636481811105, 6058.757649693963, 6059.848503787441, 4218.7468751874985, 4340.500842403164, 4348.065165989327, 4421.204183247047, 4423.0, 4143.357779544175, 4294.184105020036, 4351.238533256731, 4389.670774691847, 4409.911801764011], "value": 4062.1974407549924, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.05540933784897, 289.7899023208174, 290.91999700082476, 299.44004711190075, 301.9064090132059, 4883.584895283901, 4893.9934626803015, 4906.31311616374, 4917.680350777197, 4918.114739346916, 4839.8790030249265, 4850.757462126889, 4861.124997500448, 4873.171560834658, 4876.707397556149, 3819.1597848473293, 3835.4438606402123, 3839.4048922416932, 3840.961590384088, 3855.3253180693405, 3612.638736126393, 3660.7125156123006, 3816.2749077675294, 3838.193979264358, 3850.114473671057, 2634.367751739578, 3521.0, 3593.3352329818936, 3626.764260323084, 3737.3272810894027, 3605.9098522537147, 3695.316366472211, 3712.628737126293, 3758.0416993666577, 3758.8684396046006, 3240.9142937116094, 3244.253821621017, 3248.2366643838914, 3257.5765150530515, 3283.770136090475, 4454.37638730578, 4524.0, 4700.224462963607, 4716.50476699945, 4728.4798672146035, 4217.3973889921945, 4223.598758117974, 4234.343676730081, 4235.576442355739, 4244.936325955113, 5015.297858299841, 5025.874353141164, 5035.144025515671, 5037.319961805146, 5080.415752188509, 3429.879954201591, 3491.0, 3517.66582174693, 3518.6481351864863, 3533.116720819795, 5210.036143313499, 5210.6613070150315, 5211.817586384458, 5226.216067589854, 5228.947710522884, 3594.6944509716445, 3633.4004889193516, 3634.109643137448, 3635.4910312556262, 3635.909102272464, 3691.0956815579816, 3693.8891833245048, 3694.224212915264, 3694.5012423323046, 3700.296943580765, 4039.313316736162, 4222.78886055696, 4227.556106608823, 4235.047114399297, 4258.488981322199, 5014.342398528785, 5016.774245158977, 5024.79900803971, 5056.140456122468, 5082.669626474268, 1264.134068163311, 1276.412850088951, 1281.7756892543769, 1281.916675416095, 1290.167841742071, 822.5887056471764, 822.6051495282298, 838.5388036579857, 840.1850205300848, 865.1780808232205, 4402.207602631557, 4404.405405270248, 4411.691181617256, 4415.359772832921, 4439.378487011821, 5129.281900533928, 5131.409887862869, 5142.280080788692, 5159.864829737452, 5206.0, 4264.914701705949, 4392.616325857345, 4396.625822056118, 4399.670024748157, 4412.183746006999, 2709.4851978124093, 2710.715374885648, 2733.166384252822, 2753.7796976241852, 2753.9397332027315, 4699.895524551727, 4831.95168048322, 4843.927341089887, 4851.296561998491, 4855.757212139379, 4737.526247375235, 5185.637005409661, 5198.142306519458, 5202.3497062867145, 5233.581313494911, 4832.685875418087, 4840.0, 4889.853304400874, 4907.190313598217, 4934.457209707001, 5212.582993360598, 5216.191490319006, 5236.711980841091, 5259.317018554026, 5273.34083239595, 4939.777710002986, 5029.74851257443, 5070.746462676778, 5077.689651208618, 5078.56832169255, 4809.470958194665, 4832.613390928787, 4846.5638092571835, 4873.658843881036, 4883.658143929891, 3594.640535946489, 3602.2075143468396, 3628.8185590720886, 3647.8176091194805, 3662.9450558241115, 5114.718690471911, 5238.266642670105, 5243.842684719464, 5246.0, 5256.89486210266, 5011.974940125276, 5026.145555255688, 5029.321041659329, 5029.5221953914315, 5045.344105266292, 5026.145555255543, 5029.245613158056, 5042.29407882904, 5046.646734728533, 5098.388193416814, 4759.214729569582, 4982.128127577587, 4989.35138432016, 4990.0, 5028.4663177731145, 5041.361557493902, 5075.543201111917, 5077.213031980049, 5092.2361645753435, 5105.948940510547, 4963.156263435152, 4981.327520784793, 4981.985898531337, 5019.799208031784, 5021.196608542616], "value": 3772.7601240660088, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.4301927130683, 607.0, 650.3399049964287, 680.6630717794692, 688.9355945064874, 11690.47392867321, 12306.138570300083, 12328.938355308223, 12791.104622676416, 12871.227726336427, 12049.15655904087, 12518.374081295944, 12601.495940162382, 12620.684482887933, 12681.112322137455, 590.5010266324948, 749.3518106837573, 765.7281665008925, 765.8889461028148, 765.9617019149048, 717.7810767715845, 776.6932061835572, 780.6838230516621, 784.52928243054, 785.8153333966513, 814.9511029338229, 816.742726041298, 818.8198596308832, 820.1552401026922, 820.9712660056899, 596.1058412381428, 811.7686459359084, 816.0, 816.3346872299087, 816.7223144130994, 399.67626222759367, 408.84055218464823, 409.44111288091835, 411.4096271849905, 411.4445498576927, 12399.814002789966, 12412.944899683538, 12416.689582760413, 12435.191712538655, 12470.314132722697, 11230.382328971904, 11855.881441185564, 12046.277223366626, 12254.0, 12550.246985180918, 8982.550872456417, 9046.819063618757, 11610.767784644344, 11741.589044383405, 11754.412279386082, 4077.510698716173, 4078.2047500737367, 4092.406601042862, 4110.815013324378, 4271.722338048048, 60759.69620151915, 61754.38245617531, 62009.689951550405, 62927.37072629261, 62975.0, 9202.30982676302, 9557.283203759745, 9678.128968392879, 9754.75613109678, 9871.01289871007, 15680.843191568167, 16351.67296654084, 16600.83399166017, 16669.666606667797, 16757.078360690037, 6045.697715114315, 6063.272407311063, 6070.544709146831, 6095.725692343855, 6290.748370065237, 3498.737594680409, 3552.644735526478, 3579.51676523666, 3605.3149901518627, 3617.222297206113, 2552.706438759529, 2626.4484458263596, 2651.9337016574354, 2652.82756620819, 2658.6012098185042, 490.8404768450268, 492.3845193508115, 492.4337012435656, 495.58370968386726, 503.5166240409175, 410.4049128763305, 430.0689008297064, 455.6628095209587, 465.8998315362213, 486.5086262874522, 6769.3907548320885, 6923.9307606923285, 6974.232834388214, 7252.746153884589, 7620.923790762022, 451.3635773559331, 465.9114768194032, 469.4859129253462, 482.7827477635008, 489.2685435274288, 3330.2506935939705, 3417.1457135716073, 3436.244026314207, 3482.8084455355197, 3668.156324045431, 58028.419715803146, 100530.49734751279, 100725.99274007312, 106065.46967265269, 107697.4615126935, 25519.87240063788, 25562.0, 78283.60858195672, 88804.555977221, 89008.0, 79197.20802792013, 80065.59967200126, 80243.0, 81614.59192704117, 81720.0, 6786.524943254122, 7699.576523291273, 7811.921880781119, 7949.443538952218, 7998.5600791957, 31302.843485782425, 31790.20524486814, 36948.81525592462, 43342.0, 44056.0, 41753.58246417497, 42110.157796844505, 53507.732461337444, 62724.372756271856, 65169.67415162894, 10276.897231027893, 10362.222833287382, 10404.58381664725, 10528.789424211625, 10620.575176992834, 11507.769844603228, 11689.766204675689, 11810.0, 11949.342786146497, 12405.503779848705, 10326.586936522455, 10351.948240258751, 10874.510647020745, 10903.073238774792, 10966.232363734462, 10173.23700722434, 10408.47957602132, 10583.417912014913, 10598.841017384591, 10815.837762433726, 10876.673699789018, 11329.263597866113, 11453.770924581628, 11504.309741415542, 11592.768144636892, 9344.439333640003, 9443.291753118407, 9535.38020028696, 9741.366811157252, 9978.451185184595, 8848.424852384574, 9647.662331818352, 10041.748956276151, 10053.69838904834, 10056.798864022532], "value": 6057.476766940094, "unit": "score"}], "name": "dromaeo_css", "value": 6225.842276452503, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 119.0, 116.0, 115.0, 124.0, 115.0, 114.0, 115.0, 115.0, 114.0], "value": 115.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 123.0, 123.0, 188.0, 123.0, 129.0, 156.0, 125.0, 163.0, 127.0], "value": 140.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 160.0, 162.0, 161.0, 163.0, 164.0, 162.0, 161.0, 162.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 75.0, 75.0, 127.0, 75.0, 77.0, 74.0, 76.0, 108.0, 76.0], "value": 85.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 124.0, 85.0, 85.0, 85.0, 117.0, 84.0, 85.0, 132.0], "value": 96.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 117.0, 116.0, 116.0, 116.0, 116.0, 117.0, 117.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 148.0, 146.0, 146.0, 147.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 69.0, 63.0, 64.0, 63.0, 63.0, 62.0, 62.0, 63.0], "value": 63.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 64.0, 65.0, 64.0, 65.0, 66.0, 66.0, 65.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 79.0, 80.0, 81.0, 91.0, 79.0, 79.0, 88.0, 81.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 142.0, 130.0, 130.0, 128.0, 129.0, 128.0, 128.0, 178.0, 131.0], "value": 135.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 165.0, 166.0, 166.0, 161.0, 163.0, 163.0, 165.0, 170.0, 173.0], "value": 166.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 66.0, 70.0, 66.0, 67.0, 66.0, 68.0, 70.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1536.8999999999996, "alertThreshold": 2.0}]} 06:51:42 INFO - Return code: 0 06:51:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:51:42 INFO - # TBPL SUCCESS # 06:51:42 INFO - Running post-action listener: _resource_record_post_action 06:51:42 INFO - [mozharness: 2016-08-03 13:51:42.703662Z] Finished run-tests step (success) 06:51:42 INFO - Running post-run listener: _resource_record_post_run 06:51:42 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 8192; Write bytes: 522149888; Read time: 84; Write time: 441256 06:51:42 INFO - TinderboxPrint: CPU usage
13.0% 06:51:42 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 84 06:51:42 INFO - TinderboxPrint: I/O write bytes / time
522,149,888 / 441,256 06:51:42 INFO - TinderboxPrint: CPU idle
8,333.6 (87.0%) 06:51:42 INFO - TinderboxPrint: CPU user
1,200.0 (12.5%) 06:51:42 INFO - TinderboxPrint: Swap in / out
0 / 0 06:51:42 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237473792; Read time: 0; Write time: 231140 06:51:42 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284676096; Read time: 76; Write time: 210116 06:51:43 INFO - Running post-run listener: _upload_blobber_files 06:51:43 INFO - Blob upload gear active. 06:51:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:51: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:51: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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:51: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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:51:43 INFO - (blobuploader) - INFO - Open directory for files ... 06:51:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:51:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:51:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:51:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:51:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:51:44 INFO - (blobuploader) - INFO - Done attempting. 06:51:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:51:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:51:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:51:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:51:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:51:45 INFO - (blobuploader) - INFO - Done attempting. 06:51:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:51:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:51:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:51:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:51:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:51:48 INFO - (blobuploader) - INFO - Done attempting. 06:51:48 INFO - (blobuploader) - INFO - Iteration through files over. 06:51:48 INFO - Return code: 0 06:51:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:51:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:51:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/420ed8ae180b9560036b074d4e26a7f67aa67528ee60547bbdbf18d93d22391ffcfaff22c5becdb477510af33bd860be7d77bfdba3b856f4db97df66543588d7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/75ffcf30331c56280ccb740fc081fee72c549035831e68751ae7c4ec09e22e7ebe81fa0bf752900179f50971fe9ef8d20b8d7a6fec86a257603516b142119837", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0ab54b310541d1c11dd32341ea184753643fde8b5f8bce1788443492285a4d00faf810573c7946e3f7083803af76c8abeebab064fb45b3cbe836d0a8014a32bc"} 06:51:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:51:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:51:48 INFO - Contents: 06:51:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/420ed8ae180b9560036b074d4e26a7f67aa67528ee60547bbdbf18d93d22391ffcfaff22c5becdb477510af33bd860be7d77bfdba3b856f4db97df66543588d7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/75ffcf30331c56280ccb740fc081fee72c549035831e68751ae7c4ec09e22e7ebe81fa0bf752900179f50971fe9ef8d20b8d7a6fec86a257603516b142119837", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0ab54b310541d1c11dd32341ea184753643fde8b5f8bce1788443492285a4d00faf810573c7946e3f7083803af76c8abeebab064fb45b3cbe836d0a8014a32bc"} 06:51:48 INFO - Running post-run listener: copy_logs_to_upload_dir 06:51:48 INFO - Copying logs to upload dir... 06:51:48 INFO - mkdir: /builds/slave/test/build/upload/logs 06:51:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.369720 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-08-03 06:51:48.625429) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-03 06:51:48.628756) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1470229579.484617-765975799 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/420ed8ae180b9560036b074d4e26a7f67aa67528ee60547bbdbf18d93d22391ffcfaff22c5becdb477510af33bd860be7d77bfdba3b856f4db97df66543588d7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/75ffcf30331c56280ccb740fc081fee72c549035831e68751ae7c4ec09e22e7ebe81fa0bf752900179f50971fe9ef8d20b8d7a6fec86a257603516b142119837", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0ab54b310541d1c11dd32341ea184753643fde8b5f8bce1788443492285a4d00faf810573c7946e3f7083803af76c8abeebab064fb45b3cbe836d0a8014a32bc"} build_url:https://queue.taskcluster.net/v1/task/dxXKQZotRC--0uAvWQi4lA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011328 build_url: 'https://queue.taskcluster.net/v1/task/dxXKQZotRC--0uAvWQi4lA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/420ed8ae180b9560036b074d4e26a7f67aa67528ee60547bbdbf18d93d22391ffcfaff22c5becdb477510af33bd860be7d77bfdba3b856f4db97df66543588d7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/75ffcf30331c56280ccb740fc081fee72c549035831e68751ae7c4ec09e22e7ebe81fa0bf752900179f50971fe9ef8d20b8d7a6fec86a257603516b142119837", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0ab54b310541d1c11dd32341ea184753643fde8b5f8bce1788443492285a4d00faf810573c7946e3f7083803af76c8abeebab064fb45b3cbe836d0a8014a32bc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-03 06:51:48.655374) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 06:51:48.655706) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1470229579.484617-765975799 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004531 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 06:51:48.741210) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-03 06:51:48.741529) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-03 06:51:48.741839) ========= ========= Total master_lag: 0.20 =========