builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-032 starttime: 1466777723.8 results: success (0) buildid: 20160624043346 builduid: af622a2eb9a54899be2d6e4de0da44ed revision: 939ecc4e9d055c263633cbe276bfb634a68fe4c5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 07:15:23.804482) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 07:15:23.805443) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 07:15:23.806001) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 07:15:23.822211) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 07:15:23.822845) ========= 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=745a4373a2a16df560f216e000000264-1466777723.158442-1431706717 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-24 07:15:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-06-24 07:15:23 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.079398 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 07:15:23.921123) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 07:15:23.921782) ========= 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=745a4373a2a16df560f216e000000264-1466777723.158442-1431706717 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016396 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 07:15:23.975454) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-24 07:15:23.976173) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 939ecc4e9d055c263633cbe276bfb634a68fe4c5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 939ecc4e9d055c263633cbe276bfb634a68fe4c5 --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=745a4373a2a16df560f216e000000264-1466777723.158442-1431706717 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-24 07:15:24,105 truncating revision to first 12 chars 2016-06-24 07:15:24,105 Setting DEBUG logging. 2016-06-24 07:15:24,105 attempt 1/10 2016-06-24 07:15:24,105 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/939ecc4e9d05?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-24 07:15:25,228 unpacking tar archive at: mozilla-central-939ecc4e9d05/testing/mozharness/ program finished with exit code 0 elapsedTime=1.466817 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-24 07:15:25.461532) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 07:15:25.462264) ========= script_repo_revision: 939ecc4e9d055c263633cbe276bfb634a68fe4c5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 07:15:25.462995) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 07:15:25.463632) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 07:15:25.475558) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-24 07:15:25.475866) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1466777723.158442-1431706717 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:15:25 INFO - MultiFileLogger online at 20160624 07:15:25 in /builds/slave/test 07:15:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:15:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:15:25 INFO - {'append_to_log': False, 07:15:25 INFO - 'base_work_dir': '/builds/slave/test', 07:15:25 INFO - 'blob_upload_branch': 'Firefox', 07:15:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:15:25 INFO - 'branch': 'Firefox', 07:15:25 INFO - 'buildbot_json_path': 'buildprops.json', 07:15:25 INFO - 'config_files': ('talos/linux_config.py',), 07:15:25 INFO - 'default_actions': ('clobber', 07:15:25 INFO - 'read-buildbot-config', 07:15:25 INFO - 'download-and-extract', 07:15:25 INFO - 'populate-webroot', 07:15:25 INFO - 'create-virtualenv', 07:15:25 INFO - 'install', 07:15:25 INFO - 'run-tests'), 07:15:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:15:25 INFO - 'download_minidump_stackwalk': True, 07:15:25 INFO - 'download_symbols': 'ondemand', 07:15:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:15:25 INFO - 'tooltool.py': '/tools/tooltool.py', 07:15:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:15:25 INFO - '/tools/misc-python/virtualenv.py')}, 07:15:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:15:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:15:25 INFO - 'installer_path': 'installer.exe', 07:15:25 INFO - 'log_level': 'info', 07:15:25 INFO - 'log_name': 'talos', 07:15:25 INFO - 'log_to_console': True, 07:15:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:15:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:15:25 INFO - 'opt_config_files': (), 07:15:25 INFO - 'pip_index': False, 07:15:25 INFO - 'sps_profile': False, 07:15:25 INFO - 'sps_profile_interval': 0, 07:15:25 INFO - 'suite': 'dromaeojs', 07:15:25 INFO - 'system_bits': '32', 07:15:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:15:25 INFO - 'title': 'talos-linux64-ix-032', 07:15:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:15:25 INFO - 'use_talos_json': True, 07:15:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:15:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:15:25 INFO - 'work_dir': 'build'} 07:15:25 INFO - ##### 07:15:25 INFO - ##### Running clobber step. 07:15:25 INFO - ##### 07:15:25 INFO - Running pre-action listener: _resource_record_pre_action 07:15:25 INFO - Running main action method: clobber 07:15:25 INFO - rmtree: /builds/slave/test/build 07:15:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:15:26 INFO - Running post-action listener: _resource_record_post_action 07:15:26 INFO - ##### 07:15:26 INFO - ##### Finished clobber step (success) 07:15:26 INFO - ##### 07:15:26 INFO - ##### 07:15:26 INFO - ##### Running read-buildbot-config step. 07:15:26 INFO - ##### 07:15:26 INFO - Running pre-action listener: _resource_record_pre_action 07:15:26 INFO - Running main action method: read_buildbot_config 07:15:26 INFO - Using buildbot properties: 07:15:26 INFO - { 07:15:26 INFO - "project": "", 07:15:26 INFO - "product": "firefox", 07:15:26 INFO - "script_repo_revision": "production", 07:15:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:15:26 INFO - "repository": "", 07:15:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 07:15:26 INFO - "buildid": "20160624043346", 07:15:26 INFO - "pgo_build": "True", 07:15:26 INFO - "basedir": "/builds/slave/test", 07:15:26 INFO - "buildnumber": 790, 07:15:26 INFO - "slavename": "talos-linux64-ix-032", 07:15:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:15:26 INFO - "platform": "ubuntu64_hw", 07:15:26 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:15:26 INFO - "branch": "mozilla-central", 07:15:26 INFO - "repo_path": "mozilla-central", 07:15:26 INFO - "revision": "939ecc4e9d055c263633cbe276bfb634a68fe4c5", 07:15:26 INFO - "stage_platform": "linux64-pgo", 07:15:26 INFO - "builduid": "af622a2eb9a54899be2d6e4de0da44ed", 07:15:26 INFO - "slavebuilddir": "test" 07:15:26 INFO - } 07:15:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/CN545vF6TpaQoGM-19uF0A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:15:26 INFO - Running post-action listener: _resource_record_post_action 07:15:26 INFO - ##### 07:15:26 INFO - ##### Finished read-buildbot-config step (success) 07:15:26 INFO - ##### 07:15:26 INFO - ##### 07:15:26 INFO - ##### Running download-and-extract step. 07:15:26 INFO - ##### 07:15:26 INFO - Running pre-action listener: _resource_record_pre_action 07:15:26 INFO - Running main action method: download_and_extract 07:15:26 INFO - mkdir: /builds/slave/test/build/tests 07:15: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')]} 07:15:26 INFO - https://queue.taskcluster.net/v1/task/CN545vF6TpaQoGM-19uF0A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:15:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CN545vF6TpaQoGM-19uF0A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:15:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CN545vF6TpaQoGM-19uF0A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:15:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CN545vF6TpaQoGM-19uF0A/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 07:15:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CN545vF6TpaQoGM-19uF0A/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 07:15:27 INFO - Downloaded 1361 bytes. 07:15:27 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:15:27 INFO - Using the following test package requirements: 07:15:27 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:15:27 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:15:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:15:27 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:15:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:15:27 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:15:27 INFO - u'jsshell-linux-x86_64.zip'], 07:15:27 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:15:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:15:27 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:15:27 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:15:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:15:27 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:15:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:15:27 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:15:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:15:27 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:15:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:15:27 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:15: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')]} 07:15:27 INFO - https://queue.taskcluster.net/v1/task/CN545vF6TpaQoGM-19uF0A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:15:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CN545vF6TpaQoGM-19uF0A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:15:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CN545vF6TpaQoGM-19uF0A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:15:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CN545vF6TpaQoGM-19uF0A/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 07:15:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CN545vF6TpaQoGM-19uF0A/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 07:15:28 INFO - Downloaded 24277266 bytes. 07:15:28 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'] 07:15:28 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 07:15:29 INFO - Return code: 0 07:15:29 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 07:15:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:29 INFO - https://queue.taskcluster.net/v1/task/CN545vF6TpaQoGM-19uF0A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:15:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CN545vF6TpaQoGM-19uF0A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:15:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CN545vF6TpaQoGM-19uF0A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:15:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CN545vF6TpaQoGM-19uF0A/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 07:15:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CN545vF6TpaQoGM-19uF0A/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 07:15:31 INFO - Downloaded 24277266 bytes. 07:15: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'] 07:15: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 07:15:33 INFO - Return code: 0 07:15: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')]} 07:15:33 INFO - https://queue.taskcluster.net/v1/task/CN545vF6TpaQoGM-19uF0A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:15:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CN545vF6TpaQoGM-19uF0A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:15:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CN545vF6TpaQoGM-19uF0A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:15:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CN545vF6TpaQoGM-19uF0A/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 07:15:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CN545vF6TpaQoGM-19uF0A/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 07:15:34 INFO - Downloaded 14405518 bytes. 07:15:34 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'] 07:15:34 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 07:15:34 INFO - Return code: 0 07:15:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:34 INFO - https://queue.taskcluster.net/v1/task/CN545vF6TpaQoGM-19uF0A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:15:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CN545vF6TpaQoGM-19uF0A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:15:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CN545vF6TpaQoGM-19uF0A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:15:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CN545vF6TpaQoGM-19uF0A/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 07:15:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CN545vF6TpaQoGM-19uF0A/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 07:15:35 INFO - Downloaded 60154878 bytes. 07:15:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CN545vF6TpaQoGM-19uF0A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:15:35 INFO - mkdir: /builds/slave/test/properties 07:15:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:15:35 INFO - Writing to file /builds/slave/test/properties/build_url 07:15:35 INFO - Contents: 07:15:35 INFO - build_url:https://queue.taskcluster.net/v1/task/CN545vF6TpaQoGM-19uF0A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:15:36 INFO - Running post-action listener: _resource_record_post_action 07:15:36 INFO - Running post-action listener: set_extra_try_arguments 07:15:36 INFO - ##### 07:15:36 INFO - ##### Finished download-and-extract step (success) 07:15:36 INFO - ##### 07:15:36 INFO - ##### 07:15:36 INFO - ##### Running populate-webroot step. 07:15:36 INFO - ##### 07:15:36 INFO - Running pre-action listener: _resource_record_pre_action 07:15:36 INFO - Running main action method: populate_webroot 07:15:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:15:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:15:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:15:36 INFO - '--tppagecycles', 07:15:36 INFO - '7'], 07:15:36 INFO - 'tests': ['tsvgm']}}, 07:15:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:15:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:15:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:15:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:15:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:15:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:15:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:36 INFO - 'talos_options': ['--disable-e10s'], 07:15:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:15:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:15:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:36 INFO - 'talos_options': ['--disable-e10s'], 07:15:36 INFO - 'tests': ['damp', 'tps']}, 07:15:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:36 INFO - 'tests': ['damp', 'tps']}, 07:15:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:15:36 INFO - 'tests': ['dromaeo_dom']}, 07:15:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:15:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:15:36 INFO - 'tests': ['basic_compositor_video']}, 07:15:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:15:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:15:36 INFO - 'tests': ['a11yr', 07:15:36 INFO - 'ts_paint', 07:15:36 INFO - 'tpaint', 07:15:36 INFO - 'sessionrestore', 07:15:36 INFO - 'sessionrestore_no_auto_restore', 07:15:36 INFO - 'tabpaint']}, 07:15:36 INFO - 'other-e10s': {'tests': ['a11yr', 07:15:36 INFO - 'ts_paint', 07:15:36 INFO - 'tpaint', 07:15:36 INFO - 'sessionrestore', 07:15:36 INFO - 'sessionrestore_no_auto_restore', 07:15:36 INFO - 'tabpaint']}, 07:15:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:15:36 INFO - 'ts_paint', 07:15:36 INFO - 'tpaint', 07:15:36 INFO - 'sessionrestore', 07:15:36 INFO - 'sessionrestore_no_auto_restore', 07:15:36 INFO - 'tabpaint']}, 07:15:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:15:36 INFO - 'ts_paint', 07:15:36 INFO - 'tpaint', 07:15:36 INFO - 'sessionrestore', 07:15:36 INFO - 'sessionrestore_no_auto_restore', 07:15:36 INFO - 'tabpaint']}, 07:15:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:15:36 INFO - 'tests': ['a11yr', 07:15:36 INFO - 'ts_paint', 07:15:36 INFO - 'tpaint', 07:15:36 INFO - 'sessionrestore', 07:15:36 INFO - 'sessionrestore_no_auto_restore', 07:15:36 INFO - 'tabpaint']}, 07:15:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:15:36 INFO - 'tests': ['a11yr', 07:15:36 INFO - 'ts_paint', 07:15:36 INFO - 'tpaint', 07:15:36 INFO - 'sessionrestore', 07:15:36 INFO - 'sessionrestore_no_auto_restore', 07:15:36 INFO - 'tabpaint']}, 07:15:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:15:36 INFO - 'tests': ['tsvgx', 07:15:36 INFO - 'tsvgr_opacity', 07:15:36 INFO - 'tart', 07:15:36 INFO - 'tscrollx', 07:15:36 INFO - 'cart']}, 07:15:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:15:36 INFO - 'tsvgr_opacity', 07:15:36 INFO - 'tart', 07:15:36 INFO - 'tscrollx', 07:15:36 INFO - 'cart']}, 07:15:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:36 INFO - 'talos_options': ['--disable-e10s'], 07:15:36 INFO - 'tests': ['tp5o']}, 07:15:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:36 INFO - 'tests': ['tp5o']}, 07:15:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:36 INFO - 'talos_options': ['--disable-e10s', 07:15:36 INFO - '--xperf_path', 07:15:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:15:36 INFO - 'tests': ['tp5n']}, 07:15:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:36 INFO - 'talos_options': ['--xperf_path', 07:15:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:15:36 INFO - 'tests': ['tp5n']}}, 07:15:36 INFO - 'talos.zip': {'path': '', 07:15:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:15:36 INFO - Running post-action listener: _resource_record_post_action 07:15:36 INFO - ##### 07:15:36 INFO - ##### Finished populate-webroot step (success) 07:15:36 INFO - ##### 07:15:36 INFO - ##### 07:15:36 INFO - ##### Running create-virtualenv step. 07:15:36 INFO - ##### 07:15:36 INFO - Running pre-action listener: _resource_record_pre_action 07:15:36 INFO - Running main action method: create_virtualenv 07:15:36 INFO - Creating virtualenv /builds/slave/test/build/venv 07:15:36 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 07:15:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:15:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:15:36 INFO - Using real prefix '/usr' 07:15:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:15:37 INFO - Installing distribute.............................................................................................................................................................................................done. 07:15:39 INFO - Installing pip.................done. 07:15:39 INFO - Return code: 0 07:15:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:15: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')]} 07:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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')]} 07:15:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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 0x7fca706a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252e110>, '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 0x249a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249a6c0>, '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': '745a4373a2a16df560f216e000000264-1466777723.158442-1431706717', '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 07:15: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 07:15: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 07:15:39 INFO - Using env: {'DISPLAY': ':0', 07:15:39 INFO - 'HOME': '/home/cltbld', 07:15:39 INFO - 'LANG': 'en_US.UTF-8', 07:15:39 INFO - 'LANGUAGE': 'en_US:en', 07:15:39 INFO - 'LOGNAME': 'cltbld', 07:15:39 INFO - 'MAIL': '/var/mail/cltbld', 07:15:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:39 INFO - 'MOZ_NO_REMOTE': '1', 07:15:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:39 INFO - 'NO_EM_RESTART': '1', 07:15:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:39 INFO - 'PWD': '/builds/slave/test', 07:15:39 INFO - 'SHELL': '/bin/bash', 07:15:39 INFO - 'SHLVL': '1', 07:15:39 INFO - 'TERM': 'linux', 07:15:39 INFO - 'TMOUT': '86400', 07:15:39 INFO - 'USER': 'cltbld', 07:15:39 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1466777723.158442-1431706717', 07:15:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:39 INFO - '_': '/tools/buildbot/bin/python'} 07:15:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:39 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 07:15:39 INFO - Cleaning up... 07:15:39 INFO - Return code: 0 07:15:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:15: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')]} 07:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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')]} 07:15:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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', '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 0x7fca706a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252e110>, '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 0x249a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249a6c0>, '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': '745a4373a2a16df560f216e000000264-1466777723.158442-1431706717', '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 07:15: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', 'psutil>=3.1.1'] in /builds/slave/test/build 07:15: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 psutil>=3.1.1 07:15:39 INFO - Using env: {'DISPLAY': ':0', 07:15:39 INFO - 'HOME': '/home/cltbld', 07:15:39 INFO - 'LANG': 'en_US.UTF-8', 07:15:39 INFO - 'LANGUAGE': 'en_US:en', 07:15:39 INFO - 'LOGNAME': 'cltbld', 07:15:39 INFO - 'MAIL': '/var/mail/cltbld', 07:15:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:39 INFO - 'MOZ_NO_REMOTE': '1', 07:15:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:39 INFO - 'NO_EM_RESTART': '1', 07:15:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:39 INFO - 'PWD': '/builds/slave/test', 07:15:39 INFO - 'SHELL': '/bin/bash', 07:15:39 INFO - 'SHLVL': '1', 07:15:39 INFO - 'TERM': 'linux', 07:15:39 INFO - 'TMOUT': '86400', 07:15:39 INFO - 'USER': 'cltbld', 07:15:39 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1466777723.158442-1431706717', 07:15:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:39 INFO - '_': '/tools/buildbot/bin/python'} 07:15:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:39 INFO - Downloading/unpacking psutil>=3.1.1 07:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:15:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:15:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:15:41 INFO - Installing collected packages: psutil 07:15:41 INFO - Running setup.py install for psutil 07:15:41 INFO - building 'psutil._psutil_linux' extension 07:15:41 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 07:15: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 07:15:42 INFO - building 'psutil._psutil_posix' extension 07:15: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 07:15: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 07:15:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:15:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:15:42 INFO - Successfully installed psutil 07:15:42 INFO - Cleaning up... 07:15:42 INFO - Return code: 0 07:15:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:15: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')]} 07:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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')]} 07:15:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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 0x7fca706a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252e110>, '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 0x249a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249a6c0>, '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': '745a4373a2a16df560f216e000000264-1466777723.158442-1431706717', '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 07:15: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 07:15: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 07:15:42 INFO - Using env: {'DISPLAY': ':0', 07:15:42 INFO - 'HOME': '/home/cltbld', 07:15:42 INFO - 'LANG': 'en_US.UTF-8', 07:15:42 INFO - 'LANGUAGE': 'en_US:en', 07:15:42 INFO - 'LOGNAME': 'cltbld', 07:15:42 INFO - 'MAIL': '/var/mail/cltbld', 07:15:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:42 INFO - 'MOZ_NO_REMOTE': '1', 07:15:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:42 INFO - 'NO_EM_RESTART': '1', 07:15:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:42 INFO - 'PWD': '/builds/slave/test', 07:15:42 INFO - 'SHELL': '/bin/bash', 07:15:42 INFO - 'SHLVL': '1', 07:15:42 INFO - 'TERM': 'linux', 07:15:42 INFO - 'TMOUT': '86400', 07:15:42 INFO - 'USER': 'cltbld', 07:15:42 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1466777723.158442-1431706717', 07:15:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:42 INFO - '_': '/tools/buildbot/bin/python'} 07:15:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:15:42 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 07:15:42 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 07:15:42 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 07:15:42 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 07:15:42 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 07:15:42 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 07:15:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:15:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:15:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:15:44 INFO - Installing collected packages: mozsystemmonitor 07:15:44 INFO - Running setup.py install for mozsystemmonitor 07:15:44 INFO - Successfully installed mozsystemmonitor 07:15:44 INFO - Cleaning up... 07:15:44 INFO - Return code: 0 07:15:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:15:44 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')]} 07:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:44 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')]} 07:15:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:44 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 0x7fca706a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252e110>, '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 0x249a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249a6c0>, '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': '745a4373a2a16df560f216e000000264-1466777723.158442-1431706717', '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 07:15:44 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 07:15:44 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 07:15:44 INFO - Using env: {'DISPLAY': ':0', 07:15:44 INFO - 'HOME': '/home/cltbld', 07:15:44 INFO - 'LANG': 'en_US.UTF-8', 07:15:44 INFO - 'LANGUAGE': 'en_US:en', 07:15:44 INFO - 'LOGNAME': 'cltbld', 07:15:44 INFO - 'MAIL': '/var/mail/cltbld', 07:15:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:44 INFO - 'MOZ_NO_REMOTE': '1', 07:15:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:44 INFO - 'NO_EM_RESTART': '1', 07:15:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:44 INFO - 'PWD': '/builds/slave/test', 07:15:44 INFO - 'SHELL': '/bin/bash', 07:15:44 INFO - 'SHLVL': '1', 07:15:44 INFO - 'TERM': 'linux', 07:15:44 INFO - 'TMOUT': '86400', 07:15:44 INFO - 'USER': 'cltbld', 07:15:44 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1466777723.158442-1431706717', 07:15:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:44 INFO - '_': '/tools/buildbot/bin/python'} 07:15:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:44 INFO - Downloading/unpacking jsonschema==2.5.1 07:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:15:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:15:46 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 07:15:46 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 07:15:46 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 07:15:46 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 07:15:46 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 07:15:46 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 07:15:46 INFO - Downloading functools32-3.2.3-2.tar.gz 07:15:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:15:47 INFO - warning: no files found matching '*.txt' 07:15:47 INFO - no previously-included directories found matching 'build' 07:15:47 INFO - no previously-included directories found matching 'dist' 07:15:47 INFO - no previously-included directories found matching '.git*' 07:15:47 INFO - Installing collected packages: jsonschema, functools32 07:15:47 INFO - Running setup.py install for functools32 07:15:47 INFO - warning: no files found matching '*.txt' 07:15:47 INFO - no previously-included directories found matching 'build' 07:15:47 INFO - no previously-included directories found matching 'dist' 07:15:47 INFO - no previously-included directories found matching '.git*' 07:15:47 INFO - Successfully installed jsonschema functools32 07:15:47 INFO - Cleaning up... 07:15:47 INFO - Return code: 0 07:15:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:15: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')]} 07:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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')]} 07:15:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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 0x7fca706a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252e110>, '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 0x249a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249a6c0>, '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': '745a4373a2a16df560f216e000000264-1466777723.158442-1431706717', '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 07:15: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 07:15: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 07:15:47 INFO - Using env: {'DISPLAY': ':0', 07:15:47 INFO - 'HOME': '/home/cltbld', 07:15:47 INFO - 'LANG': 'en_US.UTF-8', 07:15:47 INFO - 'LANGUAGE': 'en_US:en', 07:15:47 INFO - 'LOGNAME': 'cltbld', 07:15:47 INFO - 'MAIL': '/var/mail/cltbld', 07:15:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:47 INFO - 'MOZ_NO_REMOTE': '1', 07:15:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:47 INFO - 'NO_EM_RESTART': '1', 07:15:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:47 INFO - 'PWD': '/builds/slave/test', 07:15:47 INFO - 'SHELL': '/bin/bash', 07:15:47 INFO - 'SHLVL': '1', 07:15:47 INFO - 'TERM': 'linux', 07:15:47 INFO - 'TMOUT': '86400', 07:15:47 INFO - 'USER': 'cltbld', 07:15:47 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1466777723.158442-1431706717', 07:15:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:47 INFO - '_': '/tools/buildbot/bin/python'} 07:15:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:47 INFO - Downloading/unpacking blobuploader==1.2.4 07:15: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 07:15: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 07:15: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 07:15: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 07:15: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 07:15: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 07:15:49 INFO - Downloading blobuploader-1.2.4.tar.gz 07:15:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:15:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:15:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:50 INFO - Downloading docopt-0.6.1.tar.gz 07:15:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:15:50 INFO - Installing collected packages: blobuploader, requests, docopt 07:15:50 INFO - Running setup.py install for blobuploader 07:15:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:15:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:15:50 INFO - Running setup.py install for requests 07:15:50 INFO - Running setup.py install for docopt 07:15:50 INFO - Successfully installed blobuploader requests docopt 07:15:50 INFO - Cleaning up... 07:15:50 INFO - Return code: 0 07:15:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:15:50 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')]} 07:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:50 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')]} 07:15:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:50 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 0x7fca706a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252e110>, '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 0x249a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249a6c0>, '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': '745a4373a2a16df560f216e000000264-1466777723.158442-1431706717', '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 07:15:50 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 07:15:50 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 07:15:50 INFO - Using env: {'DISPLAY': ':0', 07:15:50 INFO - 'HOME': '/home/cltbld', 07:15:50 INFO - 'LANG': 'en_US.UTF-8', 07:15:50 INFO - 'LANGUAGE': 'en_US:en', 07:15:50 INFO - 'LOGNAME': 'cltbld', 07:15:50 INFO - 'MAIL': '/var/mail/cltbld', 07:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:50 INFO - 'MOZ_NO_REMOTE': '1', 07:15:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:50 INFO - 'NO_EM_RESTART': '1', 07:15:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:50 INFO - 'PWD': '/builds/slave/test', 07:15:50 INFO - 'SHELL': '/bin/bash', 07:15:50 INFO - 'SHLVL': '1', 07:15:50 INFO - 'TERM': 'linux', 07:15:50 INFO - 'TMOUT': '86400', 07:15:50 INFO - 'USER': 'cltbld', 07:15:50 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1466777723.158442-1431706717', 07:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:50 INFO - '_': '/tools/buildbot/bin/python'} 07:15:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:15:50 INFO - Running setup.py (path:/tmp/pip-bAbIyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:15:51 INFO - Running setup.py (path:/tmp/pip-f1DMaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:15:51 INFO - Running setup.py (path:/tmp/pip-UmjTll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:15:51 INFO - Running setup.py (path:/tmp/pip-nId2nL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:15:51 INFO - Running setup.py (path:/tmp/pip-DkQbEq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:15:51 INFO - Running setup.py (path:/tmp/pip-cL3uxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:15:51 INFO - Running setup.py (path:/tmp/pip-pIaTVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:15:51 INFO - Running setup.py (path:/tmp/pip-Tec6vJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:15:51 INFO - Running setup.py (path:/tmp/pip-pfk_Og-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:15:51 INFO - Running setup.py (path:/tmp/pip-PgltG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:15:51 INFO - Running setup.py (path:/tmp/pip-KVgfnc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:15:51 INFO - Running setup.py (path:/tmp/pip-2t6IEn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:15:51 INFO - Running setup.py (path:/tmp/pip-I4ypHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:15:51 INFO - Running setup.py (path:/tmp/pip-G1J6hl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:51 INFO - Running setup.py (path:/tmp/pip-mzuFc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:15:52 INFO - Running setup.py (path:/tmp/pip-o3ZVy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:15:52 INFO - Running setup.py (path:/tmp/pip-hVzKjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:15:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:15:52 INFO - Running setup.py install for manifestparser 07:15:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:15:52 INFO - Running setup.py install for mozcrash 07:15:52 INFO - Running setup.py install for mozdebug 07:15:52 INFO - Running setup.py install for mozdevice 07:15:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:15:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:15:52 INFO - Running setup.py install for mozfile 07:15:52 INFO - Running setup.py install for mozhttpd 07:15:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:15:52 INFO - Running setup.py install for mozinfo 07:15:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:15:52 INFO - Running setup.py install for mozInstall 07:15:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:15:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:15:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:15:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:15:52 INFO - Running setup.py install for mozleak 07:15:53 INFO - Running setup.py install for mozlog 07:15:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:15:53 INFO - Running setup.py install for moznetwork 07:15:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:15:53 INFO - Running setup.py install for mozprocess 07:15:53 INFO - Running setup.py install for mozprofile 07:15:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:15:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:15:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:15:53 INFO - Running setup.py install for mozrunner 07:15:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:15:53 INFO - Running setup.py install for mozscreenshot 07:15:53 INFO - Running setup.py install for moztest 07:15:53 INFO - Running setup.py install for mozversion 07:15:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:15:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:15:53 INFO - Cleaning up... 07:15:54 INFO - Return code: 0 07:15:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:15: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')]} 07:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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')]} 07:15:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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 0x7fca706a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252e110>, '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 0x249a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249a6c0>, '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': '745a4373a2a16df560f216e000000264-1466777723.158442-1431706717', '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 07:15: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 07:15: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 07:15:54 INFO - Using env: {'DISPLAY': ':0', 07:15:54 INFO - 'HOME': '/home/cltbld', 07:15:54 INFO - 'LANG': 'en_US.UTF-8', 07:15:54 INFO - 'LANGUAGE': 'en_US:en', 07:15:54 INFO - 'LOGNAME': 'cltbld', 07:15:54 INFO - 'MAIL': '/var/mail/cltbld', 07:15:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:54 INFO - 'MOZ_NO_REMOTE': '1', 07:15:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:54 INFO - 'NO_EM_RESTART': '1', 07:15:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:54 INFO - 'PWD': '/builds/slave/test', 07:15:54 INFO - 'SHELL': '/bin/bash', 07:15:54 INFO - 'SHLVL': '1', 07:15:54 INFO - 'TERM': 'linux', 07:15:54 INFO - 'TMOUT': '86400', 07:15:54 INFO - 'USER': 'cltbld', 07:15:54 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1466777723.158442-1431706717', 07:15:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:54 INFO - '_': '/tools/buildbot/bin/python'} 07:15:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:15:54 INFO - Running setup.py (path:/tmp/pip-WfQlyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:15: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)) 07:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:15:54 INFO - Running setup.py (path:/tmp/pip-pUIX_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:15:54 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)) 07:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:15:54 INFO - Running setup.py (path:/tmp/pip-Uz0U6g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:15:54 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)) 07:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:15:54 INFO - Running setup.py (path:/tmp/pip-C169GD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:15:54 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)) 07:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:15:54 INFO - Running setup.py (path:/tmp/pip-wdDeOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:15:54 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)) 07:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:15:54 INFO - Running setup.py (path:/tmp/pip-eh773B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:15:54 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)) 07:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:15:54 INFO - Running setup.py (path:/tmp/pip-jXkhZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:15:54 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)) 07:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:15:54 INFO - Running setup.py (path:/tmp/pip-P3K1cc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:15:54 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)) 07:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:15:54 INFO - Running setup.py (path:/tmp/pip-XwqPEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:15:54 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)) 07:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:15:54 INFO - Running setup.py (path:/tmp/pip-GLzA1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:15:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 07:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:15:54 INFO - Running setup.py (path:/tmp/pip-bXnoyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:15: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)) 07:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:15:55 INFO - Running setup.py (path:/tmp/pip-V6WrHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:15:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 07:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:15:55 INFO - Running setup.py (path:/tmp/pip-1IL5DB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:15: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)) 07:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:15:55 INFO - Running setup.py (path:/tmp/pip-qIPiaH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:15:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 07:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:55 INFO - Running setup.py (path:/tmp/pip-vvqoNR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:55 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)) 07:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:15:55 INFO - Running setup.py (path:/tmp/pip-eJ9hD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:15:55 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)) 07:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:15:55 INFO - Running setup.py (path:/tmp/pip-gTHQn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:15:55 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)) 07:15:55 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)) 07:15:55 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)) 07:15:55 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)) 07:15:55 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)) 07:15:55 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)) 07:15:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:15:55 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 07:15:55 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 07:15:55 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 07:15:55 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 07:15:55 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 07:15:55 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 07:15:57 INFO - Downloading blessings-1.6.tar.gz 07:15:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:15:57 INFO - Installing collected packages: blessings 07:15:57 INFO - Running setup.py install for blessings 07:15:57 INFO - Successfully installed blessings 07:15:57 INFO - Cleaning up... 07:15:57 INFO - Return code: 0 07:15:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:15:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:15:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:15:57 INFO - Reading from file tmpfile_stdout 07:15:57 INFO - Current package versions: 07:15:57 INFO - argparse == 1.2.1 07:15:57 INFO - blessings == 1.6 07:15:57 INFO - blobuploader == 1.2.4 07:15:57 INFO - docopt == 0.6.1 07:15:57 INFO - functools32 == 3.2.3-2 07:15:57 INFO - jsonschema == 2.5.1 07:15:57 INFO - manifestparser == 1.1 07:15:57 INFO - mozInstall == 1.12 07:15:57 INFO - mozcrash == 0.17 07:15:57 INFO - mozdebug == 0.1 07:15:57 INFO - mozdevice == 0.48 07:15:57 INFO - mozfile == 1.2 07:15:57 INFO - mozhttpd == 0.7 07:15:57 INFO - mozinfo == 0.9 07:15:57 INFO - mozleak == 0.1 07:15:57 INFO - mozlog == 3.2 07:15:57 INFO - moznetwork == 0.27 07:15:57 INFO - mozprocess == 0.22 07:15:57 INFO - mozprofile == 0.28 07:15:57 INFO - mozrunner == 6.11 07:15:57 INFO - mozscreenshot == 0.1 07:15:57 INFO - mozsystemmonitor == 0.3 07:15:57 INFO - moztest == 0.7 07:15:57 INFO - mozversion == 1.4 07:15:57 INFO - psutil == 3.1.1 07:15:57 INFO - requests == 1.2.3 07:15:57 INFO - wsgiref == 0.1.2 07:15:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:15:57 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')]} 07:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:57 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')]} 07:15:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:57 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 0x7fca706a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252e110>, '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 0x249a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249a6c0>, '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': '745a4373a2a16df560f216e000000264-1466777723.158442-1431706717', '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 07:15:57 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 07:15:57 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 07:15:57 INFO - Using env: {'DISPLAY': ':0', 07:15:57 INFO - 'HOME': '/home/cltbld', 07:15:57 INFO - 'LANG': 'en_US.UTF-8', 07:15:57 INFO - 'LANGUAGE': 'en_US:en', 07:15:57 INFO - 'LOGNAME': 'cltbld', 07:15:57 INFO - 'MAIL': '/var/mail/cltbld', 07:15:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:57 INFO - 'MOZ_NO_REMOTE': '1', 07:15:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:57 INFO - 'NO_EM_RESTART': '1', 07:15:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:57 INFO - 'PWD': '/builds/slave/test', 07:15:57 INFO - 'SHELL': '/bin/bash', 07:15:57 INFO - 'SHLVL': '1', 07:15:57 INFO - 'TERM': 'linux', 07:15:57 INFO - 'TMOUT': '86400', 07:15:57 INFO - 'USER': 'cltbld', 07:15:57 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1466777723.158442-1431706717', 07:15:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:57 INFO - '_': '/tools/buildbot/bin/python'} 07:15:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15: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)) 07:15: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)) 07:15: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)) 07:15: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)) 07:15: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)) 07:15: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)) 07:15: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)) 07:15: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)) 07:15: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)) 07:15: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)) 07:15: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)) 07:15:58 INFO - Cleaning up... 07:15:58 INFO - Return code: 0 07:15:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:15: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')]} 07:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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')]} 07:15:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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 0x7fca706a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252e110>, '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 0x249a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249a6c0>, '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': '745a4373a2a16df560f216e000000264-1466777723.158442-1431706717', '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 07:15: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 07:15: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 07:15:58 INFO - Using env: {'DISPLAY': ':0', 07:15:58 INFO - 'HOME': '/home/cltbld', 07:15:58 INFO - 'LANG': 'en_US.UTF-8', 07:15:58 INFO - 'LANGUAGE': 'en_US:en', 07:15:58 INFO - 'LOGNAME': 'cltbld', 07:15:58 INFO - 'MAIL': '/var/mail/cltbld', 07:15:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:58 INFO - 'MOZ_NO_REMOTE': '1', 07:15:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:58 INFO - 'NO_EM_RESTART': '1', 07:15:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:58 INFO - 'PWD': '/builds/slave/test', 07:15:58 INFO - 'SHELL': '/bin/bash', 07:15:58 INFO - 'SHLVL': '1', 07:15:58 INFO - 'TERM': 'linux', 07:15:58 INFO - 'TMOUT': '86400', 07:15:58 INFO - 'USER': 'cltbld', 07:15:58 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1466777723.158442-1431706717', 07:15:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:58 INFO - '_': '/tools/buildbot/bin/python'} 07:15:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:15:58 INFO - Cleaning up... 07:15:58 INFO - Return code: 0 07:15:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:15: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')]} 07:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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')]} 07:15:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca706a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252e110>, '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 0x249a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249a6c0>, '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': '745a4373a2a16df560f216e000000264-1466777723.158442-1431706717', '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 07:15: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', 'flake8'] in /builds/slave/test/build 07:15: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 flake8 07:15:58 INFO - Using env: {'DISPLAY': ':0', 07:15:58 INFO - 'HOME': '/home/cltbld', 07:15:58 INFO - 'LANG': 'en_US.UTF-8', 07:15:58 INFO - 'LANGUAGE': 'en_US:en', 07:15:58 INFO - 'LOGNAME': 'cltbld', 07:15:58 INFO - 'MAIL': '/var/mail/cltbld', 07:15:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:58 INFO - 'MOZ_NO_REMOTE': '1', 07:15:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:58 INFO - 'NO_EM_RESTART': '1', 07:15:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:58 INFO - 'PWD': '/builds/slave/test', 07:15:58 INFO - 'SHELL': '/bin/bash', 07:15:58 INFO - 'SHLVL': '1', 07:15:58 INFO - 'TERM': 'linux', 07:15:58 INFO - 'TMOUT': '86400', 07:15:58 INFO - 'USER': 'cltbld', 07:15:58 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1466777723.158442-1431706717', 07:15:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:58 INFO - '_': '/tools/buildbot/bin/python'} 07:15:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:58 INFO - Downloading/unpacking flake8 07:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:16:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:16:00 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 07:16:00 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 07:16:00 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 07:16:00 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 07:16:00 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 07:16:00 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 07:16:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:16:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:16:00 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 07:16:00 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 07:16:00 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 07:16:00 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 07:16:00 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 07:16:00 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 07:16:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:16:00 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 07:16:00 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 07:16:00 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 07:16:00 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 07:16:00 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 07:16:00 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 07:16:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:16:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:16:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:16:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:16:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:16:01 INFO - no previously-included directories found matching 'docs/_build' 07:16:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:16:01 INFO - Running setup.py install for pep8 07:16:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:16:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:16:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:16:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:16:01 INFO - no previously-included directories found matching 'docs/_build' 07:16:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:16:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:16:01 INFO - Cleaning up... 07:16:01 INFO - Return code: 0 07:16:01 INFO - Running post-action listener: _resource_record_post_action 07:16:01 INFO - Running post-action listener: _start_resource_monitoring 07:16:01 INFO - Starting resource monitoring. 07:16:01 INFO - ##### 07:16:01 INFO - ##### Finished create-virtualenv step (success) 07:16:01 INFO - ##### 07:16:01 INFO - ##### 07:16:01 INFO - ##### Running install step. 07:16:01 INFO - ##### 07:16:01 INFO - Running pre-action listener: _resource_record_pre_action 07:16:01 INFO - Running main action method: install 07:16:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:16:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:16:01 INFO - Reading from file tmpfile_stdout 07:16:01 INFO - Detecting whether we're running mozinstall >=1.0... 07:16:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:16:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:16:01 INFO - Reading from file tmpfile_stdout 07:16:01 INFO - Output received: 07:16:01 INFO - Usage: mozinstall [options] installer 07:16:01 INFO - Options: 07:16:01 INFO - -h, --help show this help message and exit 07:16:01 INFO - -d DEST, --destination=DEST 07:16:01 INFO - Directory to install application into. [default: 07:16:01 INFO - "/builds/slave/test"] 07:16:01 INFO - --app=APP Application being installed. [default: firefox] 07:16:01 INFO - mkdir: /builds/slave/test/build/application 07:16:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:16:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:16:18 INFO - Reading from file tmpfile_stdout 07:16:18 INFO - Output received: 07:16:18 INFO - /builds/slave/test/build/application/firefox/firefox 07:16:18 INFO - Running post-action listener: _resource_record_post_action 07:16:18 INFO - ##### 07:16:18 INFO - ##### Finished install step (success) 07:16:18 INFO - ##### 07:16:18 INFO - ##### 07:16:18 INFO - ##### Running run-tests step. 07:16:18 INFO - ##### 07:16:18 INFO - Running pre-action listener: _resource_record_pre_action 07:16:18 INFO - Running main action method: run_tests 07:16:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:16:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:16:18 INFO - Python 2.7.3 07:16:18 INFO - Return code: 0 07:16:18 INFO - grabbing minidump binary from tooltool 07:16:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:18 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 0x252e110>, '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 0x249a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249a6c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:16:18 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 07:16:18 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 07:16:18 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 07:16:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:16:18 INFO - Return code: 0 07:16:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:16:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:16:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:16:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:16:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:16:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:16:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:16:19 INFO - Return code: 0 07:16:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CN545vF6TpaQoGM-19uF0A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 07:16:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CN545vF6TpaQoGM-19uF0A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --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 07:16:19 INFO - Using env: {'DISPLAY': ':0', 07:16:19 INFO - 'HOME': '/home/cltbld', 07:16:19 INFO - 'LANG': 'en_US.UTF-8', 07:16:19 INFO - 'LANGUAGE': 'en_US:en', 07:16:19 INFO - 'LOGNAME': 'cltbld', 07:16:19 INFO - 'MAIL': '/var/mail/cltbld', 07:16:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:16:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:16:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:19 INFO - 'MOZ_NO_REMOTE': '1', 07:16:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:16:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:19 INFO - 'NO_EM_RESTART': '1', 07:16:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:19 INFO - 'PWD': '/builds/slave/test', 07:16:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:16:19 INFO - 'SHELL': '/bin/bash', 07:16:19 INFO - 'SHLVL': '1', 07:16:19 INFO - 'TERM': 'linux', 07:16:19 INFO - 'TMOUT': '86400', 07:16:19 INFO - 'USER': 'cltbld', 07:16:19 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1466777723.158442-1431706717', 07:16:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:19 INFO - '_': '/tools/buildbot/bin/python'} 07:16:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CN545vF6TpaQoGM-19uF0A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 07:16:20 INFO - mozversion application_buildid: 20160624043346 07:16:20 INFO - mozversion application_changeset: 939ecc4e9d055c263633cbe276bfb634a68fe4c5 07:16:20 INFO - mozversion application_display_name: Nightly 07:16:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:16:20 INFO - mozversion application_name: Firefox 07:16:20 INFO - mozversion application_remotingname: firefox 07:16:20 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:16:20 INFO - mozversion application_vendor: Mozilla 07:16:20 INFO - mozversion application_version: 50.0a1 07:16:20 INFO - mozversion platform_buildid: 20160624043346 07:16:20 INFO - mozversion platform_changeset: 939ecc4e9d055c263633cbe276bfb634a68fe4c5 07:16:20 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:16:20 INFO - mozversion platform_version: 50.0a1 07:16:20 INFO - using testdate: 1466777780 07:16:20 INFO - actual date: 1466777780 07:16:20 INFO - starting webserver on 'localhost:35853' 07:16:20 INFO - SUITE-START | Running 2 tests 07:16:20 INFO - TEST-START | dromaeo_css 07:16:20 INFO - operating with platform_type : linux_ 07:16:20 INFO - Initialising browser for dromaeo_css test... 07:16:20 INFO - TEST-INFO | started process 13667 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6dQ_Nc/profile http://localhost:35853/getInfo.html) 07:16:24 INFO - PROCESS | 13667 | __metrics Screen width/height:1600/1200 07:16:24 INFO - PROCESS | 13667 | colorDepth:24 07:16:24 INFO - PROCESS | 13667 | Browser inner width/height: 1024/697 07:16:24 INFO - PROCESS | 13667 | __metrics 07:16:25 INFO - PROCESS | 13667 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:16:26 INFO - PROCESS | 13667 | console.error: PushService: 07:16:26 INFO - PROCESS | 13667 | stateChangeProcessEnqueue: Error transitioning state 07:16:26 INFO - PROCESS | 13667 | UnknownError 07:16:26 INFO - TEST-INFO | 13667: exit 0 07:16:26 INFO - Browser initialized. 07:16:26 INFO - Running cycle 1/1 for dromaeo_css test... 07:16:26 INFO - TEST-INFO | started process 13750 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6dQ_Nc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:16:39 INFO - PROCESS | 13750 | RSS: Main: 173920256 07:16:39 INFO - PROCESS | 13750 | 07:17:29 INFO - PROCESS | 13750 | 1466777849843 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] 07:19:39 INFO - PROCESS | 13750 | Cycle 1(1): loaded http://localhost:35853/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35853/tests/dromaeo/cssquery-ext.html) 07:19:40 INFO - PROCESS | 13750 | RSS: Main: 295768064 07:19:40 INFO - PROCESS | 13750 | 07:22:42 INFO - PROCESS | 13750 | Cycle 1(1): loaded http://localhost:35853/tests/dromaeo/cssquery-ext.html (next: http://localhost:35853/tests/dromaeo/cssquery-jquery.html) 07:22:43 INFO - PROCESS | 13750 | RSS: Main: 259379200 07:22:43 INFO - PROCESS | 13750 | 07:25:45 INFO - PROCESS | 13750 | Cycle 1(1): loaded http://localhost:35853/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35853/tests/dromaeo/cssquery-mootools.html) 07:25:45 INFO - PROCESS | 13750 | RSS: Main: 259248128 07:25:45 INFO - PROCESS | 13750 | 07:28:47 INFO - PROCESS | 13750 | Cycle 1(1): loaded http://localhost:35853/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35853/tests/dromaeo/cssquery-prototype.html) 07:28:48 INFO - PROCESS | 13750 | RSS: Main: 252952576 07:28:48 INFO - PROCESS | 13750 | 07:31:51 INFO - PROCESS | 13750 | Cycle 1(1): loaded http://localhost:35853/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35853/tests/dromaeo/cssquery-yui.html) 07:31:51 INFO - PROCESS | 13750 | RSS: Main: 240812032 07:31:51 INFO - PROCESS | 13750 | 07:34:54 INFO - PROCESS | 13750 | Cycle 1(1): loaded http://localhost:35853/tests/dromaeo/cssquery-yui.html (next: http://localhost:35853/tests/dromaeo/cssquery-dojo.html) 07:34:54 INFO - PROCESS | 13750 | RSS: Main: 287727616 07:34:54 INFO - PROCESS | 13750 | 07:34:54 INFO - PROCESS | 13750 | __start_tp_report 07:34:54 INFO - PROCESS | 13750 | _x_x_mozilla_page_load 07:34:54 INFO - PROCESS | 13750 | _x_x_mozilla_page_load_details 07:34:54 INFO - PROCESS | 13750 | |i|pagename|runs| 07:34:54 INFO - PROCESS | 13750 | |0;dojo.html;3105.4099721053;3106.6427360853495;3128.343047959929;3156.7001134892207;3162.841857907104;5273.920891186635;5340.359156901172;5345.652532585389;5432.103702889023;5438.48334408231;5395.568354531628;5404.054290499166;5415.323084614423;5475.260839786638;5519.641223320491;4840.394950631162;4875.829345972892;4909.729964851932;4913.852584422473;5072.289879416885;4970.130227210224;5001.349824522807;5014.172661510846;5025.472325405834;5032.295478632995;4769.976150119262;4812;4817.4219093708625;4860.6111511079025;4964.702117872921;4783.593394561466;4787.42550893895;4787.473377928425;4851.975740121312;4885.047415753929;4761.309610106549;4802.06359759847;4807.42310922688;4832.782524786393;4849.248366503198;5204.843854684365;5251.396089449686;5329.893402131975;5335.439778823245;5373.194020896896;5687.971560142214;5739.512141467981;5739.913901291484;5751.798687045975;5757.165211044375;5743.712814359265;5792.218050563204;5806;5812.651240925558;5812.709364531756;5182.041322355376;5389.380221274525;5395.514403703724;5506.807261745819;5513.531349835309;6056.666883321372;6061.121137435047;6064.66644334557;6066.1204125402455;6069.848253793691;5783.392743761929;5790.855228619318;5792.507636850914;5800.4199580042505;5800.53595712342;5612.943870561324;5664.915026274609;5716.314042314949;5717.199592057115;5726.856828579319;5710.914336284959;5712.914306285409;5717.199592057115;5719.828405147852;5726.398728133569;5616.5787565932715;5667.291588551431;5710.65736055838;5711.514521265739;5721;4353.434053573079;4360.302351623725;4381.255186618282;4395.692301538862;4402.207602631557;3921.0785465415606;3931.7837518936735;3932.9016774580864;3965.5439624442984;3965.9603403966166;5431.375391829911;5445.83662490126;5448;5449.128139497661;5450.4549545045975;5607.299087614048;5698.116791897262;5775.826725198251;5779.450952159538;5789.247397838254;5425.348958125051;5427.294451721251;5438.592105592096;5441.945580544144;5450.345958485007;4881.975590122027;4981.252812078144;4998.175301075355;5000.799968001312;5032.949670503248;5782.710864456844;5841.678707671119;5847.56143289255;5934.673592952343;5936.970315148396;5649.491545760901;5651.406602306699;5654.180143879033;5659.434056594308;5670.489655930986;5869.6771677556435;5872.207252020922;5880.26496687914;5882.382349853204;5882.970585147047;5435.347758269033;5544.417836127149;5566.693831839288;5576.1356989666665;5603.8879222416135;5649.519790817826;5684.261046063985;5704;5714.228579141763;5714.457126572969;5450.427705091067;5553.611247212656;5559.63862348946;5566.860828479321;5568.415316391721;5528.530074943675;5595.300587426572;5602.663840169603;5642.351129620146;5649.096144616841;5514.724263786875;5535.501804837584;5537.972310138423;5542.501174894279;5552.194931734956;5463.754131064032;5486.177073439016;5618.915716264341;5682.431756824284;5684.374718781013;5446.891062178814;5470.671759694431;5493.533049690821;5494.148406996922;5502.394736579053 07:34:54 INFO - PROCESS | 13750 | |1;ext.html;556.35740719469;601.1193601373986;601.4827248566235;604.7278724573943;612.3172662481335;29882;30589.388212235768;32763.344733105325;32921.83539082301;42855.357169642404;41118.38322425166;44921;45002;45046.549534504644;45119.54880451194;8932.642694292237;9091.727248182566;9095.863562046574;9096.681616143436;9099.545022748836;8889.111088891124;8977.416467929565;8981.371304008722;8998.28013758901;8998.68504602339;8937.374383793138;9064.410813297147;9064.864027039599;9065.59204835784;9069.138431848996;8980.191782739552;9010.909890901072;9022.09779022099;9031.187193152648;9031.503267320295;9011.008789033202;9051.864222036675;9072.727818165466;9084.636614535411;9088.18206361424;40983.38524922128;41294.587054129675;41326.58673413288;41376;41386.1722765546;3326.933461330784;3432.5709286339206;3455.05562471595;3503.61460239376;3549.946750798714;32165.517517237262;32366.352672946643;32400.675993240002;32791.06507219125;33793.6620633793;3627.963720362789;4019.3970904364287;4033.6974726895305;4051.6556092732153;4201.831926722927;351940;352099;353627;353840;354354;61603;62053.68973155195;62250.68874655598;62329.37670623236;62417.687911560155;35555.466668;36315.27369452596;36343.4548481773;37626.81186594104;63074;17756.822431775774;17832.55418614545;17843.375481858333;17944.37194698179;17947.461576152735;13521;13611.931940340235;13672.863271367358;13679.452821887213;13679.521216757565;19352.903235483733;19463.90268048679;19537.316193933144;19579.412617621496;19637.116329765195;7104.92895071053;7142.321479459443;7201.71193152268;7299.379552738077;7318.485968241265;967.7822489939707;1033.1734612310122;1074.88497540854;1078.5200585739428;1106.8671759388924;32299.838500807346;32682.18294542608;32753.508697369558;32952;33369.49945750816;1090.8091084060416;1154.878737732526;1187.9643610691694;1194.4770417717307;1227.6501197158766;17192.656146876994;17274.790764646354;17344.219510121824;17407.477775666495;17408.303667853143;489082;490548;491790;493296;494327;59097.70451147803;59211;59526.70236648789;59635.40364596385;59775;1248.656619429664;1319.346923272986;1353.350391811916;1355.6068740065468;1373.5440433140902;31814.840925795223;33430.331393372486;33601.327973440886;33999.98018880077;34066.489002664486;50149.49850501448;50290.748546258495;50772.74613626908;50800.49199508106;50833;302957;306176;307110;307704;308044;25122.24633261005;27118.864405677847;27575.862120689268;27970;28151.296217594725;42159.1568168641;44757.77621111873;48814;49647.50352496573;49851.25223121729;39866.80066599648;40584.188316234104;40964.38553421761;41170.58829411668;41965.79017105017;40796.592034080466;40828.38757418701;41013.79493102516;41396.55112071063;42059.36910946277;39931.20137597174;39958.2008359837;40476;40505.18989620132;40632.390514142906;35860.64139358573;35977.82011089928;36194.4570831443;36950.63049369472;37049.44425833668;27849.860750696116;28211.858940705166;28267.575986360633;28408.147755567366;28482.715172848006 07:34:54 INFO - PROCESS | 13750 | |2;jquery.html;381.1804620066856;391.692521370724;391.8883118311281;399.38494718134075;407.05156984226755;17978;18553.721694174597;19754;20727.896360518214;20728.170873165072;11594.478248478817;11825.231359961597;12224.572139975102;12230.938845305784;12234.694132646688;4988.87527811804;5168.689878607277;5174.43081261061;5198.376194856603;5200.661956972804;3844.1350696093436;6917.308269173092;7403;7405.148407933103;7419.36935360495;6972.233054364041;7301.306375894282;7301.707931682727;7405.8889116663295;7423.962880185619;7216.927830721731;7316.890246646304;7417.888731669029;7418.369438597726;7422.369098626623;7217.783466496014;7218.242084581096;7218.747343842941;7233.493655444121;7251.238619944936;25532.36169095769;25743.485130297475;26288.73711262882;26871.865640671673;26959.191224263304;2346.307839187427;2448.4613385055436;2692.488427198826;3105.3634005028916;3139.780215384924;15410.537683869501;15417.3833046678;15858.127802970832;15980.920095399448;16249.968753905761;1873.5690791117984;1883.5856111655414;1958.1482055305846;1979.4655443030301;2032.1363420546209;91845;94495.52752236264;96017.51991239999;96205;98910;16506.58733531671;17602.559936001446;17625.118744062747;17786.46640600784;18326.175322110535;30581.38837223243;32031.51952720711;32086.679133208836;32127.839360803046;32214.355712885612;10079.848802267972;10162.69511914629;10265.640702575374;10410.167186625053;10426.635067772591;8484.19400156984;8561.315094792402;8855.64577416909;8857.025727170007;9092.27261819053;7275.263116245898;7964.920350796418;9017.368784185044;9164.175224229852;9171.58727857248;3179.3164469639137;3286.309874926292;3383.238771276443;3448.5344478495585;3503.684668379807;916.8762217100606;998.201438848918;999.7300728803328;1023.672424824064;1034.13132968307;18914.621707565773;19616.509587260432;19629.901850490656;19740.30908918181;19756.70364944527;992.3946392700446;1007.4660429972126;1027.3168343051937;1039.9636012739518;1041.239894876729;10228.181745460346;10876.456177191109;11044.558217671203;11046.502907369188;11114.610988615521;474367;478138;478586;493230;498047;87639.56180219186;87924.56037719898;89193;89207.55396222978;89752.5512372434;983.8622592837008;996.2030375699411;996.3858549150423;1008.2790804574764;1013.9493025348703;17267;17292;17387.913060434617;17401;17533.473995780147;41356.1728765429;42063.36904946367;42636.78681606572;43152.56847431611;43918.780406097765;53906.73046634742;56304.43695563156;57276.42723572878;57695.42304576901;57775.422245777;7976.3618910488185;8580.099089595502;8580.14198580137;8638.13618638131;8805.075467075865;12489.812652810033;13423.664408389477;13703.314834258048;13792.793108103588;14002.159870407808;11025.944870275598;11661.24201926872;11981.28112313264;12065.577704780291;12508.374581271082;11815.113866459878;12196.390180490762;12313.56902508408;12401;12519.186252893533;12062.215955962834;12118.394080296126;12142.514299427923;12284.262944223376;12293.815592766294;8670.13298670128;8795.164459376349;8803.60383782744;8921.643134274816;9111.635534578543;11551.978403779473;12166.148369614042;12214;12310.692232693897;12315.630531084082 07:34:54 INFO - PROCESS | 13750 | |3;mootools.html;1287.6008437384405;1428.5857101440579;1461.8903582231333;1537.715522628314;1694.7034269002913;8622.180892815188;8932.151445612664;8963.327750418712;9286;9295.209907157883;9071.365004449675;9268.119528644767;9274.350795444305;9274.768130796734;9278.58246378913;1943.3004118517322;2216.3350994701605;2261.8416710830247;2289.9313020609325;2291.2438895164555;2310.260716570698;2320.8839558022114;2322.1175953137868;2322.2684854270933;2324.8023917966907;2268.3308424014954;2272.5114100468395;2306.6655334976417;2309;2309.110992267972;1911.2832687742098;2139.3261122746285;2188.6935828983956;2189.3650841256017;2220.589190999662;2192.5176461178676;2198.835087368454;2218.4897473581004;2221.3780141560387;2222.3333000099906;9278.768030799216;9412.858807117898;9421.48181849998;9426.528673566294;9427.3400861939;5173.922391164136;5302.6023048271145;5305.973470132624;5310.867228319323;5313.990341835078;3193.8882139125253;3213.228825081987;3266.3630592034324;3308.4044871923043;3314.7016768490953;1067.2849191042021;1080.2978064258216;1884.8869067855971;1914.3682584747;1930.806919308072;12868.935655321664;13142.4085916134;13146.737065258641;13148.934255328757;13150.276734779583;4450.421445212167;4517.141743068806;4555;4586.72479651222;4591.4260717410325;10326.845097323396;10338.741531461774;10340.948295258626;10341.37951722899;10342.482875856327;5282.418933917266;5323.121684922022;5328.333958255218;5365.436629153883;5377.569794416438;4338.284183109751;4758.1673207188605;4905.9018819624125;4930.063287975345;5002.224655178453;3741.9625803741615;3817.0838998640684;3877.6703980162;3919.8824035278985;3934.075492259317;1093.7703082352637;1126.8704099028553;1130.4799792095564;1135.744457497073;1144.101880024177;962.1196605106389;962.43216502264;968.0561452583675;973.9951300243595;977.4379731654327;5968.671723055187;5994.37059108796;6166.414190651881;6306.432421082125;6419.51853610981;423.9993615068436;426.3093788063357;426.5201648145836;429.3559660509236;436.700859910962;4084.2648323301496;4318.632916202095;4323.956760432418;4363.127374525045;4396.692231543825;11440.59957901486;11963.700907477209;11985.16103872738;11986.220895641756;11992.76014479723;11118.166137539716;11544.365059921785;11549.480273387719;11962.40187990597;11965.40172991347;8562.186592273723;8763.167499087449;8765.386422950332;8769;8774.429662071945;6116.969415153074;6254.249490061222;6389.68051597409;6391.776287829904;6464.547481676237;10171;10721.41032243203;10852.782944341227;10861.131109511378;10879.292845964987;10642.095421889226;10745.409002504937;10980.670579882617;10999.670009899715;11104.389258590854;8731.694390696295;8741.519216443157;8812.735617931472;8998.955005224932;9015.233705135137;8900.910990890008;8974.057723939153;8989.235914947303;9025.954870225869;9089.636414543344;8102.108768035393;8216.342692584698;8244.422890397615;8307.252347288531;8336.249737523653;7830.725924592612;7840.098388685375;7873.5275883447175;8040.356771458152;8086.070101938117;7143.214246432992;7241.963790181016;7246.60143692102;7249.202587715453;7259.947307640468;5166.715830629201;5241.868953276198;5318.680879147263;5327.467253274796;5382.865428364322;5028.245763135559;5072.54347108762;5106.66806657566;5128.999845030184;5255.0540902637895 07:34:54 INFO - PROCESS | 13750 | |4;prototype.html;312.42046004661336;321.3188041352333;326.03818734732545;330.9271960168762;331.80920970442;4980.526849949249;5036.3452751142395;5272.762725677344;5340.599455040868;5362.2224777407255;5274.683518988853;5295.735213239342;5303.310569625944;5308.495692909177;5311.309529761125;4228.260054490467;4230.598093181143;4238.80925358358;4243.130158317537;4245.426867372911;3974.5429275633383;4070.409790580364;4168.166366726667;4215.3887686285625;4228.175505776375;4152.771597562133;4155;4166.749995000295;4168.97915510422;4177.895552611179;4113.239050775616;4114.292568584034;4122.484689413824;4129.8967525811795;4129.958700412987;3414.2659328244545;3686.686631636314;3711.480392745018;3723.9441408378625;3733.253349330145;5150.665206761549;5156.510131537535;5159.406668233126;5175.894463322014;5178.249153872667;4680.204365257914;4703.048234982478;4720.575148236675;4728.503507131736;4741.905161896742;5326.280952071459;5408.2698835657075;5518.889622207574;5523.199136125239;5535.750891209865;3925.2738243424774;3941.211757648453;3949.763014219156;3950.940735888964;3968.9007774805573;5499.230107784913;5622.453825198062;5687.203791469197;5757.798477053325;5774.740136693859;3967.1272320089533;3969.3450580653866;3972.2254160439015;4004.099077707551;4015.0163210013147;4004.3593025115842;4008.158286759755;4037.2329257440992;4048;4072.6945479089186;4528.50186479487;4647.744374059392;4685.554872287127;4692.178868698033;4711.104890070944;5518.944810551923;5523.889522209533;5525.336959564878;5537;5539.750711218005;1392.1507880193074;1403.7262733767022;1404.34697865491;1406.2757679794913;1406.5863806874027;879.0551651965991;880.3309484791477;887.0995939121797;901.7925877048316;936.9578368973413;4685.320628508847;4730.526947305242;4755.833545825949;4767.855714628464;4792.904141917142;4963.702177869267;5001.224810154432;5003.324551185616;5046.470120637354;5063;4616.307553866947;4682.297655351656;4727.865312325086;4735.242361222188;4782.3543821584335;2629.421527263999;2700.824446410977;2706.1746167418733;2711.9050833221136;2718.3224523843996;5104.183330667075;5106.412762532282;5169.974150129226;5185.9740701297005;5229.398619158769;4913.616895805531;4917.262410638361;5046.974765126224;5110.616703747234;5136.919547583235;5115.155999260155;5140.485951404829;5171.741412929338;5175.197844334059;5211.869703257449;4956.975215123901;5036.445990941067;5040.294358789699;5051.646384753179;5057.494250574913;5015.648904576645;5053.797848086036;5219.48634895876;5672.4894759471845;5722.882533462645;5638;5671.801486947937;5918.378570250062;5949.196858424058;5955.315138759098;4104.4664193654635;4114.91770164601;4118.588141185857;4132.442120313719;4138.503379594468;5623.407258165218;5712.429082002483;5716.42835716425;5730.3410107838135;5752.309722833287;5528.557715382679;5535.7785688572;5551.2228288040515;5556.916646250229;5587.692676902647;5528.087865502147;5528.861778455571;5536.318348298337;5540.722963851872;5541.2796336476;5236.9738151309;5421.512063914267;5432.429594892637;5465.426130256425;5483.588730845282;5459.863503412446;5588.972055139699;5610.579206559442;5620.1288800236025;5624.74688639004;5433.185022246695;5437.31443252593;5447.101228297287;5453.400125986059;5456.663117536229 07:34:54 INFO - PROCESS | 13750 | |5;yui.html;739.781764379508;759.290063790356;791.2166954714827;801.1907972947323;828.1718281718282;14111.364988575513;14676.633084172887;15024.248787560606;15037.849621503781;15071.095734255938;14719.92640036801;15065.92467037666;15077.321520531576;15094.245287735625;15094.396224151049;671.8857794174977;787.3347021766598;800.5036877136155;808.2806302390877;814.3485211830541;800.951942883426;801.4349883332237;801.4429971170039;806.9031716194065;806.9993208421545;854.1970547685187;856.3363393370125;857.4169564696004;858.2790456016944;859.072202021815;708.6385943168996;825.4881973176639;845.2055068235838;845.2688424512752;857.2627540315324;612.5558969746943;613.1232337757006;614.5912967876357;614.97232624532;619.2383368456823;14707.779383309258;14736.189509576969;14754.631134221623;14761.704765904622;14764.409423623043;13798;13829.170249785046;13963.58109256724;14130.858691413057;14573.417063317454;12614.495420183182;12651.936740316332;12837.229766214057;12877.549285775047;13509.864901350958;4447.466304043503;4491.752953587551;4502.459704835408;4581.67928245023;4634.096351211515;74654.62672686655;75642.62178689126;75657;75789.24210757877;76096.23903760947;10510.947445262878;10857.619983300547;10926.508307126198;11054.336739795637;11055.502502387251;19280.903595481934;19371.612567748565;19382.321618743557;19396.80603193978;19416.12627431769;7568.735094271784;7713.074431068308;8087.110417854032;8567.74296771098;8613.440126391764;4424.137293227854;4461.7992190351515;4493.168763778712;4580.198465268565;4589.701669391546;3172.889488678944;3246.740260779132;3253.5933008373954;3255.3977514159956;3259.6903294187014;551.4788524843984;566.212963980068;583.982480525585;585.2742599176989;612.3142080869454;569.5415190771386;618.4681174190193;618.6403769252096;670.1522573943964;680.404645934807;8962.14859588338;9080.8637870432;9271.629134834531;9423.623055077856;9663.226941844636;622.7758007117434;654.2410803468049;668.7563225378784;671.5869740109895;709.6487238816819;4591.311303304531;4700.153972285021;4749.430068391746;4770;4784.569388754959;112687;113235;113770;114973;118015;58323;60094;68698.65650671715;82448.58775706204;94195.52902235583;63490.68254658697;69411.65294173497;86574.56712716396;91630.54184729034;92858.21425357385;9628.229741620793;10410.115140213167;10476;10546.57813687444;10611.8938810614;43763.56236437722;49748.751256243486;50939.49060509347;52588.47411525836;53019.734901325246;47707;62835.6858215706;70735.29264707287;74151.25848741444;74581;12351;12686.726790662176;12988.531950956196;13023.47906083746;13282.269475178571;15404.92297538505;15494.612634684223;15645.921770391074;15688.450904218755;16021.359145634044;10325.9483702581;13795.655108622364;13943.442262309394;14425.567232982607;14493.420263189355;12867.292298923649;13035.47858085666;13117.147385419918;13315.1345162568;14219.360128794437;14097;14340.21128837924;14422.07411674717;14467.710645787236;14469.421223150955;10670.679879603624;10733.248672592843;10890.61882834097;11064.778704425706;11217.607383741857;11209;11430.127760721203;11689.298642081503;11810;11842.230255033395 07:34:54 INFO - PROCESS | 13750 | __end_tp_report 07:34:54 INFO - PROCESS | 13750 | __start_cc_report 07:34:54 INFO - PROCESS | 13750 | _x_x_mozilla_cycle_collect,1104 07:34:54 INFO - PROCESS | 13750 | __end_cc_report 07:34:54 INFO - PROCESS | 13750 | __startTimestamp1466778894892__endTimestamp 07:34:54 INFO - PROCESS | 13750 | 07:34:54 INFO - PROCESS | 13750 | ------- Summary: start ------- 07:34:54 INFO - PROCESS | 13750 | Number of tests: 6 07:34:54 INFO - PROCESS | 13750 | 07:34:54 INFO - PROCESS | 13750 | [#0] dojo.html Cycles:165 Average:5327.93 Median:5513.53 stddev:598.69 (10.9%) stddev-sans-first:574.58 07:34:54 INFO - PROCESS | 13750 | Values: 3105.4 3106.6 3128.3 3156.7 3162.8 5273.9 5340.4 5345.7 5432.1 5438.5 5395.6 5404.1 5415.3 5475.3 5519.6 4840.4 4875.8 4909.7 4913.9 5072.3 4970.1 5001.3 5014.2 5025.5 5032.3 4770.0 4812.0 4817.4 4860.6 4964.7 4783.6 4787.4 4787.5 4852.0 4885.0 4761.3 4802.1 4807.4 4832.8 4849.2 5204.8 5251.4 5329.9 5335.4 5373.2 5688.0 5739.5 5739.9 5751.8 5757.2 5743.7 5792.2 5806.0 5812.7 5812.7 5182.0 5389.4 5395.5 5506.8 5513.5 6056.7 6061.1 6064.7 6066.1 6069.8 5783.4 5790.9 5792.5 5800.4 5800.5 5612.9 5664.9 5716.3 5717.2 5726.9 5710.9 5712.9 5717.2 5719.8 5726.4 5616.6 5667.3 5710.7 5711.5 5721.0 4353.4 4360.3 4381.3 4395.7 4402.2 3921.1 3931.8 3932.9 3965.5 3966.0 5431.4 5445.8 5448.0 5449.1 5450.5 5607.3 5698.1 5775.8 5779.5 5789.2 5425.3 5427.3 5438.6 5441.9 5450.3 4882.0 4981.3 4998.2 5000.8 5032.9 5782.7 5841.7 5847.6 5934.7 5937.0 5649.5 5651.4 5654.2 5659.4 5670.5 5869.7 5872.2 5880.3 5882.4 5883.0 5435.3 5544.4 5566.7 5576.1 5603.9 5649.5 5684.3 5704.0 5714.2 5714.5 5450.4 5553.6 5559.6 5566.9 5568.4 5528.5 5595.3 5602.7 5642.4 5649.1 5514.7 5535.5 5538.0 5542.5 5552.2 5463.8 5486.2 5618.9 5682.4 5684.4 5446.9 5470.7 5493.5 5494.1 5502.4 07:34:54 INFO - PROCESS | 13750 | 07:34:54 INFO - PROCESS | 13750 | [#1] ext.html Cycles:180 Average:54920.26 Median:21988.80 stddev:103510.00 (470.7%) stddev-sans-first:103719.89 07:34:54 INFO - PROCESS | 13750 | Values: 556.4 601.1 601.5 604.7 612.3 29882.0 30589.4 32763.3 32921.8 42855.4 41118.4 44921.0 45002.0 45046.5 45119.5 8932.6 9091.7 9095.9 9096.7 9099.5 8889.1 8977.4 8981.4 8998.3 8998.7 8937.4 9064.4 9064.9 9065.6 9069.1 8980.2 9010.9 9022.1 9031.2 9031.5 9011.0 9051.9 9072.7 9084.6 9088.2 40983.4 41294.6 41326.6 41376.0 41386.2 3326.9 3432.6 3455.1 3503.6 3549.9 32165.5 32366.4 32400.7 32791.1 33793.7 3628.0 4019.4 4033.7 4051.7 4201.8 351940.0 352099.0 353627.0 353840.0 354354.0 61603.0 62053.7 62250.7 62329.4 62417.7 35555.5 36315.3 36343.5 37626.8 63074.0 17756.8 17832.6 17843.4 17944.4 17947.5 13521.0 13611.9 13672.9 13679.5 13679.5 19352.9 19463.9 19537.3 19579.4 19637.1 7104.9 7142.3 7201.7 7299.4 7318.5 967.8 1033.2 1074.9 1078.5 1106.9 32299.8 32682.2 32753.5 32952.0 33369.5 1090.8 1154.9 1188.0 1194.5 1227.7 17192.7 17274.8 17344.2 17407.5 17408.3 489082.0 490548.0 491790.0 493296.0 494327.0 59097.7 59211.0 59526.7 59635.4 59775.0 1248.7 1319.3 1353.4 1355.6 1373.5 31814.8 33430.3 33601.3 34000.0 34066.5 50149.5 50290.7 50772.7 50800.5 50833.0 302957.0 306176.0 307110.0 307704.0 308044.0 25122.2 27118.9 27575.9 27970.0 28151.3 42159.2 44757.8 48814.0 49647.5 49851.3 39866.8 40584.2 40964.4 41170.6 41965.8 40796.6 40828.4 41013.8 41396.6 42059.4 39931.2 39958.2 40476.0 40505.2 40632.4 35860.6 35977.8 36194.5 36950.6 37049.4 27849.9 28211.9 28267.6 28408.1 28482.7 07:34:54 INFO - PROCESS | 13750 | 07:34:54 INFO - PROCESS | 13750 | [#2] jquery.html Cycles:180 Average:30294.14 Median:32059.10 stddev:79945.82 (249.4%) stddev-sans-first:80138.53 07:34:54 INFO - PROCESS | 13750 | Values: 381.2 391.7 391.9 399.4 407.1 17978.0 18553.7 19754.0 20727.9 20728.2 11594.5 11825.2 12224.6 12230.9 12234.7 4988.9 5168.7 5174.4 5198.4 5200.7 3844.1 6917.3 7403.0 7405.1 7419.4 6972.2 7301.3 7301.7 7405.9 7424.0 7216.9 7316.9 7417.9 7418.4 7422.4 7217.8 7218.2 7218.7 7233.5 7251.2 25532.4 25743.5 26288.7 26871.9 26959.2 2346.3 2448.5 2692.5 3105.4 3139.8 15410.5 15417.4 15858.1 15980.9 16250.0 1873.6 1883.6 1958.1 1979.5 2032.1 91845.0 94495.5 96017.5 96205.0 98910.0 16506.6 17602.6 17625.1 17786.5 18326.2 30581.4 32031.5 32086.7 32127.8 32214.4 10079.8 10162.7 10265.6 10410.2 10426.6 8484.2 8561.3 8855.6 8857.0 9092.3 7275.3 7964.9 9017.4 9164.2 9171.6 3179.3 3286.3 3383.2 3448.5 3503.7 916.9 998.2 999.7 1023.7 1034.1 18914.6 19616.5 19629.9 19740.3 19756.7 992.4 1007.5 1027.3 1040.0 1041.2 10228.2 10876.5 11044.6 11046.5 11114.6 474367.0 478138.0 478586.0 493230.0 498047.0 87639.6 87924.6 89193.0 89207.6 89752.6 983.9 996.2 996.4 1008.3 1013.9 17267.0 17292.0 17387.9 17401.0 17533.5 41356.2 42063.4 42636.8 43152.6 43918.8 53906.7 56304.4 57276.4 57695.4 57775.4 7976.4 8580.1 8580.1 8638.1 8805.1 12489.8 13423.7 13703.3 13792.8 14002.2 11025.9 11661.2 11981.3 12065.6 12508.4 11815.1 12196.4 12313.6 12401.0 12519.2 12062.2 12118.4 12142.5 12284.3 12293.8 8670.1 8795.2 8803.6 8921.6 9111.6 11552.0 12166.1 12214.0 12310.7 12315.6 07:34:54 INFO - PROCESS | 13750 | 07:34:54 INFO - PROCESS | 13750 | [#3] mootools.html Cycles:180 Average:6031.95 Median:4423.56 stddev:3584.89 (81.0%) stddev-sans-first:3577.22 07:34:54 INFO - PROCESS | 13750 | Values: 1287.6 1428.6 1461.9 1537.7 1694.7 8622.2 8932.2 8963.3 9286.0 9295.2 9071.4 9268.1 9274.4 9274.8 9278.6 1943.3 2216.3 2261.8 2289.9 2291.2 2310.3 2320.9 2322.1 2322.3 2324.8 2268.3 2272.5 2306.7 2309.0 2309.1 1911.3 2139.3 2188.7 2189.4 2220.6 2192.5 2198.8 2218.5 2221.4 2222.3 9278.8 9412.9 9421.5 9426.5 9427.3 5173.9 5302.6 5306.0 5310.9 5314.0 3193.9 3213.2 3266.4 3308.4 3314.7 1067.3 1080.3 1884.9 1914.4 1930.8 12868.9 13142.4 13146.7 13148.9 13150.3 4450.4 4517.1 4555.0 4586.7 4591.4 10326.8 10338.7 10340.9 10341.4 10342.5 5282.4 5323.1 5328.3 5365.4 5377.6 4338.3 4758.2 4905.9 4930.1 5002.2 3742.0 3817.1 3877.7 3919.9 3934.1 1093.8 1126.9 1130.5 1135.7 1144.1 962.1 962.4 968.1 974.0 977.4 5968.7 5994.4 6166.4 6306.4 6419.5 424.0 426.3 426.5 429.4 436.7 4084.3 4318.6 4324.0 4363.1 4396.7 11440.6 11963.7 11985.2 11986.2 11992.8 11118.2 11544.4 11549.5 11962.4 11965.4 8562.2 8763.2 8765.4 8769.0 8774.4 6117.0 6254.2 6389.7 6391.8 6464.5 10171.0 10721.4 10852.8 10861.1 10879.3 10642.1 10745.4 10980.7 10999.7 11104.4 8731.7 8741.5 8812.7 8999.0 9015.2 8900.9 8974.1 8989.2 9026.0 9089.6 8102.1 8216.3 8244.4 8307.3 8336.2 7830.7 7840.1 7873.5 8040.4 8086.1 7143.2 7242.0 7246.6 7249.2 7259.9 5166.7 5241.9 5318.7 5327.5 5382.9 5028.2 5072.5 5106.7 5129.0 5255.1 07:34:54 INFO - PROCESS | 13750 | 07:34:54 INFO - PROCESS | 13750 | [#4] prototype.html Cycles:180 Average:4517.84 Median:5043.38 stddev:1309.14 (26.0%) stddev-sans-first:1274.19 07:34:54 INFO - PROCESS | 13750 | Values: 312.4 321.3 326.0 330.9 331.8 4980.5 5036.3 5272.8 5340.6 5362.2 5274.7 5295.7 5303.3 5308.5 5311.3 4228.3 4230.6 4238.8 4243.1 4245.4 3974.5 4070.4 4168.2 4215.4 4228.2 4152.8 4155.0 4166.7 4169.0 4177.9 4113.2 4114.3 4122.5 4129.9 4130.0 3414.3 3686.7 3711.5 3723.9 3733.3 5150.7 5156.5 5159.4 5175.9 5178.2 4680.2 4703.0 4720.6 4728.5 4741.9 5326.3 5408.3 5518.9 5523.2 5535.8 3925.3 3941.2 3949.8 3950.9 3968.9 5499.2 5622.5 5687.2 5757.8 5774.7 3967.1 3969.3 3972.2 4004.1 4015.0 4004.4 4008.2 4037.2 4048.0 4072.7 4528.5 4647.7 4685.6 4692.2 4711.1 5518.9 5523.9 5525.3 5537.0 5539.8 1392.2 1403.7 1404.3 1406.3 1406.6 879.1 880.3 887.1 901.8 937.0 4685.3 4730.5 4755.8 4767.9 4792.9 4963.7 5001.2 5003.3 5046.5 5063.0 4616.3 4682.3 4727.9 4735.2 4782.4 2629.4 2700.8 2706.2 2711.9 2718.3 5104.2 5106.4 5170.0 5186.0 5229.4 4913.6 4917.3 5047.0 5110.6 5136.9 5115.2 5140.5 5171.7 5175.2 5211.9 4957.0 5036.4 5040.3 5051.6 5057.5 5015.6 5053.8 5219.5 5672.5 5722.9 5638.0 5671.8 5918.4 5949.2 5955.3 4104.5 4114.9 4118.6 4132.4 4138.5 5623.4 5712.4 5716.4 5730.3 5752.3 5528.6 5535.8 5551.2 5556.9 5587.7 5528.1 5528.9 5536.3 5540.7 5541.3 5237.0 5421.5 5432.4 5465.4 5483.6 5459.9 5589.0 5610.6 5620.1 5624.7 5433.2 5437.3 5447.1 5453.4 5456.7 07:34:54 INFO - PROCESS | 13750 | 07:34:54 INFO - PROCESS | 13750 | [#5] yui.html Cycles:180 Average:19576.62 Median:4541.33 stddev:27587.33 (607.5%) stddev-sans-first:27628.46 07:34:54 INFO - PROCESS | 13750 | Values: 739.8 759.3 791.2 801.2 828.2 14111.4 14676.6 15024.2 15037.8 15071.1 14719.9 15065.9 15077.3 15094.2 15094.4 671.9 787.3 800.5 808.3 814.3 801.0 801.4 801.4 806.9 807.0 854.2 856.3 857.4 858.3 859.1 708.6 825.5 845.2 845.3 857.3 612.6 613.1 614.6 615.0 619.2 14707.8 14736.2 14754.6 14761.7 14764.4 13798.0 13829.2 13963.6 14130.9 14573.4 12614.5 12651.9 12837.2 12877.5 13509.9 4447.5 4491.8 4502.5 4581.7 4634.1 74654.6 75642.6 75657.0 75789.2 76096.2 10510.9 10857.6 10926.5 11054.3 11055.5 19280.9 19371.6 19382.3 19396.8 19416.1 7568.7 7713.1 8087.1 8567.7 8613.4 4424.1 4461.8 4493.2 4580.2 4589.7 3172.9 3246.7 3253.6 3255.4 3259.7 551.5 566.2 584.0 585.3 612.3 569.5 618.5 618.6 670.2 680.4 8962.1 9080.9 9271.6 9423.6 9663.2 622.8 654.2 668.8 671.6 709.6 4591.3 4700.2 4749.4 4770.0 4784.6 112687.0 113235.0 113770.0 114973.0 118015.0 58323.0 60094.0 68698.7 82448.6 94195.5 63490.7 69411.7 86574.6 91630.5 92858.2 9628.2 10410.1 10476.0 10546.6 10611.9 43763.6 49748.8 50939.5 52588.5 53019.7 47707.0 62835.7 70735.3 74151.3 74581.0 12351.0 12686.7 12988.5 13023.5 13282.3 15404.9 15494.6 15645.9 15688.5 16021.4 10325.9 13795.7 13943.4 14425.6 14493.4 12867.3 13035.5 13117.1 13315.1 14219.4 14097.0 14340.2 14422.1 14467.7 14469.4 10670.7 10733.2 10890.6 11064.8 11217.6 11209.0 11430.1 11689.3 11810.0 11842.2 07:34:54 INFO - PROCESS | 13750 | -------- Summary: end -------- 07:34:54 INFO - PROCESS | 13750 | 07:34:55 INFO - TEST-INFO | 13750: exit 0 07:34:55 INFO - TEST-OK | dromaeo_css | took 1115692ms 07:34:55 INFO - TEST-START | kraken 07:34:55 INFO - operating with platform_type : linux_ 07:34:55 INFO - Initialising browser for kraken test... 07:34:55 INFO - TEST-INFO | started process 13938 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyF0YHW/profile http://localhost:35853/getInfo.html) 07:35:00 INFO - PROCESS | 13938 | __metrics Screen width/height:1600/1200 07:35:00 INFO - PROCESS | 13938 | colorDepth:24 07:35:00 INFO - PROCESS | 13938 | Browser inner width/height: 1024/697 07:35:00 INFO - PROCESS | 13938 | __metrics 07:35:01 INFO - PROCESS | 13938 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:35:02 INFO - PROCESS | 13938 | console.error: PushService: 07:35:02 INFO - PROCESS | 13938 | stateChangeProcessEnqueue: Error transitioning state 07:35:02 INFO - PROCESS | 13938 | UnknownError 07:35:02 INFO - TEST-INFO | 13938: exit 0 07:35:02 INFO - Browser initialized. 07:35:02 INFO - Running cycle 1/1 for kraken test... 07:35:02 INFO - TEST-INFO | started process 14025 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyF0YHW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:35:14 INFO - PROCESS | 14025 | RSS: Main: 173944832 07:35:14 INFO - PROCESS | 14025 | 07:35:17 INFO - PROCESS | 14025 | Cycle 1(1): loaded http://localhost:35853/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35853/tests/kraken/driver.html?testName=audio-beat-detection) 07:35:18 INFO - PROCESS | 14025 | RSS: Main: 231616512 07:35:18 INFO - PROCESS | 14025 | 07:35:20 INFO - PROCESS | 14025 | Cycle 1(1): loaded http://localhost:35853/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35853/tests/kraken/driver.html?testName=audio-dft) 07:35:21 INFO - PROCESS | 14025 | RSS: Main: 220217344 07:35:21 INFO - PROCESS | 14025 | 07:35:24 INFO - PROCESS | 14025 | Cycle 1(1): loaded http://localhost:35853/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35853/tests/kraken/driver.html?testName=audio-fft) 07:35:25 INFO - PROCESS | 14025 | RSS: Main: 286408704 07:35:25 INFO - PROCESS | 14025 | 07:35:27 INFO - PROCESS | 14025 | Cycle 1(1): loaded http://localhost:35853/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35853/tests/kraken/driver.html?testName=audio-oscillator) 07:35:27 INFO - PROCESS | 14025 | RSS: Main: 196931584 07:35:27 INFO - PROCESS | 14025 | 07:35:30 INFO - PROCESS | 14025 | Cycle 1(1): loaded http://localhost:35853/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35853/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:35:30 INFO - PROCESS | 14025 | RSS: Main: 200896512 07:35:30 INFO - PROCESS | 14025 | 07:35:33 INFO - PROCESS | 14025 | Cycle 1(1): loaded http://localhost:35853/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35853/tests/kraken/driver.html?testName=imaging-darkroom) 07:35:34 INFO - PROCESS | 14025 | RSS: Main: 236736512 07:35:34 INFO - PROCESS | 14025 | 07:35:37 INFO - PROCESS | 14025 | Cycle 1(1): loaded http://localhost:35853/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35853/tests/kraken/driver.html?testName=imaging-desaturate) 07:35:38 INFO - PROCESS | 14025 | RSS: Main: 237486080 07:35:38 INFO - PROCESS | 14025 | 07:35:41 INFO - PROCESS | 14025 | Cycle 1(1): loaded http://localhost:35853/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35853/tests/kraken/driver.html?testName=json-parse-financial) 07:35:41 INFO - PROCESS | 14025 | RSS: Main: 237584384 07:35:41 INFO - PROCESS | 14025 | 07:35:43 INFO - PROCESS | 14025 | Cycle 1(1): loaded http://localhost:35853/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35853/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:35:43 INFO - PROCESS | 14025 | RSS: Main: 226906112 07:35:43 INFO - PROCESS | 14025 | 07:35:45 INFO - PROCESS | 14025 | Cycle 1(1): loaded http://localhost:35853/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35853/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:35:46 INFO - PROCESS | 14025 | RSS: Main: 231038976 07:35:46 INFO - PROCESS | 14025 | 07:35:48 INFO - PROCESS | 14025 | Cycle 1(1): loaded http://localhost:35853/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35853/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:35:48 INFO - PROCESS | 14025 | RSS: Main: 236814336 07:35:48 INFO - PROCESS | 14025 | 07:35:51 INFO - PROCESS | 14025 | Cycle 1(1): loaded http://localhost:35853/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35853/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:35:52 INFO - PROCESS | 14025 | RSS: Main: 240820224 07:35:52 INFO - PROCESS | 14025 | 07:35:54 INFO - PROCESS | 14025 | Cycle 1(1): loaded http://localhost:35853/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35853/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:35:55 INFO - PROCESS | 14025 | RSS: Main: 238944256 07:35:55 INFO - PROCESS | 14025 | 07:35:56 INFO - PROCESS | 14025 | Cycle 1(1): loaded http://localhost:35853/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35853/tests/kraken/driver.html?testName=ai-astar) 07:35:57 INFO - PROCESS | 14025 | RSS: Main: 281878528 07:35:57 INFO - PROCESS | 14025 | 07:35:57 INFO - PROCESS | 14025 | __start_tp_report 07:35:57 INFO - PROCESS | 14025 | _x_x_mozilla_page_load 07:35:57 INFO - PROCESS | 14025 | _x_x_mozilla_page_load_details 07:35:57 INFO - PROCESS | 14025 | |i|pagename|runs| 07:35:57 INFO - PROCESS | 14025 | |0;ai-astar;101;111;111;110;110;110;109;110;109;109 07:35:57 INFO - PROCESS | 14025 | |1;audio-beat-detection;150;131;132;179;135;155;148;129;184;125 07:35:57 INFO - PROCESS | 14025 | |2;audio-dft;162;161;161;161;160;162;162;161;172;160 07:35:57 INFO - PROCESS | 14025 | |3;audio-fft;75;74;75;127;76;75;75;74;100;76 07:35:57 INFO - PROCESS | 14025 | |4;audio-oscillator;84;85;118;85;86;86;112;86;85;125 07:35:57 INFO - PROCESS | 14025 | |5;imaging-gaussian-blur;117;117;117;116;116;117;117;116;116;117 07:35:57 INFO - PROCESS | 14025 | |6;imaging-darkroom;145;146;145;146;145;145;146;146;145;146 07:35:57 INFO - PROCESS | 14025 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 07:35:57 INFO - PROCESS | 14025 | |8;json-parse-financial;54;53;54;54;54;53;54;54;54;54 07:35:57 INFO - PROCESS | 14025 | |9;json-stringify-tinderbox;62;62;62;63;64;63;64;63;63;68 07:35:57 INFO - PROCESS | 14025 | |10;stanford-crypto-aes;82;85;79;79;78;79;83;81;89;80 07:35:57 INFO - PROCESS | 14025 | |11;stanford-crypto-ccm;133;132;128;127;122;123;127;121;129;123 07:35:57 INFO - PROCESS | 14025 | |12;stanford-crypto-pbkdf2;161;161;162;158;157;161;164;161;163;159 07:35:57 INFO - PROCESS | 14025 | |13;stanford-crypto-sha256-iterative;64;64;63;62;66;65;61;60;65;60 07:35:57 INFO - PROCESS | 14025 | __end_tp_report 07:35:57 INFO - PROCESS | 14025 | __start_cc_report 07:35:57 INFO - PROCESS | 14025 | _x_x_mozilla_cycle_collect,1654 07:35:57 INFO - PROCESS | 14025 | __end_cc_report 07:35:57 INFO - PROCESS | 14025 | __startTimestamp1466778957210__endTimestamp 07:35:57 INFO - PROCESS | 14025 | 07:35:57 INFO - PROCESS | 14025 | ------- Summary: start ------- 07:35:57 INFO - PROCESS | 14025 | Number of tests: 14 07:35:57 INFO - PROCESS | 14025 | 07:35:57 INFO - PROCESS | 14025 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.00 stddev:2.91 (2.6%) stddev-sans-first:0.78 07:35:57 INFO - PROCESS | 14025 | Values: 101.0 111.0 111.0 110.0 110.0 110.0 109.0 110.0 109.0 109.0 07:35:57 INFO - PROCESS | 14025 | 07:35:57 INFO - PROCESS | 14025 | [#1] audio-beat-detection Cycles:10 Average:146.80 Median:149.00 stddev:20.82 (14.0%) stddev-sans-first:22.05 07:35:57 INFO - PROCESS | 14025 | Values: 150.0 131.0 132.0 179.0 135.0 155.0 148.0 129.0 184.0 125.0 07:35:57 INFO - PROCESS | 14025 | 07:35:57 INFO - PROCESS | 14025 | [#2] audio-dft Cycles:10 Average:162.20 Median:161.50 stddev:3.52 (2.2%) stddev-sans-first:3.73 07:35:57 INFO - PROCESS | 14025 | Values: 162.0 161.0 161.0 161.0 160.0 162.0 162.0 161.0 172.0 160.0 07:35:57 INFO - PROCESS | 14025 | 07:35:57 INFO - PROCESS | 14025 | [#3] audio-fft Cycles:10 Average:82.70 Median:75.00 stddev:17.45 (23.3%) stddev-sans-first:18.28 07:35:57 INFO - PROCESS | 14025 | Values: 75.0 74.0 75.0 127.0 76.0 75.0 75.0 74.0 100.0 76.0 07:35:57 INFO - PROCESS | 14025 | 07:35:57 INFO - PROCESS | 14025 | [#4] audio-oscillator Cycles:10 Average:95.20 Median:85.00 stddev:16.27 (19.1%) stddev-sans-first:16.74 07:35:57 INFO - PROCESS | 14025 | Values: 84.0 85.0 118.0 85.0 86.0 86.0 112.0 86.0 85.0 125.0 07:35:57 INFO - PROCESS | 14025 | 07:35:57 INFO - PROCESS | 14025 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 07:35:57 INFO - PROCESS | 14025 | Values: 117.0 117.0 117.0 116.0 116.0 117.0 117.0 116.0 116.0 117.0 07:35:57 INFO - PROCESS | 14025 | 07:35:57 INFO - PROCESS | 14025 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 07:35:57 INFO - PROCESS | 14025 | Values: 145.0 146.0 145.0 146.0 145.0 145.0 146.0 146.0 145.0 146.0 07:35:57 INFO - PROCESS | 14025 | 07:35:57 INFO - PROCESS | 14025 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 07:35:57 INFO - PROCESS | 14025 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 07:35:57 INFO - PROCESS | 14025 | 07:35:57 INFO - PROCESS | 14025 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:0.42 (0.8%) stddev-sans-first:0.44 07:35:57 INFO - PROCESS | 14025 | Values: 54.0 53.0 54.0 54.0 54.0 53.0 54.0 54.0 54.0 54.0 07:35:57 INFO - PROCESS | 14025 | 07:35:57 INFO - PROCESS | 14025 | [#9] json-stringify-tinderbox Cycles:10 Average:63.40 Median:63.00 stddev:1.78 (2.8%) stddev-sans-first:1.81 07:35:57 INFO - PROCESS | 14025 | Values: 62.0 62.0 62.0 63.0 64.0 63.0 64.0 63.0 63.0 68.0 07:35:57 INFO - PROCESS | 14025 | 07:35:57 INFO - PROCESS | 14025 | [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:81.50 stddev:3.41 (4.2%) stddev-sans-first:3.61 07:35:57 INFO - PROCESS | 14025 | Values: 82.0 85.0 79.0 79.0 78.0 79.0 83.0 81.0 89.0 80.0 07:35:57 INFO - PROCESS | 14025 | 07:35:57 INFO - PROCESS | 14025 | [#11] stanford-crypto-ccm Cycles:10 Average:126.50 Median:127.50 stddev:4.17 (3.3%) stddev-sans-first:3.70 07:35:57 INFO - PROCESS | 14025 | Values: 133.0 132.0 128.0 127.0 122.0 123.0 127.0 121.0 129.0 123.0 07:35:57 INFO - PROCESS | 14025 | 07:35:57 INFO - PROCESS | 14025 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.70 Median:161.00 stddev:2.16 (1.3%) stddev-sans-first:2.29 07:35:57 INFO - PROCESS | 14025 | Values: 161.0 161.0 162.0 158.0 157.0 161.0 164.0 161.0 163.0 159.0 07:35:57 INFO - PROCESS | 14025 | 07:35:57 INFO - PROCESS | 14025 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:64.00 stddev:2.16 (3.4%) stddev-sans-first:2.26 07:35:57 INFO - PROCESS | 14025 | Values: 64.0 64.0 63.0 62.0 66.0 65.0 61.0 60.0 65.0 60.0 07:35:57 INFO - PROCESS | 14025 | -------- Summary: end -------- 07:35:57 INFO - PROCESS | 14025 | 07:35:58 INFO - TEST-INFO | 14025: exit 0 07:35:58 INFO - TEST-OK | kraken | took 62457ms 07:35:58 INFO - SUITE-END | took 1178s 07:35:58 INFO - Completed test suite (00:19:38) 07:35:58 INFO - javascript benchmark 07:35:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3105.4099721053, 3106.6427360853495, 3128.343047959929, 3156.7001134892207, 3162.841857907104, 5273.920891186635, 5340.359156901172, 5345.652532585389, 5432.103702889023, 5438.48334408231, 5395.568354531628, 5404.054290499166, 5415.323084614423, 5475.260839786638, 5519.641223320491, 4840.394950631162, 4875.829345972892, 4909.729964851932, 4913.852584422473, 5072.289879416885, 4970.130227210224, 5001.349824522807, 5014.172661510846, 5025.472325405834, 5032.295478632995, 4769.976150119262, 4812.0, 4817.4219093708625, 4860.6111511079025, 4964.702117872921, 4783.593394561466, 4787.42550893895, 4787.473377928425, 4851.975740121312, 4885.047415753929, 4761.309610106549, 4802.06359759847, 4807.42310922688, 4832.782524786393, 4849.248366503198, 5204.843854684365, 5251.396089449686, 5329.893402131975, 5335.439778823245, 5373.194020896896, 5687.971560142214, 5739.512141467981, 5739.913901291484, 5751.798687045975, 5757.165211044375, 5743.712814359265, 5792.218050563204, 5806.0, 5812.651240925558, 5812.709364531756, 5182.041322355376, 5389.380221274525, 5395.514403703724, 5506.807261745819, 5513.531349835309, 6056.666883321372, 6061.121137435047, 6064.66644334557, 6066.1204125402455, 6069.848253793691, 5783.392743761929, 5790.855228619318, 5792.507636850914, 5800.4199580042505, 5800.53595712342, 5612.943870561324, 5664.915026274609, 5716.314042314949, 5717.199592057115, 5726.856828579319, 5710.914336284959, 5712.914306285409, 5717.199592057115, 5719.828405147852, 5726.398728133569, 5616.5787565932715, 5667.291588551431, 5710.65736055838, 5711.514521265739, 5721.0, 4353.434053573079, 4360.302351623725, 4381.255186618282, 4395.692301538862, 4402.207602631557, 3921.0785465415606, 3931.7837518936735, 3932.9016774580864, 3965.5439624442984, 3965.9603403966166, 5431.375391829911, 5445.83662490126, 5448.0, 5449.128139497661, 5450.4549545045975, 5607.299087614048, 5698.116791897262, 5775.826725198251, 5779.450952159538, 5789.247397838254, 5425.348958125051, 5427.294451721251, 5438.592105592096, 5441.945580544144, 5450.345958485007, 4881.975590122027, 4981.252812078144, 4998.175301075355, 5000.799968001312, 5032.949670503248, 5782.710864456844, 5841.678707671119, 5847.56143289255, 5934.673592952343, 5936.970315148396, 5649.491545760901, 5651.406602306699, 5654.180143879033, 5659.434056594308, 5670.489655930986, 5869.6771677556435, 5872.207252020922, 5880.26496687914, 5882.382349853204, 5882.970585147047, 5435.347758269033, 5544.417836127149, 5566.693831839288, 5576.1356989666665, 5603.8879222416135, 5649.519790817826, 5684.261046063985, 5704.0, 5714.228579141763, 5714.457126572969, 5450.427705091067, 5553.611247212656, 5559.63862348946, 5566.860828479321, 5568.415316391721, 5528.530074943675, 5595.300587426572, 5602.663840169603, 5642.351129620146, 5649.096144616841, 5514.724263786875, 5535.501804837584, 5537.972310138423, 5542.501174894279, 5552.194931734956, 5463.754131064032, 5486.177073439016, 5618.915716264341, 5682.431756824284, 5684.374718781013, 5446.891062178814, 5470.671759694431, 5493.533049690821, 5494.148406996922, 5502.394736579053], "value": 5288.068322383897, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.35740719469, 601.1193601373986, 601.4827248566235, 604.7278724573943, 612.3172662481335, 29882.0, 30589.388212235768, 32763.344733105325, 32921.83539082301, 42855.357169642404, 41118.38322425166, 44921.0, 45002.0, 45046.549534504644, 45119.54880451194, 8932.642694292237, 9091.727248182566, 9095.863562046574, 9096.681616143436, 9099.545022748836, 8889.111088891124, 8977.416467929565, 8981.371304008722, 8998.28013758901, 8998.68504602339, 8937.374383793138, 9064.410813297147, 9064.864027039599, 9065.59204835784, 9069.138431848996, 8980.191782739552, 9010.909890901072, 9022.09779022099, 9031.187193152648, 9031.503267320295, 9011.008789033202, 9051.864222036675, 9072.727818165466, 9084.636614535411, 9088.18206361424, 40983.38524922128, 41294.587054129675, 41326.58673413288, 41376.0, 41386.1722765546, 3326.933461330784, 3432.5709286339206, 3455.05562471595, 3503.61460239376, 3549.946750798714, 32165.517517237262, 32366.352672946643, 32400.675993240002, 32791.06507219125, 33793.6620633793, 3627.963720362789, 4019.3970904364287, 4033.6974726895305, 4051.6556092732153, 4201.831926722927, 351940.0, 352099.0, 353627.0, 353840.0, 354354.0, 61603.0, 62053.68973155195, 62250.68874655598, 62329.37670623236, 62417.687911560155, 35555.466668, 36315.27369452596, 36343.4548481773, 37626.81186594104, 63074.0, 17756.822431775774, 17832.55418614545, 17843.375481858333, 17944.37194698179, 17947.461576152735, 13521.0, 13611.931940340235, 13672.863271367358, 13679.452821887213, 13679.521216757565, 19352.903235483733, 19463.90268048679, 19537.316193933144, 19579.412617621496, 19637.116329765195, 7104.92895071053, 7142.321479459443, 7201.71193152268, 7299.379552738077, 7318.485968241265, 967.7822489939707, 1033.1734612310122, 1074.88497540854, 1078.5200585739428, 1106.8671759388924, 32299.838500807346, 32682.18294542608, 32753.508697369558, 32952.0, 33369.49945750816, 1090.8091084060416, 1154.878737732526, 1187.9643610691694, 1194.4770417717307, 1227.6501197158766, 17192.656146876994, 17274.790764646354, 17344.219510121824, 17407.477775666495, 17408.303667853143, 489082.0, 490548.0, 491790.0, 493296.0, 494327.0, 59097.70451147803, 59211.0, 59526.70236648789, 59635.40364596385, 59775.0, 1248.656619429664, 1319.346923272986, 1353.350391811916, 1355.6068740065468, 1373.5440433140902, 31814.840925795223, 33430.331393372486, 33601.327973440886, 33999.98018880077, 34066.489002664486, 50149.49850501448, 50290.748546258495, 50772.74613626908, 50800.49199508106, 50833.0, 302957.0, 306176.0, 307110.0, 307704.0, 308044.0, 25122.24633261005, 27118.864405677847, 27575.862120689268, 27970.0, 28151.296217594725, 42159.1568168641, 44757.77621111873, 48814.0, 49647.50352496573, 49851.25223121729, 39866.80066599648, 40584.188316234104, 40964.38553421761, 41170.58829411668, 41965.79017105017, 40796.592034080466, 40828.38757418701, 41013.79493102516, 41396.55112071063, 42059.36910946277, 39931.20137597174, 39958.2008359837, 40476.0, 40505.18989620132, 40632.390514142906, 35860.64139358573, 35977.82011089928, 36194.4570831443, 36950.63049369472, 37049.44425833668, 27849.860750696116, 28211.858940705166, 28267.575986360633, 28408.147755567366, 28482.715172848006], "value": 19694.554992663052, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.1804620066856, 391.692521370724, 391.8883118311281, 399.38494718134075, 407.05156984226755, 17978.0, 18553.721694174597, 19754.0, 20727.896360518214, 20728.170873165072, 11594.478248478817, 11825.231359961597, 12224.572139975102, 12230.938845305784, 12234.694132646688, 4988.87527811804, 5168.689878607277, 5174.43081261061, 5198.376194856603, 5200.661956972804, 3844.1350696093436, 6917.308269173092, 7403.0, 7405.148407933103, 7419.36935360495, 6972.233054364041, 7301.306375894282, 7301.707931682727, 7405.8889116663295, 7423.962880185619, 7216.927830721731, 7316.890246646304, 7417.888731669029, 7418.369438597726, 7422.369098626623, 7217.783466496014, 7218.242084581096, 7218.747343842941, 7233.493655444121, 7251.238619944936, 25532.36169095769, 25743.485130297475, 26288.73711262882, 26871.865640671673, 26959.191224263304, 2346.307839187427, 2448.4613385055436, 2692.488427198826, 3105.3634005028916, 3139.780215384924, 15410.537683869501, 15417.3833046678, 15858.127802970832, 15980.920095399448, 16249.968753905761, 1873.5690791117984, 1883.5856111655414, 1958.1482055305846, 1979.4655443030301, 2032.1363420546209, 91845.0, 94495.52752236264, 96017.51991239999, 96205.0, 98910.0, 16506.58733531671, 17602.559936001446, 17625.118744062747, 17786.46640600784, 18326.175322110535, 30581.38837223243, 32031.51952720711, 32086.679133208836, 32127.839360803046, 32214.355712885612, 10079.848802267972, 10162.69511914629, 10265.640702575374, 10410.167186625053, 10426.635067772591, 8484.19400156984, 8561.315094792402, 8855.64577416909, 8857.025727170007, 9092.27261819053, 7275.263116245898, 7964.920350796418, 9017.368784185044, 9164.175224229852, 9171.58727857248, 3179.3164469639137, 3286.309874926292, 3383.238771276443, 3448.5344478495585, 3503.684668379807, 916.8762217100606, 998.201438848918, 999.7300728803328, 1023.672424824064, 1034.13132968307, 18914.621707565773, 19616.509587260432, 19629.901850490656, 19740.30908918181, 19756.70364944527, 992.3946392700446, 1007.4660429972126, 1027.3168343051937, 1039.9636012739518, 1041.239894876729, 10228.181745460346, 10876.456177191109, 11044.558217671203, 11046.502907369188, 11114.610988615521, 474367.0, 478138.0, 478586.0, 493230.0, 498047.0, 87639.56180219186, 87924.56037719898, 89193.0, 89207.55396222978, 89752.5512372434, 983.8622592837008, 996.2030375699411, 996.3858549150423, 1008.2790804574764, 1013.9493025348703, 17267.0, 17292.0, 17387.913060434617, 17401.0, 17533.473995780147, 41356.1728765429, 42063.36904946367, 42636.78681606572, 43152.56847431611, 43918.780406097765, 53906.73046634742, 56304.43695563156, 57276.42723572878, 57695.42304576901, 57775.422245777, 7976.3618910488185, 8580.099089595502, 8580.14198580137, 8638.13618638131, 8805.075467075865, 12489.812652810033, 13423.664408389477, 13703.314834258048, 13792.793108103588, 14002.159870407808, 11025.944870275598, 11661.24201926872, 11981.28112313264, 12065.577704780291, 12508.374581271082, 11815.113866459878, 12196.390180490762, 12313.56902508408, 12401.0, 12519.186252893533, 12062.215955962834, 12118.394080296126, 12142.514299427923, 12284.262944223376, 12293.815592766294, 8670.13298670128, 8795.164459376349, 8803.60383782744, 8921.643134274816, 9111.635534578543, 11551.978403779473, 12166.148369614042, 12214.0, 12310.692232693897, 12315.630531084082], "value": 10324.701618416279, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1287.6008437384405, 1428.5857101440579, 1461.8903582231333, 1537.715522628314, 1694.7034269002913, 8622.180892815188, 8932.151445612664, 8963.327750418712, 9286.0, 9295.209907157883, 9071.365004449675, 9268.119528644767, 9274.350795444305, 9274.768130796734, 9278.58246378913, 1943.3004118517322, 2216.3350994701605, 2261.8416710830247, 2289.9313020609325, 2291.2438895164555, 2310.260716570698, 2320.8839558022114, 2322.1175953137868, 2322.2684854270933, 2324.8023917966907, 2268.3308424014954, 2272.5114100468395, 2306.6655334976417, 2309.0, 2309.110992267972, 1911.2832687742098, 2139.3261122746285, 2188.6935828983956, 2189.3650841256017, 2220.589190999662, 2192.5176461178676, 2198.835087368454, 2218.4897473581004, 2221.3780141560387, 2222.3333000099906, 9278.768030799216, 9412.858807117898, 9421.48181849998, 9426.528673566294, 9427.3400861939, 5173.922391164136, 5302.6023048271145, 5305.973470132624, 5310.867228319323, 5313.990341835078, 3193.8882139125253, 3213.228825081987, 3266.3630592034324, 3308.4044871923043, 3314.7016768490953, 1067.2849191042021, 1080.2978064258216, 1884.8869067855971, 1914.3682584747, 1930.806919308072, 12868.935655321664, 13142.4085916134, 13146.737065258641, 13148.934255328757, 13150.276734779583, 4450.421445212167, 4517.141743068806, 4555.0, 4586.72479651222, 4591.4260717410325, 10326.845097323396, 10338.741531461774, 10340.948295258626, 10341.37951722899, 10342.482875856327, 5282.418933917266, 5323.121684922022, 5328.333958255218, 5365.436629153883, 5377.569794416438, 4338.284183109751, 4758.1673207188605, 4905.9018819624125, 4930.063287975345, 5002.224655178453, 3741.9625803741615, 3817.0838998640684, 3877.6703980162, 3919.8824035278985, 3934.075492259317, 1093.7703082352637, 1126.8704099028553, 1130.4799792095564, 1135.744457497073, 1144.101880024177, 962.1196605106389, 962.43216502264, 968.0561452583675, 973.9951300243595, 977.4379731654327, 5968.671723055187, 5994.37059108796, 6166.414190651881, 6306.432421082125, 6419.51853610981, 423.9993615068436, 426.3093788063357, 426.5201648145836, 429.3559660509236, 436.700859910962, 4084.2648323301496, 4318.632916202095, 4323.956760432418, 4363.127374525045, 4396.692231543825, 11440.59957901486, 11963.700907477209, 11985.16103872738, 11986.220895641756, 11992.76014479723, 11118.166137539716, 11544.365059921785, 11549.480273387719, 11962.40187990597, 11965.40172991347, 8562.186592273723, 8763.167499087449, 8765.386422950332, 8769.0, 8774.429662071945, 6116.969415153074, 6254.249490061222, 6389.68051597409, 6391.776287829904, 6464.547481676237, 10171.0, 10721.41032243203, 10852.782944341227, 10861.131109511378, 10879.292845964987, 10642.095421889226, 10745.409002504937, 10980.670579882617, 10999.670009899715, 11104.389258590854, 8731.694390696295, 8741.519216443157, 8812.735617931472, 8998.955005224932, 9015.233705135137, 8900.910990890008, 8974.057723939153, 8989.235914947303, 9025.954870225869, 9089.636414543344, 8102.108768035393, 8216.342692584698, 8244.422890397615, 8307.252347288531, 8336.249737523653, 7830.725924592612, 7840.098388685375, 7873.5275883447175, 8040.356771458152, 8086.070101938117, 7143.214246432992, 7241.963790181016, 7246.60143692102, 7249.202587715453, 7259.947307640468, 5166.715830629201, 5241.868953276198, 5318.680879147263, 5327.467253274796, 5382.865428364322, 5028.245763135559, 5072.54347108762, 5106.66806657566, 5128.999845030184, 5255.0540902637895], "value": 4663.2883115389595, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.42046004661336, 321.3188041352333, 326.03818734732545, 330.9271960168762, 331.80920970442, 4980.526849949249, 5036.3452751142395, 5272.762725677344, 5340.599455040868, 5362.2224777407255, 5274.683518988853, 5295.735213239342, 5303.310569625944, 5308.495692909177, 5311.309529761125, 4228.260054490467, 4230.598093181143, 4238.80925358358, 4243.130158317537, 4245.426867372911, 3974.5429275633383, 4070.409790580364, 4168.166366726667, 4215.3887686285625, 4228.175505776375, 4152.771597562133, 4155.0, 4166.749995000295, 4168.97915510422, 4177.895552611179, 4113.239050775616, 4114.292568584034, 4122.484689413824, 4129.8967525811795, 4129.958700412987, 3414.2659328244545, 3686.686631636314, 3711.480392745018, 3723.9441408378625, 3733.253349330145, 5150.665206761549, 5156.510131537535, 5159.406668233126, 5175.894463322014, 5178.249153872667, 4680.204365257914, 4703.048234982478, 4720.575148236675, 4728.503507131736, 4741.905161896742, 5326.280952071459, 5408.2698835657075, 5518.889622207574, 5523.199136125239, 5535.750891209865, 3925.2738243424774, 3941.211757648453, 3949.763014219156, 3950.940735888964, 3968.9007774805573, 5499.230107784913, 5622.453825198062, 5687.203791469197, 5757.798477053325, 5774.740136693859, 3967.1272320089533, 3969.3450580653866, 3972.2254160439015, 4004.099077707551, 4015.0163210013147, 4004.3593025115842, 4008.158286759755, 4037.2329257440992, 4048.0, 4072.6945479089186, 4528.50186479487, 4647.744374059392, 4685.554872287127, 4692.178868698033, 4711.104890070944, 5518.944810551923, 5523.889522209533, 5525.336959564878, 5537.0, 5539.750711218005, 1392.1507880193074, 1403.7262733767022, 1404.34697865491, 1406.2757679794913, 1406.5863806874027, 879.0551651965991, 880.3309484791477, 887.0995939121797, 901.7925877048316, 936.9578368973413, 4685.320628508847, 4730.526947305242, 4755.833545825949, 4767.855714628464, 4792.904141917142, 4963.702177869267, 5001.224810154432, 5003.324551185616, 5046.470120637354, 5063.0, 4616.307553866947, 4682.297655351656, 4727.865312325086, 4735.242361222188, 4782.3543821584335, 2629.421527263999, 2700.824446410977, 2706.1746167418733, 2711.9050833221136, 2718.3224523843996, 5104.183330667075, 5106.412762532282, 5169.974150129226, 5185.9740701297005, 5229.398619158769, 4913.616895805531, 4917.262410638361, 5046.974765126224, 5110.616703747234, 5136.919547583235, 5115.155999260155, 5140.485951404829, 5171.741412929338, 5175.197844334059, 5211.869703257449, 4956.975215123901, 5036.445990941067, 5040.294358789699, 5051.646384753179, 5057.494250574913, 5015.648904576645, 5053.797848086036, 5219.48634895876, 5672.4894759471845, 5722.882533462645, 5638.0, 5671.801486947937, 5918.378570250062, 5949.196858424058, 5955.315138759098, 4104.4664193654635, 4114.91770164601, 4118.588141185857, 4132.442120313719, 4138.503379594468, 5623.407258165218, 5712.429082002483, 5716.42835716425, 5730.3410107838135, 5752.309722833287, 5528.557715382679, 5535.7785688572, 5551.2228288040515, 5556.916646250229, 5587.692676902647, 5528.087865502147, 5528.861778455571, 5536.318348298337, 5540.722963851872, 5541.2796336476, 5236.9738151309, 5421.512063914267, 5432.429594892637, 5465.426130256425, 5483.588730845282, 5459.863503412446, 5588.972055139699, 5610.579206559442, 5620.1288800236025, 5624.74688639004, 5433.185022246695, 5437.31443252593, 5447.101228297287, 5453.400125986059, 5456.663117536229], "value": 4099.590811908771, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.781764379508, 759.290063790356, 791.2166954714827, 801.1907972947323, 828.1718281718282, 14111.364988575513, 14676.633084172887, 15024.248787560606, 15037.849621503781, 15071.095734255938, 14719.92640036801, 15065.92467037666, 15077.321520531576, 15094.245287735625, 15094.396224151049, 671.8857794174977, 787.3347021766598, 800.5036877136155, 808.2806302390877, 814.3485211830541, 800.951942883426, 801.4349883332237, 801.4429971170039, 806.9031716194065, 806.9993208421545, 854.1970547685187, 856.3363393370125, 857.4169564696004, 858.2790456016944, 859.072202021815, 708.6385943168996, 825.4881973176639, 845.2055068235838, 845.2688424512752, 857.2627540315324, 612.5558969746943, 613.1232337757006, 614.5912967876357, 614.97232624532, 619.2383368456823, 14707.779383309258, 14736.189509576969, 14754.631134221623, 14761.704765904622, 14764.409423623043, 13798.0, 13829.170249785046, 13963.58109256724, 14130.858691413057, 14573.417063317454, 12614.495420183182, 12651.936740316332, 12837.229766214057, 12877.549285775047, 13509.864901350958, 4447.466304043503, 4491.752953587551, 4502.459704835408, 4581.67928245023, 4634.096351211515, 74654.62672686655, 75642.62178689126, 75657.0, 75789.24210757877, 76096.23903760947, 10510.947445262878, 10857.619983300547, 10926.508307126198, 11054.336739795637, 11055.502502387251, 19280.903595481934, 19371.612567748565, 19382.321618743557, 19396.80603193978, 19416.12627431769, 7568.735094271784, 7713.074431068308, 8087.110417854032, 8567.74296771098, 8613.440126391764, 4424.137293227854, 4461.7992190351515, 4493.168763778712, 4580.198465268565, 4589.701669391546, 3172.889488678944, 3246.740260779132, 3253.5933008373954, 3255.3977514159956, 3259.6903294187014, 551.4788524843984, 566.212963980068, 583.982480525585, 585.2742599176989, 612.3142080869454, 569.5415190771386, 618.4681174190193, 618.6403769252096, 670.1522573943964, 680.404645934807, 8962.14859588338, 9080.8637870432, 9271.629134834531, 9423.623055077856, 9663.226941844636, 622.7758007117434, 654.2410803468049, 668.7563225378784, 671.5869740109895, 709.6487238816819, 4591.311303304531, 4700.153972285021, 4749.430068391746, 4770.0, 4784.569388754959, 112687.0, 113235.0, 113770.0, 114973.0, 118015.0, 58323.0, 60094.0, 68698.65650671715, 82448.58775706204, 94195.52902235583, 63490.68254658697, 69411.65294173497, 86574.56712716396, 91630.54184729034, 92858.21425357385, 9628.229741620793, 10410.115140213167, 10476.0, 10546.57813687444, 10611.8938810614, 43763.56236437722, 49748.751256243486, 50939.49060509347, 52588.47411525836, 53019.734901325246, 47707.0, 62835.6858215706, 70735.29264707287, 74151.25848741444, 74581.0, 12351.0, 12686.726790662176, 12988.531950956196, 13023.47906083746, 13282.269475178571, 15404.92297538505, 15494.612634684223, 15645.921770391074, 15688.450904218755, 16021.359145634044, 10325.9483702581, 13795.655108622364, 13943.442262309394, 14425.567232982607, 14493.420263189355, 12867.292298923649, 13035.47858085666, 13117.147385419918, 13315.1345162568, 14219.360128794437, 14097.0, 14340.21128837924, 14422.07411674717, 14467.710645787236, 14469.421223150955, 10670.679879603624, 10733.248672592843, 10890.61882834097, 11064.778704425706, 11217.607383741857, 11209.0, 11430.127760721203, 11689.298642081503, 11810.0, 11842.230255033395], "value": 7373.641817048399, "unit": "score"}], "name": "dromaeo_css", "value": 7302.089462852362, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 111.0, 110.0, 110.0, 110.0, 109.0, 110.0, 109.0, 109.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 131.0, 132.0, 179.0, 135.0, 155.0, 148.0, 129.0, 184.0, 125.0], "value": 146.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 161.0, 160.0, 162.0, 162.0, 161.0, 172.0, 160.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 127.0, 76.0, 75.0, 75.0, 74.0, 100.0, 76.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 118.0, 85.0, 86.0, 86.0, 112.0, 86.0, 85.0, 125.0], "value": 95.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 54.0, 54.0, 53.0, 54.0, 54.0, 54.0, 54.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 63.0, 64.0, 63.0, 64.0, 63.0, 63.0, 68.0], "value": 63.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 85.0, 79.0, 79.0, 78.0, 79.0, 83.0, 81.0, 89.0, 80.0], "value": 81.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 132.0, 128.0, 127.0, 122.0, 123.0, 127.0, 121.0, 129.0, 123.0], "value": 126.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 158.0, 157.0, 161.0, 164.0, 161.0, 163.0, 159.0], "value": 160.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 62.0, 66.0, 65.0, 61.0, 60.0, 65.0, 60.0], "value": 63.0, "unit": "score"}], "name": "kraken", "value": 1501.9, "alertThreshold": 2.0}]} 07:35:58 INFO - Return code: 0 07:35:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:35:58 INFO - # TBPL SUCCESS # 07:35:58 INFO - Running post-action listener: _resource_record_post_action 07:35:58 INFO - ##### 07:35:58 INFO - ##### Finished run-tests step (success) 07:35:58 INFO - ##### 07:35:58 INFO - Running post-run listener: _resource_record_post_run 07:35:58 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 552116224; Read time: 12; Write time: 1266828 07:35:58 INFO - TinderboxPrint: CPU usage
13.3% 07:35:58 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 07:35:58 INFO - TinderboxPrint: I/O write bytes / time
552,116,224 / 1,266,828 07:35:58 INFO - TinderboxPrint: CPU idle
8,276.1 (86.6%) 07:35:58 INFO - TinderboxPrint: CPU user
1,214.1 (12.7%) 07:35:58 INFO - TinderboxPrint: Swap in / out
0 / 0 07:35:58 INFO - install - Wall time: 17s; CPU: 18.0%; Read bytes: 0; Write bytes: 256593920; Read time: 0; Write time: 780616 07:35:58 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294936576; Read time: 12; Write time: 485960 07:35:59 INFO - Running post-run listener: _upload_blobber_files 07:35:59 INFO - Blob upload gear active. 07:35:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:35:59 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 07:35:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:35:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:35:59 INFO - (blobuploader) - INFO - Open directory for files ... 07:35:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:35:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:35:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:36:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:36:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:36:03 INFO - (blobuploader) - INFO - Done attempting. 07:36:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:36:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:36:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:36:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:36:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:36:03 INFO - (blobuploader) - INFO - Done attempting. 07:36:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:36:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:36:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:36:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:36:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:36:04 INFO - (blobuploader) - INFO - Done attempting. 07:36:04 INFO - (blobuploader) - INFO - Iteration through files over. 07:36:04 INFO - Return code: 0 07:36:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:36:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:36:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a87c81e3a52f78a4cd6af4454b1778b3760aafe02fcedce7fd2e6230ddac5144124d5b5e9236f08947dd486b85f750855b9c0fda8ecd4bf6e8eb5f885b8a702", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de0ed27ef06e4bd978805f47593f0d6698b8a5e410da525c4aa683c327f8a1aae3a53d79872a5dbf5a3c62e27db9a9a9234f657b2ac62b343ff220620e392365", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/96406b8d62394354e7371aee93ccb05bfb254d25f323dfb8fc9a56a22402850a89aaefbc6c9488e29fcb736eac768e39b589790c466e91de062d58b041707abc"} 07:36:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:36:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:36:04 INFO - Contents: 07:36:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a87c81e3a52f78a4cd6af4454b1778b3760aafe02fcedce7fd2e6230ddac5144124d5b5e9236f08947dd486b85f750855b9c0fda8ecd4bf6e8eb5f885b8a702", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de0ed27ef06e4bd978805f47593f0d6698b8a5e410da525c4aa683c327f8a1aae3a53d79872a5dbf5a3c62e27db9a9a9234f657b2ac62b343ff220620e392365", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/96406b8d62394354e7371aee93ccb05bfb254d25f323dfb8fc9a56a22402850a89aaefbc6c9488e29fcb736eac768e39b589790c466e91de062d58b041707abc"} 07:36:04 INFO - Running post-run listener: copy_logs_to_upload_dir 07:36:04 INFO - Copying logs to upload dir... 07:36:04 INFO - mkdir: /builds/slave/test/build/upload/logs 07:36:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.414521 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-24 07:36:04.916515) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 07:36:04.920481) ========= 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=745a4373a2a16df560f216e000000264-1466777723.158442-1431706717 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a87c81e3a52f78a4cd6af4454b1778b3760aafe02fcedce7fd2e6230ddac5144124d5b5e9236f08947dd486b85f750855b9c0fda8ecd4bf6e8eb5f885b8a702", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de0ed27ef06e4bd978805f47593f0d6698b8a5e410da525c4aa683c327f8a1aae3a53d79872a5dbf5a3c62e27db9a9a9234f657b2ac62b343ff220620e392365", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/96406b8d62394354e7371aee93ccb05bfb254d25f323dfb8fc9a56a22402850a89aaefbc6c9488e29fcb736eac768e39b589790c466e91de062d58b041707abc"} build_url:https://queue.taskcluster.net/v1/task/CN545vF6TpaQoGM-19uF0A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011570 build_url: 'https://queue.taskcluster.net/v1/task/CN545vF6TpaQoGM-19uF0A/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/Firefox/sha512/9a87c81e3a52f78a4cd6af4454b1778b3760aafe02fcedce7fd2e6230ddac5144124d5b5e9236f08947dd486b85f750855b9c0fda8ecd4bf6e8eb5f885b8a702", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de0ed27ef06e4bd978805f47593f0d6698b8a5e410da525c4aa683c327f8a1aae3a53d79872a5dbf5a3c62e27db9a9a9234f657b2ac62b343ff220620e392365", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/96406b8d62394354e7371aee93ccb05bfb254d25f323dfb8fc9a56a22402850a89aaefbc6c9488e29fcb736eac768e39b589790c466e91de062d58b041707abc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 07:36:04.949396) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 07:36:04.950212) ========= 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=745a4373a2a16df560f216e000000264-1466777723.158442-1431706717 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004495 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 07:36:05.030005) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 07:36:05.030360) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 07:36:05.030667) ========= ========= Total master_lag: 0.19 =========