builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-061 starttime: 1469811914.83 results: success (0) buildid: 20160729093225 builduid: 38e29c42cd1f4b94bca5c38d5fc66cf6 revision: 28c06a8a920886900feef350561aa11e74122513 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-29 10:05:14.834286) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-29 10:05:14.835060) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-29 10:05:14.835372) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-29 10:05:14.982410) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 10:05:14.982704) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1469807819.680894-1233759330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-29 10:05:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-07-29 10:05:15 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.078630 ========= master_lag: 0.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 10:05:15.166365) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 10:05:15.166774) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1469807819.680894-1233759330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019544 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 10:05:15.200279) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 10:05:15.200708) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 28c06a8a920886900feef350561aa11e74122513 --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 28c06a8a920886900feef350561aa11e74122513 --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=516f8d7ca085b4d087ab0a71000001a4-1469807819.680894-1233759330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-29 10:05:15,384 truncating revision to first 12 chars 2016-07-29 10:05:15,384 Setting DEBUG logging. 2016-07-29 10:05:15,384 attempt 1/10 2016-07-29 10:05:15,384 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/28c06a8a9208?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-29 10:05:15,708 unpacking tar archive at: fx-team-28c06a8a9208/testing/mozharness/ program finished with exit code 0 elapsedTime=0.638474 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 10:05:15.853095) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-29 10:05:15.853414) ========= script_repo_revision: 28c06a8a920886900feef350561aa11e74122513 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-29 10:05:15.853873) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-29 10:05:15.854217) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-29 10:05:15.866156) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-07-29 10:05:15.866462) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=516f8d7ca085b4d087ab0a71000001a4-1469807819.680894-1233759330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:05:16 INFO - MultiFileLogger online at 20160729 10:05:16 in /builds/slave/test 10:05:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 10:05:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:05:16 INFO - {'append_to_log': False, 10:05:16 INFO - 'base_work_dir': '/builds/slave/test', 10:05:16 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:05:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:05:16 INFO - 'branch': 'Fx-Team-Non-PGO', 10:05:16 INFO - 'buildbot_json_path': 'buildprops.json', 10:05:16 INFO - 'config_files': ('talos/linux_config.py',), 10:05:16 INFO - 'default_actions': ('clobber', 10:05:16 INFO - 'read-buildbot-config', 10:05:16 INFO - 'download-and-extract', 10:05:16 INFO - 'populate-webroot', 10:05:16 INFO - 'create-virtualenv', 10:05:16 INFO - 'install', 10:05:16 INFO - 'run-tests'), 10:05:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:05:16 INFO - 'download_minidump_stackwalk': True, 10:05:16 INFO - 'download_symbols': 'ondemand', 10:05:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:05:16 INFO - 'tooltool.py': '/tools/tooltool.py', 10:05:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:05:16 INFO - '/tools/misc-python/virtualenv.py')}, 10:05:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:05:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:05:16 INFO - 'installer_path': 'installer.exe', 10:05:16 INFO - 'log_level': 'info', 10:05:16 INFO - 'log_name': 'talos', 10:05:16 INFO - 'log_to_console': True, 10:05:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:05:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:05:16 INFO - 'opt_config_files': (), 10:05:16 INFO - 'pip_index': False, 10:05:16 INFO - 'sps_profile': False, 10:05:16 INFO - 'sps_profile_interval': 0, 10:05:16 INFO - 'suite': 'dromaeojs', 10:05:16 INFO - 'system_bits': '32', 10:05:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:05:16 INFO - 'title': 'talos-linux64-ix-061', 10:05:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:05:16 INFO - 'use_talos_json': True, 10:05:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:05:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:05:16 INFO - 'work_dir': 'build'} 10:05:16 INFO - [mozharness: 2016-07-29 17:05:16.142995Z] Running clobber step. 10:05:16 INFO - Running pre-action listener: _resource_record_pre_action 10:05:16 INFO - Running main action method: clobber 10:05:16 INFO - rmtree: /builds/slave/test/build 10:05:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:05:16 INFO - Running post-action listener: _resource_record_post_action 10:05:16 INFO - [mozharness: 2016-07-29 17:05:16.587852Z] Finished clobber step (success) 10:05:16 INFO - [mozharness: 2016-07-29 17:05:16.587954Z] Running read-buildbot-config step. 10:05:16 INFO - Running pre-action listener: _resource_record_pre_action 10:05:16 INFO - Running main action method: read_buildbot_config 10:05:16 INFO - Using buildbot properties: 10:05:16 INFO - { 10:05:16 INFO - "project": "", 10:05:16 INFO - "product": "firefox", 10:05:16 INFO - "script_repo_revision": "production", 10:05:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:05:16 INFO - "repository": "", 10:05:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 10:05:16 INFO - "buildid": "20160729093225", 10:05:16 INFO - "pgo_build": "False", 10:05:16 INFO - "basedir": "/builds/slave/test", 10:05:16 INFO - "buildnumber": 1838, 10:05:16 INFO - "slavename": "talos-linux64-ix-061", 10:05:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:05:16 INFO - "platform": "ubuntu64_hw", 10:05:16 INFO - "scheduler": "tests-fx-team-linux64-talos", 10:05:16 INFO - "branch": "fx-team", 10:05:16 INFO - "repo_path": "integration/fx-team", 10:05:16 INFO - "revision": "28c06a8a920886900feef350561aa11e74122513", 10:05:16 INFO - "stage_platform": "linux64", 10:05:16 INFO - "builduid": "38e29c42cd1f4b94bca5c38d5fc66cf6", 10:05:16 INFO - "slavebuilddir": "test" 10:05:16 INFO - } 10:05:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/AbO1_ekCQqWehh8u9sr5Cw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 10:05:16 INFO - Running post-action listener: _resource_record_post_action 10:05:16 INFO - [mozharness: 2016-07-29 17:05:16.590416Z] Finished read-buildbot-config step (success) 10:05:16 INFO - [mozharness: 2016-07-29 17:05:16.590505Z] Running download-and-extract step. 10:05:16 INFO - Running pre-action listener: _resource_record_pre_action 10:05:16 INFO - Running main action method: download_and_extract 10:05:16 INFO - mkdir: /builds/slave/test/build/tests 10:05:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:16 INFO - https://queue.taskcluster.net/v1/task/AbO1_ekCQqWehh8u9sr5Cw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:05:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbO1_ekCQqWehh8u9sr5Cw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:05:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbO1_ekCQqWehh8u9sr5Cw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:05:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbO1_ekCQqWehh8u9sr5Cw/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 10:05:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbO1_ekCQqWehh8u9sr5Cw/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 10:05:25 INFO - Downloaded 1361 bytes. 10:05:25 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:05:25 INFO - Using the following test package requirements: 10:05:25 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:05:25 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:05:25 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:05:25 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:25 INFO - u'jsshell-linux-x86_64.zip'], 10:05:25 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:05:25 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:05:25 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:05:25 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:05:25 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:05:25 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:05:25 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:05:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:25 INFO - https://queue.taskcluster.net/v1/task/AbO1_ekCQqWehh8u9sr5Cw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:05:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbO1_ekCQqWehh8u9sr5Cw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:05:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbO1_ekCQqWehh8u9sr5Cw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:05:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbO1_ekCQqWehh8u9sr5Cw/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 10:05:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbO1_ekCQqWehh8u9sr5Cw/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 10:05:29 INFO - Downloaded 20231869 bytes. 10:05:29 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'] 10:05:29 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 10:05:30 INFO - Return code: 0 10:05:30 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 10:05:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:30 INFO - https://queue.taskcluster.net/v1/task/AbO1_ekCQqWehh8u9sr5Cw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:05:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbO1_ekCQqWehh8u9sr5Cw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:05:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbO1_ekCQqWehh8u9sr5Cw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:05:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbO1_ekCQqWehh8u9sr5Cw/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 10:05:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbO1_ekCQqWehh8u9sr5Cw/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 10:05:33 INFO - Downloaded 20231869 bytes. 10:05:33 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'] 10:05:33 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 10:05:34 INFO - Return code: 0 10:05:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:34 INFO - https://queue.taskcluster.net/v1/task/AbO1_ekCQqWehh8u9sr5Cw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:05:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbO1_ekCQqWehh8u9sr5Cw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:05:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbO1_ekCQqWehh8u9sr5Cw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:05:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbO1_ekCQqWehh8u9sr5Cw/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 10:05:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbO1_ekCQqWehh8u9sr5Cw/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 10:05:35 INFO - Downloaded 14413725 bytes. 10:05:35 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'] 10:05:35 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 10:05:35 INFO - Return code: 0 10:05:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:35 INFO - https://queue.taskcluster.net/v1/task/AbO1_ekCQqWehh8u9sr5Cw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:05:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbO1_ekCQqWehh8u9sr5Cw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:05:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbO1_ekCQqWehh8u9sr5Cw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:05:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbO1_ekCQqWehh8u9sr5Cw/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 10:05:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbO1_ekCQqWehh8u9sr5Cw/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 10:05:36 INFO - Downloaded 55587307 bytes. 10:05:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AbO1_ekCQqWehh8u9sr5Cw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:05:36 INFO - mkdir: /builds/slave/test/properties 10:05:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:05:36 INFO - Writing to file /builds/slave/test/properties/build_url 10:05:36 INFO - Contents: 10:05:36 INFO - build_url:https://queue.taskcluster.net/v1/task/AbO1_ekCQqWehh8u9sr5Cw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:05:37 INFO - Running post-action listener: _resource_record_post_action 10:05:37 INFO - Running post-action listener: set_extra_try_arguments 10:05:37 INFO - [mozharness: 2016-07-29 17:05:37.451887Z] Finished download-and-extract step (success) 10:05:37 INFO - [mozharness: 2016-07-29 17:05:37.452119Z] Running populate-webroot step. 10:05:37 INFO - Running pre-action listener: _resource_record_pre_action 10:05:37 INFO - Running main action method: populate_webroot 10:05:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:05:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:05:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:05:37 INFO - '--tppagecycles', 10:05:37 INFO - '7'], 10:05:37 INFO - 'tests': ['tsvgm']}}, 10:05:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:05:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:05:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:05:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:05:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:05:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:05:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:37 INFO - 'talos_options': ['--disable-e10s'], 10:05:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:05:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:05:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:37 INFO - 'talos_options': ['--disable-e10s'], 10:05:37 INFO - 'tests': ['damp', 'tps']}, 10:05:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:37 INFO - 'tests': ['damp', 'tps']}, 10:05:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:05:37 INFO - 'tests': ['dromaeo_dom']}, 10:05:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:05:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:05:37 INFO - 'tests': ['basic_compositor_video']}, 10:05:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:05:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:05:37 INFO - 'tests': ['a11yr', 10:05:37 INFO - 'ts_paint', 10:05:37 INFO - 'tpaint', 10:05:37 INFO - 'sessionrestore', 10:05:37 INFO - 'sessionrestore_no_auto_restore', 10:05:37 INFO - 'tabpaint']}, 10:05:37 INFO - 'other-e10s': {'tests': ['a11yr', 10:05:37 INFO - 'ts_paint', 10:05:37 INFO - 'tpaint', 10:05:37 INFO - 'sessionrestore', 10:05:37 INFO - 'sessionrestore_no_auto_restore', 10:05:37 INFO - 'tabpaint']}, 10:05:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:05:37 INFO - 'ts_paint', 10:05:37 INFO - 'tpaint', 10:05:37 INFO - 'sessionrestore', 10:05:37 INFO - 'sessionrestore_no_auto_restore', 10:05:37 INFO - 'tabpaint']}, 10:05:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:05:37 INFO - 'ts_paint', 10:05:37 INFO - 'tpaint', 10:05:37 INFO - 'sessionrestore', 10:05:37 INFO - 'sessionrestore_no_auto_restore', 10:05:37 INFO - 'tabpaint']}, 10:05:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:05:37 INFO - 'tests': ['a11yr', 10:05:37 INFO - 'ts_paint', 10:05:37 INFO - 'tpaint', 10:05:37 INFO - 'sessionrestore', 10:05:37 INFO - 'sessionrestore_no_auto_restore', 10:05:37 INFO - 'tabpaint']}, 10:05:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:05:37 INFO - 'tests': ['a11yr', 10:05:37 INFO - 'ts_paint', 10:05:37 INFO - 'tpaint', 10:05:37 INFO - 'sessionrestore', 10:05:37 INFO - 'sessionrestore_no_auto_restore', 10:05:37 INFO - 'tabpaint']}, 10:05:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:05:37 INFO - 'tests': ['tsvgx', 10:05:37 INFO - 'tsvgr_opacity', 10:05:37 INFO - 'tart', 10:05:37 INFO - 'tscrollx', 10:05:37 INFO - 'cart']}, 10:05:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:05:37 INFO - 'tsvgr_opacity', 10:05:37 INFO - 'tart', 10:05:37 INFO - 'tscrollx', 10:05:37 INFO - 'cart']}, 10:05:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:37 INFO - 'talos_options': ['--disable-e10s'], 10:05:37 INFO - 'tests': ['tp5o']}, 10:05:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:37 INFO - 'tests': ['tp5o']}, 10:05:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:37 INFO - 'talos_options': ['--disable-e10s', 10:05:37 INFO - '--xperf_path', 10:05:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:05:37 INFO - 'tests': ['tp5n']}, 10:05:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:37 INFO - 'talos_options': ['--xperf_path', 10:05:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:05:37 INFO - 'tests': ['tp5n']}}, 10:05:37 INFO - 'talos.zip': {'path': '', 10:05:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:05:37 INFO - Running post-action listener: _resource_record_post_action 10:05:37 INFO - [mozharness: 2016-07-29 17:05:37.474565Z] Finished populate-webroot step (success) 10:05:37 INFO - [mozharness: 2016-07-29 17:05:37.474660Z] Running create-virtualenv step. 10:05:37 INFO - Running pre-action listener: _resource_record_pre_action 10:05:37 INFO - Running main action method: create_virtualenv 10:05:37 INFO - Creating virtualenv /builds/slave/test/build/venv 10:05:37 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 10:05:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:05:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:05:37 INFO - Using real prefix '/usr' 10:05:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:05:38 INFO - Installing distribute.............................................................................................................................................................................................done. 10:05:40 INFO - Installing pip.................done. 10:05:40 INFO - Return code: 0 10:05:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:05: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')]} 10:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05: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')]} 10:05:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:40 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 0x1663030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1924180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19223b0>, '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 0x19232b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1923740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1469807819.680894-1233759330', '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 10:05:40 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 10:05:40 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 10:05:40 INFO - Using env: {'DISPLAY': ':0', 10:05:40 INFO - 'HOME': '/home/cltbld', 10:05:40 INFO - 'LANG': 'en_US.UTF-8', 10:05:40 INFO - 'LANGUAGE': 'en_US:en', 10:05:40 INFO - 'LOGNAME': 'cltbld', 10:05:40 INFO - 'MAIL': '/var/mail/cltbld', 10:05:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:40 INFO - 'MOZ_NO_REMOTE': '1', 10:05:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:40 INFO - 'NO_EM_RESTART': '1', 10:05:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:40 INFO - 'PWD': '/builds/slave/test', 10:05:40 INFO - 'SHELL': '/bin/bash', 10:05:40 INFO - 'SHLVL': '1', 10:05:40 INFO - 'TERM': 'linux', 10:05:40 INFO - 'TMOUT': '86400', 10:05:40 INFO - 'USER': 'cltbld', 10:05:40 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1469807819.680894-1233759330', 10:05:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:40 INFO - '_': '/tools/buildbot/bin/python'} 10:05:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:40 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 10:05:40 INFO - Cleaning up... 10:05:40 INFO - Return code: 0 10:05:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:05: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')]} 10:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05: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')]} 10:05:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:40 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 0x1663030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1924180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19223b0>, '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 0x19232b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1923740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1469807819.680894-1233759330', '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 10:05:40 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 10:05:40 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 10:05:40 INFO - Using env: {'DISPLAY': ':0', 10:05:40 INFO - 'HOME': '/home/cltbld', 10:05:40 INFO - 'LANG': 'en_US.UTF-8', 10:05:40 INFO - 'LANGUAGE': 'en_US:en', 10:05:40 INFO - 'LOGNAME': 'cltbld', 10:05:40 INFO - 'MAIL': '/var/mail/cltbld', 10:05:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:40 INFO - 'MOZ_NO_REMOTE': '1', 10:05:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:40 INFO - 'NO_EM_RESTART': '1', 10:05:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:40 INFO - 'PWD': '/builds/slave/test', 10:05:40 INFO - 'SHELL': '/bin/bash', 10:05:40 INFO - 'SHLVL': '1', 10:05:40 INFO - 'TERM': 'linux', 10:05:40 INFO - 'TMOUT': '86400', 10:05:40 INFO - 'USER': 'cltbld', 10:05:40 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1469807819.680894-1233759330', 10:05:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:40 INFO - '_': '/tools/buildbot/bin/python'} 10:05:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:40 INFO - Downloading/unpacking psutil>=3.1.1 10:05:40 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 10:05:40 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 10:05:40 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 10:05:40 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 10:05:40 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 10:05:40 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 10:05:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:05:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:05:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:05:42 INFO - Installing collected packages: psutil 10:05:42 INFO - Running setup.py install for psutil 10:05:43 INFO - building 'psutil._psutil_linux' extension 10:05:43 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 10:05:43 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 10:05:43 INFO - building 'psutil._psutil_posix' extension 10:05:43 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 10:05:43 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 10:05:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:05:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:05:43 INFO - Successfully installed psutil 10:05:43 INFO - Cleaning up... 10:05:43 INFO - Return code: 0 10:05:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:05: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')]} 10:05:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05: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')]} 10:05:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:43 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 0x1663030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1924180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19223b0>, '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 0x19232b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1923740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1469807819.680894-1233759330', '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 10:05:43 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 10:05:43 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 10:05:43 INFO - Using env: {'DISPLAY': ':0', 10:05:43 INFO - 'HOME': '/home/cltbld', 10:05:43 INFO - 'LANG': 'en_US.UTF-8', 10:05:43 INFO - 'LANGUAGE': 'en_US:en', 10:05:43 INFO - 'LOGNAME': 'cltbld', 10:05:43 INFO - 'MAIL': '/var/mail/cltbld', 10:05:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:43 INFO - 'MOZ_NO_REMOTE': '1', 10:05:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:43 INFO - 'NO_EM_RESTART': '1', 10:05:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:43 INFO - 'PWD': '/builds/slave/test', 10:05:43 INFO - 'SHELL': '/bin/bash', 10:05:43 INFO - 'SHLVL': '1', 10:05:43 INFO - 'TERM': 'linux', 10:05:43 INFO - 'TMOUT': '86400', 10:05:43 INFO - 'USER': 'cltbld', 10:05:43 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1469807819.680894-1233759330', 10:05:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:43 INFO - '_': '/tools/buildbot/bin/python'} 10:05:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:05:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:05:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:05:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:05:45 INFO - Installing collected packages: mozsystemmonitor 10:05:45 INFO - Running setup.py install for mozsystemmonitor 10:05:46 INFO - Successfully installed mozsystemmonitor 10:05:46 INFO - Cleaning up... 10:05:47 INFO - Return code: 0 10:05:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:05: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')]} 10:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05: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')]} 10:05:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1663030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1924180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19223b0>, '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 0x19232b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1923740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1469807819.680894-1233759330', '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 10:05: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==2.5.1'] in /builds/slave/test/build 10:05: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==2.5.1 10:05:47 INFO - Using env: {'DISPLAY': ':0', 10:05:47 INFO - 'HOME': '/home/cltbld', 10:05:47 INFO - 'LANG': 'en_US.UTF-8', 10:05:47 INFO - 'LANGUAGE': 'en_US:en', 10:05:47 INFO - 'LOGNAME': 'cltbld', 10:05:47 INFO - 'MAIL': '/var/mail/cltbld', 10:05:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:47 INFO - 'MOZ_NO_REMOTE': '1', 10:05:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:47 INFO - 'NO_EM_RESTART': '1', 10:05:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:47 INFO - 'PWD': '/builds/slave/test', 10:05:47 INFO - 'SHELL': '/bin/bash', 10:05:47 INFO - 'SHLVL': '1', 10:05:47 INFO - 'TERM': 'linux', 10:05:47 INFO - 'TMOUT': '86400', 10:05:47 INFO - 'USER': 'cltbld', 10:05:47 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1469807819.680894-1233759330', 10:05:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:47 INFO - '_': '/tools/buildbot/bin/python'} 10:05:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:47 INFO - Downloading/unpacking jsonschema==2.5.1 10:05:47 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 10:05:47 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 10:05:47 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 10:05:47 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 10:05:47 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 10:05:47 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 10:05:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:05:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:05:49 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 10:05:49 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 10:05:49 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 10:05:49 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 10:05:49 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 10:05:49 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 10:05:49 INFO - Downloading functools32-3.2.3-2.tar.gz 10:05:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:05:49 INFO - warning: no files found matching '*.txt' 10:05:49 INFO - no previously-included directories found matching 'build' 10:05:49 INFO - no previously-included directories found matching 'dist' 10:05:49 INFO - no previously-included directories found matching '.git*' 10:05:49 INFO - Installing collected packages: jsonschema, functools32 10:05:49 INFO - Running setup.py install for functools32 10:05:49 INFO - warning: no files found matching '*.txt' 10:05:49 INFO - no previously-included directories found matching 'build' 10:05:49 INFO - no previously-included directories found matching 'dist' 10:05:49 INFO - no previously-included directories found matching '.git*' 10:05:49 INFO - Successfully installed jsonschema functools32 10:05:49 INFO - Cleaning up... 10:05:49 INFO - Return code: 0 10:05:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:49 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 0x1663030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1924180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19223b0>, '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 0x19232b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1923740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1469807819.680894-1233759330', '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 10:05:49 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 10:05:49 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 10:05:49 INFO - Using env: {'DISPLAY': ':0', 10:05:49 INFO - 'HOME': '/home/cltbld', 10:05:49 INFO - 'LANG': 'en_US.UTF-8', 10:05:49 INFO - 'LANGUAGE': 'en_US:en', 10:05:49 INFO - 'LOGNAME': 'cltbld', 10:05:49 INFO - 'MAIL': '/var/mail/cltbld', 10:05:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:49 INFO - 'MOZ_NO_REMOTE': '1', 10:05:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:49 INFO - 'NO_EM_RESTART': '1', 10:05:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:49 INFO - 'PWD': '/builds/slave/test', 10:05:49 INFO - 'SHELL': '/bin/bash', 10:05:49 INFO - 'SHLVL': '1', 10:05:49 INFO - 'TERM': 'linux', 10:05:49 INFO - 'TMOUT': '86400', 10:05:49 INFO - 'USER': 'cltbld', 10:05:49 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1469807819.680894-1233759330', 10:05:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:49 INFO - '_': '/tools/buildbot/bin/python'} 10:05:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:05:49 INFO - Cleaning up... 10:05:49 INFO - Return code: 0 10:05:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:49 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 0x1663030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1924180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19223b0>, '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 0x19232b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1923740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1469807819.680894-1233759330', '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 10:05:49 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 10:05:49 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 10:05:49 INFO - Using env: {'DISPLAY': ':0', 10:05:49 INFO - 'HOME': '/home/cltbld', 10:05:49 INFO - 'LANG': 'en_US.UTF-8', 10:05:49 INFO - 'LANGUAGE': 'en_US:en', 10:05:49 INFO - 'LOGNAME': 'cltbld', 10:05:49 INFO - 'MAIL': '/var/mail/cltbld', 10:05:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:49 INFO - 'MOZ_NO_REMOTE': '1', 10:05:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:49 INFO - 'NO_EM_RESTART': '1', 10:05:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:49 INFO - 'PWD': '/builds/slave/test', 10:05:49 INFO - 'SHELL': '/bin/bash', 10:05:49 INFO - 'SHLVL': '1', 10:05:49 INFO - 'TERM': 'linux', 10:05:49 INFO - 'TMOUT': '86400', 10:05:49 INFO - 'USER': 'cltbld', 10:05:49 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1469807819.680894-1233759330', 10:05:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:49 INFO - '_': '/tools/buildbot/bin/python'} 10:05:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:50 INFO - Downloading/unpacking blobuploader==1.2.4 10:05:50 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 10:05:50 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 10:05:50 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 10:05:50 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 10:05:50 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 10:05:50 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 10:05:51 INFO - Downloading blobuploader-1.2.4.tar.gz 10:05:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:05:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:05:52 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 10:05:52 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 10:05:52 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 10:05:52 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 10:05:52 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 10:05:52 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 10:05:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:05:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:05:52 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 10:05:52 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 10:05:52 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 10:05:52 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 10:05:52 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 10:05:52 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 10:05:52 INFO - Downloading docopt-0.6.1.tar.gz 10:05:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:05:52 INFO - Installing collected packages: blobuploader, requests, docopt 10:05:52 INFO - Running setup.py install for blobuploader 10:05:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:05:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:05:52 INFO - Running setup.py install for requests 10:05:53 INFO - Running setup.py install for docopt 10:05:53 INFO - Successfully installed blobuploader requests docopt 10:05:53 INFO - Cleaning up... 10:05:53 INFO - Return code: 0 10:05:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:05:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:53 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 0x1663030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1924180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19223b0>, '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 0x19232b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1923740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1469807819.680894-1233759330', '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 10:05:53 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 10:05:53 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 10:05:53 INFO - Using env: {'DISPLAY': ':0', 10:05:53 INFO - 'HOME': '/home/cltbld', 10:05:53 INFO - 'LANG': 'en_US.UTF-8', 10:05:53 INFO - 'LANGUAGE': 'en_US:en', 10:05:53 INFO - 'LOGNAME': 'cltbld', 10:05:53 INFO - 'MAIL': '/var/mail/cltbld', 10:05:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:53 INFO - 'MOZ_NO_REMOTE': '1', 10:05:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:53 INFO - 'NO_EM_RESTART': '1', 10:05:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:53 INFO - 'PWD': '/builds/slave/test', 10:05:53 INFO - 'SHELL': '/bin/bash', 10:05:53 INFO - 'SHLVL': '1', 10:05:53 INFO - 'TERM': 'linux', 10:05:53 INFO - 'TMOUT': '86400', 10:05:53 INFO - 'USER': 'cltbld', 10:05:53 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1469807819.680894-1233759330', 10:05:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:53 INFO - '_': '/tools/buildbot/bin/python'} 10:05:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:05:53 INFO - Running setup.py (path:/tmp/pip-Uo1dfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:05:53 INFO - Running setup.py (path:/tmp/pip-R3mjgx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:05:53 INFO - Running setup.py (path:/tmp/pip-A7kCot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:05:53 INFO - Running setup.py (path:/tmp/pip-QdAwYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:05:53 INFO - Running setup.py (path:/tmp/pip-MNd1JY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:05:53 INFO - Running setup.py (path:/tmp/pip-FW1dfK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:05:53 INFO - Running setup.py (path:/tmp/pip-MookTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:05:54 INFO - Running setup.py (path:/tmp/pip-tQmxqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:05:54 INFO - Running setup.py (path:/tmp/pip-hN5Art-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:05:54 INFO - Running setup.py (path:/tmp/pip-cGPPxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:05:54 INFO - Running setup.py (path:/tmp/pip-v83UG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:05:54 INFO - Running setup.py (path:/tmp/pip-cvTjU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:05:54 INFO - Running setup.py (path:/tmp/pip-oSehZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:05:54 INFO - Running setup.py (path:/tmp/pip-xcQVma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:54 INFO - Running setup.py (path:/tmp/pip-5fy9TH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:05:54 INFO - Running setup.py (path:/tmp/pip-2RoXaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:05:54 INFO - Running setup.py (path:/tmp/pip-m1qTOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:05:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:05:54 INFO - Running setup.py install for manifestparser 10:05:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:05:54 INFO - Running setup.py install for mozcrash 10:05:54 INFO - Running setup.py install for mozdebug 10:05:55 INFO - Running setup.py install for mozdevice 10:05:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:05:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:05:55 INFO - Running setup.py install for mozfile 10:05:55 INFO - Running setup.py install for mozhttpd 10:05:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:05:55 INFO - Running setup.py install for mozinfo 10:05:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:05:55 INFO - Running setup.py install for mozInstall 10:05:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:05:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:05:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:05:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:05:55 INFO - Running setup.py install for mozleak 10:05:55 INFO - Running setup.py install for mozlog 10:05:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:05:55 INFO - Running setup.py install for moznetwork 10:05:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:05:55 INFO - Running setup.py install for mozprocess 10:05:56 INFO - Running setup.py install for mozprofile 10:05:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:05:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:05:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:05:56 INFO - Running setup.py install for mozrunner 10:05:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:05:56 INFO - Running setup.py install for mozscreenshot 10:05:56 INFO - Running setup.py install for moztest 10:05:56 INFO - Running setup.py install for mozversion 10:05:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:05:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:05:56 INFO - Cleaning up... 10:05:56 INFO - Return code: 0 10:05:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:05:56 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')]} 10:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:56 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')]} 10:05:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:56 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 0x1663030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1924180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19223b0>, '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 0x19232b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1923740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1469807819.680894-1233759330', '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 10:05:56 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 10:05:56 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 10:05:56 INFO - Using env: {'DISPLAY': ':0', 10:05:56 INFO - 'HOME': '/home/cltbld', 10:05:56 INFO - 'LANG': 'en_US.UTF-8', 10:05:56 INFO - 'LANGUAGE': 'en_US:en', 10:05:56 INFO - 'LOGNAME': 'cltbld', 10:05:56 INFO - 'MAIL': '/var/mail/cltbld', 10:05:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:56 INFO - 'MOZ_NO_REMOTE': '1', 10:05:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:56 INFO - 'NO_EM_RESTART': '1', 10:05:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:56 INFO - 'PWD': '/builds/slave/test', 10:05:56 INFO - 'SHELL': '/bin/bash', 10:05:56 INFO - 'SHLVL': '1', 10:05:56 INFO - 'TERM': 'linux', 10:05:56 INFO - 'TMOUT': '86400', 10:05:56 INFO - 'USER': 'cltbld', 10:05:56 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1469807819.680894-1233759330', 10:05:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:56 INFO - '_': '/tools/buildbot/bin/python'} 10:05:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:05:56 INFO - Running setup.py (path:/tmp/pip-joDiqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:05:56 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)) 10:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:05:56 INFO - Running setup.py (path:/tmp/pip-r5wND5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:05:56 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)) 10:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:05:56 INFO - Running setup.py (path:/tmp/pip-WXoxl9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:05:57 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)) 10:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:05:57 INFO - Running setup.py (path:/tmp/pip-6reQlI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:05:57 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)) 10:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:05:57 INFO - Running setup.py (path:/tmp/pip-1O6iyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:05:57 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)) 10:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:05:57 INFO - Running setup.py (path:/tmp/pip-d4kV7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:05:57 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)) 10:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:05:57 INFO - Running setup.py (path:/tmp/pip-bGxAV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:05:57 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)) 10:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:05:57 INFO - Running setup.py (path:/tmp/pip-KDdqev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:05:57 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)) 10:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:05:57 INFO - Running setup.py (path:/tmp/pip-MfsQcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:05:57 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)) 10:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:05:57 INFO - Running setup.py (path:/tmp/pip-Mn1K7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:05:57 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)) 10:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:05:57 INFO - Running setup.py (path:/tmp/pip-_L1wP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:05:57 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)) 10:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:05:57 INFO - Running setup.py (path:/tmp/pip-xCAocu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:05:57 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)) 10:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:05:57 INFO - Running setup.py (path:/tmp/pip-_IUM0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:05:57 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)) 10:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:05:57 INFO - Running setup.py (path:/tmp/pip-v5VmgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:05:57 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)) 10:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:57 INFO - Running setup.py (path:/tmp/pip-lSpvzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:57 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)) 10:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:05:57 INFO - Running setup.py (path:/tmp/pip-wq9TFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:05:57 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)) 10:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:05:57 INFO - Running setup.py (path:/tmp/pip-3PftMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:05:58 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)) 10:05:58 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)) 10:05:58 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)) 10:05:58 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)) 10:05:58 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)) 10:05:58 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)) 10:05:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:59 INFO - Downloading blessings-1.6.tar.gz 10:05:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:06:00 INFO - Installing collected packages: blessings 10:06:00 INFO - Running setup.py install for blessings 10:06:00 INFO - Successfully installed blessings 10:06:00 INFO - Cleaning up... 10:06:00 INFO - Return code: 0 10:06:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:06:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:06:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:06:00 INFO - Reading from file tmpfile_stdout 10:06:00 INFO - Current package versions: 10:06:00 INFO - argparse == 1.2.1 10:06:00 INFO - blessings == 1.6 10:06:00 INFO - blobuploader == 1.2.4 10:06:00 INFO - docopt == 0.6.1 10:06:00 INFO - functools32 == 3.2.3-2 10:06:00 INFO - jsonschema == 2.5.1 10:06:00 INFO - manifestparser == 1.1 10:06:00 INFO - mozInstall == 1.12 10:06:00 INFO - mozcrash == 0.17 10:06:00 INFO - mozdebug == 0.1 10:06:00 INFO - mozdevice == 0.48 10:06:00 INFO - mozfile == 1.2 10:06:00 INFO - mozhttpd == 0.7 10:06:00 INFO - mozinfo == 0.9 10:06:00 INFO - mozleak == 0.1 10:06:00 INFO - mozlog == 3.3 10:06:00 INFO - moznetwork == 0.27 10:06:00 INFO - mozprocess == 0.23 10:06:00 INFO - mozprofile == 0.28 10:06:00 INFO - mozrunner == 6.12 10:06:00 INFO - mozscreenshot == 0.1 10:06:00 INFO - mozsystemmonitor == 0.3 10:06:00 INFO - moztest == 0.7 10:06:00 INFO - mozversion == 1.4 10:06:00 INFO - psutil == 3.1.1 10:06:00 INFO - requests == 1.2.3 10:06:00 INFO - wsgiref == 0.1.2 10:06:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:06: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')]} 10:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06: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')]} 10:06:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:00 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 0x1663030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1924180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19223b0>, '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 0x19232b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1923740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1469807819.680894-1233759330', '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 10:06:00 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 10:06:00 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 10:06:00 INFO - Using env: {'DISPLAY': ':0', 10:06:00 INFO - 'HOME': '/home/cltbld', 10:06:00 INFO - 'LANG': 'en_US.UTF-8', 10:06:00 INFO - 'LANGUAGE': 'en_US:en', 10:06:00 INFO - 'LOGNAME': 'cltbld', 10:06:00 INFO - 'MAIL': '/var/mail/cltbld', 10:06:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:00 INFO - 'MOZ_NO_REMOTE': '1', 10:06:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:00 INFO - 'NO_EM_RESTART': '1', 10:06:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:00 INFO - 'PWD': '/builds/slave/test', 10:06:00 INFO - 'SHELL': '/bin/bash', 10:06:00 INFO - 'SHLVL': '1', 10:06:00 INFO - 'TERM': 'linux', 10:06:00 INFO - 'TMOUT': '86400', 10:06:00 INFO - 'USER': 'cltbld', 10:06:00 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1469807819.680894-1233759330', 10:06:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:00 INFO - '_': '/tools/buildbot/bin/python'} 10:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:00 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)) 10:06:00 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)) 10:06:00 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)) 10:06:00 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)) 10:06:00 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)) 10:06:00 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)) 10:06:00 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)) 10:06:00 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)) 10:06:00 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)) 10:06:00 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)) 10:06:00 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)) 10:06:00 INFO - Cleaning up... 10:06:00 INFO - Return code: 0 10:06:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:06: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')]} 10:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06: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')]} 10:06:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1663030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1924180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19223b0>, '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 0x19232b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1923740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1469807819.680894-1233759330', '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 10:06:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:06:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:06:00 INFO - Using env: {'DISPLAY': ':0', 10:06:00 INFO - 'HOME': '/home/cltbld', 10:06:00 INFO - 'LANG': 'en_US.UTF-8', 10:06:00 INFO - 'LANGUAGE': 'en_US:en', 10:06:00 INFO - 'LOGNAME': 'cltbld', 10:06:00 INFO - 'MAIL': '/var/mail/cltbld', 10:06:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:00 INFO - 'MOZ_NO_REMOTE': '1', 10:06:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:00 INFO - 'NO_EM_RESTART': '1', 10:06:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:00 INFO - 'PWD': '/builds/slave/test', 10:06:00 INFO - 'SHELL': '/bin/bash', 10:06:00 INFO - 'SHLVL': '1', 10:06:00 INFO - 'TERM': 'linux', 10:06:00 INFO - 'TMOUT': '86400', 10:06:00 INFO - 'USER': 'cltbld', 10:06:00 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1469807819.680894-1233759330', 10:06:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:00 INFO - '_': '/tools/buildbot/bin/python'} 10:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:06:00 INFO - Cleaning up... 10:06:00 INFO - Return code: 0 10:06:00 INFO - Running post-action listener: _resource_record_post_action 10:06:00 INFO - Running post-action listener: _start_resource_monitoring 10:06:00 INFO - Starting resource monitoring. 10:06:00 INFO - [mozharness: 2016-07-29 17:06:00.862548Z] Finished create-virtualenv step (success) 10:06:00 INFO - [mozharness: 2016-07-29 17:06:00.863021Z] Running install step. 10:06:00 INFO - Running pre-action listener: _resource_record_pre_action 10:06:00 INFO - Running main action method: install 10:06:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:06:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:06:01 INFO - Reading from file tmpfile_stdout 10:06:01 INFO - Detecting whether we're running mozinstall >=1.0... 10:06:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:06:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:06:01 INFO - Reading from file tmpfile_stdout 10:06:01 INFO - Output received: 10:06:01 INFO - Usage: mozinstall [options] installer 10:06:01 INFO - Options: 10:06:01 INFO - -h, --help show this help message and exit 10:06:01 INFO - -d DEST, --destination=DEST 10:06:01 INFO - Directory to install application into. [default: 10:06:01 INFO - "/builds/slave/test"] 10:06:01 INFO - --app=APP Application being installed. [default: firefox] 10:06:01 INFO - mkdir: /builds/slave/test/build/application 10:06:01 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'] 10:06:01 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 10:06:17 INFO - Reading from file tmpfile_stdout 10:06:17 INFO - Output received: 10:06:17 INFO - /builds/slave/test/build/application/firefox/firefox 10:06:17 INFO - Running post-action listener: _resource_record_post_action 10:06:17 INFO - [mozharness: 2016-07-29 17:06:17.143732Z] Finished install step (success) 10:06:17 INFO - [mozharness: 2016-07-29 17:06:17.144073Z] Running run-tests step. 10:06:17 INFO - Running pre-action listener: _resource_record_pre_action 10:06:17 INFO - Running main action method: run_tests 10:06:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:06:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:06:17 INFO - Python 2.7.3 10:06:17 INFO - Return code: 0 10:06:17 INFO - grabbing minidump binary from tooltool 10:06:17 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')]} 10:06:17 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 0x19223b0>, '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 0x19232b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1923740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:06:17 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 10:06:17 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 10:06:17 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 10:06:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:06:17 INFO - Return code: 0 10:06:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:06:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:06:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:06:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:06:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:06:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AbO1_ekCQqWehh8u9sr5Cw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 10:06:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AbO1_ekCQqWehh8u9sr5Cw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 10:06:17 INFO - Using env: {'DISPLAY': ':0', 10:06:17 INFO - 'HOME': '/home/cltbld', 10:06:17 INFO - 'LANG': 'en_US.UTF-8', 10:06:17 INFO - 'LANGUAGE': 'en_US:en', 10:06:17 INFO - 'LOGNAME': 'cltbld', 10:06:17 INFO - 'MAIL': '/var/mail/cltbld', 10:06:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:06:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:06:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:17 INFO - 'MOZ_NO_REMOTE': '1', 10:06:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:06:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:17 INFO - 'NO_EM_RESTART': '1', 10:06:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:17 INFO - 'PWD': '/builds/slave/test', 10:06:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:06:17 INFO - 'SHELL': '/bin/bash', 10:06:17 INFO - 'SHLVL': '1', 10:06:17 INFO - 'TERM': 'linux', 10:06:17 INFO - 'TMOUT': '86400', 10:06:17 INFO - 'USER': 'cltbld', 10:06:17 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1469807819.680894-1233759330', 10:06:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:17 INFO - '_': '/tools/buildbot/bin/python'} 10:06:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AbO1_ekCQqWehh8u9sr5Cw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 10:06:17 INFO - mozversion application_buildid: 20160729093225 10:06:17 INFO - mozversion application_changeset: 28c06a8a920886900feef350561aa11e74122513 10:06:17 INFO - mozversion application_display_name: Nightly 10:06:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:06:17 INFO - mozversion application_name: Firefox 10:06:17 INFO - mozversion application_remotingname: firefox 10:06:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:06:17 INFO - mozversion application_vendor: Mozilla 10:06:17 INFO - mozversion application_version: 50.0a1 10:06:17 INFO - mozversion platform_buildid: 20160729093225 10:06:17 INFO - mozversion platform_changeset: 28c06a8a920886900feef350561aa11e74122513 10:06:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:06:17 INFO - mozversion platform_version: 50.0a1 10:06:17 INFO - using testdate: 1469811977 10:06:17 INFO - actual date: 1469811977 10:06:17 INFO - starting webserver on 'localhost:42229' 10:06:17 INFO - SUITE-START | Running 2 tests 10:06:17 INFO - TEST-START | dromaeo_css 10:06:17 INFO - operating with platform_type : linux_ 10:06:17 INFO - Initialising browser for dromaeo_css test... 10:06:17 INFO - TEST-INFO | started process 4968 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZsSu6B/profile http://localhost:42229/getInfo.html) 10:06:22 INFO - PROCESS | 4968 | __metrics Screen width/height:1600/1200 10:06:22 INFO - PROCESS | 4968 | colorDepth:24 10:06:22 INFO - PROCESS | 4968 | Browser inner width/height: 1024/697 10:06:22 INFO - PROCESS | 4968 | __metrics 10:06:22 INFO - PROCESS | 4968 | 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" 10:06:22 INFO - PROCESS | 4968 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:06:23 INFO - TEST-INFO | 4968: exit 0 10:06:23 INFO - Browser initialized. 10:06:23 INFO - Running cycle 1/1 for dromaeo_css test... 10:06:23 INFO - TEST-INFO | started process 5047 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZsSu6B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:06:35 INFO - PROCESS | 5047 | RSS: Main: 157810688 10:06:35 INFO - PROCESS | 5047 | 10:07:28 INFO - PROCESS | 5047 | 1469812048146 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] 10:09:40 INFO - PROCESS | 5047 | Cycle 1(1): loaded http://localhost:42229/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42229/tests/dromaeo/cssquery-ext.html) 10:09:41 INFO - PROCESS | 5047 | RSS: Main: 245010432 10:09:41 INFO - PROCESS | 5047 | 10:12:43 INFO - PROCESS | 5047 | Cycle 1(1): loaded http://localhost:42229/tests/dromaeo/cssquery-ext.html (next: http://localhost:42229/tests/dromaeo/cssquery-jquery.html) 10:12:44 INFO - PROCESS | 5047 | RSS: Main: 240926720 10:12:44 INFO - PROCESS | 5047 | 10:15:46 INFO - PROCESS | 5047 | Cycle 1(1): loaded http://localhost:42229/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42229/tests/dromaeo/cssquery-mootools.html) 10:15:46 INFO - PROCESS | 5047 | RSS: Main: 192503808 10:15:46 INFO - PROCESS | 5047 | 10:18:49 INFO - PROCESS | 5047 | Cycle 1(1): loaded http://localhost:42229/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42229/tests/dromaeo/cssquery-prototype.html) 10:18:49 INFO - PROCESS | 5047 | RSS: Main: 187936768 10:18:49 INFO - PROCESS | 5047 | 10:21:52 INFO - PROCESS | 5047 | Cycle 1(1): loaded http://localhost:42229/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42229/tests/dromaeo/cssquery-yui.html) 10:21:53 INFO - PROCESS | 5047 | RSS: Main: 190636032 10:21:53 INFO - PROCESS | 5047 | 10:24:56 INFO - PROCESS | 5047 | Cycle 1(1): loaded http://localhost:42229/tests/dromaeo/cssquery-yui.html (next: http://localhost:42229/tests/dromaeo/cssquery-dojo.html) 10:24:56 INFO - PROCESS | 5047 | RSS: Main: 281026560 10:24:56 INFO - PROCESS | 5047 | 10:24:56 INFO - PROCESS | 5047 | __start_tp_report 10:24:56 INFO - PROCESS | 5047 | _x_x_mozilla_page_load 10:24:56 INFO - PROCESS | 5047 | _x_x_mozilla_page_load_details 10:24:56 INFO - PROCESS | 5047 | |i|pagename|runs| 10:24:56 INFO - PROCESS | 5047 | |0;dojo.html;2671.3455203475146;2671.5458372076746;2701;2702.716214797447;2708.6885008224062;4649.46531148918;4707.129181101499;4761;4903.730294833783;4920.729359885209;4731.243001119821;4771.785269662865;4795.25673520604;4856.97571512142;4863.951360486394;4326.5673432656795;4354.847580334689;4401.647868170555;4458.063806600618;4556.863294101182;4486.990427153897;4500.234960056799;4541.909161816761;4560.156371071363;4561.2245918193985;4330.458692663417;4376.212281789277;4456.665750068725;4466.843660471868;4562.133194692998;4343.131373725268;4346.847860324873;4359.04101097758;4372.540883207249;4376.256036473776;4349.630281426083;4401.053773438694;4413.0732546165345;4421.712588681726;4457.531959144308;4633.652476064275;4805;4855.247436647325;4864.173090574611;4868.9269660955115;5141.15170996785;5192.844214673566;5194.4805519447755;5223.112070947948;5279.788808447657;5218.425973142951;5230.8169214077325;5235.502627250406;5273.4462881397285;5301.019311427398;4671.392718946515;4794.808207671654;4899.485554016848;4936.654434189572;4939.604831613462;5273.31446911899;5304.177852432879;5333.599980001515;5341.172118321666;5406.729663516887;5117.616178786606;5125.948740512622;5127.820526281637;5182.222666600041;5182.274481572507;4958.330625365602;5097.260897169964;5178.948210517847;5245.449227831023;5246.344206974129;5079.923801142986;5145.511176438233;5150.562202212779;5203.531682148549;5206.062908676399;5104.846854594368;5114.48855114493;5119.564836988898;5128.3845938486875;5170.97414512925;4182.351735480945;4239.872803815891;4349.347597860283;4366.672499562545;4389.3635422864145;3775.075106598846;3814.809259537012;3818.694504439638;3854.69162467002;3917.373220284741;4502.032063106448;4512.05246898155;4551.112533056088;4552.499225085238;4553;4996.300517927493;5238.109521381298;5239.790408383622;5252.921206181911;5295.947040529545;4363.694541382073;4375.343698445195;4440.400545926259;4451.643868490513;4487.169873573399;4632.027274272373;4635.884102897455;4643.558861908114;4644.575199777317;4687.601553867959;4812.470628230822;4826.348442960226;4831;4858.708477491362;4901.50984901507;5002.974985125051;5060.21566657154;5070;5089.8727531812;5115.8233606271515;4801.783919723551;4811.831585894477;4813.326134341265;4848.296996935495;4856.1016212000895;5018.799248030184;5039.546440820343;5039.748012599429;5045.2432135180015;5058.190689489664;4970.179920313108;5116.104681680766;5146.614003949793;5179.559737422362;5196.402413722471;4952.653314267966;4955.40535135786;4959.776810043629;4967.875803104806;5007.349044624176;4973.900521989613;4982.501749824988;4995.550400463976;4997.650164488451;5025.924611130763;4690.788914498924;4810.95189048105;4861.805527778849;4865.5864251539015;4895.534924182197;4972.65191436596;4980.153373926513;4982.128127577732;5002.2496625506465;5026.095302845377;4899.559039686445;4907.55831975124;4909.165441874961;4914.975425122851;4941.604671626189 10:24:56 INFO - PROCESS | 5047 | |1;ext.html;572.0875204049539;577.2755192233747;586.6890548009557;589.2222266608079;589.5519405252008;27465.862670686645;39343;40184.799076004616;40445.7977710111;44824.77587612058;40766.388504172384;41181.17637647245;41210;41253;41253.38119928196;7718.768436946886;7858.174891636381;7866.095399029127;7873.921260787405;7875.330596899242;7738.303552680258;7837.725679601215;7840.921590784104;7844.137144914055;7846.607669616525;7846.05847298325;7893.723719669812;7894.526328420285;7902.288794008538;7902.565358905258;7837.294643482085;7858.803529911741;7862.410319226081;7870.173631768639;7875.645595948167;7765.378769698411;7826.452148349618;7844.9215507844765;7848.058233012075;7850.293473587348;37530.624693753256;38109.23781524382;38155.61844381548;38157.809210954045;38166.23667526662;3091.5671805947186;3111.48660471022;3491.7555771096036;3706.592274849764;3769.924601507982;29845.70154298451;29957.400851983057;30721.846390768125;31884.20289492758;33787.15532111692;2856.7714582833532;2883.2215301868378;2971.777116716255;2977.2705687106795;3034.9393012139635;260059;263158.68420657964;263800;264208;264432;32848.67151328504;55553;56509;56548.71725641345;56594.15108773289;32312.515312270334;34418.139546511535;34455.48316775251;34480.482792757626;34485.827570861984;12946.41741121633;13128.803067953988;13147.408366623526;13156.079074464695;13159.144655597356;11884.286942783288;12158.270503769802;12168.087393445527;12174.513019479122;12184.634460966185;7798.922010779819;7921.36629069673;7984.760457186294;7985.680572777024;8047.356211503065;3150.5904232449634;3178.713915747594;3186.123815950632;3186.537951996994;3214.774965752422;758.2152472191256;825.8802473641289;863.6329559937002;870.6386849457531;882.0429833630454;26568.335791605365;27714.861425692743;28378.71621283802;28417.71582284192;28471.28821779472;889.3507739350181;897.5153417154663;908.895477020138;912.5802131019673;954.9856752148723;14671.193084380247;14904.329305181293;14937.775933361008;15035.61196880473;15188.772168417483;388955;389043;391345;393564;393863;49916.50083499191;50047;50068.99724010999;50502.747486262335;50765;1161.6747310753003;1165.6269993601966;1180.5690922813112;1201.195199216527;1206.927584344942;26564;27370.315742106606;27772;27995.160145195678;27999;45911.31133033074;47213;47275;51898;51925.74037129941;358244;364232;364719;365257;366415;38651.420228697156;39031.2193756129;39099;39099.218015640094;39545.406818897165;42499.787501062296;42572.78713606412;42838.78580607077;43033.56966430296;43341.783291083346;36767;37021.62978370182;37225.81387093047;37858;38005.619943801314;36555.08612284608;37300.440493393166;37688.62311376961;37693.62306376901;38277;28589.857050714614;36118.8194059028;36196.45705314475;36818;37045.62954370422;31122.533162002135;31637.8418107908;32760.344793104483;33011.66988330086;33554.664453356134;25190.62214066827;25273.368165796;25289.241322760347;25494;25597.616035759107 10:24:56 INFO - PROCESS | 5047 | |2;jquery.html;351.66943073510885;372.1774877520679;373.45102699032424;382.51802728562;399.97200195986295;12840.74318513629;15891.84108158918;16099.758503622441;16959.067251301174;18092.09539523025;17022.82977170228;17157.656846863087;17164;17310.394136205236;17406;5070.645054846163;5071.923921141186;5193.45468725784;5231.267622532849;5241.921371179416;3677.3932301170275;5170.327857378536;5251.52736253739;5740.913886291709;6035.245594300713;6105.145279660851;6112.419320164578;6115.113308570255;6131.294901086388;6133.172021777048;5976.671283079429;6042.335343112254;6052.394760523956;6101.420365065312;6107.26712794463;5193.896122077537;5377.3009508764;5380;5380.461953804627;5380.569554435636;20700.792992070186;20786.168553257852;20887.268945586984;21043.158273669036;21095.261665841776;1940.0784627301919;1966.2036875065621;1966.429735376739;2019.1418647074934;2516.219971808745;13307.933460332733;13319.800202996963;13402.329883505883;13563.932180339036;14026.158430494203;1668.8331166883336;1702.5403141151944;1717.2272477385227;1730.2732852202105;1738.7478815571799;72620.63689681518;72947;73126.26873731248;74124;74783.62608186979;9517.428954262767;9726.513674316257;9795.951020244853;9986.872414732647;10157.527158561967;13522.459101635824;13554.390052447663;13565.321733913264;13575.96360545926;13590.38843252056;7534;7787.571683557346;7867.685292588232;7872.763817085496;7993.080795708452;7539.547627142389;7615.847683046308;7795.649195786204;7813.648385822538;7828.921710782934;6147.477464415485;6218.284897236876;6220.564560480723;6225.688715564203;6266.467350275278;1767.328415202215;1852.1757817770963;1853.3883818339916;1859.3492277702696;1876.8592355573387;762.6529928882456;839.4040231435627;853.3770347646129;929.2055292724758;934.9995504809924;17144.39994600183;17165;17417.47747567575;17624.383146589807;17963;869.5956380283072;874.0528608078247;890.496869268874;892.312919052326;923.5013092929877;8952.283817294601;10297.279190456597;10322.793544129225;10362.481875906326;10452.425116618659;386773;387764;393200;398736;402296;54042;66097.66951165213;69581.3041869585;70306.64846675734;71644.2835571648;899.2940541674753;907.577976241051;928.9860652090224;929.9628014879329;939.0140352629847;15565.92217038953;15768;16166.757498637295;16182.595435114215;16475;35673.28653426969;35674.8216258917;36284.63715362812;36286;36840.81579592085;45969;46268;46454.76772616115;46722;47751.52248477471;7642.8089297768;7704.768856934301;7806.4925779824125;7833.138354781084;7960.402969777174;11369.602063927723;11520.13598980063;11578.594749183738;11611.825822612836;12046.216995895238;10002.749656292963;10222.948885255526;10291.588336466457;10559.947690661545;10693.09108725767;9845;9861.063198996084;10014.94992525062;10038.49807509607;10412.427316497666;10110.393376397145;10153.949230254097;10388.584456621651;10465.895341046797;10672.359658420519;7788.104367997526;7805.297523222937;7988;8042.638081286239;8079.636416361395;9887.258455615714;10144.239182061227;10317.793644127225;10559;10944.781104378028 10:24:56 INFO - PROCESS | 5047 | |3;mootools.html;1269.3780047776593;1350.3045931345355;1417.844037155913;1457.3150619208975;1683.8147803741595;6578.835529111769;7533.623318834057;7809.101953275375;7837.451378403514;8015.639296231669;7825.295723384894;7886;7888.802779930505;7891;7904.091029531592;2100.5483820978525;2122.840786940978;2122.9893850530802;2126.1176611706123;2127.5213077057692;2084.551821358408;2117.597656445278;2120.226117467121;2120.9893950530227;2126.436494329004;2097.569998150383;2118.8199003084756;2123.893805309736;2124.2458927080897;2128.329576183505;1998.6902030185345;2002.1590931808676;2004.0681083296265;2005.548751530894;2006.0571531380301;1981.4848139483695;1988.7514060742408;2012.4063401296505;2017.384697667211;2017.8284845788125;7866.488678235896;7866.960665196694;7927.445078844483;7931.325837303836;7946.880796788053;4557.567031132037;4754.66717329787;4767.165745994472;4821.855344339676;4828.710277383333;2744.0807329544627;2878.136559032282;2918.9270268243463;2936.9118926432243;2939.4415061138316;836.2181360428019;856.4818284937585;856.5331894117721;1439.5393474088296;1489.41912654065;10355.27513074085;10426.113780328682;10467.05796478313;10494.947525262325;10526.684199474028;4060.26915155269;4139.94431419986;4190.937135942963;4276.444062271885;4277.486701595828;8550.828983420297;8579.14208579137;8582.613782379807;8589.957050214709;8591.226789588967;4654.720716757005;4655.208614535537;4658.161530924466;4660.603848672901;4660.743659098782;3729.179580492287;4152.086540960984;4309.525952145262;4311.4395128633705;4323.221820072417;3338.716209122203;3395;3469.8091604961464;3503.2292895562937;3503.474478828145;997.7056768253383;1033.3311701602008;1045.6810672744887;1049.275999560301;1063.1494804156644;736.8710475666844;824.1387749801472;856.8543347630794;869.2437579305918;874.8600223964136;5199.038177937094;5238.464036775238;5258.8159414420315;5466.9179962300595;5581.246531718166;418.56051146296267;426.1349460594997;427.3824323852004;431.0366331249655;906.3610154840821;3428.628498664223;3726.2920045191327;3727.012341729444;3762.1535154589997;3768.189839184534;9658.951705241428;9868.703938881845;9935.304528683067;9948.502574871227;9957.900420995842;9879.16027137687;9883.11052005323;9895.752606184902;9903.950480247553;9907.851382229272;7373.410127189812;7412.891812923606;7414.110306763115;7472.29013243741;7477.7008919643695;5170.3278573785165;5225.947740522546;5282.2604835323855;5287.391949925808;5352.357717073976;8500.404971651926;8810.207081362709;8828.426152300337;8877.378583499092;8883;8752.824943500967;8922.330825188266;9001.54992250398;9005.459672419676;9080.545972701471;5791.971040144772;6341.619502829845;6346.714397852015;6443.194600674916;6450.258220304725;7209.711611535689;7506.43701722384;7519;7534.698612055676;7542.773716788505;6758.121444212221;6824.93175068243;6887.586744795329;6979.2671769465505;7074.964625176841;6669.333066693292;6748.122744043243;6779.8983015253825;6947.617881016593;6953.860922781617;6359.618422894456;6441.3880681335195;6448.548601597843;6449.5485316027425;6452.967735161482;4403.735775853459;4498;4558.452985641744;4570.611498022706;4625.167469855458;4564.8402305919135;4597.42532183477;4634.953650463587;4659.277811939155;4672.229082201398 10:24:56 INFO - PROCESS | 5047 | |4;prototype.html;296.43677013674005;303.9635243770748;307.9630444346679;312.1011486917676;318.32991552781397;4785.880352991173;4816.181249187638;4861.739291229577;4886.047220791947;4906.656534042619;4545;4662.440507139148;4684.180268453016;4698.718076915387;4818.397700287464;3696.9260614787686;3711.090782758228;3726.0312318797173;3773.547174339083;3779.1874746929407;3795.1271207622262;3801.201747633;3804.676602488778;3811.923761524768;3812.703680748545;3640.1627625646115;3736.2527494501073;3768.2275133597545;3785.9053523661855;3824.980875095621;3737.9252414951548;3754.887353379403;3768.4912536807456;3781.6596506314427;3791.317562838688;3321.3191295784304;3334.9666503334897;3350.9832450837835;3357.093584732133;3366.848491817874;4710.387649605564;4721.197396442613;4728.550787675165;4734.313524538957;4741.241401375763;4171.895702607429;4313.439252897135;4329.328954012101;4344.174606824693;4348.717333373321;4967.3542439483;4971.627127965381;4982.701037937735;4994.525520075587;5000.0999820032375;3675.4119340905327;3679.448082787603;3691.2248427830186;3694.64900834423;3700.1674623209833;5139.820106296262;5184.637075404723;5220.4779522047875;5245.26566280721;5266.262723218752;3698.7965661888315;3706.221693444407;3715.5912849586525;3723.925521489555;3731.2350968051483;3777.20678657485;3790.1996551637753;3790.677792387623;3797.5442946846556;3800.9429858552144;4265.722728022669;4288.742675439421;4307.870763877088;4309.224339618899;4325.740455572675;4940.555350018516;4989.550940415307;5011.574016208663;5025.522575355335;5065.696058236517;1291.296243547269;1302.439950821156;1306.1314226039576;1309.4238535044549;1311.967200819987;855.2217482091268;906.5421961909326;918.7519369770125;936.5036530638772;938.394735395666;4448.377227188196;4453.398791163151;4458.598726114666;4461.776911154494;4465.330200469891;5145.331106956147;5151.321312917262;5153.793848246103;5194.84415467529;5195.792168313301;4246.25903379619;4376.286702244565;4404.119176164716;4420.381146639473;4449.755263460541;2702.3244188952763;2705.513007658601;2721.4148957973734;2725.713800051006;2728.3629822106973;4814.5907597854575;4817.325574419584;4819.445763737145;4824.372831531879;4840.322354870321;5038.672486288379;5168.173092305213;5174.379074511083;5183.922241166386;5219.095030313908;4801.831935882297;4804.615630749532;4816.277558366273;4817.856054055982;4823.27650852375;5130.333056702605;5135.101357262539;5148.2020286855595;5160.122779127482;5169.431362550192;4874.2444921037295;5032.974835125801;5103.87240318995;5132.43543210254;5140.997505486394;4909.361782968334;4920.532549407943;4923.359963204761;4932.4081110267;4938.30863679078;3732.9813350933073;3733.8693145739767;3738.7009039277336;3743.606921273336;3744.756590821697;5026.195808670595;5126.384833819816;5175;5178.71517066565;5221.530062294411;5018.723970181529;5022.233325006246;5029.27075574047;5037.345145131109;5040.621953353587;5058.696478211319;5065.4428012917815;5071.797128114834;5080.872978175427;5091.592672586258;4859.271109333628;4893.6085113191575;4913.852584422473;4953.777080031479;4957.330760347451;4863.56227939473;4933.629977751755;5065.721385323843;5093.23601459784;5096.617753668415;4948.158813001726;4975.626827987843;4983.3023376728015;4983.651144419856;4997.100521906092 10:24:56 INFO - PROCESS | 5047 | |5;yui.html;545.4708932335639;553.903066963281;560.8597850537367;621.6643012773103;633.5090305013614;12092.395380230986;12587.811182832265;12631.557895473661;12636.431360588773;12642.115051946368;12978.091533592653;13587.388567514461;13711.108777929428;14125.646858828508;14143.434262629507;767.7005967672612;787.3268355556003;788.3732432716005;788.4283894176705;788.4559653838861;635.6916895305797;744.5607091815828;776.9572673502955;777.587878424436;781.7615627233691;812.4110020235312;813.1827513349076;816.3550794872044;816.3795515408273;818.0020375142346;805.4160733468248;805.995970020152;806.2985202873479;806.6974884418344;806.8668669669497;481.41748484334;489.97305148216833;490.64918583213176;490.74726515844367;573.5669569475061;12547.372631368486;12939.5471158509;13005.86994130056;13012.739745205137;13028.54400095992;11276.605318813885;11310.321380717101;11844.822327665092;11878;11955.581554645545;10887.510062047228;11243.269187502787;11688.824667629993;11773;11825.231359961575;3879.8254078566533;3974.1654252606986;3986.3023970805284;4040.1919616076902;4092.406601042862;65048.67475662639;65116;65164.67417662881;65189.3481065188;65246.3475365245;9121.90878091224;9352.532373381304;9383.061693830563;9397.76505587352;9552.522373881278;17145.22846471912;17229;17237.05196214195;17253.91373043152;17254.309827606754;6289.55973081889;6447.967760161169;6544.607323560602;6582.275949645631;6719.395254427125;3552.2007548301426;3607.6933460656137;3635.927281454409;3653.0684675408133;3693.778373297611;2648.351153967252;2752.7522522973027;2753.490604238182;2753.9586906196423;2762.8480433576347;444.1960052305273;451.58454222115734;458.7385190441483;464.5215428109053;483.6469377354551;468.64148926071584;504.1339982201198;516.9948300516946;519.6855902179127;543.0740587298646;6667.892991553296;6718.49611279156;6803.609712319849;6861.622610756356;7282.162551306562;470.92465205566947;499.44810983863033;558.05409830338;569.3537834557724;572.7565784541553;3581.8567257309937;3707.443883417509;3878.631530004645;4017.444561563038;4020.8391664333685;91079.54460227789;91595;94806.5259673711;95856.52071739736;96167.51916240374;81756.18243817605;81877.59061204655;82239;83486.16513834785;85680.57159714162;42452.15095698069;42912.356314655306;61085;62013.689931550056;71802;7887.698529742528;8340.41617086798;8399.538025408661;8533.146685331418;8631.352648551509;42461.49851187464;43289.8052233734;44105.33841992437;44472;45411.318830216915;55676.44323556712;63177.052344215794;65648;65771.67114164398;65946.34053659403;10971.23201375928;11098.5560577576;11322.830157547478;11398.373089480157;11833.940830296138;11400.258983166068;11419.143564232882;11420.200585958903;12003.699907502383;12057.336846473178;11032.172587055842;11392.886071139514;11503.079753619522;11925.76148477043;11937.104717146423;11238.887611124112;11460.541578337106;11946.223495472766;11962.641120766391;12153.453094610586;10352.637657681946;10513.211509136998;10568.577256909637;10949.56201751921;11449.255798373079;9489.1934185595;9581.808363832544;9760.560774765294;9856.901430985597;10000.699769076042;9467.810643786948;9831.705048848546;9926.801463970825;9952.701418957442;10086.899131008597 10:24:56 INFO - PROCESS | 5047 | __end_tp_report 10:24:56 INFO - PROCESS | 5047 | __start_cc_report 10:24:56 INFO - PROCESS | 5047 | _x_x_mozilla_cycle_collect,944 10:24:56 INFO - PROCESS | 5047 | __end_cc_report 10:24:56 INFO - PROCESS | 5047 | __startTimestamp1469813096417__endTimestamp 10:24:56 INFO - PROCESS | 5047 | 10:24:56 INFO - PROCESS | 5047 | ------- Summary: start ------- 10:24:56 INFO - PROCESS | 5047 | Number of tests: 6 10:24:56 INFO - PROCESS | 5047 | 10:24:56 INFO - PROCESS | 5047 | [#0] dojo.html Cycles:165 Average:4757.92 Median:4868.93 stddev:501.43 (10.3%) stddev-sans-first:475.50 10:24:56 INFO - PROCESS | 5047 | Values: 2671.3 2671.5 2701.0 2702.7 2708.7 4649.5 4707.1 4761.0 4903.7 4920.7 4731.2 4771.8 4795.3 4857.0 4864.0 4326.6 4354.8 4401.6 4458.1 4556.9 4487.0 4500.2 4541.9 4560.2 4561.2 4330.5 4376.2 4456.7 4466.8 4562.1 4343.1 4346.8 4359.0 4372.5 4376.3 4349.6 4401.1 4413.1 4421.7 4457.5 4633.7 4805.0 4855.2 4864.2 4868.9 5141.2 5192.8 5194.5 5223.1 5279.8 5218.4 5230.8 5235.5 5273.4 5301.0 4671.4 4794.8 4899.5 4936.7 4939.6 5273.3 5304.2 5333.6 5341.2 5406.7 5117.6 5125.9 5127.8 5182.2 5182.3 4958.3 5097.3 5178.9 5245.4 5246.3 5079.9 5145.5 5150.6 5203.5 5206.1 5104.8 5114.5 5119.6 5128.4 5171.0 4182.4 4239.9 4349.3 4366.7 4389.4 3775.1 3814.8 3818.7 3854.7 3917.4 4502.0 4512.1 4551.1 4552.5 4553.0 4996.3 5238.1 5239.8 5252.9 5295.9 4363.7 4375.3 4440.4 4451.6 4487.2 4632.0 4635.9 4643.6 4644.6 4687.6 4812.5 4826.3 4831.0 4858.7 4901.5 5003.0 5060.2 5070.0 5089.9 5115.8 4801.8 4811.8 4813.3 4848.3 4856.1 5018.8 5039.5 5039.7 5045.2 5058.2 4970.2 5116.1 5146.6 5179.6 5196.4 4952.7 4955.4 4959.8 4967.9 5007.3 4973.9 4982.5 4995.6 4997.7 5025.9 4690.8 4811.0 4861.8 4865.6 4895.5 4972.7 4980.2 4982.1 5002.2 5026.1 4899.6 4907.6 4909.2 4915.0 4941.6 10:24:56 INFO - PROCESS | 5047 | 10:24:56 INFO - PROCESS | 5047 | [#1] ext.html Cycles:180 Average:48813.86 Median:37931.81 stddev:90775.75 (239.3%) stddev-sans-first:90958.14 10:24:56 INFO - PROCESS | 5047 | Values: 572.1 577.3 586.7 589.2 589.6 27465.9 39343.0 40184.8 40445.8 44824.8 40766.4 41181.2 41210.0 41253.0 41253.4 7718.8 7858.2 7866.1 7873.9 7875.3 7738.3 7837.7 7840.9 7844.1 7846.6 7846.1 7893.7 7894.5 7902.3 7902.6 7837.3 7858.8 7862.4 7870.2 7875.6 7765.4 7826.5 7844.9 7848.1 7850.3 37530.6 38109.2 38155.6 38157.8 38166.2 3091.6 3111.5 3491.8 3706.6 3769.9 29845.7 29957.4 30721.8 31884.2 33787.2 2856.8 2883.2 2971.8 2977.3 3034.9 260059.0 263158.7 263800.0 264208.0 264432.0 32848.7 55553.0 56509.0 56548.7 56594.2 32312.5 34418.1 34455.5 34480.5 34485.8 12946.4 13128.8 13147.4 13156.1 13159.1 11884.3 12158.3 12168.1 12174.5 12184.6 7798.9 7921.4 7984.8 7985.7 8047.4 3150.6 3178.7 3186.1 3186.5 3214.8 758.2 825.9 863.6 870.6 882.0 26568.3 27714.9 28378.7 28417.7 28471.3 889.4 897.5 908.9 912.6 955.0 14671.2 14904.3 14937.8 15035.6 15188.8 388955.0 389043.0 391345.0 393564.0 393863.0 49916.5 50047.0 50069.0 50502.7 50765.0 1161.7 1165.6 1180.6 1201.2 1206.9 26564.0 27370.3 27772.0 27995.2 27999.0 45911.3 47213.0 47275.0 51898.0 51925.7 358244.0 364232.0 364719.0 365257.0 366415.0 38651.4 39031.2 39099.0 39099.2 39545.4 42499.8 42572.8 42838.8 43033.6 43341.8 36767.0 37021.6 37225.8 37858.0 38005.6 36555.1 37300.4 37688.6 37693.6 38277.0 28589.9 36118.8 36196.5 36818.0 37045.6 31122.5 31637.8 32760.3 33011.7 33554.7 25190.6 25273.4 25289.2 25494.0 25597.6 10:24:56 INFO - PROCESS | 5047 | 10:24:56 INFO - PROCESS | 5047 | [#2] jquery.html Cycles:180 Average:24381.62 Median:199567.99 stddev:64759.52 (32.4%) stddev-sans-first:64916.05 10:24:56 INFO - PROCESS | 5047 | Values: 351.7 372.2 373.5 382.5 400.0 12840.7 15891.8 16099.8 16959.1 18092.1 17022.8 17157.7 17164.0 17310.4 17406.0 5070.6 5071.9 5193.5 5231.3 5241.9 3677.4 5170.3 5251.5 5740.9 6035.2 6105.1 6112.4 6115.1 6131.3 6133.2 5976.7 6042.3 6052.4 6101.4 6107.3 5193.9 5377.3 5380.0 5380.5 5380.6 20700.8 20786.2 20887.3 21043.2 21095.3 1940.1 1966.2 1966.4 2019.1 2516.2 13307.9 13319.8 13402.3 13563.9 14026.2 1668.8 1702.5 1717.2 1730.3 1738.7 72620.6 72947.0 73126.3 74124.0 74783.6 9517.4 9726.5 9796.0 9986.9 10157.5 13522.5 13554.4 13565.3 13576.0 13590.4 7534.0 7787.6 7867.7 7872.8 7993.1 7539.5 7615.8 7795.6 7813.6 7828.9 6147.5 6218.3 6220.6 6225.7 6266.5 1767.3 1852.2 1853.4 1859.3 1876.9 762.7 839.4 853.4 929.2 935.0 17144.4 17165.0 17417.5 17624.4 17963.0 869.6 874.1 890.5 892.3 923.5 8952.3 10297.3 10322.8 10362.5 10452.4 386773.0 387764.0 393200.0 398736.0 402296.0 54042.0 66097.7 69581.3 70306.6 71644.3 899.3 907.6 929.0 930.0 939.0 15565.9 15768.0 16166.8 16182.6 16475.0 35673.3 35674.8 36284.6 36286.0 36840.8 45969.0 46268.0 46454.8 46722.0 47751.5 7642.8 7704.8 7806.5 7833.1 7960.4 11369.6 11520.1 11578.6 11611.8 12046.2 10002.7 10222.9 10291.6 10559.9 10693.1 9845.0 9861.1 10014.9 10038.5 10412.4 10110.4 10153.9 10388.6 10465.9 10672.4 7788.1 7805.3 7988.0 8042.6 8079.6 9887.3 10144.2 10317.8 10559.0 10944.8 10:24:56 INFO - PROCESS | 5047 | 10:24:56 INFO - PROCESS | 5047 | [#3] mootools.html Cycles:180 Average:5111.55 Median:5184.68 stddev:2899.41 (55.9%) stddev-sans-first:2893.16 10:24:56 INFO - PROCESS | 5047 | Values: 1269.4 1350.3 1417.8 1457.3 1683.8 6578.8 7533.6 7809.1 7837.5 8015.6 7825.3 7886.0 7888.8 7891.0 7904.1 2100.5 2122.8 2123.0 2126.1 2127.5 2084.6 2117.6 2120.2 2121.0 2126.4 2097.6 2118.8 2123.9 2124.2 2128.3 1998.7 2002.2 2004.1 2005.5 2006.1 1981.5 1988.8 2012.4 2017.4 2017.8 7866.5 7867.0 7927.4 7931.3 7946.9 4557.6 4754.7 4767.2 4821.9 4828.7 2744.1 2878.1 2918.9 2936.9 2939.4 836.2 856.5 856.5 1439.5 1489.4 10355.3 10426.1 10467.1 10494.9 10526.7 4060.3 4139.9 4190.9 4276.4 4277.5 8550.8 8579.1 8582.6 8590.0 8591.2 4654.7 4655.2 4658.2 4660.6 4660.7 3729.2 4152.1 4309.5 4311.4 4323.2 3338.7 3395.0 3469.8 3503.2 3503.5 997.7 1033.3 1045.7 1049.3 1063.1 736.9 824.1 856.9 869.2 874.9 5199.0 5238.5 5258.8 5466.9 5581.2 418.6 426.1 427.4 431.0 906.4 3428.6 3726.3 3727.0 3762.2 3768.2 9659.0 9868.7 9935.3 9948.5 9957.9 9879.2 9883.1 9895.8 9904.0 9907.9 7373.4 7412.9 7414.1 7472.3 7477.7 5170.3 5225.9 5282.3 5287.4 5352.4 8500.4 8810.2 8828.4 8877.4 8883.0 8752.8 8922.3 9001.5 9005.5 9080.5 5792.0 6341.6 6346.7 6443.2 6450.3 7209.7 7506.4 7519.0 7534.7 7542.8 6758.1 6824.9 6887.6 6979.3 7075.0 6669.3 6748.1 6779.9 6947.6 6953.9 6359.6 6441.4 6448.5 6449.5 6453.0 4403.7 4498.0 4558.5 4570.6 4625.2 4564.8 4597.4 4635.0 4659.3 4672.2 10:24:56 INFO - PROCESS | 5047 | 10:24:56 INFO - PROCESS | 5047 | [#4] prototype.html Cycles:180 Average:4186.75 Median:4803.22 stddev:1195.97 (24.9%) stddev-sans-first:1163.13 10:24:56 INFO - PROCESS | 5047 | Values: 296.4 304.0 308.0 312.1 318.3 4785.9 4816.2 4861.7 4886.0 4906.7 4545.0 4662.4 4684.2 4698.7 4818.4 3696.9 3711.1 3726.0 3773.5 3779.2 3795.1 3801.2 3804.7 3811.9 3812.7 3640.2 3736.3 3768.2 3785.9 3825.0 3737.9 3754.9 3768.5 3781.7 3791.3 3321.3 3335.0 3351.0 3357.1 3366.8 4710.4 4721.2 4728.6 4734.3 4741.2 4171.9 4313.4 4329.3 4344.2 4348.7 4967.4 4971.6 4982.7 4994.5 5000.1 3675.4 3679.4 3691.2 3694.6 3700.2 5139.8 5184.6 5220.5 5245.3 5266.3 3698.8 3706.2 3715.6 3723.9 3731.2 3777.2 3790.2 3790.7 3797.5 3800.9 4265.7 4288.7 4307.9 4309.2 4325.7 4940.6 4989.6 5011.6 5025.5 5065.7 1291.3 1302.4 1306.1 1309.4 1312.0 855.2 906.5 918.8 936.5 938.4 4448.4 4453.4 4458.6 4461.8 4465.3 5145.3 5151.3 5153.8 5194.8 5195.8 4246.3 4376.3 4404.1 4420.4 4449.8 2702.3 2705.5 2721.4 2725.7 2728.4 4814.6 4817.3 4819.4 4824.4 4840.3 5038.7 5168.2 5174.4 5183.9 5219.1 4801.8 4804.6 4816.3 4817.9 4823.3 5130.3 5135.1 5148.2 5160.1 5169.4 4874.2 5033.0 5103.9 5132.4 5141.0 4909.4 4920.5 4923.4 4932.4 4938.3 3733.0 3733.9 3738.7 3743.6 3744.8 5026.2 5126.4 5175.0 5178.7 5221.5 5018.7 5022.2 5029.3 5037.3 5040.6 5058.7 5065.4 5071.8 5080.9 5091.6 4859.3 4893.6 4913.9 4953.8 4957.3 4863.6 4933.6 5065.7 5093.2 5096.6 4948.2 4975.6 4983.3 4983.7 4997.1 10:24:56 INFO - PROCESS | 5047 | 10:24:56 INFO - PROCESS | 5047 | [#5] yui.html Cycles:180 Average:17013.87 Median:482.53 stddev:24210.56 (5017.4%) stddev-sans-first:24246.90 10:24:56 INFO - PROCESS | 5047 | Values: 545.5 553.9 560.9 621.7 633.5 12092.4 12587.8 12631.6 12636.4 12642.1 12978.1 13587.4 13711.1 14125.6 14143.4 767.7 787.3 788.4 788.4 788.5 635.7 744.6 777.0 777.6 781.8 812.4 813.2 816.4 816.4 818.0 805.4 806.0 806.3 806.7 806.9 481.4 490.0 490.6 490.7 573.6 12547.4 12939.5 13005.9 13012.7 13028.5 11276.6 11310.3 11844.8 11878.0 11955.6 10887.5 11243.3 11688.8 11773.0 11825.2 3879.8 3974.2 3986.3 4040.2 4092.4 65048.7 65116.0 65164.7 65189.3 65246.3 9121.9 9352.5 9383.1 9397.8 9552.5 17145.2 17229.0 17237.1 17253.9 17254.3 6289.6 6448.0 6544.6 6582.3 6719.4 3552.2 3607.7 3635.9 3653.1 3693.8 2648.4 2752.8 2753.5 2754.0 2762.8 444.2 451.6 458.7 464.5 483.6 468.6 504.1 517.0 519.7 543.1 6667.9 6718.5 6803.6 6861.6 7282.2 470.9 499.4 558.1 569.4 572.8 3581.9 3707.4 3878.6 4017.4 4020.8 91079.5 91595.0 94806.5 95856.5 96167.5 81756.2 81877.6 82239.0 83486.2 85680.6 42452.2 42912.4 61085.0 62013.7 71802.0 7887.7 8340.4 8399.5 8533.1 8631.4 42461.5 43289.8 44105.3 44472.0 45411.3 55676.4 63177.1 65648.0 65771.7 65946.3 10971.2 11098.6 11322.8 11398.4 11833.9 11400.3 11419.1 11420.2 12003.7 12057.3 11032.2 11392.9 11503.1 11925.8 11937.1 11238.9 11460.5 11946.2 11962.6 12153.5 10352.6 10513.2 10568.6 10949.6 11449.3 9489.2 9581.8 9760.6 9856.9 10000.7 9467.8 9831.7 9926.8 9952.7 10086.9 10:24:56 INFO - PROCESS | 5047 | -------- Summary: end -------- 10:24:56 INFO - PROCESS | 5047 | 10:24:57 INFO - TEST-INFO | 5047: exit 0 10:24:57 INFO - TEST-OK | dromaeo_css | took 1119882ms 10:24:57 INFO - TEST-START | kraken 10:24:57 INFO - operating with platform_type : linux_ 10:24:57 INFO - Initialising browser for kraken test... 10:24:57 INFO - TEST-INFO | started process 5240 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTCacFf/profile http://localhost:42229/getInfo.html) 10:25:01 INFO - PROCESS | 5240 | __metrics Screen width/height:1600/1200 10:25:01 INFO - PROCESS | 5240 | colorDepth:24 10:25:01 INFO - PROCESS | 5240 | Browser inner width/height: 1024/697 10:25:01 INFO - PROCESS | 5240 | __metrics 10:25:02 INFO - PROCESS | 5240 | 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" 10:25:02 INFO - PROCESS | 5240 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:25:03 INFO - PROCESS | 5240 | console.error: PushService: 10:25:03 INFO - PROCESS | 5240 | stateChangeProcessEnqueue: Error transitioning state 10:25:03 INFO - PROCESS | 5240 | UnknownError 10:25:03 INFO - TEST-INFO | 5240: exit 0 10:25:03 INFO - Browser initialized. 10:25:03 INFO - Running cycle 1/1 for kraken test... 10:25:03 INFO - TEST-INFO | started process 5320 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTCacFf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:25:15 INFO - PROCESS | 5320 | RSS: Main: 157523968 10:25:15 INFO - PROCESS | 5320 | 10:25:18 INFO - PROCESS | 5320 | Cycle 1(1): loaded http://localhost:42229/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42229/tests/kraken/driver.html?testName=audio-beat-detection) 10:25:19 INFO - PROCESS | 5320 | RSS: Main: 213745664 10:25:19 INFO - PROCESS | 5320 | 10:25:21 INFO - PROCESS | 5320 | Cycle 1(1): loaded http://localhost:42229/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42229/tests/kraken/driver.html?testName=audio-dft) 10:25:22 INFO - PROCESS | 5320 | RSS: Main: 191111168 10:25:22 INFO - PROCESS | 5320 | 10:25:25 INFO - PROCESS | 5320 | Cycle 1(1): loaded http://localhost:42229/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42229/tests/kraken/driver.html?testName=audio-fft) 10:25:26 INFO - PROCESS | 5320 | RSS: Main: 270016512 10:25:26 INFO - PROCESS | 5320 | 10:25:28 INFO - PROCESS | 5320 | Cycle 1(1): loaded http://localhost:42229/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42229/tests/kraken/driver.html?testName=audio-oscillator) 10:25:29 INFO - PROCESS | 5320 | RSS: Main: 180670464 10:25:29 INFO - PROCESS | 5320 | 10:25:31 INFO - PROCESS | 5320 | Cycle 1(1): loaded http://localhost:42229/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42229/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:25:31 INFO - PROCESS | 5320 | RSS: Main: 185061376 10:25:31 INFO - PROCESS | 5320 | 10:25:35 INFO - PROCESS | 5320 | Cycle 1(1): loaded http://localhost:42229/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42229/tests/kraken/driver.html?testName=imaging-darkroom) 10:25:35 INFO - PROCESS | 5320 | RSS: Main: 221212672 10:25:35 INFO - PROCESS | 5320 | 10:25:39 INFO - PROCESS | 5320 | Cycle 1(1): loaded http://localhost:42229/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42229/tests/kraken/driver.html?testName=imaging-desaturate) 10:25:39 INFO - PROCESS | 5320 | RSS: Main: 220360704 10:25:39 INFO - PROCESS | 5320 | 10:25:42 INFO - PROCESS | 5320 | Cycle 1(1): loaded http://localhost:42229/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42229/tests/kraken/driver.html?testName=json-parse-financial) 10:25:43 INFO - PROCESS | 5320 | RSS: Main: 220430336 10:25:43 INFO - PROCESS | 5320 | 10:25:44 INFO - PROCESS | 5320 | Cycle 1(1): loaded http://localhost:42229/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42229/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:25:45 INFO - PROCESS | 5320 | RSS: Main: 185233408 10:25:45 INFO - PROCESS | 5320 | 10:25:47 INFO - PROCESS | 5320 | Cycle 1(1): loaded http://localhost:42229/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42229/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:25:48 INFO - PROCESS | 5320 | RSS: Main: 191356928 10:25:48 INFO - PROCESS | 5320 | 10:25:50 INFO - PROCESS | 5320 | Cycle 1(1): loaded http://localhost:42229/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42229/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:25:50 INFO - PROCESS | 5320 | RSS: Main: 195809280 10:25:50 INFO - PROCESS | 5320 | 10:25:53 INFO - PROCESS | 5320 | Cycle 1(1): loaded http://localhost:42229/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42229/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:25:54 INFO - PROCESS | 5320 | RSS: Main: 189677568 10:25:54 INFO - PROCESS | 5320 | 10:25:57 INFO - PROCESS | 5320 | Cycle 1(1): loaded http://localhost:42229/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42229/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:25:57 INFO - PROCESS | 5320 | RSS: Main: 193552384 10:25:57 INFO - PROCESS | 5320 | 10:25:59 INFO - PROCESS | 5320 | Cycle 1(1): loaded http://localhost:42229/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42229/tests/kraken/driver.html?testName=ai-astar) 10:25:59 INFO - PROCESS | 5320 | RSS: Main: 244195328 10:25:59 INFO - PROCESS | 5320 | 10:25:59 INFO - PROCESS | 5320 | __start_tp_report 10:25:59 INFO - PROCESS | 5320 | _x_x_mozilla_page_load 10:25:59 INFO - PROCESS | 5320 | _x_x_mozilla_page_load_details 10:25:59 INFO - PROCESS | 5320 | |i|pagename|runs| 10:25:59 INFO - PROCESS | 5320 | |0;ai-astar;105;114;115;114;114;114;113;114;113;113 10:25:59 INFO - PROCESS | 5320 | |1;audio-beat-detection;160;123;123;183;123;123;143;122;171;123 10:25:59 INFO - PROCESS | 5320 | |2;audio-dft;163;160;161;162;160;160;160;160;161;161 10:25:59 INFO - PROCESS | 5320 | |3;audio-fft;77;76;76;124;76;76;76;75;100;76 10:25:59 INFO - PROCESS | 5320 | |4;audio-oscillator;85;85;116;85;85;86;120;84;83;122 10:25:59 INFO - PROCESS | 5320 | |5;imaging-gaussian-blur;117;116;116;117;117;117;117;116;117;118 10:25:59 INFO - PROCESS | 5320 | |6;imaging-darkroom;147;148;147;146;149;147;146;146;146;146 10:25:59 INFO - PROCESS | 5320 | |7;imaging-desaturate;95;97;97;96;97;96;95;95;96;95 10:25:59 INFO - PROCESS | 5320 | |8;json-parse-financial;62;60;60;62;61;61;61;62;61;62 10:25:59 INFO - PROCESS | 5320 | |9;json-stringify-tinderbox;67;66;66;66;65;65;66;66;66;66 10:25:59 INFO - PROCESS | 5320 | |10;stanford-crypto-aes;79;89;80;79;89;82;85;79;89;88 10:25:59 INFO - PROCESS | 5320 | |11;stanford-crypto-ccm;130;130;130;132;126;128;131;137;175;145 10:25:59 INFO - PROCESS | 5320 | |12;stanford-crypto-pbkdf2;165;166;167;168;164;168;166;164;167;165 10:25:59 INFO - PROCESS | 5320 | |13;stanford-crypto-sha256-iterative;67;71;69;67;68;69;65;66;70;67 10:25:59 INFO - PROCESS | 5320 | __end_tp_report 10:25:59 INFO - PROCESS | 5320 | __start_cc_report 10:25:59 INFO - PROCESS | 5320 | _x_x_mozilla_cycle_collect,1953 10:25:59 INFO - PROCESS | 5320 | __end_cc_report 10:25:59 INFO - PROCESS | 5320 | __startTimestamp1469813159720__endTimestamp 10:25:59 INFO - PROCESS | 5320 | 10:25:59 INFO - PROCESS | 5320 | ------- Summary: start ------- 10:25:59 INFO - PROCESS | 5320 | Number of tests: 14 10:25:59 INFO - PROCESS | 5320 | 10:25:59 INFO - PROCESS | 5320 | [#0] ai-astar Cycles:10 Average:112.90 Median:114.00 stddev:2.85 (2.5%) stddev-sans-first:0.67 10:25:59 INFO - PROCESS | 5320 | Values: 105.0 114.0 115.0 114.0 114.0 114.0 113.0 114.0 113.0 113.0 10:25:59 INFO - PROCESS | 5320 | 10:25:59 INFO - PROCESS | 5320 | [#1] audio-beat-detection Cycles:10 Average:139.40 Median:133.00 stddev:23.53 (17.7%) stddev-sans-first:23.75 10:25:59 INFO - PROCESS | 5320 | Values: 160.0 123.0 123.0 183.0 123.0 123.0 143.0 122.0 171.0 123.0 10:25:59 INFO - PROCESS | 5320 | 10:25:59 INFO - PROCESS | 5320 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.03 (0.6%) stddev-sans-first:0.73 10:25:59 INFO - PROCESS | 5320 | Values: 163.0 160.0 161.0 162.0 160.0 160.0 160.0 160.0 161.0 161.0 10:25:59 INFO - PROCESS | 5320 | 10:25:59 INFO - PROCESS | 5320 | [#3] audio-fft Cycles:10 Average:83.20 Median:76.00 stddev:16.21 (21.3%) stddev-sans-first:17.03 10:25:59 INFO - PROCESS | 5320 | Values: 77.0 76.0 76.0 124.0 76.0 76.0 76.0 75.0 100.0 76.0 10:25:59 INFO - PROCESS | 5320 | 10:25:59 INFO - PROCESS | 5320 | [#4] audio-oscillator Cycles:10 Average:95.10 Median:85.00 stddev:16.80 (19.8%) stddev-sans-first:17.42 10:25:59 INFO - PROCESS | 5320 | Values: 85.0 85.0 116.0 85.0 85.0 86.0 120.0 84.0 83.0 122.0 10:25:59 INFO - PROCESS | 5320 | 10:25:59 INFO - PROCESS | 5320 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 10:25:59 INFO - PROCESS | 5320 | Values: 117.0 116.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 118.0 10:25:59 INFO - PROCESS | 5320 | 10:25:59 INFO - PROCESS | 5320 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:1.03 (0.7%) stddev-sans-first:1.09 10:25:59 INFO - PROCESS | 5320 | Values: 147.0 148.0 147.0 146.0 149.0 147.0 146.0 146.0 146.0 146.0 10:25:59 INFO - PROCESS | 5320 | 10:25:59 INFO - PROCESS | 5320 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.88 (0.9%) stddev-sans-first:0.87 10:25:59 INFO - PROCESS | 5320 | Values: 95.0 97.0 97.0 96.0 97.0 96.0 95.0 95.0 96.0 95.0 10:25:59 INFO - PROCESS | 5320 | 10:25:59 INFO - PROCESS | 5320 | [#8] json-parse-financial Cycles:10 Average:61.20 Median:61.50 stddev:0.79 (1.3%) stddev-sans-first:0.78 10:25:59 INFO - PROCESS | 5320 | Values: 62.0 60.0 60.0 62.0 61.0 61.0 61.0 62.0 61.0 62.0 10:25:59 INFO - PROCESS | 5320 | 10:25:59 INFO - PROCESS | 5320 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:0.57 (0.9%) stddev-sans-first:0.44 10:25:59 INFO - PROCESS | 5320 | Values: 67.0 66.0 66.0 66.0 65.0 65.0 66.0 66.0 66.0 66.0 10:25:59 INFO - PROCESS | 5320 | 10:25:59 INFO - PROCESS | 5320 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:86.50 stddev:4.56 (5.3%) stddev-sans-first:4.48 10:25:59 INFO - PROCESS | 5320 | Values: 79.0 89.0 80.0 79.0 89.0 82.0 85.0 79.0 89.0 88.0 10:25:59 INFO - PROCESS | 5320 | 10:25:59 INFO - PROCESS | 5320 | [#11] stanford-crypto-ccm Cycles:10 Average:136.40 Median:131.50 stddev:14.58 (11.1%) stddev-sans-first:15.28 10:25:59 INFO - PROCESS | 5320 | Values: 130.0 130.0 130.0 132.0 126.0 128.0 131.0 137.0 175.0 145.0 10:25:59 INFO - PROCESS | 5320 | 10:25:59 INFO - PROCESS | 5320 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.00 Median:166.50 stddev:1.49 (0.9%) stddev-sans-first:1.54 10:25:59 INFO - PROCESS | 5320 | Values: 165.0 166.0 167.0 168.0 164.0 168.0 166.0 164.0 167.0 165.0 10:25:59 INFO - PROCESS | 5320 | 10:25:59 INFO - PROCESS | 5320 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.50 stddev:1.85 (2.7%) stddev-sans-first:1.94 10:25:59 INFO - PROCESS | 5320 | Values: 67.0 71.0 69.0 67.0 68.0 69.0 65.0 66.0 70.0 67.0 10:25:59 INFO - PROCESS | 5320 | -------- Summary: end -------- 10:25:59 INFO - PROCESS | 5320 | 10:26:00 INFO - TEST-INFO | 5320: exit 0 10:26:00 INFO - TEST-OK | kraken | took 63526ms 10:26:00 INFO - SUITE-END | took 1183s 10:26:00 INFO - Completed test suite (00:19:43) 10:26:00 INFO - javascript benchmark 10:26:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2671.3455203475146, 2671.5458372076746, 2701.0, 2702.716214797447, 2708.6885008224062, 4649.46531148918, 4707.129181101499, 4761.0, 4903.730294833783, 4920.729359885209, 4731.243001119821, 4771.785269662865, 4795.25673520604, 4856.97571512142, 4863.951360486394, 4326.5673432656795, 4354.847580334689, 4401.647868170555, 4458.063806600618, 4556.863294101182, 4486.990427153897, 4500.234960056799, 4541.909161816761, 4560.156371071363, 4561.2245918193985, 4330.458692663417, 4376.212281789277, 4456.665750068725, 4466.843660471868, 4562.133194692998, 4343.131373725268, 4346.847860324873, 4359.04101097758, 4372.540883207249, 4376.256036473776, 4349.630281426083, 4401.053773438694, 4413.0732546165345, 4421.712588681726, 4457.531959144308, 4633.652476064275, 4805.0, 4855.247436647325, 4864.173090574611, 4868.9269660955115, 5141.15170996785, 5192.844214673566, 5194.4805519447755, 5223.112070947948, 5279.788808447657, 5218.425973142951, 5230.8169214077325, 5235.502627250406, 5273.4462881397285, 5301.019311427398, 4671.392718946515, 4794.808207671654, 4899.485554016848, 4936.654434189572, 4939.604831613462, 5273.31446911899, 5304.177852432879, 5333.599980001515, 5341.172118321666, 5406.729663516887, 5117.616178786606, 5125.948740512622, 5127.820526281637, 5182.222666600041, 5182.274481572507, 4958.330625365602, 5097.260897169964, 5178.948210517847, 5245.449227831023, 5246.344206974129, 5079.923801142986, 5145.511176438233, 5150.562202212779, 5203.531682148549, 5206.062908676399, 5104.846854594368, 5114.48855114493, 5119.564836988898, 5128.3845938486875, 5170.97414512925, 4182.351735480945, 4239.872803815891, 4349.347597860283, 4366.672499562545, 4389.3635422864145, 3775.075106598846, 3814.809259537012, 3818.694504439638, 3854.69162467002, 3917.373220284741, 4502.032063106448, 4512.05246898155, 4551.112533056088, 4552.499225085238, 4553.0, 4996.300517927493, 5238.109521381298, 5239.790408383622, 5252.921206181911, 5295.947040529545, 4363.694541382073, 4375.343698445195, 4440.400545926259, 4451.643868490513, 4487.169873573399, 4632.027274272373, 4635.884102897455, 4643.558861908114, 4644.575199777317, 4687.601553867959, 4812.470628230822, 4826.348442960226, 4831.0, 4858.708477491362, 4901.50984901507, 5002.974985125051, 5060.21566657154, 5070.0, 5089.8727531812, 5115.8233606271515, 4801.783919723551, 4811.831585894477, 4813.326134341265, 4848.296996935495, 4856.1016212000895, 5018.799248030184, 5039.546440820343, 5039.748012599429, 5045.2432135180015, 5058.190689489664, 4970.179920313108, 5116.104681680766, 5146.614003949793, 5179.559737422362, 5196.402413722471, 4952.653314267966, 4955.40535135786, 4959.776810043629, 4967.875803104806, 5007.349044624176, 4973.900521989613, 4982.501749824988, 4995.550400463976, 4997.650164488451, 5025.924611130763, 4690.788914498924, 4810.95189048105, 4861.805527778849, 4865.5864251539015, 4895.534924182197, 4972.65191436596, 4980.153373926513, 4982.128127577732, 5002.2496625506465, 5026.095302845377, 4899.559039686445, 4907.55831975124, 4909.165441874961, 4914.975425122851, 4941.604671626189], "value": 4725.9809394146705, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.0875204049539, 577.2755192233747, 586.6890548009557, 589.2222266608079, 589.5519405252008, 27465.862670686645, 39343.0, 40184.799076004616, 40445.7977710111, 44824.77587612058, 40766.388504172384, 41181.17637647245, 41210.0, 41253.0, 41253.38119928196, 7718.768436946886, 7858.174891636381, 7866.095399029127, 7873.921260787405, 7875.330596899242, 7738.303552680258, 7837.725679601215, 7840.921590784104, 7844.137144914055, 7846.607669616525, 7846.05847298325, 7893.723719669812, 7894.526328420285, 7902.288794008538, 7902.565358905258, 7837.294643482085, 7858.803529911741, 7862.410319226081, 7870.173631768639, 7875.645595948167, 7765.378769698411, 7826.452148349618, 7844.9215507844765, 7848.058233012075, 7850.293473587348, 37530.624693753256, 38109.23781524382, 38155.61844381548, 38157.809210954045, 38166.23667526662, 3091.5671805947186, 3111.48660471022, 3491.7555771096036, 3706.592274849764, 3769.924601507982, 29845.70154298451, 29957.400851983057, 30721.846390768125, 31884.20289492758, 33787.15532111692, 2856.7714582833532, 2883.2215301868378, 2971.777116716255, 2977.2705687106795, 3034.9393012139635, 260059.0, 263158.68420657964, 263800.0, 264208.0, 264432.0, 32848.67151328504, 55553.0, 56509.0, 56548.71725641345, 56594.15108773289, 32312.515312270334, 34418.139546511535, 34455.48316775251, 34480.482792757626, 34485.827570861984, 12946.41741121633, 13128.803067953988, 13147.408366623526, 13156.079074464695, 13159.144655597356, 11884.286942783288, 12158.270503769802, 12168.087393445527, 12174.513019479122, 12184.634460966185, 7798.922010779819, 7921.36629069673, 7984.760457186294, 7985.680572777024, 8047.356211503065, 3150.5904232449634, 3178.713915747594, 3186.123815950632, 3186.537951996994, 3214.774965752422, 758.2152472191256, 825.8802473641289, 863.6329559937002, 870.6386849457531, 882.0429833630454, 26568.335791605365, 27714.861425692743, 28378.71621283802, 28417.71582284192, 28471.28821779472, 889.3507739350181, 897.5153417154663, 908.895477020138, 912.5802131019673, 954.9856752148723, 14671.193084380247, 14904.329305181293, 14937.775933361008, 15035.61196880473, 15188.772168417483, 388955.0, 389043.0, 391345.0, 393564.0, 393863.0, 49916.50083499191, 50047.0, 50068.99724010999, 50502.747486262335, 50765.0, 1161.6747310753003, 1165.6269993601966, 1180.5690922813112, 1201.195199216527, 1206.927584344942, 26564.0, 27370.315742106606, 27772.0, 27995.160145195678, 27999.0, 45911.31133033074, 47213.0, 47275.0, 51898.0, 51925.74037129941, 358244.0, 364232.0, 364719.0, 365257.0, 366415.0, 38651.420228697156, 39031.2193756129, 39099.0, 39099.218015640094, 39545.406818897165, 42499.787501062296, 42572.78713606412, 42838.78580607077, 43033.56966430296, 43341.783291083346, 36767.0, 37021.62978370182, 37225.81387093047, 37858.0, 38005.619943801314, 36555.08612284608, 37300.440493393166, 37688.62311376961, 37693.62306376901, 38277.0, 28589.857050714614, 36118.8194059028, 36196.45705314475, 36818.0, 37045.62954370422, 31122.533162002135, 31637.8418107908, 32760.344793104483, 33011.66988330086, 33554.664453356134, 25190.62214066827, 25273.368165796, 25289.241322760347, 25494.0, 25597.616035759107], "value": 16873.71408597507, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.66943073510885, 372.1774877520679, 373.45102699032424, 382.51802728562, 399.97200195986295, 12840.74318513629, 15891.84108158918, 16099.758503622441, 16959.067251301174, 18092.09539523025, 17022.82977170228, 17157.656846863087, 17164.0, 17310.394136205236, 17406.0, 5070.645054846163, 5071.923921141186, 5193.45468725784, 5231.267622532849, 5241.921371179416, 3677.3932301170275, 5170.327857378536, 5251.52736253739, 5740.913886291709, 6035.245594300713, 6105.145279660851, 6112.419320164578, 6115.113308570255, 6131.294901086388, 6133.172021777048, 5976.671283079429, 6042.335343112254, 6052.394760523956, 6101.420365065312, 6107.26712794463, 5193.896122077537, 5377.3009508764, 5380.0, 5380.461953804627, 5380.569554435636, 20700.792992070186, 20786.168553257852, 20887.268945586984, 21043.158273669036, 21095.261665841776, 1940.0784627301919, 1966.2036875065621, 1966.429735376739, 2019.1418647074934, 2516.219971808745, 13307.933460332733, 13319.800202996963, 13402.329883505883, 13563.932180339036, 14026.158430494203, 1668.8331166883336, 1702.5403141151944, 1717.2272477385227, 1730.2732852202105, 1738.7478815571799, 72620.63689681518, 72947.0, 73126.26873731248, 74124.0, 74783.62608186979, 9517.428954262767, 9726.513674316257, 9795.951020244853, 9986.872414732647, 10157.527158561967, 13522.459101635824, 13554.390052447663, 13565.321733913264, 13575.96360545926, 13590.38843252056, 7534.0, 7787.571683557346, 7867.685292588232, 7872.763817085496, 7993.080795708452, 7539.547627142389, 7615.847683046308, 7795.649195786204, 7813.648385822538, 7828.921710782934, 6147.477464415485, 6218.284897236876, 6220.564560480723, 6225.688715564203, 6266.467350275278, 1767.328415202215, 1852.1757817770963, 1853.3883818339916, 1859.3492277702696, 1876.8592355573387, 762.6529928882456, 839.4040231435627, 853.3770347646129, 929.2055292724758, 934.9995504809924, 17144.39994600183, 17165.0, 17417.47747567575, 17624.383146589807, 17963.0, 869.5956380283072, 874.0528608078247, 890.496869268874, 892.312919052326, 923.5013092929877, 8952.283817294601, 10297.279190456597, 10322.793544129225, 10362.481875906326, 10452.425116618659, 386773.0, 387764.0, 393200.0, 398736.0, 402296.0, 54042.0, 66097.66951165213, 69581.3041869585, 70306.64846675734, 71644.2835571648, 899.2940541674753, 907.577976241051, 928.9860652090224, 929.9628014879329, 939.0140352629847, 15565.92217038953, 15768.0, 16166.757498637295, 16182.595435114215, 16475.0, 35673.28653426969, 35674.8216258917, 36284.63715362812, 36286.0, 36840.81579592085, 45969.0, 46268.0, 46454.76772616115, 46722.0, 47751.52248477471, 7642.8089297768, 7704.768856934301, 7806.4925779824125, 7833.138354781084, 7960.402969777174, 11369.602063927723, 11520.13598980063, 11578.594749183738, 11611.825822612836, 12046.216995895238, 10002.749656292963, 10222.948885255526, 10291.588336466457, 10559.947690661545, 10693.09108725767, 9845.0, 9861.063198996084, 10014.94992525062, 10038.49807509607, 10412.427316497666, 10110.393376397145, 10153.949230254097, 10388.584456621651, 10465.895341046797, 10672.359658420519, 7788.104367997526, 7805.297523222937, 7988.0, 8042.638081286239, 8079.636416361395, 9887.258455615714, 10144.239182061227, 10317.793644127225, 10559.0, 10944.781104378028], "value": 8480.383339112506, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1269.3780047776593, 1350.3045931345355, 1417.844037155913, 1457.3150619208975, 1683.8147803741595, 6578.835529111769, 7533.623318834057, 7809.101953275375, 7837.451378403514, 8015.639296231669, 7825.295723384894, 7886.0, 7888.802779930505, 7891.0, 7904.091029531592, 2100.5483820978525, 2122.840786940978, 2122.9893850530802, 2126.1176611706123, 2127.5213077057692, 2084.551821358408, 2117.597656445278, 2120.226117467121, 2120.9893950530227, 2126.436494329004, 2097.569998150383, 2118.8199003084756, 2123.893805309736, 2124.2458927080897, 2128.329576183505, 1998.6902030185345, 2002.1590931808676, 2004.0681083296265, 2005.548751530894, 2006.0571531380301, 1981.4848139483695, 1988.7514060742408, 2012.4063401296505, 2017.384697667211, 2017.8284845788125, 7866.488678235896, 7866.960665196694, 7927.445078844483, 7931.325837303836, 7946.880796788053, 4557.567031132037, 4754.66717329787, 4767.165745994472, 4821.855344339676, 4828.710277383333, 2744.0807329544627, 2878.136559032282, 2918.9270268243463, 2936.9118926432243, 2939.4415061138316, 836.2181360428019, 856.4818284937585, 856.5331894117721, 1439.5393474088296, 1489.41912654065, 10355.27513074085, 10426.113780328682, 10467.05796478313, 10494.947525262325, 10526.684199474028, 4060.26915155269, 4139.94431419986, 4190.937135942963, 4276.444062271885, 4277.486701595828, 8550.828983420297, 8579.14208579137, 8582.613782379807, 8589.957050214709, 8591.226789588967, 4654.720716757005, 4655.208614535537, 4658.161530924466, 4660.603848672901, 4660.743659098782, 3729.179580492287, 4152.086540960984, 4309.525952145262, 4311.4395128633705, 4323.221820072417, 3338.716209122203, 3395.0, 3469.8091604961464, 3503.2292895562937, 3503.474478828145, 997.7056768253383, 1033.3311701602008, 1045.6810672744887, 1049.275999560301, 1063.1494804156644, 736.8710475666844, 824.1387749801472, 856.8543347630794, 869.2437579305918, 874.8600223964136, 5199.038177937094, 5238.464036775238, 5258.8159414420315, 5466.9179962300595, 5581.246531718166, 418.56051146296267, 426.1349460594997, 427.3824323852004, 431.0366331249655, 906.3610154840821, 3428.628498664223, 3726.2920045191327, 3727.012341729444, 3762.1535154589997, 3768.189839184534, 9658.951705241428, 9868.703938881845, 9935.304528683067, 9948.502574871227, 9957.900420995842, 9879.16027137687, 9883.11052005323, 9895.752606184902, 9903.950480247553, 9907.851382229272, 7373.410127189812, 7412.891812923606, 7414.110306763115, 7472.29013243741, 7477.7008919643695, 5170.3278573785165, 5225.947740522546, 5282.2604835323855, 5287.391949925808, 5352.357717073976, 8500.404971651926, 8810.207081362709, 8828.426152300337, 8877.378583499092, 8883.0, 8752.824943500967, 8922.330825188266, 9001.54992250398, 9005.459672419676, 9080.545972701471, 5791.971040144772, 6341.619502829845, 6346.714397852015, 6443.194600674916, 6450.258220304725, 7209.711611535689, 7506.43701722384, 7519.0, 7534.698612055676, 7542.773716788505, 6758.121444212221, 6824.93175068243, 6887.586744795329, 6979.2671769465505, 7074.964625176841, 6669.333066693292, 6748.122744043243, 6779.8983015253825, 6947.617881016593, 6953.860922781617, 6359.618422894456, 6441.3880681335195, 6448.548601597843, 6449.5485316027425, 6452.967735161482, 4403.735775853459, 4498.0, 4558.452985641744, 4570.611498022706, 4625.167469855458, 4564.8402305919135, 4597.42532183477, 4634.953650463587, 4659.277811939155, 4672.229082201398], "value": 4054.8040362858287, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.43677013674005, 303.9635243770748, 307.9630444346679, 312.1011486917676, 318.32991552781397, 4785.880352991173, 4816.181249187638, 4861.739291229577, 4886.047220791947, 4906.656534042619, 4545.0, 4662.440507139148, 4684.180268453016, 4698.718076915387, 4818.397700287464, 3696.9260614787686, 3711.090782758228, 3726.0312318797173, 3773.547174339083, 3779.1874746929407, 3795.1271207622262, 3801.201747633, 3804.676602488778, 3811.923761524768, 3812.703680748545, 3640.1627625646115, 3736.2527494501073, 3768.2275133597545, 3785.9053523661855, 3824.980875095621, 3737.9252414951548, 3754.887353379403, 3768.4912536807456, 3781.6596506314427, 3791.317562838688, 3321.3191295784304, 3334.9666503334897, 3350.9832450837835, 3357.093584732133, 3366.848491817874, 4710.387649605564, 4721.197396442613, 4728.550787675165, 4734.313524538957, 4741.241401375763, 4171.895702607429, 4313.439252897135, 4329.328954012101, 4344.174606824693, 4348.717333373321, 4967.3542439483, 4971.627127965381, 4982.701037937735, 4994.525520075587, 5000.0999820032375, 3675.4119340905327, 3679.448082787603, 3691.2248427830186, 3694.64900834423, 3700.1674623209833, 5139.820106296262, 5184.637075404723, 5220.4779522047875, 5245.26566280721, 5266.262723218752, 3698.7965661888315, 3706.221693444407, 3715.5912849586525, 3723.925521489555, 3731.2350968051483, 3777.20678657485, 3790.1996551637753, 3790.677792387623, 3797.5442946846556, 3800.9429858552144, 4265.722728022669, 4288.742675439421, 4307.870763877088, 4309.224339618899, 4325.740455572675, 4940.555350018516, 4989.550940415307, 5011.574016208663, 5025.522575355335, 5065.696058236517, 1291.296243547269, 1302.439950821156, 1306.1314226039576, 1309.4238535044549, 1311.967200819987, 855.2217482091268, 906.5421961909326, 918.7519369770125, 936.5036530638772, 938.394735395666, 4448.377227188196, 4453.398791163151, 4458.598726114666, 4461.776911154494, 4465.330200469891, 5145.331106956147, 5151.321312917262, 5153.793848246103, 5194.84415467529, 5195.792168313301, 4246.25903379619, 4376.286702244565, 4404.119176164716, 4420.381146639473, 4449.755263460541, 2702.3244188952763, 2705.513007658601, 2721.4148957973734, 2725.713800051006, 2728.3629822106973, 4814.5907597854575, 4817.325574419584, 4819.445763737145, 4824.372831531879, 4840.322354870321, 5038.672486288379, 5168.173092305213, 5174.379074511083, 5183.922241166386, 5219.095030313908, 4801.831935882297, 4804.615630749532, 4816.277558366273, 4817.856054055982, 4823.27650852375, 5130.333056702605, 5135.101357262539, 5148.2020286855595, 5160.122779127482, 5169.431362550192, 4874.2444921037295, 5032.974835125801, 5103.87240318995, 5132.43543210254, 5140.997505486394, 4909.361782968334, 4920.532549407943, 4923.359963204761, 4932.4081110267, 4938.30863679078, 3732.9813350933073, 3733.8693145739767, 3738.7009039277336, 3743.606921273336, 3744.756590821697, 5026.195808670595, 5126.384833819816, 5175.0, 5178.71517066565, 5221.530062294411, 5018.723970181529, 5022.233325006246, 5029.27075574047, 5037.345145131109, 5040.621953353587, 5058.696478211319, 5065.4428012917815, 5071.797128114834, 5080.872978175427, 5091.592672586258, 4859.271109333628, 4893.6085113191575, 4913.852584422473, 4953.777080031479, 4957.330760347451, 4863.56227939473, 4933.629977751755, 5065.721385323843, 5093.23601459784, 5096.617753668415, 4948.158813001726, 4975.626827987843, 4983.3023376728015, 4983.651144419856, 4997.100521906092], "value": 3812.3858702724033, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.4708932335639, 553.903066963281, 560.8597850537367, 621.6643012773103, 633.5090305013614, 12092.395380230986, 12587.811182832265, 12631.557895473661, 12636.431360588773, 12642.115051946368, 12978.091533592653, 13587.388567514461, 13711.108777929428, 14125.646858828508, 14143.434262629507, 767.7005967672612, 787.3268355556003, 788.3732432716005, 788.4283894176705, 788.4559653838861, 635.6916895305797, 744.5607091815828, 776.9572673502955, 777.587878424436, 781.7615627233691, 812.4110020235312, 813.1827513349076, 816.3550794872044, 816.3795515408273, 818.0020375142346, 805.4160733468248, 805.995970020152, 806.2985202873479, 806.6974884418344, 806.8668669669497, 481.41748484334, 489.97305148216833, 490.64918583213176, 490.74726515844367, 573.5669569475061, 12547.372631368486, 12939.5471158509, 13005.86994130056, 13012.739745205137, 13028.54400095992, 11276.605318813885, 11310.321380717101, 11844.822327665092, 11878.0, 11955.581554645545, 10887.510062047228, 11243.269187502787, 11688.824667629993, 11773.0, 11825.231359961575, 3879.8254078566533, 3974.1654252606986, 3986.3023970805284, 4040.1919616076902, 4092.406601042862, 65048.67475662639, 65116.0, 65164.67417662881, 65189.3481065188, 65246.3475365245, 9121.90878091224, 9352.532373381304, 9383.061693830563, 9397.76505587352, 9552.522373881278, 17145.22846471912, 17229.0, 17237.05196214195, 17253.91373043152, 17254.309827606754, 6289.55973081889, 6447.967760161169, 6544.607323560602, 6582.275949645631, 6719.395254427125, 3552.2007548301426, 3607.6933460656137, 3635.927281454409, 3653.0684675408133, 3693.778373297611, 2648.351153967252, 2752.7522522973027, 2753.490604238182, 2753.9586906196423, 2762.8480433576347, 444.1960052305273, 451.58454222115734, 458.7385190441483, 464.5215428109053, 483.6469377354551, 468.64148926071584, 504.1339982201198, 516.9948300516946, 519.6855902179127, 543.0740587298646, 6667.892991553296, 6718.49611279156, 6803.609712319849, 6861.622610756356, 7282.162551306562, 470.92465205566947, 499.44810983863033, 558.05409830338, 569.3537834557724, 572.7565784541553, 3581.8567257309937, 3707.443883417509, 3878.631530004645, 4017.444561563038, 4020.8391664333685, 91079.54460227789, 91595.0, 94806.5259673711, 95856.52071739736, 96167.51916240374, 81756.18243817605, 81877.59061204655, 82239.0, 83486.16513834785, 85680.57159714162, 42452.15095698069, 42912.356314655306, 61085.0, 62013.689931550056, 71802.0, 7887.698529742528, 8340.41617086798, 8399.538025408661, 8533.146685331418, 8631.352648551509, 42461.49851187464, 43289.8052233734, 44105.33841992437, 44472.0, 45411.318830216915, 55676.44323556712, 63177.052344215794, 65648.0, 65771.67114164398, 65946.34053659403, 10971.23201375928, 11098.5560577576, 11322.830157547478, 11398.373089480157, 11833.940830296138, 11400.258983166068, 11419.143564232882, 11420.200585958903, 12003.699907502383, 12057.336846473178, 11032.172587055842, 11392.886071139514, 11503.079753619522, 11925.76148477043, 11937.104717146423, 11238.887611124112, 11460.541578337106, 11946.223495472766, 11962.641120766391, 12153.453094610586, 10352.637657681946, 10513.211509136998, 10568.577256909637, 10949.56201751921, 11449.255798373079, 9489.1934185595, 9581.808363832544, 9760.560774765294, 9856.901430985597, 10000.699769076042, 9467.810643786948, 9831.705048848546, 9926.801463970825, 9952.701418957442, 10086.899131008597], "value": 6292.470383442594, "unit": "score"}], "name": "dromaeo_css", "value": 6353.686732854514, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 115.0, 114.0, 114.0, 114.0, 113.0, 114.0, 113.0, 113.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 123.0, 123.0, 183.0, 123.0, 123.0, 143.0, 122.0, 171.0, 123.0], "value": 139.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 161.0, 162.0, 160.0, 160.0, 160.0, 160.0, 161.0, 161.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 124.0, 76.0, 76.0, 76.0, 75.0, 100.0, 76.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 116.0, 85.0, 85.0, 86.0, 120.0, 84.0, 83.0, 122.0], "value": 95.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 118.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 146.0, 149.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 97.0, 96.0, 97.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 60.0, 62.0, 61.0, 61.0, 61.0, 62.0, 61.0, 62.0], "value": 61.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 66.0, 65.0, 65.0, 66.0, 66.0, 66.0, 66.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 89.0, 80.0, 79.0, 89.0, 82.0, 85.0, 79.0, 89.0, 88.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 130.0, 130.0, 132.0, 126.0, 128.0, 131.0, 137.0, 175.0, 145.0], "value": 136.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 166.0, 167.0, 168.0, 164.0, 168.0, 166.0, 164.0, 167.0, 165.0], "value": 166.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 69.0, 67.0, 68.0, 69.0, 65.0, 66.0, 70.0, 67.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1532.2000000000003, "alertThreshold": 2.0}]} 10:26:00 INFO - Return code: 0 10:26:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:26:01 INFO - # TBPL SUCCESS # 10:26:01 INFO - Running post-action listener: _resource_record_post_action 10:26:01 INFO - [mozharness: 2016-07-29 17:26:01.038041Z] Finished run-tests step (success) 10:26:01 INFO - Running post-run listener: _resource_record_post_run 10:26:01 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 622592; Write bytes: 281640960; Read time: 92; Write time: 236876 10:26:01 INFO - TinderboxPrint: CPU usage
13.0% 10:26:01 INFO - TinderboxPrint: I/O read bytes / time
622,592 / 92 10:26:01 INFO - TinderboxPrint: I/O write bytes / time
281,640,960 / 236,876 10:26:01 INFO - TinderboxPrint: CPU idle
8,336.5 (87.0%) 10:26:01 INFO - TinderboxPrint: CPU user
1,198.2 (12.5%) 10:26:01 INFO - TinderboxPrint: Swap in / out
0 / 0 10:26:01 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 1368064; Read time: 0; Write time: 36 10:26:01 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 618496; Write bytes: 280272896; Read time: 92; Write time: 236840 10:26:01 INFO - Running post-run listener: _upload_blobber_files 10:26:01 INFO - Blob upload gear active. 10:26:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:26:01 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 10:26:01 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:26:01 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:26:02 INFO - (blobuploader) - INFO - Open directory for files ... 10:26:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:26:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:26:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:26:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:26:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:26:02 INFO - (blobuploader) - INFO - Done attempting. 10:26:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:26:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:26:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:26:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:26:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:26:06 INFO - (blobuploader) - INFO - Done attempting. 10:26:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:26:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:26:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:26:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:26:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:26:07 INFO - (blobuploader) - INFO - Done attempting. 10:26:07 INFO - (blobuploader) - INFO - Iteration through files over. 10:26:07 INFO - Return code: 0 10:26:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:26:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:26:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ea98efd4a36627a5c3bc5a30ff4f8ee32cc2b366db2fab4edf4548de53733de9fba8cf2d889ca8fea2ad7d20f7aee564688f8b24f28f631fe9b4e2a0dcdfb801", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8b00a02f7e0a6da29385856030c945ff7012f91f2ea0c4743abf31506beebed37871bc2af13f963ddb221aa816b5ad42d4c36f3388a02372d3e0802c4152768c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d23ccbdc0c1ed450487d619abea60b79d994e03fc032a6bfc327560d753002a70007d1f1849ae8f4593f313311c65a0227946d692d0748ca380b9ff05d0e7e93"} 10:26:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:26:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:26:07 INFO - Contents: 10:26:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ea98efd4a36627a5c3bc5a30ff4f8ee32cc2b366db2fab4edf4548de53733de9fba8cf2d889ca8fea2ad7d20f7aee564688f8b24f28f631fe9b4e2a0dcdfb801", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8b00a02f7e0a6da29385856030c945ff7012f91f2ea0c4743abf31506beebed37871bc2af13f963ddb221aa816b5ad42d4c36f3388a02372d3e0802c4152768c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d23ccbdc0c1ed450487d619abea60b79d994e03fc032a6bfc327560d753002a70007d1f1849ae8f4593f313311c65a0227946d692d0748ca380b9ff05d0e7e93"} 10:26:07 INFO - Running post-run listener: copy_logs_to_upload_dir 10:26:07 INFO - Copying logs to upload dir... 10:26:07 INFO - mkdir: /builds/slave/test/build/upload/logs 10:26:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.364975 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-07-29 10:26:07.236104) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-29 10:26:07.239356) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1469807819.680894-1233759330 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-Non-PGO/sha512/ea98efd4a36627a5c3bc5a30ff4f8ee32cc2b366db2fab4edf4548de53733de9fba8cf2d889ca8fea2ad7d20f7aee564688f8b24f28f631fe9b4e2a0dcdfb801", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8b00a02f7e0a6da29385856030c945ff7012f91f2ea0c4743abf31506beebed37871bc2af13f963ddb221aa816b5ad42d4c36f3388a02372d3e0802c4152768c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d23ccbdc0c1ed450487d619abea60b79d994e03fc032a6bfc327560d753002a70007d1f1849ae8f4593f313311c65a0227946d692d0748ca380b9ff05d0e7e93"} build_url:https://queue.taskcluster.net/v1/task/AbO1_ekCQqWehh8u9sr5Cw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011331 build_url: 'https://queue.taskcluster.net/v1/task/AbO1_ekCQqWehh8u9sr5Cw/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-Non-PGO/sha512/ea98efd4a36627a5c3bc5a30ff4f8ee32cc2b366db2fab4edf4548de53733de9fba8cf2d889ca8fea2ad7d20f7aee564688f8b24f28f631fe9b4e2a0dcdfb801", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8b00a02f7e0a6da29385856030c945ff7012f91f2ea0c4743abf31506beebed37871bc2af13f963ddb221aa816b5ad42d4c36f3388a02372d3e0802c4152768c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d23ccbdc0c1ed450487d619abea60b79d994e03fc032a6bfc327560d753002a70007d1f1849ae8f4593f313311c65a0227946d692d0748ca380b9ff05d0e7e93"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-29 10:26:07.264850) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-07-29 10:26:07.265202) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1469807819.680894-1233759330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004391 ========= master_lag: 1.26 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-07-29 10:26:08.533837) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-29 10:26:08.534186) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-29 10:26:08.534753) ========= ========= Total master_lag: 1.42 =========