builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-015 starttime: 1469709145.1 results: success (0) buildid: 20160728023018 builduid: 4ef3f5750efd4d25aa7e052f93932b65 revision: e82080019746478198c4009ba0c5c358be3f0359 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 05:32:25.104960) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 05:32:25.105420) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 05:32:25.105730) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 05:32:25.120118) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 05:32:25.120423) ========= 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=20e666a3d4cfbb71505a330e000001b4-1469709144.393428-1291125723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-28 05:32:25-- 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% 93.7M=0s 2016-07-28 05:32:25 (93.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115961 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 05:32:25.250629) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 05:32:25.250958) ========= 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=20e666a3d4cfbb71505a330e000001b4-1469709144.393428-1291125723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017860 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 05:32:25.300587) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 05:32:25.300982) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e82080019746478198c4009ba0c5c358be3f0359 --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 e82080019746478198c4009ba0c5c358be3f0359 --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=20e666a3d4cfbb71505a330e000001b4-1469709144.393428-1291125723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-28 05:32:25,497 truncating revision to first 12 chars 2016-07-28 05:32:25,497 Setting DEBUG logging. 2016-07-28 05:32:25,497 attempt 1/10 2016-07-28 05:32:25,497 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e82080019746?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-28 05:32:26,080 unpacking tar archive at: fx-team-e82080019746/testing/mozharness/ program finished with exit code 0 elapsedTime=0.904943 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 05:32:26.220558) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 05:32:26.220912) ========= script_repo_revision: e82080019746478198c4009ba0c5c358be3f0359 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 05:32:26.221321) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 05:32:26.221817) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 05:32:26.231708) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-07-28 05:32:26.232114) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1469709144.393428-1291125723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:32:26 INFO - MultiFileLogger online at 20160728 05:32:26 in /builds/slave/test 05:32:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:32:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:32:26 INFO - {'append_to_log': False, 05:32:26 INFO - 'base_work_dir': '/builds/slave/test', 05:32:26 INFO - 'blob_upload_branch': 'Fx-Team', 05:32:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:32:26 INFO - 'branch': 'Fx-Team', 05:32:26 INFO - 'buildbot_json_path': 'buildprops.json', 05:32:26 INFO - 'config_files': ('talos/linux_config.py',), 05:32:26 INFO - 'default_actions': ('clobber', 05:32:26 INFO - 'read-buildbot-config', 05:32:26 INFO - 'download-and-extract', 05:32:26 INFO - 'populate-webroot', 05:32:26 INFO - 'create-virtualenv', 05:32:26 INFO - 'install', 05:32:26 INFO - 'run-tests'), 05:32:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:32:26 INFO - 'download_minidump_stackwalk': True, 05:32:26 INFO - 'download_symbols': 'ondemand', 05:32:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:32:26 INFO - 'tooltool.py': '/tools/tooltool.py', 05:32:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:32:26 INFO - '/tools/misc-python/virtualenv.py')}, 05:32:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:32:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:32:26 INFO - 'installer_path': 'installer.exe', 05:32:26 INFO - 'log_level': 'info', 05:32:26 INFO - 'log_name': 'talos', 05:32:26 INFO - 'log_to_console': True, 05:32:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:32:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:32:26 INFO - 'opt_config_files': (), 05:32:26 INFO - 'pip_index': False, 05:32:26 INFO - 'sps_profile': False, 05:32:26 INFO - 'sps_profile_interval': 0, 05:32:26 INFO - 'suite': 'dromaeojs', 05:32:26 INFO - 'system_bits': '32', 05:32:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:32:26 INFO - 'title': 'talos-linux64-ix-015', 05:32:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:32:26 INFO - 'use_talos_json': True, 05:32:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:32:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:32:26 INFO - 'work_dir': 'build'} 05:32:26 INFO - [mozharness: 2016-07-28 12:32:26.520521Z] Running clobber step. 05:32:26 INFO - Running pre-action listener: _resource_record_pre_action 05:32:26 INFO - Running main action method: clobber 05:32:26 INFO - rmtree: /builds/slave/test/build 05:32:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:32:26 INFO - Running post-action listener: _resource_record_post_action 05:32:26 INFO - [mozharness: 2016-07-28 12:32:26.991302Z] Finished clobber step (success) 05:32:26 INFO - [mozharness: 2016-07-28 12:32:26.991403Z] Running read-buildbot-config step. 05:32:26 INFO - Running pre-action listener: _resource_record_pre_action 05:32:26 INFO - Running main action method: read_buildbot_config 05:32:26 INFO - Using buildbot properties: 05:32:26 INFO - { 05:32:26 INFO - "project": "", 05:32:26 INFO - "product": "firefox", 05:32:26 INFO - "script_repo_revision": "production", 05:32:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:32:26 INFO - "repository": "", 05:32:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:32:26 INFO - "buildid": "20160728023018", 05:32:26 INFO - "pgo_build": "True", 05:32:26 INFO - "basedir": "/builds/slave/test", 05:32:26 INFO - "buildnumber": 1378, 05:32:26 INFO - "slavename": "talos-linux64-ix-015", 05:32:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:32:26 INFO - "platform": "ubuntu64_hw", 05:32:26 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:32:26 INFO - "branch": "fx-team", 05:32:26 INFO - "repo_path": "integration/fx-team", 05:32:26 INFO - "revision": "e82080019746478198c4009ba0c5c358be3f0359", 05:32:26 INFO - "stage_platform": "linux64-pgo", 05:32:26 INFO - "builduid": "4ef3f5750efd4d25aa7e052f93932b65", 05:32:26 INFO - "slavebuilddir": "test" 05:32:26 INFO - } 05:32:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/HvmjPUWjR8K0aQlKkETNnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:32:26 INFO - Running post-action listener: _resource_record_post_action 05:32:26 INFO - [mozharness: 2016-07-28 12:32:26.994111Z] Finished read-buildbot-config step (success) 05:32:26 INFO - [mozharness: 2016-07-28 12:32:26.994201Z] Running download-and-extract step. 05:32:26 INFO - Running pre-action listener: _resource_record_pre_action 05:32:26 INFO - Running main action method: download_and_extract 05:32:26 INFO - mkdir: /builds/slave/test/build/tests 05:32:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:26 INFO - https://queue.taskcluster.net/v1/task/HvmjPUWjR8K0aQlKkETNnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:32:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvmjPUWjR8K0aQlKkETNnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:32:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvmjPUWjR8K0aQlKkETNnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:32:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvmjPUWjR8K0aQlKkETNnQ/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 05:32:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvmjPUWjR8K0aQlKkETNnQ/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 05:32:27 INFO - Downloaded 1361 bytes. 05:32:27 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:32:27 INFO - Using the following test package requirements: 05:32:27 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:32:27 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:32:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:32:27 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:32:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:32:27 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:32:27 INFO - u'jsshell-linux-x86_64.zip'], 05:32:27 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:32:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:32:27 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:32:27 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:32:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:32:27 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:32:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:32:27 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:32:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:32:27 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:32:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:32:27 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:27 INFO - https://queue.taskcluster.net/v1/task/HvmjPUWjR8K0aQlKkETNnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:32:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvmjPUWjR8K0aQlKkETNnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:32:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvmjPUWjR8K0aQlKkETNnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:32:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvmjPUWjR8K0aQlKkETNnQ/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 05:32:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvmjPUWjR8K0aQlKkETNnQ/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 05:32:29 INFO - Downloaded 24318744 bytes. 05:32: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'] 05:32: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 05:32:30 INFO - Return code: 0 05:32: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 05:32: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')]} 05:32:30 INFO - https://queue.taskcluster.net/v1/task/HvmjPUWjR8K0aQlKkETNnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:32:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvmjPUWjR8K0aQlKkETNnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:32:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvmjPUWjR8K0aQlKkETNnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:32:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvmjPUWjR8K0aQlKkETNnQ/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 05:32:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvmjPUWjR8K0aQlKkETNnQ/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 05:32:31 INFO - Downloaded 24318744 bytes. 05:32:31 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'] 05:32:31 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 05:32:33 INFO - Return code: 0 05:32:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:33 INFO - https://queue.taskcluster.net/v1/task/HvmjPUWjR8K0aQlKkETNnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:32:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvmjPUWjR8K0aQlKkETNnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:32:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvmjPUWjR8K0aQlKkETNnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:32:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvmjPUWjR8K0aQlKkETNnQ/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 05:32:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvmjPUWjR8K0aQlKkETNnQ/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 05:32:35 INFO - Downloaded 14413725 bytes. 05:32: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'] 05:32: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 05:32:35 INFO - Return code: 0 05:32:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:35 INFO - https://queue.taskcluster.net/v1/task/HvmjPUWjR8K0aQlKkETNnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:32:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvmjPUWjR8K0aQlKkETNnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:32:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvmjPUWjR8K0aQlKkETNnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:32:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvmjPUWjR8K0aQlKkETNnQ/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 05:32:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HvmjPUWjR8K0aQlKkETNnQ/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 05:32:36 INFO - Downloaded 60989495 bytes. 05:32:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HvmjPUWjR8K0aQlKkETNnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:32:36 INFO - mkdir: /builds/slave/test/properties 05:32:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:32:36 INFO - Writing to file /builds/slave/test/properties/build_url 05:32:36 INFO - Contents: 05:32:36 INFO - build_url:https://queue.taskcluster.net/v1/task/HvmjPUWjR8K0aQlKkETNnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:32:37 INFO - Running post-action listener: _resource_record_post_action 05:32:37 INFO - Running post-action listener: set_extra_try_arguments 05:32:37 INFO - [mozharness: 2016-07-28 12:32:37.266266Z] Finished download-and-extract step (success) 05:32:37 INFO - [mozharness: 2016-07-28 12:32:37.266499Z] Running populate-webroot step. 05:32:37 INFO - Running pre-action listener: _resource_record_pre_action 05:32:37 INFO - Running main action method: populate_webroot 05:32:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:32:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:32:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:32:37 INFO - '--tppagecycles', 05:32:37 INFO - '7'], 05:32:37 INFO - 'tests': ['tsvgm']}}, 05:32:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:32:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:32:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:32:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:32:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:32:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:32:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:37 INFO - 'talos_options': ['--disable-e10s'], 05:32:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:32:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:32:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:37 INFO - 'talos_options': ['--disable-e10s'], 05:32:37 INFO - 'tests': ['damp', 'tps']}, 05:32:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:37 INFO - 'tests': ['damp', 'tps']}, 05:32:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:32:37 INFO - 'tests': ['dromaeo_dom']}, 05:32:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:32:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:32:37 INFO - 'tests': ['basic_compositor_video']}, 05:32:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:32:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:32:37 INFO - 'tests': ['a11yr', 05:32:37 INFO - 'ts_paint', 05:32:37 INFO - 'tpaint', 05:32:37 INFO - 'sessionrestore', 05:32:37 INFO - 'sessionrestore_no_auto_restore', 05:32:37 INFO - 'tabpaint']}, 05:32:37 INFO - 'other-e10s': {'tests': ['a11yr', 05:32:37 INFO - 'ts_paint', 05:32:37 INFO - 'tpaint', 05:32:37 INFO - 'sessionrestore', 05:32:37 INFO - 'sessionrestore_no_auto_restore', 05:32:37 INFO - 'tabpaint']}, 05:32:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:32:37 INFO - 'ts_paint', 05:32:37 INFO - 'tpaint', 05:32:37 INFO - 'sessionrestore', 05:32:37 INFO - 'sessionrestore_no_auto_restore', 05:32:37 INFO - 'tabpaint']}, 05:32:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:32:37 INFO - 'ts_paint', 05:32:37 INFO - 'tpaint', 05:32:37 INFO - 'sessionrestore', 05:32:37 INFO - 'sessionrestore_no_auto_restore', 05:32:37 INFO - 'tabpaint']}, 05:32:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:32:37 INFO - 'tests': ['a11yr', 05:32:37 INFO - 'ts_paint', 05:32:37 INFO - 'tpaint', 05:32:37 INFO - 'sessionrestore', 05:32:37 INFO - 'sessionrestore_no_auto_restore', 05:32:37 INFO - 'tabpaint']}, 05:32:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:32:37 INFO - 'tests': ['a11yr', 05:32:37 INFO - 'ts_paint', 05:32:37 INFO - 'tpaint', 05:32:37 INFO - 'sessionrestore', 05:32:37 INFO - 'sessionrestore_no_auto_restore', 05:32:37 INFO - 'tabpaint']}, 05:32:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:32:37 INFO - 'tests': ['tsvgx', 05:32:37 INFO - 'tsvgr_opacity', 05:32:37 INFO - 'tart', 05:32:37 INFO - 'tscrollx', 05:32:37 INFO - 'cart']}, 05:32:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:32:37 INFO - 'tsvgr_opacity', 05:32:37 INFO - 'tart', 05:32:37 INFO - 'tscrollx', 05:32:37 INFO - 'cart']}, 05:32:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:37 INFO - 'talos_options': ['--disable-e10s'], 05:32:37 INFO - 'tests': ['tp5o']}, 05:32:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:37 INFO - 'tests': ['tp5o']}, 05:32:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:37 INFO - 'talos_options': ['--disable-e10s', 05:32:37 INFO - '--xperf_path', 05:32:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:32:37 INFO - 'tests': ['tp5n']}, 05:32:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:37 INFO - 'talos_options': ['--xperf_path', 05:32:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:32:37 INFO - 'tests': ['tp5n']}}, 05:32:37 INFO - 'talos.zip': {'path': '', 05:32:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:32:37 INFO - Running post-action listener: _resource_record_post_action 05:32:37 INFO - [mozharness: 2016-07-28 12:32:37.291515Z] Finished populate-webroot step (success) 05:32:37 INFO - [mozharness: 2016-07-28 12:32:37.291604Z] Running create-virtualenv step. 05:32:37 INFO - Running pre-action listener: _resource_record_pre_action 05:32:37 INFO - Running main action method: create_virtualenv 05:32:37 INFO - Creating virtualenv /builds/slave/test/build/venv 05:32: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 05:32:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:32:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:32:37 INFO - Using real prefix '/usr' 05:32:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:32:37 INFO - Installing distribute.............................................................................................................................................................................................done. 05:32:39 INFO - Installing pip.................done. 05:32:39 INFO - Return code: 0 05:32:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:39 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 0x19f8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cb9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb73b0>, '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 0x1cb82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cb8740>, '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': '20e666a3d4cfbb71505a330e000001b4-1469709144.393428-1291125723', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:32:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:32:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:32:39 INFO - Using env: {'DISPLAY': ':0', 05:32:39 INFO - 'HOME': '/home/cltbld', 05:32:39 INFO - 'LANG': 'en_US.UTF-8', 05:32:39 INFO - 'LANGUAGE': 'en_US:en', 05:32:39 INFO - 'LOGNAME': 'cltbld', 05:32:39 INFO - 'MAIL': '/var/mail/cltbld', 05:32:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:39 INFO - 'MOZ_NO_REMOTE': '1', 05:32:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:39 INFO - 'NO_EM_RESTART': '1', 05:32:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:39 INFO - 'PWD': '/builds/slave/test', 05:32:39 INFO - 'SHELL': '/bin/bash', 05:32:39 INFO - 'SHLVL': '1', 05:32:39 INFO - 'TERM': 'linux', 05:32:39 INFO - 'TMOUT': '86400', 05:32:39 INFO - 'USER': 'cltbld', 05:32:39 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469709144.393428-1291125723', 05:32:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:39 INFO - '_': '/tools/buildbot/bin/python'} 05:32:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32: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 05:32:40 INFO - Cleaning up... 05:32:40 INFO - Return code: 0 05:32:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:32: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')]} 05:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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')]} 05:32:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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 0x19f8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cb9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb73b0>, '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 0x1cb82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cb8740>, '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': '20e666a3d4cfbb71505a330e000001b4-1469709144.393428-1291125723', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:32: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 05:32: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 05:32:40 INFO - Using env: {'DISPLAY': ':0', 05:32:40 INFO - 'HOME': '/home/cltbld', 05:32:40 INFO - 'LANG': 'en_US.UTF-8', 05:32:40 INFO - 'LANGUAGE': 'en_US:en', 05:32:40 INFO - 'LOGNAME': 'cltbld', 05:32:40 INFO - 'MAIL': '/var/mail/cltbld', 05:32:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:40 INFO - 'MOZ_NO_REMOTE': '1', 05:32:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:40 INFO - 'NO_EM_RESTART': '1', 05:32:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:40 INFO - 'PWD': '/builds/slave/test', 05:32:40 INFO - 'SHELL': '/bin/bash', 05:32:40 INFO - 'SHLVL': '1', 05:32:40 INFO - 'TERM': 'linux', 05:32:40 INFO - 'TMOUT': '86400', 05:32:40 INFO - 'USER': 'cltbld', 05:32:40 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469709144.393428-1291125723', 05:32:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:40 INFO - '_': '/tools/buildbot/bin/python'} 05:32:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:40 INFO - Downloading/unpacking psutil>=3.1.1 05:32: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 05:32: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 05:32: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 05:32: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 05:32: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 05:32: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 05:32:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:32:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:32:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:32:42 INFO - Installing collected packages: psutil 05:32:42 INFO - Running setup.py install for psutil 05:32:42 INFO - building 'psutil._psutil_linux' extension 05:32:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:32:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:32:42 INFO - building 'psutil._psutil_posix' extension 05:32:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:32:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:32:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:32:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:32:42 INFO - Successfully installed psutil 05:32:42 INFO - Cleaning up... 05:32:42 INFO - Return code: 0 05:32:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:32:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:42 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 0x19f8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cb9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb73b0>, '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 0x1cb82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cb8740>, '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': '20e666a3d4cfbb71505a330e000001b4-1469709144.393428-1291125723', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:32:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:32:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:32:42 INFO - Using env: {'DISPLAY': ':0', 05:32:42 INFO - 'HOME': '/home/cltbld', 05:32:42 INFO - 'LANG': 'en_US.UTF-8', 05:32:42 INFO - 'LANGUAGE': 'en_US:en', 05:32:42 INFO - 'LOGNAME': 'cltbld', 05:32:42 INFO - 'MAIL': '/var/mail/cltbld', 05:32:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:42 INFO - 'MOZ_NO_REMOTE': '1', 05:32:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:42 INFO - 'NO_EM_RESTART': '1', 05:32:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:42 INFO - 'PWD': '/builds/slave/test', 05:32:42 INFO - 'SHELL': '/bin/bash', 05:32:42 INFO - 'SHLVL': '1', 05:32:42 INFO - 'TERM': 'linux', 05:32:42 INFO - 'TMOUT': '86400', 05:32:42 INFO - 'USER': 'cltbld', 05:32:42 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469709144.393428-1291125723', 05:32:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:42 INFO - '_': '/tools/buildbot/bin/python'} 05:32:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:32:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:32:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:32:45 INFO - Installing collected packages: mozsystemmonitor 05:32:45 INFO - Running setup.py install for mozsystemmonitor 05:32:45 INFO - Successfully installed mozsystemmonitor 05:32:45 INFO - Cleaning up... 05:32:45 INFO - Return code: 0 05:32:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cb9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb73b0>, '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 0x1cb82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cb8740>, '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': '20e666a3d4cfbb71505a330e000001b4-1469709144.393428-1291125723', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:32:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:32:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:32:45 INFO - Using env: {'DISPLAY': ':0', 05:32:45 INFO - 'HOME': '/home/cltbld', 05:32:45 INFO - 'LANG': 'en_US.UTF-8', 05:32:45 INFO - 'LANGUAGE': 'en_US:en', 05:32:45 INFO - 'LOGNAME': 'cltbld', 05:32:45 INFO - 'MAIL': '/var/mail/cltbld', 05:32:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:45 INFO - 'MOZ_NO_REMOTE': '1', 05:32:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:45 INFO - 'NO_EM_RESTART': '1', 05:32:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:45 INFO - 'PWD': '/builds/slave/test', 05:32:45 INFO - 'SHELL': '/bin/bash', 05:32:45 INFO - 'SHLVL': '1', 05:32:45 INFO - 'TERM': 'linux', 05:32:45 INFO - 'TMOUT': '86400', 05:32:45 INFO - 'USER': 'cltbld', 05:32:45 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469709144.393428-1291125723', 05:32:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:45 INFO - '_': '/tools/buildbot/bin/python'} 05:32:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:45 INFO - Downloading/unpacking jsonschema==2.5.1 05:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:32:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:32: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 05:32: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 05:32: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 05:32: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 05:32: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 05:32: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 05:32:47 INFO - Downloading functools32-3.2.3-2.tar.gz 05:32:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:32:47 INFO - warning: no files found matching '*.txt' 05:32:47 INFO - no previously-included directories found matching 'build' 05:32:47 INFO - no previously-included directories found matching 'dist' 05:32:47 INFO - no previously-included directories found matching '.git*' 05:32:47 INFO - Installing collected packages: jsonschema, functools32 05:32:47 INFO - Running setup.py install for functools32 05:32:47 INFO - warning: no files found matching '*.txt' 05:32:47 INFO - no previously-included directories found matching 'build' 05:32:47 INFO - no previously-included directories found matching 'dist' 05:32:47 INFO - no previously-included directories found matching '.git*' 05:32:47 INFO - Successfully installed jsonschema functools32 05:32:47 INFO - Cleaning up... 05:32:47 INFO - Return code: 0 05:32:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:32: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')]} 05:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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')]} 05:32:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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', '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 0x19f8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cb9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb73b0>, '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 0x1cb82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cb8740>, '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': '20e666a3d4cfbb71505a330e000001b4-1469709144.393428-1291125723', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:32: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:32: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 functools32==3.2.3-2 05:32:47 INFO - Using env: {'DISPLAY': ':0', 05:32:47 INFO - 'HOME': '/home/cltbld', 05:32:47 INFO - 'LANG': 'en_US.UTF-8', 05:32:47 INFO - 'LANGUAGE': 'en_US:en', 05:32:47 INFO - 'LOGNAME': 'cltbld', 05:32:47 INFO - 'MAIL': '/var/mail/cltbld', 05:32:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:47 INFO - 'MOZ_NO_REMOTE': '1', 05:32:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:47 INFO - 'NO_EM_RESTART': '1', 05:32:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:47 INFO - 'PWD': '/builds/slave/test', 05:32:47 INFO - 'SHELL': '/bin/bash', 05:32:47 INFO - 'SHLVL': '1', 05:32:47 INFO - 'TERM': 'linux', 05:32:47 INFO - 'TMOUT': '86400', 05:32:47 INFO - 'USER': 'cltbld', 05:32:47 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469709144.393428-1291125723', 05:32:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:47 INFO - '_': '/tools/buildbot/bin/python'} 05:32:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:32:47 INFO - Cleaning up... 05:32:47 INFO - Return code: 0 05:32:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:32: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')]} 05:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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')]} 05:32:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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', '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 0x19f8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cb9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb73b0>, '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 0x1cb82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cb8740>, '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': '20e666a3d4cfbb71505a330e000001b4-1469709144.393428-1291125723', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:32: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:32: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 blobuploader==1.2.4 05:32:47 INFO - Using env: {'DISPLAY': ':0', 05:32:47 INFO - 'HOME': '/home/cltbld', 05:32:47 INFO - 'LANG': 'en_US.UTF-8', 05:32:47 INFO - 'LANGUAGE': 'en_US:en', 05:32:47 INFO - 'LOGNAME': 'cltbld', 05:32:47 INFO - 'MAIL': '/var/mail/cltbld', 05:32:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:47 INFO - 'MOZ_NO_REMOTE': '1', 05:32:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:47 INFO - 'NO_EM_RESTART': '1', 05:32:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:47 INFO - 'PWD': '/builds/slave/test', 05:32:47 INFO - 'SHELL': '/bin/bash', 05:32:47 INFO - 'SHLVL': '1', 05:32:47 INFO - 'TERM': 'linux', 05:32:47 INFO - 'TMOUT': '86400', 05:32:47 INFO - 'USER': 'cltbld', 05:32:47 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469709144.393428-1291125723', 05:32:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:47 INFO - '_': '/tools/buildbot/bin/python'} 05:32:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:48 INFO - Downloading/unpacking blobuploader==1.2.4 05:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:50 INFO - Downloading blobuploader-1.2.4.tar.gz 05:32:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:32:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:32: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 05:32: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 05:32: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 05:32: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 05:32: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 05:32: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 05:32:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:32:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:32: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 05:32: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 05:32: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 05:32: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 05:32: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 05:32: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 05:32:50 INFO - Downloading docopt-0.6.1.tar.gz 05:32:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:32:50 INFO - Installing collected packages: blobuploader, requests, docopt 05:32:50 INFO - Running setup.py install for blobuploader 05:32:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:32:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:32:50 INFO - Running setup.py install for requests 05:32:51 INFO - Running setup.py install for docopt 05:32:51 INFO - Successfully installed blobuploader requests docopt 05:32:51 INFO - Cleaning up... 05:32:51 INFO - Return code: 0 05:32:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:51 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 0x19f8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cb9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb73b0>, '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 0x1cb82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cb8740>, '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': '20e666a3d4cfbb71505a330e000001b4-1469709144.393428-1291125723', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:32:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:32:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:32:51 INFO - Using env: {'DISPLAY': ':0', 05:32:51 INFO - 'HOME': '/home/cltbld', 05:32:51 INFO - 'LANG': 'en_US.UTF-8', 05:32:51 INFO - 'LANGUAGE': 'en_US:en', 05:32:51 INFO - 'LOGNAME': 'cltbld', 05:32:51 INFO - 'MAIL': '/var/mail/cltbld', 05:32:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:51 INFO - 'MOZ_NO_REMOTE': '1', 05:32:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:51 INFO - 'NO_EM_RESTART': '1', 05:32:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:51 INFO - 'PWD': '/builds/slave/test', 05:32:51 INFO - 'SHELL': '/bin/bash', 05:32:51 INFO - 'SHLVL': '1', 05:32:51 INFO - 'TERM': 'linux', 05:32:51 INFO - 'TMOUT': '86400', 05:32:51 INFO - 'USER': 'cltbld', 05:32:51 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469709144.393428-1291125723', 05:32:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:51 INFO - '_': '/tools/buildbot/bin/python'} 05:32:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:32:51 INFO - Running setup.py (path:/tmp/pip-blskHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:32:51 INFO - Running setup.py (path:/tmp/pip-Jsqn1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:32:51 INFO - Running setup.py (path:/tmp/pip-8zzVp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:32:51 INFO - Running setup.py (path:/tmp/pip-KcloP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:32:51 INFO - Running setup.py (path:/tmp/pip-m1qyGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:32:52 INFO - Running setup.py (path:/tmp/pip-6wophO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:32:52 INFO - Running setup.py (path:/tmp/pip-LmiuNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:32:52 INFO - Running setup.py (path:/tmp/pip-FRJNZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:32:52 INFO - Running setup.py (path:/tmp/pip-H8Bt_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:32:52 INFO - Running setup.py (path:/tmp/pip-mSGUWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:32:52 INFO - Running setup.py (path:/tmp/pip-U6dcvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:32:52 INFO - Running setup.py (path:/tmp/pip-kXu84M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:32:52 INFO - Running setup.py (path:/tmp/pip-aOgLjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:32:52 INFO - Running setup.py (path:/tmp/pip-HqdbNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:52 INFO - Running setup.py (path:/tmp/pip-AHu1Pj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:32:52 INFO - Running setup.py (path:/tmp/pip-DoMv52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:32:52 INFO - Running setup.py (path:/tmp/pip-gw551f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:32:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:32:52 INFO - Running setup.py install for manifestparser 05:32:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:32:53 INFO - Running setup.py install for mozcrash 05:32:53 INFO - Running setup.py install for mozdebug 05:32:53 INFO - Running setup.py install for mozdevice 05:32:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:32:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:32:53 INFO - Running setup.py install for mozfile 05:32:53 INFO - Running setup.py install for mozhttpd 05:32:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:32:53 INFO - Running setup.py install for mozinfo 05:32:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:32:53 INFO - Running setup.py install for mozInstall 05:32:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:32:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:32:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:32:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:32:53 INFO - Running setup.py install for mozleak 05:32:53 INFO - Running setup.py install for mozlog 05:32:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:32:53 INFO - Running setup.py install for moznetwork 05:32:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:32:54 INFO - Running setup.py install for mozprocess 05:32:54 INFO - Running setup.py install for mozprofile 05:32:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:32:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:32:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:32:54 INFO - Running setup.py install for mozrunner 05:32:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:32:54 INFO - Running setup.py install for mozscreenshot 05:32:54 INFO - Running setup.py install for moztest 05:32:54 INFO - Running setup.py install for mozversion 05:32:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:32:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:32:54 INFO - Cleaning up... 05:32:54 INFO - Return code: 0 05:32:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:54 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 0x19f8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cb9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb73b0>, '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 0x1cb82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cb8740>, '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': '20e666a3d4cfbb71505a330e000001b4-1469709144.393428-1291125723', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:32:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:32:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:32:54 INFO - Using env: {'DISPLAY': ':0', 05:32:54 INFO - 'HOME': '/home/cltbld', 05:32:54 INFO - 'LANG': 'en_US.UTF-8', 05:32:54 INFO - 'LANGUAGE': 'en_US:en', 05:32:54 INFO - 'LOGNAME': 'cltbld', 05:32:54 INFO - 'MAIL': '/var/mail/cltbld', 05:32:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:54 INFO - 'MOZ_NO_REMOTE': '1', 05:32:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:54 INFO - 'NO_EM_RESTART': '1', 05:32:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:54 INFO - 'PWD': '/builds/slave/test', 05:32:54 INFO - 'SHELL': '/bin/bash', 05:32:54 INFO - 'SHLVL': '1', 05:32:54 INFO - 'TERM': 'linux', 05:32:54 INFO - 'TMOUT': '86400', 05:32:54 INFO - 'USER': 'cltbld', 05:32:54 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469709144.393428-1291125723', 05:32:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:54 INFO - '_': '/tools/buildbot/bin/python'} 05:32:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:32:54 INFO - Running setup.py (path:/tmp/pip-apJjnz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:32:54 INFO - Running setup.py (path:/tmp/pip-PLijSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:32:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:32:55 INFO - Running setup.py (path:/tmp/pip-xMuOL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:32:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:32:55 INFO - Running setup.py (path:/tmp/pip-qu89xu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:32:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:32:55 INFO - Running setup.py (path:/tmp/pip-1yEcJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:32:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:32:55 INFO - Running setup.py (path:/tmp/pip-7748K6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:32:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:32:55 INFO - Running setup.py (path:/tmp/pip-Y5DXsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:32:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:32:55 INFO - Running setup.py (path:/tmp/pip-1wiYBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:32:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:32:55 INFO - Running setup.py (path:/tmp/pip-bQgDaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:32:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:32:55 INFO - Running setup.py (path:/tmp/pip-VN4uig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:32:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:32:55 INFO - Running setup.py (path:/tmp/pip-CLESly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:32:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:32:55 INFO - Running setup.py (path:/tmp/pip-nztiCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:32:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:32:55 INFO - Running setup.py (path:/tmp/pip-WT0JbQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:32:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:32:55 INFO - Running setup.py (path:/tmp/pip-OkHFQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:32:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:55 INFO - Running setup.py (path:/tmp/pip-tAgFZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:32:56 INFO - Running setup.py (path:/tmp/pip-CLG32b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:32:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:32:56 INFO - Running setup.py (path:/tmp/pip-GtmA3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:32:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:32:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:32:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:32:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:32:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:32:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:32:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:58 INFO - Downloading blessings-1.6.tar.gz 05:32:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:32:58 INFO - Installing collected packages: blessings 05:32:58 INFO - Running setup.py install for blessings 05:32:58 INFO - Successfully installed blessings 05:32:58 INFO - Cleaning up... 05:32:58 INFO - Return code: 0 05:32:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:32:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:32:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:32:58 INFO - Reading from file tmpfile_stdout 05:32:58 INFO - Current package versions: 05:32:58 INFO - argparse == 1.2.1 05:32:58 INFO - blessings == 1.6 05:32:58 INFO - blobuploader == 1.2.4 05:32:58 INFO - docopt == 0.6.1 05:32:58 INFO - functools32 == 3.2.3-2 05:32:58 INFO - jsonschema == 2.5.1 05:32:58 INFO - manifestparser == 1.1 05:32:58 INFO - mozInstall == 1.12 05:32:58 INFO - mozcrash == 0.17 05:32:58 INFO - mozdebug == 0.1 05:32:58 INFO - mozdevice == 0.48 05:32:58 INFO - mozfile == 1.2 05:32:58 INFO - mozhttpd == 0.7 05:32:58 INFO - mozinfo == 0.9 05:32:58 INFO - mozleak == 0.1 05:32:58 INFO - mozlog == 3.3 05:32:58 INFO - moznetwork == 0.27 05:32:58 INFO - mozprocess == 0.23 05:32:58 INFO - mozprofile == 0.28 05:32:58 INFO - mozrunner == 6.12 05:32:58 INFO - mozscreenshot == 0.1 05:32:58 INFO - mozsystemmonitor == 0.3 05:32:58 INFO - moztest == 0.7 05:32:58 INFO - mozversion == 1.4 05:32:58 INFO - psutil == 3.1.1 05:32:58 INFO - requests == 1.2.3 05:32:58 INFO - wsgiref == 0.1.2 05:32:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:58 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 0x19f8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cb9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb73b0>, '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 0x1cb82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cb8740>, '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': '20e666a3d4cfbb71505a330e000001b4-1469709144.393428-1291125723', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:32:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:32:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:32:58 INFO - Using env: {'DISPLAY': ':0', 05:32:58 INFO - 'HOME': '/home/cltbld', 05:32:58 INFO - 'LANG': 'en_US.UTF-8', 05:32:58 INFO - 'LANGUAGE': 'en_US:en', 05:32:58 INFO - 'LOGNAME': 'cltbld', 05:32:58 INFO - 'MAIL': '/var/mail/cltbld', 05:32:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:58 INFO - 'MOZ_NO_REMOTE': '1', 05:32:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:58 INFO - 'NO_EM_RESTART': '1', 05:32:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:58 INFO - 'PWD': '/builds/slave/test', 05:32:58 INFO - 'SHELL': '/bin/bash', 05:32:58 INFO - 'SHLVL': '1', 05:32:58 INFO - 'TERM': 'linux', 05:32:58 INFO - 'TMOUT': '86400', 05:32:58 INFO - 'USER': 'cltbld', 05:32:58 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469709144.393428-1291125723', 05:32:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:58 INFO - '_': '/tools/buildbot/bin/python'} 05:32:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:32:58 INFO - Cleaning up... 05:32:58 INFO - Return code: 0 05:32:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:32:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:58 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 0x19f8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cb9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb73b0>, '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 0x1cb82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cb8740>, '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': '20e666a3d4cfbb71505a330e000001b4-1469709144.393428-1291125723', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:32:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:32:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:32:58 INFO - Using env: {'DISPLAY': ':0', 05:32:58 INFO - 'HOME': '/home/cltbld', 05:32:58 INFO - 'LANG': 'en_US.UTF-8', 05:32:58 INFO - 'LANGUAGE': 'en_US:en', 05:32:58 INFO - 'LOGNAME': 'cltbld', 05:32:58 INFO - 'MAIL': '/var/mail/cltbld', 05:32:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:58 INFO - 'MOZ_NO_REMOTE': '1', 05:32:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:58 INFO - 'NO_EM_RESTART': '1', 05:32:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:58 INFO - 'PWD': '/builds/slave/test', 05:32:58 INFO - 'SHELL': '/bin/bash', 05:32:58 INFO - 'SHLVL': '1', 05:32:58 INFO - 'TERM': 'linux', 05:32:58 INFO - 'TMOUT': '86400', 05:32:58 INFO - 'USER': 'cltbld', 05:32:58 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469709144.393428-1291125723', 05:32:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:58 INFO - '_': '/tools/buildbot/bin/python'} 05:32:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:32:58 INFO - Cleaning up... 05:32:58 INFO - Return code: 0 05:32:58 INFO - Running post-action listener: _resource_record_post_action 05:32:58 INFO - Running post-action listener: _start_resource_monitoring 05:32:58 INFO - Starting resource monitoring. 05:32:58 INFO - [mozharness: 2016-07-28 12:32:58.984115Z] Finished create-virtualenv step (success) 05:32:58 INFO - [mozharness: 2016-07-28 12:32:58.984548Z] Running install step. 05:32:58 INFO - Running pre-action listener: _resource_record_pre_action 05:32:58 INFO - Running main action method: install 05:32:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:32:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:32:59 INFO - Reading from file tmpfile_stdout 05:32:59 INFO - Detecting whether we're running mozinstall >=1.0... 05:32:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:32:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:32:59 INFO - Reading from file tmpfile_stdout 05:32:59 INFO - Output received: 05:32:59 INFO - Usage: mozinstall [options] installer 05:32:59 INFO - Options: 05:32:59 INFO - -h, --help show this help message and exit 05:32:59 INFO - -d DEST, --destination=DEST 05:32:59 INFO - Directory to install application into. [default: 05:32:59 INFO - "/builds/slave/test"] 05:32:59 INFO - --app=APP Application being installed. [default: firefox] 05:32:59 INFO - mkdir: /builds/slave/test/build/application 05:32:59 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'] 05:32:59 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 05:33:16 INFO - Reading from file tmpfile_stdout 05:33:16 INFO - Output received: 05:33:16 INFO - /builds/slave/test/build/application/firefox/firefox 05:33:16 INFO - Running post-action listener: _resource_record_post_action 05:33:16 INFO - [mozharness: 2016-07-28 12:33:16.557889Z] Finished install step (success) 05:33:16 INFO - [mozharness: 2016-07-28 12:33:16.558164Z] Running run-tests step. 05:33:16 INFO - Running pre-action listener: _resource_record_pre_action 05:33:16 INFO - Running main action method: run_tests 05:33:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:33:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:33:16 INFO - Python 2.7.3 05:33:16 INFO - Return code: 0 05:33:16 INFO - grabbing minidump binary from tooltool 05:33:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:16 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 0x1cb73b0>, '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 0x1cb82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cb8740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:33:16 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:33:16 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:33:16 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:33:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:33:16 INFO - Return code: 0 05:33:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:33:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:33:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:33:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:33:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:33:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HvmjPUWjR8K0aQlKkETNnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:33:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HvmjPUWjR8K0aQlKkETNnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:33:16 INFO - Using env: {'DISPLAY': ':0', 05:33:16 INFO - 'HOME': '/home/cltbld', 05:33:16 INFO - 'LANG': 'en_US.UTF-8', 05:33:16 INFO - 'LANGUAGE': 'en_US:en', 05:33:16 INFO - 'LOGNAME': 'cltbld', 05:33:16 INFO - 'MAIL': '/var/mail/cltbld', 05:33:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:33:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:33:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:16 INFO - 'MOZ_NO_REMOTE': '1', 05:33:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:33:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:16 INFO - 'NO_EM_RESTART': '1', 05:33:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:16 INFO - 'PWD': '/builds/slave/test', 05:33:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:33:16 INFO - 'SHELL': '/bin/bash', 05:33:16 INFO - 'SHLVL': '1', 05:33:16 INFO - 'TERM': 'linux', 05:33:16 INFO - 'TMOUT': '86400', 05:33:16 INFO - 'USER': 'cltbld', 05:33:16 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469709144.393428-1291125723', 05:33:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:16 INFO - '_': '/tools/buildbot/bin/python'} 05:33:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HvmjPUWjR8K0aQlKkETNnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:33:16 INFO - mozversion application_buildid: 20160728023018 05:33:16 INFO - mozversion application_changeset: e82080019746478198c4009ba0c5c358be3f0359 05:33:16 INFO - mozversion application_display_name: Nightly 05:33:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:33:16 INFO - mozversion application_name: Firefox 05:33:16 INFO - mozversion application_remotingname: firefox 05:33:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:33:16 INFO - mozversion application_vendor: Mozilla 05:33:16 INFO - mozversion application_version: 50.0a1 05:33:16 INFO - mozversion platform_buildid: 20160728023018 05:33:16 INFO - mozversion platform_changeset: e82080019746478198c4009ba0c5c358be3f0359 05:33:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:33:16 INFO - mozversion platform_version: 50.0a1 05:33:16 INFO - using testdate: 1469709196 05:33:16 INFO - actual date: 1469709196 05:33:16 INFO - starting webserver on 'localhost:36141' 05:33:16 INFO - SUITE-START | Running 2 tests 05:33:16 INFO - TEST-START | dromaeo_css 05:33:16 INFO - operating with platform_type : linux_ 05:33:16 INFO - Initialising browser for dromaeo_css test... 05:33:16 INFO - TEST-INFO | started process 7935 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1lSsXt/profile http://localhost:36141/getInfo.html) 05:33:20 INFO - PROCESS | 7935 | JavaScript error: , line 0: uncaught exception: undefined 05:33:20 INFO - PROCESS | 7935 | __metrics Screen width/height:1600/1200 05:33:20 INFO - PROCESS | 7935 | colorDepth:24 05:33:20 INFO - PROCESS | 7935 | Browser inner width/height: 1024/697 05:33:20 INFO - PROCESS | 7935 | __metrics 05:33:21 INFO - PROCESS | 7935 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:33:21 INFO - PROCESS | 7935 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:33:22 INFO - TEST-INFO | 7935: exit 0 05:33:22 INFO - Browser initialized. 05:33:22 INFO - Running cycle 1/1 for dromaeo_css test... 05:33:22 INFO - TEST-INFO | started process 8013 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1lSsXt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:33:34 INFO - PROCESS | 8013 | RSS: Main: 157335552 05:33:34 INFO - PROCESS | 8013 | 05:34:26 INFO - PROCESS | 8013 | 1469709266205 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:36:34 INFO - PROCESS | 8013 | Cycle 1(1): loaded http://localhost:36141/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36141/tests/dromaeo/cssquery-ext.html) 05:36:35 INFO - PROCESS | 8013 | RSS: Main: 335179776 05:36:35 INFO - PROCESS | 8013 | 05:39:38 INFO - PROCESS | 8013 | Cycle 1(1): loaded http://localhost:36141/tests/dromaeo/cssquery-ext.html (next: http://localhost:36141/tests/dromaeo/cssquery-jquery.html) 05:39:38 INFO - PROCESS | 8013 | RSS: Main: 249430016 05:39:38 INFO - PROCESS | 8013 | 05:42:40 INFO - PROCESS | 8013 | Cycle 1(1): loaded http://localhost:36141/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36141/tests/dromaeo/cssquery-mootools.html) 05:42:41 INFO - PROCESS | 8013 | RSS: Main: 186167296 05:42:41 INFO - PROCESS | 8013 | 05:45:43 INFO - PROCESS | 8013 | Cycle 1(1): loaded http://localhost:36141/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36141/tests/dromaeo/cssquery-prototype.html) 05:45:44 INFO - PROCESS | 8013 | RSS: Main: 246611968 05:45:44 INFO - PROCESS | 8013 | 05:48:46 INFO - PROCESS | 8013 | Cycle 1(1): loaded http://localhost:36141/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36141/tests/dromaeo/cssquery-yui.html) 05:48:47 INFO - PROCESS | 8013 | RSS: Main: 186269696 05:48:47 INFO - PROCESS | 8013 | 05:51:49 INFO - PROCESS | 8013 | Cycle 1(1): loaded http://localhost:36141/tests/dromaeo/cssquery-yui.html (next: http://localhost:36141/tests/dromaeo/cssquery-dojo.html) 05:51:50 INFO - PROCESS | 8013 | RSS: Main: 277704704 05:51:50 INFO - PROCESS | 8013 | 05:51:50 INFO - PROCESS | 8013 | __start_tp_report 05:51:50 INFO - PROCESS | 8013 | _x_x_mozilla_page_load 05:51:50 INFO - PROCESS | 8013 | _x_x_mozilla_page_load_details 05:51:50 INFO - PROCESS | 8013 | |i|pagename|runs| 05:51:50 INFO - PROCESS | 8013 | |0;dojo.html;3068.186930463427;3093.381323735252;3093.4586447371703;3119.5320701894707;3131.2641529240623;5284.9958507883475;5373.032854086267;5377.327834020747;5423.430539793324;5446.2919820423385;5385.596080293974;5412.404635490103;5467.316585426822;5489.780408783654;5516.834494965157;4879.585235255007;4904.092742842586;4976.129177393959;4988.87527811804;5057.418396884369;4959.032988567231;4987.975060124694;5001.899962000758;5013.3232013678235;5018.372703412074;4793.7363445010515;4900.142475066885;4966.8758281043265;4968.031233909389;4996.1756310208775;4852.8544143675745;4857.781399837016;4874.610031197496;4940.357753492023;5032.622553308516;4865.80787707014;4901.975490122527;4911.484294149134;4932.136876046713;4949.430815456232;5245.79016839326;5272.314599102092;5334.653247538898;5412.5940554458575;5436;5669.433056694339;5711.314642242916;5751.856203594902;5757.712114394263;5762.711864406805;5802.013657678205;5806.158107074492;5806.651600903917;5810.883782324372;5812.302523697141;5204.9219261711105;5325.946740532584;5354.464553544653;5361.919571206435;5363.356397232318;5990.580659353804;5994.0409534474275;6012.218411606463;6017.398260174035;6018.067199584071;5742.971285143548;5753.769849206069;5758.683272419973;5758.971205143947;5762.510186634183;5644.379118296984;5695.971520142372;5703.9429605704245;5714.942850571524;5836.9124463133085;5693.402192769782;5732.914006289909;5740.052891272893;5782.653040817564;5795.1017592273265;5695.743691533891;5732.455416735404;5739.7704091836695;5753.367129615739;5760.279965004374;4284.3145096784365;4305.074409002017;4305.332673435622;4347.586979236968;4357.346398040319;3915.0799562102884;3943.2704949584418;3946.092398748304;3947.684185265172;3952.940705889414;5414.83755487336;5416.756245968941;5417.647852889629;5423.810166644149;5425.782968681208;5726.169705392778;5738.053221218453;5765.88468230633;5775.075987841925;5877.94122058774;5436.429174936654;5481.260029895992;5484.177373394023;5493.697846618475;5536.086545719992;5019.422766381913;5020.1214787412055;5020.146575082244;5022.221555658879;5063.822766203165;5753.309602847685;5760.711964401763;5810.941890581124;5978.461938425476;5980.162777211194;5622.943770562242;5634.690092044813;5640.407757185437;5684.943150568524;5684.943150568607;5768.134779783066;5774.740136693943;5774.769009239583;5779.162021506942;5782.739776709974;5458.890822183614;5533.363663178625;5534.557235421076;5567.081431563746;5626.43735626434;5769.105788602773;5775.047117225611;5781;5823;5839.416058394297;5595.860103497445;5596.552275817843;5597.160425936142;5601.80393686219;5609.943900560942;5495.230667706444;5588.748506317307;5598.776048957996;5613.298337707786;5613.578981576316;5478.890422191614;5511.972440137773;5564.360098588714;5564.4991950724625;5572.3034620672415;5631.465010823965;5650.660960342392;5665.065264231355;5674.517665998436;5685.346185188756;5504.9174262385295;5533.833984980457;5540.473655002768;5548.195511650869;5552.083906155439 05:51:50 INFO - PROCESS | 8013 | |1;ext.html;567.3957235544148;608.3156448994881;617.5769597825487;623.5821999260494;653.8528831013026;42699.35950960734;43734.56265437345;44001.77999110008;44339.77830110849;47362;45795.31307030397;46275.30587041197;46286.305705414365;46302.536974630246;46328.53671463293;8897;8957.19385255327;9015.954920225422;9041.050689677588;9092.318076144282;8981.191692747652;9061.048589898031;9062.909370906305;9064.320175986828;9064.456132632064;9116.270698344117;9176.770580735501;9194.58624361902;9198.816023679556;9199.678011269607;9082.182603565678;9112.544372781334;9120.45277283365;9124.771880702969;9127.178553930178;8994.28045756338;9035.232005279493;9054.094590540959;9055.683051093247;9061.864072038925;42886;43007.13985720268;43080.78459607682;43137.568624313986;43164;3637.163452405935;3704.444333349992;3716.1081340478363;3743.7192210584317;3767.171222331083;32641.34717305664;33238.833805831055;33482.3303533928;33577.83211083953;34497;4432.867013989586;4476.171908196994;4490.685652004361;4584.954150458486;4610.2623580227;365576;366530;366615.1669241663;366925;366994;52317.47682523126;57771.42228577661;59201.703991479764;59580.404195958356;59597;55551;60464.395356046756;60477;60501.39498605046;60522.394776051675;15597.298121584328;15770.76343854843;15777.211139442981;15777.68444631101;15788.131652759208;11686.24039437434;12154.209976351509;12208.389580520938;12328.32194229326;12343.938280308541;17479.388221412442;17499;17512.474625761246;17619.55951101207;17649.7352539712;6848.623325717033;6857.177138743283;6965.965170174218;7071.434285257167;7121.67952442131;947.1097168661436;963.5760265483165;967.9516024198762;1103.3379972016726;1123.4719681749564;31752.682473175435;33286.66713332884;33296.66703332936;33395.332093357996;33425.66574334274;1068.834330678746;1094.9726256843483;1128.7968165730083;1130.4856290387854;1165.825126231072;17165.656686866194;17526.123693815258;17532.386366477112;17540.298388064588;17597.824021759876;554993;560330;562649;563270;563539;58880;59026.70486647539;59180.70409647924;59402.40597594055;59414.40585594175;1247.133242396544;1264.6016504801141;1370.8080868678592;1386.736520061185;1395.337214822951;31816.5227521592;34109.488357674156;34417.62329506792;34534.30931381408;34597.827010864785;50723.239151413494;51154.232686508985;51252.74373628108;51505.48494515007;51517.227241590655;393900;395307;395915;396044;396421;27316;27833.860830695718;28037.299067523476;29166.27084322909;41853.79073104615;45650.77174614106;48732;48932.75533622309;49454.25818612652;50301.74849125731;40856.59143408647;42555.14889702127;43096.56903430926;43260;43274.567254327056;42438.78780606077;42460.51388201521;42704.57295427006;42728.14543709046;43015.56984430116;40510.18979620332;41074;41335.586644133175;41366;41410;35372.292554148255;37466.25067498689;37738.86783396502;37981.810090949366;38451.615483844806;28317.433651326446;28399.574006389506;28507.721612014055;28666.283342916595;28777.856110719313 05:51:50 INFO - PROCESS | 8013 | |2;jquery.html;361.88962366478216;381.3631235836155;389.92591407632557;392.86446176069256;414.2998332817538;16728.247228874698;18870.62258754826;18983.24067037317;19187.808121918777;20072.297469588568;18393.816061839378;18927;19151.23395064196;19360.90319548404;19700.901495492537;5736.282964629421;5741.655500669952;5803.187553742479;5928.584999050068;5929.9703501482645;5714.371419143911;5737.655740655553;5829.533637309005;5845.561582881301;5846;5719.771209151629;5794.5074668653215;5818.1272809078555;5821.243238379026;5844.298684157886;5667.603267771257;5723.742431590588;5781.797637082724;5806.071028635441;5839.182514447981;5004.124278251292;5134.0758663440565;5185.299984502081;5188.040212560651;5193.63644544882;23390.18134365306;23549.175778847657;23695;23781.88109059461;24124;2194.4294483434423;2338.8362814602983;2634.5916382960672;2652.4695060987688;3109.6112985876766;9040.909590904139;9667.27495437845;10138.087572118471;10174.135198508136;10554.155667546578;1904;1905.6950887857877;1934.9129289182022;1950.8341790947786;1963.1950900131021;82744.58627706883;84334.57832710797;84942.57528712317;85567.57216213942;86706;10490.42302673345;10732.731681707864;10743.194260430499;10783.56865725378;10843.644544431945;14755.852441475448;14762.188079655722;14768.778468322984;14771.858080578257;14784.852151478348;7929.801754956172;8187.590620468953;8248.54632995191;8380.748577542683;8386.454880432751;7969.641366138538;7973.322267607318;8024.2376974187355;8229.506229626242;8270.462419942685;4398.978005110018;4468.352088947085;4504.662150338672;4714.5521175488275;4754.144254034307;1862.8975406352781;1909.5989842133308;1924.2399252295265;1926.248762982438;1968.5767559974388;888.5646033443695;972.7957129002989;975.5756246032856;1074.2802322443981;1082.4154956323498;18095.72856407155;18281.725774113398;18651.533711657317;18859.622807543772;19260.22959081621;1005.8591797148259;1015.1777060580805;1031.185363562777;1047.3349423116376;1056.0073530880948;9909.75225619351;10343.689689309333;10346.172306215485;10437.739056523496;10485.528151233213;452660;458490;463007;502190;512012;87675;88686;89858;91538.54230728804;92114.53942730243;969.7527130581798;996.5465713100522;1018.7809620931536;1025.9435731034716;1028.377831412;15949.362025519313;16273.104979225782;16821.41125060617;16838.831611683727;17022.57443563921;41151.176976460905;41415.7929210352;42951.57048429476;43187;44616.77691611651;60399.698001509714;61248.693756530934;61377.69311153416;62047.37952620416;63240.68379658072;7829.7259595913865;7857.882131768142;7890.250426209501;7964.721234756756;8146.83706325882;12256.816147757612;12622.684432889251;12918.22490650564;13333.333333333101;13394.464221431033;5557.166425036277;9865.950670246602;12017.158798883995;12231;12531.12282140278;11217.158713096387;11257.295380754163;11442.94278528602;11686.18196726255;12005.459754311252;11456.3698996556;11479.311241325548;11605.477753500943;11839.408029598313;12340.321282329558;8124.268815806606;8184;8236.258736713724;8270.586470676322;8309.542975136426;10754.946225268823;11078.224524283223;11649.650510484698;12110.576129835414;12136.453859576164 05:51:50 INFO - PROCESS | 8013 | |3;mootools.html;1298.5909438526858;1460.4304321314683;1520.4070412539108;1629.8125715542708;1821.9908900455505;7521.962390188049;8673.956630216848;8996.95501522493;9017.458952462857;9274;9037.322200834931;9115.361924665276;9124.726258212248;9129.452232866017;9130.452172869633;2302.2862912497094;2334.719833619968;2340.0873659272897;2342.0631747301045;2345.097137602027;2227.175944900389;2296.8621882687007;2364.267077206063;2364.302530753423;2365.1603680693365;2281.555096756133;2289.244549298736;2299.1722979727283;2350.024739733017;2351.824087956022;2283.4976305212826;2287.4052746286;2289.473421113145;2291.450051987519;2292.4383526036063;2275.82931280153;2279.3845661671257;2279.7948184663296;2279.988600056989;2283.6003699352545;8814.735557933273;9012.954935225347;9050.366474346798;9089.409188402798;9094.590743416562;5078.949210507884;5241.056609810233;5316.282301889273;5332.14685650298;5332.466753324637;3361.83190840457;3395.9151021224666;3422.401079811048;3455.272363818091;3467.930641387183;1070.5664205996584;1089.5968491658136;1101.6805126513302;1113.432149603708;1123.601121601836;12849.67875803103;12969.610911672758;12999.480020799252;13089.34553272342;13097.148685335518;4394.231009573312;4506.188886000486;4598.241290187082;4658.95341046592;4666.0901124280435;11017.889821101846;11035.39305338198;11045.226834121535;11061.336319820837;11090.168237382228;5238.659487133325;5245.737713114329;5246.081935661244;5247.895042099137;5248.527632513092;4227.577242275748;4663.48701642819;4828.155072862235;4846.466888642247;4876.414830220397;3866.2460820140363;3925.8429662813737;4004.2191772604647;4026.033751899523;4037.313656678372;1230.3110258255406;1253.185429470833;1265.44320498982;1277.5400855691944;1281.9423125959354;829.2205326992728;945.6501094594906;990.1979396688705;1010.7321559786662;1027.3168343051937;6052.425019623129;6082.665453400017;6108.664023478663;6110.388961103854;6423.229212494437;437.5930384742157;448.1060284731981;451.82153049545246;455.46937817442307;460.3899832721657;4146.274401979642;4154.771487568152;4206.600372964564;4235.110626768352;4238.660907127422;11145.331280123057;11354.261972971895;11416.543338266376;11418.543258269576;11458.77082458363;10576.788464230673;11064.114870810316;11380.487878045507;11401.429928503541;11407;8499.83000340002;8608.139186081467;8625.309975202093;8660.653573857102;8683.044865064838;6196.659183744757;6399.55203135776;6429.099926010269;6502.934970650422;6663.900041499478;10554.525046372779;10751.086157676373;10776.245662803842;10798.514066866852;10895.455227238448;10911;11064.778704425706;11145.387003714874;11170.553177872795;11172.273802202832;6875.5874647521305;7824.921750782647;7964.761057168294;8319.667213311399;8631.180037896389;8627.87058194115;9003.729888103368;9011.954940225258;9020.458772473672;9021.90978090237;7667.46327757074;7759.340456061298;7868.685252590061;8154.38842086834;8180.754577362689;7738.342240909586;7808.7657370278985;7853;7894.131645519104;7954.721584744506;7209.134903811576;7219.169795473587;7289.125304963438;7308.926910731037;7310.378617817332;5364.14173732201;5375.6774593524515;5489.917651235155;5497.312835895513;5734.54123670097;5501.119820828648;5528.751206195811;5574.470425309589;5681.403452637579;5721.370649228498 05:51:50 INFO - PROCESS | 8013 | |4;prototype.html;309.1174745798089;329.94226010448165;330.7849897566582;333.36493978970054;334.6937552139792;5137.280780690707;5157.432682404937;5170.819021334254;5175.482451754822;5249.343832020997;5170;5170.974145129278;5190.662606930547;5192.324997750287;5199.402068762093;4106.5072191337085;4109.383592461125;4120.217158739845;4139.586041395866;4155.148194620111;3981.2236613860164;3993;4140.420341152241;4151.771652559108;4175;4099.959000410003;4100;4122.031322639177;4136.090060186754;4147.253494371012;4119.7940102994735;4120.7321524100835;4123.7938103094875;4133.276676581616;4159.708820382574;3471.9132021699406;3527.7883327000463;3637.7089832813576;3672.687821535146;3717.9551246814144;5036.219385995177;5039.798408063673;5049.34358533392;5063.392392912837;5067.594592432597;4671.416072990876;4680.7191568506;4701.529847015306;4706.058788242365;4717.174494463455;5247.212918062283;5334.653247538898;5412.5940554458575;5438.184272359138;5442.292501974718;3974.841006359742;4013.4581831452674;4025.3156963316305;4031.4154447604933;4037.232925744129;5674.120511320752;5675.2054712340305;5691.686957217351;5705.400932902068;5716.371199168088;4008.3987401889367;4103.97948010264;4122.690798190148;4139.379093135994;4140.710150289511;4167.124903770182;4192.874213773592;4194.3498757692;4207.389928460356;4210.705250632487;4697.224957881979;4723.929141062887;4734.692245004064;4736.573708366263;4747.2879068140055;5373.811916582979;5437.211604317352;5459.12653975362;5464.672119672753;5503.0189131912475;1432.8352239492592;1445.4579532675248;1445.515752222996;1446.2985452055746;1450.4995776457106;896.3411892259185;950.4772375193616;956.9138777510058;967.2068903499204;967.8354679704468;4714.434267887876;4731.976340118277;4736.218523943579;4739.928901066487;4775;4961.603071754251;5359.598030147677;5447.53695935842;5600.719964001865;5683.431656834284;5305.151175811851;5313.840584782385;5319.335083114611;5340.973295133499;5349.304590403222;2907.4621195078557;2964.8733481276977;2965.733084022448;2983.9858095785257;2991.446582382266;5750.856228594235;5795.652260864277;5812.912806307909;5830.650160990354;5842.474177323977;5730.5129064030025;5745.482906538432;5749.712514374264;5757.107648314518;5765.913511297334;5453.445767956114;5699.686517241592;5758.1362795581;5800.361960184377;5821.534277257894;5579.330480342385;5598.236555485009;5607.327120745374;5641.774329026793;5651.519620832275;5343.198520221842;5561.63849349791;5586.273784408001;5589.580781441489;5620.437956204347;5746.224259724883;5781.913271301018;5794.333651630117;5797.710114494174;5799.594028417971;4155.16896620671;4157.210130075276;4168;4183.665306775511;4183.728057676241;5373;5611;5622.746976385991;5646.632968857011;5676;5346.198070289488;5402.297701298806;5408.999335122858;5427.213054107211;5459.153831156177;5394.811181608625;5395.81114660985;5416.539594134385;5447.455254474521;5472.863178420572;5245.265662807134;5328.387235467816;5382.327209098863;5409.864753381197;5418.810341638024;5461.808836690697;5470.452954704498;5472.303585888388;5472.972635136799;5479;5187.636865419385;5245.632805703564;5286.2511494023665;5303.602229832855;5385.9192112119135 05:51:50 INFO - PROCESS | 8013 | |5;yui.html;722.0252658910475;744.9979777199668;774.635921117075;809.4697972827796;856.9014563325218;15560.144192069445;16679;16697.66604667906;16703.331866725333;16720.665586688257;15430.382784688627;15740.527784166494;16094.678106437865;16587.41944031959;16634.33462661492;661.1339145719099;797.9640916158758;816.5631387207845;835.4611275727152;835.9289460395873;824.9917500824974;830.5182993863544;831.4055450352996;834.0325222741621;834.1741675741033;879.2570278115014;880.1286726141107;880.454118446564;880.6257340630239;881.7971866470716;690.858374033322;839.6809212499272;875.4222213339198;875.5578432891413;875.7022612311813;622.8972219583809;628.9716962736687;629.6064959400375;629.8267976306506;630.1681780050335;15729.764053539206;15835.524934251876;15844.207789610473;15876.206189690585;15893.602659933478;14776.335064921997;14785.408583656641;14859.925700371537;14866.628334291621;15132.848671513255;13632.522861699892;13638.386272617658;13795.724085518334;13892.583222503341;13983.37074831635;4729.834455794031;4751.976240118777;4897.118518666639;4934.3338649282605;4955.380577427822;69817;70860.6456967717;90644.54677726568;91533.5423322879;92942.5352873238;11939.343336116423;12302.323372214436;12344.938275308745;12374.257544547176;12568.371581420892;23023.309300721005;23028.194013209457;23172.65241021386;23174.53650926972;23180.884095579753;9021.32340074484;9021.594028268612;9062.275017998545;9139.77150571241;9377.859332110023;4702.003297197355;4904.803807847647;4971.825986090542;5021.372328458942;5121.692698438105;3572.9464058039152;3649.069487280726;3667.064898450878;3679.282539904693;3679.466477360768;633.8890694128509;637.3467196123918;638.0078977190514;638.8850006998784;660.5871330418488;625.5996162456032;683.8392977650249;729.6023667101442;749.9550026998397;783.8471498057824;10020.549075291628;10242;10497.527611257512;10653.414062226651;10750.408727520062;624.8312955501989;727.66163733864;728.50461686054;735.2243383230636;754.3776384482824;4829.710217386968;4869.016390994591;4964.875878103004;5018.873200055929;5053.0904437200925;65501.67249163723;66053;66053.33946660472;66157.33842661609;87418;96793.51603241939;99383.50308248412;100156.49921750344;100672;101655;86334.56832715921;88017;88630;89705.55147224222;92353.5382323084;9448.811023779348;9746.707598772047;9835.508224588599;9917.504124793875;9919.801603968024;49619.50380496149;50385.465308122446;50892.49107508877;50971.74514127554;51362;42779.144417112104;42954;43199.35200972051;68902;69734.65132674304;12930.159539629894;13103.934480327538;13171.67070823237;13286;13308.667283317995;13548.390322435316;14135.575932722035;14170.220637864604;14215.289235537975;14375.424983000981;13003.804942926054;13167.613072310975;13287.667808304483;13473.326333683473;13581.388837502534;13037.869621303666;13166.802497962346;13276.867231327564;14027.36876840565;14200.360983755549;12962.611121666365;13288.269145197108;13340.066195366619;13450.192988420726;13792;10279.691609251735;10359.533820978224;10502.422366769595;10657.840132398176;10689.786204276026;10288.588456461957;10668.862933014063;10811.13510919109;10979.560817567528;10985 05:51:50 INFO - PROCESS | 8013 | __end_tp_report 05:51:50 INFO - PROCESS | 8013 | __start_cc_report 05:51:50 INFO - PROCESS | 8013 | _x_x_mozilla_cycle_collect,1618 05:51:50 INFO - PROCESS | 8013 | __end_cc_report 05:51:50 INFO - PROCESS | 8013 | __startTimestamp1469710310086__endTimestamp 05:51:50 INFO - PROCESS | 8013 | 05:51:50 INFO - PROCESS | 8013 | ------- Summary: start ------- 05:51:50 INFO - PROCESS | 8013 | Number of tests: 6 05:51:50 INFO - PROCESS | 8013 | 05:51:50 INFO - PROCESS | 8013 | [#0] dojo.html Cycles:165 Average:5343.27 Median:5536.09 stddev:599.08 (10.8%) stddev-sans-first:573.71 05:51:50 INFO - PROCESS | 8013 | Values: 3068.2 3093.4 3093.5 3119.5 3131.3 5285.0 5373.0 5377.3 5423.4 5446.3 5385.6 5412.4 5467.3 5489.8 5516.8 4879.6 4904.1 4976.1 4988.9 5057.4 4959.0 4988.0 5001.9 5013.3 5018.4 4793.7 4900.1 4966.9 4968.0 4996.2 4852.9 4857.8 4874.6 4940.4 5032.6 4865.8 4902.0 4911.5 4932.1 4949.4 5245.8 5272.3 5334.7 5412.6 5436.0 5669.4 5711.3 5751.9 5757.7 5762.7 5802.0 5806.2 5806.7 5810.9 5812.3 5204.9 5325.9 5354.5 5361.9 5363.4 5990.6 5994.0 6012.2 6017.4 6018.1 5743.0 5753.8 5758.7 5759.0 5762.5 5644.4 5696.0 5703.9 5714.9 5836.9 5693.4 5732.9 5740.1 5782.7 5795.1 5695.7 5732.5 5739.8 5753.4 5760.3 4284.3 4305.1 4305.3 4347.6 4357.3 3915.1 3943.3 3946.1 3947.7 3952.9 5414.8 5416.8 5417.6 5423.8 5425.8 5726.2 5738.1 5765.9 5775.1 5877.9 5436.4 5481.3 5484.2 5493.7 5536.1 5019.4 5020.1 5020.1 5022.2 5063.8 5753.3 5760.7 5810.9 5978.5 5980.2 5622.9 5634.7 5640.4 5684.9 5684.9 5768.1 5774.7 5774.8 5779.2 5782.7 5458.9 5533.4 5534.6 5567.1 5626.4 5769.1 5775.0 5781.0 5823.0 5839.4 5595.9 5596.6 5597.2 5601.8 5609.9 5495.2 5588.7 5598.8 5613.3 5613.6 5478.9 5512.0 5564.4 5564.5 5572.3 5631.5 5650.7 5665.1 5674.5 5685.3 5504.9 5533.8 5540.5 5548.2 5552.1 05:51:50 INFO - PROCESS | 8013 | 05:51:50 INFO - PROCESS | 8013 | [#1] ext.html Cycles:180 Average:60669.28 Median:43011.35 stddev:119084.89 (276.9%) stddev-sans-first:119333.46 05:51:50 INFO - PROCESS | 8013 | Values: 567.4 608.3 617.6 623.6 653.9 42699.4 43734.6 44001.8 44339.8 47362.0 45795.3 46275.3 46286.3 46302.5 46328.5 8897.0 8957.2 9016.0 9041.1 9092.3 8981.2 9061.0 9062.9 9064.3 9064.5 9116.3 9176.8 9194.6 9198.8 9199.7 9082.2 9112.5 9120.5 9124.8 9127.2 8994.3 9035.2 9054.1 9055.7 9061.9 42886.0 43007.1 43080.8 43137.6 43164.0 3637.2 3704.4 3716.1 3743.7 3767.2 32641.3 33238.8 33482.3 33577.8 34497.0 4432.9 4476.2 4490.7 4585.0 4610.3 365576.0 366530.0 366615.2 366925.0 366994.0 52317.5 57771.4 59201.7 59580.4 59597.0 55551.0 60464.4 60477.0 60501.4 60522.4 15597.3 15770.8 15777.2 15777.7 15788.1 11686.2 12154.2 12208.4 12328.3 12343.9 17479.4 17499.0 17512.5 17619.6 17649.7 6848.6 6857.2 6966.0 7071.4 7121.7 947.1 963.6 968.0 1103.3 1123.5 31752.7 33286.7 33296.7 33395.3 33425.7 1068.8 1095.0 1128.8 1130.5 1165.8 17165.7 17526.1 17532.4 17540.3 17597.8 554993.0 560330.0 562649.0 563270.0 563539.0 58880.0 59026.7 59180.7 59402.4 59414.4 1247.1 1264.6 1370.8 1386.7 1395.3 31816.5 34109.5 34417.6 34534.3 34597.8 50723.2 51154.2 51252.7 51505.5 51517.2 393900.0 395307.0 395915.0 396044.0 396421.0 27316.0 27833.9 28037.3 29166.3 41853.8 45650.8 48732.0 48932.8 49454.3 50301.7 40856.6 42555.1 43096.6 43260.0 43274.6 42438.8 42460.5 42704.6 42728.1 43015.6 40510.2 41074.0 41335.6 41366.0 41410.0 35372.3 37466.3 37738.9 37981.8 38451.6 28317.4 28399.6 28507.7 28666.3 28777.9 05:51:50 INFO - PROCESS | 8013 | 05:51:50 INFO - PROCESS | 8013 | [#2] jquery.html Cycles:180 Average:28686.97 Median:371.63 stddev:79040.94 (21268.9%) stddev-sans-first:79234.06 05:51:50 INFO - PROCESS | 8013 | Values: 361.9 381.4 389.9 392.9 414.3 16728.2 18870.6 18983.2 19187.8 20072.3 18393.8 18927.0 19151.2 19360.9 19700.9 5736.3 5741.7 5803.2 5928.6 5930.0 5714.4 5737.7 5829.5 5845.6 5846.0 5719.8 5794.5 5818.1 5821.2 5844.3 5667.6 5723.7 5781.8 5806.1 5839.2 5004.1 5134.1 5185.3 5188.0 5193.6 23390.2 23549.2 23695.0 23781.9 24124.0 2194.4 2338.8 2634.6 2652.5 3109.6 9040.9 9667.3 10138.1 10174.1 10554.2 1904.0 1905.7 1934.9 1950.8 1963.2 82744.6 84334.6 84942.6 85567.6 86706.0 10490.4 10732.7 10743.2 10783.6 10843.6 14755.9 14762.2 14768.8 14771.9 14784.9 7929.8 8187.6 8248.5 8380.7 8386.5 7969.6 7973.3 8024.2 8229.5 8270.5 4399.0 4468.4 4504.7 4714.6 4754.1 1862.9 1909.6 1924.2 1926.2 1968.6 888.6 972.8 975.6 1074.3 1082.4 18095.7 18281.7 18651.5 18859.6 19260.2 1005.9 1015.2 1031.2 1047.3 1056.0 9909.8 10343.7 10346.2 10437.7 10485.5 452660.0 458490.0 463007.0 502190.0 512012.0 87675.0 88686.0 89858.0 91538.5 92114.5 969.8 996.5 1018.8 1025.9 1028.4 15949.4 16273.1 16821.4 16838.8 17022.6 41151.2 41415.8 42951.6 43187.0 44616.8 60399.7 61248.7 61377.7 62047.4 63240.7 7829.7 7857.9 7890.3 7964.7 8146.8 12256.8 12622.7 12918.2 13333.3 13394.5 5557.2 9866.0 12017.2 12231.0 12531.1 11217.2 11257.3 11442.9 11686.2 12005.5 11456.4 11479.3 11605.5 11839.4 12340.3 8124.3 8184.0 8236.3 8270.6 8309.5 10754.9 11078.2 11649.7 12110.6 12136.5 05:51:50 INFO - PROCESS | 8013 | 05:51:50 INFO - PROCESS | 8013 | [#3] mootools.html Cycles:180 Average:5990.36 Median:2477.15 stddev:3520.64 (142.1%) stddev-sans-first:3512.86 05:51:50 INFO - PROCESS | 8013 | Values: 1298.6 1460.4 1520.4 1629.8 1822.0 7522.0 8674.0 8997.0 9017.5 9274.0 9037.3 9115.4 9124.7 9129.5 9130.5 2302.3 2334.7 2340.1 2342.1 2345.1 2227.2 2296.9 2364.3 2364.3 2365.2 2281.6 2289.2 2299.2 2350.0 2351.8 2283.5 2287.4 2289.5 2291.5 2292.4 2275.8 2279.4 2279.8 2280.0 2283.6 8814.7 9013.0 9050.4 9089.4 9094.6 5078.9 5241.1 5316.3 5332.1 5332.5 3361.8 3395.9 3422.4 3455.3 3467.9 1070.6 1089.6 1101.7 1113.4 1123.6 12849.7 12969.6 12999.5 13089.3 13097.1 4394.2 4506.2 4598.2 4659.0 4666.1 11017.9 11035.4 11045.2 11061.3 11090.2 5238.7 5245.7 5246.1 5247.9 5248.5 4227.6 4663.5 4828.2 4846.5 4876.4 3866.2 3925.8 4004.2 4026.0 4037.3 1230.3 1253.2 1265.4 1277.5 1281.9 829.2 945.7 990.2 1010.7 1027.3 6052.4 6082.7 6108.7 6110.4 6423.2 437.6 448.1 451.8 455.5 460.4 4146.3 4154.8 4206.6 4235.1 4238.7 11145.3 11354.3 11416.5 11418.5 11458.8 10576.8 11064.1 11380.5 11401.4 11407.0 8499.8 8608.1 8625.3 8660.7 8683.0 6196.7 6399.6 6429.1 6502.9 6663.9 10554.5 10751.1 10776.2 10798.5 10895.5 10911.0 11064.8 11145.4 11170.6 11172.3 6875.6 7824.9 7964.8 8319.7 8631.2 8627.9 9003.7 9012.0 9020.5 9021.9 7667.5 7759.3 7868.7 8154.4 8180.8 7738.3 7808.8 7853.0 7894.1 7954.7 7209.1 7219.2 7289.1 7308.9 7310.4 5364.1 5375.7 5489.9 5497.3 5734.5 5501.1 5528.8 5574.5 5681.4 5721.4 05:51:50 INFO - PROCESS | 8013 | 05:51:50 INFO - PROCESS | 8013 | [#4] prototype.html Cycles:180 Average:4605.54 Median:5222.33 stddev:1329.57 (25.5%) stddev-sans-first:1293.60 05:51:50 INFO - PROCESS | 8013 | Values: 309.1 329.9 330.8 333.4 334.7 5137.3 5157.4 5170.8 5175.5 5249.3 5170.0 5171.0 5190.7 5192.3 5199.4 4106.5 4109.4 4120.2 4139.6 4155.1 3981.2 3993.0 4140.4 4151.8 4175.0 4100.0 4100.0 4122.0 4136.1 4147.3 4119.8 4120.7 4123.8 4133.3 4159.7 3471.9 3527.8 3637.7 3672.7 3718.0 5036.2 5039.8 5049.3 5063.4 5067.6 4671.4 4680.7 4701.5 4706.1 4717.2 5247.2 5334.7 5412.6 5438.2 5442.3 3974.8 4013.5 4025.3 4031.4 4037.2 5674.1 5675.2 5691.7 5705.4 5716.4 4008.4 4104.0 4122.7 4139.4 4140.7 4167.1 4192.9 4194.3 4207.4 4210.7 4697.2 4723.9 4734.7 4736.6 4747.3 5373.8 5437.2 5459.1 5464.7 5503.0 1432.8 1445.5 1445.5 1446.3 1450.5 896.3 950.5 956.9 967.2 967.8 4714.4 4732.0 4736.2 4739.9 4775.0 4961.6 5359.6 5447.5 5600.7 5683.4 5305.2 5313.8 5319.3 5341.0 5349.3 2907.5 2964.9 2965.7 2984.0 2991.4 5750.9 5795.7 5812.9 5830.7 5842.5 5730.5 5745.5 5749.7 5757.1 5765.9 5453.4 5699.7 5758.1 5800.4 5821.5 5579.3 5598.2 5607.3 5641.8 5651.5 5343.2 5561.6 5586.3 5589.6 5620.4 5746.2 5781.9 5794.3 5797.7 5799.6 4155.2 4157.2 4168.0 4183.7 4183.7 5373.0 5611.0 5622.7 5646.6 5676.0 5346.2 5402.3 5409.0 5427.2 5459.2 5394.8 5395.8 5416.5 5447.5 5472.9 5245.3 5328.4 5382.3 5409.9 5418.8 5461.8 5470.5 5472.3 5473.0 5479.0 5187.6 5245.6 5286.3 5303.6 5385.9 05:51:50 INFO - PROCESS | 8013 | 05:51:50 INFO - PROCESS | 8013 | [#5] yui.html Cycles:180 Average:19501.11 Median:4883.07 stddev:26535.82 (543.4%) stddev-sans-first:26572.79 05:51:50 INFO - PROCESS | 8013 | Values: 722.0 745.0 774.6 809.5 856.9 15560.1 16679.0 16697.7 16703.3 16720.7 15430.4 15740.5 16094.7 16587.4 16634.3 661.1 798.0 816.6 835.5 835.9 825.0 830.5 831.4 834.0 834.2 879.3 880.1 880.5 880.6 881.8 690.9 839.7 875.4 875.6 875.7 622.9 629.0 629.6 629.8 630.2 15729.8 15835.5 15844.2 15876.2 15893.6 14776.3 14785.4 14859.9 14866.6 15132.8 13632.5 13638.4 13795.7 13892.6 13983.4 4729.8 4752.0 4897.1 4934.3 4955.4 69817.0 70860.6 90644.5 91533.5 92942.5 11939.3 12302.3 12344.9 12374.3 12568.4 23023.3 23028.2 23172.7 23174.5 23180.9 9021.3 9021.6 9062.3 9139.8 9377.9 4702.0 4904.8 4971.8 5021.4 5121.7 3572.9 3649.1 3667.1 3679.3 3679.5 633.9 637.3 638.0 638.9 660.6 625.6 683.8 729.6 750.0 783.8 10020.5 10242.0 10497.5 10653.4 10750.4 624.8 727.7 728.5 735.2 754.4 4829.7 4869.0 4964.9 5018.9 5053.1 65501.7 66053.0 66053.3 66157.3 87418.0 96793.5 99383.5 100156.5 100672.0 101655.0 86334.6 88017.0 88630.0 89705.6 92353.5 9448.8 9746.7 9835.5 9917.5 9919.8 49619.5 50385.5 50892.5 50971.7 51362.0 42779.1 42954.0 43199.4 68902.0 69734.7 12930.2 13103.9 13171.7 13286.0 13308.7 13548.4 14135.6 14170.2 14215.3 14375.4 13003.8 13167.6 13287.7 13473.3 13581.4 13037.9 13166.8 13276.9 14027.4 14200.4 12962.6 13288.3 13340.1 13450.2 13792.0 10279.7 10359.5 10502.4 10657.8 10689.8 10288.6 10668.9 10811.1 10979.6 10985.0 05:51:50 INFO - PROCESS | 8013 | -------- Summary: end -------- 05:51:50 INFO - PROCESS | 8013 | 05:51:50 INFO - TEST-INFO | 8013: exit 0 05:51:50 INFO - TEST-OK | dromaeo_css | took 1114057ms 05:51:50 INFO - TEST-START | kraken 05:51:50 INFO - operating with platform_type : linux_ 05:51:50 INFO - Initialising browser for kraken test... 05:51:50 INFO - TEST-INFO | started process 8208 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEzVtrV/profile http://localhost:36141/getInfo.html) 05:51:54 INFO - PROCESS | 8208 | JavaScript error: , line 0: uncaught exception: undefined 05:51:54 INFO - PROCESS | 8208 | __metrics Screen width/height:1600/1200 05:51:54 INFO - PROCESS | 8208 | colorDepth:24 05:51:54 INFO - PROCESS | 8208 | Browser inner width/height: 1024/697 05:51:54 INFO - PROCESS | 8208 | __metrics 05:51:55 INFO - PROCESS | 8208 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:51:55 INFO - PROCESS | 8208 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:51:56 INFO - TEST-INFO | 8208: exit 0 05:51:56 INFO - Browser initialized. 05:51:56 INFO - Running cycle 1/1 for kraken test... 05:51:56 INFO - TEST-INFO | started process 8287 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEzVtrV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:52:08 INFO - PROCESS | 8287 | RSS: Main: 157339648 05:52:08 INFO - PROCESS | 8287 | 05:52:11 INFO - PROCESS | 8287 | Cycle 1(1): loaded http://localhost:36141/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36141/tests/kraken/driver.html?testName=audio-beat-detection) 05:52:11 INFO - PROCESS | 8287 | RSS: Main: 214241280 05:52:11 INFO - PROCESS | 8287 | 05:52:14 INFO - PROCESS | 8287 | Cycle 1(1): loaded http://localhost:36141/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36141/tests/kraken/driver.html?testName=audio-dft) 05:52:15 INFO - PROCESS | 8287 | RSS: Main: 193200128 05:52:15 INFO - PROCESS | 8287 | 05:52:18 INFO - PROCESS | 8287 | Cycle 1(1): loaded http://localhost:36141/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36141/tests/kraken/driver.html?testName=audio-fft) 05:52:18 INFO - PROCESS | 8287 | RSS: Main: 271958016 05:52:18 INFO - PROCESS | 8287 | 05:52:20 INFO - PROCESS | 8287 | Cycle 1(1): loaded http://localhost:36141/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36141/tests/kraken/driver.html?testName=audio-oscillator) 05:52:21 INFO - PROCESS | 8287 | RSS: Main: 181362688 05:52:21 INFO - PROCESS | 8287 | 05:52:23 INFO - PROCESS | 8287 | Cycle 1(1): loaded http://localhost:36141/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36141/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:52:24 INFO - PROCESS | 8287 | RSS: Main: 186179584 05:52:24 INFO - PROCESS | 8287 | 05:52:27 INFO - PROCESS | 8287 | Cycle 1(1): loaded http://localhost:36141/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36141/tests/kraken/driver.html?testName=imaging-darkroom) 05:52:27 INFO - PROCESS | 8287 | RSS: Main: 220790784 05:52:27 INFO - PROCESS | 8287 | 05:52:31 INFO - PROCESS | 8287 | Cycle 1(1): loaded http://localhost:36141/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36141/tests/kraken/driver.html?testName=imaging-desaturate) 05:52:31 INFO - PROCESS | 8287 | RSS: Main: 221122560 05:52:31 INFO - PROCESS | 8287 | 05:52:34 INFO - PROCESS | 8287 | Cycle 1(1): loaded http://localhost:36141/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36141/tests/kraken/driver.html?testName=json-parse-financial) 05:52:35 INFO - PROCESS | 8287 | RSS: Main: 220966912 05:52:35 INFO - PROCESS | 8287 | 05:52:36 INFO - PROCESS | 8287 | Cycle 1(1): loaded http://localhost:36141/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36141/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:52:37 INFO - PROCESS | 8287 | RSS: Main: 185753600 05:52:37 INFO - PROCESS | 8287 | 05:52:39 INFO - PROCESS | 8287 | Cycle 1(1): loaded http://localhost:36141/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36141/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:52:39 INFO - PROCESS | 8287 | RSS: Main: 190201856 05:52:39 INFO - PROCESS | 8287 | 05:52:41 INFO - PROCESS | 8287 | Cycle 1(1): loaded http://localhost:36141/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36141/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:52:42 INFO - PROCESS | 8287 | RSS: Main: 195420160 05:52:42 INFO - PROCESS | 8287 | 05:52:44 INFO - PROCESS | 8287 | Cycle 1(1): loaded http://localhost:36141/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36141/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:52:45 INFO - PROCESS | 8287 | RSS: Main: 189161472 05:52:45 INFO - PROCESS | 8287 | 05:52:48 INFO - PROCESS | 8287 | Cycle 1(1): loaded http://localhost:36141/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36141/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:52:48 INFO - PROCESS | 8287 | RSS: Main: 194019328 05:52:48 INFO - PROCESS | 8287 | 05:52:50 INFO - PROCESS | 8287 | Cycle 1(1): loaded http://localhost:36141/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36141/tests/kraken/driver.html?testName=ai-astar) 05:52:50 INFO - PROCESS | 8287 | RSS: Main: 245141504 05:52:50 INFO - PROCESS | 8287 | 05:52:50 INFO - PROCESS | 8287 | __start_tp_report 05:52:50 INFO - PROCESS | 8287 | _x_x_mozilla_page_load 05:52:50 INFO - PROCESS | 8287 | _x_x_mozilla_page_load_details 05:52:50 INFO - PROCESS | 8287 | |i|pagename|runs| 05:52:50 INFO - PROCESS | 8287 | |0;ai-astar;103;111;110;109;110;110;108;109;111;109 05:52:50 INFO - PROCESS | 8287 | |1;audio-beat-detection;145;115;120;177;122;132;151;117;152;117 05:52:50 INFO - PROCESS | 8287 | |2;audio-dft;161;160;161;160;159;162;162;161;162;161 05:52:50 INFO - PROCESS | 8287 | |3;audio-fft;74;74;76;132;76;77;75;75;101;74 05:52:50 INFO - PROCESS | 8287 | |4;audio-oscillator;82;83;125;83;83;84;119;83;83;126 05:52:50 INFO - PROCESS | 8287 | |5;imaging-gaussian-blur;116;116;116;117;117;117;116;117;117;117 05:52:50 INFO - PROCESS | 8287 | |6;imaging-darkroom;146;146;146;145;145;146;145;145;146;145 05:52:50 INFO - PROCESS | 8287 | |7;imaging-desaturate;95;95;95;94;94;95;94;95;95;94 05:52:50 INFO - PROCESS | 8287 | |8;json-parse-financial;55;51;51;51;51;53;53;52;52;51 05:52:50 INFO - PROCESS | 8287 | |9;json-stringify-tinderbox;69;64;64;63;63;63;63;63;63;63 05:52:50 INFO - PROCESS | 8287 | |10;stanford-crypto-aes;77;75;81;76;76;76;76;76;75;80 05:52:50 INFO - PROCESS | 8287 | |11;stanford-crypto-ccm;122;123;136;121;152;122;118;127;179;127 05:52:50 INFO - PROCESS | 8287 | |12;stanford-crypto-pbkdf2;159;160;158;163;162;157;164;159;162;158 05:52:50 INFO - PROCESS | 8287 | |13;stanford-crypto-sha256-iterative;64;64;64;65;64;65;63;63;62;62 05:52:50 INFO - PROCESS | 8287 | __end_tp_report 05:52:50 INFO - PROCESS | 8287 | __start_cc_report 05:52:50 INFO - PROCESS | 8287 | _x_x_mozilla_cycle_collect,1725 05:52:50 INFO - PROCESS | 8287 | __end_cc_report 05:52:50 INFO - PROCESS | 8287 | __startTimestamp1469710370828__endTimestamp 05:52:50 INFO - PROCESS | 8287 | 05:52:50 INFO - PROCESS | 8287 | ------- Summary: start ------- 05:52:50 INFO - PROCESS | 8287 | Number of tests: 14 05:52:50 INFO - PROCESS | 8287 | 05:52:50 INFO - PROCESS | 8287 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.00 stddev:2.31 (2.1%) stddev-sans-first:1.00 05:52:50 INFO - PROCESS | 8287 | Values: 103.0 111.0 110.0 109.0 110.0 110.0 108.0 109.0 111.0 109.0 05:52:50 INFO - PROCESS | 8287 | 05:52:50 INFO - PROCESS | 8287 | [#1] audio-beat-detection Cycles:10 Average:134.80 Median:138.50 stddev:20.71 (15.0%) stddev-sans-first:21.63 05:52:50 INFO - PROCESS | 8287 | Values: 145.0 115.0 120.0 177.0 122.0 132.0 151.0 117.0 152.0 117.0 05:52:50 INFO - PROCESS | 8287 | 05:52:50 INFO - PROCESS | 8287 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 05:52:50 INFO - PROCESS | 8287 | Values: 161.0 160.0 161.0 160.0 159.0 162.0 162.0 161.0 162.0 161.0 05:52:50 INFO - PROCESS | 8287 | 05:52:50 INFO - PROCESS | 8287 | [#3] audio-fft Cycles:10 Average:83.40 Median:75.00 stddev:18.94 (25.3%) stddev-sans-first:19.78 05:52:50 INFO - PROCESS | 8287 | Values: 74.0 74.0 76.0 132.0 76.0 77.0 75.0 75.0 101.0 74.0 05:52:50 INFO - PROCESS | 8287 | 05:52:50 INFO - PROCESS | 8287 | [#4] audio-oscillator Cycles:10 Average:95.10 Median:83.00 stddev:19.57 (23.6%) stddev-sans-first:20.17 05:52:50 INFO - PROCESS | 8287 | Values: 82.0 83.0 125.0 83.0 83.0 84.0 119.0 83.0 83.0 126.0 05:52:50 INFO - PROCESS | 8287 | 05:52:50 INFO - PROCESS | 8287 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 05:52:50 INFO - PROCESS | 8287 | Values: 116.0 116.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 05:52:50 INFO - PROCESS | 8287 | 05:52:50 INFO - PROCESS | 8287 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 05:52:50 INFO - PROCESS | 8287 | Values: 146.0 146.0 146.0 145.0 145.0 146.0 145.0 145.0 146.0 145.0 05:52:50 INFO - PROCESS | 8287 | 05:52:50 INFO - PROCESS | 8287 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 05:52:50 INFO - PROCESS | 8287 | Values: 95.0 95.0 95.0 94.0 94.0 95.0 94.0 95.0 95.0 94.0 05:52:50 INFO - PROCESS | 8287 | 05:52:50 INFO - PROCESS | 8287 | [#8] json-parse-financial Cycles:10 Average:52.00 Median:52.00 stddev:1.33 (2.6%) stddev-sans-first:0.87 05:52:50 INFO - PROCESS | 8287 | Values: 55.0 51.0 51.0 51.0 51.0 53.0 53.0 52.0 52.0 51.0 05:52:50 INFO - PROCESS | 8287 | 05:52:50 INFO - PROCESS | 8287 | [#9] json-stringify-tinderbox Cycles:10 Average:63.80 Median:63.00 stddev:1.87 (3.0%) stddev-sans-first:0.44 05:52:50 INFO - PROCESS | 8287 | Values: 69.0 64.0 64.0 63.0 63.0 63.0 63.0 63.0 63.0 63.0 05:52:50 INFO - PROCESS | 8287 | 05:52:50 INFO - PROCESS | 8287 | [#10] stanford-crypto-aes Cycles:10 Average:76.80 Median:76.00 stddev:2.04 (2.7%) stddev-sans-first:2.17 05:52:50 INFO - PROCESS | 8287 | Values: 77.0 75.0 81.0 76.0 76.0 76.0 76.0 76.0 75.0 80.0 05:52:50 INFO - PROCESS | 8287 | 05:52:50 INFO - PROCESS | 8287 | [#11] stanford-crypto-ccm Cycles:10 Average:132.70 Median:127.00 stddev:19.06 (15.0%) stddev-sans-first:19.81 05:52:50 INFO - PROCESS | 8287 | Values: 122.0 123.0 136.0 121.0 152.0 122.0 118.0 127.0 179.0 127.0 05:52:50 INFO - PROCESS | 8287 | 05:52:50 INFO - PROCESS | 8287 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.20 Median:161.00 stddev:2.39 (1.5%) stddev-sans-first:2.50 05:52:50 INFO - PROCESS | 8287 | Values: 159.0 160.0 158.0 163.0 162.0 157.0 164.0 159.0 162.0 158.0 05:52:50 INFO - PROCESS | 8287 | 05:52:50 INFO - PROCESS | 8287 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:64.00 stddev:1.07 (1.7%) stddev-sans-first:1.13 05:52:50 INFO - PROCESS | 8287 | Values: 64.0 64.0 64.0 65.0 64.0 65.0 63.0 63.0 62.0 62.0 05:52:50 INFO - PROCESS | 8287 | -------- Summary: end -------- 05:52:50 INFO - PROCESS | 8287 | 05:52:51 INFO - TEST-INFO | 8287: exit 0 05:52:51 INFO - TEST-OK | kraken | took 61033ms 05:52:51 INFO - SUITE-END | took 1175s 05:52:51 INFO - Completed test suite (00:19:35) 05:52:51 INFO - javascript benchmark 05:52:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3068.186930463427, 3093.381323735252, 3093.4586447371703, 3119.5320701894707, 3131.2641529240623, 5284.9958507883475, 5373.032854086267, 5377.327834020747, 5423.430539793324, 5446.2919820423385, 5385.596080293974, 5412.404635490103, 5467.316585426822, 5489.780408783654, 5516.834494965157, 4879.585235255007, 4904.092742842586, 4976.129177393959, 4988.87527811804, 5057.418396884369, 4959.032988567231, 4987.975060124694, 5001.899962000758, 5013.3232013678235, 5018.372703412074, 4793.7363445010515, 4900.142475066885, 4966.8758281043265, 4968.031233909389, 4996.1756310208775, 4852.8544143675745, 4857.781399837016, 4874.610031197496, 4940.357753492023, 5032.622553308516, 4865.80787707014, 4901.975490122527, 4911.484294149134, 4932.136876046713, 4949.430815456232, 5245.79016839326, 5272.314599102092, 5334.653247538898, 5412.5940554458575, 5436.0, 5669.433056694339, 5711.314642242916, 5751.856203594902, 5757.712114394263, 5762.711864406805, 5802.013657678205, 5806.158107074492, 5806.651600903917, 5810.883782324372, 5812.302523697141, 5204.9219261711105, 5325.946740532584, 5354.464553544653, 5361.919571206435, 5363.356397232318, 5990.580659353804, 5994.0409534474275, 6012.218411606463, 6017.398260174035, 6018.067199584071, 5742.971285143548, 5753.769849206069, 5758.683272419973, 5758.971205143947, 5762.510186634183, 5644.379118296984, 5695.971520142372, 5703.9429605704245, 5714.942850571524, 5836.9124463133085, 5693.402192769782, 5732.914006289909, 5740.052891272893, 5782.653040817564, 5795.1017592273265, 5695.743691533891, 5732.455416735404, 5739.7704091836695, 5753.367129615739, 5760.279965004374, 4284.3145096784365, 4305.074409002017, 4305.332673435622, 4347.586979236968, 4357.346398040319, 3915.0799562102884, 3943.2704949584418, 3946.092398748304, 3947.684185265172, 3952.940705889414, 5414.83755487336, 5416.756245968941, 5417.647852889629, 5423.810166644149, 5425.782968681208, 5726.169705392778, 5738.053221218453, 5765.88468230633, 5775.075987841925, 5877.94122058774, 5436.429174936654, 5481.260029895992, 5484.177373394023, 5493.697846618475, 5536.086545719992, 5019.422766381913, 5020.1214787412055, 5020.146575082244, 5022.221555658879, 5063.822766203165, 5753.309602847685, 5760.711964401763, 5810.941890581124, 5978.461938425476, 5980.162777211194, 5622.943770562242, 5634.690092044813, 5640.407757185437, 5684.943150568524, 5684.943150568607, 5768.134779783066, 5774.740136693943, 5774.769009239583, 5779.162021506942, 5782.739776709974, 5458.890822183614, 5533.363663178625, 5534.557235421076, 5567.081431563746, 5626.43735626434, 5769.105788602773, 5775.047117225611, 5781.0, 5823.0, 5839.416058394297, 5595.860103497445, 5596.552275817843, 5597.160425936142, 5601.80393686219, 5609.943900560942, 5495.230667706444, 5588.748506317307, 5598.776048957996, 5613.298337707786, 5613.578981576316, 5478.890422191614, 5511.972440137773, 5564.360098588714, 5564.4991950724625, 5572.3034620672415, 5631.465010823965, 5650.660960342392, 5665.065264231355, 5674.517665998436, 5685.346185188756, 5504.9174262385295, 5533.833984980457, 5540.473655002768, 5548.195511650869, 5552.083906155439], "value": 5302.939814281414, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.3957235544148, 608.3156448994881, 617.5769597825487, 623.5821999260494, 653.8528831013026, 42699.35950960734, 43734.56265437345, 44001.77999110008, 44339.77830110849, 47362.0, 45795.31307030397, 46275.30587041197, 46286.305705414365, 46302.536974630246, 46328.53671463293, 8897.0, 8957.19385255327, 9015.954920225422, 9041.050689677588, 9092.318076144282, 8981.191692747652, 9061.048589898031, 9062.909370906305, 9064.320175986828, 9064.456132632064, 9116.270698344117, 9176.770580735501, 9194.58624361902, 9198.816023679556, 9199.678011269607, 9082.182603565678, 9112.544372781334, 9120.45277283365, 9124.771880702969, 9127.178553930178, 8994.28045756338, 9035.232005279493, 9054.094590540959, 9055.683051093247, 9061.864072038925, 42886.0, 43007.13985720268, 43080.78459607682, 43137.568624313986, 43164.0, 3637.163452405935, 3704.444333349992, 3716.1081340478363, 3743.7192210584317, 3767.171222331083, 32641.34717305664, 33238.833805831055, 33482.3303533928, 33577.83211083953, 34497.0, 4432.867013989586, 4476.171908196994, 4490.685652004361, 4584.954150458486, 4610.2623580227, 365576.0, 366530.0, 366615.1669241663, 366925.0, 366994.0, 52317.47682523126, 57771.42228577661, 59201.703991479764, 59580.404195958356, 59597.0, 55551.0, 60464.395356046756, 60477.0, 60501.39498605046, 60522.394776051675, 15597.298121584328, 15770.76343854843, 15777.211139442981, 15777.68444631101, 15788.131652759208, 11686.24039437434, 12154.209976351509, 12208.389580520938, 12328.32194229326, 12343.938280308541, 17479.388221412442, 17499.0, 17512.474625761246, 17619.55951101207, 17649.7352539712, 6848.623325717033, 6857.177138743283, 6965.965170174218, 7071.434285257167, 7121.67952442131, 947.1097168661436, 963.5760265483165, 967.9516024198762, 1103.3379972016726, 1123.4719681749564, 31752.682473175435, 33286.66713332884, 33296.66703332936, 33395.332093357996, 33425.66574334274, 1068.834330678746, 1094.9726256843483, 1128.7968165730083, 1130.4856290387854, 1165.825126231072, 17165.656686866194, 17526.123693815258, 17532.386366477112, 17540.298388064588, 17597.824021759876, 554993.0, 560330.0, 562649.0, 563270.0, 563539.0, 58880.0, 59026.70486647539, 59180.70409647924, 59402.40597594055, 59414.40585594175, 1247.133242396544, 1264.6016504801141, 1370.8080868678592, 1386.736520061185, 1395.337214822951, 31816.5227521592, 34109.488357674156, 34417.62329506792, 34534.30931381408, 34597.827010864785, 50723.239151413494, 51154.232686508985, 51252.74373628108, 51505.48494515007, 51517.227241590655, 393900.0, 395307.0, 395915.0, 396044.0, 396421.0, 27316.0, 27833.860830695718, 28037.299067523476, 29166.27084322909, 41853.79073104615, 45650.77174614106, 48732.0, 48932.75533622309, 49454.25818612652, 50301.74849125731, 40856.59143408647, 42555.14889702127, 43096.56903430926, 43260.0, 43274.567254327056, 42438.78780606077, 42460.51388201521, 42704.57295427006, 42728.14543709046, 43015.56984430116, 40510.18979620332, 41074.0, 41335.586644133175, 41366.0, 41410.0, 35372.292554148255, 37466.25067498689, 37738.86783396502, 37981.810090949366, 38451.615483844806, 28317.433651326446, 28399.574006389506, 28507.721612014055, 28666.283342916595, 28777.856110719313], "value": 20370.372041559393, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.88962366478216, 381.3631235836155, 389.92591407632557, 392.86446176069256, 414.2998332817538, 16728.247228874698, 18870.62258754826, 18983.24067037317, 19187.808121918777, 20072.297469588568, 18393.816061839378, 18927.0, 19151.23395064196, 19360.90319548404, 19700.901495492537, 5736.282964629421, 5741.655500669952, 5803.187553742479, 5928.584999050068, 5929.9703501482645, 5714.371419143911, 5737.655740655553, 5829.533637309005, 5845.561582881301, 5846.0, 5719.771209151629, 5794.5074668653215, 5818.1272809078555, 5821.243238379026, 5844.298684157886, 5667.603267771257, 5723.742431590588, 5781.797637082724, 5806.071028635441, 5839.182514447981, 5004.124278251292, 5134.0758663440565, 5185.299984502081, 5188.040212560651, 5193.63644544882, 23390.18134365306, 23549.175778847657, 23695.0, 23781.88109059461, 24124.0, 2194.4294483434423, 2338.8362814602983, 2634.5916382960672, 2652.4695060987688, 3109.6112985876766, 9040.909590904139, 9667.27495437845, 10138.087572118471, 10174.135198508136, 10554.155667546578, 1904.0, 1905.6950887857877, 1934.9129289182022, 1950.8341790947786, 1963.1950900131021, 82744.58627706883, 84334.57832710797, 84942.57528712317, 85567.57216213942, 86706.0, 10490.42302673345, 10732.731681707864, 10743.194260430499, 10783.56865725378, 10843.644544431945, 14755.852441475448, 14762.188079655722, 14768.778468322984, 14771.858080578257, 14784.852151478348, 7929.801754956172, 8187.590620468953, 8248.54632995191, 8380.748577542683, 8386.454880432751, 7969.641366138538, 7973.322267607318, 8024.2376974187355, 8229.506229626242, 8270.462419942685, 4398.978005110018, 4468.352088947085, 4504.662150338672, 4714.5521175488275, 4754.144254034307, 1862.8975406352781, 1909.5989842133308, 1924.2399252295265, 1926.248762982438, 1968.5767559974388, 888.5646033443695, 972.7957129002989, 975.5756246032856, 1074.2802322443981, 1082.4154956323498, 18095.72856407155, 18281.725774113398, 18651.533711657317, 18859.622807543772, 19260.22959081621, 1005.8591797148259, 1015.1777060580805, 1031.185363562777, 1047.3349423116376, 1056.0073530880948, 9909.75225619351, 10343.689689309333, 10346.172306215485, 10437.739056523496, 10485.528151233213, 452660.0, 458490.0, 463007.0, 502190.0, 512012.0, 87675.0, 88686.0, 89858.0, 91538.54230728804, 92114.53942730243, 969.7527130581798, 996.5465713100522, 1018.7809620931536, 1025.9435731034716, 1028.377831412, 15949.362025519313, 16273.104979225782, 16821.41125060617, 16838.831611683727, 17022.57443563921, 41151.176976460905, 41415.7929210352, 42951.57048429476, 43187.0, 44616.77691611651, 60399.698001509714, 61248.693756530934, 61377.69311153416, 62047.37952620416, 63240.68379658072, 7829.7259595913865, 7857.882131768142, 7890.250426209501, 7964.721234756756, 8146.83706325882, 12256.816147757612, 12622.684432889251, 12918.22490650564, 13333.333333333101, 13394.464221431033, 5557.166425036277, 9865.950670246602, 12017.158798883995, 12231.0, 12531.12282140278, 11217.158713096387, 11257.295380754163, 11442.94278528602, 11686.18196726255, 12005.459754311252, 11456.3698996556, 11479.311241325548, 11605.477753500943, 11839.408029598313, 12340.321282329558, 8124.268815806606, 8184.0, 8236.258736713724, 8270.586470676322, 8309.542975136426, 10754.946225268823, 11078.224524283223, 11649.650510484698, 12110.576129835414, 12136.453859576164], "value": 9134.176022770705, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1298.5909438526858, 1460.4304321314683, 1520.4070412539108, 1629.8125715542708, 1821.9908900455505, 7521.962390188049, 8673.956630216848, 8996.95501522493, 9017.458952462857, 9274.0, 9037.322200834931, 9115.361924665276, 9124.726258212248, 9129.452232866017, 9130.452172869633, 2302.2862912497094, 2334.719833619968, 2340.0873659272897, 2342.0631747301045, 2345.097137602027, 2227.175944900389, 2296.8621882687007, 2364.267077206063, 2364.302530753423, 2365.1603680693365, 2281.555096756133, 2289.244549298736, 2299.1722979727283, 2350.024739733017, 2351.824087956022, 2283.4976305212826, 2287.4052746286, 2289.473421113145, 2291.450051987519, 2292.4383526036063, 2275.82931280153, 2279.3845661671257, 2279.7948184663296, 2279.988600056989, 2283.6003699352545, 8814.735557933273, 9012.954935225347, 9050.366474346798, 9089.409188402798, 9094.590743416562, 5078.949210507884, 5241.056609810233, 5316.282301889273, 5332.14685650298, 5332.466753324637, 3361.83190840457, 3395.9151021224666, 3422.401079811048, 3455.272363818091, 3467.930641387183, 1070.5664205996584, 1089.5968491658136, 1101.6805126513302, 1113.432149603708, 1123.601121601836, 12849.67875803103, 12969.610911672758, 12999.480020799252, 13089.34553272342, 13097.148685335518, 4394.231009573312, 4506.188886000486, 4598.241290187082, 4658.95341046592, 4666.0901124280435, 11017.889821101846, 11035.39305338198, 11045.226834121535, 11061.336319820837, 11090.168237382228, 5238.659487133325, 5245.737713114329, 5246.081935661244, 5247.895042099137, 5248.527632513092, 4227.577242275748, 4663.48701642819, 4828.155072862235, 4846.466888642247, 4876.414830220397, 3866.2460820140363, 3925.8429662813737, 4004.2191772604647, 4026.033751899523, 4037.313656678372, 1230.3110258255406, 1253.185429470833, 1265.44320498982, 1277.5400855691944, 1281.9423125959354, 829.2205326992728, 945.6501094594906, 990.1979396688705, 1010.7321559786662, 1027.3168343051937, 6052.425019623129, 6082.665453400017, 6108.664023478663, 6110.388961103854, 6423.229212494437, 437.5930384742157, 448.1060284731981, 451.82153049545246, 455.46937817442307, 460.3899832721657, 4146.274401979642, 4154.771487568152, 4206.600372964564, 4235.110626768352, 4238.660907127422, 11145.331280123057, 11354.261972971895, 11416.543338266376, 11418.543258269576, 11458.77082458363, 10576.788464230673, 11064.114870810316, 11380.487878045507, 11401.429928503541, 11407.0, 8499.83000340002, 8608.139186081467, 8625.309975202093, 8660.653573857102, 8683.044865064838, 6196.659183744757, 6399.55203135776, 6429.099926010269, 6502.934970650422, 6663.900041499478, 10554.525046372779, 10751.086157676373, 10776.245662803842, 10798.514066866852, 10895.455227238448, 10911.0, 11064.778704425706, 11145.387003714874, 11170.553177872795, 11172.273802202832, 6875.5874647521305, 7824.921750782647, 7964.761057168294, 8319.667213311399, 8631.180037896389, 8627.87058194115, 9003.729888103368, 9011.954940225258, 9020.458772473672, 9021.90978090237, 7667.46327757074, 7759.340456061298, 7868.685252590061, 8154.38842086834, 8180.754577362689, 7738.342240909586, 7808.7657370278985, 7853.0, 7894.131645519104, 7954.721584744506, 7209.134903811576, 7219.169795473587, 7289.125304963438, 7308.926910731037, 7310.378617817332, 5364.14173732201, 5375.6774593524515, 5489.917651235155, 5497.312835895513, 5734.54123670097, 5501.119820828648, 5528.751206195811, 5574.470425309589, 5681.403452637579, 5721.370649228498], "value": 4650.626506945112, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.1174745798089, 329.94226010448165, 330.7849897566582, 333.36493978970054, 334.6937552139792, 5137.280780690707, 5157.432682404937, 5170.819021334254, 5175.482451754822, 5249.343832020997, 5170.0, 5170.974145129278, 5190.662606930547, 5192.324997750287, 5199.402068762093, 4106.5072191337085, 4109.383592461125, 4120.217158739845, 4139.586041395866, 4155.148194620111, 3981.2236613860164, 3993.0, 4140.420341152241, 4151.771652559108, 4175.0, 4099.959000410003, 4100.0, 4122.031322639177, 4136.090060186754, 4147.253494371012, 4119.7940102994735, 4120.7321524100835, 4123.7938103094875, 4133.276676581616, 4159.708820382574, 3471.9132021699406, 3527.7883327000463, 3637.7089832813576, 3672.687821535146, 3717.9551246814144, 5036.219385995177, 5039.798408063673, 5049.34358533392, 5063.392392912837, 5067.594592432597, 4671.416072990876, 4680.7191568506, 4701.529847015306, 4706.058788242365, 4717.174494463455, 5247.212918062283, 5334.653247538898, 5412.5940554458575, 5438.184272359138, 5442.292501974718, 3974.841006359742, 4013.4581831452674, 4025.3156963316305, 4031.4154447604933, 4037.232925744129, 5674.120511320752, 5675.2054712340305, 5691.686957217351, 5705.400932902068, 5716.371199168088, 4008.3987401889367, 4103.97948010264, 4122.690798190148, 4139.379093135994, 4140.710150289511, 4167.124903770182, 4192.874213773592, 4194.3498757692, 4207.389928460356, 4210.705250632487, 4697.224957881979, 4723.929141062887, 4734.692245004064, 4736.573708366263, 4747.2879068140055, 5373.811916582979, 5437.211604317352, 5459.12653975362, 5464.672119672753, 5503.0189131912475, 1432.8352239492592, 1445.4579532675248, 1445.515752222996, 1446.2985452055746, 1450.4995776457106, 896.3411892259185, 950.4772375193616, 956.9138777510058, 967.2068903499204, 967.8354679704468, 4714.434267887876, 4731.976340118277, 4736.218523943579, 4739.928901066487, 4775.0, 4961.603071754251, 5359.598030147677, 5447.53695935842, 5600.719964001865, 5683.431656834284, 5305.151175811851, 5313.840584782385, 5319.335083114611, 5340.973295133499, 5349.304590403222, 2907.4621195078557, 2964.8733481276977, 2965.733084022448, 2983.9858095785257, 2991.446582382266, 5750.856228594235, 5795.652260864277, 5812.912806307909, 5830.650160990354, 5842.474177323977, 5730.5129064030025, 5745.482906538432, 5749.712514374264, 5757.107648314518, 5765.913511297334, 5453.445767956114, 5699.686517241592, 5758.1362795581, 5800.361960184377, 5821.534277257894, 5579.330480342385, 5598.236555485009, 5607.327120745374, 5641.774329026793, 5651.519620832275, 5343.198520221842, 5561.63849349791, 5586.273784408001, 5589.580781441489, 5620.437956204347, 5746.224259724883, 5781.913271301018, 5794.333651630117, 5797.710114494174, 5799.594028417971, 4155.16896620671, 4157.210130075276, 4168.0, 4183.665306775511, 4183.728057676241, 5373.0, 5611.0, 5622.746976385991, 5646.632968857011, 5676.0, 5346.198070289488, 5402.297701298806, 5408.999335122858, 5427.213054107211, 5459.153831156177, 5394.811181608625, 5395.81114660985, 5416.539594134385, 5447.455254474521, 5472.863178420572, 5245.265662807134, 5328.387235467816, 5382.327209098863, 5409.864753381197, 5418.810341638024, 5461.808836690697, 5470.452954704498, 5472.303585888388, 5472.972635136799, 5479.0, 5187.636865419385, 5245.632805703564, 5286.2511494023665, 5303.602229832855, 5385.9192112119135], "value": 4183.361582748302, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [722.0252658910475, 744.9979777199668, 774.635921117075, 809.4697972827796, 856.9014563325218, 15560.144192069445, 16679.0, 16697.66604667906, 16703.331866725333, 16720.665586688257, 15430.382784688627, 15740.527784166494, 16094.678106437865, 16587.41944031959, 16634.33462661492, 661.1339145719099, 797.9640916158758, 816.5631387207845, 835.4611275727152, 835.9289460395873, 824.9917500824974, 830.5182993863544, 831.4055450352996, 834.0325222741621, 834.1741675741033, 879.2570278115014, 880.1286726141107, 880.454118446564, 880.6257340630239, 881.7971866470716, 690.858374033322, 839.6809212499272, 875.4222213339198, 875.5578432891413, 875.7022612311813, 622.8972219583809, 628.9716962736687, 629.6064959400375, 629.8267976306506, 630.1681780050335, 15729.764053539206, 15835.524934251876, 15844.207789610473, 15876.206189690585, 15893.602659933478, 14776.335064921997, 14785.408583656641, 14859.925700371537, 14866.628334291621, 15132.848671513255, 13632.522861699892, 13638.386272617658, 13795.724085518334, 13892.583222503341, 13983.37074831635, 4729.834455794031, 4751.976240118777, 4897.118518666639, 4934.3338649282605, 4955.380577427822, 69817.0, 70860.6456967717, 90644.54677726568, 91533.5423322879, 92942.5352873238, 11939.343336116423, 12302.323372214436, 12344.938275308745, 12374.257544547176, 12568.371581420892, 23023.309300721005, 23028.194013209457, 23172.65241021386, 23174.53650926972, 23180.884095579753, 9021.32340074484, 9021.594028268612, 9062.275017998545, 9139.77150571241, 9377.859332110023, 4702.003297197355, 4904.803807847647, 4971.825986090542, 5021.372328458942, 5121.692698438105, 3572.9464058039152, 3649.069487280726, 3667.064898450878, 3679.282539904693, 3679.466477360768, 633.8890694128509, 637.3467196123918, 638.0078977190514, 638.8850006998784, 660.5871330418488, 625.5996162456032, 683.8392977650249, 729.6023667101442, 749.9550026998397, 783.8471498057824, 10020.549075291628, 10242.0, 10497.527611257512, 10653.414062226651, 10750.408727520062, 624.8312955501989, 727.66163733864, 728.50461686054, 735.2243383230636, 754.3776384482824, 4829.710217386968, 4869.016390994591, 4964.875878103004, 5018.873200055929, 5053.0904437200925, 65501.67249163723, 66053.0, 66053.33946660472, 66157.33842661609, 87418.0, 96793.51603241939, 99383.50308248412, 100156.49921750344, 100672.0, 101655.0, 86334.56832715921, 88017.0, 88630.0, 89705.55147224222, 92353.5382323084, 9448.811023779348, 9746.707598772047, 9835.508224588599, 9917.504124793875, 9919.801603968024, 49619.50380496149, 50385.465308122446, 50892.49107508877, 50971.74514127554, 51362.0, 42779.144417112104, 42954.0, 43199.35200972051, 68902.0, 69734.65132674304, 12930.159539629894, 13103.934480327538, 13171.67070823237, 13286.0, 13308.667283317995, 13548.390322435316, 14135.575932722035, 14170.220637864604, 14215.289235537975, 14375.424983000981, 13003.804942926054, 13167.613072310975, 13287.667808304483, 13473.326333683473, 13581.388837502534, 13037.869621303666, 13166.802497962346, 13276.867231327564, 14027.36876840565, 14200.360983755549, 12962.611121666365, 13288.269145197108, 13340.066195366619, 13450.192988420726, 13792.0, 10279.691609251735, 10359.533820978224, 10502.422366769595, 10657.840132398176, 10689.786204276026, 10288.588456461957, 10668.862933014063, 10811.13510919109, 10979.560817567528, 10985.0], "value": 7613.344610025151, "unit": "score"}], "name": "dromaeo_css", "value": 7257.837259486716, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 110.0, 109.0, 110.0, 110.0, 108.0, 109.0, 111.0, 109.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 115.0, 120.0, 177.0, 122.0, 132.0, 151.0, 117.0, 152.0, 117.0], "value": 134.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 160.0, 159.0, 162.0, 162.0, 161.0, 162.0, 161.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 132.0, 76.0, 77.0, 75.0, 75.0, 101.0, 74.0], "value": 83.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 125.0, 83.0, 83.0, 84.0, 119.0, 83.0, 83.0, 126.0], "value": 95.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 51.0, 51.0, 51.0, 51.0, 53.0, 53.0, 52.0, 52.0, 51.0], "value": 52.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 64.0, 64.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0], "value": 63.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 81.0, 76.0, 76.0, 76.0, 76.0, 76.0, 75.0, 80.0], "value": 76.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 123.0, 136.0, 121.0, 152.0, 122.0, 118.0, 127.0, 179.0, 127.0], "value": 132.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 158.0, 163.0, 162.0, 157.0, 164.0, 159.0, 162.0, 158.0], "value": 160.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 65.0, 64.0, 65.0, 63.0, 63.0, 62.0, 62.0], "value": 63.6, "unit": "score"}], "name": "kraken", "value": 1489.0, "alertThreshold": 2.0}]} 05:52:52 INFO - Return code: 0 05:52:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:52:52 INFO - # TBPL SUCCESS # 05:52:52 INFO - Running post-action listener: _resource_record_post_action 05:52:52 INFO - [mozharness: 2016-07-28 12:52:52.138461Z] Finished run-tests step (success) 05:52:52 INFO - Running post-run listener: _resource_record_post_run 05:52:52 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 554643456; Read time: 20; Write time: 587352 05:52:52 INFO - TinderboxPrint: CPU usage
13.0% 05:52:52 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 05:52:52 INFO - TinderboxPrint: I/O write bytes / time
554,643,456 / 587,352 05:52:52 INFO - TinderboxPrint: CPU idle
8,280.7 (87.0%) 05:52:52 INFO - TinderboxPrint: CPU user
1,197.1 (12.6%) 05:52:52 INFO - TinderboxPrint: Swap in / out
0 / 0 05:52:52 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 257474560; Read time: 0; Write time: 303644 05:52:52 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 297168896; Read time: 0; Write time: 283708 05:52:52 INFO - Running post-run listener: _upload_blobber_files 05:52:52 INFO - Blob upload gear active. 05:52:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:52:52 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 05:52:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:52:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:52:53 INFO - (blobuploader) - INFO - Open directory for files ... 05:52:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:52:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:52:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:53:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:53:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:53:01 INFO - (blobuploader) - INFO - Done attempting. 05:53:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:53:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:53:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:53:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:53:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:53:01 INFO - (blobuploader) - INFO - Done attempting. 05:53:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:53:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:53:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:53:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:53:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:53:02 INFO - (blobuploader) - INFO - Done attempting. 05:53:02 INFO - (blobuploader) - INFO - Iteration through files over. 05:53:02 INFO - Return code: 0 05:53:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:53:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:53:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d44fa11fd20f63391b5d7162dfba4b4aa814f391b966358ec6df360550f022a5985190b2e9dedcf40749a1f50a61217fc8ead144543928412b2053d80a779539", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3e3798b231f1104bf68736d961523fb182da5a487d8610f01006e6ffa9b0e02da6fae037eff72b1ae6117eef7cb82b6173daced87b2f6c8f37a28bd41649743e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/430793811f6bcd73e586e901a6bcdcfe24cc3f0990320bd7302c3c3d51ad044cdd9fc4434906ea0adaf65904bb00773d6137734bfe14cd669bcf22a7483fddee"} 05:53:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:53:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:53:02 INFO - Contents: 05:53:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d44fa11fd20f63391b5d7162dfba4b4aa814f391b966358ec6df360550f022a5985190b2e9dedcf40749a1f50a61217fc8ead144543928412b2053d80a779539", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3e3798b231f1104bf68736d961523fb182da5a487d8610f01006e6ffa9b0e02da6fae037eff72b1ae6117eef7cb82b6173daced87b2f6c8f37a28bd41649743e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/430793811f6bcd73e586e901a6bcdcfe24cc3f0990320bd7302c3c3d51ad044cdd9fc4434906ea0adaf65904bb00773d6137734bfe14cd669bcf22a7483fddee"} 05:53:02 INFO - Running post-run listener: copy_logs_to_upload_dir 05:53:02 INFO - Copying logs to upload dir... 05:53:02 INFO - mkdir: /builds/slave/test/build/upload/logs 05:53:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.247522 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-07-28 05:53:02.499045) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-28 05:53:02.502782) ========= 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=20e666a3d4cfbb71505a330e000001b4-1469709144.393428-1291125723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d44fa11fd20f63391b5d7162dfba4b4aa814f391b966358ec6df360550f022a5985190b2e9dedcf40749a1f50a61217fc8ead144543928412b2053d80a779539", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3e3798b231f1104bf68736d961523fb182da5a487d8610f01006e6ffa9b0e02da6fae037eff72b1ae6117eef7cb82b6173daced87b2f6c8f37a28bd41649743e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/430793811f6bcd73e586e901a6bcdcfe24cc3f0990320bd7302c3c3d51ad044cdd9fc4434906ea0adaf65904bb00773d6137734bfe14cd669bcf22a7483fddee"} build_url:https://queue.taskcluster.net/v1/task/HvmjPUWjR8K0aQlKkETNnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011452 build_url: 'https://queue.taskcluster.net/v1/task/HvmjPUWjR8K0aQlKkETNnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d44fa11fd20f63391b5d7162dfba4b4aa814f391b966358ec6df360550f022a5985190b2e9dedcf40749a1f50a61217fc8ead144543928412b2053d80a779539", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3e3798b231f1104bf68736d961523fb182da5a487d8610f01006e6ffa9b0e02da6fae037eff72b1ae6117eef7cb82b6173daced87b2f6c8f37a28bd41649743e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/430793811f6bcd73e586e901a6bcdcfe24cc3f0990320bd7302c3c3d51ad044cdd9fc4434906ea0adaf65904bb00773d6137734bfe14cd669bcf22a7483fddee"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-28 05:53:02.528278) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 05:53:02.528647) ========= 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=20e666a3d4cfbb71505a330e000001b4-1469709144.393428-1291125723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004423 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 05:53:02.612359) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 05:53:02.612670) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 05:53:02.612968) ========= ========= Total master_lag: 0.17 =========