builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-051 starttime: 1470042716.91 results: success (0) buildid: 20160731233002 builduid: e6c16dd86e6b414da5bb0ee71c721d6b revision: 482f81651a2e9b65b0066bdb99beadaa43827f29 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 02:11:56.908929) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 02:11:56.909369) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 02:11:56.909854) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 02:11:56.929723) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 02:11:56.930162) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1470042394.975943-494518010 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-01 02:11:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 67.1M=0s 2016-08-01 02:11:58 (67.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115460 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 02:11:57.060005) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 02:11:57.060321) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1470042394.975943-494518010 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017045 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 02:11:57.110470) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 02:11:57.110829) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 482f81651a2e9b65b0066bdb99beadaa43827f29 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 482f81651a2e9b65b0066bdb99beadaa43827f29 --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=5ac5dba3e01a12f1ff77ab15000001b1-1470042394.975943-494518010 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-01 02:11:58,822 truncating revision to first 12 chars 2016-08-01 02:11:58,822 Setting DEBUG logging. 2016-08-01 02:11:58,822 attempt 1/10 2016-08-01 02:11:58,822 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/482f81651a2e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-01 02:11:59,176 unpacking tar archive at: fx-team-482f81651a2e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.773531 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 02:11:57.898069) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 02:11:57.898492) ========= script_repo_revision: 482f81651a2e9b65b0066bdb99beadaa43827f29 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 02:11:57.899059) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 02:11:57.899492) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 02:11:57.911441) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-08-01 02:11:57.911758) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1470042394.975943-494518010 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:11:59 INFO - MultiFileLogger online at 20160801 02:11:59 in /builds/slave/test 02:11:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:11:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:11:59 INFO - {'append_to_log': False, 02:11:59 INFO - 'base_work_dir': '/builds/slave/test', 02:11:59 INFO - 'blob_upload_branch': 'Fx-Team', 02:11:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:11:59 INFO - 'branch': 'Fx-Team', 02:11:59 INFO - 'buildbot_json_path': 'buildprops.json', 02:11:59 INFO - 'config_files': ('talos/linux_config.py',), 02:11:59 INFO - 'default_actions': ('clobber', 02:11:59 INFO - 'read-buildbot-config', 02:11:59 INFO - 'download-and-extract', 02:11:59 INFO - 'populate-webroot', 02:11:59 INFO - 'create-virtualenv', 02:11:59 INFO - 'install', 02:11:59 INFO - 'run-tests'), 02:11:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:11:59 INFO - 'download_minidump_stackwalk': True, 02:11:59 INFO - 'download_symbols': 'ondemand', 02:11:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:11:59 INFO - 'tooltool.py': '/tools/tooltool.py', 02:11:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:11:59 INFO - '/tools/misc-python/virtualenv.py')}, 02:11:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:11:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:11:59 INFO - 'installer_path': 'installer.exe', 02:11:59 INFO - 'log_level': 'info', 02:11:59 INFO - 'log_name': 'talos', 02:11:59 INFO - 'log_to_console': True, 02:11:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:11:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:11:59 INFO - 'opt_config_files': (), 02:11:59 INFO - 'pip_index': False, 02:11:59 INFO - 'sps_profile': False, 02:11:59 INFO - 'sps_profile_interval': 0, 02:11:59 INFO - 'suite': 'dromaeojs', 02:11:59 INFO - 'system_bits': '32', 02:11:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:11:59 INFO - 'title': 'talos-linux64-ix-051', 02:11:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:11:59 INFO - 'use_talos_json': True, 02:11:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:11:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:11:59 INFO - 'work_dir': 'build'} 02:11:59 INFO - [mozharness: 2016-08-01 09:11:59.716767Z] Running clobber step. 02:11:59 INFO - Running pre-action listener: _resource_record_pre_action 02:11:59 INFO - Running main action method: clobber 02:11:59 INFO - rmtree: /builds/slave/test/build 02:11:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:12:00 INFO - Running post-action listener: _resource_record_post_action 02:12:00 INFO - [mozharness: 2016-08-01 09:12:00.185352Z] Finished clobber step (success) 02:12:00 INFO - [mozharness: 2016-08-01 09:12:00.185454Z] Running read-buildbot-config step. 02:12:00 INFO - Running pre-action listener: _resource_record_pre_action 02:12:00 INFO - Running main action method: read_buildbot_config 02:12:00 INFO - Using buildbot properties: 02:12:00 INFO - { 02:12:00 INFO - "project": "", 02:12:00 INFO - "product": "firefox", 02:12:00 INFO - "script_repo_revision": "production", 02:12:00 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:12:00 INFO - "repository": "", 02:12:00 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 02:12:00 INFO - "buildid": "20160731233002", 02:12:00 INFO - "pgo_build": "True", 02:12:00 INFO - "basedir": "/builds/slave/test", 02:12:00 INFO - "buildnumber": 1403, 02:12:00 INFO - "slavename": "talos-linux64-ix-051", 02:12:00 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:12:00 INFO - "platform": "ubuntu64_hw", 02:12:00 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:12:00 INFO - "branch": "fx-team", 02:12:00 INFO - "repo_path": "integration/fx-team", 02:12:00 INFO - "revision": "482f81651a2e9b65b0066bdb99beadaa43827f29", 02:12:00 INFO - "stage_platform": "linux64-pgo", 02:12:00 INFO - "builduid": "e6c16dd86e6b414da5bb0ee71c721d6b", 02:12:00 INFO - "slavebuilddir": "test" 02:12:00 INFO - } 02:12:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/WmjbcJYjRIuTNoQIVLKMjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:12:00 INFO - Running post-action listener: _resource_record_post_action 02:12:00 INFO - [mozharness: 2016-08-01 09:12:00.187901Z] Finished read-buildbot-config step (success) 02:12:00 INFO - [mozharness: 2016-08-01 09:12:00.187991Z] Running download-and-extract step. 02:12:00 INFO - Running pre-action listener: _resource_record_pre_action 02:12:00 INFO - Running main action method: download_and_extract 02:12:00 INFO - mkdir: /builds/slave/test/build/tests 02:12:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:00 INFO - https://queue.taskcluster.net/v1/task/WmjbcJYjRIuTNoQIVLKMjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:12:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmjbcJYjRIuTNoQIVLKMjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:12:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmjbcJYjRIuTNoQIVLKMjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:12:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmjbcJYjRIuTNoQIVLKMjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:12:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmjbcJYjRIuTNoQIVLKMjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:12:08 INFO - Downloaded 1361 bytes. 02:12:08 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:12:08 INFO - Using the following test package requirements: 02:12:08 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:12:08 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:12:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:12:08 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:12:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:12:08 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:12:08 INFO - u'jsshell-linux-x86_64.zip'], 02:12:08 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:12:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:12:08 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:12:08 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:12:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:12:08 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:12:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:12:08 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:12:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:12:08 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:12:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:12:08 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:12:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:08 INFO - https://queue.taskcluster.net/v1/task/WmjbcJYjRIuTNoQIVLKMjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:12:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmjbcJYjRIuTNoQIVLKMjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:12:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmjbcJYjRIuTNoQIVLKMjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:12:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmjbcJYjRIuTNoQIVLKMjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:12:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmjbcJYjRIuTNoQIVLKMjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:12:10 INFO - Downloaded 21807948 bytes. 02:12:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:12:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:12:11 INFO - Return code: 0 02:12:11 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:12:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:11 INFO - https://queue.taskcluster.net/v1/task/WmjbcJYjRIuTNoQIVLKMjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:12:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmjbcJYjRIuTNoQIVLKMjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:12:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmjbcJYjRIuTNoQIVLKMjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:12:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmjbcJYjRIuTNoQIVLKMjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:12:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmjbcJYjRIuTNoQIVLKMjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:12:21 INFO - Downloaded 21807948 bytes. 02:12:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:12:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:12:22 INFO - Return code: 0 02:12: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')]} 02:12:22 INFO - https://queue.taskcluster.net/v1/task/WmjbcJYjRIuTNoQIVLKMjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:12:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmjbcJYjRIuTNoQIVLKMjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:12:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmjbcJYjRIuTNoQIVLKMjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:12:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmjbcJYjRIuTNoQIVLKMjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:12:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmjbcJYjRIuTNoQIVLKMjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:12:23 INFO - Downloaded 14413723 bytes. 02:12:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:12:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:12:23 INFO - Return code: 0 02:12:23 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')]} 02:12:23 INFO - https://queue.taskcluster.net/v1/task/WmjbcJYjRIuTNoQIVLKMjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:12:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmjbcJYjRIuTNoQIVLKMjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:12:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmjbcJYjRIuTNoQIVLKMjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:12:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmjbcJYjRIuTNoQIVLKMjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:12:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmjbcJYjRIuTNoQIVLKMjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:12:25 INFO - Downloaded 59376635 bytes. 02:12:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WmjbcJYjRIuTNoQIVLKMjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:12:25 INFO - mkdir: /builds/slave/test/properties 02:12:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:12:25 INFO - Writing to file /builds/slave/test/properties/build_url 02:12:25 INFO - Contents: 02:12:25 INFO - build_url:https://queue.taskcluster.net/v1/task/WmjbcJYjRIuTNoQIVLKMjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:12:25 INFO - Running post-action listener: _resource_record_post_action 02:12:25 INFO - Running post-action listener: set_extra_try_arguments 02:12:25 INFO - [mozharness: 2016-08-01 09:12:25.910312Z] Finished download-and-extract step (success) 02:12:25 INFO - [mozharness: 2016-08-01 09:12:25.910546Z] Running populate-webroot step. 02:12:25 INFO - Running pre-action listener: _resource_record_pre_action 02:12:25 INFO - Running main action method: populate_webroot 02:12:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:12:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:12:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:12:25 INFO - '--tppagecycles', 02:12:25 INFO - '7'], 02:12:25 INFO - 'tests': ['tsvgm']}}, 02:12:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:12:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:12:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:12:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:12:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:12:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:12:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:12:25 INFO - 'talos_options': ['--disable-e10s'], 02:12:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:12:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:12:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:12:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:12:25 INFO - 'talos_options': ['--disable-e10s'], 02:12:25 INFO - 'tests': ['damp', 'tps']}, 02:12:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:12:25 INFO - 'tests': ['damp', 'tps']}, 02:12:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:12:25 INFO - 'tests': ['dromaeo_dom']}, 02:12:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:12:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:12:25 INFO - 'tests': ['basic_compositor_video']}, 02:12:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:12:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:12:25 INFO - 'tests': ['a11yr', 02:12:25 INFO - 'ts_paint', 02:12:25 INFO - 'tpaint', 02:12:25 INFO - 'sessionrestore', 02:12:25 INFO - 'sessionrestore_no_auto_restore', 02:12:25 INFO - 'tabpaint']}, 02:12:25 INFO - 'other-e10s': {'tests': ['a11yr', 02:12:25 INFO - 'ts_paint', 02:12:25 INFO - 'tpaint', 02:12:25 INFO - 'sessionrestore', 02:12:25 INFO - 'sessionrestore_no_auto_restore', 02:12:25 INFO - 'tabpaint']}, 02:12:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:12:25 INFO - 'ts_paint', 02:12:25 INFO - 'tpaint', 02:12:25 INFO - 'sessionrestore', 02:12:25 INFO - 'sessionrestore_no_auto_restore', 02:12:25 INFO - 'tabpaint']}, 02:12:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:12:25 INFO - 'ts_paint', 02:12:25 INFO - 'tpaint', 02:12:25 INFO - 'sessionrestore', 02:12:25 INFO - 'sessionrestore_no_auto_restore', 02:12:25 INFO - 'tabpaint']}, 02:12:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:12:25 INFO - 'tests': ['a11yr', 02:12:25 INFO - 'ts_paint', 02:12:25 INFO - 'tpaint', 02:12:25 INFO - 'sessionrestore', 02:12:25 INFO - 'sessionrestore_no_auto_restore', 02:12:25 INFO - 'tabpaint']}, 02:12:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:12:25 INFO - 'tests': ['a11yr', 02:12:25 INFO - 'ts_paint', 02:12:25 INFO - 'tpaint', 02:12:25 INFO - 'sessionrestore', 02:12:25 INFO - 'sessionrestore_no_auto_restore', 02:12:25 INFO - 'tabpaint']}, 02:12:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:12:25 INFO - 'tests': ['tsvgx', 02:12:25 INFO - 'tsvgr_opacity', 02:12:25 INFO - 'tart', 02:12:25 INFO - 'tscrollx', 02:12:25 INFO - 'cart']}, 02:12:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:12:25 INFO - 'tsvgr_opacity', 02:12:25 INFO - 'tart', 02:12:25 INFO - 'tscrollx', 02:12:25 INFO - 'cart']}, 02:12:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:12:25 INFO - 'talos_options': ['--disable-e10s'], 02:12:25 INFO - 'tests': ['tp5o']}, 02:12:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:12:25 INFO - 'tests': ['tp5o']}, 02:12:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:12:25 INFO - 'talos_options': ['--disable-e10s', 02:12:25 INFO - '--xperf_path', 02:12:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:12:25 INFO - 'tests': ['tp5n']}, 02:12:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:12:25 INFO - 'talos_options': ['--xperf_path', 02:12:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:12:25 INFO - 'tests': ['tp5n']}}, 02:12:25 INFO - 'talos.zip': {'path': '', 02:12:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:12:25 INFO - Running post-action listener: _resource_record_post_action 02:12:25 INFO - [mozharness: 2016-08-01 09:12:25.928165Z] Finished populate-webroot step (success) 02:12:25 INFO - [mozharness: 2016-08-01 09:12:25.928255Z] Running create-virtualenv step. 02:12:25 INFO - Running pre-action listener: _resource_record_pre_action 02:12:25 INFO - Running main action method: create_virtualenv 02:12:25 INFO - Creating virtualenv /builds/slave/test/build/venv 02:12:25 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 02:12:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:12:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:12:26 INFO - Using real prefix '/usr' 02:12:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:12:26 INFO - Installing distribute.............................................................................................................................................................................................done. 02:12:28 INFO - Installing pip.................done. 02:12:28 INFO - Return code: 0 02:12:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2274180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22723b0>, '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 0x22732b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2273740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1470042394.975943-494518010', '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 02:12:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:12:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:12:28 INFO - Using env: {'DISPLAY': ':0', 02:12:28 INFO - 'HOME': '/home/cltbld', 02:12:28 INFO - 'LANG': 'en_US.UTF-8', 02:12:28 INFO - 'LANGUAGE': 'en_US:en', 02:12:28 INFO - 'LOGNAME': 'cltbld', 02:12:28 INFO - 'MAIL': '/var/mail/cltbld', 02:12:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:28 INFO - 'MOZ_NO_REMOTE': '1', 02:12:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:28 INFO - 'NO_EM_RESTART': '1', 02:12:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:28 INFO - 'PWD': '/builds/slave/test', 02:12:28 INFO - 'SHELL': '/bin/bash', 02:12:28 INFO - 'SHLVL': '1', 02:12:28 INFO - 'TERM': 'linux', 02:12:28 INFO - 'TMOUT': '86400', 02:12:28 INFO - 'USER': 'cltbld', 02:12:28 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1470042394.975943-494518010', 02:12:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:28 INFO - '_': '/tools/buildbot/bin/python'} 02:12:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:28 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 02:12:28 INFO - Cleaning up... 02:12:28 INFO - Return code: 0 02:12:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1fb3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2274180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22723b0>, '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 0x22732b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2273740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1470042394.975943-494518010', '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 02:12:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:12:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:12:28 INFO - Using env: {'DISPLAY': ':0', 02:12:28 INFO - 'HOME': '/home/cltbld', 02:12:28 INFO - 'LANG': 'en_US.UTF-8', 02:12:28 INFO - 'LANGUAGE': 'en_US:en', 02:12:28 INFO - 'LOGNAME': 'cltbld', 02:12:28 INFO - 'MAIL': '/var/mail/cltbld', 02:12:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:28 INFO - 'MOZ_NO_REMOTE': '1', 02:12:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:28 INFO - 'NO_EM_RESTART': '1', 02:12:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:28 INFO - 'PWD': '/builds/slave/test', 02:12:28 INFO - 'SHELL': '/bin/bash', 02:12:28 INFO - 'SHLVL': '1', 02:12:28 INFO - 'TERM': 'linux', 02:12:28 INFO - 'TMOUT': '86400', 02:12:28 INFO - 'USER': 'cltbld', 02:12:28 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1470042394.975943-494518010', 02:12:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:28 INFO - '_': '/tools/buildbot/bin/python'} 02:12:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:29 INFO - Downloading/unpacking psutil>=3.1.1 02:12: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 02:12: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 02:12: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 02:12: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 02:12: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 02:12: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 02:12:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:12:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:12:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:12:31 INFO - Installing collected packages: psutil 02:12:31 INFO - Running setup.py install for psutil 02:12:31 INFO - building 'psutil._psutil_linux' extension 02:12:31 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 02:12:31 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 02:12:31 INFO - building 'psutil._psutil_posix' extension 02:12:31 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 02:12:31 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 02:12:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:12:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:12:31 INFO - Successfully installed psutil 02:12:31 INFO - Cleaning up... 02:12:31 INFO - Return code: 0 02:12:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:12:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2274180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22723b0>, '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 0x22732b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2273740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1470042394.975943-494518010', '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 02:12:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:12:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:12:31 INFO - Using env: {'DISPLAY': ':0', 02:12:31 INFO - 'HOME': '/home/cltbld', 02:12:31 INFO - 'LANG': 'en_US.UTF-8', 02:12:31 INFO - 'LANGUAGE': 'en_US:en', 02:12:31 INFO - 'LOGNAME': 'cltbld', 02:12:31 INFO - 'MAIL': '/var/mail/cltbld', 02:12:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:31 INFO - 'MOZ_NO_REMOTE': '1', 02:12:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:31 INFO - 'NO_EM_RESTART': '1', 02:12:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:31 INFO - 'PWD': '/builds/slave/test', 02:12:31 INFO - 'SHELL': '/bin/bash', 02:12:31 INFO - 'SHLVL': '1', 02:12:31 INFO - 'TERM': 'linux', 02:12:31 INFO - 'TMOUT': '86400', 02:12:31 INFO - 'USER': 'cltbld', 02:12:31 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1470042394.975943-494518010', 02:12:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:31 INFO - '_': '/tools/buildbot/bin/python'} 02:12:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:12:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:12:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:12:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:12:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:12:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:12:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:12:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:12:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:12:33 INFO - Installing collected packages: mozsystemmonitor 02:12:33 INFO - Running setup.py install for mozsystemmonitor 02:12:33 INFO - Successfully installed mozsystemmonitor 02:12:33 INFO - Cleaning up... 02:12:33 INFO - Return code: 0 02:12:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:33 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 0x1fb3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2274180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22723b0>, '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 0x22732b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2273740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1470042394.975943-494518010', '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 02:12:33 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 02:12:33 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 02:12:33 INFO - Using env: {'DISPLAY': ':0', 02:12:33 INFO - 'HOME': '/home/cltbld', 02:12:33 INFO - 'LANG': 'en_US.UTF-8', 02:12:33 INFO - 'LANGUAGE': 'en_US:en', 02:12:33 INFO - 'LOGNAME': 'cltbld', 02:12:33 INFO - 'MAIL': '/var/mail/cltbld', 02:12:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:33 INFO - 'MOZ_NO_REMOTE': '1', 02:12:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:33 INFO - 'NO_EM_RESTART': '1', 02:12:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:33 INFO - 'PWD': '/builds/slave/test', 02:12:33 INFO - 'SHELL': '/bin/bash', 02:12:33 INFO - 'SHLVL': '1', 02:12:33 INFO - 'TERM': 'linux', 02:12:33 INFO - 'TMOUT': '86400', 02:12:33 INFO - 'USER': 'cltbld', 02:12:33 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1470042394.975943-494518010', 02:12:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:33 INFO - '_': '/tools/buildbot/bin/python'} 02:12:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:34 INFO - Downloading/unpacking jsonschema==2.5.1 02:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:12:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:12:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:12:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:12:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:12:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:12:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:12:36 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 02:12:36 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 02:12:36 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 02:12:36 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 02:12:36 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 02:12:36 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 02:12:36 INFO - Downloading functools32-3.2.3-2.tar.gz 02:12:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:12:36 INFO - warning: no files found matching '*.txt' 02:12:36 INFO - no previously-included directories found matching 'build' 02:12:36 INFO - no previously-included directories found matching 'dist' 02:12:36 INFO - no previously-included directories found matching '.git*' 02:12:36 INFO - Installing collected packages: jsonschema, functools32 02:12:36 INFO - Running setup.py install for functools32 02:12:36 INFO - warning: no files found matching '*.txt' 02:12:36 INFO - no previously-included directories found matching 'build' 02:12:36 INFO - no previously-included directories found matching 'dist' 02:12:36 INFO - no previously-included directories found matching '.git*' 02:12:36 INFO - Successfully installed jsonschema functools32 02:12:36 INFO - Cleaning up... 02:12:36 INFO - Return code: 0 02:12:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:12:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:36 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 0x1fb3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2274180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22723b0>, '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 0x22732b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2273740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1470042394.975943-494518010', '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 02:12:36 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 02:12:36 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 02:12:36 INFO - Using env: {'DISPLAY': ':0', 02:12:36 INFO - 'HOME': '/home/cltbld', 02:12:36 INFO - 'LANG': 'en_US.UTF-8', 02:12:36 INFO - 'LANGUAGE': 'en_US:en', 02:12:36 INFO - 'LOGNAME': 'cltbld', 02:12:36 INFO - 'MAIL': '/var/mail/cltbld', 02:12:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:36 INFO - 'MOZ_NO_REMOTE': '1', 02:12:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:36 INFO - 'NO_EM_RESTART': '1', 02:12:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:36 INFO - 'PWD': '/builds/slave/test', 02:12:36 INFO - 'SHELL': '/bin/bash', 02:12:36 INFO - 'SHLVL': '1', 02:12:36 INFO - 'TERM': 'linux', 02:12:36 INFO - 'TMOUT': '86400', 02:12:36 INFO - 'USER': 'cltbld', 02:12:36 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1470042394.975943-494518010', 02:12:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:36 INFO - '_': '/tools/buildbot/bin/python'} 02:12:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:12:36 INFO - Cleaning up... 02:12:36 INFO - Return code: 0 02:12:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:12:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:36 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 0x1fb3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2274180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22723b0>, '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 0x22732b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2273740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1470042394.975943-494518010', '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 02:12:36 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 02:12:36 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 02:12:36 INFO - Using env: {'DISPLAY': ':0', 02:12:36 INFO - 'HOME': '/home/cltbld', 02:12:36 INFO - 'LANG': 'en_US.UTF-8', 02:12:36 INFO - 'LANGUAGE': 'en_US:en', 02:12:36 INFO - 'LOGNAME': 'cltbld', 02:12:36 INFO - 'MAIL': '/var/mail/cltbld', 02:12:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:36 INFO - 'MOZ_NO_REMOTE': '1', 02:12:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:36 INFO - 'NO_EM_RESTART': '1', 02:12:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:36 INFO - 'PWD': '/builds/slave/test', 02:12:36 INFO - 'SHELL': '/bin/bash', 02:12:36 INFO - 'SHLVL': '1', 02:12:36 INFO - 'TERM': 'linux', 02:12:36 INFO - 'TMOUT': '86400', 02:12:36 INFO - 'USER': 'cltbld', 02:12:36 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1470042394.975943-494518010', 02:12:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:36 INFO - '_': '/tools/buildbot/bin/python'} 02:12:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:36 INFO - Downloading/unpacking blobuploader==1.2.4 02:12:36 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 02:12:36 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 02:12:36 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 02:12:36 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 02:12:36 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 02:12:36 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 02:12:38 INFO - Downloading blobuploader-1.2.4.tar.gz 02:12:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:12:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:12: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 02:12: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 02:12: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 02:12: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 02:12: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 02:12: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 02:12:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:12:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:12:39 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 02:12:39 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 02:12:39 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 02:12:39 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 02:12:39 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 02:12:39 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 02:12:39 INFO - Downloading docopt-0.6.1.tar.gz 02:12:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:12:39 INFO - Installing collected packages: blobuploader, requests, docopt 02:12:39 INFO - Running setup.py install for blobuploader 02:12:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:12:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:12:39 INFO - Running setup.py install for requests 02:12:40 INFO - Running setup.py install for docopt 02:12:40 INFO - Successfully installed blobuploader requests docopt 02:12:40 INFO - Cleaning up... 02:12:40 INFO - Return code: 0 02:12:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:40 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 0x1fb3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2274180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22723b0>, '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 0x22732b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2273740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1470042394.975943-494518010', '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 02:12:40 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 02:12:40 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 02:12:40 INFO - Using env: {'DISPLAY': ':0', 02:12:40 INFO - 'HOME': '/home/cltbld', 02:12:40 INFO - 'LANG': 'en_US.UTF-8', 02:12:40 INFO - 'LANGUAGE': 'en_US:en', 02:12:40 INFO - 'LOGNAME': 'cltbld', 02:12:40 INFO - 'MAIL': '/var/mail/cltbld', 02:12:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:40 INFO - 'MOZ_NO_REMOTE': '1', 02:12:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:40 INFO - 'NO_EM_RESTART': '1', 02:12:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:40 INFO - 'PWD': '/builds/slave/test', 02:12:40 INFO - 'SHELL': '/bin/bash', 02:12:40 INFO - 'SHLVL': '1', 02:12:40 INFO - 'TERM': 'linux', 02:12:40 INFO - 'TMOUT': '86400', 02:12:40 INFO - 'USER': 'cltbld', 02:12:40 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1470042394.975943-494518010', 02:12:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:40 INFO - '_': '/tools/buildbot/bin/python'} 02:12:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:12:40 INFO - Running setup.py (path:/tmp/pip-nvGKhm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:12:40 INFO - Running setup.py (path:/tmp/pip-XK1dV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:12:40 INFO - Running setup.py (path:/tmp/pip-vdMomg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:12:40 INFO - Running setup.py (path:/tmp/pip-TCF5V8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:12:40 INFO - Running setup.py (path:/tmp/pip-5X9xNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:12:40 INFO - Running setup.py (path:/tmp/pip-GaNuD4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:12:40 INFO - Running setup.py (path:/tmp/pip-HZWqh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:12:40 INFO - Running setup.py (path:/tmp/pip-WZsr_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:12:40 INFO - Running setup.py (path:/tmp/pip-UASl9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:12:41 INFO - Running setup.py (path:/tmp/pip-FeU20G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:12:41 INFO - Running setup.py (path:/tmp/pip-_Bpyiq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:12:41 INFO - Running setup.py (path:/tmp/pip-wkiBS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:12:41 INFO - Running setup.py (path:/tmp/pip-N8U7A6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:12:41 INFO - Running setup.py (path:/tmp/pip-H0uPAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:12:41 INFO - Running setup.py (path:/tmp/pip-xvh8zt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:12:41 INFO - Running setup.py (path:/tmp/pip-WDbUXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:12:41 INFO - Running setup.py (path:/tmp/pip-9ve31e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:12:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:12:41 INFO - Running setup.py install for manifestparser 02:12:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:12:41 INFO - Running setup.py install for mozcrash 02:12:41 INFO - Running setup.py install for mozdebug 02:12:41 INFO - Running setup.py install for mozdevice 02:12:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:12:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:12:42 INFO - Running setup.py install for mozfile 02:12:42 INFO - Running setup.py install for mozhttpd 02:12:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:12:42 INFO - Running setup.py install for mozinfo 02:12:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:12:42 INFO - Running setup.py install for mozInstall 02:12:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:12:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:12:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:12:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:12:42 INFO - Running setup.py install for mozleak 02:12:42 INFO - Running setup.py install for mozlog 02:12:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:12:42 INFO - Running setup.py install for moznetwork 02:12:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:12:42 INFO - Running setup.py install for mozprocess 02:12:42 INFO - Running setup.py install for mozprofile 02:12:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:12:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:12:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:12:43 INFO - Running setup.py install for mozrunner 02:12:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:12:43 INFO - Running setup.py install for mozscreenshot 02:12:43 INFO - Running setup.py install for moztest 02:12:43 INFO - Running setup.py install for mozversion 02:12:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:12:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:12:43 INFO - Cleaning up... 02:12:43 INFO - Return code: 0 02:12:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:12:43 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')]} 02:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:43 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')]} 02:12:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:43 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 0x1fb3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2274180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22723b0>, '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 0x22732b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2273740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1470042394.975943-494518010', '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 02:12:43 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 02:12:43 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 02:12:43 INFO - Using env: {'DISPLAY': ':0', 02:12:43 INFO - 'HOME': '/home/cltbld', 02:12:43 INFO - 'LANG': 'en_US.UTF-8', 02:12:43 INFO - 'LANGUAGE': 'en_US:en', 02:12:43 INFO - 'LOGNAME': 'cltbld', 02:12:43 INFO - 'MAIL': '/var/mail/cltbld', 02:12:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:43 INFO - 'MOZ_NO_REMOTE': '1', 02:12:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:43 INFO - 'NO_EM_RESTART': '1', 02:12:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:43 INFO - 'PWD': '/builds/slave/test', 02:12:43 INFO - 'SHELL': '/bin/bash', 02:12:43 INFO - 'SHLVL': '1', 02:12:43 INFO - 'TERM': 'linux', 02:12:43 INFO - 'TMOUT': '86400', 02:12:43 INFO - 'USER': 'cltbld', 02:12:43 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1470042394.975943-494518010', 02:12:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:43 INFO - '_': '/tools/buildbot/bin/python'} 02:12:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:12:43 INFO - Running setup.py (path:/tmp/pip-d5ao5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:12:43 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)) 02:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:12:43 INFO - Running setup.py (path:/tmp/pip-bHrgPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:12:43 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)) 02:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:12:43 INFO - Running setup.py (path:/tmp/pip-W75wQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:12:43 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)) 02:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:12:43 INFO - Running setup.py (path:/tmp/pip-1U0eBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:12:43 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)) 02:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:12:43 INFO - Running setup.py (path:/tmp/pip-szeuXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:12:44 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)) 02:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:12:44 INFO - Running setup.py (path:/tmp/pip-KgA4BL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:12:44 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)) 02:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:12:44 INFO - Running setup.py (path:/tmp/pip-5Uz84h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:12:44 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)) 02:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:12:44 INFO - Running setup.py (path:/tmp/pip-_iiap6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:12:44 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)) 02:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:12:44 INFO - Running setup.py (path:/tmp/pip-9TE0p0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:12:44 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)) 02:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:12:44 INFO - Running setup.py (path:/tmp/pip-jjGuSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:12:44 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)) 02:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:12:44 INFO - Running setup.py (path:/tmp/pip-GUTS7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:12:44 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)) 02:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:12:44 INFO - Running setup.py (path:/tmp/pip-bAzBcX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:12:44 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)) 02:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:12:44 INFO - Running setup.py (path:/tmp/pip-rQYpsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:12:44 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)) 02:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:12:44 INFO - Running setup.py (path:/tmp/pip-kILKDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:12:44 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)) 02:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:12:44 INFO - Running setup.py (path:/tmp/pip-eGHniS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:12:44 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)) 02:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:12:44 INFO - Running setup.py (path:/tmp/pip-eBiPXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:12:44 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)) 02:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:12:44 INFO - Running setup.py (path:/tmp/pip-_HKjIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:12:44 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)) 02:12:44 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)) 02:12:44 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)) 02:12:44 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)) 02:12:44 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)) 02:12:44 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)) 02:12:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:12:44 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 02:12:44 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 02:12:44 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 02:12:44 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 02:12:44 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 02:12:44 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 02:12:46 INFO - Downloading blessings-1.6.tar.gz 02:12:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:12:46 INFO - Installing collected packages: blessings 02:12:46 INFO - Running setup.py install for blessings 02:12:46 INFO - Successfully installed blessings 02:12:46 INFO - Cleaning up... 02:12:47 INFO - Return code: 0 02:12:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:12:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:12:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:12:47 INFO - Reading from file tmpfile_stdout 02:12:47 INFO - Current package versions: 02:12:47 INFO - argparse == 1.2.1 02:12:47 INFO - blessings == 1.6 02:12:47 INFO - blobuploader == 1.2.4 02:12:47 INFO - docopt == 0.6.1 02:12:47 INFO - functools32 == 3.2.3-2 02:12:47 INFO - jsonschema == 2.5.1 02:12:47 INFO - manifestparser == 1.1 02:12:47 INFO - mozInstall == 1.12 02:12:47 INFO - mozcrash == 0.17 02:12:47 INFO - mozdebug == 0.1 02:12:47 INFO - mozdevice == 0.48 02:12:47 INFO - mozfile == 1.2 02:12:47 INFO - mozhttpd == 0.7 02:12:47 INFO - mozinfo == 0.9 02:12:47 INFO - mozleak == 0.1 02:12:47 INFO - mozlog == 3.3 02:12:47 INFO - moznetwork == 0.27 02:12:47 INFO - mozprocess == 0.23 02:12:47 INFO - mozprofile == 0.28 02:12:47 INFO - mozrunner == 6.12 02:12:47 INFO - mozscreenshot == 0.1 02:12:47 INFO - mozsystemmonitor == 0.3 02:12:47 INFO - moztest == 0.7 02:12:47 INFO - mozversion == 1.4 02:12:47 INFO - psutil == 3.1.1 02:12:47 INFO - requests == 1.2.3 02:12:47 INFO - wsgiref == 0.1.2 02:12:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:12:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:47 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 0x1fb3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2274180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22723b0>, '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 0x22732b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2273740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1470042394.975943-494518010', '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 02:12:47 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 02:12:47 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 02:12:47 INFO - Using env: {'DISPLAY': ':0', 02:12:47 INFO - 'HOME': '/home/cltbld', 02:12:47 INFO - 'LANG': 'en_US.UTF-8', 02:12:47 INFO - 'LANGUAGE': 'en_US:en', 02:12:47 INFO - 'LOGNAME': 'cltbld', 02:12:47 INFO - 'MAIL': '/var/mail/cltbld', 02:12:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:47 INFO - 'MOZ_NO_REMOTE': '1', 02:12:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:47 INFO - 'NO_EM_RESTART': '1', 02:12:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:47 INFO - 'PWD': '/builds/slave/test', 02:12:47 INFO - 'SHELL': '/bin/bash', 02:12:47 INFO - 'SHLVL': '1', 02:12:47 INFO - 'TERM': 'linux', 02:12:47 INFO - 'TMOUT': '86400', 02:12:47 INFO - 'USER': 'cltbld', 02:12:47 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1470042394.975943-494518010', 02:12:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:47 INFO - '_': '/tools/buildbot/bin/python'} 02:12:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:47 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)) 02:12:47 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)) 02:12:47 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)) 02:12:47 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)) 02:12:47 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)) 02:12:47 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)) 02:12:47 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)) 02:12:47 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)) 02:12:47 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)) 02:12:47 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)) 02:12:47 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)) 02:12:47 INFO - Cleaning up... 02:12:47 INFO - Return code: 0 02:12:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:12:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:12:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:47 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 0x1fb3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2274180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22723b0>, '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 0x22732b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2273740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1470042394.975943-494518010', '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 02:12:47 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 02:12:47 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 02:12:47 INFO - Using env: {'DISPLAY': ':0', 02:12:47 INFO - 'HOME': '/home/cltbld', 02:12:47 INFO - 'LANG': 'en_US.UTF-8', 02:12:47 INFO - 'LANGUAGE': 'en_US:en', 02:12:47 INFO - 'LOGNAME': 'cltbld', 02:12:47 INFO - 'MAIL': '/var/mail/cltbld', 02:12:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:47 INFO - 'MOZ_NO_REMOTE': '1', 02:12:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:47 INFO - 'NO_EM_RESTART': '1', 02:12:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:47 INFO - 'PWD': '/builds/slave/test', 02:12:47 INFO - 'SHELL': '/bin/bash', 02:12:47 INFO - 'SHLVL': '1', 02:12:47 INFO - 'TERM': 'linux', 02:12:47 INFO - 'TMOUT': '86400', 02:12:47 INFO - 'USER': 'cltbld', 02:12:47 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1470042394.975943-494518010', 02:12:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:47 INFO - '_': '/tools/buildbot/bin/python'} 02:12:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:12:47 INFO - Cleaning up... 02:12:47 INFO - Return code: 0 02:12:47 INFO - Running post-action listener: _resource_record_post_action 02:12:47 INFO - Running post-action listener: _start_resource_monitoring 02:12:47 INFO - Starting resource monitoring. 02:12:47 INFO - [mozharness: 2016-08-01 09:12:47.724191Z] Finished create-virtualenv step (success) 02:12:47 INFO - [mozharness: 2016-08-01 09:12:47.724623Z] Running install step. 02:12:47 INFO - Running pre-action listener: _resource_record_pre_action 02:12:47 INFO - Running main action method: install 02:12:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:12:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:12:47 INFO - Reading from file tmpfile_stdout 02:12:47 INFO - Detecting whether we're running mozinstall >=1.0... 02:12:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:12:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:12:48 INFO - Reading from file tmpfile_stdout 02:12:48 INFO - Output received: 02:12:48 INFO - Usage: mozinstall [options] installer 02:12:48 INFO - Options: 02:12:48 INFO - -h, --help show this help message and exit 02:12:48 INFO - -d DEST, --destination=DEST 02:12:48 INFO - Directory to install application into. [default: 02:12:48 INFO - "/builds/slave/test"] 02:12:48 INFO - --app=APP Application being installed. [default: firefox] 02:12:48 INFO - mkdir: /builds/slave/test/build/application 02:12:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:12:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:13:04 INFO - Reading from file tmpfile_stdout 02:13:04 INFO - Output received: 02:13:04 INFO - /builds/slave/test/build/application/firefox/firefox 02:13:04 INFO - Running post-action listener: _resource_record_post_action 02:13:04 INFO - [mozharness: 2016-08-01 09:13:04.915140Z] Finished install step (success) 02:13:04 INFO - [mozharness: 2016-08-01 09:13:04.915420Z] Running run-tests step. 02:13:04 INFO - Running pre-action listener: _resource_record_pre_action 02:13:04 INFO - Running main action method: run_tests 02:13:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:13:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:13:04 INFO - Python 2.7.3 02:13:04 INFO - Return code: 0 02:13:04 INFO - grabbing minidump binary from tooltool 02:13:04 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')]} 02:13:04 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 0x22723b0>, '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 0x22732b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2273740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:13:04 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 02:13:04 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 02:13:04 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 02:13:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:13:04 INFO - Return code: 0 02:13:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:13:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:13:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:13:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:13:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:13:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WmjbcJYjRIuTNoQIVLKMjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 02:13:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WmjbcJYjRIuTNoQIVLKMjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --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 02:13:04 INFO - Using env: {'DISPLAY': ':0', 02:13:04 INFO - 'HOME': '/home/cltbld', 02:13:04 INFO - 'LANG': 'en_US.UTF-8', 02:13:04 INFO - 'LANGUAGE': 'en_US:en', 02:13:04 INFO - 'LOGNAME': 'cltbld', 02:13:04 INFO - 'MAIL': '/var/mail/cltbld', 02:13:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:13:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:13:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:04 INFO - 'MOZ_NO_REMOTE': '1', 02:13:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:13:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:04 INFO - 'NO_EM_RESTART': '1', 02:13:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:04 INFO - 'PWD': '/builds/slave/test', 02:13:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:13:04 INFO - 'SHELL': '/bin/bash', 02:13:04 INFO - 'SHLVL': '1', 02:13:04 INFO - 'TERM': 'linux', 02:13:04 INFO - 'TMOUT': '86400', 02:13:04 INFO - 'USER': 'cltbld', 02:13:04 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1470042394.975943-494518010', 02:13:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:04 INFO - '_': '/tools/buildbot/bin/python'} 02:13:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WmjbcJYjRIuTNoQIVLKMjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 02:13:05 INFO - mozversion application_buildid: 20160731233002 02:13:05 INFO - mozversion application_changeset: 482f81651a2e9b65b0066bdb99beadaa43827f29 02:13:05 INFO - mozversion application_display_name: Nightly 02:13:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:13:05 INFO - mozversion application_name: Firefox 02:13:05 INFO - mozversion application_remotingname: firefox 02:13:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:13:05 INFO - mozversion application_vendor: Mozilla 02:13:05 INFO - mozversion application_version: 50.0a1 02:13:05 INFO - mozversion platform_buildid: 20160731233002 02:13:05 INFO - mozversion platform_changeset: 482f81651a2e9b65b0066bdb99beadaa43827f29 02:13:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:13:05 INFO - mozversion platform_version: 50.0a1 02:13:05 INFO - using testdate: 1470042785 02:13:05 INFO - actual date: 1470042785 02:13:05 INFO - starting webserver on 'localhost:42193' 02:13:05 INFO - SUITE-START | Running 2 tests 02:13:05 INFO - TEST-START | dromaeo_css 02:13:05 INFO - operating with platform_type : linux_ 02:13:05 INFO - Initialising browser for dromaeo_css test... 02:13:05 INFO - TEST-INFO | started process 18342 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppAZrPD/profile http://localhost:42193/getInfo.html) 02:13:09 INFO - PROCESS | 18342 | __metrics Screen width/height:1600/1200 02:13:09 INFO - PROCESS | 18342 | colorDepth:24 02:13:09 INFO - PROCESS | 18342 | Browser inner width/height: 1024/697 02:13:09 INFO - PROCESS | 18342 | __metrics 02:13:09 INFO - PROCESS | 18342 | 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" 02:13:09 INFO - PROCESS | 18342 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:13:10 INFO - PROCESS | 18342 | console.error: PushService: 02:13:10 INFO - PROCESS | 18342 | stateChangeProcessEnqueue: Error transitioning state 02:13:10 INFO - PROCESS | 18342 | UnknownError 02:13:10 INFO - TEST-INFO | 18342: exit 0 02:13:10 INFO - Browser initialized. 02:13:10 INFO - Running cycle 1/1 for dromaeo_css test... 02:13:10 INFO - TEST-INFO | started process 18423 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppAZrPD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:13:22 INFO - PROCESS | 18423 | RSS: Main: 155693056 02:13:22 INFO - PROCESS | 18423 | 02:14:13 INFO - PROCESS | 18423 | 1470042853345 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] 02:16:22 INFO - PROCESS | 18423 | Cycle 1(1): loaded http://localhost:42193/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42193/tests/dromaeo/cssquery-ext.html) 02:16:23 INFO - PROCESS | 18423 | RSS: Main: 264097792 02:16:23 INFO - PROCESS | 18423 | 02:19:25 INFO - PROCESS | 18423 | Cycle 1(1): loaded http://localhost:42193/tests/dromaeo/cssquery-ext.html (next: http://localhost:42193/tests/dromaeo/cssquery-jquery.html) 02:19:26 INFO - PROCESS | 18423 | RSS: Main: 236867584 02:19:26 INFO - PROCESS | 18423 | 02:22:28 INFO - PROCESS | 18423 | Cycle 1(1): loaded http://localhost:42193/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42193/tests/dromaeo/cssquery-mootools.html) 02:22:28 INFO - PROCESS | 18423 | RSS: Main: 185348096 02:22:28 INFO - PROCESS | 18423 | 02:25:30 INFO - PROCESS | 18423 | Cycle 1(1): loaded http://localhost:42193/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42193/tests/dromaeo/cssquery-prototype.html) 02:25:31 INFO - PROCESS | 18423 | RSS: Main: 185454592 02:25:31 INFO - PROCESS | 18423 | 02:28:34 INFO - PROCESS | 18423 | Cycle 1(1): loaded http://localhost:42193/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42193/tests/dromaeo/cssquery-yui.html) 02:28:34 INFO - PROCESS | 18423 | RSS: Main: 186843136 02:28:34 INFO - PROCESS | 18423 | 02:31:37 INFO - PROCESS | 18423 | Cycle 1(1): loaded http://localhost:42193/tests/dromaeo/cssquery-yui.html (next: http://localhost:42193/tests/dromaeo/cssquery-dojo.html) 02:31:37 INFO - PROCESS | 18423 | RSS: Main: 277565440 02:31:37 INFO - PROCESS | 18423 | 02:31:37 INFO - PROCESS | 18423 | __start_tp_report 02:31:37 INFO - PROCESS | 18423 | _x_x_mozilla_page_load 02:31:37 INFO - PROCESS | 18423 | _x_x_mozilla_page_load_details 02:31:37 INFO - PROCESS | 18423 | |i|pagename|runs| 02:31:37 INFO - PROCESS | 18423 | |0;dojo.html;3006.428778532079;3036.8785248590057;3054.6181727284084;3065.3715988222416;3072.508398656214;5003.924941125877;5065.392152941643;5206.427292997767;5282.603804714648;5356.8125115620915;5136.101182293102;5178.378594568657;5210.609204309673;5224.373075230968;5237.659552129109;4698.9060218795685;4740.407449068866;4781.3784208053075;4792.281157826319;5000.499950005007;4893.975530122344;4908.263760435928;4938.259261110827;4955.984023275238;4976.4525902150735;4590.196715574778;4703.318018887242;4754.144254034272;4757.048590281923;4926.729029903354;4737.076270127326;4748.287756836467;4755.785989630475;4769.976150119227;4860.975695121537;4764.952350476486;4788.545088216614;4802.06359759847;4803.351547541072;4841.2012018016985;4986.800527978877;5160.767765450526;5230.581553475713;5235.136202526579;5319.787208511655;5607.7476513556985;5608.775648974036;5640.492355688008;5649.067903795869;5652.971735141339;5668.914966275468;5674.319081710221;5684.943150568482;5687.459691329317;5693.829185124453;4984.975075124637;5164.431912489623;5212.739363031833;5214.765335559871;5278.5249327560705;5776.537876969833;5833.79581714638;5837.182794408701;5838.854028649318;5840.561957853093;5532.834014979557;5570.944290557042;5579.0515612346;5579.721013949367;5580.19087232349;5378.435264297271;5450.127979523258;5490.478404551562;5493.917591236134;5558.082916318843;5517.806876759294;5521.3926468088475;5522.22688823565;5525.917111243334;5535.114381698909;5489.149181876815;5524.8342549723575;5529.529989950819;5566.916496252559;5591.860203494945;4124.25342778339;4176.14389050244;4271.722338048017;4296.785160741951;4299.07569872479;3884.9028774280305;3890.6498415142773;3914.217156568641;3917.2753040686994;3953.92092158161;5338.119210330252;5348.438413966477;5348.679079255257;5350.759215835296;5397.73011349431;5327.893442131213;5512.283403157644;5530.55755539564;5637.46444087811;5688.516476099578;5312.415634280226;5317.973410132925;5319.787208511693;5344.331958505187;5361.51746342831;4824.855254342376;4828.275758636162;4828.686135401188;4837.419509658793;4877.3903262092235;5521.972390138024;5805.7387417566315;5809.099589563624;5832.329282132524;5835.416458354215;5614.550835933197;5616.831495055155;5624.6625202487985;5625.46558076982;5689.1750696148;5872.265966754156;5873.500752436091;5879.970600146972;5893.233879595797;5897;5185.792568297225;5488.204210389551;5499.670019798825;5518.862028449321;5540.861478463071;5669.064604340238;5673;5688.516476099412;5718.199452076629;5731.684757338219;5534.557235421076;5548.250986116823;5549.611527193058;5554.2779438672715;5554.50009499147;5156.9742151289;5401.081816091195;5410.783568657367;5491.835244942658;5496.725163741717;5393.406725260296;5423.972880135574;5431.049566325956;5464.480874316933;5480.314960629921;5511.311086114236;5530.364008138955;5567.359753628384;5572.860678482908;5577.051901176891;5219.712915789668;5296.3379577552805;5325.2278419628165;5408.648437851527;5419.403865574863 02:31:37 INFO - PROCESS | 18423 | |1;ext.html;601.1253625974206;614.5360253008979;617.6078190349127;630.8265227062556;644.214058848205;35418;43907.560924390746;44329.335059974124;45245.321320180185;45246.547534524645;42978.355324670156;43466.78266608663;46972.29541556879;47090.293645595346;47112.76443617777;8062.798430039266;8897.644094236222;9056.456612603264;9061.13919177677;9065.04816994216;10298.588056477733;10639.57441702331;10649.893501064967;11044.447777611127;11047.558097676123;10896.509657065451;10906.890931090667;10997.395143267117;11019.283746556488;11025.503852326625;10752.569897204103;10805.891941080647;10813.891861081367;10818.783624327549;10822.080123189498;10653.84019239712;10667.626633067805;10731.302465339806;10741.838872416842;10764.192685548536;43749.562504374866;43908.341374879405;44117.77941110306;44154.337684934755;44251.77874110641;3318.933621327584;3487.4071407860724;3578.8031658258788;3617.7105831533677;3793.146542028049;33093;33932;34727.6527234727;34831.4775278371;35336.46995295073;4346.847860324905;4349.760763158025;4372.8560775540645;4405.647548196137;4634.513376095529;256339;257951;259769.9999999981;260610;262056;59688;59776.402235977956;60020.399796002355;60043.39956600378;60126.398736012954;63670.68164659147;63806.36193638097;63809;63884.68057659775;63972;14176.929115354356;14504.564863054125;14516.274186290855;14520.709585808225;14522.346494407777;10669.893301067044;10687;10737.570497180182;10744.516496757664;10785.946070269598;13482.52811151605;15180.468683596022;17248.913755431142;17275.222614982355;17474.825251747574;6036.245469316335;6039.335673075958;6106.2061931948565;6166.167567378437;6183.165272688219;972.8783902012249;1030.283952652899;1084.3764835219781;1094.9178811589163;1120.2270433400927;33615.82344617927;33783.83108084444;33910.66089339075;34273.48589771155;34433.483497747555;1094.578587243901;1095.6986828622194;1164.3770582738193;1183.2841131115551;1218.6222271095812;16253.615550237888;17236.827631723772;17288.740668889975;17424.215910284067;17506.912465437592;580194;584930;585520;588839;589565;58251.70874145687;58771.41228587745;58890;59219;59311.703441483376;1331.1214598365032;1381.8272715910512;1390.8261467316586;1391.7703578909366;1399.0975820595659;30913.69086309108;32111.839440802647;32728.181795455304;32820.34359312752;33233.169170770925;51322.48677513177;51588.22617660813;51595.48404516057;51665;51708.224376633625;468200;470991;472076;474582;475256;25287.494250114527;27756.861215693792;28153.718462815108;28473.572896406986;28656.85073619445;48144.27783583319;49305.50694493009;49374.25938610995;49610.00779984308;50071.499285006685;40139.59860401358;40869.795651022745;40934.1813163741;41406.1718765617;42746;41435.7928210357;41674.66123036364;42072.36891446692;42193.578064218964;42742.14515709731;42061.78969105135;42701.786491067345;43368.78315608402;43492;43558.12883742244;34070;36257;36577.63422365742;36838.529553243;37293.25413491769;29448.55827162637;29598;29618.87297417835;29737;29961.700382995892 02:31:37 INFO - PROCESS | 18423 | |2;jquery.html;362.71850063103085;375.07356828633266;385.30452533177623;385.90931131184175;402.65371780268964;18499.722504162433;19618.215271389163;19942.302019429324;20022.399328020147;20203.292884749037;18120.4563863084;18821.341253056147;19017.334393296238;19702.901485492588;19776.90111549444;5574.554035677156;5650.265465489501;5652.123920792284;5896.027155519334;5898.321693005295;5621.128725047624;5636.7181640918;5641.069223578104;5651.011073062218;5657.490825825675;5556.777728890839;5574.916376254359;5620.971895140539;5627.859303517424;5664.235328230698;5680.11958146488;5689.288838895138;5706.400827913071;5736.368999410061;5746.1668058131545;5088.592912566985;5114.59083273341;5126.051680439131;5152.072626927152;5158.123119069767;21577.1369145234;22062.117515299367;22255.332340029825;24143.758562414503;24260.514789704106;2761.6962134165224;2856.1717102040384;2867.856607169633;2880.7839412043973;2937.8090424122365;9616.23070154386;9747.415155090717;9773;9775.120239178437;9820.705378838646;1892.6971684530547;1957.148640341456;2011.9698204526944;2033.3594917600908;2044.6217449771839;77583.61208193979;86056;86065;86160;86766.5661671694;10574.629887953884;10729.195310351599;10886.891131088587;10929.453527323602;10991.340519568852;15190.696186076437;15215.771763423558;15229.162396068323;15253.694926101416;15261.084334939938;7571.129320128146;7596.734114306083;7662.4253181011645;7669.156392796788;7848.175941526171;6952.582845029315;7117.64411779409;7202.243764404662;7424.443166762407;7432.219616940251;4565.589096981287;4665.160271151158;4695.460022097434;4777.355057067251;4790.281457781291;1920.4334721257262;1959.431764788224;1961.9411417657493;1975.4567493938994;1975.651271095508;915.4827522449795;992.9751756206008;1009.2783659683215;1010.4442556593845;1032.4837581209395;19543.511412214524;19740.506487337643;19768.703469447682;19872;19892;971.3880255439028;980.152168374351;1002.5839276700234;1005.9849102263472;1030.1346868630387;10429.634962776418;11016.17378696601;11042.668719938414;11072.280301780358;11092.778144437067;472098;472989;491545;517752;519566;62930.68534657389;96767;96935.51532242294;99178.504107479;100421.49789251007;951.5480146930291;957.3537861943161;996.9102780749768;997.9850302245472;1001.2790790630734;17320.220590073728;17720.822791771916;18097.90951045289;18128.72806907924;18258.26966921308;44277.335839963074;44515;44766.55233447754;45007;45204;60803.69598152158;60853.39146608477;60946;61881.69059154675;61925.690371547855;7660.923390766021;7734.690612375442;7835.177306382748;8136.471129376571;8198.057223419382;11308.378039207922;12292.877071229173;12538.749225015266;12590.24458532491;12842.486300548248;10418.843717344094;10431.791364172826;10535;10812.67561973142;10867.184961128105;10639.946800266258;10954.671359859218;11000.284981476178;11138.88861111411;11271.718207044889;11151.88848111541;11178.161637877029;11370.260933039326;11641.6507504775;11799.469023893773;7635.236476352543;7723.227677232457;7855.489393189425;7960.721374752087;8106.829712760742;10286.639967601099;10371.740706482398;10471.94764026175;10476.476176191312;10969.50637221311 02:31:37 INFO - PROCESS | 18423 | |3;mootools.html;1395.4278745714253;1476.830164531079;1530.3572499550187;1742.1550547984225;1779.6262784815187;8329.042160151585;8931.55342232889;8952.641894324235;8957.014728379881;8960.41757285776;7052.33002864727;8137.75586732399;8299.087100418948;8344.457610255344;8758.605862736176;2276.157821606004;2316.7104111986;2319.350581837088;2320.617098178807;2323.1288266899915;2282.7260728712577;2298.9885050574726;2340.2511196417154;2342.906283748648;2343.355577216262;2315.4790172211287;2318.026428899866;2330.2659662206433;2341.4614638633125;2346.049849810821;2224.243757122578;2232.174095584628;2233.9553208935813;2235.4634887627017;2243.6298010828195;2249.9437514062115;2257.830662700304;2260.49138943738;2261.231181398316;2269.931902042941;8597.613107410181;8656;8695.39132260742;8696.782580435476;8727.34544909128;5006.824761133379;5154.201098829687;5160.483951604847;5161.612879034087;5162.303089082963;3131.123285480069;3135.6707545707827;3298.884539041146;3303.884364047247;3305.818180000099;1024.3495380433478;1027.8355463125938;1034.9534270957824;1046.3303485769113;1049.0191670787763;11600.30398176112;11960.282383057045;11986.64040078799;12152.696182595417;12305.876941230563;4245.787710614457;4328.632066274339;4487.237169681162;4489.034857505587;4489.483709373399;9594.42433453995;9622.951885240669;9629;9637.469939153274;9643.662471813454;5160.303359046556;5188.792448302102;5194.610404219623;5195.584353251731;5200.869978250574;3953.5453422856162;4087.6116768906904;4088.9591104088577;4318.244307246219;4846.95153048465;3620.728445366608;3676.3933950897804;3750.1187221003042;3762.360398732222;3797.3924172132324;1034.31923124922;1049.071571659087;1051.264115119404;1064.6220591689994;1072.4101744040747;926.2266007883358;929.990700093004;940.4639355567261;963.5230560872272;1001.5092604623682;5657.179708942181;5668.57485688575;5765.1928729977835;5835.912461313083;5897.085951677497;410.98561550345596;413.30977267961975;416.10537344709115;418.111513034801;418.61487431562426;3588.748787584844;3945.605439456089;3966.920661586752;4023.6177563131455;4095.262852686545;10616.840747388795;10923.563057477772;11009.06422954058;11011.174161937886;11019.063379612662;10265.74335641615;10698.62554810578;10728.249022568345;10898.509567069501;11016.339019658846;8071.757847264474;8280.420370574122;8292.502449852907;8292.626831792584;8294.751157465165;6068.089786532056;6144.1398204250545;6192.535559833121;6291.433770960635;6427;10092.646757363456;10106.242031847494;10152.340097893613;10217.33587316822;10235.437050962268;9789;10093.495325233856;10290.12533934624;10400.791984160123;10402.115820155372;6876.209235937731;7591.316781489692;7828.882566761617;7973.521588704696;7996.640151193326;8319.459235149696;8553.401261911606;8557.57212139403;8572.614232359683;8576.871346929925;7553.773386798405;7669.9616501917135;7689.692412303445;7766.339861111869;7867.9606601966625;7443;7524.924750752642;7593.468457207942;7593.620318983918;7760.262775036363;6777.695003724745;6842.589444633338;6887.690053947685;6892.241853396223;6893.241743408322;5101.464346243591;5164.612654051037;5179.300794392709;5237.188235823453;5459.645123066988;5156.61325400589;5156.731489705789;5170.508801663836;5336.332958380202;5352.518273355417 02:31:37 INFO - PROCESS | 18423 | |4;prototype.html;296.28890662410214;298.4165955556887;305.4014132300691;306.9616297962755;307.54329820216986;5182.8704282392955;5221.817236396727;5232.63951372643;5244.318238628977;5254.344881362373;5112.539871411572;5144.511271429217;5186.507281808232;5190.8442746717565;5194.35070616173;3807.428885667144;3877.3020856245867;3997.4609775236454;4027.496562929634;4060.553339132693;4032.959670403288;4033.455483509718;4041.898952526181;4057.918841623166;4060.533038700543;3988.441618173458;3990.4612877261634;3992.9800350998203;3995.3008223560905;4016.2168377166463;3772.5472943246714;3926.450296958428;3953.596473251983;3998.200359927997;4013.3979903014488;3522.5068490411363;3522.559680039995;3524.594671612746;3535.116220944764;3536.5932917714536;5075.949240507584;5085.466026067284;5089.923651145235;5090.236464530313;5102.413222479388;4373.2565463871215;4522.3216517522305;4540.7502587357685;4577.748223847687;4577.862664120082;5323.600729945269;5334.759935802898;5340.092184328634;5381.273528073699;5388.407275199725;3701.648343407372;3822.4075268333454;3832.770033797953;3841.615838416164;3853.865114720971;5594.216809646653;5612.803551875665;5613.775448982035;5626.9437305626825;5630.268065151545;3910.3156947534635;3921;3922.1371298314325;3924;3926.2736393767245;3956.2680904032845;3973.443717879499;3991.501062367204;3992.86024989124;3994.0628795034386;4449.755263460541;4537.455505339381;4549.545045495424;4566.292224705109;4638.002829391629;5427.375851777097;5429.610971172671;5431.375391829911;5462.2079798429;5463.125899856004;1354.9160671462791;1362.5163067111032;1369.7739872921056;1373.8322425938072;1374.7869080292571;854.9059603443616;862.0043849354006;868.9044205137429;869.604330029835;893.2273583350485;4780.378550788445;4811.422629284508;4816.229403295456;4847.612191024709;4859.198232291703;4975.776090075955;5020.723860187724;5026.396832380138;5038.4304004957;5060.520345030982;4739.928901066487;4782.856514304576;4810;4978.178600530872;5312.362516498045;2938.647362316493;2979.7914146010003;2988.641363036406;2989.5515672649276;2991.100651086576;5865.97345464542;5894.852628684317;5898.557608179403;5921.911171332434;5924.407559244041;5520.91718624221;5709.200711900255;5718.771249150071;5749.568782341341;5768.711564421762;5857.096443655829;5863.912041319383;5879.882402351929;5891.3209735225255;5894.793682221101;5333.759980800795;5556.749946252347;5570.660322664409;5573.191887176417;5596.972015139898;5554.777808887761;5563.1905887528155;5563.941341703434;5570.944290557042;5580.497755202051;5769.653820770767;5830.854228644318;5845.240118784531;5871.383504731942;5899.38056504078;3888.08629971962;3965.2862484751868;3971.285168669667;4008.7995600219288;4018.8191531381744;5320.17537281722;5550.47270509301;5551.805686800943;5562.471565201299;5565.944340556543;5297.417284098669;5455.236266922713;5458.426865179099;5471.2887324647545;5480.0271902116;5384.330857434208;5387.3804512481565;5388.838334849961;5406;5412.700951771468;5174.586033117266;5352.330958630171;5360;5365.22204280385;5374.785008599769;5464.825062611558;5485.6982865942755;5488.643238189505;5492.450754924475;5493.7802487900035;5371.248025276386;5374.301340825824;5375.731213439234;5380.300560927211;5382.407935127211 02:31:37 INFO - PROCESS | 18423 | |5;yui.html;773.918738532454;781.827997840475;807.4428644235477;848.5587494502856;867.176182626505;14397;14733.48432804852;14855;14866.851331486681;15007.399704011854;14900.18049007307;14999.47501837436;14999.550013499585;15002.474913378033;15020.17389043602;652.6475703120309;785.3756263770316;789.3290702902516;808.4825711544587;815.8327542853731;792.8453951479464;802.5666140284239;802.7511471443871;803.1125606205147;803.3292201012162;853.6670698427619;853.6713365354321;854.1586537260824;855.1747563601124;855.5636625321068;687.4191308344466;826.9090400055989;845.9619317130744;848.6902280667542;857.0229937870832;623.4980840423457;625.1279465146141;625.337142628815;625.4933503861841;625.5871125057486;15390.07659540431;15422.922885385502;15426.074435533792;15432.845671543366;15447.691046179014;13900.721985560333;13925;14247.928760356235;14372.425102995867;14440;13162.539311124161;13178.80596119822;13565;13765.105268157638;14240.786388204186;4154.563770804052;4203.62167404935;4223.894402639928;4393.868183954486;4393.9121217575785;79170.60414697947;79833.60083199547;79970;80779.19220807776;82809.58595207045;11687.134590292986;11701.590444334408;11722.238054526428;11938.940305298418;12031.578894738643;22489.550208996057;22508;22569.548609027726;22590;22748.20381286647;8452.535110568977;8517.190866867762;8530.232279094911;8532;8742.213200811957;4621.30680397943;4684.391029166187;4698.107359601665;4704.903499952989;4890.82882099132;3142.481490554079;3200.231944333343;3210.0369889033195;3216.469282568397;3237.4820028795752;574.4600075928614;577.2985822225932;589.0369246282273;613.9017757158833;628.3810446709987;653.7352372289231;669.1668872254074;690.8652812701575;710.7974227345181;719.316649183278;9133.77165570866;9351.812963740687;9460.148586627236;9900.851487227554;10112.646057387956;610.8992016317346;639.2648454277524;674.3189378727423;711.5061708710936;721.0914248047497;4654.97672511642;4672.229082201467;4750.596199323028;4773.76131193439;4790.784414701347;73009;83115.16884831195;131976;132484;132524;90664.54667726751;109796.4510177444;111062.44468777605;113297.4335128319;115633.4218328903;96614.51692741632;98139;98308.99999999857;98998.50500747451;101050.4947475258;8681.262092721936;8934.329925255763;9050.773730656523;9080.909190908007;9100.635974560944;40385;49433.752831235615;55151.44848551463;56243;56489.43510565006;75326;78171.60914195393;86340;86614.56692716749;87358.56320718356;13621.727565448833;13680.794788077988;13700.383482743102;14000.299985000505;14527.128372297697;15651.765223521885;16049.438269660506;16133.75799363034;16776.74834877502;16786.58033549171;14495.78256326135;14896.702065958403;15006.2496875158;15329.233538323262;15671.216439177768;14036.649083772987;14394.136351818925;14599.781003284746;14713.779293310396;15130.016548924285;13134.343282835629;13304.46782128704;13882.722345553235;14380.209088500233;14931.701365972402;11530.2603782734;11664.475098620413;11709.238899471507;11735.823962640738;11822.586209482626;10877;11992.460339284928;12056.84726164416;12260.26438413698;12282.447289871798 02:31:37 INFO - PROCESS | 18423 | __end_tp_report 02:31:37 INFO - PROCESS | 18423 | __start_cc_report 02:31:37 INFO - PROCESS | 18423 | _x_x_mozilla_cycle_collect,1030 02:31:37 INFO - PROCESS | 18423 | __end_cc_report 02:31:37 INFO - PROCESS | 18423 | __startTimestamp1470043897772__endTimestamp 02:31:37 INFO - PROCESS | 18423 | 02:31:37 INFO - PROCESS | 18423 | ------- Summary: start ------- 02:31:37 INFO - PROCESS | 18423 | Number of tests: 6 02:31:37 INFO - PROCESS | 18423 | 02:31:37 INFO - PROCESS | 18423 | [#0] dojo.html Cycles:165 Average:5211.74 Median:5397.73 stddev:587.30 (10.9%) stddev-sans-first:563.05 02:31:37 INFO - PROCESS | 18423 | Values: 3006.4 3036.9 3054.6 3065.4 3072.5 5003.9 5065.4 5206.4 5282.6 5356.8 5136.1 5178.4 5210.6 5224.4 5237.7 4698.9 4740.4 4781.4 4792.3 5000.5 4894.0 4908.3 4938.3 4956.0 4976.5 4590.2 4703.3 4754.1 4757.0 4926.7 4737.1 4748.3 4755.8 4770.0 4861.0 4765.0 4788.5 4802.1 4803.4 4841.2 4986.8 5160.8 5230.6 5235.1 5319.8 5607.7 5608.8 5640.5 5649.1 5653.0 5668.9 5674.3 5684.9 5687.5 5693.8 4985.0 5164.4 5212.7 5214.8 5278.5 5776.5 5833.8 5837.2 5838.9 5840.6 5532.8 5570.9 5579.1 5579.7 5580.2 5378.4 5450.1 5490.5 5493.9 5558.1 5517.8 5521.4 5522.2 5525.9 5535.1 5489.1 5524.8 5529.5 5566.9 5591.9 4124.3 4176.1 4271.7 4296.8 4299.1 3884.9 3890.6 3914.2 3917.3 3953.9 5338.1 5348.4 5348.7 5350.8 5397.7 5327.9 5512.3 5530.6 5637.5 5688.5 5312.4 5318.0 5319.8 5344.3 5361.5 4824.9 4828.3 4828.7 4837.4 4877.4 5522.0 5805.7 5809.1 5832.3 5835.4 5614.6 5616.8 5624.7 5625.5 5689.2 5872.3 5873.5 5880.0 5893.2 5897.0 5185.8 5488.2 5499.7 5518.9 5540.9 5669.1 5673.0 5688.5 5718.2 5731.7 5534.6 5548.3 5549.6 5554.3 5554.5 5157.0 5401.1 5410.8 5491.8 5496.7 5393.4 5424.0 5431.0 5464.5 5480.3 5511.3 5530.4 5567.4 5572.9 5577.1 5219.7 5296.3 5325.2 5408.6 5419.4 02:31:37 INFO - PROCESS | 18423 | 02:31:37 INFO - PROCESS | 18423 | [#1] ext.html Cycles:180 Average:60629.46 Median:36417.32 stddev:122402.33 (336.1%) stddev-sans-first:122662.72 02:31:37 INFO - PROCESS | 18423 | Values: 601.1 614.5 617.6 630.8 644.2 35418.0 43907.6 44329.3 45245.3 45246.5 42978.4 43466.8 46972.3 47090.3 47112.8 8062.8 8897.6 9056.5 9061.1 9065.0 10298.6 10639.6 10649.9 11044.4 11047.6 10896.5 10906.9 10997.4 11019.3 11025.5 10752.6 10805.9 10813.9 10818.8 10822.1 10653.8 10667.6 10731.3 10741.8 10764.2 43749.6 43908.3 44117.8 44154.3 44251.8 3318.9 3487.4 3578.8 3617.7 3793.1 33093.0 33932.0 34727.7 34831.5 35336.5 4346.8 4349.8 4372.9 4405.6 4634.5 256339.0 257951.0 259770.0 260610.0 262056.0 59688.0 59776.4 60020.4 60043.4 60126.4 63670.7 63806.4 63809.0 63884.7 63972.0 14176.9 14504.6 14516.3 14520.7 14522.3 10669.9 10687.0 10737.6 10744.5 10785.9 13482.5 15180.5 17248.9 17275.2 17474.8 6036.2 6039.3 6106.2 6166.2 6183.2 972.9 1030.3 1084.4 1094.9 1120.2 33615.8 33783.8 33910.7 34273.5 34433.5 1094.6 1095.7 1164.4 1183.3 1218.6 16253.6 17236.8 17288.7 17424.2 17506.9 580194.0 584930.0 585520.0 588839.0 589565.0 58251.7 58771.4 58890.0 59219.0 59311.7 1331.1 1381.8 1390.8 1391.8 1399.1 30913.7 32111.8 32728.2 32820.3 33233.2 51322.5 51588.2 51595.5 51665.0 51708.2 468200.0 470991.0 472076.0 474582.0 475256.0 25287.5 27756.9 28153.7 28473.6 28656.9 48144.3 49305.5 49374.3 49610.0 50071.5 40139.6 40869.8 40934.2 41406.2 42746.0 41435.8 41674.7 42072.4 42193.6 42742.1 42061.8 42701.8 43368.8 43492.0 43558.1 34070.0 36257.0 36577.6 36838.5 37293.3 29448.6 29598.0 29618.9 29737.0 29961.7 02:31:37 INFO - PROCESS | 18423 | 02:31:37 INFO - PROCESS | 18423 | [#2] jquery.html Cycles:180 Average:29217.30 Median:385.61 stddev:81803.51 (21214.2%) stddev-sans-first:82004.30 02:31:37 INFO - PROCESS | 18423 | Values: 362.7 375.1 385.3 385.9 402.7 18499.7 19618.2 19942.3 20022.4 20203.3 18120.5 18821.3 19017.3 19702.9 19776.9 5574.6 5650.3 5652.1 5896.0 5898.3 5621.1 5636.7 5641.1 5651.0 5657.5 5556.8 5574.9 5621.0 5627.9 5664.2 5680.1 5689.3 5706.4 5736.4 5746.2 5088.6 5114.6 5126.1 5152.1 5158.1 21577.1 22062.1 22255.3 24143.8 24260.5 2761.7 2856.2 2867.9 2880.8 2937.8 9616.2 9747.4 9773.0 9775.1 9820.7 1892.7 1957.1 2012.0 2033.4 2044.6 77583.6 86056.0 86065.0 86160.0 86766.6 10574.6 10729.2 10886.9 10929.5 10991.3 15190.7 15215.8 15229.2 15253.7 15261.1 7571.1 7596.7 7662.4 7669.2 7848.2 6952.6 7117.6 7202.2 7424.4 7432.2 4565.6 4665.2 4695.5 4777.4 4790.3 1920.4 1959.4 1961.9 1975.5 1975.7 915.5 993.0 1009.3 1010.4 1032.5 19543.5 19740.5 19768.7 19872.0 19892.0 971.4 980.2 1002.6 1006.0 1030.1 10429.6 11016.2 11042.7 11072.3 11092.8 472098.0 472989.0 491545.0 517752.0 519566.0 62930.7 96767.0 96935.5 99178.5 100421.5 951.5 957.4 996.9 998.0 1001.3 17320.2 17720.8 18097.9 18128.7 18258.3 44277.3 44515.0 44766.6 45007.0 45204.0 60803.7 60853.4 60946.0 61881.7 61925.7 7660.9 7734.7 7835.2 8136.5 8198.1 11308.4 12292.9 12538.7 12590.2 12842.5 10418.8 10431.8 10535.0 10812.7 10867.2 10639.9 10954.7 11000.3 11138.9 11271.7 11151.9 11178.2 11370.3 11641.7 11799.5 7635.2 7723.2 7855.5 7960.7 8106.8 10286.6 10371.7 10471.9 10476.5 10969.5 02:31:37 INFO - PROCESS | 18423 | 02:31:37 INFO - PROCESS | 18423 | [#3] mootools.html Cycles:180 Average:5683.99 Median:4407.93 stddev:3289.22 (74.6%) stddev-sans-first:3282.66 02:31:37 INFO - PROCESS | 18423 | Values: 1395.4 1476.8 1530.4 1742.2 1779.6 8329.0 8931.6 8952.6 8957.0 8960.4 7052.3 8137.8 8299.1 8344.5 8758.6 2276.2 2316.7 2319.4 2320.6 2323.1 2282.7 2299.0 2340.3 2342.9 2343.4 2315.5 2318.0 2330.3 2341.5 2346.0 2224.2 2232.2 2234.0 2235.5 2243.6 2249.9 2257.8 2260.5 2261.2 2269.9 8597.6 8656.0 8695.4 8696.8 8727.3 5006.8 5154.2 5160.5 5161.6 5162.3 3131.1 3135.7 3298.9 3303.9 3305.8 1024.3 1027.8 1035.0 1046.3 1049.0 11600.3 11960.3 11986.6 12152.7 12305.9 4245.8 4328.6 4487.2 4489.0 4489.5 9594.4 9623.0 9629.0 9637.5 9643.7 5160.3 5188.8 5194.6 5195.6 5200.9 3953.5 4087.6 4089.0 4318.2 4847.0 3620.7 3676.4 3750.1 3762.4 3797.4 1034.3 1049.1 1051.3 1064.6 1072.4 926.2 930.0 940.5 963.5 1001.5 5657.2 5668.6 5765.2 5835.9 5897.1 411.0 413.3 416.1 418.1 418.6 3588.7 3945.6 3966.9 4023.6 4095.3 10616.8 10923.6 11009.1 11011.2 11019.1 10265.7 10698.6 10728.2 10898.5 11016.3 8071.8 8280.4 8292.5 8292.6 8294.8 6068.1 6144.1 6192.5 6291.4 6427.0 10092.6 10106.2 10152.3 10217.3 10235.4 9789.0 10093.5 10290.1 10400.8 10402.1 6876.2 7591.3 7828.9 7973.5 7996.6 8319.5 8553.4 8557.6 8572.6 8576.9 7553.8 7670.0 7689.7 7766.3 7868.0 7443.0 7524.9 7593.5 7593.6 7760.3 6777.7 6842.6 6887.7 6892.2 6893.2 5101.5 5164.6 5179.3 5237.2 5459.6 5156.6 5156.7 5170.5 5336.3 5352.5 02:31:37 INFO - PROCESS | 18423 | 02:31:37 INFO - PROCESS | 18423 | [#4] prototype.html Cycles:180 Average:4536.78 Median:5159.55 stddev:1352.83 (26.2%) stddev-sans-first:1318.65 02:31:37 INFO - PROCESS | 18423 | Values: 296.3 298.4 305.4 307.0 307.5 5182.9 5221.8 5232.6 5244.3 5254.3 5112.5 5144.5 5186.5 5190.8 5194.4 3807.4 3877.3 3997.5 4027.5 4060.6 4033.0 4033.5 4041.9 4057.9 4060.5 3988.4 3990.5 3993.0 3995.3 4016.2 3772.5 3926.5 3953.6 3998.2 4013.4 3522.5 3522.6 3524.6 3535.1 3536.6 5075.9 5085.5 5089.9 5090.2 5102.4 4373.3 4522.3 4540.8 4577.7 4577.9 5323.6 5334.8 5340.1 5381.3 5388.4 3701.6 3822.4 3832.8 3841.6 3853.9 5594.2 5612.8 5613.8 5626.9 5630.3 3910.3 3921.0 3922.1 3924.0 3926.3 3956.3 3973.4 3991.5 3992.9 3994.1 4449.8 4537.5 4549.5 4566.3 4638.0 5427.4 5429.6 5431.4 5462.2 5463.1 1354.9 1362.5 1369.8 1373.8 1374.8 854.9 862.0 868.9 869.6 893.2 4780.4 4811.4 4816.2 4847.6 4859.2 4975.8 5020.7 5026.4 5038.4 5060.5 4739.9 4782.9 4810.0 4978.2 5312.4 2938.6 2979.8 2988.6 2989.6 2991.1 5866.0 5894.9 5898.6 5921.9 5924.4 5520.9 5709.2 5718.8 5749.6 5768.7 5857.1 5863.9 5879.9 5891.3 5894.8 5333.8 5556.7 5570.7 5573.2 5597.0 5554.8 5563.2 5563.9 5570.9 5580.5 5769.7 5830.9 5845.2 5871.4 5899.4 3888.1 3965.3 3971.3 4008.8 4018.8 5320.2 5550.5 5551.8 5562.5 5565.9 5297.4 5455.2 5458.4 5471.3 5480.0 5384.3 5387.4 5388.8 5406.0 5412.7 5174.6 5352.3 5360.0 5365.2 5374.8 5464.8 5485.7 5488.6 5492.5 5493.8 5371.2 5374.3 5375.7 5380.3 5382.4 02:31:37 INFO - PROCESS | 18423 | 02:31:37 INFO - PROCESS | 18423 | [#5] yui.html Cycles:180 Average:21875.48 Median:4638.14 stddev:32010.36 (690.2%) stddev-sans-first:32060.95 02:31:37 INFO - PROCESS | 18423 | Values: 773.9 781.8 807.4 848.6 867.2 14397.0 14733.5 14855.0 14866.9 15007.4 14900.2 14999.5 14999.6 15002.5 15020.2 652.6 785.4 789.3 808.5 815.8 792.8 802.6 802.8 803.1 803.3 853.7 853.7 854.2 855.2 855.6 687.4 826.9 846.0 848.7 857.0 623.5 625.1 625.3 625.5 625.6 15390.1 15422.9 15426.1 15432.8 15447.7 13900.7 13925.0 14247.9 14372.4 14440.0 13162.5 13178.8 13565.0 13765.1 14240.8 4154.6 4203.6 4223.9 4393.9 4393.9 79170.6 79833.6 79970.0 80779.2 82809.6 11687.1 11701.6 11722.2 11938.9 12031.6 22489.6 22508.0 22569.5 22590.0 22748.2 8452.5 8517.2 8530.2 8532.0 8742.2 4621.3 4684.4 4698.1 4704.9 4890.8 3142.5 3200.2 3210.0 3216.5 3237.5 574.5 577.3 589.0 613.9 628.4 653.7 669.2 690.9 710.8 719.3 9133.8 9351.8 9460.1 9900.9 10112.6 610.9 639.3 674.3 711.5 721.1 4655.0 4672.2 4750.6 4773.8 4790.8 73009.0 83115.2 131976.0 132484.0 132524.0 90664.5 109796.5 111062.4 113297.4 115633.4 96614.5 98139.0 98309.0 98998.5 101050.5 8681.3 8934.3 9050.8 9080.9 9100.6 40385.0 49433.8 55151.4 56243.0 56489.4 75326.0 78171.6 86340.0 86614.6 87358.6 13621.7 13680.8 13700.4 14000.3 14527.1 15651.8 16049.4 16133.8 16776.7 16786.6 14495.8 14896.7 15006.2 15329.2 15671.2 14036.6 14394.1 14599.8 14713.8 15130.0 13134.3 13304.5 13882.7 14380.2 14931.7 11530.3 11664.5 11709.2 11735.8 11822.6 10877.0 11992.5 12056.8 12260.3 12282.4 02:31:37 INFO - PROCESS | 18423 | -------- Summary: end -------- 02:31:37 INFO - PROCESS | 18423 | 02:31:38 INFO - TEST-INFO | 18423: exit 0 02:31:38 INFO - TEST-OK | dromaeo_css | took 1113317ms 02:31:38 INFO - TEST-START | kraken 02:31:38 INFO - operating with platform_type : linux_ 02:31:38 INFO - Initialising browser for kraken test... 02:31:38 INFO - TEST-INFO | started process 18616 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpifJAYE/profile http://localhost:42193/getInfo.html) 02:31:42 INFO - PROCESS | 18616 | __metrics Screen width/height:1600/1200 02:31:42 INFO - PROCESS | 18616 | colorDepth:24 02:31:42 INFO - PROCESS | 18616 | Browser inner width/height: 1024/697 02:31:42 INFO - PROCESS | 18616 | __metrics 02:31:42 INFO - PROCESS | 18616 | 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" 02:31:42 INFO - PROCESS | 18616 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:31:43 INFO - PROCESS | 18616 | console.error: PushService: 02:31:43 INFO - PROCESS | 18616 | stateChangeProcessEnqueue: Error transitioning state 02:31:43 INFO - PROCESS | 18616 | UnknownError 02:31:43 INFO - TEST-INFO | 18616: exit 0 02:31:43 INFO - Browser initialized. 02:31:43 INFO - Running cycle 1/1 for kraken test... 02:31:43 INFO - TEST-INFO | started process 18696 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpifJAYE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:31:55 INFO - PROCESS | 18696 | RSS: Main: 156065792 02:31:55 INFO - PROCESS | 18696 | 02:31:58 INFO - PROCESS | 18696 | Cycle 1(1): loaded http://localhost:42193/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42193/tests/kraken/driver.html?testName=audio-beat-detection) 02:31:59 INFO - PROCESS | 18696 | RSS: Main: 212807680 02:31:59 INFO - PROCESS | 18696 | 02:32:01 INFO - PROCESS | 18696 | Cycle 1(1): loaded http://localhost:42193/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42193/tests/kraken/driver.html?testName=audio-dft) 02:32:02 INFO - PROCESS | 18696 | RSS: Main: 191545344 02:32:02 INFO - PROCESS | 18696 | 02:32:05 INFO - PROCESS | 18696 | Cycle 1(1): loaded http://localhost:42193/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42193/tests/kraken/driver.html?testName=audio-fft) 02:32:06 INFO - PROCESS | 18696 | RSS: Main: 269815808 02:32:06 INFO - PROCESS | 18696 | 02:32:08 INFO - PROCESS | 18696 | Cycle 1(1): loaded http://localhost:42193/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42193/tests/kraken/driver.html?testName=audio-oscillator) 02:32:08 INFO - PROCESS | 18696 | RSS: Main: 179453952 02:32:08 INFO - PROCESS | 18696 | 02:32:10 INFO - PROCESS | 18696 | Cycle 1(1): loaded http://localhost:42193/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42193/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:32:11 INFO - PROCESS | 18696 | RSS: Main: 184147968 02:32:11 INFO - PROCESS | 18696 | 02:32:14 INFO - PROCESS | 18696 | Cycle 1(1): loaded http://localhost:42193/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42193/tests/kraken/driver.html?testName=imaging-darkroom) 02:32:15 INFO - PROCESS | 18696 | RSS: Main: 218755072 02:32:15 INFO - PROCESS | 18696 | 02:32:18 INFO - PROCESS | 18696 | Cycle 1(1): loaded http://localhost:42193/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42193/tests/kraken/driver.html?testName=imaging-desaturate) 02:32:19 INFO - PROCESS | 18696 | RSS: Main: 219660288 02:32:19 INFO - PROCESS | 18696 | 02:32:21 INFO - PROCESS | 18696 | Cycle 1(1): loaded http://localhost:42193/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42193/tests/kraken/driver.html?testName=json-parse-financial) 02:32:22 INFO - PROCESS | 18696 | RSS: Main: 219258880 02:32:22 INFO - PROCESS | 18696 | 02:32:24 INFO - PROCESS | 18696 | Cycle 1(1): loaded http://localhost:42193/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42193/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:32:24 INFO - PROCESS | 18696 | RSS: Main: 183975936 02:32:24 INFO - PROCESS | 18696 | 02:32:26 INFO - PROCESS | 18696 | Cycle 1(1): loaded http://localhost:42193/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42193/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:32:26 INFO - PROCESS | 18696 | RSS: Main: 188477440 02:32:26 INFO - PROCESS | 18696 | 02:32:28 INFO - PROCESS | 18696 | Cycle 1(1): loaded http://localhost:42193/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42193/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:32:29 INFO - PROCESS | 18696 | RSS: Main: 193900544 02:32:29 INFO - PROCESS | 18696 | 02:32:32 INFO - PROCESS | 18696 | Cycle 1(1): loaded http://localhost:42193/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42193/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:32:32 INFO - PROCESS | 18696 | RSS: Main: 187441152 02:32:32 INFO - PROCESS | 18696 | 02:32:35 INFO - PROCESS | 18696 | Cycle 1(1): loaded http://localhost:42193/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42193/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:32:36 INFO - PROCESS | 18696 | RSS: Main: 192692224 02:32:36 INFO - PROCESS | 18696 | 02:32:37 INFO - PROCESS | 18696 | Cycle 1(1): loaded http://localhost:42193/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42193/tests/kraken/driver.html?testName=ai-astar) 02:32:37 INFO - PROCESS | 18696 | RSS: Main: 242712576 02:32:37 INFO - PROCESS | 18696 | 02:32:37 INFO - PROCESS | 18696 | __start_tp_report 02:32:37 INFO - PROCESS | 18696 | _x_x_mozilla_page_load 02:32:37 INFO - PROCESS | 18696 | _x_x_mozilla_page_load_details 02:32:37 INFO - PROCESS | 18696 | |i|pagename|runs| 02:32:37 INFO - PROCESS | 18696 | |0;ai-astar;103;111;110;111;111;111;111;111;118;108 02:32:37 INFO - PROCESS | 18696 | |1;audio-beat-detection;152;123;126;169;123;121;148;116;170;123 02:32:37 INFO - PROCESS | 18696 | |2;audio-dft;161;163;162;161;161;161;161;160;163;162 02:32:37 INFO - PROCESS | 18696 | |3;audio-fft;75;75;74;105;74;74;74;74;104;75 02:32:37 INFO - PROCESS | 18696 | |4;audio-oscillator;83;84;124;84;83;83;121;84;83;130 02:32:37 INFO - PROCESS | 18696 | |5;imaging-gaussian-blur;117;117;116;116;117;117;117;116;116;117 02:32:37 INFO - PROCESS | 18696 | |6;imaging-darkroom;145;147;146;146;146;147;145;145;146;145 02:32:37 INFO - PROCESS | 18696 | |7;imaging-desaturate;94;95;94;96;95;95;95;95;95;95 02:32:37 INFO - PROCESS | 18696 | |8;json-parse-financial;56;53;53;53;54;52;54;53;54;54 02:32:37 INFO - PROCESS | 18696 | |9;json-stringify-tinderbox;63;62;62;61;63;62;62;62;62;62 02:32:37 INFO - PROCESS | 18696 | |10;stanford-crypto-aes;76;77;75;76;74;76;75;75;75;86 02:32:37 INFO - PROCESS | 18696 | |11;stanford-crypto-ccm;120;123;119;122;118;119;121;121;165;122 02:32:37 INFO - PROCESS | 18696 | |12;stanford-crypto-pbkdf2;166;159;158;159;157;155;154;158;158;161 02:32:37 INFO - PROCESS | 18696 | |13;stanford-crypto-sha256-iterative;62;63;62;60;61;64;65;62;62;61 02:32:37 INFO - PROCESS | 18696 | __end_tp_report 02:32:37 INFO - PROCESS | 18696 | __start_cc_report 02:32:37 INFO - PROCESS | 18696 | _x_x_mozilla_cycle_collect,1637 02:32:37 INFO - PROCESS | 18696 | __end_cc_report 02:32:37 INFO - PROCESS | 18696 | __startTimestamp1470043957974__endTimestamp 02:32:37 INFO - PROCESS | 18696 | 02:32:37 INFO - PROCESS | 18696 | ------- Summary: start ------- 02:32:37 INFO - PROCESS | 18696 | Number of tests: 14 02:32:37 INFO - PROCESS | 18696 | 02:32:37 INFO - PROCESS | 18696 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:3.66 (3.3%) stddev-sans-first:2.69 02:32:37 INFO - PROCESS | 18696 | Values: 103.0 111.0 110.0 111.0 111.0 111.0 111.0 111.0 118.0 108.0 02:32:37 INFO - PROCESS | 18696 | 02:32:37 INFO - PROCESS | 18696 | [#1] audio-beat-detection Cycles:10 Average:137.10 Median:137.00 stddev:20.72 (15.1%) stddev-sans-first:21.27 02:32:37 INFO - PROCESS | 18696 | Values: 152.0 123.0 126.0 169.0 123.0 121.0 148.0 116.0 170.0 123.0 02:32:37 INFO - PROCESS | 18696 | 02:32:37 INFO - PROCESS | 18696 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:0.97 (0.6%) stddev-sans-first:1.01 02:32:37 INFO - PROCESS | 18696 | Values: 161.0 163.0 162.0 161.0 161.0 161.0 161.0 160.0 163.0 162.0 02:32:37 INFO - PROCESS | 18696 | 02:32:37 INFO - PROCESS | 18696 | [#3] audio-fft Cycles:10 Average:80.40 Median:74.00 stddev:12.71 (17.2%) stddev-sans-first:13.33 02:32:37 INFO - PROCESS | 18696 | Values: 75.0 75.0 74.0 105.0 74.0 74.0 74.0 74.0 104.0 75.0 02:32:37 INFO - PROCESS | 18696 | 02:32:37 INFO - PROCESS | 18696 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:83.00 stddev:20.20 (24.3%) stddev-sans-first:20.88 02:32:37 INFO - PROCESS | 18696 | Values: 83.0 84.0 124.0 84.0 83.0 83.0 121.0 84.0 83.0 130.0 02:32:37 INFO - PROCESS | 18696 | 02:32:37 INFO - PROCESS | 18696 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 02:32:37 INFO - PROCESS | 18696 | Values: 117.0 117.0 116.0 116.0 117.0 117.0 117.0 116.0 116.0 117.0 02:32:37 INFO - PROCESS | 18696 | 02:32:37 INFO - PROCESS | 18696 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 02:32:37 INFO - PROCESS | 18696 | Values: 145.0 147.0 146.0 146.0 146.0 147.0 145.0 145.0 146.0 145.0 02:32:37 INFO - PROCESS | 18696 | 02:32:37 INFO - PROCESS | 18696 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 02:32:37 INFO - PROCESS | 18696 | Values: 94.0 95.0 94.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 02:32:37 INFO - PROCESS | 18696 | 02:32:37 INFO - PROCESS | 18696 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:54.00 stddev:1.07 (2.0%) stddev-sans-first:0.71 02:32:37 INFO - PROCESS | 18696 | Values: 56.0 53.0 53.0 53.0 54.0 52.0 54.0 53.0 54.0 54.0 02:32:37 INFO - PROCESS | 18696 | 02:32:37 INFO - PROCESS | 18696 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 02:32:37 INFO - PROCESS | 18696 | Values: 63.0 62.0 62.0 61.0 63.0 62.0 62.0 62.0 62.0 62.0 02:32:37 INFO - PROCESS | 18696 | 02:32:37 INFO - PROCESS | 18696 | [#10] stanford-crypto-aes Cycles:10 Average:76.50 Median:76.00 stddev:3.44 (4.5%) stddev-sans-first:3.64 02:32:37 INFO - PROCESS | 18696 | Values: 76.0 77.0 75.0 76.0 74.0 76.0 75.0 75.0 75.0 86.0 02:32:37 INFO - PROCESS | 18696 | 02:32:37 INFO - PROCESS | 18696 | [#11] stanford-crypto-ccm Cycles:10 Average:125.00 Median:121.50 stddev:14.14 (11.6%) stddev-sans-first:14.88 02:32:37 INFO - PROCESS | 18696 | Values: 120.0 123.0 119.0 122.0 118.0 119.0 121.0 121.0 165.0 122.0 02:32:37 INFO - PROCESS | 18696 | 02:32:37 INFO - PROCESS | 18696 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.50 Median:158.50 stddev:3.31 (2.1%) stddev-sans-first:2.12 02:32:37 INFO - PROCESS | 18696 | Values: 166.0 159.0 158.0 159.0 157.0 155.0 154.0 158.0 158.0 161.0 02:32:37 INFO - PROCESS | 18696 | 02:32:37 INFO - PROCESS | 18696 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.20 Median:62.00 stddev:1.48 (2.4%) stddev-sans-first:1.56 02:32:37 INFO - PROCESS | 18696 | Values: 62.0 63.0 62.0 60.0 61.0 64.0 65.0 62.0 62.0 61.0 02:32:37 INFO - PROCESS | 18696 | -------- Summary: end -------- 02:32:37 INFO - PROCESS | 18696 | 02:32:38 INFO - TEST-INFO | 18696: exit 0 02:32:39 INFO - TEST-OK | kraken | took 60536ms 02:32:39 INFO - SUITE-END | took 1173s 02:32:39 INFO - Completed test suite (00:19:33) 02:32:39 INFO - javascript benchmark 02:32:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3006.428778532079, 3036.8785248590057, 3054.6181727284084, 3065.3715988222416, 3072.508398656214, 5003.924941125877, 5065.392152941643, 5206.427292997767, 5282.603804714648, 5356.8125115620915, 5136.101182293102, 5178.378594568657, 5210.609204309673, 5224.373075230968, 5237.659552129109, 4698.9060218795685, 4740.407449068866, 4781.3784208053075, 4792.281157826319, 5000.499950005007, 4893.975530122344, 4908.263760435928, 4938.259261110827, 4955.984023275238, 4976.4525902150735, 4590.196715574778, 4703.318018887242, 4754.144254034272, 4757.048590281923, 4926.729029903354, 4737.076270127326, 4748.287756836467, 4755.785989630475, 4769.976150119227, 4860.975695121537, 4764.952350476486, 4788.545088216614, 4802.06359759847, 4803.351547541072, 4841.2012018016985, 4986.800527978877, 5160.767765450526, 5230.581553475713, 5235.136202526579, 5319.787208511655, 5607.7476513556985, 5608.775648974036, 5640.492355688008, 5649.067903795869, 5652.971735141339, 5668.914966275468, 5674.319081710221, 5684.943150568482, 5687.459691329317, 5693.829185124453, 4984.975075124637, 5164.431912489623, 5212.739363031833, 5214.765335559871, 5278.5249327560705, 5776.537876969833, 5833.79581714638, 5837.182794408701, 5838.854028649318, 5840.561957853093, 5532.834014979557, 5570.944290557042, 5579.0515612346, 5579.721013949367, 5580.19087232349, 5378.435264297271, 5450.127979523258, 5490.478404551562, 5493.917591236134, 5558.082916318843, 5517.806876759294, 5521.3926468088475, 5522.22688823565, 5525.917111243334, 5535.114381698909, 5489.149181876815, 5524.8342549723575, 5529.529989950819, 5566.916496252559, 5591.860203494945, 4124.25342778339, 4176.14389050244, 4271.722338048017, 4296.785160741951, 4299.07569872479, 3884.9028774280305, 3890.6498415142773, 3914.217156568641, 3917.2753040686994, 3953.92092158161, 5338.119210330252, 5348.438413966477, 5348.679079255257, 5350.759215835296, 5397.73011349431, 5327.893442131213, 5512.283403157644, 5530.55755539564, 5637.46444087811, 5688.516476099578, 5312.415634280226, 5317.973410132925, 5319.787208511693, 5344.331958505187, 5361.51746342831, 4824.855254342376, 4828.275758636162, 4828.686135401188, 4837.419509658793, 4877.3903262092235, 5521.972390138024, 5805.7387417566315, 5809.099589563624, 5832.329282132524, 5835.416458354215, 5614.550835933197, 5616.831495055155, 5624.6625202487985, 5625.46558076982, 5689.1750696148, 5872.265966754156, 5873.500752436091, 5879.970600146972, 5893.233879595797, 5897.0, 5185.792568297225, 5488.204210389551, 5499.670019798825, 5518.862028449321, 5540.861478463071, 5669.064604340238, 5673.0, 5688.516476099412, 5718.199452076629, 5731.684757338219, 5534.557235421076, 5548.250986116823, 5549.611527193058, 5554.2779438672715, 5554.50009499147, 5156.9742151289, 5401.081816091195, 5410.783568657367, 5491.835244942658, 5496.725163741717, 5393.406725260296, 5423.972880135574, 5431.049566325956, 5464.480874316933, 5480.314960629921, 5511.311086114236, 5530.364008138955, 5567.359753628384, 5572.860678482908, 5577.051901176891, 5219.712915789668, 5296.3379577552805, 5325.2278419628165, 5408.648437851527, 5419.403865574863], "value": 5172.800387470363, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [601.1253625974206, 614.5360253008979, 617.6078190349127, 630.8265227062556, 644.214058848205, 35418.0, 43907.560924390746, 44329.335059974124, 45245.321320180185, 45246.547534524645, 42978.355324670156, 43466.78266608663, 46972.29541556879, 47090.293645595346, 47112.76443617777, 8062.798430039266, 8897.644094236222, 9056.456612603264, 9061.13919177677, 9065.04816994216, 10298.588056477733, 10639.57441702331, 10649.893501064967, 11044.447777611127, 11047.558097676123, 10896.509657065451, 10906.890931090667, 10997.395143267117, 11019.283746556488, 11025.503852326625, 10752.569897204103, 10805.891941080647, 10813.891861081367, 10818.783624327549, 10822.080123189498, 10653.84019239712, 10667.626633067805, 10731.302465339806, 10741.838872416842, 10764.192685548536, 43749.562504374866, 43908.341374879405, 44117.77941110306, 44154.337684934755, 44251.77874110641, 3318.933621327584, 3487.4071407860724, 3578.8031658258788, 3617.7105831533677, 3793.146542028049, 33093.0, 33932.0, 34727.6527234727, 34831.4775278371, 35336.46995295073, 4346.847860324905, 4349.760763158025, 4372.8560775540645, 4405.647548196137, 4634.513376095529, 256339.0, 257951.0, 259769.9999999981, 260610.0, 262056.0, 59688.0, 59776.402235977956, 60020.399796002355, 60043.39956600378, 60126.398736012954, 63670.68164659147, 63806.36193638097, 63809.0, 63884.68057659775, 63972.0, 14176.929115354356, 14504.564863054125, 14516.274186290855, 14520.709585808225, 14522.346494407777, 10669.893301067044, 10687.0, 10737.570497180182, 10744.516496757664, 10785.946070269598, 13482.52811151605, 15180.468683596022, 17248.913755431142, 17275.222614982355, 17474.825251747574, 6036.245469316335, 6039.335673075958, 6106.2061931948565, 6166.167567378437, 6183.165272688219, 972.8783902012249, 1030.283952652899, 1084.3764835219781, 1094.9178811589163, 1120.2270433400927, 33615.82344617927, 33783.83108084444, 33910.66089339075, 34273.48589771155, 34433.483497747555, 1094.578587243901, 1095.6986828622194, 1164.3770582738193, 1183.2841131115551, 1218.6222271095812, 16253.615550237888, 17236.827631723772, 17288.740668889975, 17424.215910284067, 17506.912465437592, 580194.0, 584930.0, 585520.0, 588839.0, 589565.0, 58251.70874145687, 58771.41228587745, 58890.0, 59219.0, 59311.703441483376, 1331.1214598365032, 1381.8272715910512, 1390.8261467316586, 1391.7703578909366, 1399.0975820595659, 30913.69086309108, 32111.839440802647, 32728.181795455304, 32820.34359312752, 33233.169170770925, 51322.48677513177, 51588.22617660813, 51595.48404516057, 51665.0, 51708.224376633625, 468200.0, 470991.0, 472076.0, 474582.0, 475256.0, 25287.494250114527, 27756.861215693792, 28153.718462815108, 28473.572896406986, 28656.85073619445, 48144.27783583319, 49305.50694493009, 49374.25938610995, 49610.00779984308, 50071.499285006685, 40139.59860401358, 40869.795651022745, 40934.1813163741, 41406.1718765617, 42746.0, 41435.7928210357, 41674.66123036364, 42072.36891446692, 42193.578064218964, 42742.14515709731, 42061.78969105135, 42701.786491067345, 43368.78315608402, 43492.0, 43558.12883742244, 34070.0, 36257.0, 36577.63422365742, 36838.529553243, 37293.25413491769, 29448.55827162637, 29598.0, 29618.87297417835, 29737.0, 29961.700382995892], "value": 20453.552760312363, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.71850063103085, 375.07356828633266, 385.30452533177623, 385.90931131184175, 402.65371780268964, 18499.722504162433, 19618.215271389163, 19942.302019429324, 20022.399328020147, 20203.292884749037, 18120.4563863084, 18821.341253056147, 19017.334393296238, 19702.901485492588, 19776.90111549444, 5574.554035677156, 5650.265465489501, 5652.123920792284, 5896.027155519334, 5898.321693005295, 5621.128725047624, 5636.7181640918, 5641.069223578104, 5651.011073062218, 5657.490825825675, 5556.777728890839, 5574.916376254359, 5620.971895140539, 5627.859303517424, 5664.235328230698, 5680.11958146488, 5689.288838895138, 5706.400827913071, 5736.368999410061, 5746.1668058131545, 5088.592912566985, 5114.59083273341, 5126.051680439131, 5152.072626927152, 5158.123119069767, 21577.1369145234, 22062.117515299367, 22255.332340029825, 24143.758562414503, 24260.514789704106, 2761.6962134165224, 2856.1717102040384, 2867.856607169633, 2880.7839412043973, 2937.8090424122365, 9616.23070154386, 9747.415155090717, 9773.0, 9775.120239178437, 9820.705378838646, 1892.6971684530547, 1957.148640341456, 2011.9698204526944, 2033.3594917600908, 2044.6217449771839, 77583.61208193979, 86056.0, 86065.0, 86160.0, 86766.5661671694, 10574.629887953884, 10729.195310351599, 10886.891131088587, 10929.453527323602, 10991.340519568852, 15190.696186076437, 15215.771763423558, 15229.162396068323, 15253.694926101416, 15261.084334939938, 7571.129320128146, 7596.734114306083, 7662.4253181011645, 7669.156392796788, 7848.175941526171, 6952.582845029315, 7117.64411779409, 7202.243764404662, 7424.443166762407, 7432.219616940251, 4565.589096981287, 4665.160271151158, 4695.460022097434, 4777.355057067251, 4790.281457781291, 1920.4334721257262, 1959.431764788224, 1961.9411417657493, 1975.4567493938994, 1975.651271095508, 915.4827522449795, 992.9751756206008, 1009.2783659683215, 1010.4442556593845, 1032.4837581209395, 19543.511412214524, 19740.506487337643, 19768.703469447682, 19872.0, 19892.0, 971.3880255439028, 980.152168374351, 1002.5839276700234, 1005.9849102263472, 1030.1346868630387, 10429.634962776418, 11016.17378696601, 11042.668719938414, 11072.280301780358, 11092.778144437067, 472098.0, 472989.0, 491545.0, 517752.0, 519566.0, 62930.68534657389, 96767.0, 96935.51532242294, 99178.504107479, 100421.49789251007, 951.5480146930291, 957.3537861943161, 996.9102780749768, 997.9850302245472, 1001.2790790630734, 17320.220590073728, 17720.822791771916, 18097.90951045289, 18128.72806907924, 18258.26966921308, 44277.335839963074, 44515.0, 44766.55233447754, 45007.0, 45204.0, 60803.69598152158, 60853.39146608477, 60946.0, 61881.69059154675, 61925.690371547855, 7660.923390766021, 7734.690612375442, 7835.177306382748, 8136.471129376571, 8198.057223419382, 11308.378039207922, 12292.877071229173, 12538.749225015266, 12590.24458532491, 12842.486300548248, 10418.843717344094, 10431.791364172826, 10535.0, 10812.67561973142, 10867.184961128105, 10639.946800266258, 10954.671359859218, 11000.284981476178, 11138.88861111411, 11271.718207044889, 11151.88848111541, 11178.161637877029, 11370.260933039326, 11641.6507504775, 11799.469023893773, 7635.236476352543, 7723.227677232457, 7855.489393189425, 7960.721374752087, 8106.829712760742, 10286.639967601099, 10371.740706482398, 10471.94764026175, 10476.476176191312, 10969.50637221311], "value": 9107.203079777699, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1395.4278745714253, 1476.830164531079, 1530.3572499550187, 1742.1550547984225, 1779.6262784815187, 8329.042160151585, 8931.55342232889, 8952.641894324235, 8957.014728379881, 8960.41757285776, 7052.33002864727, 8137.75586732399, 8299.087100418948, 8344.457610255344, 8758.605862736176, 2276.157821606004, 2316.7104111986, 2319.350581837088, 2320.617098178807, 2323.1288266899915, 2282.7260728712577, 2298.9885050574726, 2340.2511196417154, 2342.906283748648, 2343.355577216262, 2315.4790172211287, 2318.026428899866, 2330.2659662206433, 2341.4614638633125, 2346.049849810821, 2224.243757122578, 2232.174095584628, 2233.9553208935813, 2235.4634887627017, 2243.6298010828195, 2249.9437514062115, 2257.830662700304, 2260.49138943738, 2261.231181398316, 2269.931902042941, 8597.613107410181, 8656.0, 8695.39132260742, 8696.782580435476, 8727.34544909128, 5006.824761133379, 5154.201098829687, 5160.483951604847, 5161.612879034087, 5162.303089082963, 3131.123285480069, 3135.6707545707827, 3298.884539041146, 3303.884364047247, 3305.818180000099, 1024.3495380433478, 1027.8355463125938, 1034.9534270957824, 1046.3303485769113, 1049.0191670787763, 11600.30398176112, 11960.282383057045, 11986.64040078799, 12152.696182595417, 12305.876941230563, 4245.787710614457, 4328.632066274339, 4487.237169681162, 4489.034857505587, 4489.483709373399, 9594.42433453995, 9622.951885240669, 9629.0, 9637.469939153274, 9643.662471813454, 5160.303359046556, 5188.792448302102, 5194.610404219623, 5195.584353251731, 5200.869978250574, 3953.5453422856162, 4087.6116768906904, 4088.9591104088577, 4318.244307246219, 4846.95153048465, 3620.728445366608, 3676.3933950897804, 3750.1187221003042, 3762.360398732222, 3797.3924172132324, 1034.31923124922, 1049.071571659087, 1051.264115119404, 1064.6220591689994, 1072.4101744040747, 926.2266007883358, 929.990700093004, 940.4639355567261, 963.5230560872272, 1001.5092604623682, 5657.179708942181, 5668.57485688575, 5765.1928729977835, 5835.912461313083, 5897.085951677497, 410.98561550345596, 413.30977267961975, 416.10537344709115, 418.111513034801, 418.61487431562426, 3588.748787584844, 3945.605439456089, 3966.920661586752, 4023.6177563131455, 4095.262852686545, 10616.840747388795, 10923.563057477772, 11009.06422954058, 11011.174161937886, 11019.063379612662, 10265.74335641615, 10698.62554810578, 10728.249022568345, 10898.509567069501, 11016.339019658846, 8071.757847264474, 8280.420370574122, 8292.502449852907, 8292.626831792584, 8294.751157465165, 6068.089786532056, 6144.1398204250545, 6192.535559833121, 6291.433770960635, 6427.0, 10092.646757363456, 10106.242031847494, 10152.340097893613, 10217.33587316822, 10235.437050962268, 9789.0, 10093.495325233856, 10290.12533934624, 10400.791984160123, 10402.115820155372, 6876.209235937731, 7591.316781489692, 7828.882566761617, 7973.521588704696, 7996.640151193326, 8319.459235149696, 8553.401261911606, 8557.57212139403, 8572.614232359683, 8576.871346929925, 7553.773386798405, 7669.9616501917135, 7689.692412303445, 7766.339861111869, 7867.9606601966625, 7443.0, 7524.924750752642, 7593.468457207942, 7593.620318983918, 7760.262775036363, 6777.695003724745, 6842.589444633338, 6887.690053947685, 6892.241853396223, 6893.241743408322, 5101.464346243591, 5164.612654051037, 5179.300794392709, 5237.188235823453, 5459.645123066988, 5156.61325400589, 5156.731489705789, 5170.508801663836, 5336.332958380202, 5352.518273355417], "value": 4431.586485727296, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.28890662410214, 298.4165955556887, 305.4014132300691, 306.9616297962755, 307.54329820216986, 5182.8704282392955, 5221.817236396727, 5232.63951372643, 5244.318238628977, 5254.344881362373, 5112.539871411572, 5144.511271429217, 5186.507281808232, 5190.8442746717565, 5194.35070616173, 3807.428885667144, 3877.3020856245867, 3997.4609775236454, 4027.496562929634, 4060.553339132693, 4032.959670403288, 4033.455483509718, 4041.898952526181, 4057.918841623166, 4060.533038700543, 3988.441618173458, 3990.4612877261634, 3992.9800350998203, 3995.3008223560905, 4016.2168377166463, 3772.5472943246714, 3926.450296958428, 3953.596473251983, 3998.200359927997, 4013.3979903014488, 3522.5068490411363, 3522.559680039995, 3524.594671612746, 3535.116220944764, 3536.5932917714536, 5075.949240507584, 5085.466026067284, 5089.923651145235, 5090.236464530313, 5102.413222479388, 4373.2565463871215, 4522.3216517522305, 4540.7502587357685, 4577.748223847687, 4577.862664120082, 5323.600729945269, 5334.759935802898, 5340.092184328634, 5381.273528073699, 5388.407275199725, 3701.648343407372, 3822.4075268333454, 3832.770033797953, 3841.615838416164, 3853.865114720971, 5594.216809646653, 5612.803551875665, 5613.775448982035, 5626.9437305626825, 5630.268065151545, 3910.3156947534635, 3921.0, 3922.1371298314325, 3924.0, 3926.2736393767245, 3956.2680904032845, 3973.443717879499, 3991.501062367204, 3992.86024989124, 3994.0628795034386, 4449.755263460541, 4537.455505339381, 4549.545045495424, 4566.292224705109, 4638.002829391629, 5427.375851777097, 5429.610971172671, 5431.375391829911, 5462.2079798429, 5463.125899856004, 1354.9160671462791, 1362.5163067111032, 1369.7739872921056, 1373.8322425938072, 1374.7869080292571, 854.9059603443616, 862.0043849354006, 868.9044205137429, 869.604330029835, 893.2273583350485, 4780.378550788445, 4811.422629284508, 4816.229403295456, 4847.612191024709, 4859.198232291703, 4975.776090075955, 5020.723860187724, 5026.396832380138, 5038.4304004957, 5060.520345030982, 4739.928901066487, 4782.856514304576, 4810.0, 4978.178600530872, 5312.362516498045, 2938.647362316493, 2979.7914146010003, 2988.641363036406, 2989.5515672649276, 2991.100651086576, 5865.97345464542, 5894.852628684317, 5898.557608179403, 5921.911171332434, 5924.407559244041, 5520.91718624221, 5709.200711900255, 5718.771249150071, 5749.568782341341, 5768.711564421762, 5857.096443655829, 5863.912041319383, 5879.882402351929, 5891.3209735225255, 5894.793682221101, 5333.759980800795, 5556.749946252347, 5570.660322664409, 5573.191887176417, 5596.972015139898, 5554.777808887761, 5563.1905887528155, 5563.941341703434, 5570.944290557042, 5580.497755202051, 5769.653820770767, 5830.854228644318, 5845.240118784531, 5871.383504731942, 5899.38056504078, 3888.08629971962, 3965.2862484751868, 3971.285168669667, 4008.7995600219288, 4018.8191531381744, 5320.17537281722, 5550.47270509301, 5551.805686800943, 5562.471565201299, 5565.944340556543, 5297.417284098669, 5455.236266922713, 5458.426865179099, 5471.2887324647545, 5480.0271902116, 5384.330857434208, 5387.3804512481565, 5388.838334849961, 5406.0, 5412.700951771468, 5174.586033117266, 5352.330958630171, 5360.0, 5365.22204280385, 5374.785008599769, 5464.825062611558, 5485.6982865942755, 5488.643238189505, 5492.450754924475, 5493.7802487900035, 5371.248025276386, 5374.301340825824, 5375.731213439234, 5380.300560927211, 5382.407935127211], "value": 4097.061551472055, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [773.918738532454, 781.827997840475, 807.4428644235477, 848.5587494502856, 867.176182626505, 14397.0, 14733.48432804852, 14855.0, 14866.851331486681, 15007.399704011854, 14900.18049007307, 14999.47501837436, 14999.550013499585, 15002.474913378033, 15020.17389043602, 652.6475703120309, 785.3756263770316, 789.3290702902516, 808.4825711544587, 815.8327542853731, 792.8453951479464, 802.5666140284239, 802.7511471443871, 803.1125606205147, 803.3292201012162, 853.6670698427619, 853.6713365354321, 854.1586537260824, 855.1747563601124, 855.5636625321068, 687.4191308344466, 826.9090400055989, 845.9619317130744, 848.6902280667542, 857.0229937870832, 623.4980840423457, 625.1279465146141, 625.337142628815, 625.4933503861841, 625.5871125057486, 15390.07659540431, 15422.922885385502, 15426.074435533792, 15432.845671543366, 15447.691046179014, 13900.721985560333, 13925.0, 14247.928760356235, 14372.425102995867, 14440.0, 13162.539311124161, 13178.80596119822, 13565.0, 13765.105268157638, 14240.786388204186, 4154.563770804052, 4203.62167404935, 4223.894402639928, 4393.868183954486, 4393.9121217575785, 79170.60414697947, 79833.60083199547, 79970.0, 80779.19220807776, 82809.58595207045, 11687.134590292986, 11701.590444334408, 11722.238054526428, 11938.940305298418, 12031.578894738643, 22489.550208996057, 22508.0, 22569.548609027726, 22590.0, 22748.20381286647, 8452.535110568977, 8517.190866867762, 8530.232279094911, 8532.0, 8742.213200811957, 4621.30680397943, 4684.391029166187, 4698.107359601665, 4704.903499952989, 4890.82882099132, 3142.481490554079, 3200.231944333343, 3210.0369889033195, 3216.469282568397, 3237.4820028795752, 574.4600075928614, 577.2985822225932, 589.0369246282273, 613.9017757158833, 628.3810446709987, 653.7352372289231, 669.1668872254074, 690.8652812701575, 710.7974227345181, 719.316649183278, 9133.77165570866, 9351.812963740687, 9460.148586627236, 9900.851487227554, 10112.646057387956, 610.8992016317346, 639.2648454277524, 674.3189378727423, 711.5061708710936, 721.0914248047497, 4654.97672511642, 4672.229082201467, 4750.596199323028, 4773.76131193439, 4790.784414701347, 73009.0, 83115.16884831195, 131976.0, 132484.0, 132524.0, 90664.54667726751, 109796.4510177444, 111062.44468777605, 113297.4335128319, 115633.4218328903, 96614.51692741632, 98139.0, 98308.99999999857, 98998.50500747451, 101050.4947475258, 8681.262092721936, 8934.329925255763, 9050.773730656523, 9080.909190908007, 9100.635974560944, 40385.0, 49433.752831235615, 55151.44848551463, 56243.0, 56489.43510565006, 75326.0, 78171.60914195393, 86340.0, 86614.56692716749, 87358.56320718356, 13621.727565448833, 13680.794788077988, 13700.383482743102, 14000.299985000505, 14527.128372297697, 15651.765223521885, 16049.438269660506, 16133.75799363034, 16776.74834877502, 16786.58033549171, 14495.78256326135, 14896.702065958403, 15006.2496875158, 15329.233538323262, 15671.216439177768, 14036.649083772987, 14394.136351818925, 14599.781003284746, 14713.779293310396, 15130.016548924285, 13134.343282835629, 13304.46782128704, 13882.722345553235, 14380.209088500233, 14931.701365972402, 11530.2603782734, 11664.475098620413, 11709.238899471507, 11735.823962640738, 11822.586209482626, 10877.0, 11992.460339284928, 12056.84726164416, 12260.26438413698, 12282.447289871798], "value": 7728.733336130777, "unit": "score"}], "name": "dromaeo_css", "value": 7164.372316956995, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 110.0, 111.0, 111.0, 111.0, 111.0, 111.0, 118.0, 108.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 123.0, 126.0, 169.0, 123.0, 121.0, 148.0, 116.0, 170.0, 123.0], "value": 137.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 162.0, 161.0, 161.0, 161.0, 161.0, 160.0, 163.0, 162.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 105.0, 74.0, 74.0, 74.0, 74.0, 104.0, 75.0], "value": 80.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 124.0, 84.0, 83.0, 83.0, 121.0, 84.0, 83.0, 130.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 146.0, 146.0, 146.0, 147.0, 145.0, 145.0, 146.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 53.0, 53.0, 54.0, 52.0, 54.0, 53.0, 54.0, 54.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 61.0, 63.0, 62.0, 62.0, 62.0, 62.0, 62.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 75.0, 76.0, 74.0, 76.0, 75.0, 75.0, 75.0, 86.0], "value": 76.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 123.0, 119.0, 122.0, 118.0, 119.0, 121.0, 121.0, 165.0, 122.0], "value": 125.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 159.0, 158.0, 159.0, 157.0, 155.0, 154.0, 158.0, 158.0, 161.0], "value": 158.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 60.0, 61.0, 64.0, 65.0, 62.0, 62.0, 61.0], "value": 62.2, "unit": "score"}], "name": "kraken", "value": 1480.6, "alertThreshold": 2.0}]} 02:32:39 INFO - Return code: 0 02:32:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:32:39 INFO - # TBPL SUCCESS # 02:32:39 INFO - Running post-action listener: _resource_record_post_action 02:32:39 INFO - [mozharness: 2016-08-01 09:32:39.262413Z] Finished run-tests step (success) 02:32:39 INFO - Running post-run listener: _resource_record_post_run 02:32:39 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 540999680; Read time: 16; Write time: 368324 02:32:39 INFO - TinderboxPrint: CPU usage
13.0% 02:32:39 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 02:32:39 INFO - TinderboxPrint: I/O write bytes / time
540,999,680 / 368,324 02:32:39 INFO - TinderboxPrint: CPU idle
8,267.3 (87.0%) 02:32:39 INFO - TinderboxPrint: CPU user
1,195.2 (12.6%) 02:32:39 INFO - TinderboxPrint: Swap in / out
0 / 0 02:32:39 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 247857152; Read time: 0; Write time: 192544 02:32:39 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 292757504; Read time: 0; Write time: 175724 02:32:39 INFO - Running post-run listener: _upload_blobber_files 02:32:39 INFO - Blob upload gear active. 02:32:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:32:39 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 02:32:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:32:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:32:40 INFO - (blobuploader) - INFO - Open directory for files ... 02:32:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:32:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:32:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:32:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:32:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:32:41 INFO - (blobuploader) - INFO - Done attempting. 02:32:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:32:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:32:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:32:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:32:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:32:41 INFO - (blobuploader) - INFO - Done attempting. 02:32:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:32:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:32:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:32:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:32:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:32:46 INFO - (blobuploader) - INFO - Done attempting. 02:32:46 INFO - (blobuploader) - INFO - Iteration through files over. 02:32:46 INFO - Return code: 0 02:32:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:32:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:32:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8de3e2d23c54015abe5b9f4fe9feb607271e4a527deb5ed8571a96ef146f5812aef48b1f25ea25caa1787d9303692590bcc42c75ecf59ff02d3415c0edaf4b16", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5747a3e9365964e862d14acc451f2faeb4d98b9eb399d887f70091a394547c083bb45b158b91836d58105b21589bc60cefbb446b327e921a270f5d9ae69a7c83", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/036eff3b249ceeaf97a796020485da66bbe5d8d5eee66756a135eaa947c2d25b404d7e8414f96be0f229a9d172dc99dabb525802c63fe9e7a31aca51abdcd9b5"} 02:32:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:32:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:32:46 INFO - Contents: 02:32:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8de3e2d23c54015abe5b9f4fe9feb607271e4a527deb5ed8571a96ef146f5812aef48b1f25ea25caa1787d9303692590bcc42c75ecf59ff02d3415c0edaf4b16", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5747a3e9365964e862d14acc451f2faeb4d98b9eb399d887f70091a394547c083bb45b158b91836d58105b21589bc60cefbb446b327e921a270f5d9ae69a7c83", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/036eff3b249ceeaf97a796020485da66bbe5d8d5eee66756a135eaa947c2d25b404d7e8414f96be0f229a9d172dc99dabb525802c63fe9e7a31aca51abdcd9b5"} 02:32:46 INFO - Running post-run listener: copy_logs_to_upload_dir 02:32:46 INFO - Copying logs to upload dir... 02:32:46 INFO - mkdir: /builds/slave/test/build/upload/logs 02:32:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.248406 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-08-01 02:32:45.175634) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 02:32:45.178784) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1470042394.975943-494518010 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8de3e2d23c54015abe5b9f4fe9feb607271e4a527deb5ed8571a96ef146f5812aef48b1f25ea25caa1787d9303692590bcc42c75ecf59ff02d3415c0edaf4b16", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5747a3e9365964e862d14acc451f2faeb4d98b9eb399d887f70091a394547c083bb45b158b91836d58105b21589bc60cefbb446b327e921a270f5d9ae69a7c83", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/036eff3b249ceeaf97a796020485da66bbe5d8d5eee66756a135eaa947c2d25b404d7e8414f96be0f229a9d172dc99dabb525802c63fe9e7a31aca51abdcd9b5"} build_url:https://queue.taskcluster.net/v1/task/WmjbcJYjRIuTNoQIVLKMjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011321 build_url: 'https://queue.taskcluster.net/v1/task/WmjbcJYjRIuTNoQIVLKMjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8de3e2d23c54015abe5b9f4fe9feb607271e4a527deb5ed8571a96ef146f5812aef48b1f25ea25caa1787d9303692590bcc42c75ecf59ff02d3415c0edaf4b16", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5747a3e9365964e862d14acc451f2faeb4d98b9eb399d887f70091a394547c083bb45b158b91836d58105b21589bc60cefbb446b327e921a270f5d9ae69a7c83", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/036eff3b249ceeaf97a796020485da66bbe5d8d5eee66756a135eaa947c2d25b404d7e8414f96be0f229a9d172dc99dabb525802c63fe9e7a31aca51abdcd9b5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 02:32:45.205795) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 02:32:45.206403) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1470042394.975943-494518010 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004510 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 02:32:45.290464) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 02:32:45.291041) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 02:32:45.291627) ========= ========= Total master_lag: 0.17 =========