builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-047 starttime: 1466507667.7 results: success (0) buildid: 20160621025605 builduid: 18c7bc5306884d04b4a6e8cd47f1f130 revision: 027db1e33f89606c4996feae0203e5f3bb5db43d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 04:14:27.695911) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 04:14:27.696362) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 04:14:27.696649) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 04:14:27.711106) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 04:14:27.711479) ========= 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=03627c79f6bb3d1578c4a402000001ba-1466507667.694690-364733738 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-21 04:14:28-- 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% 38.9M=0s 2016-06-21 04:14:28 (38.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104370 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 04:14:27.829301) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 04:14:27.829672) ========= 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=03627c79f6bb3d1578c4a402000001ba-1466507667.694690-364733738 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018583 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 04:14:27.879151) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 04:14:27.879513) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 027db1e33f89606c4996feae0203e5f3bb5db43d --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 027db1e33f89606c4996feae0203e5f3bb5db43d --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=03627c79f6bb3d1578c4a402000001ba-1466507667.694690-364733738 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-21 04:14:28,617 truncating revision to first 12 chars 2016-06-21 04:14:28,617 Setting DEBUG logging. 2016-06-21 04:14:28,617 attempt 1/10 2016-06-21 04:14:28,617 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/027db1e33f89?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-21 04:14:28,917 unpacking tar archive at: mozilla-central-027db1e33f89/testing/mozharness/ program finished with exit code 0 elapsedTime=0.648998 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 04:14:28.541729) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 04:14:28.542046) ========= script_repo_revision: 027db1e33f89606c4996feae0203e5f3bb5db43d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 04:14:28.542422) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 04:14:28.542699) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 04:14:28.552826) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-21 04:14:28.553092) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1466507667.694690-364733738 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:14:29 INFO - MultiFileLogger online at 20160621 04:14:29 in /builds/slave/test 04:14:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:14:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:14:29 INFO - {'append_to_log': False, 04:14:29 INFO - 'base_work_dir': '/builds/slave/test', 04:14:29 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:14:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:14:29 INFO - 'branch': 'Firefox-Non-PGO', 04:14:29 INFO - 'buildbot_json_path': 'buildprops.json', 04:14:29 INFO - 'config_files': ('talos/linux_config.py',), 04:14:29 INFO - 'default_actions': ('clobber', 04:14:29 INFO - 'read-buildbot-config', 04:14:29 INFO - 'download-and-extract', 04:14:29 INFO - 'populate-webroot', 04:14:29 INFO - 'create-virtualenv', 04:14:29 INFO - 'install', 04:14:29 INFO - 'run-tests'), 04:14:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:14:29 INFO - 'download_minidump_stackwalk': True, 04:14:29 INFO - 'download_symbols': 'ondemand', 04:14:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:14:29 INFO - 'tooltool.py': '/tools/tooltool.py', 04:14:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:14:29 INFO - '/tools/misc-python/virtualenv.py')}, 04:14:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:14:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:14:29 INFO - 'installer_path': 'installer.exe', 04:14:29 INFO - 'log_level': 'info', 04:14:29 INFO - 'log_name': 'talos', 04:14:29 INFO - 'log_to_console': True, 04:14:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:14:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:14:29 INFO - 'opt_config_files': (), 04:14:29 INFO - 'pip_index': False, 04:14:29 INFO - 'sps_profile': False, 04:14:29 INFO - 'sps_profile_interval': 0, 04:14:29 INFO - 'suite': 'dromaeojs', 04:14:29 INFO - 'system_bits': '32', 04:14:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:14:29 INFO - 'title': 'talos-linux64-ix-047', 04:14:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:14:29 INFO - 'use_talos_json': True, 04:14:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:14:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:14:29 INFO - 'work_dir': 'build'} 04:14:29 INFO - ##### 04:14:29 INFO - ##### Running clobber step. 04:14:29 INFO - ##### 04:14:29 INFO - Running pre-action listener: _resource_record_pre_action 04:14:29 INFO - Running main action method: clobber 04:14:29 INFO - rmtree: /builds/slave/test/build 04:14:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:14:29 INFO - Running post-action listener: _resource_record_post_action 04:14:29 INFO - ##### 04:14:29 INFO - ##### Finished clobber step (success) 04:14:29 INFO - ##### 04:14:29 INFO - ##### 04:14:29 INFO - ##### Running read-buildbot-config step. 04:14:29 INFO - ##### 04:14:29 INFO - Running pre-action listener: _resource_record_pre_action 04:14:29 INFO - Running main action method: read_buildbot_config 04:14:29 INFO - Using buildbot properties: 04:14:29 INFO - { 04:14:29 INFO - "project": "", 04:14:29 INFO - "product": "firefox", 04:14:29 INFO - "script_repo_revision": "production", 04:14:29 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:14:29 INFO - "repository": "", 04:14:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:14:29 INFO - "buildid": "20160621025605", 04:14:29 INFO - "pgo_build": "False", 04:14:29 INFO - "basedir": "/builds/slave/test", 04:14:29 INFO - "buildnumber": 614, 04:14:29 INFO - "slavename": "talos-linux64-ix-047", 04:14:29 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:14:29 INFO - "platform": "ubuntu64_hw", 04:14:29 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:14:29 INFO - "branch": "mozilla-central", 04:14:29 INFO - "repo_path": "mozilla-central", 04:14:29 INFO - "revision": "027db1e33f89606c4996feae0203e5f3bb5db43d", 04:14:29 INFO - "stage_platform": "linux64", 04:14:29 INFO - "builduid": "18c7bc5306884d04b4a6e8cd47f1f130", 04:14:29 INFO - "slavebuilddir": "test" 04:14:29 INFO - } 04:14:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:14:29 INFO - Running post-action listener: _resource_record_post_action 04:14:29 INFO - ##### 04:14:29 INFO - ##### Finished read-buildbot-config step (success) 04:14:29 INFO - ##### 04:14:29 INFO - ##### 04:14:29 INFO - ##### Running download-and-extract step. 04:14:29 INFO - ##### 04:14:29 INFO - Running pre-action listener: _resource_record_pre_action 04:14:29 INFO - Running main action method: download_and_extract 04:14:29 INFO - mkdir: /builds/slave/test/build/tests 04:14: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')]} 04:14:29 INFO - https://queue.taskcluster.net/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:14:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:14:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:14:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/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 04:14:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/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 04:14:30 INFO - Downloaded 1361 bytes. 04:14:30 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:14:30 INFO - Using the following test package requirements: 04:14:30 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:14:30 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:14:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:14:30 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:14:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:14:30 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:14:30 INFO - u'jsshell-linux-x86_64.zip'], 04:14:30 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:14:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:14:30 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:14:30 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:14:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:14:30 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:14:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:14:30 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:14:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:14:30 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:14:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:14:30 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:14:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:30 INFO - https://queue.taskcluster.net/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:14:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:14:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:14:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/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 04:14:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/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 04:14:31 INFO - Downloaded 22654924 bytes. 04:14: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'] 04:14: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 04:14:32 INFO - Return code: 0 04:14:32 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 04:14:32 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')]} 04:14:32 INFO - https://queue.taskcluster.net/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:14:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:14:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:14:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/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 04:14:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/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 04:14:34 INFO - Downloaded 22654924 bytes. 04:14:34 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'] 04:14:34 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 04:14:35 INFO - Return code: 0 04:14:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:35 INFO - https://queue.taskcluster.net/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:14:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:14:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:14:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/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 04:14:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/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 04:14:37 INFO - Downloaded 14405384 bytes. 04:14:37 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'] 04:14:37 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 04:14:37 INFO - Return code: 0 04:14:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:37 INFO - https://queue.taskcluster.net/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:14:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:14:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:14:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/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 04:14:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/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 04:14:42 INFO - Downloaded 56228248 bytes. 04:14:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:14:42 INFO - mkdir: /builds/slave/test/properties 04:14:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:14:42 INFO - Writing to file /builds/slave/test/properties/build_url 04:14:42 INFO - Contents: 04:14:42 INFO - build_url:https://queue.taskcluster.net/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:14:43 INFO - Running post-action listener: _resource_record_post_action 04:14:43 INFO - Running post-action listener: set_extra_try_arguments 04:14:43 INFO - ##### 04:14:43 INFO - ##### Finished download-and-extract step (success) 04:14:43 INFO - ##### 04:14:43 INFO - ##### 04:14:43 INFO - ##### Running populate-webroot step. 04:14:43 INFO - ##### 04:14:43 INFO - Running pre-action listener: _resource_record_pre_action 04:14:43 INFO - Running main action method: populate_webroot 04:14:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:14:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:14:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:14:43 INFO - '--tppagecycles', 04:14:43 INFO - '7'], 04:14:43 INFO - 'tests': ['tsvgm']}}, 04:14:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:14:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:14:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:14:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:14:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:14:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:14:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:43 INFO - 'talos_options': ['--disable-e10s'], 04:14:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:14:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:14:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:43 INFO - 'talos_options': ['--disable-e10s'], 04:14:43 INFO - 'tests': ['damp', 'tps']}, 04:14:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:43 INFO - 'tests': ['damp', 'tps']}, 04:14:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:14:43 INFO - 'tests': ['dromaeo_dom']}, 04:14:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:14:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:14:43 INFO - 'tests': ['basic_compositor_video']}, 04:14:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:14:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:14:43 INFO - 'tests': ['a11yr', 04:14:43 INFO - 'ts_paint', 04:14:43 INFO - 'tpaint', 04:14:43 INFO - 'sessionrestore', 04:14:43 INFO - 'sessionrestore_no_auto_restore', 04:14:43 INFO - 'tabpaint']}, 04:14:43 INFO - 'other-e10s': {'tests': ['a11yr', 04:14:43 INFO - 'ts_paint', 04:14:43 INFO - 'tpaint', 04:14:43 INFO - 'sessionrestore', 04:14:43 INFO - 'sessionrestore_no_auto_restore', 04:14:43 INFO - 'tabpaint']}, 04:14:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:14:43 INFO - 'ts_paint', 04:14:43 INFO - 'tpaint', 04:14:43 INFO - 'sessionrestore', 04:14:43 INFO - 'sessionrestore_no_auto_restore', 04:14:43 INFO - 'tabpaint']}, 04:14:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:14:43 INFO - 'ts_paint', 04:14:43 INFO - 'tpaint', 04:14:43 INFO - 'sessionrestore', 04:14:43 INFO - 'sessionrestore_no_auto_restore', 04:14:43 INFO - 'tabpaint']}, 04:14:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:14:43 INFO - 'tests': ['a11yr', 04:14:43 INFO - 'ts_paint', 04:14:43 INFO - 'tpaint', 04:14:43 INFO - 'sessionrestore', 04:14:43 INFO - 'sessionrestore_no_auto_restore', 04:14:43 INFO - 'tabpaint']}, 04:14:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:14:43 INFO - 'tests': ['a11yr', 04:14:43 INFO - 'ts_paint', 04:14:43 INFO - 'tpaint', 04:14:43 INFO - 'sessionrestore', 04:14:43 INFO - 'sessionrestore_no_auto_restore', 04:14:43 INFO - 'tabpaint']}, 04:14:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:14:43 INFO - 'tests': ['tsvgx', 04:14:43 INFO - 'tsvgr_opacity', 04:14:43 INFO - 'tart', 04:14:43 INFO - 'tscrollx', 04:14:43 INFO - 'cart']}, 04:14:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:14:43 INFO - 'tsvgr_opacity', 04:14:43 INFO - 'tart', 04:14:43 INFO - 'tscrollx', 04:14:43 INFO - 'cart']}, 04:14:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:43 INFO - 'talos_options': ['--disable-e10s'], 04:14:43 INFO - 'tests': ['tp5o']}, 04:14:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:43 INFO - 'tests': ['tp5o']}, 04:14:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:43 INFO - 'talos_options': ['--disable-e10s', 04:14:43 INFO - '--xperf_path', 04:14:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:14:43 INFO - 'tests': ['tp5n']}, 04:14:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:43 INFO - 'talos_options': ['--xperf_path', 04:14:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:14:43 INFO - 'tests': ['tp5n']}}, 04:14:43 INFO - 'talos.zip': {'path': '', 04:14:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:14:43 INFO - Running post-action listener: _resource_record_post_action 04:14:43 INFO - ##### 04:14:43 INFO - ##### Finished populate-webroot step (success) 04:14:43 INFO - ##### 04:14:43 INFO - ##### 04:14:43 INFO - ##### Running create-virtualenv step. 04:14:43 INFO - ##### 04:14:43 INFO - Running pre-action listener: _resource_record_pre_action 04:14:43 INFO - Running main action method: create_virtualenv 04:14:43 INFO - Creating virtualenv /builds/slave/test/build/venv 04:14:43 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 04:14:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:14:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:14:43 INFO - Using real prefix '/usr' 04:14:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:14:43 INFO - Installing distribute.............................................................................................................................................................................................done. 04:14:45 INFO - Installing pip.................done. 04:14:45 INFO - Return code: 0 04:14:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:14:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f177e0aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ad350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3c1c0>, '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 0x1a3d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3d550>, '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': '03627c79f6bb3d1578c4a402000001ba-1466507667.694690-364733738', '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 04:14:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:14:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:14:45 INFO - Using env: {'DISPLAY': ':0', 04:14:45 INFO - 'HOME': '/home/cltbld', 04:14:45 INFO - 'LANG': 'en_US.UTF-8', 04:14:45 INFO - 'LANGUAGE': 'en_US:en', 04:14:45 INFO - 'LOGNAME': 'cltbld', 04:14:45 INFO - 'MAIL': '/var/mail/cltbld', 04:14:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:45 INFO - 'MOZ_NO_REMOTE': '1', 04:14:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:45 INFO - 'NO_EM_RESTART': '1', 04:14:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:45 INFO - 'PWD': '/builds/slave/test', 04:14:45 INFO - 'SHELL': '/bin/bash', 04:14:45 INFO - 'SHLVL': '1', 04:14:45 INFO - 'TERM': 'linux', 04:14:45 INFO - 'TMOUT': '86400', 04:14:45 INFO - 'USER': 'cltbld', 04:14:45 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466507667.694690-364733738', 04:14:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:45 INFO - '_': '/tools/buildbot/bin/python'} 04:14:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:46 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 04:14:46 INFO - Cleaning up... 04:14:46 INFO - Return code: 0 04:14:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:14:46 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')]} 04:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:46 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')]} 04:14:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:46 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 0x7f177e0aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ad350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3c1c0>, '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 0x1a3d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3d550>, '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': '03627c79f6bb3d1578c4a402000001ba-1466507667.694690-364733738', '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 04:14:46 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 04:14:46 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 04:14:46 INFO - Using env: {'DISPLAY': ':0', 04:14:46 INFO - 'HOME': '/home/cltbld', 04:14:46 INFO - 'LANG': 'en_US.UTF-8', 04:14:46 INFO - 'LANGUAGE': 'en_US:en', 04:14:46 INFO - 'LOGNAME': 'cltbld', 04:14:46 INFO - 'MAIL': '/var/mail/cltbld', 04:14:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:46 INFO - 'MOZ_NO_REMOTE': '1', 04:14:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:46 INFO - 'NO_EM_RESTART': '1', 04:14:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:46 INFO - 'PWD': '/builds/slave/test', 04:14:46 INFO - 'SHELL': '/bin/bash', 04:14:46 INFO - 'SHLVL': '1', 04:14:46 INFO - 'TERM': 'linux', 04:14:46 INFO - 'TMOUT': '86400', 04:14:46 INFO - 'USER': 'cltbld', 04:14:46 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466507667.694690-364733738', 04:14:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:46 INFO - '_': '/tools/buildbot/bin/python'} 04:14:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:46 INFO - Downloading/unpacking psutil>=3.1.1 04:14: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 04:14: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 04:14: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 04:14: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 04:14: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 04:14: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 04:14:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:14:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:14:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:14:48 INFO - Installing collected packages: psutil 04:14:48 INFO - Running setup.py install for psutil 04:14:48 INFO - building 'psutil._psutil_linux' extension 04:14:48 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 04:14:48 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 04:14:48 INFO - building 'psutil._psutil_posix' extension 04:14:48 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 04:14:48 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 04:14:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:14:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:14:48 INFO - Successfully installed psutil 04:14:48 INFO - Cleaning up... 04:14:48 INFO - Return code: 0 04:14:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:14:48 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')]} 04:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:48 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')]} 04:14:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:48 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 0x7f177e0aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ad350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3c1c0>, '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 0x1a3d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3d550>, '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': '03627c79f6bb3d1578c4a402000001ba-1466507667.694690-364733738', '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 04:14:48 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 04:14:48 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 04:14:48 INFO - Using env: {'DISPLAY': ':0', 04:14:48 INFO - 'HOME': '/home/cltbld', 04:14:48 INFO - 'LANG': 'en_US.UTF-8', 04:14:48 INFO - 'LANGUAGE': 'en_US:en', 04:14:48 INFO - 'LOGNAME': 'cltbld', 04:14:48 INFO - 'MAIL': '/var/mail/cltbld', 04:14:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:48 INFO - 'MOZ_NO_REMOTE': '1', 04:14:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:48 INFO - 'NO_EM_RESTART': '1', 04:14:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:48 INFO - 'PWD': '/builds/slave/test', 04:14:48 INFO - 'SHELL': '/bin/bash', 04:14:48 INFO - 'SHLVL': '1', 04:14:48 INFO - 'TERM': 'linux', 04:14:48 INFO - 'TMOUT': '86400', 04:14:48 INFO - 'USER': 'cltbld', 04:14:48 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466507667.694690-364733738', 04:14:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:48 INFO - '_': '/tools/buildbot/bin/python'} 04:14:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:14: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 04:14: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 04:14: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 04:14: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 04:14: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 04:14: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 04:14:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:14:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:14:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:14:51 INFO - Installing collected packages: mozsystemmonitor 04:14:51 INFO - Running setup.py install for mozsystemmonitor 04:14:51 INFO - Successfully installed mozsystemmonitor 04:14:51 INFO - Cleaning up... 04:14:51 INFO - Return code: 0 04:14:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:14:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:51 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 0x7f177e0aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ad350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3c1c0>, '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 0x1a3d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3d550>, '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': '03627c79f6bb3d1578c4a402000001ba-1466507667.694690-364733738', '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 04:14:51 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 04:14:51 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 04:14:51 INFO - Using env: {'DISPLAY': ':0', 04:14:51 INFO - 'HOME': '/home/cltbld', 04:14:51 INFO - 'LANG': 'en_US.UTF-8', 04:14:51 INFO - 'LANGUAGE': 'en_US:en', 04:14:51 INFO - 'LOGNAME': 'cltbld', 04:14:51 INFO - 'MAIL': '/var/mail/cltbld', 04:14:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:51 INFO - 'MOZ_NO_REMOTE': '1', 04:14:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:51 INFO - 'NO_EM_RESTART': '1', 04:14:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:51 INFO - 'PWD': '/builds/slave/test', 04:14:51 INFO - 'SHELL': '/bin/bash', 04:14:51 INFO - 'SHLVL': '1', 04:14:51 INFO - 'TERM': 'linux', 04:14:51 INFO - 'TMOUT': '86400', 04:14:51 INFO - 'USER': 'cltbld', 04:14:51 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466507667.694690-364733738', 04:14:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:51 INFO - '_': '/tools/buildbot/bin/python'} 04:14:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:51 INFO - Downloading/unpacking jsonschema==2.5.1 04:14:51 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 04:14:51 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 04:14:51 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 04:14:51 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 04:14:51 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 04:14:51 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 04:14:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:14:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:14:53 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 04:14:53 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 04:14:53 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 04:14:53 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 04:14:53 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 04:14:53 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 04:14:53 INFO - Downloading functools32-3.2.3-2.tar.gz 04:14:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:14:53 INFO - warning: no files found matching '*.txt' 04:14:53 INFO - no previously-included directories found matching 'build' 04:14:53 INFO - no previously-included directories found matching 'dist' 04:14:53 INFO - no previously-included directories found matching '.git*' 04:14:53 INFO - Installing collected packages: jsonschema, functools32 04:14:53 INFO - Running setup.py install for functools32 04:14:53 INFO - warning: no files found matching '*.txt' 04:14:53 INFO - no previously-included directories found matching 'build' 04:14:53 INFO - no previously-included directories found matching 'dist' 04:14:53 INFO - no previously-included directories found matching '.git*' 04:14:53 INFO - Successfully installed jsonschema functools32 04:14:53 INFO - Cleaning up... 04:14:53 INFO - Return code: 0 04:14:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:14:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:53 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 0x7f177e0aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ad350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3c1c0>, '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 0x1a3d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3d550>, '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': '03627c79f6bb3d1578c4a402000001ba-1466507667.694690-364733738', '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 04:14:53 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 04:14:53 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 04:14:53 INFO - Using env: {'DISPLAY': ':0', 04:14:53 INFO - 'HOME': '/home/cltbld', 04:14:53 INFO - 'LANG': 'en_US.UTF-8', 04:14:53 INFO - 'LANGUAGE': 'en_US:en', 04:14:53 INFO - 'LOGNAME': 'cltbld', 04:14:53 INFO - 'MAIL': '/var/mail/cltbld', 04:14:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:53 INFO - 'MOZ_NO_REMOTE': '1', 04:14:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:53 INFO - 'NO_EM_RESTART': '1', 04:14:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:53 INFO - 'PWD': '/builds/slave/test', 04:14:53 INFO - 'SHELL': '/bin/bash', 04:14:53 INFO - 'SHLVL': '1', 04:14:53 INFO - 'TERM': 'linux', 04:14:53 INFO - 'TMOUT': '86400', 04:14:53 INFO - 'USER': 'cltbld', 04:14:53 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466507667.694690-364733738', 04:14:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:53 INFO - '_': '/tools/buildbot/bin/python'} 04:14:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:53 INFO - Downloading/unpacking blobuploader==1.2.4 04:14:53 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 04:14:53 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 04:14:53 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 04:14:53 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 04:14:53 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 04:14:53 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 04:14:55 INFO - Downloading blobuploader-1.2.4.tar.gz 04:14:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:14:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:14: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 04:14: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 04:14: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 04:14: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 04:14: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 04:14: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 04:14:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:14:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:56 INFO - Downloading docopt-0.6.1.tar.gz 04:14:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:14:56 INFO - Installing collected packages: blobuploader, requests, docopt 04:14:56 INFO - Running setup.py install for blobuploader 04:14:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:14:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:14:56 INFO - Running setup.py install for requests 04:14:57 INFO - Running setup.py install for docopt 04:14:57 INFO - Successfully installed blobuploader requests docopt 04:14:57 INFO - Cleaning up... 04:14:57 INFO - Return code: 0 04:14:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14: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')]} 04:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14: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')]} 04:14:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:57 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 0x7f177e0aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ad350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3c1c0>, '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 0x1a3d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3d550>, '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': '03627c79f6bb3d1578c4a402000001ba-1466507667.694690-364733738', '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 04:14:57 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 04:14:57 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 04:14:57 INFO - Using env: {'DISPLAY': ':0', 04:14:57 INFO - 'HOME': '/home/cltbld', 04:14:57 INFO - 'LANG': 'en_US.UTF-8', 04:14:57 INFO - 'LANGUAGE': 'en_US:en', 04:14:57 INFO - 'LOGNAME': 'cltbld', 04:14:57 INFO - 'MAIL': '/var/mail/cltbld', 04:14:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:57 INFO - 'MOZ_NO_REMOTE': '1', 04:14:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:57 INFO - 'NO_EM_RESTART': '1', 04:14:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:57 INFO - 'PWD': '/builds/slave/test', 04:14:57 INFO - 'SHELL': '/bin/bash', 04:14:57 INFO - 'SHLVL': '1', 04:14:57 INFO - 'TERM': 'linux', 04:14:57 INFO - 'TMOUT': '86400', 04:14:57 INFO - 'USER': 'cltbld', 04:14:57 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466507667.694690-364733738', 04:14:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:57 INFO - '_': '/tools/buildbot/bin/python'} 04:14:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:14:57 INFO - Running setup.py (path:/tmp/pip-Or6VVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:14:57 INFO - Running setup.py (path:/tmp/pip-lgPdxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:14:57 INFO - Running setup.py (path:/tmp/pip-TYtPbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:14:57 INFO - Running setup.py (path:/tmp/pip-vh5aCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:14:57 INFO - Running setup.py (path:/tmp/pip-pnUQFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:14:57 INFO - Running setup.py (path:/tmp/pip-ERbKJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:14:57 INFO - Running setup.py (path:/tmp/pip-fcWuCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:14:57 INFO - Running setup.py (path:/tmp/pip-H6aCRB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:14:58 INFO - Running setup.py (path:/tmp/pip-81Evud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:14:58 INFO - Running setup.py (path:/tmp/pip-XWPa70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:14:58 INFO - Running setup.py (path:/tmp/pip-72lMsV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:14:58 INFO - Running setup.py (path:/tmp/pip-xxsH9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:14:58 INFO - Running setup.py (path:/tmp/pip-n7ZV4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:14:58 INFO - Running setup.py (path:/tmp/pip-RNjcB7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:58 INFO - Running setup.py (path:/tmp/pip-Nm3Nnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:14:58 INFO - Running setup.py (path:/tmp/pip-6_vYkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:14:58 INFO - Running setup.py (path:/tmp/pip-UDTSDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:14:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:14:58 INFO - Running setup.py install for manifestparser 04:14:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:14:58 INFO - Running setup.py install for mozcrash 04:14:58 INFO - Running setup.py install for mozdebug 04:14:58 INFO - Running setup.py install for mozdevice 04:14:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:14:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:14:59 INFO - Running setup.py install for mozfile 04:14:59 INFO - Running setup.py install for mozhttpd 04:14:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:14:59 INFO - Running setup.py install for mozinfo 04:14:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:14:59 INFO - Running setup.py install for mozInstall 04:14:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:14:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:14:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:14:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:14:59 INFO - Running setup.py install for mozleak 04:14:59 INFO - Running setup.py install for mozlog 04:14:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:14:59 INFO - Running setup.py install for moznetwork 04:14:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:14:59 INFO - Running setup.py install for mozprocess 04:14:59 INFO - Running setup.py install for mozprofile 04:15:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:15:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:15:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:15:00 INFO - Running setup.py install for mozrunner 04:15:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:15:00 INFO - Running setup.py install for mozscreenshot 04:15:00 INFO - Running setup.py install for moztest 04:15:00 INFO - Running setup.py install for mozversion 04:15:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:15:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:15:00 INFO - Cleaning up... 04:15:00 INFO - Return code: 0 04:15:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:15:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:00 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 0x7f177e0aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ad350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3c1c0>, '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 0x1a3d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3d550>, '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': '03627c79f6bb3d1578c4a402000001ba-1466507667.694690-364733738', '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 04:15:00 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 04:15:00 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 04:15:00 INFO - Using env: {'DISPLAY': ':0', 04:15:00 INFO - 'HOME': '/home/cltbld', 04:15:00 INFO - 'LANG': 'en_US.UTF-8', 04:15:00 INFO - 'LANGUAGE': 'en_US:en', 04:15:00 INFO - 'LOGNAME': 'cltbld', 04:15:00 INFO - 'MAIL': '/var/mail/cltbld', 04:15:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:00 INFO - 'MOZ_NO_REMOTE': '1', 04:15:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:15:00 INFO - 'NO_EM_RESTART': '1', 04:15:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:15:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:00 INFO - 'PWD': '/builds/slave/test', 04:15:00 INFO - 'SHELL': '/bin/bash', 04:15:00 INFO - 'SHLVL': '1', 04:15:00 INFO - 'TERM': 'linux', 04:15:00 INFO - 'TMOUT': '86400', 04:15:00 INFO - 'USER': 'cltbld', 04:15:00 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466507667.694690-364733738', 04:15:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:00 INFO - '_': '/tools/buildbot/bin/python'} 04:15:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:15:00 INFO - Running setup.py (path:/tmp/pip-Th4SPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:15:00 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)) 04:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:15:00 INFO - Running setup.py (path:/tmp/pip-wJAVA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:15:00 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)) 04:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:15:00 INFO - Running setup.py (path:/tmp/pip-scbXVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:15:00 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)) 04:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:15:00 INFO - Running setup.py (path:/tmp/pip-VGur0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:15:00 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)) 04:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:15:00 INFO - Running setup.py (path:/tmp/pip-_55pvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:15:01 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)) 04:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:15:01 INFO - Running setup.py (path:/tmp/pip-QuxEkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:15:01 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)) 04:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:15:01 INFO - Running setup.py (path:/tmp/pip-qhPGl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:15:01 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)) 04:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:15:01 INFO - Running setup.py (path:/tmp/pip-SioYTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:15:01 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)) 04:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:15:01 INFO - Running setup.py (path:/tmp/pip-47LUGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:15:01 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)) 04:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:15:01 INFO - Running setup.py (path:/tmp/pip-pcqBfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:15:01 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)) 04:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:15:01 INFO - Running setup.py (path:/tmp/pip-KADMP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:15:01 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)) 04:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:15:01 INFO - Running setup.py (path:/tmp/pip-o_W24k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:15:01 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)) 04:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:15:01 INFO - Running setup.py (path:/tmp/pip-TTTuXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:15:01 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)) 04:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:15:01 INFO - Running setup.py (path:/tmp/pip-Lp1VWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:15:01 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)) 04:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:15:01 INFO - Running setup.py (path:/tmp/pip-iPhHP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:15:01 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)) 04:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:15:01 INFO - Running setup.py (path:/tmp/pip-Y064Kv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:15:01 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)) 04:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:15:01 INFO - Running setup.py (path:/tmp/pip-iIOusT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:15:01 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)) 04:15:01 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)) 04:15:01 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)) 04:15:01 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)) 04:15:01 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)) 04:15:01 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)) 04:15:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:15:01 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 04:15:01 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 04:15:01 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 04:15:01 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 04:15:01 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 04:15:01 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 04:15:03 INFO - Downloading blessings-1.6.tar.gz 04:15:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:15:03 INFO - Installing collected packages: blessings 04:15:03 INFO - Running setup.py install for blessings 04:15:04 INFO - Successfully installed blessings 04:15:04 INFO - Cleaning up... 04:15:04 INFO - Return code: 0 04:15:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:15:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:15:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:15:04 INFO - Reading from file tmpfile_stdout 04:15:04 INFO - Current package versions: 04:15:04 INFO - argparse == 1.2.1 04:15:04 INFO - blessings == 1.6 04:15:04 INFO - blobuploader == 1.2.4 04:15:04 INFO - docopt == 0.6.1 04:15:04 INFO - functools32 == 3.2.3-2 04:15:04 INFO - jsonschema == 2.5.1 04:15:04 INFO - manifestparser == 1.1 04:15:04 INFO - mozInstall == 1.12 04:15:04 INFO - mozcrash == 0.17 04:15:04 INFO - mozdebug == 0.1 04:15:04 INFO - mozdevice == 0.48 04:15:04 INFO - mozfile == 1.2 04:15:04 INFO - mozhttpd == 0.7 04:15:04 INFO - mozinfo == 0.9 04:15:04 INFO - mozleak == 0.1 04:15:04 INFO - mozlog == 3.2 04:15:04 INFO - moznetwork == 0.27 04:15:04 INFO - mozprocess == 0.22 04:15:04 INFO - mozprofile == 0.28 04:15:04 INFO - mozrunner == 6.11 04:15:04 INFO - mozscreenshot == 0.1 04:15:04 INFO - mozsystemmonitor == 0.3 04:15:04 INFO - moztest == 0.7 04:15:04 INFO - mozversion == 1.4 04:15:04 INFO - psutil == 3.1.1 04:15:04 INFO - requests == 1.2.3 04:15:04 INFO - wsgiref == 0.1.2 04:15:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:15:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:04 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 0x7f177e0aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ad350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3c1c0>, '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 0x1a3d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3d550>, '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': '03627c79f6bb3d1578c4a402000001ba-1466507667.694690-364733738', '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 04:15:04 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 04:15:04 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 04:15:04 INFO - Using env: {'DISPLAY': ':0', 04:15:04 INFO - 'HOME': '/home/cltbld', 04:15:04 INFO - 'LANG': 'en_US.UTF-8', 04:15:04 INFO - 'LANGUAGE': 'en_US:en', 04:15:04 INFO - 'LOGNAME': 'cltbld', 04:15:04 INFO - 'MAIL': '/var/mail/cltbld', 04:15:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:04 INFO - 'MOZ_NO_REMOTE': '1', 04:15:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:15:04 INFO - 'NO_EM_RESTART': '1', 04:15:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:15:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:04 INFO - 'PWD': '/builds/slave/test', 04:15:04 INFO - 'SHELL': '/bin/bash', 04:15:04 INFO - 'SHLVL': '1', 04:15:04 INFO - 'TERM': 'linux', 04:15:04 INFO - 'TMOUT': '86400', 04:15:04 INFO - 'USER': 'cltbld', 04:15:04 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466507667.694690-364733738', 04:15:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:04 INFO - '_': '/tools/buildbot/bin/python'} 04:15:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:04 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)) 04:15:04 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)) 04:15:04 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)) 04:15:04 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)) 04:15:04 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)) 04:15:04 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)) 04:15:04 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)) 04:15:04 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)) 04:15:04 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)) 04:15:04 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)) 04:15:04 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)) 04:15:04 INFO - Cleaning up... 04:15:04 INFO - Return code: 0 04:15:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:15:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:04 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 0x7f177e0aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ad350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3c1c0>, '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 0x1a3d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3d550>, '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': '03627c79f6bb3d1578c4a402000001ba-1466507667.694690-364733738', '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 04:15:04 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 04:15:04 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 04:15:04 INFO - Using env: {'DISPLAY': ':0', 04:15:04 INFO - 'HOME': '/home/cltbld', 04:15:04 INFO - 'LANG': 'en_US.UTF-8', 04:15:04 INFO - 'LANGUAGE': 'en_US:en', 04:15:04 INFO - 'LOGNAME': 'cltbld', 04:15:04 INFO - 'MAIL': '/var/mail/cltbld', 04:15:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:04 INFO - 'MOZ_NO_REMOTE': '1', 04:15:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:15:04 INFO - 'NO_EM_RESTART': '1', 04:15:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:15:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:04 INFO - 'PWD': '/builds/slave/test', 04:15:04 INFO - 'SHELL': '/bin/bash', 04:15:04 INFO - 'SHLVL': '1', 04:15:04 INFO - 'TERM': 'linux', 04:15:04 INFO - 'TMOUT': '86400', 04:15:04 INFO - 'USER': 'cltbld', 04:15:04 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466507667.694690-364733738', 04:15:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:04 INFO - '_': '/tools/buildbot/bin/python'} 04:15:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:15:04 INFO - Cleaning up... 04:15:04 INFO - Return code: 0 04:15:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:15:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:04 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 0x7f177e0aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ad350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3c1c0>, '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 0x1a3d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3d550>, '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': '03627c79f6bb3d1578c4a402000001ba-1466507667.694690-364733738', '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 04:15:04 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 04:15:04 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 04:15:04 INFO - Using env: {'DISPLAY': ':0', 04:15:04 INFO - 'HOME': '/home/cltbld', 04:15:04 INFO - 'LANG': 'en_US.UTF-8', 04:15:04 INFO - 'LANGUAGE': 'en_US:en', 04:15:04 INFO - 'LOGNAME': 'cltbld', 04:15:04 INFO - 'MAIL': '/var/mail/cltbld', 04:15:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:04 INFO - 'MOZ_NO_REMOTE': '1', 04:15:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:15:04 INFO - 'NO_EM_RESTART': '1', 04:15:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:15:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:04 INFO - 'PWD': '/builds/slave/test', 04:15:04 INFO - 'SHELL': '/bin/bash', 04:15:04 INFO - 'SHLVL': '1', 04:15:04 INFO - 'TERM': 'linux', 04:15:04 INFO - 'TMOUT': '86400', 04:15:04 INFO - 'USER': 'cltbld', 04:15:04 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466507667.694690-364733738', 04:15:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:04 INFO - '_': '/tools/buildbot/bin/python'} 04:15:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:05 INFO - Downloading/unpacking flake8 04:15:05 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 04:15:05 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 04:15:05 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 04:15:05 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 04:15:05 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 04:15:05 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 04:15:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:15:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:15:06 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 04:15:06 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 04:15:06 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 04:15:06 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 04:15:06 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 04:15:06 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 04:15:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:15:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:15:07 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 04:15:07 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 04:15:07 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 04:15:07 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 04:15:07 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 04:15:07 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 04:15:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:15:07 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 04:15:07 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 04:15:07 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 04:15:07 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 04:15:07 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 04:15:07 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 04:15:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:15:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:15:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:15:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:15:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:15:07 INFO - no previously-included directories found matching 'docs/_build' 04:15:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:15:07 INFO - Running setup.py install for pep8 04:15:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:15:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:15:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:15:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:15:07 INFO - no previously-included directories found matching 'docs/_build' 04:15:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:15:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:15:07 INFO - Cleaning up... 04:15:07 INFO - Return code: 0 04:15:07 INFO - Running post-action listener: _resource_record_post_action 04:15:07 INFO - Running post-action listener: _start_resource_monitoring 04:15:07 INFO - Starting resource monitoring. 04:15:07 INFO - ##### 04:15:07 INFO - ##### Finished create-virtualenv step (success) 04:15:07 INFO - ##### 04:15:07 INFO - ##### 04:15:07 INFO - ##### Running install step. 04:15:07 INFO - ##### 04:15:07 INFO - Running pre-action listener: _resource_record_pre_action 04:15:07 INFO - Running main action method: install 04:15:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:15:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:15:08 INFO - Reading from file tmpfile_stdout 04:15:08 INFO - Detecting whether we're running mozinstall >=1.0... 04:15:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:15:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:15:08 INFO - Reading from file tmpfile_stdout 04:15:08 INFO - Output received: 04:15:08 INFO - Usage: mozinstall [options] installer 04:15:08 INFO - Options: 04:15:08 INFO - -h, --help show this help message and exit 04:15:08 INFO - -d DEST, --destination=DEST 04:15:08 INFO - Directory to install application into. [default: 04:15:08 INFO - "/builds/slave/test"] 04:15:08 INFO - --app=APP Application being installed. [default: firefox] 04:15:08 INFO - mkdir: /builds/slave/test/build/application 04:15:08 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'] 04:15:08 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 04:15:24 INFO - Reading from file tmpfile_stdout 04:15:24 INFO - Output received: 04:15:24 INFO - /builds/slave/test/build/application/firefox/firefox 04:15:24 INFO - Running post-action listener: _resource_record_post_action 04:15:24 INFO - ##### 04:15:24 INFO - ##### Finished install step (success) 04:15:24 INFO - ##### 04:15:24 INFO - ##### 04:15:24 INFO - ##### Running run-tests step. 04:15:24 INFO - ##### 04:15:24 INFO - Running pre-action listener: _resource_record_pre_action 04:15:24 INFO - Running main action method: run_tests 04:15:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:15:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:15:24 INFO - Python 2.7.3 04:15:24 INFO - Return code: 0 04:15:24 INFO - grabbing minidump binary from tooltool 04:15:24 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')]} 04:15:24 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 0x1a3c1c0>, '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 0x1a3d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3d550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:15:24 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 04:15:24 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 04:15:24 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 04:15:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:15:24 INFO - Return code: 0 04:15:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:15:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:15:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:15:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:15:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:15:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:15:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:15:25 INFO - Return code: 0 04:15:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 04:15:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --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 04:15:25 INFO - Using env: {'DISPLAY': ':0', 04:15:25 INFO - 'HOME': '/home/cltbld', 04:15:25 INFO - 'LANG': 'en_US.UTF-8', 04:15:25 INFO - 'LANGUAGE': 'en_US:en', 04:15:25 INFO - 'LOGNAME': 'cltbld', 04:15:25 INFO - 'MAIL': '/var/mail/cltbld', 04:15:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:15:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:15:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:25 INFO - 'MOZ_NO_REMOTE': '1', 04:15:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:15:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:15:25 INFO - 'NO_EM_RESTART': '1', 04:15:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:15:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:25 INFO - 'PWD': '/builds/slave/test', 04:15:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:15:25 INFO - 'SHELL': '/bin/bash', 04:15:25 INFO - 'SHLVL': '1', 04:15:25 INFO - 'TERM': 'linux', 04:15:25 INFO - 'TMOUT': '86400', 04:15:25 INFO - 'USER': 'cltbld', 04:15:25 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466507667.694690-364733738', 04:15:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:25 INFO - '_': '/tools/buildbot/bin/python'} 04:15:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 04:15:25 INFO - mozversion application_buildid: 20160621025605 04:15:25 INFO - mozversion application_changeset: 027db1e33f89606c4996feae0203e5f3bb5db43d 04:15:25 INFO - mozversion application_display_name: Nightly 04:15:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:15:25 INFO - mozversion application_name: Firefox 04:15:25 INFO - mozversion application_remotingname: firefox 04:15:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:15:25 INFO - mozversion application_vendor: Mozilla 04:15:25 INFO - mozversion application_version: 50.0a1 04:15:25 INFO - mozversion platform_buildid: 20160621025605 04:15:25 INFO - mozversion platform_changeset: 027db1e33f89606c4996feae0203e5f3bb5db43d 04:15:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:15:25 INFO - mozversion platform_version: 50.0a1 04:15:25 INFO - using testdate: 1466507725 04:15:25 INFO - actual date: 1466507725 04:15:25 INFO - starting webserver on 'localhost:40088' 04:15:25 INFO - SUITE-START | Running 2 tests 04:15:25 INFO - TEST-START | dromaeo_css 04:15:25 INFO - operating with platform_type : linux_ 04:15:25 INFO - Initialising browser for dromaeo_css test... 04:15:25 INFO - TEST-INFO | started process 12341 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8mYo7G/profile http://localhost:40088/getInfo.html) 04:15:30 INFO - PROCESS | 12341 | __metrics Screen width/height:1600/1200 04:15:30 INFO - PROCESS | 12341 | colorDepth:24 04:15:30 INFO - PROCESS | 12341 | Browser inner width/height: 1024/697 04:15:30 INFO - PROCESS | 12341 | __metrics 04:15:31 INFO - PROCESS | 12341 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:15:32 INFO - TEST-INFO | 12341: exit 0 04:15:32 INFO - Browser initialized. 04:15:32 INFO - Running cycle 1/1 for dromaeo_css test... 04:15:32 INFO - TEST-INFO | started process 12422 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8mYo7G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:15:44 INFO - PROCESS | 12422 | RSS: Main: 175009792 04:15:44 INFO - PROCESS | 12422 | 04:16:35 INFO - PROCESS | 12422 | 1466507795095 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] 04:18:47 INFO - PROCESS | 12422 | Cycle 1(1): loaded http://localhost:40088/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40088/tests/dromaeo/cssquery-ext.html) 04:18:49 INFO - PROCESS | 12422 | RSS: Main: 289910784 04:18:49 INFO - PROCESS | 12422 | 04:21:51 INFO - PROCESS | 12422 | Cycle 1(1): loaded http://localhost:40088/tests/dromaeo/cssquery-ext.html (next: http://localhost:40088/tests/dromaeo/cssquery-jquery.html) 04:21:52 INFO - PROCESS | 12422 | RSS: Main: 257794048 04:21:52 INFO - PROCESS | 12422 | 04:24:54 INFO - PROCESS | 12422 | Cycle 1(1): loaded http://localhost:40088/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40088/tests/dromaeo/cssquery-mootools.html) 04:24:55 INFO - PROCESS | 12422 | RSS: Main: 253288448 04:24:55 INFO - PROCESS | 12422 | 04:27:57 INFO - PROCESS | 12422 | Cycle 1(1): loaded http://localhost:40088/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40088/tests/dromaeo/cssquery-prototype.html) 04:27:57 INFO - PROCESS | 12422 | RSS: Main: 256839680 04:27:57 INFO - PROCESS | 12422 | 04:31:01 INFO - PROCESS | 12422 | Cycle 1(1): loaded http://localhost:40088/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40088/tests/dromaeo/cssquery-yui.html) 04:31:01 INFO - PROCESS | 12422 | RSS: Main: 236081152 04:31:01 INFO - PROCESS | 12422 | 04:34:04 INFO - PROCESS | 12422 | Cycle 1(1): loaded http://localhost:40088/tests/dromaeo/cssquery-yui.html (next: http://localhost:40088/tests/dromaeo/cssquery-dojo.html) 04:34:04 INFO - PROCESS | 12422 | RSS: Main: 318562304 04:34:04 INFO - PROCESS | 12422 | 04:34:04 INFO - PROCESS | 12422 | __start_tp_report 04:34:04 INFO - PROCESS | 12422 | _x_x_mozilla_page_load 04:34:04 INFO - PROCESS | 12422 | _x_x_mozilla_page_load_details 04:34:04 INFO - PROCESS | 12422 | |i|pagename|runs| 04:34:04 INFO - PROCESS | 12422 | |0;dojo.html;2634.7101818799933;2642.20733779866;2653.708092109868;2681.1956413076073;2689.6100065490505;4637.420322459692;4695.85912422627;4721.716696998183;4773.90452190956;4822.734749588772;4687.742174180418;4703.529647035295;4708.176069187895;4734.124187025394;4788.090262850056;4225.133847561258;4249.511306199795;4261.04126571522;4370.2570563004365;4371.628411585003;4267.167902259061;4350.303951367781;4394.912101757963;4423.823047078129;4431.446069241345;4219.9578004219875;4268.445102136733;4272.2950713132295;4282.957170428318;4306.870793876189;4231.386448964883;4257.276263035292;4258.6380157686635;4304.741715497049;4316.438862947828;4262.573742625744;4300.8709738707885;4310.224159651261;4331.501877284121;4346.782660866944;4600.4479462464715;4703.811847526094;4768.7615619218905;4783.593394561466;4791.377120974251;4972.105021096201;5024.773885175176;5030.396352437694;5096.51583099605;5100.591952643779;5063.797448102072;5085.440601533828;5089.898202035975;5110.744462776884;5128.948710512885;4666.556677115668;4719.221328480831;4735.502772208937;4749;4785.449673287581;5197.532222100029;5207.270982062439;5281.551068159172;5284.392294886137;5285.286486324374;5030.823921162815;5059.114654935445;5069.239614057847;5075.264086707407;5080.441151473335;4991.351124353883;5023.19628859388;5072.797088116434;5137.563307118862;5183.948160518422;5007.799688012512;5017.1721665924715;5027.044861476308;5030.320906677625;5065.088284108896;5006.824761133343;5007.749612519359;5009.624278179152;5014;5051.873703157377;4128.8348466061625;4174.624283814411;4222.59885310895;4237.660987121023;4268.551802060739;3722.3858063419775;3732.2162345907122;3744.8689295874515;3769.849206031783;3790.65884070435;4412.492563355191;4415.09490554442;4416.29339305716;4449.911001779947;4460.977695111568;5026.899462010812;5060.7722652480725;5108.897822043538;5132.1788513838355;5138.717370544581;4435.090806384684;4436.933445998313;4437.179121862466;4460.817883260938;4469.217886869785;4567.383403240587;4578.748168850745;4583.54164583539;4585.495595484494;4629.699069560468;4656.208444564364;4797.8080876765935;4858.5384388483035;4865.221564549655;4872.098661747588;5138.409082955508;5159.226116082617;5167.173252279617;5167.638265321391;5207.557357624644;4838.661293709407;4875.8049678012485;4876.003354498696;4880.902381952412;4928.088303663833;4840.782164802522;4951.282064100757;5027.069992051483;5069.239614057921;5069.493050694901;5132.409772876018;5152.175651895679;5152.845414637567;5162.535371816554;5165.251038599307;4985.3020577118505;5002.224655178453;5004.924926126184;5005.399352077774;5032.7483625819295;4872.780724867461;4891.5353041461;4930.013997200646;4941;4986.6509344347;4924.630652701134;4960.057589058211;4995.600351971906;5000.824971125993;5005.899882002267;4916.778744956414;5058.291839142449;5059.87350316245;5063.544281014726;5096.388433388017;4818.084563932842;4872.756362181947;4878.463369029475;4893.266010098514;4908.901821963612 04:34:04 INFO - PROCESS | 12422 | |1;ext.html;540.6315384430388;581.459242904099;582.7319433060792;583.2621733507111;600.4745847383538;26058.739412605868;39339.60660393395;40248.59751402485;40267.59732402675;40363.39454908175;40590.18819623606;41250.381244281285;41277.17445651085;41388.79305603468;41470.58529414705;7687.03912011;7831.021122359705;7831.29518343349;7835.412344074217;7838.059432868064;7826.060872695284;7996.280334769869;8002.439829211958;8002.67989280431;8008;8005.11943686197;8040.1959804019425;8041.356691464669;8044.597770111501;8046.718364857231;7972.481788683746;7999.480033797843;8015.839683206333;8019.639116239783;8024.879626805603;7735.419843511759;7798.688052477894;7799.883001754978;7800.609969501502;7805.063392392893;38039.809800951094;38276.42585361222;38348.424773628416;38464;38480.037999049964;3212.9357412851846;3250.252441938344;3423.9315213695586;3567.1438854674952;3774.2451509697894;28136.577951330746;28396.574051389245;28980.565291520645;29018.12945611635;29182.854085729436;3133.5143052826847;3137.952930706041;3242.935141297161;3244.23760416302;3250.886218982348;181299;181901;183070;183260;183628.08185959118;42570;43822.78088609601;43875.78062109669;48243.276350854765;48912.75543622259;47411.5258847414;47615.76192119017;51965.7401712989;53415;53575.73212133914;13474.258915759727;13781.310934453237;13785.655358616115;13786.379612917443;13787.172769633855;10612.09797167234;10677.733056673645;10692.358458492516;10692.411917344622;10694.572217111228;13921.791173132411;15087.47193848232;15540.222988850739;15653.608659783597;15722.921385393;5981.37195594465;6037.849053773603;6058.1518587397795;6126.571140020156;6223.751049958041;795.208767276552;869.1829680100685;894.5303715549388;950.2682934140811;972.246508955551;26642.467150656877;26790.732092679213;27362.31594210121;27570.724292757215;27642.170734877986;910.094456016268;950.9429434233969;979.8236317462926;985.2069084386994;1001.6544292219173;14283.357248923823;14604.225197212496;14689.412423503154;14943.028703134261;14964.551063468114;345418;372833;381002;381205;585366;47410;47634.285485717744;47855.5214447851;47905.520944790806;47931;1148.873623901387;1177.8409914661754;1182.8166634171716;1201.7115892185811;1201.813718873576;26934.86532567403;27023.86488067547;27531.724682752916;28232;28403.715962840935;41292.1741565173;44682.55317446784;45952;45991.31013034874;50137.74931125321;326324;326697;328532;329080;329365;22041.448963776034;24474.51050979006;24582.87708561446;25051.87474062618;25093.121740738985;38004.81889482717;40610.18779624332;41399.37900931428;41684.58315416928;41949.58050419579;34243.31513369769;34975.475367870014;35440.29119417649;35489.64510354863;35840;33184.502232466046;35442;35524.28951421009;35560.644393556766;35575;33752.1561960953;34510;34609;34624.480632791034;34776;30882.845585771927;31077.378452431276;31252;31375.05874823759;31726.36547269088;23732.762672373054;24310.149144779847;24812.2706502281;25045.99816007339;25204.74795252024 04:34:04 INFO - PROCESS | 12422 | |2;jquery.html;367.42864845165775;370.0988093991131;371.25748502993997;377.75068454819825;387.2294134672002;16447.67104657906;16481.505554833344;16918.830811691896;17006.06466644334;17064.65870682589;16007.199640017981;16311.102889341082;16406.179691015463;16768;16771.161441927885;4918.557329840305;5153.845384638448;5184.377874655028;5190.506901844319;5193.766280517386;3781.2059467511854;3978.9602103979023;5112;5591.8042868499615;5987.940120598803;5931.495822855062;6016.608920420181;6019.337872834007;6055.7577696892295;6063.060225665029;5769.105788602752;6078.270607527081;6087.482563982023;6088.939110608903;6096.268447786272;3441.1913200397885;5026.2711906773675;5322.760475778599;5325.467453254682;5351.866203344908;21053.157873685035;21418.785812141836;21517.246896358552;21933.670994935088;21949.122035118577;1987.3640435060786;1991.551900822318;2019.4345583236718;2161.373201771484;2403.411164264749;12492.687682807911;13315.733685326239;13588.864111358858;14056.226907520082;14138.717225655531;1718.407149533409;1749.623830876355;1796.4161647464625;1806.7831860176864;1814.600787826676;64937;68539.65730171416;68563.65718171377;68663;68956.6552167236;9528.666496672584;9584.137427631547;9644.421334719798;9792.706218813304;9932.205423566098;13660.385282662304;13751.106178098391;13776.586702398945;13816.516421925386;13817.309134543233;7211.531250468703;7269.418446524265;7361.484696071224;7379.262073792578;7403.66683499233;6950.895736563955;6979.197392299849;7013.26360732126;7076.22161562238;7095.9645201773665;6199.690015499207;6279.152314437492;6334.384731893338;6391.58454700443;6405.839854003594;1585.69871724372;1695.533728224748;1722.750201220816;1737.1922056243907;1774.8491378232736;757.8257000889716;839.2824135364298;909.3225546967551;933.7012156109979;978.4618459847055;17636.382726604763;18504.259829606664;18627.81372186288;18711.812881871007;19006;818.1899919080067;896.5024411451576;901.8016036471965;924.7872989212519;931.3713243560569;7658.349040331635;10249;10444.529996150191;10497;10506.684799456028;293590;297071;297677;400493;430926;80592;84862;86233;86663.56668216745;88272;920.40173886974;925.8935222449504;953.2135987810223;960.0255740423476;965.1940629574244;15455.459058933333;15830.28763705613;15956.686280489495;16107.677846442772;16502.504924852274;27794.41739468416;37700.24599507939;38706.22587548177;39538.209235814546;40052.599474004885;53417.46582534125;54364.184537232766;54445.45554544404;54464.45535544594;55170.44829551653;7572.242775722604;7702.768916932501;7807.804804879924;8016.959915200387;8055.879161812461;10579.682609521727;11035.448227588427;12024.75950481003;12298;12504.374781261082;5457.154141108134;6478.838029049311;9935.65225217114;10235.7441063974;10746.140308775435;5460.655418462162;10616.416097114732;10743.785124297627;10806.35161890289;10920.56317747313;5716.857078573069;9620.422774633544;10141.898581014391;10625.415602141957;10902.400367979837;7524.736634217776;7575.6969721210535;7740.8451830964195;7896.052473703192;8021.478603890729;5357.973210133924;7833.412494063082;9985.650502232387;10431.947840261053;10472.895271047191 04:34:04 INFO - PROCESS | 12422 | |3;mootools.html;1214.9817752733704;1369.5685858954428;1409.3446547355477;1482.822061352637;1679.2443400469792;6553.836154096144;7009.684564194611;7300.525465844717;7557.05536807899;7568.9621551892305;7633.27483889031;7634.9618251908805;7696.191899850519;7698.692052317901;7706.653200605972;2130.957380852382;2152.666336717811;2157.6763485477145;2161.275972549198;2161.9891900540556;2143.07847625521;2185.8579192352527;2186.671999200125;2186.9562608747815;2187.387531491177;2128.4253251622054;2133.5946170227685;2136.839737019722;2138.919845478031;2225.532638145983;2174.043420894809;2179.9128034878586;2180.5093853882986;2183.814375778061;2184.159098746978;2104.074207348777;2133.893305334727;2135.6262654035636;2135.9572808543744;2139.7967193116783;7585.1656317805;7700.422468314899;7713.074431068251;7730.420218483636;7730.574818384986;4470.061287129706;4650.465196502411;4652.534746525354;4652.62778977681;4659.951510910052;2666;2734.753872151496;2788.776897848167;2792.902248421316;2795.7623601993855;879.6921077622845;887.3522328700085;888.7911340834899;896.1218006353745;896.6278994217392;10182.796344073151;10291.639792607297;10303.896961030368;10311.639092631722;10415.323004004715;3825.9808700956874;3943.1127996200626;3992.920141597152;4002.939955900664;4006.559278479365;8302.958485207657;8323.375746818892;8347.248747612744;8347.95826020866;8359.414840961195;4433.623142032899;4467.709598876063;4483.618892394118;4483.820647174141;4492.9101417972115;3595.442706380515;3963.900902477461;3989.4614227078973;4031.858884939013;4167.374893765898;3515.2793677296095;3621.311950729353;3680.8159592020293;3692.649198326155;3693.9445908311395;1130.6721050895312;1134.8638163420442;1135.9545618175346;1144.9771004579861;1147.4951021550492;677.1332694151494;725.2312548698396;758.6510205305511;798.8482188384188;857.3955361470148;4909;4928.211486162197;5097.337346144977;5324.1747529133045;5390;405.3676265026509;405.58022446767455;406.9450624165759;407.1978202940203;411.51441299266554;3486.2853115111343;3495.1611613212644;3528.8059156746112;3542.5217595624263;3590.2281009583066;9093.4998575079;9363.719088427359;9393.765155871159;9483.905160948303;9498.810023799624;9372.5313734313;9383.24934005278;9395.06049395055;9400.764980875396;9402.811943761086;7079.681414336367;7133.678984445713;7250.238724933912;7310.74412395553;7321.194668586451;4928.605711542997;4944.876378090433;4961.50384961501;5062.898742025212;5158.587313015025;8640.524771137647;8668.219860212359;8826.867596985921;8865.113488651083;8869.11308869108;8780.604872780612;8960.372773905765;9011.234045105977;9040.502772347583;9106.043865394304;5940.435658612425;6494.740210391531;6623.138991931018;6675.399214070757;6709.798706038827;7429.5542267464125;7449.143348514774;7493.213212612597;7514.774556763306;7539.773806785586;6585.934140658532;6679.432248258952;6709.429698475684;6793.116894803841;6938;6738.124043874265;6782.321767823179;6800.149981252343;6859.17689877198;6948.513604047668;6069.666168360783;6099.329073801967;6128.754849805958;6136.23297087864;6139.447449729546;4527.2303708369;4557.430321209848;4560.545951407867;4624.9768751156025;4684.110019096361;4436.82252709888;4680.274557443602;4684.531546845425;4718.905621887612;4737.952620473751 04:34:04 INFO - PROCESS | 12422 | |4;prototype.html;276.7523066855163;283.53217191633803;285.4301342615614;285.8427864674429;286.95116865579763;4550.749708766025;4671.649626278026;4698.3657206277185;4705.717656940577;4758.286257061438;4501.842435514757;4594.402727645402;4678.953210467895;4679.391679081723;4686.343911852344;3660.5723767730606;3682.558093028827;3687.59436461989;3689.8339574719066;3693.7968411737343;3509.2630547585036;3527.8588856445713;3691.305347096621;3707.2956138333766;3713.9071523211865;3601;3606.71146308296;3608.260306637133;3616.2948225096115;3626.38351480249;3594.622564630702;3599.0102721751728;3609.7473176877365;3619.475176099464;3619.9276014479565;3150.810951342904;3175.3966746318124;3176.142441540794;3177.396294703999;3180.634227063871;4364.825406983717;4592.563706447882;4612.846788302924;4614.169449499089;4616.746078965655;4128.8348466061325;4148.23257697327;4148.543660197376;4159.313713237312;4174.895627609304;4937.481564435719;4943.134951383529;4957.702537847741;4959.132151873408;4963.783872951114;3308.9503657445157;3419.7093247074026;3463.5843698756057;3476.200473890994;3493.737969652286;5116.155834287338;5139.563137133348;5157.974210128926;5164.535191832715;5197.688138711652;3471.9479207811396;3483.3555792178527;3483.54713887193;3523.700485458765;3545.166885781839;3453.4474484082425;3537.25717599307;3538.0093573799377;3539.43369060949;3564.215872508044;4057.229126465962;4063.959360406358;4069.5116586009276;4070.6946978976694;4099.241640296555;4868.099401610642;4906.215005599087;4909.386326709161;4935.259711043373;4943.258511223274;1163.6450882480756;1185.057878986208;1218.3725381428571;1220.5292622389998;1227.4415141110774;762.8321769210764;779.2091027606983;790.3203245209115;796.3629096722715;802.5345299726145;3953.8418463261146;3990.6408423242046;4000.7799571023293;4009.9599004009588;4015.3374693175883;4498.190325741398;4531.614812740888;4535.092981403733;4535.501094879561;4559.452865656142;3977.6022397759994;3978.204359128128;3984.960150398517;3985.3822657488136;4008.016032064147;2326.8016971259813;2426.502566973766;2439.9508211469238;2457.8771061446855;2462.581361168606;4250.319948808237;4289.699721019561;4313.633341166036;4339.262325404688;4373.2565463871215;4610.4697959734385;4617.353570500132;4628.236341003764;4628.333799832058;4641.350210970467;4131.35963925592;4342.804573794187;4347.260965635849;4348.195583817004;4351.956480435155;4503.482099558592;4523.592876641118;4540.750258735669;4595.862124136282;4600.401947746772;4377.912441751211;4388.890277742954;4416.470023597189;4417.469903611587;4419.977900110607;4235.174141042467;4289.935650965301;4332.6317263033;4341.65550602671;4505.752183629801;3615.5480564929385;3634.382155033598;3635.909102272464;3636.563612366427;3637.745357825033;4938;5062.341895553702;5113.846584602468;5138.743062846917;5165.354330708661;4884.340614017205;4979.576735977483;4987.850364489072;4988.152014157675;5028.899422011466;4946.713854397811;4958.404991401055;4963.255511673134;4965.82619608312;5004.649674522749;4727.456342520517;4851.56335929768;4931.852044438672;4939.901201975868;4941.357623508921;5012.172991456368;5025.65793747154;5025.7989680412375;5053.2420136979745;5054.545090941833;4930.8767280818265;4931.3589233399425;4933.4819843915875;4935.840077581694;4958.305837182869 04:34:04 INFO - PROCESS | 12422 | |5;yui.html;664.3887623386483;712.301944094787;715.7602203261907;722.8048426924734;742.9814254643635;11781.528738850446;11853;11886.940565297162;11899.58351457699;13153.868461315384;13010.804837927439;13178.60464186076;13200.141990770593;13232.669183270424;13237.867621323783;624.5784095735384;757.0725860820506;764.9808754781134;775.9185285545021;782.5930516131608;774.0904437286194;774.9612519374037;775.3138472451865;777.7433446962517;777.9260970207849;830.4062595244399;831.4595512916623;832.367400775412;832.9625166867505;833.125218520551;649.8245473722092;671.7245929169018;673.9056532085511;675.8546912413806;822.3873214455239;590.7814108779736;604.6916072802858;609.2567068176817;613.3988691082719;613.7790395457631;13114.540991065267;13116.540921067717;13140;13148;13195.2742599157;12343.876561234452;12853;12976.416061277265;13032.80450793239;13085.149465284727;11436.942815285953;11501.942490287578;11650;11706.473208705544;11872.52509899603;4137.627613514768;4184.079502509443;4223.429836972;4249.4475718156755;4332.566743325642;56992.71503642455;58265.70867145637;60185.79628407451;60279.397206028254;60463;10070.949645251727;10117.342372745748;10121.949390253001;10190.337628054152;10196.694099177037;18914.81085189158;18936.81063189378;18979.145938432805;19005.429837104908;19081.61836763257;6583.188878016806;6608.603483790988;6703;6826.658667066726;6838.48711346651;3679.9448008279896;3713.2202237530423;3767.868124615625;3770.377887648562;3818.045488627843;2719.687235967889;2807.228012296635;2820.407714380003;2821.971780282212;2829.080548821641;458.5483298950531;473.0232070773841;473.16958737415615;474.42831388177166;476.345025589814;426.81220263084765;426.84633531928483;458.9885252868705;505.48188107190424;528.9685114027661;7143.4999550031;7223.313785190398;7519.345743936326;7621.771346859603;7860.921390786133;459.4922610515399;481.40546425164894;516.5118962580326;550.5265471694339;555.3141869790805;3603.4414665726854;3604.7765525535306;3641.1625326175126;3727.8881633551036;3766.3408903441787;88451.55774221088;89222.55388723145;90197.54901225583;91485.54257228671;92468;76674;77832.22167778363;78960;79011;80765.59617201876;71281.64359178275;72003.6399818008;72474.2752572478;72566.63716681488;73183.63408182925;7011.6494175292055;7046.260142684944;7151.356377925804;7249.601271930094;7428.925710743039;42132.368014480424;42775;42851.71520841402;43733;44076.33885491784;55544.44455555393;58540.70729646495;58774.70612646909;58797.70601146967;59155.112673310796;9261.814763704822;9495.43027418357;9846.261530385107;9939.850902236616;9970.700878973643;12452.31512266834;12791.680207994874;13481.932590336986;13547.661308467366;14066.78899816524;7623.504472209289;8725.197743500501;11832.290062596272;11985.400729963641;11997.100217483898;11811.409429528661;11843.763124737285;12037.157398981988;12226.87773122293;12336.074794390635;11990.280583165038;12033.63899083029;12766.489340426651;12787.936060319638;12790.488380464678;9970.900290996997;10211.693649190536;10360.114649555402;10395.844062339222;10424.42665653366;9578.952105239428;9948.850767238642;10453.372797632166;10538.420386878795;10649.361038337725 04:34:04 INFO - PROCESS | 12422 | __end_tp_report 04:34:04 INFO - PROCESS | 12422 | __start_cc_report 04:34:04 INFO - PROCESS | 12422 | _x_x_mozilla_cycle_collect,1072 04:34:04 INFO - PROCESS | 12422 | __end_cc_report 04:34:04 INFO - PROCESS | 12422 | __startTimestamp1466508844653__endTimestamp 04:34:04 INFO - PROCESS | 12422 | 04:34:04 INFO - PROCESS | 12422 | ------- Summary: start ------- 04:34:04 INFO - PROCESS | 12422 | Number of tests: 6 04:34:04 INFO - PROCESS | 12422 | 04:34:04 INFO - PROCESS | 12422 | [#0] dojo.html Cycles:165 Average:4697.77 Median:4872.10 stddev:507.46 (10.4%) stddev-sans-first:482.52 04:34:04 INFO - PROCESS | 12422 | Values: 2634.7 2642.2 2653.7 2681.2 2689.6 4637.4 4695.9 4721.7 4773.9 4822.7 4687.7 4703.5 4708.2 4734.1 4788.1 4225.1 4249.5 4261.0 4370.3 4371.6 4267.2 4350.3 4394.9 4423.8 4431.4 4220.0 4268.4 4272.3 4283.0 4306.9 4231.4 4257.3 4258.6 4304.7 4316.4 4262.6 4300.9 4310.2 4331.5 4346.8 4600.4 4703.8 4768.8 4783.6 4791.4 4972.1 5024.8 5030.4 5096.5 5100.6 5063.8 5085.4 5089.9 5110.7 5128.9 4666.6 4719.2 4735.5 4749.0 4785.4 5197.5 5207.3 5281.6 5284.4 5285.3 5030.8 5059.1 5069.2 5075.3 5080.4 4991.4 5023.2 5072.8 5137.6 5183.9 5007.8 5017.2 5027.0 5030.3 5065.1 5006.8 5007.7 5009.6 5014.0 5051.9 4128.8 4174.6 4222.6 4237.7 4268.6 3722.4 3732.2 3744.9 3769.8 3790.7 4412.5 4415.1 4416.3 4449.9 4461.0 5026.9 5060.8 5108.9 5132.2 5138.7 4435.1 4436.9 4437.2 4460.8 4469.2 4567.4 4578.7 4583.5 4585.5 4629.7 4656.2 4797.8 4858.5 4865.2 4872.1 5138.4 5159.2 5167.2 5167.6 5207.6 4838.7 4875.8 4876.0 4880.9 4928.1 4840.8 4951.3 5027.1 5069.2 5069.5 5132.4 5152.2 5152.8 5162.5 5165.3 4985.3 5002.2 5004.9 5005.4 5032.7 4872.8 4891.5 4930.0 4941.0 4986.7 4924.6 4960.1 4995.6 5000.8 5005.9 4916.8 5058.3 5059.9 5063.5 5096.4 4818.1 4872.8 4878.5 4893.3 4908.9 04:34:04 INFO - PROCESS | 12422 | 04:34:04 INFO - PROCESS | 12422 | [#1] ext.html Cycles:180 Average:45821.84 Median:19703.57 stddev:86555.20 (439.3%) stddev-sans-first:86731.24 04:34:04 INFO - PROCESS | 12422 | Values: 540.6 581.5 582.7 583.3 600.5 26058.7 39339.6 40248.6 40267.6 40363.4 40590.2 41250.4 41277.2 41388.8 41470.6 7687.0 7831.0 7831.3 7835.4 7838.1 7826.1 7996.3 8002.4 8002.7 8008.0 8005.1 8040.2 8041.4 8044.6 8046.7 7972.5 7999.5 8015.8 8019.6 8024.9 7735.4 7798.7 7799.9 7800.6 7805.1 38039.8 38276.4 38348.4 38464.0 38480.0 3212.9 3250.3 3423.9 3567.1 3774.2 28136.6 28396.6 28980.6 29018.1 29182.9 3133.5 3138.0 3242.9 3244.2 3250.9 181299.0 181901.0 183070.0 183260.0 183628.1 42570.0 43822.8 43875.8 48243.3 48912.8 47411.5 47615.8 51965.7 53415.0 53575.7 13474.3 13781.3 13785.7 13786.4 13787.2 10612.1 10677.7 10692.4 10692.4 10694.6 13921.8 15087.5 15540.2 15653.6 15722.9 5981.4 6037.8 6058.2 6126.6 6223.8 795.2 869.2 894.5 950.3 972.2 26642.5 26790.7 27362.3 27570.7 27642.2 910.1 950.9 979.8 985.2 1001.7 14283.4 14604.2 14689.4 14943.0 14964.6 345418.0 372833.0 381002.0 381205.0 585366.0 47410.0 47634.3 47855.5 47905.5 47931.0 1148.9 1177.8 1182.8 1201.7 1201.8 26934.9 27023.9 27531.7 28232.0 28403.7 41292.2 44682.6 45952.0 45991.3 50137.7 326324.0 326697.0 328532.0 329080.0 329365.0 22041.4 24474.5 24582.9 25051.9 25093.1 38004.8 40610.2 41399.4 41684.6 41949.6 34243.3 34975.5 35440.3 35489.6 35840.0 33184.5 35442.0 35524.3 35560.6 35575.0 33752.2 34510.0 34609.0 34624.5 34776.0 30882.8 31077.4 31252.0 31375.1 31726.4 23732.8 24310.1 24812.3 25046.0 25204.7 04:34:04 INFO - PROCESS | 12422 | 04:34:04 INFO - PROCESS | 12422 | [#2] jquery.html Cycles:180 Average:23459.77 Median:5132.92 stddev:58219.36 (1134.2%) stddev-sans-first:58356.87 04:34:04 INFO - PROCESS | 12422 | Values: 367.4 370.1 371.3 377.8 387.2 16447.7 16481.5 16918.8 17006.1 17064.7 16007.2 16311.1 16406.2 16768.0 16771.2 4918.6 5153.8 5184.4 5190.5 5193.8 3781.2 3979.0 5112.0 5591.8 5987.9 5931.5 6016.6 6019.3 6055.8 6063.1 5769.1 6078.3 6087.5 6088.9 6096.3 3441.2 5026.3 5322.8 5325.5 5351.9 21053.2 21418.8 21517.2 21933.7 21949.1 1987.4 1991.6 2019.4 2161.4 2403.4 12492.7 13315.7 13588.9 14056.2 14138.7 1718.4 1749.6 1796.4 1806.8 1814.6 64937.0 68539.7 68563.7 68663.0 68956.7 9528.7 9584.1 9644.4 9792.7 9932.2 13660.4 13751.1 13776.6 13816.5 13817.3 7211.5 7269.4 7361.5 7379.3 7403.7 6950.9 6979.2 7013.3 7076.2 7096.0 6199.7 6279.2 6334.4 6391.6 6405.8 1585.7 1695.5 1722.8 1737.2 1774.8 757.8 839.3 909.3 933.7 978.5 17636.4 18504.3 18627.8 18711.8 19006.0 818.2 896.5 901.8 924.8 931.4 7658.3 10249.0 10444.5 10497.0 10506.7 293590.0 297071.0 297677.0 400493.0 430926.0 80592.0 84862.0 86233.0 86663.6 88272.0 920.4 925.9 953.2 960.0 965.2 15455.5 15830.3 15956.7 16107.7 16502.5 27794.4 37700.2 38706.2 39538.2 40052.6 53417.5 54364.2 54445.5 54464.5 55170.4 7572.2 7702.8 7807.8 8017.0 8055.9 10579.7 11035.4 12024.8 12298.0 12504.4 5457.2 6478.8 9935.7 10235.7 10746.1 5460.7 10616.4 10743.8 10806.4 10920.6 5716.9 9620.4 10141.9 10625.4 10902.4 7524.7 7575.7 7740.8 7896.1 8021.5 5358.0 7833.4 9985.7 10431.9 10472.9 04:34:04 INFO - PROCESS | 12422 | 04:34:04 INFO - PROCESS | 12422 | [#3] mootools.html Cycles:180 Average:5008.71 Median:4918.61 stddev:2817.49 (57.3%) stddev-sans-first:2810.97 04:34:04 INFO - PROCESS | 12422 | Values: 1215.0 1369.6 1409.3 1482.8 1679.2 6553.8 7009.7 7300.5 7557.1 7569.0 7633.3 7635.0 7696.2 7698.7 7706.7 2131.0 2152.7 2157.7 2161.3 2162.0 2143.1 2185.9 2186.7 2187.0 2187.4 2128.4 2133.6 2136.8 2138.9 2225.5 2174.0 2179.9 2180.5 2183.8 2184.2 2104.1 2133.9 2135.6 2136.0 2139.8 7585.2 7700.4 7713.1 7730.4 7730.6 4470.1 4650.5 4652.5 4652.6 4660.0 2666.0 2734.8 2788.8 2792.9 2795.8 879.7 887.4 888.8 896.1 896.6 10182.8 10291.6 10303.9 10311.6 10415.3 3826.0 3943.1 3992.9 4002.9 4006.6 8303.0 8323.4 8347.2 8348.0 8359.4 4433.6 4467.7 4483.6 4483.8 4492.9 3595.4 3963.9 3989.5 4031.9 4167.4 3515.3 3621.3 3680.8 3692.6 3693.9 1130.7 1134.9 1136.0 1145.0 1147.5 677.1 725.2 758.7 798.8 857.4 4909.0 4928.2 5097.3 5324.2 5390.0 405.4 405.6 406.9 407.2 411.5 3486.3 3495.2 3528.8 3542.5 3590.2 9093.5 9363.7 9393.8 9483.9 9498.8 9372.5 9383.2 9395.1 9400.8 9402.8 7079.7 7133.7 7250.2 7310.7 7321.2 4928.6 4944.9 4961.5 5062.9 5158.6 8640.5 8668.2 8826.9 8865.1 8869.1 8780.6 8960.4 9011.2 9040.5 9106.0 5940.4 6494.7 6623.1 6675.4 6709.8 7429.6 7449.1 7493.2 7514.8 7539.8 6585.9 6679.4 6709.4 6793.1 6938.0 6738.1 6782.3 6800.1 6859.2 6948.5 6069.7 6099.3 6128.8 6136.2 6139.4 4527.2 4557.4 4560.5 4625.0 4684.1 4436.8 4680.3 4684.5 4718.9 4738.0 04:34:04 INFO - PROCESS | 12422 | 04:34:04 INFO - PROCESS | 12422 | [#4] prototype.html Cycles:180 Average:3959.23 Median:4347.73 stddev:1159.41 (26.7%) stddev-sans-first:1129.23 04:34:04 INFO - PROCESS | 12422 | Values: 276.8 283.5 285.4 285.8 287.0 4550.7 4671.6 4698.4 4705.7 4758.3 4501.8 4594.4 4679.0 4679.4 4686.3 3660.6 3682.6 3687.6 3689.8 3693.8 3509.3 3527.9 3691.3 3707.3 3713.9 3601.0 3606.7 3608.3 3616.3 3626.4 3594.6 3599.0 3609.7 3619.5 3619.9 3150.8 3175.4 3176.1 3177.4 3180.6 4364.8 4592.6 4612.8 4614.2 4616.7 4128.8 4148.2 4148.5 4159.3 4174.9 4937.5 4943.1 4957.7 4959.1 4963.8 3309.0 3419.7 3463.6 3476.2 3493.7 5116.2 5139.6 5158.0 5164.5 5197.7 3471.9 3483.4 3483.5 3523.7 3545.2 3453.4 3537.3 3538.0 3539.4 3564.2 4057.2 4064.0 4069.5 4070.7 4099.2 4868.1 4906.2 4909.4 4935.3 4943.3 1163.6 1185.1 1218.4 1220.5 1227.4 762.8 779.2 790.3 796.4 802.5 3953.8 3990.6 4000.8 4010.0 4015.3 4498.2 4531.6 4535.1 4535.5 4559.5 3977.6 3978.2 3985.0 3985.4 4008.0 2326.8 2426.5 2440.0 2457.9 2462.6 4250.3 4289.7 4313.6 4339.3 4373.3 4610.5 4617.4 4628.2 4628.3 4641.4 4131.4 4342.8 4347.3 4348.2 4352.0 4503.5 4523.6 4540.8 4595.9 4600.4 4377.9 4388.9 4416.5 4417.5 4420.0 4235.2 4289.9 4332.6 4341.7 4505.8 3615.5 3634.4 3635.9 3636.6 3637.7 4938.0 5062.3 5113.8 5138.7 5165.4 4884.3 4979.6 4987.9 4988.2 5028.9 4946.7 4958.4 4963.3 4965.8 5004.6 4727.5 4851.6 4931.9 4939.9 4941.4 5012.2 5025.7 5025.8 5053.2 5054.5 4930.9 4931.4 4933.5 4935.8 4958.3 04:34:04 INFO - PROCESS | 12422 | 04:34:04 INFO - PROCESS | 12422 | [#5] yui.html Cycles:180 Average:17053.74 Median:473.10 stddev:23771.33 (5024.6%) stddev-sans-first:23806.16 04:34:04 INFO - PROCESS | 12422 | Values: 664.4 712.3 715.8 722.8 743.0 11781.5 11853.0 11886.9 11899.6 13153.9 13010.8 13178.6 13200.1 13232.7 13237.9 624.6 757.1 765.0 775.9 782.6 774.1 775.0 775.3 777.7 777.9 830.4 831.5 832.4 833.0 833.1 649.8 671.7 673.9 675.9 822.4 590.8 604.7 609.3 613.4 613.8 13114.5 13116.5 13140.0 13148.0 13195.3 12343.9 12853.0 12976.4 13032.8 13085.1 11436.9 11501.9 11650.0 11706.5 11872.5 4137.6 4184.1 4223.4 4249.4 4332.6 56992.7 58265.7 60185.8 60279.4 60463.0 10070.9 10117.3 10121.9 10190.3 10196.7 18914.8 18936.8 18979.1 19005.4 19081.6 6583.2 6608.6 6703.0 6826.7 6838.5 3679.9 3713.2 3767.9 3770.4 3818.0 2719.7 2807.2 2820.4 2822.0 2829.1 458.5 473.0 473.2 474.4 476.3 426.8 426.8 459.0 505.5 529.0 7143.5 7223.3 7519.3 7621.8 7860.9 459.5 481.4 516.5 550.5 555.3 3603.4 3604.8 3641.2 3727.9 3766.3 88451.6 89222.6 90197.5 91485.5 92468.0 76674.0 77832.2 78960.0 79011.0 80765.6 71281.6 72003.6 72474.3 72566.6 73183.6 7011.6 7046.3 7151.4 7249.6 7428.9 42132.4 42775.0 42851.7 43733.0 44076.3 55544.4 58540.7 58774.7 58797.7 59155.1 9261.8 9495.4 9846.3 9939.9 9970.7 12452.3 12791.7 13481.9 13547.7 14066.8 7623.5 8725.2 11832.3 11985.4 11997.1 11811.4 11843.8 12037.2 12226.9 12336.1 11990.3 12033.6 12766.5 12787.9 12790.5 9970.9 10211.7 10360.1 10395.8 10424.4 9579.0 9948.9 10453.4 10538.4 10649.4 04:34:04 INFO - PROCESS | 12422 | -------- Summary: end -------- 04:34:04 INFO - PROCESS | 12422 | 04:34:05 INFO - TEST-INFO | 12422: exit 0 04:34:05 INFO - TEST-OK | dromaeo_css | took 1119884ms 04:34:05 INFO - TEST-START | kraken 04:34:05 INFO - operating with platform_type : linux_ 04:34:05 INFO - Initialising browser for kraken test... 04:34:05 INFO - TEST-INFO | started process 12605 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph34xFV/profile http://localhost:40088/getInfo.html) 04:34:09 INFO - PROCESS | 12605 | __metrics Screen width/height:1600/1200 04:34:09 INFO - PROCESS | 12605 | colorDepth:24 04:34:09 INFO - PROCESS | 12605 | Browser inner width/height: 1024/697 04:34:09 INFO - PROCESS | 12605 | __metrics 04:34:10 INFO - PROCESS | 12605 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:34:11 INFO - TEST-INFO | 12605: exit 0 04:34:11 INFO - Browser initialized. 04:34:11 INFO - Running cycle 1/1 for kraken test... 04:34:11 INFO - TEST-INFO | started process 12685 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph34xFV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:34:24 INFO - PROCESS | 12685 | RSS: Main: 175509504 04:34:24 INFO - PROCESS | 12685 | 04:34:26 INFO - PROCESS | 12685 | Cycle 1(1): loaded http://localhost:40088/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40088/tests/kraken/driver.html?testName=audio-beat-detection) 04:34:27 INFO - PROCESS | 12685 | RSS: Main: 233902080 04:34:27 INFO - PROCESS | 12685 | 04:34:30 INFO - PROCESS | 12685 | Cycle 1(1): loaded http://localhost:40088/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40088/tests/kraken/driver.html?testName=audio-dft) 04:34:31 INFO - PROCESS | 12685 | RSS: Main: 222433280 04:34:31 INFO - PROCESS | 12685 | 04:34:34 INFO - PROCESS | 12685 | Cycle 1(1): loaded http://localhost:40088/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40088/tests/kraken/driver.html?testName=audio-fft) 04:34:35 INFO - PROCESS | 12685 | RSS: Main: 289026048 04:34:35 INFO - PROCESS | 12685 | 04:34:37 INFO - PROCESS | 12685 | Cycle 1(1): loaded http://localhost:40088/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40088/tests/kraken/driver.html?testName=audio-oscillator) 04:34:37 INFO - PROCESS | 12685 | RSS: Main: 198975488 04:34:37 INFO - PROCESS | 12685 | 04:34:40 INFO - PROCESS | 12685 | Cycle 1(1): loaded http://localhost:40088/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40088/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:34:40 INFO - PROCESS | 12685 | RSS: Main: 202870784 04:34:40 INFO - PROCESS | 12685 | 04:34:43 INFO - PROCESS | 12685 | Cycle 1(1): loaded http://localhost:40088/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40088/tests/kraken/driver.html?testName=imaging-darkroom) 04:34:44 INFO - PROCESS | 12685 | RSS: Main: 239636480 04:34:44 INFO - PROCESS | 12685 | 04:34:47 INFO - PROCESS | 12685 | Cycle 1(1): loaded http://localhost:40088/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40088/tests/kraken/driver.html?testName=imaging-desaturate) 04:34:48 INFO - PROCESS | 12685 | RSS: Main: 239648768 04:34:48 INFO - PROCESS | 12685 | 04:34:51 INFO - PROCESS | 12685 | Cycle 1(1): loaded http://localhost:40088/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40088/tests/kraken/driver.html?testName=json-parse-financial) 04:34:52 INFO - PROCESS | 12685 | RSS: Main: 239407104 04:34:52 INFO - PROCESS | 12685 | 04:34:53 INFO - PROCESS | 12685 | Cycle 1(1): loaded http://localhost:40088/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40088/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:34:54 INFO - PROCESS | 12685 | RSS: Main: 225411072 04:34:54 INFO - PROCESS | 12685 | 04:34:56 INFO - PROCESS | 12685 | Cycle 1(1): loaded http://localhost:40088/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40088/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:34:56 INFO - PROCESS | 12685 | RSS: Main: 233185280 04:34:56 INFO - PROCESS | 12685 | 04:34:59 INFO - PROCESS | 12685 | Cycle 1(1): loaded http://localhost:40088/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40088/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:34:59 INFO - PROCESS | 12685 | RSS: Main: 240435200 04:34:59 INFO - PROCESS | 12685 | 04:35:02 INFO - PROCESS | 12685 | Cycle 1(1): loaded http://localhost:40088/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40088/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:35:03 INFO - PROCESS | 12685 | RSS: Main: 243949568 04:35:03 INFO - PROCESS | 12685 | 04:35:06 INFO - PROCESS | 12685 | Cycle 1(1): loaded http://localhost:40088/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40088/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:35:06 INFO - PROCESS | 12685 | RSS: Main: 244228096 04:35:06 INFO - PROCESS | 12685 | 04:35:08 INFO - PROCESS | 12685 | Cycle 1(1): loaded http://localhost:40088/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40088/tests/kraken/driver.html?testName=ai-astar) 04:35:08 INFO - PROCESS | 12685 | RSS: Main: 287920128 04:35:08 INFO - PROCESS | 12685 | 04:35:08 INFO - PROCESS | 12685 | __start_tp_report 04:35:08 INFO - PROCESS | 12685 | _x_x_mozilla_page_load 04:35:08 INFO - PROCESS | 12685 | _x_x_mozilla_page_load_details 04:35:08 INFO - PROCESS | 12685 | |i|pagename|runs| 04:35:08 INFO - PROCESS | 12685 | |0;ai-astar;114;110;113;115;113;114;113;114;113;113 04:35:08 INFO - PROCESS | 12685 | |1;audio-beat-detection;162;134;131;194;131;133;155;130;199;130 04:35:08 INFO - PROCESS | 12685 | |2;audio-dft;161;162;162;161;162;162;162;161;159;160 04:35:08 INFO - PROCESS | 12685 | |3;audio-fft;82;78;76;129;76;77;76;75;101;75 04:35:08 INFO - PROCESS | 12685 | |4;audio-oscillator;86;87;114;86;87;87;119;86;87;134 04:35:08 INFO - PROCESS | 12685 | |5;imaging-gaussian-blur;117;117;118;118;118;118;119;118;117;116 04:35:08 INFO - PROCESS | 12685 | |6;imaging-darkroom;146;146;147;147;147;147;147;146;147;146 04:35:08 INFO - PROCESS | 12685 | |7;imaging-desaturate;95;95;96;94;95;95;94;95;94;95 04:35:08 INFO - PROCESS | 12685 | |8;json-parse-financial;63;64;64;64;65;64;64;64;63;64 04:35:08 INFO - PROCESS | 12685 | |9;json-stringify-tinderbox;65;64;64;64;66;65;64;64;65;64 04:35:08 INFO - PROCESS | 12685 | |10;stanford-crypto-aes;85;85;84;85;86;85;84;93;112;85 04:35:08 INFO - PROCESS | 12685 | |11;stanford-crypto-ccm;147;145;141;133;131;130;129;131;153;139 04:35:08 INFO - PROCESS | 12685 | |12;stanford-crypto-pbkdf2;172;171;175;168;168;169;175;176;171;169 04:35:08 INFO - PROCESS | 12685 | |13;stanford-crypto-sha256-iterative;67;68;67;66;67;67;68;67;66;66 04:35:08 INFO - PROCESS | 12685 | __end_tp_report 04:35:08 INFO - PROCESS | 12685 | __start_cc_report 04:35:08 INFO - PROCESS | 12685 | _x_x_mozilla_cycle_collect,1893 04:35:08 INFO - PROCESS | 12685 | __end_cc_report 04:35:08 INFO - PROCESS | 12685 | __startTimestamp1466508908821__endTimestamp 04:35:08 INFO - PROCESS | 12685 | 04:35:08 INFO - PROCESS | 12685 | ------- Summary: start ------- 04:35:08 INFO - PROCESS | 12685 | Number of tests: 14 04:35:08 INFO - PROCESS | 12685 | 04:35:08 INFO - PROCESS | 12685 | [#0] ai-astar Cycles:10 Average:113.20 Median:113.50 stddev:1.32 (1.2%) stddev-sans-first:1.36 04:35:08 INFO - PROCESS | 12685 | Values: 114.0 110.0 113.0 115.0 113.0 114.0 113.0 114.0 113.0 113.0 04:35:08 INFO - PROCESS | 12685 | 04:35:08 INFO - PROCESS | 12685 | [#1] audio-beat-detection Cycles:10 Average:149.90 Median:144.50 stddev:27.02 (18.7%) stddev-sans-first:28.31 04:35:08 INFO - PROCESS | 12685 | Values: 162.0 134.0 131.0 194.0 131.0 133.0 155.0 130.0 199.0 130.0 04:35:08 INFO - PROCESS | 12685 | 04:35:08 INFO - PROCESS | 12685 | [#2] audio-dft Cycles:10 Average:161.20 Median:162.00 stddev:1.03 (0.6%) stddev-sans-first:1.09 04:35:08 INFO - PROCESS | 12685 | Values: 161.0 162.0 162.0 161.0 162.0 162.0 162.0 161.0 159.0 160.0 04:35:08 INFO - PROCESS | 12685 | 04:35:08 INFO - PROCESS | 12685 | [#3] audio-fft Cycles:10 Average:84.50 Median:76.00 stddev:17.49 (23.0%) stddev-sans-first:18.53 04:35:08 INFO - PROCESS | 12685 | Values: 82.0 78.0 76.0 129.0 76.0 77.0 76.0 75.0 101.0 75.0 04:35:08 INFO - PROCESS | 12685 | 04:35:08 INFO - PROCESS | 12685 | [#4] audio-oscillator Cycles:10 Average:97.30 Median:86.50 stddev:17.96 (20.8%) stddev-sans-first:18.58 04:35:08 INFO - PROCESS | 12685 | Values: 86.0 87.0 114.0 86.0 87.0 87.0 119.0 86.0 87.0 134.0 04:35:08 INFO - PROCESS | 12685 | 04:35:08 INFO - PROCESS | 12685 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.84 (0.7%) stddev-sans-first:0.87 04:35:08 INFO - PROCESS | 12685 | Values: 117.0 117.0 118.0 118.0 118.0 118.0 119.0 118.0 117.0 116.0 04:35:08 INFO - PROCESS | 12685 | 04:35:08 INFO - PROCESS | 12685 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 04:35:08 INFO - PROCESS | 12685 | Values: 146.0 146.0 147.0 147.0 147.0 147.0 147.0 146.0 147.0 146.0 04:35:08 INFO - PROCESS | 12685 | 04:35:08 INFO - PROCESS | 12685 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 04:35:08 INFO - PROCESS | 12685 | Values: 95.0 95.0 96.0 94.0 95.0 95.0 94.0 95.0 94.0 95.0 04:35:08 INFO - PROCESS | 12685 | 04:35:08 INFO - PROCESS | 12685 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:64.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 04:35:08 INFO - PROCESS | 12685 | Values: 63.0 64.0 64.0 64.0 65.0 64.0 64.0 64.0 63.0 64.0 04:35:08 INFO - PROCESS | 12685 | 04:35:08 INFO - PROCESS | 12685 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:64.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 04:35:08 INFO - PROCESS | 12685 | Values: 65.0 64.0 64.0 64.0 66.0 65.0 64.0 64.0 65.0 64.0 04:35:08 INFO - PROCESS | 12685 | 04:35:08 INFO - PROCESS | 12685 | [#10] stanford-crypto-aes Cycles:10 Average:88.40 Median:85.00 stddev:8.69 (10.2%) stddev-sans-first:9.13 04:35:08 INFO - PROCESS | 12685 | Values: 85.0 85.0 84.0 85.0 86.0 85.0 84.0 93.0 112.0 85.0 04:35:08 INFO - PROCESS | 12685 | 04:35:08 INFO - PROCESS | 12685 | [#11] stanford-crypto-ccm Cycles:10 Average:137.90 Median:140.00 stddev:8.39 (6.0%) stddev-sans-first:8.22 04:35:08 INFO - PROCESS | 12685 | Values: 147.0 145.0 141.0 133.0 131.0 130.0 129.0 131.0 153.0 139.0 04:35:08 INFO - PROCESS | 12685 | 04:35:08 INFO - PROCESS | 12685 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.40 Median:171.50 stddev:3.03 (1.8%) stddev-sans-first:3.20 04:35:08 INFO - PROCESS | 12685 | Values: 172.0 171.0 175.0 168.0 168.0 169.0 175.0 176.0 171.0 169.0 04:35:08 INFO - PROCESS | 12685 | 04:35:08 INFO - PROCESS | 12685 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 04:35:08 INFO - PROCESS | 12685 | Values: 67.0 68.0 67.0 66.0 67.0 67.0 68.0 67.0 66.0 66.0 04:35:08 INFO - PROCESS | 12685 | -------- Summary: end -------- 04:35:08 INFO - PROCESS | 12685 | 04:35:09 INFO - TEST-INFO | 12685: exit 0 04:35:09 INFO - TEST-OK | kraken | took 64457ms 04:35:09 INFO - SUITE-END | took 1184s 04:35:09 INFO - Completed test suite (00:19:44) 04:35:09 INFO - javascript benchmark 04:35:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2634.7101818799933, 2642.20733779866, 2653.708092109868, 2681.1956413076073, 2689.6100065490505, 4637.420322459692, 4695.85912422627, 4721.716696998183, 4773.90452190956, 4822.734749588772, 4687.742174180418, 4703.529647035295, 4708.176069187895, 4734.124187025394, 4788.090262850056, 4225.133847561258, 4249.511306199795, 4261.04126571522, 4370.2570563004365, 4371.628411585003, 4267.167902259061, 4350.303951367781, 4394.912101757963, 4423.823047078129, 4431.446069241345, 4219.9578004219875, 4268.445102136733, 4272.2950713132295, 4282.957170428318, 4306.870793876189, 4231.386448964883, 4257.276263035292, 4258.6380157686635, 4304.741715497049, 4316.438862947828, 4262.573742625744, 4300.8709738707885, 4310.224159651261, 4331.501877284121, 4346.782660866944, 4600.4479462464715, 4703.811847526094, 4768.7615619218905, 4783.593394561466, 4791.377120974251, 4972.105021096201, 5024.773885175176, 5030.396352437694, 5096.51583099605, 5100.591952643779, 5063.797448102072, 5085.440601533828, 5089.898202035975, 5110.744462776884, 5128.948710512885, 4666.556677115668, 4719.221328480831, 4735.502772208937, 4749.0, 4785.449673287581, 5197.532222100029, 5207.270982062439, 5281.551068159172, 5284.392294886137, 5285.286486324374, 5030.823921162815, 5059.114654935445, 5069.239614057847, 5075.264086707407, 5080.441151473335, 4991.351124353883, 5023.19628859388, 5072.797088116434, 5137.563307118862, 5183.948160518422, 5007.799688012512, 5017.1721665924715, 5027.044861476308, 5030.320906677625, 5065.088284108896, 5006.824761133343, 5007.749612519359, 5009.624278179152, 5014.0, 5051.873703157377, 4128.8348466061625, 4174.624283814411, 4222.59885310895, 4237.660987121023, 4268.551802060739, 3722.3858063419775, 3732.2162345907122, 3744.8689295874515, 3769.849206031783, 3790.65884070435, 4412.492563355191, 4415.09490554442, 4416.29339305716, 4449.911001779947, 4460.977695111568, 5026.899462010812, 5060.7722652480725, 5108.897822043538, 5132.1788513838355, 5138.717370544581, 4435.090806384684, 4436.933445998313, 4437.179121862466, 4460.817883260938, 4469.217886869785, 4567.383403240587, 4578.748168850745, 4583.54164583539, 4585.495595484494, 4629.699069560468, 4656.208444564364, 4797.8080876765935, 4858.5384388483035, 4865.221564549655, 4872.098661747588, 5138.409082955508, 5159.226116082617, 5167.173252279617, 5167.638265321391, 5207.557357624644, 4838.661293709407, 4875.8049678012485, 4876.003354498696, 4880.902381952412, 4928.088303663833, 4840.782164802522, 4951.282064100757, 5027.069992051483, 5069.239614057921, 5069.493050694901, 5132.409772876018, 5152.175651895679, 5152.845414637567, 5162.535371816554, 5165.251038599307, 4985.3020577118505, 5002.224655178453, 5004.924926126184, 5005.399352077774, 5032.7483625819295, 4872.780724867461, 4891.5353041461, 4930.013997200646, 4941.0, 4986.6509344347, 4924.630652701134, 4960.057589058211, 4995.600351971906, 5000.824971125993, 5005.899882002267, 4916.778744956414, 5058.291839142449, 5059.87350316245, 5063.544281014726, 5096.388433388017, 4818.084563932842, 4872.756362181947, 4878.463369029475, 4893.266010098514, 4908.901821963612], "value": 4664.713687048374, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [540.6315384430388, 581.459242904099, 582.7319433060792, 583.2621733507111, 600.4745847383538, 26058.739412605868, 39339.60660393395, 40248.59751402485, 40267.59732402675, 40363.39454908175, 40590.18819623606, 41250.381244281285, 41277.17445651085, 41388.79305603468, 41470.58529414705, 7687.03912011, 7831.021122359705, 7831.29518343349, 7835.412344074217, 7838.059432868064, 7826.060872695284, 7996.280334769869, 8002.439829211958, 8002.67989280431, 8008.0, 8005.11943686197, 8040.1959804019425, 8041.356691464669, 8044.597770111501, 8046.718364857231, 7972.481788683746, 7999.480033797843, 8015.839683206333, 8019.639116239783, 8024.879626805603, 7735.419843511759, 7798.688052477894, 7799.883001754978, 7800.609969501502, 7805.063392392893, 38039.809800951094, 38276.42585361222, 38348.424773628416, 38464.0, 38480.037999049964, 3212.9357412851846, 3250.252441938344, 3423.9315213695586, 3567.1438854674952, 3774.2451509697894, 28136.577951330746, 28396.574051389245, 28980.565291520645, 29018.12945611635, 29182.854085729436, 3133.5143052826847, 3137.952930706041, 3242.935141297161, 3244.23760416302, 3250.886218982348, 181299.0, 181901.0, 183070.0, 183260.0, 183628.08185959118, 42570.0, 43822.78088609601, 43875.78062109669, 48243.276350854765, 48912.75543622259, 47411.5258847414, 47615.76192119017, 51965.7401712989, 53415.0, 53575.73212133914, 13474.258915759727, 13781.310934453237, 13785.655358616115, 13786.379612917443, 13787.172769633855, 10612.09797167234, 10677.733056673645, 10692.358458492516, 10692.411917344622, 10694.572217111228, 13921.791173132411, 15087.47193848232, 15540.222988850739, 15653.608659783597, 15722.921385393, 5981.37195594465, 6037.849053773603, 6058.1518587397795, 6126.571140020156, 6223.751049958041, 795.208767276552, 869.1829680100685, 894.5303715549388, 950.2682934140811, 972.246508955551, 26642.467150656877, 26790.732092679213, 27362.31594210121, 27570.724292757215, 27642.170734877986, 910.094456016268, 950.9429434233969, 979.8236317462926, 985.2069084386994, 1001.6544292219173, 14283.357248923823, 14604.225197212496, 14689.412423503154, 14943.028703134261, 14964.551063468114, 345418.0, 372833.0, 381002.0, 381205.0, 585366.0, 47410.0, 47634.285485717744, 47855.5214447851, 47905.520944790806, 47931.0, 1148.873623901387, 1177.8409914661754, 1182.8166634171716, 1201.7115892185811, 1201.813718873576, 26934.86532567403, 27023.86488067547, 27531.724682752916, 28232.0, 28403.715962840935, 41292.1741565173, 44682.55317446784, 45952.0, 45991.31013034874, 50137.74931125321, 326324.0, 326697.0, 328532.0, 329080.0, 329365.0, 22041.448963776034, 24474.51050979006, 24582.87708561446, 25051.87474062618, 25093.121740738985, 38004.81889482717, 40610.18779624332, 41399.37900931428, 41684.58315416928, 41949.58050419579, 34243.31513369769, 34975.475367870014, 35440.29119417649, 35489.64510354863, 35840.0, 33184.502232466046, 35442.0, 35524.28951421009, 35560.644393556766, 35575.0, 33752.1561960953, 34510.0, 34609.0, 34624.480632791034, 34776.0, 30882.845585771927, 31077.378452431276, 31252.0, 31375.05874823759, 31726.36547269088, 23732.762672373054, 24310.149144779847, 24812.2706502281, 25045.99816007339, 25204.74795252024], "value": 17023.197646155983, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.42864845165775, 370.0988093991131, 371.25748502993997, 377.75068454819825, 387.2294134672002, 16447.67104657906, 16481.505554833344, 16918.830811691896, 17006.06466644334, 17064.65870682589, 16007.199640017981, 16311.102889341082, 16406.179691015463, 16768.0, 16771.161441927885, 4918.557329840305, 5153.845384638448, 5184.377874655028, 5190.506901844319, 5193.766280517386, 3781.2059467511854, 3978.9602103979023, 5112.0, 5591.8042868499615, 5987.940120598803, 5931.495822855062, 6016.608920420181, 6019.337872834007, 6055.7577696892295, 6063.060225665029, 5769.105788602752, 6078.270607527081, 6087.482563982023, 6088.939110608903, 6096.268447786272, 3441.1913200397885, 5026.2711906773675, 5322.760475778599, 5325.467453254682, 5351.866203344908, 21053.157873685035, 21418.785812141836, 21517.246896358552, 21933.670994935088, 21949.122035118577, 1987.3640435060786, 1991.551900822318, 2019.4345583236718, 2161.373201771484, 2403.411164264749, 12492.687682807911, 13315.733685326239, 13588.864111358858, 14056.226907520082, 14138.717225655531, 1718.407149533409, 1749.623830876355, 1796.4161647464625, 1806.7831860176864, 1814.600787826676, 64937.0, 68539.65730171416, 68563.65718171377, 68663.0, 68956.6552167236, 9528.666496672584, 9584.137427631547, 9644.421334719798, 9792.706218813304, 9932.205423566098, 13660.385282662304, 13751.106178098391, 13776.586702398945, 13816.516421925386, 13817.309134543233, 7211.531250468703, 7269.418446524265, 7361.484696071224, 7379.262073792578, 7403.66683499233, 6950.895736563955, 6979.197392299849, 7013.26360732126, 7076.22161562238, 7095.9645201773665, 6199.690015499207, 6279.152314437492, 6334.384731893338, 6391.58454700443, 6405.839854003594, 1585.69871724372, 1695.533728224748, 1722.750201220816, 1737.1922056243907, 1774.8491378232736, 757.8257000889716, 839.2824135364298, 909.3225546967551, 933.7012156109979, 978.4618459847055, 17636.382726604763, 18504.259829606664, 18627.81372186288, 18711.812881871007, 19006.0, 818.1899919080067, 896.5024411451576, 901.8016036471965, 924.7872989212519, 931.3713243560569, 7658.349040331635, 10249.0, 10444.529996150191, 10497.0, 10506.684799456028, 293590.0, 297071.0, 297677.0, 400493.0, 430926.0, 80592.0, 84862.0, 86233.0, 86663.56668216745, 88272.0, 920.40173886974, 925.8935222449504, 953.2135987810223, 960.0255740423476, 965.1940629574244, 15455.459058933333, 15830.28763705613, 15956.686280489495, 16107.677846442772, 16502.504924852274, 27794.41739468416, 37700.24599507939, 38706.22587548177, 39538.209235814546, 40052.599474004885, 53417.46582534125, 54364.184537232766, 54445.45554544404, 54464.45535544594, 55170.44829551653, 7572.242775722604, 7702.768916932501, 7807.804804879924, 8016.959915200387, 8055.879161812461, 10579.682609521727, 11035.448227588427, 12024.75950481003, 12298.0, 12504.374781261082, 5457.154141108134, 6478.838029049311, 9935.65225217114, 10235.7441063974, 10746.140308775435, 5460.655418462162, 10616.416097114732, 10743.785124297627, 10806.35161890289, 10920.56317747313, 5716.857078573069, 9620.422774633544, 10141.898581014391, 10625.415602141957, 10902.400367979837, 7524.736634217776, 7575.6969721210535, 7740.8451830964195, 7896.052473703192, 8021.478603890729, 5357.973210133924, 7833.412494063082, 9985.650502232387, 10431.947840261053, 10472.895271047191], "value": 8361.473976481411, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1214.9817752733704, 1369.5685858954428, 1409.3446547355477, 1482.822061352637, 1679.2443400469792, 6553.836154096144, 7009.684564194611, 7300.525465844717, 7557.05536807899, 7568.9621551892305, 7633.27483889031, 7634.9618251908805, 7696.191899850519, 7698.692052317901, 7706.653200605972, 2130.957380852382, 2152.666336717811, 2157.6763485477145, 2161.275972549198, 2161.9891900540556, 2143.07847625521, 2185.8579192352527, 2186.671999200125, 2186.9562608747815, 2187.387531491177, 2128.4253251622054, 2133.5946170227685, 2136.839737019722, 2138.919845478031, 2225.532638145983, 2174.043420894809, 2179.9128034878586, 2180.5093853882986, 2183.814375778061, 2184.159098746978, 2104.074207348777, 2133.893305334727, 2135.6262654035636, 2135.9572808543744, 2139.7967193116783, 7585.1656317805, 7700.422468314899, 7713.074431068251, 7730.420218483636, 7730.574818384986, 4470.061287129706, 4650.465196502411, 4652.534746525354, 4652.62778977681, 4659.951510910052, 2666.0, 2734.753872151496, 2788.776897848167, 2792.902248421316, 2795.7623601993855, 879.6921077622845, 887.3522328700085, 888.7911340834899, 896.1218006353745, 896.6278994217392, 10182.796344073151, 10291.639792607297, 10303.896961030368, 10311.639092631722, 10415.323004004715, 3825.9808700956874, 3943.1127996200626, 3992.920141597152, 4002.939955900664, 4006.559278479365, 8302.958485207657, 8323.375746818892, 8347.248747612744, 8347.95826020866, 8359.414840961195, 4433.623142032899, 4467.709598876063, 4483.618892394118, 4483.820647174141, 4492.9101417972115, 3595.442706380515, 3963.900902477461, 3989.4614227078973, 4031.858884939013, 4167.374893765898, 3515.2793677296095, 3621.311950729353, 3680.8159592020293, 3692.649198326155, 3693.9445908311395, 1130.6721050895312, 1134.8638163420442, 1135.9545618175346, 1144.9771004579861, 1147.4951021550492, 677.1332694151494, 725.2312548698396, 758.6510205305511, 798.8482188384188, 857.3955361470148, 4909.0, 4928.211486162197, 5097.337346144977, 5324.1747529133045, 5390.0, 405.3676265026509, 405.58022446767455, 406.9450624165759, 407.1978202940203, 411.51441299266554, 3486.2853115111343, 3495.1611613212644, 3528.8059156746112, 3542.5217595624263, 3590.2281009583066, 9093.4998575079, 9363.719088427359, 9393.765155871159, 9483.905160948303, 9498.810023799624, 9372.5313734313, 9383.24934005278, 9395.06049395055, 9400.764980875396, 9402.811943761086, 7079.681414336367, 7133.678984445713, 7250.238724933912, 7310.74412395553, 7321.194668586451, 4928.605711542997, 4944.876378090433, 4961.50384961501, 5062.898742025212, 5158.587313015025, 8640.524771137647, 8668.219860212359, 8826.867596985921, 8865.113488651083, 8869.11308869108, 8780.604872780612, 8960.372773905765, 9011.234045105977, 9040.502772347583, 9106.043865394304, 5940.435658612425, 6494.740210391531, 6623.138991931018, 6675.399214070757, 6709.798706038827, 7429.5542267464125, 7449.143348514774, 7493.213212612597, 7514.774556763306, 7539.773806785586, 6585.934140658532, 6679.432248258952, 6709.429698475684, 6793.116894803841, 6938.0, 6738.124043874265, 6782.321767823179, 6800.149981252343, 6859.17689877198, 6948.513604047668, 6069.666168360783, 6099.329073801967, 6128.754849805958, 6136.23297087864, 6139.447449729546, 4527.2303708369, 4557.430321209848, 4560.545951407867, 4624.9768751156025, 4684.110019096361, 4436.82252709888, 4680.274557443602, 4684.531546845425, 4718.905621887612, 4737.952620473751], "value": 3961.015414063945, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [276.7523066855163, 283.53217191633803, 285.4301342615614, 285.8427864674429, 286.95116865579763, 4550.749708766025, 4671.649626278026, 4698.3657206277185, 4705.717656940577, 4758.286257061438, 4501.842435514757, 4594.402727645402, 4678.953210467895, 4679.391679081723, 4686.343911852344, 3660.5723767730606, 3682.558093028827, 3687.59436461989, 3689.8339574719066, 3693.7968411737343, 3509.2630547585036, 3527.8588856445713, 3691.305347096621, 3707.2956138333766, 3713.9071523211865, 3601.0, 3606.71146308296, 3608.260306637133, 3616.2948225096115, 3626.38351480249, 3594.622564630702, 3599.0102721751728, 3609.7473176877365, 3619.475176099464, 3619.9276014479565, 3150.810951342904, 3175.3966746318124, 3176.142441540794, 3177.396294703999, 3180.634227063871, 4364.825406983717, 4592.563706447882, 4612.846788302924, 4614.169449499089, 4616.746078965655, 4128.8348466061325, 4148.23257697327, 4148.543660197376, 4159.313713237312, 4174.895627609304, 4937.481564435719, 4943.134951383529, 4957.702537847741, 4959.132151873408, 4963.783872951114, 3308.9503657445157, 3419.7093247074026, 3463.5843698756057, 3476.200473890994, 3493.737969652286, 5116.155834287338, 5139.563137133348, 5157.974210128926, 5164.535191832715, 5197.688138711652, 3471.9479207811396, 3483.3555792178527, 3483.54713887193, 3523.700485458765, 3545.166885781839, 3453.4474484082425, 3537.25717599307, 3538.0093573799377, 3539.43369060949, 3564.215872508044, 4057.229126465962, 4063.959360406358, 4069.5116586009276, 4070.6946978976694, 4099.241640296555, 4868.099401610642, 4906.215005599087, 4909.386326709161, 4935.259711043373, 4943.258511223274, 1163.6450882480756, 1185.057878986208, 1218.3725381428571, 1220.5292622389998, 1227.4415141110774, 762.8321769210764, 779.2091027606983, 790.3203245209115, 796.3629096722715, 802.5345299726145, 3953.8418463261146, 3990.6408423242046, 4000.7799571023293, 4009.9599004009588, 4015.3374693175883, 4498.190325741398, 4531.614812740888, 4535.092981403733, 4535.501094879561, 4559.452865656142, 3977.6022397759994, 3978.204359128128, 3984.960150398517, 3985.3822657488136, 4008.016032064147, 2326.8016971259813, 2426.502566973766, 2439.9508211469238, 2457.8771061446855, 2462.581361168606, 4250.319948808237, 4289.699721019561, 4313.633341166036, 4339.262325404688, 4373.2565463871215, 4610.4697959734385, 4617.353570500132, 4628.236341003764, 4628.333799832058, 4641.350210970467, 4131.35963925592, 4342.804573794187, 4347.260965635849, 4348.195583817004, 4351.956480435155, 4503.482099558592, 4523.592876641118, 4540.750258735669, 4595.862124136282, 4600.401947746772, 4377.912441751211, 4388.890277742954, 4416.470023597189, 4417.469903611587, 4419.977900110607, 4235.174141042467, 4289.935650965301, 4332.6317263033, 4341.65550602671, 4505.752183629801, 3615.5480564929385, 3634.382155033598, 3635.909102272464, 3636.563612366427, 3637.745357825033, 4938.0, 5062.341895553702, 5113.846584602468, 5138.743062846917, 5165.354330708661, 4884.340614017205, 4979.576735977483, 4987.850364489072, 4988.152014157675, 5028.899422011466, 4946.713854397811, 4958.404991401055, 4963.255511673134, 4965.82619608312, 5004.649674522749, 4727.456342520517, 4851.56335929768, 4931.852044438672, 4939.901201975868, 4941.357623508921, 5012.172991456368, 5025.65793747154, 5025.7989680412375, 5053.2420136979745, 5054.545090941833, 4930.8767280818265, 4931.3589233399425, 4933.4819843915875, 4935.840077581694, 4958.305837182869], "value": 3589.185523898488, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [664.3887623386483, 712.301944094787, 715.7602203261907, 722.8048426924734, 742.9814254643635, 11781.528738850446, 11853.0, 11886.940565297162, 11899.58351457699, 13153.868461315384, 13010.804837927439, 13178.60464186076, 13200.141990770593, 13232.669183270424, 13237.867621323783, 624.5784095735384, 757.0725860820506, 764.9808754781134, 775.9185285545021, 782.5930516131608, 774.0904437286194, 774.9612519374037, 775.3138472451865, 777.7433446962517, 777.9260970207849, 830.4062595244399, 831.4595512916623, 832.367400775412, 832.9625166867505, 833.125218520551, 649.8245473722092, 671.7245929169018, 673.9056532085511, 675.8546912413806, 822.3873214455239, 590.7814108779736, 604.6916072802858, 609.2567068176817, 613.3988691082719, 613.7790395457631, 13114.540991065267, 13116.540921067717, 13140.0, 13148.0, 13195.2742599157, 12343.876561234452, 12853.0, 12976.416061277265, 13032.80450793239, 13085.149465284727, 11436.942815285953, 11501.942490287578, 11650.0, 11706.473208705544, 11872.52509899603, 4137.627613514768, 4184.079502509443, 4223.429836972, 4249.4475718156755, 4332.566743325642, 56992.71503642455, 58265.70867145637, 60185.79628407451, 60279.397206028254, 60463.0, 10070.949645251727, 10117.342372745748, 10121.949390253001, 10190.337628054152, 10196.694099177037, 18914.81085189158, 18936.81063189378, 18979.145938432805, 19005.429837104908, 19081.61836763257, 6583.188878016806, 6608.603483790988, 6703.0, 6826.658667066726, 6838.48711346651, 3679.9448008279896, 3713.2202237530423, 3767.868124615625, 3770.377887648562, 3818.045488627843, 2719.687235967889, 2807.228012296635, 2820.407714380003, 2821.971780282212, 2829.080548821641, 458.5483298950531, 473.0232070773841, 473.16958737415615, 474.42831388177166, 476.345025589814, 426.81220263084765, 426.84633531928483, 458.9885252868705, 505.48188107190424, 528.9685114027661, 7143.4999550031, 7223.313785190398, 7519.345743936326, 7621.771346859603, 7860.921390786133, 459.4922610515399, 481.40546425164894, 516.5118962580326, 550.5265471694339, 555.3141869790805, 3603.4414665726854, 3604.7765525535306, 3641.1625326175126, 3727.8881633551036, 3766.3408903441787, 88451.55774221088, 89222.55388723145, 90197.54901225583, 91485.54257228671, 92468.0, 76674.0, 77832.22167778363, 78960.0, 79011.0, 80765.59617201876, 71281.64359178275, 72003.6399818008, 72474.2752572478, 72566.63716681488, 73183.63408182925, 7011.6494175292055, 7046.260142684944, 7151.356377925804, 7249.601271930094, 7428.925710743039, 42132.368014480424, 42775.0, 42851.71520841402, 43733.0, 44076.33885491784, 55544.44455555393, 58540.70729646495, 58774.70612646909, 58797.70601146967, 59155.112673310796, 9261.814763704822, 9495.43027418357, 9846.261530385107, 9939.850902236616, 9970.700878973643, 12452.31512266834, 12791.680207994874, 13481.932590336986, 13547.661308467366, 14066.78899816524, 7623.504472209289, 8725.197743500501, 11832.290062596272, 11985.400729963641, 11997.100217483898, 11811.409429528661, 11843.763124737285, 12037.157398981988, 12226.87773122293, 12336.074794390635, 11990.280583165038, 12033.63899083029, 12766.489340426651, 12787.936060319638, 12790.488380464678, 9970.900290996997, 10211.693649190536, 10360.114649555402, 10395.844062339222, 10424.42665653366, 9578.952105239428, 9948.850767238642, 10453.372797632166, 10538.420386878795, 10649.361038337725], "value": 6381.465604434019, "unit": "score"}], "name": "dromaeo_css", "value": 6261.15061143423, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 110.0, 113.0, 115.0, 113.0, 114.0, 113.0, 114.0, 113.0, 113.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 134.0, 131.0, 194.0, 131.0, 133.0, 155.0, 130.0, 199.0, 130.0], "value": 149.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 161.0, 162.0, 162.0, 162.0, 161.0, 159.0, 160.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 78.0, 76.0, 129.0, 76.0, 77.0, 76.0, 75.0, 101.0, 75.0], "value": 84.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 114.0, 86.0, 87.0, 87.0, 119.0, 86.0, 87.0, 134.0], "value": 97.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 119.0, 118.0, 117.0, 116.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 64.0, 63.0, 64.0], "value": 63.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 64.0, 66.0, 65.0, 64.0, 64.0, 65.0, 64.0], "value": 64.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 85.0, 86.0, 85.0, 84.0, 93.0, 112.0, 85.0], "value": 88.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 141.0, 133.0, 131.0, 130.0, 129.0, 131.0, 153.0, 139.0], "value": 137.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 171.0, 175.0, 168.0, 168.0, 169.0, 175.0, 176.0, 171.0, 169.0], "value": 171.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 66.0, 67.0, 67.0, 68.0, 67.0, 66.0, 66.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1558.1000000000004, "alertThreshold": 2.0}]} 04:35:10 INFO - Return code: 0 04:35:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:35:10 INFO - # TBPL SUCCESS # 04:35:10 INFO - Running post-action listener: _resource_record_post_action 04:35:10 INFO - ##### 04:35:10 INFO - ##### Finished run-tests step (success) 04:35:10 INFO - ##### 04:35:10 INFO - Running post-run listener: _resource_record_post_run 04:35:10 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 403689472; Read time: 16; Write time: 249612 04:35:10 INFO - TinderboxPrint: CPU usage
13.2% 04:35:10 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 04:35:10 INFO - TinderboxPrint: I/O write bytes / time
403,689,472 / 249,612 04:35:10 INFO - TinderboxPrint: CPU idle
8,324.3 (86.8%) 04:35:10 INFO - TinderboxPrint: CPU user
1,220.7 (12.7%) 04:35:10 INFO - TinderboxPrint: Swap in / out
0 / 0 04:35:10 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 105181184; Read time: 0; Write time: 61064 04:35:10 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 298508288; Read time: 16; Write time: 188548 04:35:10 INFO - Running post-run listener: _upload_blobber_files 04:35:10 INFO - Blob upload gear active. 04:35:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:35:10 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 04:35:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:35:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:35:11 INFO - (blobuploader) - INFO - Open directory for files ... 04:35:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:35:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:35:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:35:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:35:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:35:14 INFO - (blobuploader) - INFO - Done attempting. 04:35:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:35:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:35:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:35:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:35:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:35:15 INFO - (blobuploader) - INFO - Done attempting. 04:35:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:35:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:35:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:35:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:35:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:35:16 INFO - (blobuploader) - INFO - Done attempting. 04:35:16 INFO - (blobuploader) - INFO - Iteration through files over. 04:35:16 INFO - Return code: 0 04:35:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:35:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:35:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e0ccf1519c3e9fb67182ff7ee55c4abc6df27b2d7210d821007e69b36bd98fa12f9be54bed0c0a035c35692759c10d0238fa9b23c16f9f8b53f0e4c2ded73b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b0d29733b089982e3fb45ee02d57aee8c654e231328c8a8c9bb2a0a7d68001e5e98853ff4a48a19b3ab9e7294cde606d1bb07bcba9309c7a517e6ffb3a72af4a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/593418a19b4987f1e1c10131fe8f51cd531ac0dec9aa36f2de286fcb49c072edf6b15ad6453ef422d29736e7b51a5fe888215adb8af8f39b6ff736918d6f8007"} 04:35:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:35:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:35:16 INFO - Contents: 04:35:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e0ccf1519c3e9fb67182ff7ee55c4abc6df27b2d7210d821007e69b36bd98fa12f9be54bed0c0a035c35692759c10d0238fa9b23c16f9f8b53f0e4c2ded73b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b0d29733b089982e3fb45ee02d57aee8c654e231328c8a8c9bb2a0a7d68001e5e98853ff4a48a19b3ab9e7294cde606d1bb07bcba9309c7a517e6ffb3a72af4a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/593418a19b4987f1e1c10131fe8f51cd531ac0dec9aa36f2de286fcb49c072edf6b15ad6453ef422d29736e7b51a5fe888215adb8af8f39b6ff736918d6f8007"} 04:35:16 INFO - Running post-run listener: copy_logs_to_upload_dir 04:35:16 INFO - Copying logs to upload dir... 04:35:16 INFO - mkdir: /builds/slave/test/build/upload/logs 04:35:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.316437 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-21 04:35:15.890691) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 04:35:15.893890) ========= 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=03627c79f6bb3d1578c4a402000001ba-1466507667.694690-364733738 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e0ccf1519c3e9fb67182ff7ee55c4abc6df27b2d7210d821007e69b36bd98fa12f9be54bed0c0a035c35692759c10d0238fa9b23c16f9f8b53f0e4c2ded73b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b0d29733b089982e3fb45ee02d57aee8c654e231328c8a8c9bb2a0a7d68001e5e98853ff4a48a19b3ab9e7294cde606d1bb07bcba9309c7a517e6ffb3a72af4a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/593418a19b4987f1e1c10131fe8f51cd531ac0dec9aa36f2de286fcb49c072edf6b15ad6453ef422d29736e7b51a5fe888215adb8af8f39b6ff736918d6f8007"} build_url:https://queue.taskcluster.net/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011252 build_url: 'https://queue.taskcluster.net/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/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-Non-PGO/sha512/2e0ccf1519c3e9fb67182ff7ee55c4abc6df27b2d7210d821007e69b36bd98fa12f9be54bed0c0a035c35692759c10d0238fa9b23c16f9f8b53f0e4c2ded73b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b0d29733b089982e3fb45ee02d57aee8c654e231328c8a8c9bb2a0a7d68001e5e98853ff4a48a19b3ab9e7294cde606d1bb07bcba9309c7a517e6ffb3a72af4a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/593418a19b4987f1e1c10131fe8f51cd531ac0dec9aa36f2de286fcb49c072edf6b15ad6453ef422d29736e7b51a5fe888215adb8af8f39b6ff736918d6f8007"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 04:35:15.919155) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 04:35:15.919470) ========= 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=03627c79f6bb3d1578c4a402000001ba-1466507667.694690-364733738 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004527 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 04:35:16.006538) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 04:35:16.006863) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 04:35:16.007169) ========= ========= Total master_lag: 0.18 =========