builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-004 starttime: 1465982404.54 results: success (0) buildid: 20160614233002 builduid: f966cac64b504c2bb72a20c5b103e2fc revision: da53037ac8087280b90ee94a55f116a24e5e9730 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-15 02:20:04.538220) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-15 02:20:04.538732) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-15 02:20:04.539011) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-15 02:20:04.574363) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 02:20:04.574710) ========= 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=c6927cf182745ad25b1d38b9000001fe-1465974564.938806-1672166689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-15 02:20:06-- 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% 71.2M=0s 2016-06-15 02:20:06 (71.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122207 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 02:20:04.722957) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 02:20:04.723399) ========= 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=c6927cf182745ad25b1d38b9000001fe-1465974564.938806-1672166689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021993 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 02:20:04.778761) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-15 02:20:04.779109) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev da53037ac8087280b90ee94a55f116a24e5e9730 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev da53037ac8087280b90ee94a55f116a24e5e9730 --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=c6927cf182745ad25b1d38b9000001fe-1465974564.938806-1672166689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-15 02:20:06,388 truncating revision to first 12 chars 2016-06-15 02:20:06,388 Setting DEBUG logging. 2016-06-15 02:20:06,388 attempt 1/10 2016-06-15 02:20:06,388 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/da53037ac808?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-15 02:20:07,579 unpacking tar archive at: fx-team-da53037ac808/testing/mozharness/ program finished with exit code 0 elapsedTime=1.526521 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-15 02:20:06.319466) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-15 02:20:06.319785) ========= script_repo_revision: da53037ac8087280b90ee94a55f116a24e5e9730 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-15 02:20:06.320193) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-15 02:20:06.320487) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-15 02:20:06.334488) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-06-15 02:20:06.334822) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1465974564.938806-1672166689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:20:08 INFO - MultiFileLogger online at 20160615 02:20:08 in /builds/slave/test 02:20:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:20:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:20:08 INFO - {'append_to_log': False, 02:20:08 INFO - 'base_work_dir': '/builds/slave/test', 02:20:08 INFO - 'blob_upload_branch': 'Fx-Team', 02:20:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:20:08 INFO - 'branch': 'Fx-Team', 02:20:08 INFO - 'buildbot_json_path': 'buildprops.json', 02:20:08 INFO - 'config_files': ('talos/linux_config.py',), 02:20:08 INFO - 'default_actions': ('clobber', 02:20:08 INFO - 'read-buildbot-config', 02:20:08 INFO - 'download-and-extract', 02:20:08 INFO - 'populate-webroot', 02:20:08 INFO - 'create-virtualenv', 02:20:08 INFO - 'install', 02:20:08 INFO - 'run-tests'), 02:20:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:20:08 INFO - 'download_minidump_stackwalk': True, 02:20:08 INFO - 'download_symbols': 'ondemand', 02:20:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:20:08 INFO - 'tooltool.py': '/tools/tooltool.py', 02:20:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:20:08 INFO - '/tools/misc-python/virtualenv.py')}, 02:20:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:20:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:20:08 INFO - 'installer_path': 'installer.exe', 02:20:08 INFO - 'log_level': 'info', 02:20:08 INFO - 'log_name': 'talos', 02:20:08 INFO - 'log_to_console': True, 02:20:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:20:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:20:08 INFO - 'opt_config_files': (), 02:20:08 INFO - 'pip_index': False, 02:20:08 INFO - 'sps_profile': False, 02:20:08 INFO - 'sps_profile_interval': 0, 02:20:08 INFO - 'suite': 'dromaeojs-e10s', 02:20:08 INFO - 'system_bits': '32', 02:20:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:20:08 INFO - 'title': 'talos-linux64-ix-004', 02:20:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:20:08 INFO - 'use_talos_json': True, 02:20:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:20:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:20:08 INFO - 'work_dir': 'build'} 02:20:08 INFO - ##### 02:20:08 INFO - ##### Running clobber step. 02:20:08 INFO - ##### 02:20:08 INFO - Running pre-action listener: _resource_record_pre_action 02:20:08 INFO - Running main action method: clobber 02:20:08 INFO - rmtree: /builds/slave/test/build 02:20:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:20:08 INFO - Running post-action listener: _resource_record_post_action 02:20:08 INFO - ##### 02:20:08 INFO - ##### Finished clobber step (success) 02:20:08 INFO - ##### 02:20:08 INFO - ##### 02:20:08 INFO - ##### Running read-buildbot-config step. 02:20:08 INFO - ##### 02:20:08 INFO - Running pre-action listener: _resource_record_pre_action 02:20:08 INFO - Running main action method: read_buildbot_config 02:20:08 INFO - Using buildbot properties: 02:20:08 INFO - { 02:20:08 INFO - "project": "", 02:20:08 INFO - "product": "firefox", 02:20:08 INFO - "script_repo_revision": "production", 02:20:08 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 02:20:08 INFO - "repository": "", 02:20:08 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 02:20:08 INFO - "buildid": "20160614233002", 02:20:08 INFO - "pgo_build": "True", 02:20:08 INFO - "basedir": "/builds/slave/test", 02:20:08 INFO - "buildnumber": 558, 02:20:08 INFO - "slavename": "talos-linux64-ix-004", 02:20:08 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:20:08 INFO - "platform": "ubuntu64_hw", 02:20:08 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:20:08 INFO - "branch": "fx-team", 02:20:08 INFO - "repo_path": "integration/fx-team", 02:20:08 INFO - "revision": "da53037ac8087280b90ee94a55f116a24e5e9730", 02:20:08 INFO - "stage_platform": "linux64-pgo", 02:20:08 INFO - "builduid": "f966cac64b504c2bb72a20c5b103e2fc", 02:20:08 INFO - "slavebuilddir": "test" 02:20:08 INFO - } 02:20:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/BqmXjc4-T8a-gPRYbhKsXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:20:08 INFO - Running post-action listener: _resource_record_post_action 02:20:08 INFO - ##### 02:20:08 INFO - ##### Finished read-buildbot-config step (success) 02:20:08 INFO - ##### 02:20:08 INFO - ##### 02:20:08 INFO - ##### Running download-and-extract step. 02:20:08 INFO - ##### 02:20:08 INFO - Running pre-action listener: _resource_record_pre_action 02:20:08 INFO - Running main action method: download_and_extract 02:20:08 INFO - mkdir: /builds/slave/test/build/tests 02:20:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:08 INFO - https://queue.taskcluster.net/v1/task/BqmXjc4-T8a-gPRYbhKsXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:20:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BqmXjc4-T8a-gPRYbhKsXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:20:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BqmXjc4-T8a-gPRYbhKsXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:20:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BqmXjc4-T8a-gPRYbhKsXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:20:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BqmXjc4-T8a-gPRYbhKsXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:20:10 INFO - Downloaded 1361 bytes. 02:20:10 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:20:10 INFO - Using the following test package requirements: 02:20:10 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:20:10 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:20:10 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:20:10 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:10 INFO - u'jsshell-linux-x86_64.zip'], 02:20:10 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:20:10 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:20:10 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:20:10 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:20:10 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:20:10 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:20:10 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:20:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:10 INFO - https://queue.taskcluster.net/v1/task/BqmXjc4-T8a-gPRYbhKsXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:20:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BqmXjc4-T8a-gPRYbhKsXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:20:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BqmXjc4-T8a-gPRYbhKsXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:20:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BqmXjc4-T8a-gPRYbhKsXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:20:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BqmXjc4-T8a-gPRYbhKsXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:20:11 INFO - Downloaded 24221107 bytes. 02:20:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:20:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:20:13 INFO - Return code: 0 02:20:13 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:20:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:13 INFO - https://queue.taskcluster.net/v1/task/BqmXjc4-T8a-gPRYbhKsXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:20:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BqmXjc4-T8a-gPRYbhKsXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:20:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BqmXjc4-T8a-gPRYbhKsXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:20:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BqmXjc4-T8a-gPRYbhKsXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:20:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BqmXjc4-T8a-gPRYbhKsXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:20:14 INFO - Downloaded 24221107 bytes. 02:20:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:20:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:20:15 INFO - Return code: 0 02:20:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:15 INFO - https://queue.taskcluster.net/v1/task/BqmXjc4-T8a-gPRYbhKsXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:20:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BqmXjc4-T8a-gPRYbhKsXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:20:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BqmXjc4-T8a-gPRYbhKsXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:20:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BqmXjc4-T8a-gPRYbhKsXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:20:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BqmXjc4-T8a-gPRYbhKsXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:20:18 INFO - Downloaded 14405384 bytes. 02:20:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:20:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:20:18 INFO - Return code: 0 02:20:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:18 INFO - https://queue.taskcluster.net/v1/task/BqmXjc4-T8a-gPRYbhKsXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:20:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BqmXjc4-T8a-gPRYbhKsXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:20:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BqmXjc4-T8a-gPRYbhKsXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:20:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BqmXjc4-T8a-gPRYbhKsXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:20:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BqmXjc4-T8a-gPRYbhKsXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:20:19 INFO - Downloaded 59391515 bytes. 02:20:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BqmXjc4-T8a-gPRYbhKsXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:20:19 INFO - mkdir: /builds/slave/test/properties 02:20:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:20:19 INFO - Writing to file /builds/slave/test/properties/build_url 02:20:19 INFO - Contents: 02:20:19 INFO - build_url:https://queue.taskcluster.net/v1/task/BqmXjc4-T8a-gPRYbhKsXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:20:20 INFO - Running post-action listener: _resource_record_post_action 02:20:20 INFO - Running post-action listener: set_extra_try_arguments 02:20:20 INFO - ##### 02:20:20 INFO - ##### Finished download-and-extract step (success) 02:20:20 INFO - ##### 02:20:20 INFO - ##### 02:20:20 INFO - ##### Running populate-webroot step. 02:20:20 INFO - ##### 02:20:20 INFO - Running pre-action listener: _resource_record_pre_action 02:20:20 INFO - Running main action method: populate_webroot 02:20:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:20:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:20:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:20:20 INFO - '--tppagecycles', 02:20:20 INFO - '7'], 02:20:20 INFO - 'tests': ['tsvgm']}}, 02:20:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:20:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:20:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:20:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:20:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:20:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:20:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:20 INFO - 'talos_options': ['--disable-e10s'], 02:20:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:20:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:20:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:20 INFO - 'talos_options': ['--disable-e10s'], 02:20:20 INFO - 'tests': ['damp', 'tps']}, 02:20:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:20 INFO - 'tests': ['damp', 'tps']}, 02:20:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:20:20 INFO - 'tests': ['dromaeo_dom']}, 02:20:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:20:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:20:20 INFO - 'tests': ['basic_compositor_video']}, 02:20:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:20:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:20:20 INFO - 'tests': ['a11yr', 02:20:20 INFO - 'ts_paint', 02:20:20 INFO - 'tpaint', 02:20:20 INFO - 'sessionrestore', 02:20:20 INFO - 'sessionrestore_no_auto_restore', 02:20:20 INFO - 'tabpaint']}, 02:20:20 INFO - 'other-e10s': {'tests': ['a11yr', 02:20:20 INFO - 'ts_paint', 02:20:20 INFO - 'tpaint', 02:20:20 INFO - 'sessionrestore', 02:20:20 INFO - 'sessionrestore_no_auto_restore', 02:20:20 INFO - 'tabpaint']}, 02:20:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:20:20 INFO - 'ts_paint', 02:20:20 INFO - 'tpaint', 02:20:20 INFO - 'sessionrestore', 02:20:20 INFO - 'sessionrestore_no_auto_restore', 02:20:20 INFO - 'tabpaint']}, 02:20:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:20:20 INFO - 'ts_paint', 02:20:20 INFO - 'tpaint', 02:20:20 INFO - 'sessionrestore', 02:20:20 INFO - 'sessionrestore_no_auto_restore', 02:20:20 INFO - 'tabpaint']}, 02:20:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:20:20 INFO - 'tests': ['a11yr', 02:20:20 INFO - 'ts_paint', 02:20:20 INFO - 'tpaint', 02:20:20 INFO - 'sessionrestore', 02:20:20 INFO - 'sessionrestore_no_auto_restore', 02:20:20 INFO - 'tabpaint']}, 02:20:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:20:20 INFO - 'tests': ['a11yr', 02:20:20 INFO - 'ts_paint', 02:20:20 INFO - 'tpaint', 02:20:20 INFO - 'sessionrestore', 02:20:20 INFO - 'sessionrestore_no_auto_restore', 02:20:20 INFO - 'tabpaint']}, 02:20:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:20:20 INFO - 'tests': ['tsvgx', 02:20:20 INFO - 'tsvgr_opacity', 02:20:20 INFO - 'tart', 02:20:20 INFO - 'tscrollx', 02:20:20 INFO - 'cart']}, 02:20:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:20:20 INFO - 'tsvgr_opacity', 02:20:20 INFO - 'tart', 02:20:20 INFO - 'tscrollx', 02:20:20 INFO - 'cart']}, 02:20:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:20 INFO - 'talos_options': ['--disable-e10s'], 02:20:20 INFO - 'tests': ['tp5o']}, 02:20:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:20 INFO - 'tests': ['tp5o']}, 02:20:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:20 INFO - 'talos_options': ['--disable-e10s', 02:20:20 INFO - '--xperf_path', 02:20:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:20:20 INFO - 'tests': ['tp5n']}, 02:20:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:20 INFO - 'talos_options': ['--xperf_path', 02:20:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:20:20 INFO - 'tests': ['tp5n']}}, 02:20:20 INFO - 'talos.zip': {'path': '', 02:20:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:20:20 INFO - Running post-action listener: _resource_record_post_action 02:20:20 INFO - ##### 02:20:20 INFO - ##### Finished populate-webroot step (success) 02:20:20 INFO - ##### 02:20:20 INFO - ##### 02:20:20 INFO - ##### Running create-virtualenv step. 02:20:20 INFO - ##### 02:20:20 INFO - Running pre-action listener: _resource_record_pre_action 02:20:20 INFO - Running main action method: create_virtualenv 02:20:20 INFO - Creating virtualenv /builds/slave/test/build/venv 02:20:20 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:20:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:20:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:20:20 INFO - Using real prefix '/usr' 02:20:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:20:21 INFO - Installing distribute.............................................................................................................................................................................................done. 02:20:23 INFO - Installing pip.................done. 02:20:23 INFO - Return code: 0 02:20:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:20:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:23 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 0x7fc13005ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1385350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14141c0>, '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 0x14150c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1415550>, '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': 'c6927cf182745ad25b1d38b9000001fe-1465974564.938806-1672166689', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:20:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:20:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:20:23 INFO - Using env: {'DISPLAY': ':0', 02:20:23 INFO - 'HOME': '/home/cltbld', 02:20:23 INFO - 'LANG': 'en_US.UTF-8', 02:20:23 INFO - 'LANGUAGE': 'en_US:en', 02:20:23 INFO - 'LOGNAME': 'cltbld', 02:20:23 INFO - 'MAIL': '/var/mail/cltbld', 02:20:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:23 INFO - 'MOZ_NO_REMOTE': '1', 02:20:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:23 INFO - 'NO_EM_RESTART': '1', 02:20:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:23 INFO - 'PWD': '/builds/slave/test', 02:20:23 INFO - 'SHELL': '/bin/bash', 02:20:23 INFO - 'SHLVL': '1', 02:20:23 INFO - 'TERM': 'linux', 02:20:23 INFO - 'TMOUT': '86400', 02:20:23 INFO - 'USER': 'cltbld', 02:20:23 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465974564.938806-1672166689', 02:20:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:23 INFO - '_': '/tools/buildbot/bin/python'} 02:20:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:23 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:20:23 INFO - Cleaning up... 02:20:23 INFO - Return code: 0 02:20:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:20:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:23 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 0x7fc13005ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1385350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14141c0>, '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 0x14150c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1415550>, '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': 'c6927cf182745ad25b1d38b9000001fe-1465974564.938806-1672166689', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:20:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:20:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:20:23 INFO - Using env: {'DISPLAY': ':0', 02:20:23 INFO - 'HOME': '/home/cltbld', 02:20:23 INFO - 'LANG': 'en_US.UTF-8', 02:20:23 INFO - 'LANGUAGE': 'en_US:en', 02:20:23 INFO - 'LOGNAME': 'cltbld', 02:20:23 INFO - 'MAIL': '/var/mail/cltbld', 02:20:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:23 INFO - 'MOZ_NO_REMOTE': '1', 02:20:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:23 INFO - 'NO_EM_RESTART': '1', 02:20:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:23 INFO - 'PWD': '/builds/slave/test', 02:20:23 INFO - 'SHELL': '/bin/bash', 02:20:23 INFO - 'SHLVL': '1', 02:20:23 INFO - 'TERM': 'linux', 02:20:23 INFO - 'TMOUT': '86400', 02:20:23 INFO - 'USER': 'cltbld', 02:20:23 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465974564.938806-1672166689', 02:20:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:23 INFO - '_': '/tools/buildbot/bin/python'} 02:20:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:23 INFO - Downloading/unpacking psutil>=3.1.1 02:20:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:20:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:20:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:20:25 INFO - Installing collected packages: psutil 02:20:25 INFO - Running setup.py install for psutil 02:20:25 INFO - building 'psutil._psutil_linux' extension 02:20:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:20:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:20:25 INFO - building 'psutil._psutil_posix' extension 02:20:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:20:26 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:20:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:20:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:20:26 INFO - Successfully installed psutil 02:20:26 INFO - Cleaning up... 02:20:26 INFO - Return code: 0 02:20:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:20:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:26 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 0x7fc13005ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1385350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14141c0>, '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 0x14150c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1415550>, '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': 'c6927cf182745ad25b1d38b9000001fe-1465974564.938806-1672166689', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:20:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:20:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:20:26 INFO - Using env: {'DISPLAY': ':0', 02:20:26 INFO - 'HOME': '/home/cltbld', 02:20:26 INFO - 'LANG': 'en_US.UTF-8', 02:20:26 INFO - 'LANGUAGE': 'en_US:en', 02:20:26 INFO - 'LOGNAME': 'cltbld', 02:20:26 INFO - 'MAIL': '/var/mail/cltbld', 02:20:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:26 INFO - 'MOZ_NO_REMOTE': '1', 02:20:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:26 INFO - 'NO_EM_RESTART': '1', 02:20:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:26 INFO - 'PWD': '/builds/slave/test', 02:20:26 INFO - 'SHELL': '/bin/bash', 02:20:26 INFO - 'SHLVL': '1', 02:20:26 INFO - 'TERM': 'linux', 02:20:26 INFO - 'TMOUT': '86400', 02:20:26 INFO - 'USER': 'cltbld', 02:20:26 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465974564.938806-1672166689', 02:20:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:26 INFO - '_': '/tools/buildbot/bin/python'} 02:20:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:20:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:20:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:20:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:20:28 INFO - Installing collected packages: mozsystemmonitor 02:20:28 INFO - Running setup.py install for mozsystemmonitor 02:20:28 INFO - Successfully installed mozsystemmonitor 02:20:28 INFO - Cleaning up... 02:20:28 INFO - Return code: 0 02:20:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:20:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc13005ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1385350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14141c0>, '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 0x14150c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1415550>, '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': 'c6927cf182745ad25b1d38b9000001fe-1465974564.938806-1672166689', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:20:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:20:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:20:28 INFO - Using env: {'DISPLAY': ':0', 02:20:28 INFO - 'HOME': '/home/cltbld', 02:20:28 INFO - 'LANG': 'en_US.UTF-8', 02:20:28 INFO - 'LANGUAGE': 'en_US:en', 02:20:28 INFO - 'LOGNAME': 'cltbld', 02:20:28 INFO - 'MAIL': '/var/mail/cltbld', 02:20:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:28 INFO - 'MOZ_NO_REMOTE': '1', 02:20:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:28 INFO - 'NO_EM_RESTART': '1', 02:20:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:28 INFO - 'PWD': '/builds/slave/test', 02:20:28 INFO - 'SHELL': '/bin/bash', 02:20:28 INFO - 'SHLVL': '1', 02:20:28 INFO - 'TERM': 'linux', 02:20:28 INFO - 'TMOUT': '86400', 02:20:28 INFO - 'USER': 'cltbld', 02:20:28 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465974564.938806-1672166689', 02:20:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:28 INFO - '_': '/tools/buildbot/bin/python'} 02:20:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:28 INFO - Downloading/unpacking jsonschema==2.5.1 02:20:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:20:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:30 INFO - Downloading functools32-3.2.3-2.tar.gz 02:20:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:20:30 INFO - warning: no files found matching '*.txt' 02:20:30 INFO - no previously-included directories found matching 'build' 02:20:30 INFO - no previously-included directories found matching 'dist' 02:20:30 INFO - no previously-included directories found matching '.git*' 02:20:30 INFO - Installing collected packages: jsonschema, functools32 02:20:30 INFO - Running setup.py install for functools32 02:20:30 INFO - warning: no files found matching '*.txt' 02:20:30 INFO - no previously-included directories found matching 'build' 02:20:30 INFO - no previously-included directories found matching 'dist' 02:20:30 INFO - no previously-included directories found matching '.git*' 02:20:30 INFO - Successfully installed jsonschema functools32 02:20:30 INFO - Cleaning up... 02:20:31 INFO - Return code: 0 02:20:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:20:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc13005ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1385350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14141c0>, '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 0x14150c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1415550>, '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': 'c6927cf182745ad25b1d38b9000001fe-1465974564.938806-1672166689', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:20:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:20:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:20:31 INFO - Using env: {'DISPLAY': ':0', 02:20:31 INFO - 'HOME': '/home/cltbld', 02:20:31 INFO - 'LANG': 'en_US.UTF-8', 02:20:31 INFO - 'LANGUAGE': 'en_US:en', 02:20:31 INFO - 'LOGNAME': 'cltbld', 02:20:31 INFO - 'MAIL': '/var/mail/cltbld', 02:20:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:31 INFO - 'MOZ_NO_REMOTE': '1', 02:20:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:31 INFO - 'NO_EM_RESTART': '1', 02:20:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:31 INFO - 'PWD': '/builds/slave/test', 02:20:31 INFO - 'SHELL': '/bin/bash', 02:20:31 INFO - 'SHLVL': '1', 02:20:31 INFO - 'TERM': 'linux', 02:20:31 INFO - 'TMOUT': '86400', 02:20:31 INFO - 'USER': 'cltbld', 02:20:31 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465974564.938806-1672166689', 02:20:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:31 INFO - '_': '/tools/buildbot/bin/python'} 02:20:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:31 INFO - Downloading/unpacking blobuploader==1.2.4 02:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:33 INFO - Downloading blobuploader-1.2.4.tar.gz 02:20:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:20:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:20:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:20:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:20:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:33 INFO - Downloading docopt-0.6.1.tar.gz 02:20:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:20:33 INFO - Installing collected packages: blobuploader, requests, docopt 02:20:33 INFO - Running setup.py install for blobuploader 02:20:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:20:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:20:33 INFO - Running setup.py install for requests 02:20:34 INFO - Running setup.py install for docopt 02:20:34 INFO - Successfully installed blobuploader requests docopt 02:20:34 INFO - Cleaning up... 02:20:34 INFO - Return code: 0 02:20:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:20:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:34 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 0x7fc13005ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1385350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14141c0>, '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 0x14150c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1415550>, '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': 'c6927cf182745ad25b1d38b9000001fe-1465974564.938806-1672166689', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:20:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:20:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:20:34 INFO - Using env: {'DISPLAY': ':0', 02:20:34 INFO - 'HOME': '/home/cltbld', 02:20:34 INFO - 'LANG': 'en_US.UTF-8', 02:20:34 INFO - 'LANGUAGE': 'en_US:en', 02:20:34 INFO - 'LOGNAME': 'cltbld', 02:20:34 INFO - 'MAIL': '/var/mail/cltbld', 02:20:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:34 INFO - 'MOZ_NO_REMOTE': '1', 02:20:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:34 INFO - 'NO_EM_RESTART': '1', 02:20:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:34 INFO - 'PWD': '/builds/slave/test', 02:20:34 INFO - 'SHELL': '/bin/bash', 02:20:34 INFO - 'SHLVL': '1', 02:20:34 INFO - 'TERM': 'linux', 02:20:34 INFO - 'TMOUT': '86400', 02:20:34 INFO - 'USER': 'cltbld', 02:20:34 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465974564.938806-1672166689', 02:20:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:34 INFO - '_': '/tools/buildbot/bin/python'} 02:20:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:20:34 INFO - Running setup.py (path:/tmp/pip-1kzwfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:20:34 INFO - Running setup.py (path:/tmp/pip-dHxzvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:20:34 INFO - Running setup.py (path:/tmp/pip-nrU68q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:20:34 INFO - Running setup.py (path:/tmp/pip-LB0lHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:20:34 INFO - Running setup.py (path:/tmp/pip-foIkBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:20:35 INFO - Running setup.py (path:/tmp/pip-RHQMu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:20:35 INFO - Running setup.py (path:/tmp/pip-4Z_eje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:20:35 INFO - Running setup.py (path:/tmp/pip-xZ5sXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:20:35 INFO - Running setup.py (path:/tmp/pip-MRajdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:20:35 INFO - Running setup.py (path:/tmp/pip-n2gpmy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:20:35 INFO - Running setup.py (path:/tmp/pip-aKpSac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:20:35 INFO - Running setup.py (path:/tmp/pip-rCE2zy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:20:35 INFO - Running setup.py (path:/tmp/pip-IUB46O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:20:35 INFO - Running setup.py (path:/tmp/pip-MjThrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:20:35 INFO - Running setup.py (path:/tmp/pip-2SNiTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:20:35 INFO - Running setup.py (path:/tmp/pip-TXbYcF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:20:35 INFO - Running setup.py (path:/tmp/pip-0Lpp3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:20:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:20:35 INFO - Running setup.py install for manifestparser 02:20:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:20:36 INFO - Running setup.py install for mozcrash 02:20:36 INFO - Running setup.py install for mozdebug 02:20:36 INFO - Running setup.py install for mozdevice 02:20:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:20:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:20:36 INFO - Running setup.py install for mozfile 02:20:36 INFO - Running setup.py install for mozhttpd 02:20:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:20:36 INFO - Running setup.py install for mozinfo 02:20:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:20:36 INFO - Running setup.py install for mozInstall 02:20:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:20:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:20:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:20:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:20:36 INFO - Running setup.py install for mozleak 02:20:36 INFO - Running setup.py install for mozlog 02:20:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:20:36 INFO - Running setup.py install for moznetwork 02:20:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:20:37 INFO - Running setup.py install for mozprocess 02:20:37 INFO - Running setup.py install for mozprofile 02:20:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:20:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:20:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:20:37 INFO - Running setup.py install for mozrunner 02:20:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:20:37 INFO - Running setup.py install for mozscreenshot 02:20:37 INFO - Running setup.py install for moztest 02:20:37 INFO - Running setup.py install for mozversion 02:20:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:20:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:20:37 INFO - Cleaning up... 02:20:37 INFO - Return code: 0 02:20:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:20: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')]} 02:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20: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')]} 02:20:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:37 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 0x7fc13005ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1385350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14141c0>, '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 0x14150c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1415550>, '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': 'c6927cf182745ad25b1d38b9000001fe-1465974564.938806-1672166689', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:20:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:20:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:20:37 INFO - Using env: {'DISPLAY': ':0', 02:20:37 INFO - 'HOME': '/home/cltbld', 02:20:37 INFO - 'LANG': 'en_US.UTF-8', 02:20:37 INFO - 'LANGUAGE': 'en_US:en', 02:20:37 INFO - 'LOGNAME': 'cltbld', 02:20:37 INFO - 'MAIL': '/var/mail/cltbld', 02:20:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:37 INFO - 'MOZ_NO_REMOTE': '1', 02:20:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:37 INFO - 'NO_EM_RESTART': '1', 02:20:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:37 INFO - 'PWD': '/builds/slave/test', 02:20:37 INFO - 'SHELL': '/bin/bash', 02:20:37 INFO - 'SHLVL': '1', 02:20:37 INFO - 'TERM': 'linux', 02:20:37 INFO - 'TMOUT': '86400', 02:20:37 INFO - 'USER': 'cltbld', 02:20:37 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465974564.938806-1672166689', 02:20:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:37 INFO - '_': '/tools/buildbot/bin/python'} 02:20:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:20:37 INFO - Running setup.py (path:/tmp/pip-J0NW1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:20:38 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:20:38 INFO - Running setup.py (path:/tmp/pip-BQQggi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:20:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:20:38 INFO - Running setup.py (path:/tmp/pip-RRFP_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:20:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:20:38 INFO - Running setup.py (path:/tmp/pip-XOgwg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:20:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:20:38 INFO - Running setup.py (path:/tmp/pip-6jFCGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:20:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:20:38 INFO - Running setup.py (path:/tmp/pip-8pW8Ax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:20:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:20:38 INFO - Running setup.py (path:/tmp/pip-dd6oO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:20:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:20:38 INFO - Running setup.py (path:/tmp/pip-WNBbrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:20:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:20:38 INFO - Running setup.py (path:/tmp/pip-_t5oZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:20:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:20:38 INFO - Running setup.py (path:/tmp/pip-8wiiGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:20:38 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)) 02:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:20:38 INFO - Running setup.py (path:/tmp/pip-MmMEQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:20:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:20:38 INFO - Running setup.py (path:/tmp/pip-niR8YC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:20:38 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)) 02:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:20:38 INFO - Running setup.py (path:/tmp/pip-XfAcHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:20:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:20:38 INFO - Running setup.py (path:/tmp/pip-Z6M0jC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:20:38 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)) 02:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:20:38 INFO - Running setup.py (path:/tmp/pip-ZX2Qxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:20:39 INFO - Running setup.py (path:/tmp/pip-ifshAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:20:39 INFO - Running setup.py (path:/tmp/pip-wPczNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:20:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:20:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:41 INFO - Downloading blessings-1.6.tar.gz 02:20:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:20:41 INFO - Installing collected packages: blessings 02:20:41 INFO - Running setup.py install for blessings 02:20:41 INFO - Successfully installed blessings 02:20:41 INFO - Cleaning up... 02:20:41 INFO - Return code: 0 02:20:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:20:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:20:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:20:41 INFO - Reading from file tmpfile_stdout 02:20:41 INFO - Current package versions: 02:20:41 INFO - argparse == 1.2.1 02:20:41 INFO - blessings == 1.6 02:20:41 INFO - blobuploader == 1.2.4 02:20:41 INFO - docopt == 0.6.1 02:20:41 INFO - functools32 == 3.2.3-2 02:20:41 INFO - jsonschema == 2.5.1 02:20:41 INFO - manifestparser == 1.1 02:20:41 INFO - mozInstall == 1.12 02:20:41 INFO - mozcrash == 0.17 02:20:41 INFO - mozdebug == 0.1 02:20:41 INFO - mozdevice == 0.48 02:20:41 INFO - mozfile == 1.2 02:20:41 INFO - mozhttpd == 0.7 02:20:41 INFO - mozinfo == 0.9 02:20:41 INFO - mozleak == 0.1 02:20:41 INFO - mozlog == 3.2 02:20:41 INFO - moznetwork == 0.27 02:20:41 INFO - mozprocess == 0.22 02:20:41 INFO - mozprofile == 0.28 02:20:41 INFO - mozrunner == 6.11 02:20:41 INFO - mozscreenshot == 0.1 02:20:41 INFO - mozsystemmonitor == 0.3 02:20:41 INFO - moztest == 0.7 02:20:41 INFO - mozversion == 1.4 02:20:41 INFO - psutil == 3.1.1 02:20:41 INFO - requests == 1.2.3 02:20:41 INFO - wsgiref == 0.1.2 02:20:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:20:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:41 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 0x7fc13005ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1385350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14141c0>, '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 0x14150c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1415550>, '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': 'c6927cf182745ad25b1d38b9000001fe-1465974564.938806-1672166689', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:20:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:20:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:20:41 INFO - Using env: {'DISPLAY': ':0', 02:20:41 INFO - 'HOME': '/home/cltbld', 02:20:41 INFO - 'LANG': 'en_US.UTF-8', 02:20:41 INFO - 'LANGUAGE': 'en_US:en', 02:20:41 INFO - 'LOGNAME': 'cltbld', 02:20:41 INFO - 'MAIL': '/var/mail/cltbld', 02:20:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:41 INFO - 'MOZ_NO_REMOTE': '1', 02:20:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:41 INFO - 'NO_EM_RESTART': '1', 02:20:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:41 INFO - 'PWD': '/builds/slave/test', 02:20:41 INFO - 'SHELL': '/bin/bash', 02:20:41 INFO - 'SHLVL': '1', 02:20:41 INFO - 'TERM': 'linux', 02:20:41 INFO - 'TMOUT': '86400', 02:20:41 INFO - 'USER': 'cltbld', 02:20:41 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465974564.938806-1672166689', 02:20:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:41 INFO - '_': '/tools/buildbot/bin/python'} 02:20:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:20:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:20:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:20:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:20:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:20:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:20:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:20:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:20:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:20:41 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:20:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:20:41 INFO - Cleaning up... 02:20:41 INFO - Return code: 0 02:20:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:20:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:41 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 0x7fc13005ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1385350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14141c0>, '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 0x14150c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1415550>, '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': 'c6927cf182745ad25b1d38b9000001fe-1465974564.938806-1672166689', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:20:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:20:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:20:41 INFO - Using env: {'DISPLAY': ':0', 02:20:41 INFO - 'HOME': '/home/cltbld', 02:20:41 INFO - 'LANG': 'en_US.UTF-8', 02:20:41 INFO - 'LANGUAGE': 'en_US:en', 02:20:41 INFO - 'LOGNAME': 'cltbld', 02:20:41 INFO - 'MAIL': '/var/mail/cltbld', 02:20:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:41 INFO - 'MOZ_NO_REMOTE': '1', 02:20:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:41 INFO - 'NO_EM_RESTART': '1', 02:20:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:41 INFO - 'PWD': '/builds/slave/test', 02:20:41 INFO - 'SHELL': '/bin/bash', 02:20:41 INFO - 'SHLVL': '1', 02:20:41 INFO - 'TERM': 'linux', 02:20:41 INFO - 'TMOUT': '86400', 02:20:41 INFO - 'USER': 'cltbld', 02:20:41 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465974564.938806-1672166689', 02:20:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:41 INFO - '_': '/tools/buildbot/bin/python'} 02:20:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:20:41 INFO - Cleaning up... 02:20:41 INFO - Return code: 0 02:20:41 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:20:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:41 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 0x7fc13005ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1385350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14141c0>, '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 0x14150c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1415550>, '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': 'c6927cf182745ad25b1d38b9000001fe-1465974564.938806-1672166689', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:20:41 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 02:20:41 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 02:20:41 INFO - Using env: {'DISPLAY': ':0', 02:20:41 INFO - 'HOME': '/home/cltbld', 02:20:41 INFO - 'LANG': 'en_US.UTF-8', 02:20:41 INFO - 'LANGUAGE': 'en_US:en', 02:20:41 INFO - 'LOGNAME': 'cltbld', 02:20:41 INFO - 'MAIL': '/var/mail/cltbld', 02:20:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:41 INFO - 'MOZ_NO_REMOTE': '1', 02:20:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:41 INFO - 'NO_EM_RESTART': '1', 02:20:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:41 INFO - 'PWD': '/builds/slave/test', 02:20:41 INFO - 'SHELL': '/bin/bash', 02:20:41 INFO - 'SHLVL': '1', 02:20:41 INFO - 'TERM': 'linux', 02:20:41 INFO - 'TMOUT': '86400', 02:20:41 INFO - 'USER': 'cltbld', 02:20:41 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465974564.938806-1672166689', 02:20:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:41 INFO - '_': '/tools/buildbot/bin/python'} 02:20:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:42 INFO - Downloading/unpacking flake8 02:20:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:44 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:20:44 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:20:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:44 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:20:44 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:20:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:44 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:20:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:20:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:20:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:20:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:20:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:20:44 INFO - no previously-included directories found matching 'docs/_build' 02:20:44 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:20:44 INFO - Running setup.py install for pep8 02:20:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:20:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:20:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:20:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:20:44 INFO - no previously-included directories found matching 'docs/_build' 02:20:44 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:20:44 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:20:44 INFO - Cleaning up... 02:20:45 INFO - Return code: 0 02:20:45 INFO - Running post-action listener: _resource_record_post_action 02:20:45 INFO - Running post-action listener: _start_resource_monitoring 02:20:45 INFO - Starting resource monitoring. 02:20:45 INFO - ##### 02:20:45 INFO - ##### Finished create-virtualenv step (success) 02:20:45 INFO - ##### 02:20:45 INFO - ##### 02:20:45 INFO - ##### Running install step. 02:20:45 INFO - ##### 02:20:45 INFO - Running pre-action listener: _resource_record_pre_action 02:20:45 INFO - Running main action method: install 02:20:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:20:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:20:45 INFO - Reading from file tmpfile_stdout 02:20:45 INFO - Detecting whether we're running mozinstall >=1.0... 02:20:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:20:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:20:45 INFO - Reading from file tmpfile_stdout 02:20:45 INFO - Output received: 02:20:45 INFO - Usage: mozinstall [options] installer 02:20:45 INFO - Options: 02:20:45 INFO - -h, --help show this help message and exit 02:20:45 INFO - -d DEST, --destination=DEST 02:20:45 INFO - Directory to install application into. [default: 02:20:45 INFO - "/builds/slave/test"] 02:20:45 INFO - --app=APP Application being installed. [default: firefox] 02:20:45 INFO - mkdir: /builds/slave/test/build/application 02:20:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:20:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:21:02 INFO - Reading from file tmpfile_stdout 02:21:02 INFO - Output received: 02:21:02 INFO - /builds/slave/test/build/application/firefox/firefox 02:21:02 INFO - Running post-action listener: _resource_record_post_action 02:21:02 INFO - ##### 02:21:02 INFO - ##### Finished install step (success) 02:21:02 INFO - ##### 02:21:02 INFO - ##### 02:21:02 INFO - ##### Running run-tests step. 02:21:02 INFO - ##### 02:21:02 INFO - Running pre-action listener: _resource_record_pre_action 02:21:02 INFO - Running main action method: run_tests 02:21:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:21:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:21:02 INFO - Python 2.7.3 02:21:02 INFO - Return code: 0 02:21:02 INFO - grabbing minidump binary from tooltool 02:21:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:21:02 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 0x14141c0>, '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 0x14150c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1415550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:21:02 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:21:02 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:21:02 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:21:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:21:02 INFO - Return code: 0 02:21:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:21:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:21:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:21:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:21:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:21:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:21:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:21:03 INFO - Return code: 0 02:21:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BqmXjc4-T8a-gPRYbhKsXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:21:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BqmXjc4-T8a-gPRYbhKsXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:21:03 INFO - Using env: {'DISPLAY': ':0', 02:21:03 INFO - 'HOME': '/home/cltbld', 02:21:03 INFO - 'LANG': 'en_US.UTF-8', 02:21:03 INFO - 'LANGUAGE': 'en_US:en', 02:21:03 INFO - 'LOGNAME': 'cltbld', 02:21:03 INFO - 'MAIL': '/var/mail/cltbld', 02:21:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:21:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:21:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:03 INFO - 'MOZ_NO_REMOTE': '1', 02:21:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:21:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:03 INFO - 'NO_EM_RESTART': '1', 02:21:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:03 INFO - 'PWD': '/builds/slave/test', 02:21:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:21:03 INFO - 'SHELL': '/bin/bash', 02:21:03 INFO - 'SHLVL': '1', 02:21:03 INFO - 'TERM': 'linux', 02:21:03 INFO - 'TMOUT': '86400', 02:21:03 INFO - 'USER': 'cltbld', 02:21:03 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465974564.938806-1672166689', 02:21:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:03 INFO - '_': '/tools/buildbot/bin/python'} 02:21:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BqmXjc4-T8a-gPRYbhKsXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:21:03 INFO - mozversion application_buildid: 20160614233002 02:21:03 INFO - mozversion application_changeset: da53037ac8087280b90ee94a55f116a24e5e9730 02:21:03 INFO - mozversion application_display_name: Nightly 02:21:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:21:03 INFO - mozversion application_name: Firefox 02:21:03 INFO - mozversion application_remotingname: firefox 02:21:03 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:21:03 INFO - mozversion application_vendor: Mozilla 02:21:03 INFO - mozversion application_version: 50.0a1 02:21:03 INFO - mozversion platform_buildid: 20160614233002 02:21:03 INFO - mozversion platform_changeset: da53037ac8087280b90ee94a55f116a24e5e9730 02:21:03 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:21:03 INFO - mozversion platform_version: 50.0a1 02:21:03 INFO - using testdate: 1465982463 02:21:03 INFO - actual date: 1465982463 02:21:03 INFO - starting webserver on 'localhost:38728' 02:21:03 INFO - SUITE-START | Running 2 tests 02:21:03 INFO - TEST-START | dromaeo_css 02:21:03 INFO - operating with platform_type : linux_ 02:21:03 INFO - Initialising browser for dromaeo_css test... 02:21:03 INFO - TEST-INFO | started process 16948 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpodnw2F/profile http://localhost:38728/getInfo.html) 02:21:08 INFO - PROCESS | 16948 | __metrics Screen width/height:1600/1200 02:21:08 INFO - PROCESS | 16948 | colorDepth:24 02:21:08 INFO - PROCESS | 16948 | Browser inner width/height: 1024/697 02:21:08 INFO - PROCESS | 16948 | __metrics 02:21:09 ERROR - PROCESS | 16948 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 02:21:09 INFO - TEST-INFO | 16948: exit 0 02:21:09 INFO - Browser initialized. 02:21:09 INFO - Running cycle 1/1 for dromaeo_css test... 02:21:09 INFO - TEST-INFO | started process 17069 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpodnw2F/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:21:21 INFO - PROCESS | 17069 | RSS: Main: 184631296 02:21:21 INFO - PROCESS | 17069 | 02:22:11 INFO - PROCESS | 17069 | 1465982531479 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:24:19 INFO - PROCESS | 17069 | Cycle 1(1): loaded http://localhost:38728/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38728/tests/dromaeo/cssquery-ext.html) 02:24:20 INFO - PROCESS | 17069 | RSS: Main: 188481536 02:24:20 INFO - PROCESS | 17069 | 02:27:22 INFO - PROCESS | 17069 | Cycle 1(1): loaded http://localhost:38728/tests/dromaeo/cssquery-ext.html (next: http://localhost:38728/tests/dromaeo/cssquery-jquery.html) 02:27:23 INFO - PROCESS | 17069 | RSS: Main: 187617280 02:27:23 INFO - PROCESS | 17069 | 02:30:25 INFO - PROCESS | 17069 | Cycle 1(1): loaded http://localhost:38728/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38728/tests/dromaeo/cssquery-mootools.html) 02:30:25 INFO - PROCESS | 17069 | RSS: Main: 188809216 02:30:25 INFO - PROCESS | 17069 | 02:33:27 INFO - PROCESS | 17069 | Cycle 1(1): loaded http://localhost:38728/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38728/tests/dromaeo/cssquery-prototype.html) 02:33:28 INFO - PROCESS | 17069 | RSS: Main: 186290176 02:33:28 INFO - PROCESS | 17069 | 02:36:30 INFO - PROCESS | 17069 | Cycle 1(1): loaded http://localhost:38728/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38728/tests/dromaeo/cssquery-yui.html) 02:36:31 INFO - PROCESS | 17069 | RSS: Main: 188493824 02:36:31 INFO - PROCESS | 17069 | 02:39:34 INFO - PROCESS | 17069 | Cycle 1(1): loaded http://localhost:38728/tests/dromaeo/cssquery-yui.html (next: http://localhost:38728/tests/dromaeo/cssquery-dojo.html) 02:39:34 INFO - PROCESS | 17069 | RSS: Main: 189534208 02:39:34 INFO - PROCESS | 17069 | 02:39:34 INFO - PROCESS | 17069 | __start_tp_report 02:39:34 INFO - PROCESS | 17069 | _x_x_mozilla_page_load 02:39:34 INFO - PROCESS | 17069 | _x_x_mozilla_page_load_details 02:39:34 INFO - PROCESS | 17069 | |i|pagename|runs| 02:39:34 INFO - PROCESS | 17069 | |0;dojo.html;3135.6550779414265;3153.369326134772;3177.0786471923143;3180.697833705798;3188.52172174174;5438.238646589481;5473.042217611917;5498.725063746811;5557.138643510252;5576.079946808772;5273.630845840793;5401.135818269077;5407.540359069484;5497.835064948048;5498.367687715914;4866.367372241612;4980.825671101494;5012.198048312271;5072.289879416885;5132.281480592701;4949.381327334083;5160.277561141444;5176.792928282883;5188.896222075557;5190.429052804188;4866.902661946777;4934.679245849008;4952.678075925053;5055.797768089272;5071.061853557086;4898.5591296783105;4898.877528061791;4908.656394052417;4922.680025798311;4939.851804445872;4921.8523444296725;4926.5812405945535;4937.037277730844;4960.2063669813015;4974.37820272466;5348.491893270172;5376.973115134399;5456.61803673743;5477.123660214346;5484.122540393518;5773.826785196451;5795.275590551181;5811.79658711943;5812.041013232812;5840.503557197643;5728.971355143198;5891.027980383232;5892.970535147339;5895.145203945447;5901.970490147564;5448.046591846451;5463.31708536433;5490.505854473076;5509.311336082989;5532.723363831792;5990.460858522754;6001.339852616209;6002.759889604455;6017.879642407127;6038.033914573647;5657.830265092054;5722.456366645162;5768.538516918637;5778.711064446761;5806.44838740319;5814;5909.231799866076;5916.319623243382;5935.584509084409;5972.970135149383;5606.131049687305;5714.285714285715;5807.419258074159;5877.118432235199;5917.585768996215;5758.568107391962;5808.564357673107;5840.036393995028;5847.298324201123;5855.765769369177;4454.510003899569;4482.887927801831;4495.865124046284;4515.616172625298;4532.909341813145;3975.5030621172355;3989.9027767363627;4006.759594424344;4013.3979903014783;4045;5438.728063596884;5475.397706252309;5538.701049858324;5539.2522009529;5539.695316757617;5833.38749431312;5846.356900740915;5891.410858914074;5930.644161350333;5937.465628093406;5538.723063846872;5548.223248745179;5552.805651802168;5561.6663000219305;5571.247881536022;4973.701577905337;4999.975000124976;5027.170516864677;5052.72210028452;5054.393472783216;6041.72812223451;6042.667653279024;6048.183495228176;6048.364921683248;6058.787942421994;5794.739236734441;5874;5878.441548052928;5897.616654917417;5903.645781253139;6035.486983606267;6084.817455476343;6106.053561697944;6138.846528836815;6146.6004709693725;5802.854928626818;5835.095560188178;5835.912461313169;5837.416258374129;5848.64908105515;5765.509931655856;5843.94156058451;5949.434803693643;5958.523318134626;5966.701664916824;5571.05292100352;5706.2011318414625;5746.252987111816;5752.942470575241;5772.163036359789;5658.292713410824;5683.119116536944;5693.3168019837885;5773.134029895549;5793.884122317446;5699.5155411790465;5706.857328566819;5707.743151558107;5713.514351280188;5719.256496655408;5580.414056524007;5638.01334766406;5725.4560816724015;5782.5952183348445;5793.94206057934;5570.888582228252;5573.414791446839;5606.271184745957;5612.7754889803955;5618.88762224745 02:39:34 INFO - PROCESS | 17069 | |1;ext.html;584.3484514766037;620.6617393520531;626.4800215820866;646.5248042688625;647.7085311609777;36960.81519592401;40447.79776101119;40843.59156408435;40892.79553602228;40945.79527102364;40916.79541602288;41572.79213603935;41592;41634.791826040826;41661.58338416615;8741.868871966926;8818.382713210078;8896.822063558724;8915.955420222923;8917.95541022294;8712.738617841474;8785.64857405703;8789.25291350236;8804.779880502974;8805;8757.343199260049;8768.167024132697;8771.210591046836;8771.473711577293;8807.471551706885;8868.068852770431;8870.15733505316;8887.911120888773;8891;8923.375363724543;8785.209331160226;8825.602847871862;8839.071897450804;8893.11068893112;8894.73315800527;38859.41710874339;39021;39123;39147;39266;3561.5726112866623;4078.062045729499;4285.785710714483;4295.140971805651;4403.493598236212;31951;32275.83862080698;32344.514832277535;33266;33308.66691333104;4214.683898707609;4241.130568233505;4245.469316335458;4290.356446533014;4292.184484947881;339285;339945;342301;344600.2769986159;344963;55096;55206;55356.44643553513;55587;55732.72133639387;35128.47307290393;35542.46686299708;36150.45774313388;58971.70514147402;59315;16326.918365408335;16537.338506459608;16546.66906661884;16653.250603722863;16660.58348541272;12649.93675031619;12680.6829829255;12720.809187862189;12736.681582960315;12862.807057894139;19100.904495477433;19171.520711982314;19172.424827255203;19220.903895480435;19339.80660193408;7052.753153639598;7258.201597824235;7284.453665975073;7317.890231646529;7349.154847192534;1016.8118898003893;1018.2617602238317;1059.708580140452;1188.976220475603;1196.186593116689;31500.684993150233;31970.520442193385;32018.519722204186;32263;32271.193220169684;1109.778044391125;1131.6378758797107;1132.6828488023366;1183.7454947186225;1184.0350114656528;16712.49862504127;16789.1605419731;16936;16999.66000680004;17170.484885453458;561596;562968;564400;565725;565948;56133.43866561364;56548.324358916536;56772.716136419054;56815.71592142013;57315;1333.8132661427408;1335.746208220435;1372.444160115135;1383.9446422143;1411.1885665742238;30273;30875.536866947463;31358.843205783825;31660.683393165775;31696.36607267888;48297;48573.51426485831;48891.75554122207;48976.755116224194;49168.75415622899;353679;354014;354619;357878;359595;26408.8679556601;27821.860890695418;27885.58171627468;27950.16149515518;28054.57918131189;41152.794236028625;45110.32334514919;47830.521694782605;48680;48824;39397.2120557593;39591;40887.16007779717;40984;41019.17961640691;39930.40104398378;39972.600273998054;40210.39684404678;40490;40766;38533.4219986706;43391.78304108459;43947.78026109849;46500.53499464962;47117.29324060073;39208;42971.57028429801;43696.78151609222;43750.78124609484;44222.557774421846;33855.492167617995;34773.47839782355;34784.130396740286;35010.29979400449;35037.82481087578 02:39:34 INFO - PROCESS | 17069 | |2;jquery.html;383.53783690652756;391.77472953052;392.9567747547769;395.0636990332911;413.18189983832013;13665;14308.642283942907;17755.467335979924;19387.224511019558;19431.222751089957;17488.562785930357;18308.542286442847;18644.627107457844;18986.145623446944;19193.232270709155;5670.659760414368;5739.856503587423;5777.335606405254;5858.970705146468;5878.794242201524;5784.3058832940105;5790.392008839074;5824.767009319622;5827.854303642401;5840.386759390245;5263.842084737464;5575.442455754433;5649.915251271234;5767.33675627304;5808.12878068289;5489.231507588941;5516.696581688006;5528.668279903179;5535.446455354472;5553.055980483327;5521.613487055908;5585.385607583163;5603.299587551556;5608.327000759894;5611.775528978836;13757.518486852912;13786;13863.653408664864;16196.190190490428;21390.251341202984;2269.841111122222;2303.332033710222;2346.9178578749834;2349.624060150385;2492.6385674077155;9702.757431064209;9862.161716254128;9971.700848974542;10353.689389318333;11971.880281197164;1791.937282195117;1821.4535639308156;1911.961760764777;1916.1090093106773;1936.1384184038109;59722;68896.6555167226;71024;75016.62491687562;79120;9394.67118650844;10301.175905927508;10658;10686;10919.781604367869;14890.92554537242;14941.17823519695;15041.623959400884;15083.095014299177;15097.169655669044;7978.920210797934;8019.238172373615;8086.676532938734;8205.384596155312;8286.958565207135;7781.45529812919;7811.765647030598;7833.451658383859;7869.2130786922;7943.960280198562;4624.768761561909;4740.431148262231;4817.229243321051;4828.130936431476;4847.151748444008;1932.5748335366197;1966.8235799184215;1978.6339527187517;1990.5222746540726;2006.2175751456944;917.9586918588546;971.3006635222629;1010.9595616175418;1032.9876720813495;1055.5302890213782;17854;17864.91067544654;18739.531511712044;19080.522986925436;19261.13324900383;974.965876194344;993.3096497934011;1020.9387436753818;1020.9586222053464;1024.2727663359099;10144.898551014543;10146.594136234615;10816.188785840935;10875;10974.835377469344;515104;520556;530096;539211;543926;70451.64774176096;89943;92284.53857730668;93415.53292233631;94027.52986235161;992.5583115513672;1028.3007554862616;1029.4132344563527;1031.7369070887025;1034.8706411698538;16478.83521164821;17011.829881701025;17332.82667173312;17716.468505944842;17824;39529;40439.595604043585;40999.7950010248;41295.1740965185;41453.378199327635;49745.75127124341;50851;53003.734981324844;58785.11822322754;59080.704596476746;8173.877391839246;8503.617337219963;8609.440386374865;8685.826283474422;8825.02924678272;11705.765884682089;12233.755324893631;12565.246085234916;13503.662408439868;13510;11420.828687569527;11511.712207194887;11574.88425115738;11873.287602743518;12009.159358844798;11628.418579071182;11689.181757276909;11725.824112638487;11735.413229338328;11853.34806585646;11711.472983715583;11913.82129268079;11993.220440671328;12099.516019359478;12121.333326667118;7282.890756638549;7575;7685.269899359552;8147.14454982242;8706.825863482822;10749.408782517037;11176;11296.661100167008;11387.544498219979;11554.76890462203 02:39:34 INFO - PROCESS | 17069 | |3;mootools.html;1468.0677769616298;1470.5955862137914;1595.9042457452554;1725.6893759123352;1732.7487514310417;7758.922410775891;8414.158584141584;8558.315334773219;8973.91026089739;8978.012418633953;8613.35399845011;8786.912130878689;8993.955030224839;9003.234725048362;9006.86489702655;2274.9090036398566;2309.9027961718134;2313.6645186447954;2327.045911176418;2330;2295.1393227539675;2309.1109922679807;2336.7780060894274;2340.73081595617;2357.634566642173;2328.3015095471374;2335.0426325206668;2344.4842134730416;2356.3402247370677;2356.7878890899815;2233.3076746208567;2245.910733294351;2247.5617254635354;2248.4603695113137;2249.7862703043265;2247.0899285789283;2252.583272094668;2257.3566533537864;2264.0943622551113;2267.648514480258;8949.284057275467;8975.147361000694;8977.775555611097;9000.099990001014;9027.4132181408;5216.634835561512;5298.337707786527;5302.734863256822;5345.465453454663;5346.465353464661;3087.8919237826794;3169.35028319194;3315.784474009206;3357.7649564530493;3367.4275373186615;1085.625459216569;1086.5653738504582;1090.6182836007413;1093.6281664234118;1122;12446.81329780054;12467.625971220878;12511.186772859735;12529.310887901252;12538.811917821331;4604.470485894098;4689.320048592935;4749.62003039756;4751.40607424072;4781.95218047822;10388.532516036796;10395;10410.167186625053;10418.11446027081;10425.270231083752;5126.7180305083575;5242.7640756166065;5257.158854583325;5272.92090618641;5296.523312901857;4167.395727619539;4815.855524334275;4838.467768545527;4943.258511223274;4955.182394904872;3935.4687117238805;3947.3289540778137;4061.472008638858;4076.9796151019054;4081.4490043844294;1243.7823380908485;1274.8526326306212;1297.7469393468373;1299.0841456772953;1313.3039489070807;963.5471328475745;967.883853937532;970.8786401699788;979;1006.6426418621284;5925.170476133345;6067.848303792441;6073.08903664445;6080.513558915364;6118;909.5634095634133;950.7955789505289;977.5503268496429;979.1530326267728;1023.8566600675912;3961.603839616015;4128.690348223895;4186.497620285585;4211.810468528863;4228.2600544905135;10908.890911090788;11272.041876440431;11276.097912167006;11357.602483913024;11463.713407164887;11226.550937962553;11245.381504017358;11246.381449020218;11257.71855703614;11259.211855170059;7900.723474678359;8244.628991695388;8244.917550824415;8360.665573376997;8411.915880841114;5683;6036.154938308552;6100.23747031621;6133.601315914451;6207.596506227081;10308.12380947628;10318.17454603645;10543.472826358804;10625.149988000787;10672.57309707634;10418.270721049454;10645.787084258116;10721.142308615135;10734.087602553558;10747.46262686847;7279.599622020628;7695.769126926201;7977.92022079795;8110.391720621095;8245.628946697532;8747.475151490931;8889.377743557889;8900.198982091642;8934.28525717954;8968.820623587622;7843.882341764992;7994.5203287802915;8088.757337279891;8097.797555061171;8108.675652973815;7589.734359297398;7818.022747156606;7917.208279172037;7926.009248843895;8065.637046332812;6688.83277918056;6689.565178263398;6831.146106736658;6842.213145488134;6843.692033858588;4873.147199240189;4925.916298414343;4991.625628077982;5044.218146187347;5059.747012649426;5185.870353241199;5240.528352448298;5272.7100009499845;5275.7362131894015;5296.867578310573 02:39:34 INFO - PROCESS | 17069 | |4;prototype.html;326.36033374585827;334.5416779012752;337.5004992610936;338.55818157304725;344.1087583159616;5489.039418101836;5574.693391863446;5649.519790817785;5657.5856035991;5690.9146362804595;5543.279373681416;5589.189567512708;5608.61633805632;5612.298462692163;5622.746976386063;4351.73889566627;4366.257736184841;4366.97816510917;4367.366731823891;4381.518033016366;4047.394774676519;4246.851360202393;4254.957450425487;4261.190373828978;4268.146370725852;4235.729281215638;4249.1714115747445;4252.766097864616;4253.383259427396;4267.765272909989;4211.199872024321;4314.1371725654835;4323.913521729579;4325.178216138924;4340.52254252032;3702.87039953603;3703.8147792706345;3787.3561494545993;3790.753601015953;3794.544654641433;5391.919121213185;5411.18832175173;5412.864678383072;5421.566274698014;5436.782528698847;4919.434265059493;4921.753912304406;4925.532074452921;4932.802687892516;4935.679180853233;5564.1931919871795;5796.942030579682;5801.3618501965175;5821.243238379026;5824.068149096124;4105.712600117993;4120;4120.196561670476;4155.397467367215;4163.271427500205;5708.172315014342;5806.6516009040015;5971.970140149315;6002.559385747433;6047.304559975615;4167.791610419466;4190.916181676349;4193.874183774492;4206.26390381682;4214.810333534998;4171.520275168334;4209.768462734518;4261.296886013835;4264;4269.252880745857;4756.262779269219;4875.171220892456;4891.902161956741;4949.406071271471;4986.501349865057;5772.163036359789;5840.3575606683235;5865.618734782311;5885.440883116097;5894.8821023579285;1456.4392708806974;1467.7798330250334;1481.6666250093858;1490.299559207171;1495.2075400037997;907.3920473282916;940.6472572785206;942.8261814041562;953.5280036382036;968.1722127580957;4863.1732605457155;4943.480934501826;4964.510646805944;4978.809323897473;5000.724960127155;5177.301064356339;5185;5271.841844744664;5296.3379577552805;5371.62398632092;4970.353853998957;4997.225430058346;5081.780372710523;5197.870053248624;5690.573207009491;3214.421404147229;3240.238543942172;3262.983685081607;3263.2494526259093;3272.885449009273;6108.816735497942;6146.262448506119;6166.876662466726;6174.660393678301;6324.33594472583;6143.92481315768;6152.2924863640355;6164.291106522807;6211.503079753609;6238.844028899314;6253.53098517613;6272.655003974825;6291.402316779899;6342.016987366873;6360.745570177233;5809.215755872903;6067.787627433018;6068.848278793065;6097.75608975636;6101.359357267601;5946.443029497184;5950.166976623363;5972.163897054329;6044.969775151096;6048.395160484092;5972.283326000907;6003.609765365237;6161.44546990773;6174.104754810617;6188.504919606511;4214.925194075491;4245.405643209891;4258.829646814217;4274.529801721746;4280.935785963151;5946.494547963472;6090;6111.205543279345;6119.816405507842;6156.630602163885;5781;5819;5836.941630583639;5856.677882716492;5926.348101708895;5846.590738648254;5855;5876;5892.143974647972;5924.140999555127;5593.552515798808;5676.829695109153;5780.248567686174;5784.1034639630925;5788.797392091256;5840.415958404125;5895.970520147372;5914;5925.4370834770625;5934.97032514852;5524.723763811713;5696.20253164549;5737.483626473638;5744.253247077853;5785.669296061845 02:39:34 INFO - PROCESS | 17069 | |5;yui.html;726.654838951498;739.8668239716849;787.1577412168978;812.122907260159;845.7631863078338;12615.747685046304;13002.089853710244;13043.086983911106;13073.215607063583;13084.803727944076;13619.319034048307;13674.863251367484;13831.446742130327;15349.462768803094;15420.922895385536;818.6807145213371;818.8321394114192;826.8925039744855;827.5117680568463;828.9212524810164;770.4760762681375;826.3678286111129;829.1418381974657;831.5094094484253;832.5712258187039;849.0321034021221;853.1724227499346;856.9271611912994;858.8368210040104;860.8364410761967;852.9829403411959;853.1511146409331;855.4054931822386;855.9614817333235;856.1823458597025;621.6332363905318;623.0996210475864;623.2738859228992;623.7317953280087;624.6439529468205;14273.500427485093;14282.428702851978;14322.785158222636;14329.426822927071;14331.928340358232;14601.269936503133;14631.63420914475;14632.853671463256;14687.192204428753;14714.117152970748;11339.603113891057;11744.882551174464;11771.23486973344;11804.350760708157;12240.265584064984;3787.2993496203017;3838.7888666123354;3964.0288129408477;4034.838606455738;4035.7578545287083;74602.62698686526;75926;76217.61891190508;76427.23572764256;76622.6168869152;11441.713957151138;11609.825852612217;11639.301641901513;11708.94145529284;11713.590024349278;21517.955794199526;21636.24273150432;21664.783352166276;21739.782602173775;21866.344009679735;8518.148185181431;8532.786680332918;8796.252318552995;8821.647134114692;8985.955070224607;4759.23852183649;4914.336564563738;4942.678725882806;4978.850634480971;4996.550310472075;3573.8213089345427;3621.239539696693;3691.0587800110798;3703.2963736889906;3703.6111208323277;600.0249594409086;602.764921680545;605.6214865708932;615.2862679292;618.848382146377;705.8800003999332;721.3255606008399;748.6743266679013;752.7741677496729;767.0718430698805;9464.621415143318;9472.763180920532;9501;9663.178629816404;9670.854937175947;692.5083190934392;701.0010734703129;720.2077714513993;734.2694019450681;736.3041925380571;4538.500764915857;4602.7008244464005;4669.112868554964;4677.742724150205;4755.096531659043;108143;109405;109432.4528377369;111038.44480777545;115932.42033789777;82483;89455.55272223728;92825.53587232156;94037.5298123505;94307;53155.468445315826;69672.30327696759;73815.89276160861;82504;86887.56556217179;9690.224782017563;10488.895111048792;10493.422861742678;10607.840882386925;10613.522391492246;48083.27875081806;48092.27861582149;49689;50664.24003639875;51489.742551287;46570.37003704854;64092;70421;70858.29141708722;76021.6198919024;12968.8054679178;13192.142510736772;13221.669458263621;13420.731585368434;13693.931530342285;15433.768493472831;15438;15465.381384744484;15477.922610386877;15484.225788710293;13357.332133393485;13920.51278205258;13950.651233719238;14431.2062836545;14457.349419275948;13983.300834958009;14450.205238711971;14675.706485870009;15161.166135862191;15198.620034498783;10813.837792433276;13476.865231347561;14118.858811411754;14516.401003799197;14520.491782787552;11218.270812397168;11298.265612735146;11580.36308003068;11682.70793230176;11981.041516678819;11298.435078246219;11319.547218111513;11328.830067549157;11797.233179843282;11835.585754498552 02:39:34 INFO - PROCESS | 17069 | __end_tp_report 02:39:34 INFO - PROCESS | 17069 | __start_cc_report 02:39:34 INFO - PROCESS | 17069 | _x_x_mozilla_cycle_collect,352 02:39:34 INFO - PROCESS | 17069 | __end_cc_report 02:39:34 INFO - PROCESS | 17069 | __startTimestamp1465983574518__endTimestamp 02:39:34 INFO - PROCESS | 17069 | 02:39:34 INFO - PROCESS | 17069 | ------- Summary: start ------- 02:39:34 INFO - PROCESS | 17069 | Number of tests: 6 02:39:34 INFO - PROCESS | 17069 | 02:39:34 INFO - PROCESS | 17069 | [#0] dojo.html Cycles:165 Average:5442.19 Median:5618.89 stddev:617.61 (11.0%) stddev-sans-first:592.41 02:39:34 INFO - PROCESS | 17069 | Values: 3135.7 3153.4 3177.1 3180.7 3188.5 5438.2 5473.0 5498.7 5557.1 5576.1 5273.6 5401.1 5407.5 5497.8 5498.4 4866.4 4980.8 5012.2 5072.3 5132.3 4949.4 5160.3 5176.8 5188.9 5190.4 4866.9 4934.7 4952.7 5055.8 5071.1 4898.6 4898.9 4908.7 4922.7 4939.9 4921.9 4926.6 4937.0 4960.2 4974.4 5348.5 5377.0 5456.6 5477.1 5484.1 5773.8 5795.3 5811.8 5812.0 5840.5 5729.0 5891.0 5893.0 5895.1 5902.0 5448.0 5463.3 5490.5 5509.3 5532.7 5990.5 6001.3 6002.8 6017.9 6038.0 5657.8 5722.5 5768.5 5778.7 5806.4 5814.0 5909.2 5916.3 5935.6 5973.0 5606.1 5714.3 5807.4 5877.1 5917.6 5758.6 5808.6 5840.0 5847.3 5855.8 4454.5 4482.9 4495.9 4515.6 4532.9 3975.5 3989.9 4006.8 4013.4 4045.0 5438.7 5475.4 5538.7 5539.3 5539.7 5833.4 5846.4 5891.4 5930.6 5937.5 5538.7 5548.2 5552.8 5561.7 5571.2 4973.7 5000.0 5027.2 5052.7 5054.4 6041.7 6042.7 6048.2 6048.4 6058.8 5794.7 5874.0 5878.4 5897.6 5903.6 6035.5 6084.8 6106.1 6138.8 6146.6 5802.9 5835.1 5835.9 5837.4 5848.6 5765.5 5843.9 5949.4 5958.5 5966.7 5571.1 5706.2 5746.3 5752.9 5772.2 5658.3 5683.1 5693.3 5773.1 5793.9 5699.5 5706.9 5707.7 5713.5 5719.3 5580.4 5638.0 5725.5 5782.6 5793.9 5570.9 5573.4 5606.3 5612.8 5618.9 02:39:34 INFO - PROCESS | 17069 | 02:39:34 INFO - PROCESS | 17069 | [#1] ext.html Cycles:180 Average:58054.83 Median:22460.83 stddev:114846.77 (511.3%) stddev-sans-first:115087.88 02:39:34 INFO - PROCESS | 17069 | Values: 584.3 620.7 626.5 646.5 647.7 36960.8 40447.8 40843.6 40892.8 40945.8 40916.8 41572.8 41592.0 41634.8 41661.6 8741.9 8818.4 8896.8 8916.0 8918.0 8712.7 8785.6 8789.3 8804.8 8805.0 8757.3 8768.2 8771.2 8771.5 8807.5 8868.1 8870.2 8887.9 8891.0 8923.4 8785.2 8825.6 8839.1 8893.1 8894.7 38859.4 39021.0 39123.0 39147.0 39266.0 3561.6 4078.1 4285.8 4295.1 4403.5 31951.0 32275.8 32344.5 33266.0 33308.7 4214.7 4241.1 4245.5 4290.4 4292.2 339285.0 339945.0 342301.0 344600.3 344963.0 55096.0 55206.0 55356.4 55587.0 55732.7 35128.5 35542.5 36150.5 58971.7 59315.0 16326.9 16537.3 16546.7 16653.3 16660.6 12649.9 12680.7 12720.8 12736.7 12862.8 19100.9 19171.5 19172.4 19220.9 19339.8 7052.8 7258.2 7284.5 7317.9 7349.2 1016.8 1018.3 1059.7 1189.0 1196.2 31500.7 31970.5 32018.5 32263.0 32271.2 1109.8 1131.6 1132.7 1183.7 1184.0 16712.5 16789.2 16936.0 16999.7 17170.5 561596.0 562968.0 564400.0 565725.0 565948.0 56133.4 56548.3 56772.7 56815.7 57315.0 1333.8 1335.7 1372.4 1383.9 1411.2 30273.0 30875.5 31358.8 31660.7 31696.4 48297.0 48573.5 48891.8 48976.8 49168.8 353679.0 354014.0 354619.0 357878.0 359595.0 26408.9 27821.9 27885.6 27950.2 28054.6 41152.8 45110.3 47830.5 48680.0 48824.0 39397.2 39591.0 40887.2 40984.0 41019.2 39930.4 39972.6 40210.4 40490.0 40766.0 38533.4 43391.8 43947.8 46500.5 47117.3 39208.0 42971.6 43696.8 43750.8 44222.6 33855.5 34773.5 34784.1 35010.3 35037.8 02:39:34 INFO - PROCESS | 17069 | 02:39:34 INFO - PROCESS | 17069 | [#2] jquery.html Cycles:180 Average:29207.19 Median:1438.09 stddev:86977.93 (6048.2%) stddev-sans-first:87195.00 02:39:34 INFO - PROCESS | 17069 | Values: 383.5 391.8 393.0 395.1 413.2 13665.0 14308.6 17755.5 19387.2 19431.2 17488.6 18308.5 18644.6 18986.1 19193.2 5670.7 5739.9 5777.3 5859.0 5878.8 5784.3 5790.4 5824.8 5827.9 5840.4 5263.8 5575.4 5649.9 5767.3 5808.1 5489.2 5516.7 5528.7 5535.4 5553.1 5521.6 5585.4 5603.3 5608.3 5611.8 13757.5 13786.0 13863.7 16196.2 21390.3 2269.8 2303.3 2346.9 2349.6 2492.6 9702.8 9862.2 9971.7 10353.7 11971.9 1791.9 1821.5 1912.0 1916.1 1936.1 59722.0 68896.7 71024.0 75016.6 79120.0 9394.7 10301.2 10658.0 10686.0 10919.8 14890.9 14941.2 15041.6 15083.1 15097.2 7978.9 8019.2 8086.7 8205.4 8287.0 7781.5 7811.8 7833.5 7869.2 7944.0 4624.8 4740.4 4817.2 4828.1 4847.2 1932.6 1966.8 1978.6 1990.5 2006.2 918.0 971.3 1011.0 1033.0 1055.5 17854.0 17864.9 18739.5 19080.5 19261.1 975.0 993.3 1020.9 1021.0 1024.3 10144.9 10146.6 10816.2 10875.0 10974.8 515104.0 520556.0 530096.0 539211.0 543926.0 70451.6 89943.0 92284.5 93415.5 94027.5 992.6 1028.3 1029.4 1031.7 1034.9 16478.8 17011.8 17332.8 17716.5 17824.0 39529.0 40439.6 40999.8 41295.2 41453.4 49745.8 50851.0 53003.7 58785.1 59080.7 8173.9 8503.6 8609.4 8685.8 8825.0 11705.8 12233.8 12565.2 13503.7 13510.0 11420.8 11511.7 11574.9 11873.3 12009.2 11628.4 11689.2 11725.8 11735.4 11853.3 11711.5 11913.8 11993.2 12099.5 12121.3 7282.9 7575.0 7685.3 8147.1 8706.8 10749.4 11176.0 11296.7 11387.5 11554.8 02:39:34 INFO - PROCESS | 17069 | 02:39:34 INFO - PROCESS | 17069 | [#3] mootools.html Cycles:180 Average:5882.36 Median:4750.51 stddev:3396.49 (71.5%) stddev-sans-first:3389.82 02:39:34 INFO - PROCESS | 17069 | Values: 1468.1 1470.6 1595.9 1725.7 1732.7 7758.9 8414.2 8558.3 8973.9 8978.0 8613.4 8786.9 8994.0 9003.2 9006.9 2274.9 2309.9 2313.7 2327.0 2330.0 2295.1 2309.1 2336.8 2340.7 2357.6 2328.3 2335.0 2344.5 2356.3 2356.8 2233.3 2245.9 2247.6 2248.5 2249.8 2247.1 2252.6 2257.4 2264.1 2267.6 8949.3 8975.1 8977.8 9000.1 9027.4 5216.6 5298.3 5302.7 5345.5 5346.5 3087.9 3169.4 3315.8 3357.8 3367.4 1085.6 1086.6 1090.6 1093.6 1122.0 12446.8 12467.6 12511.2 12529.3 12538.8 4604.5 4689.3 4749.6 4751.4 4782.0 10388.5 10395.0 10410.2 10418.1 10425.3 5126.7 5242.8 5257.2 5272.9 5296.5 4167.4 4815.9 4838.5 4943.3 4955.2 3935.5 3947.3 4061.5 4077.0 4081.4 1243.8 1274.9 1297.7 1299.1 1313.3 963.5 967.9 970.9 979.0 1006.6 5925.2 6067.8 6073.1 6080.5 6118.0 909.6 950.8 977.6 979.2 1023.9 3961.6 4128.7 4186.5 4211.8 4228.3 10908.9 11272.0 11276.1 11357.6 11463.7 11226.6 11245.4 11246.4 11257.7 11259.2 7900.7 8244.6 8244.9 8360.7 8411.9 5683.0 6036.2 6100.2 6133.6 6207.6 10308.1 10318.2 10543.5 10625.1 10672.6 10418.3 10645.8 10721.1 10734.1 10747.5 7279.6 7695.8 7977.9 8110.4 8245.6 8747.5 8889.4 8900.2 8934.3 8968.8 7843.9 7994.5 8088.8 8097.8 8108.7 7589.7 7818.0 7917.2 7926.0 8065.6 6688.8 6689.6 6831.1 6842.2 6843.7 4873.1 4925.9 4991.6 5044.2 5059.7 5185.9 5240.5 5272.7 5275.7 5296.9 02:39:34 INFO - PROCESS | 17069 | 02:39:34 INFO - PROCESS | 17069 | [#4] prototype.html Cycles:180 Average:4861.18 Median:5534.00 stddev:1444.65 (26.1%) stddev-sans-first:1408.03 02:39:34 INFO - PROCESS | 17069 | Values: 326.4 334.5 337.5 338.6 344.1 5489.0 5574.7 5649.5 5657.6 5690.9 5543.3 5589.2 5608.6 5612.3 5622.7 4351.7 4366.3 4367.0 4367.4 4381.5 4047.4 4246.9 4255.0 4261.2 4268.1 4235.7 4249.2 4252.8 4253.4 4267.8 4211.2 4314.1 4323.9 4325.2 4340.5 3702.9 3703.8 3787.4 3790.8 3794.5 5391.9 5411.2 5412.9 5421.6 5436.8 4919.4 4921.8 4925.5 4932.8 4935.7 5564.2 5796.9 5801.4 5821.2 5824.1 4105.7 4120.0 4120.2 4155.4 4163.3 5708.2 5806.7 5972.0 6002.6 6047.3 4167.8 4190.9 4193.9 4206.3 4214.8 4171.5 4209.8 4261.3 4264.0 4269.3 4756.3 4875.2 4891.9 4949.4 4986.5 5772.2 5840.4 5865.6 5885.4 5894.9 1456.4 1467.8 1481.7 1490.3 1495.2 907.4 940.6 942.8 953.5 968.2 4863.2 4943.5 4964.5 4978.8 5000.7 5177.3 5185.0 5271.8 5296.3 5371.6 4970.4 4997.2 5081.8 5197.9 5690.6 3214.4 3240.2 3263.0 3263.2 3272.9 6108.8 6146.3 6166.9 6174.7 6324.3 6143.9 6152.3 6164.3 6211.5 6238.8 6253.5 6272.7 6291.4 6342.0 6360.7 5809.2 6067.8 6068.8 6097.8 6101.4 5946.4 5950.2 5972.2 6045.0 6048.4 5972.3 6003.6 6161.4 6174.1 6188.5 4214.9 4245.4 4258.8 4274.5 4280.9 5946.5 6090.0 6111.2 6119.8 6156.6 5781.0 5819.0 5836.9 5856.7 5926.3 5846.6 5855.0 5876.0 5892.1 5924.1 5593.6 5676.8 5780.2 5784.1 5788.8 5840.4 5896.0 5914.0 5925.4 5935.0 5524.7 5696.2 5737.5 5744.3 5785.7 02:39:34 INFO - PROCESS | 17069 | 02:39:34 INFO - PROCESS | 17069 | [#5] yui.html Cycles:180 Average:19829.04 Median:25586.54 stddev:27800.78 (108.7%) stddev-sans-first:27841.77 02:39:34 INFO - PROCESS | 17069 | Values: 726.7 739.9 787.2 812.1 845.8 12615.7 13002.1 13043.1 13073.2 13084.8 13619.3 13674.9 13831.4 15349.5 15420.9 818.7 818.8 826.9 827.5 828.9 770.5 826.4 829.1 831.5 832.6 849.0 853.2 856.9 858.8 860.8 853.0 853.2 855.4 856.0 856.2 621.6 623.1 623.3 623.7 624.6 14273.5 14282.4 14322.8 14329.4 14331.9 14601.3 14631.6 14632.9 14687.2 14714.1 11339.6 11744.9 11771.2 11804.4 12240.3 3787.3 3838.8 3964.0 4034.8 4035.8 74602.6 75926.0 76217.6 76427.2 76622.6 11441.7 11609.8 11639.3 11708.9 11713.6 21518.0 21636.2 21664.8 21739.8 21866.3 8518.1 8532.8 8796.3 8821.6 8986.0 4759.2 4914.3 4942.7 4978.9 4996.6 3573.8 3621.2 3691.1 3703.3 3703.6 600.0 602.8 605.6 615.3 618.8 705.9 721.3 748.7 752.8 767.1 9464.6 9472.8 9501.0 9663.2 9670.9 692.5 701.0 720.2 734.3 736.3 4538.5 4602.7 4669.1 4677.7 4755.1 108143.0 109405.0 109432.5 111038.4 115932.4 82483.0 89455.6 92825.5 94037.5 94307.0 53155.5 69672.3 73815.9 82504.0 86887.6 9690.2 10488.9 10493.4 10607.8 10613.5 48083.3 48092.3 49689.0 50664.2 51489.7 46570.4 64092.0 70421.0 70858.3 76021.6 12968.8 13192.1 13221.7 13420.7 13693.9 15433.8 15438.0 15465.4 15477.9 15484.2 13357.3 13920.5 13950.7 14431.2 14457.3 13983.3 14450.2 14675.7 15161.2 15198.6 10813.8 13476.9 14118.9 14516.4 14520.5 11218.3 11298.3 11580.4 11682.7 11981.0 11298.4 11319.5 11328.8 11797.2 11835.6 02:39:34 INFO - PROCESS | 17069 | -------- Summary: end -------- 02:39:34 INFO - PROCESS | 17069 | 02:39:35 INFO - TEST-INFO | 17069: exit 0 02:39:35 INFO - TEST-OK | dromaeo_css | took 1111843ms 02:39:35 INFO - TEST-START | kraken 02:39:35 INFO - operating with platform_type : linux_ 02:39:35 INFO - Initialising browser for kraken test... 02:39:35 INFO - TEST-INFO | started process 17304 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfAkdyn/profile http://localhost:38728/getInfo.html) 02:39:39 INFO - PROCESS | 17304 | __metrics Screen width/height:1600/1200 02:39:39 INFO - PROCESS | 17304 | colorDepth:24 02:39:39 INFO - PROCESS | 17304 | Browser inner width/height: 1024/697 02:39:39 INFO - PROCESS | 17304 | __metrics 02:39:40 ERROR - PROCESS | 17304 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 02:39:41 INFO - TEST-INFO | 17304: exit 0 02:39:41 INFO - Browser initialized. 02:39:41 INFO - Running cycle 1/1 for kraken test... 02:39:41 INFO - TEST-INFO | started process 17421 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfAkdyn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:39:53 INFO - PROCESS | 17421 | RSS: Main: 184709120 02:39:53 INFO - PROCESS | 17421 | 02:39:55 INFO - PROCESS | 17421 | Cycle 1(1): loaded http://localhost:38728/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38728/tests/kraken/driver.html?testName=audio-beat-detection) 02:39:56 INFO - PROCESS | 17421 | RSS: Main: 190611456 02:39:56 INFO - PROCESS | 17421 | 02:39:59 INFO - PROCESS | 17421 | Cycle 1(1): loaded http://localhost:38728/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38728/tests/kraken/driver.html?testName=audio-dft) 02:40:00 INFO - PROCESS | 17421 | RSS: Main: 190705664 02:40:00 INFO - PROCESS | 17421 | 02:40:03 INFO - PROCESS | 17421 | Cycle 1(1): loaded http://localhost:38728/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38728/tests/kraken/driver.html?testName=audio-fft) 02:40:03 INFO - PROCESS | 17421 | RSS: Main: 185360384 02:40:03 INFO - PROCESS | 17421 | 02:40:06 INFO - PROCESS | 17421 | Cycle 1(1): loaded http://localhost:38728/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38728/tests/kraken/driver.html?testName=audio-oscillator) 02:40:06 INFO - PROCESS | 17421 | RSS: Main: 186105856 02:40:06 INFO - PROCESS | 17421 | 02:40:08 INFO - PROCESS | 17421 | Cycle 1(1): loaded http://localhost:38728/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38728/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:40:09 INFO - PROCESS | 17421 | RSS: Main: 186490880 02:40:09 INFO - PROCESS | 17421 | 02:40:12 INFO - PROCESS | 17421 | Cycle 1(1): loaded http://localhost:38728/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38728/tests/kraken/driver.html?testName=imaging-darkroom) 02:40:13 INFO - PROCESS | 17421 | RSS: Main: 186789888 02:40:13 INFO - PROCESS | 17421 | 02:40:16 INFO - PROCESS | 17421 | Cycle 1(1): loaded http://localhost:38728/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38728/tests/kraken/driver.html?testName=imaging-desaturate) 02:40:17 INFO - PROCESS | 17421 | RSS: Main: 183742464 02:40:17 INFO - PROCESS | 17421 | 02:40:20 INFO - PROCESS | 17421 | Cycle 1(1): loaded http://localhost:38728/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38728/tests/kraken/driver.html?testName=json-parse-financial) 02:40:20 INFO - PROCESS | 17421 | RSS: Main: 184946688 02:40:20 INFO - PROCESS | 17421 | 02:40:22 INFO - PROCESS | 17421 | Cycle 1(1): loaded http://localhost:38728/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38728/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:40:22 INFO - PROCESS | 17421 | RSS: Main: 185733120 02:40:22 INFO - PROCESS | 17421 | 02:40:24 INFO - PROCESS | 17421 | Cycle 1(1): loaded http://localhost:38728/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38728/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:40:25 INFO - PROCESS | 17421 | RSS: Main: 185614336 02:40:25 INFO - PROCESS | 17421 | 02:40:27 INFO - PROCESS | 17421 | Cycle 1(1): loaded http://localhost:38728/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38728/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:40:28 INFO - PROCESS | 17421 | RSS: Main: 186318848 02:40:28 INFO - PROCESS | 17421 | 02:40:30 INFO - PROCESS | 17421 | Cycle 1(1): loaded http://localhost:38728/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38728/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:40:31 INFO - PROCESS | 17421 | RSS: Main: 186179584 02:40:31 INFO - PROCESS | 17421 | 02:40:34 INFO - PROCESS | 17421 | Cycle 1(1): loaded http://localhost:38728/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38728/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:40:34 INFO - PROCESS | 17421 | RSS: Main: 186007552 02:40:34 INFO - PROCESS | 17421 | 02:40:36 INFO - PROCESS | 17421 | Cycle 1(1): loaded http://localhost:38728/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38728/tests/kraken/driver.html?testName=ai-astar) 02:40:36 INFO - PROCESS | 17421 | RSS: Main: 187125760 02:40:36 INFO - PROCESS | 17421 | 02:40:36 INFO - PROCESS | 17421 | __start_tp_report 02:40:36 INFO - PROCESS | 17421 | _x_x_mozilla_page_load 02:40:36 INFO - PROCESS | 17421 | _x_x_mozilla_page_load_details 02:40:36 INFO - PROCESS | 17421 | |i|pagename|runs| 02:40:36 INFO - PROCESS | 17421 | |0;ai-astar;113;107;113;111;111;112;111;111;112;114 02:40:36 INFO - PROCESS | 17421 | |1;audio-beat-detection;151;127;154;171;129;162;156;130;201;131 02:40:36 INFO - PROCESS | 17421 | |2;audio-dft;165;164;165;163;171;167;167;164;163;165 02:40:36 INFO - PROCESS | 17421 | |3;audio-fft;76;76;75;164;76;76;74;75;163;74 02:40:36 INFO - PROCESS | 17421 | |4;audio-oscillator;87;85;145;85;87;86;132;86;85;144 02:40:36 INFO - PROCESS | 17421 | |5;imaging-gaussian-blur;118;118;118;118;118;117;118;118;118;118 02:40:36 INFO - PROCESS | 17421 | |6;imaging-darkroom;147;148;146;147;148;148;148;147;148;148 02:40:36 INFO - PROCESS | 17421 | |7;imaging-desaturate;95;96;95;96;96;95;95;96;96;95 02:40:36 INFO - PROCESS | 17421 | |8;json-parse-financial;59;61;58;57;60;60;58;61;58;58 02:40:36 INFO - PROCESS | 17421 | |9;json-stringify-tinderbox;62;61;62;61;62;62;62;62;62;62 02:40:36 INFO - PROCESS | 17421 | |10;stanford-crypto-aes;87;84;81;87;84;84;84;91;106;88 02:40:36 INFO - PROCESS | 17421 | |11;stanford-crypto-ccm;129;134;131;139;123;125;123;123;131;131 02:40:36 INFO - PROCESS | 17421 | |12;stanford-crypto-pbkdf2;163;164;163;163;159;162;165;161;161;162 02:40:36 INFO - PROCESS | 17421 | |13;stanford-crypto-sha256-iterative;64;63;64;64;65;62;67;63;68;65 02:40:36 INFO - PROCESS | 17421 | __end_tp_report 02:40:36 INFO - PROCESS | 17421 | __start_cc_report 02:40:36 INFO - PROCESS | 17421 | _x_x_mozilla_cycle_collect,928 02:40:36 INFO - PROCESS | 17421 | __end_cc_report 02:40:36 INFO - PROCESS | 17421 | __startTimestamp1465983636778__endTimestamp 02:40:36 INFO - PROCESS | 17421 | 02:40:36 INFO - PROCESS | 17421 | ------- Summary: start ------- 02:40:36 INFO - PROCESS | 17421 | Number of tests: 14 02:40:36 INFO - PROCESS | 17421 | 02:40:36 INFO - PROCESS | 17421 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.00 stddev:1.90 (1.7%) stddev-sans-first:1.94 02:40:36 INFO - PROCESS | 17421 | Values: 113.0 107.0 113.0 111.0 111.0 112.0 111.0 111.0 112.0 114.0 02:40:36 INFO - PROCESS | 17421 | 02:40:36 INFO - PROCESS | 17421 | [#1] audio-beat-detection Cycles:10 Average:151.20 Median:155.00 stddev:23.47 (15.1%) stddev-sans-first:24.89 02:40:36 INFO - PROCESS | 17421 | Values: 151.0 127.0 154.0 171.0 129.0 162.0 156.0 130.0 201.0 131.0 02:40:36 INFO - PROCESS | 17421 | 02:40:36 INFO - PROCESS | 17421 | [#2] audio-dft Cycles:10 Average:165.40 Median:165.00 stddev:2.41 (1.5%) stddev-sans-first:2.55 02:40:36 INFO - PROCESS | 17421 | Values: 165.0 164.0 165.0 163.0 171.0 167.0 167.0 164.0 163.0 165.0 02:40:36 INFO - PROCESS | 17421 | 02:40:36 INFO - PROCESS | 17421 | [#3] audio-fft Cycles:10 Average:92.90 Median:75.50 stddev:37.22 (49.3%) stddev-sans-first:38.97 02:40:36 INFO - PROCESS | 17421 | Values: 76.0 76.0 75.0 164.0 76.0 76.0 74.0 75.0 163.0 74.0 02:40:36 INFO - PROCESS | 17421 | 02:40:36 INFO - PROCESS | 17421 | [#4] audio-oscillator Cycles:10 Average:102.20 Median:85.50 stddev:26.54 (31.0%) stddev-sans-first:27.58 02:40:36 INFO - PROCESS | 17421 | Values: 87.0 85.0 145.0 85.0 87.0 86.0 132.0 86.0 85.0 144.0 02:40:36 INFO - PROCESS | 17421 | 02:40:36 INFO - PROCESS | 17421 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 02:40:36 INFO - PROCESS | 17421 | Values: 118.0 118.0 118.0 118.0 118.0 117.0 118.0 118.0 118.0 118.0 02:40:36 INFO - PROCESS | 17421 | 02:40:36 INFO - PROCESS | 17421 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.71 (0.5%) stddev-sans-first:0.73 02:40:36 INFO - PROCESS | 17421 | Values: 147.0 148.0 146.0 147.0 148.0 148.0 148.0 147.0 148.0 148.0 02:40:36 INFO - PROCESS | 17421 | 02:40:36 INFO - PROCESS | 17421 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 02:40:36 INFO - PROCESS | 17421 | Values: 95.0 96.0 95.0 96.0 96.0 95.0 95.0 96.0 96.0 95.0 02:40:36 INFO - PROCESS | 17421 | 02:40:36 INFO - PROCESS | 17421 | [#8] json-parse-financial Cycles:10 Average:59.00 Median:59.50 stddev:1.41 (2.4%) stddev-sans-first:1.50 02:40:36 INFO - PROCESS | 17421 | Values: 59.0 61.0 58.0 57.0 60.0 60.0 58.0 61.0 58.0 58.0 02:40:36 INFO - PROCESS | 17421 | 02:40:36 INFO - PROCESS | 17421 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:62.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 02:40:36 INFO - PROCESS | 17421 | Values: 62.0 61.0 62.0 61.0 62.0 62.0 62.0 62.0 62.0 62.0 02:40:36 INFO - PROCESS | 17421 | 02:40:36 INFO - PROCESS | 17421 | [#10] stanford-crypto-aes Cycles:10 Average:87.60 Median:85.50 stddev:7.04 (8.2%) stddev-sans-first:7.47 02:40:36 INFO - PROCESS | 17421 | Values: 87.0 84.0 81.0 87.0 84.0 84.0 84.0 91.0 106.0 88.0 02:40:36 INFO - PROCESS | 17421 | 02:40:36 INFO - PROCESS | 17421 | [#11] stanford-crypto-ccm Cycles:10 Average:128.90 Median:131.00 stddev:5.38 (4.1%) stddev-sans-first:5.71 02:40:36 INFO - PROCESS | 17421 | Values: 129.0 134.0 131.0 139.0 123.0 125.0 123.0 123.0 131.0 131.0 02:40:36 INFO - PROCESS | 17421 | 02:40:36 INFO - PROCESS | 17421 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.30 Median:163.00 stddev:1.70 (1.0%) stddev-sans-first:1.79 02:40:36 INFO - PROCESS | 17421 | Values: 163.0 164.0 163.0 163.0 159.0 162.0 165.0 161.0 161.0 162.0 02:40:36 INFO - PROCESS | 17421 | 02:40:36 INFO - PROCESS | 17421 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.50 Median:64.50 stddev:1.84 (2.9%) stddev-sans-first:1.94 02:40:36 INFO - PROCESS | 17421 | Values: 64.0 63.0 64.0 64.0 65.0 62.0 67.0 63.0 68.0 65.0 02:40:36 INFO - PROCESS | 17421 | -------- Summary: end -------- 02:40:36 INFO - PROCESS | 17421 | 02:40:37 INFO - TEST-INFO | 17421: exit 0 02:40:37 INFO - TEST-OK | kraken | took 62505ms 02:40:37 INFO - SUITE-END | took 1174s 02:40:37 INFO - Completed test suite (00:19:34) 02:40:37 INFO - javascript benchmark 02:40:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7289.290726205026, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3135.6550779414265, 3153.369326134772, 3177.0786471923143, 3180.697833705798, 3188.52172174174, 5438.238646589481, 5473.042217611917, 5498.725063746811, 5557.138643510252, 5576.079946808772, 5273.630845840793, 5401.135818269077, 5407.540359069484, 5497.835064948048, 5498.367687715914, 4866.367372241612, 4980.825671101494, 5012.198048312271, 5072.289879416885, 5132.281480592701, 4949.381327334083, 5160.277561141444, 5176.792928282883, 5188.896222075557, 5190.429052804188, 4866.902661946777, 4934.679245849008, 4952.678075925053, 5055.797768089272, 5071.061853557086, 4898.5591296783105, 4898.877528061791, 4908.656394052417, 4922.680025798311, 4939.851804445872, 4921.8523444296725, 4926.5812405945535, 4937.037277730844, 4960.2063669813015, 4974.37820272466, 5348.491893270172, 5376.973115134399, 5456.61803673743, 5477.123660214346, 5484.122540393518, 5773.826785196451, 5795.275590551181, 5811.79658711943, 5812.041013232812, 5840.503557197643, 5728.971355143198, 5891.027980383232, 5892.970535147339, 5895.145203945447, 5901.970490147564, 5448.046591846451, 5463.31708536433, 5490.505854473076, 5509.311336082989, 5532.723363831792, 5990.460858522754, 6001.339852616209, 6002.759889604455, 6017.879642407127, 6038.033914573647, 5657.830265092054, 5722.456366645162, 5768.538516918637, 5778.711064446761, 5806.44838740319, 5814.0, 5909.231799866076, 5916.319623243382, 5935.584509084409, 5972.970135149383, 5606.131049687305, 5714.285714285715, 5807.419258074159, 5877.118432235199, 5917.585768996215, 5758.568107391962, 5808.564357673107, 5840.036393995028, 5847.298324201123, 5855.765769369177, 4454.510003899569, 4482.887927801831, 4495.865124046284, 4515.616172625298, 4532.909341813145, 3975.5030621172355, 3989.9027767363627, 4006.759594424344, 4013.3979903014783, 4045.0, 5438.728063596884, 5475.397706252309, 5538.701049858324, 5539.2522009529, 5539.695316757617, 5833.38749431312, 5846.356900740915, 5891.410858914074, 5930.644161350333, 5937.465628093406, 5538.723063846872, 5548.223248745179, 5552.805651802168, 5561.6663000219305, 5571.247881536022, 4973.701577905337, 4999.975000124976, 5027.170516864677, 5052.72210028452, 5054.393472783216, 6041.72812223451, 6042.667653279024, 6048.183495228176, 6048.364921683248, 6058.787942421994, 5794.739236734441, 5874.0, 5878.441548052928, 5897.616654917417, 5903.645781253139, 6035.486983606267, 6084.817455476343, 6106.053561697944, 6138.846528836815, 6146.6004709693725, 5802.854928626818, 5835.095560188178, 5835.912461313169, 5837.416258374129, 5848.64908105515, 5765.509931655856, 5843.94156058451, 5949.434803693643, 5958.523318134626, 5966.701664916824, 5571.05292100352, 5706.2011318414625, 5746.252987111816, 5752.942470575241, 5772.163036359789, 5658.292713410824, 5683.119116536944, 5693.3168019837885, 5773.134029895549, 5793.884122317446, 5699.5155411790465, 5706.857328566819, 5707.743151558107, 5713.514351280188, 5719.256496655408, 5580.414056524007, 5638.01334766406, 5725.4560816724015, 5782.5952183348445, 5793.94206057934, 5570.888582228252, 5573.414791446839, 5606.271184745957, 5612.7754889803955, 5618.88762224745], "value": 5400.516151861382, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.3484514766037, 620.6617393520531, 626.4800215820866, 646.5248042688625, 647.7085311609777, 36960.81519592401, 40447.79776101119, 40843.59156408435, 40892.79553602228, 40945.79527102364, 40916.79541602288, 41572.79213603935, 41592.0, 41634.791826040826, 41661.58338416615, 8741.868871966926, 8818.382713210078, 8896.822063558724, 8915.955420222923, 8917.95541022294, 8712.738617841474, 8785.64857405703, 8789.25291350236, 8804.779880502974, 8805.0, 8757.343199260049, 8768.167024132697, 8771.210591046836, 8771.473711577293, 8807.471551706885, 8868.068852770431, 8870.15733505316, 8887.911120888773, 8891.0, 8923.375363724543, 8785.209331160226, 8825.602847871862, 8839.071897450804, 8893.11068893112, 8894.73315800527, 38859.41710874339, 39021.0, 39123.0, 39147.0, 39266.0, 3561.5726112866623, 4078.062045729499, 4285.785710714483, 4295.140971805651, 4403.493598236212, 31951.0, 32275.83862080698, 32344.514832277535, 33266.0, 33308.66691333104, 4214.683898707609, 4241.130568233505, 4245.469316335458, 4290.356446533014, 4292.184484947881, 339285.0, 339945.0, 342301.0, 344600.2769986159, 344963.0, 55096.0, 55206.0, 55356.44643553513, 55587.0, 55732.72133639387, 35128.47307290393, 35542.46686299708, 36150.45774313388, 58971.70514147402, 59315.0, 16326.918365408335, 16537.338506459608, 16546.66906661884, 16653.250603722863, 16660.58348541272, 12649.93675031619, 12680.6829829255, 12720.809187862189, 12736.681582960315, 12862.807057894139, 19100.904495477433, 19171.520711982314, 19172.424827255203, 19220.903895480435, 19339.80660193408, 7052.753153639598, 7258.201597824235, 7284.453665975073, 7317.890231646529, 7349.154847192534, 1016.8118898003893, 1018.2617602238317, 1059.708580140452, 1188.976220475603, 1196.186593116689, 31500.684993150233, 31970.520442193385, 32018.519722204186, 32263.0, 32271.193220169684, 1109.778044391125, 1131.6378758797107, 1132.6828488023366, 1183.7454947186225, 1184.0350114656528, 16712.49862504127, 16789.1605419731, 16936.0, 16999.66000680004, 17170.484885453458, 561596.0, 562968.0, 564400.0, 565725.0, 565948.0, 56133.43866561364, 56548.324358916536, 56772.716136419054, 56815.71592142013, 57315.0, 1333.8132661427408, 1335.746208220435, 1372.444160115135, 1383.9446422143, 1411.1885665742238, 30273.0, 30875.536866947463, 31358.843205783825, 31660.683393165775, 31696.36607267888, 48297.0, 48573.51426485831, 48891.75554122207, 48976.755116224194, 49168.75415622899, 353679.0, 354014.0, 354619.0, 357878.0, 359595.0, 26408.8679556601, 27821.860890695418, 27885.58171627468, 27950.16149515518, 28054.57918131189, 41152.794236028625, 45110.32334514919, 47830.521694782605, 48680.0, 48824.0, 39397.2120557593, 39591.0, 40887.16007779717, 40984.0, 41019.17961640691, 39930.40104398378, 39972.600273998054, 40210.39684404678, 40490.0, 40766.0, 38533.4219986706, 43391.78304108459, 43947.78026109849, 46500.53499464962, 47117.29324060073, 39208.0, 42971.57028429801, 43696.78151609222, 43750.78124609484, 44222.557774421846, 33855.492167617995, 34773.47839782355, 34784.130396740286, 35010.29979400449, 35037.82481087578], "value": 19998.78113292444, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.53783690652756, 391.77472953052, 392.9567747547769, 395.0636990332911, 413.18189983832013, 13665.0, 14308.642283942907, 17755.467335979924, 19387.224511019558, 19431.222751089957, 17488.562785930357, 18308.542286442847, 18644.627107457844, 18986.145623446944, 19193.232270709155, 5670.659760414368, 5739.856503587423, 5777.335606405254, 5858.970705146468, 5878.794242201524, 5784.3058832940105, 5790.392008839074, 5824.767009319622, 5827.854303642401, 5840.386759390245, 5263.842084737464, 5575.442455754433, 5649.915251271234, 5767.33675627304, 5808.12878068289, 5489.231507588941, 5516.696581688006, 5528.668279903179, 5535.446455354472, 5553.055980483327, 5521.613487055908, 5585.385607583163, 5603.299587551556, 5608.327000759894, 5611.775528978836, 13757.518486852912, 13786.0, 13863.653408664864, 16196.190190490428, 21390.251341202984, 2269.841111122222, 2303.332033710222, 2346.9178578749834, 2349.624060150385, 2492.6385674077155, 9702.757431064209, 9862.161716254128, 9971.700848974542, 10353.689389318333, 11971.880281197164, 1791.937282195117, 1821.4535639308156, 1911.961760764777, 1916.1090093106773, 1936.1384184038109, 59722.0, 68896.6555167226, 71024.0, 75016.62491687562, 79120.0, 9394.67118650844, 10301.175905927508, 10658.0, 10686.0, 10919.781604367869, 14890.92554537242, 14941.17823519695, 15041.623959400884, 15083.095014299177, 15097.169655669044, 7978.920210797934, 8019.238172373615, 8086.676532938734, 8205.384596155312, 8286.958565207135, 7781.45529812919, 7811.765647030598, 7833.451658383859, 7869.2130786922, 7943.960280198562, 4624.768761561909, 4740.431148262231, 4817.229243321051, 4828.130936431476, 4847.151748444008, 1932.5748335366197, 1966.8235799184215, 1978.6339527187517, 1990.5222746540726, 2006.2175751456944, 917.9586918588546, 971.3006635222629, 1010.9595616175418, 1032.9876720813495, 1055.5302890213782, 17854.0, 17864.91067544654, 18739.531511712044, 19080.522986925436, 19261.13324900383, 974.965876194344, 993.3096497934011, 1020.9387436753818, 1020.9586222053464, 1024.2727663359099, 10144.898551014543, 10146.594136234615, 10816.188785840935, 10875.0, 10974.835377469344, 515104.0, 520556.0, 530096.0, 539211.0, 543926.0, 70451.64774176096, 89943.0, 92284.53857730668, 93415.53292233631, 94027.52986235161, 992.5583115513672, 1028.3007554862616, 1029.4132344563527, 1031.7369070887025, 1034.8706411698538, 16478.83521164821, 17011.829881701025, 17332.82667173312, 17716.468505944842, 17824.0, 39529.0, 40439.595604043585, 40999.7950010248, 41295.1740965185, 41453.378199327635, 49745.75127124341, 50851.0, 53003.734981324844, 58785.11822322754, 59080.704596476746, 8173.877391839246, 8503.617337219963, 8609.440386374865, 8685.826283474422, 8825.02924678272, 11705.765884682089, 12233.755324893631, 12565.246085234916, 13503.662408439868, 13510.0, 11420.828687569527, 11511.712207194887, 11574.88425115738, 11873.287602743518, 12009.159358844798, 11628.418579071182, 11689.181757276909, 11725.824112638487, 11735.413229338328, 11853.34806585646, 11711.472983715583, 11913.82129268079, 11993.220440671328, 12099.516019359478, 12121.333326667118, 7282.890756638549, 7575.0, 7685.269899359552, 8147.14454982242, 8706.825863482822, 10749.408782517037, 11176.0, 11296.661100167008, 11387.544498219979, 11554.76890462203], "value": 8966.981495352478, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1468.0677769616298, 1470.5955862137914, 1595.9042457452554, 1725.6893759123352, 1732.7487514310417, 7758.922410775891, 8414.158584141584, 8558.315334773219, 8973.91026089739, 8978.012418633953, 8613.35399845011, 8786.912130878689, 8993.955030224839, 9003.234725048362, 9006.86489702655, 2274.9090036398566, 2309.9027961718134, 2313.6645186447954, 2327.045911176418, 2330.0, 2295.1393227539675, 2309.1109922679807, 2336.7780060894274, 2340.73081595617, 2357.634566642173, 2328.3015095471374, 2335.0426325206668, 2344.4842134730416, 2356.3402247370677, 2356.7878890899815, 2233.3076746208567, 2245.910733294351, 2247.5617254635354, 2248.4603695113137, 2249.7862703043265, 2247.0899285789283, 2252.583272094668, 2257.3566533537864, 2264.0943622551113, 2267.648514480258, 8949.284057275467, 8975.147361000694, 8977.775555611097, 9000.099990001014, 9027.4132181408, 5216.634835561512, 5298.337707786527, 5302.734863256822, 5345.465453454663, 5346.465353464661, 3087.8919237826794, 3169.35028319194, 3315.784474009206, 3357.7649564530493, 3367.4275373186615, 1085.625459216569, 1086.5653738504582, 1090.6182836007413, 1093.6281664234118, 1122.0, 12446.81329780054, 12467.625971220878, 12511.186772859735, 12529.310887901252, 12538.811917821331, 4604.470485894098, 4689.320048592935, 4749.62003039756, 4751.40607424072, 4781.95218047822, 10388.532516036796, 10395.0, 10410.167186625053, 10418.11446027081, 10425.270231083752, 5126.7180305083575, 5242.7640756166065, 5257.158854583325, 5272.92090618641, 5296.523312901857, 4167.395727619539, 4815.855524334275, 4838.467768545527, 4943.258511223274, 4955.182394904872, 3935.4687117238805, 3947.3289540778137, 4061.472008638858, 4076.9796151019054, 4081.4490043844294, 1243.7823380908485, 1274.8526326306212, 1297.7469393468373, 1299.0841456772953, 1313.3039489070807, 963.5471328475745, 967.883853937532, 970.8786401699788, 979.0, 1006.6426418621284, 5925.170476133345, 6067.848303792441, 6073.08903664445, 6080.513558915364, 6118.0, 909.5634095634133, 950.7955789505289, 977.5503268496429, 979.1530326267728, 1023.8566600675912, 3961.603839616015, 4128.690348223895, 4186.497620285585, 4211.810468528863, 4228.2600544905135, 10908.890911090788, 11272.041876440431, 11276.097912167006, 11357.602483913024, 11463.713407164887, 11226.550937962553, 11245.381504017358, 11246.381449020218, 11257.71855703614, 11259.211855170059, 7900.723474678359, 8244.628991695388, 8244.917550824415, 8360.665573376997, 8411.915880841114, 5683.0, 6036.154938308552, 6100.23747031621, 6133.601315914451, 6207.596506227081, 10308.12380947628, 10318.17454603645, 10543.472826358804, 10625.149988000787, 10672.57309707634, 10418.270721049454, 10645.787084258116, 10721.142308615135, 10734.087602553558, 10747.46262686847, 7279.599622020628, 7695.769126926201, 7977.92022079795, 8110.391720621095, 8245.628946697532, 8747.475151490931, 8889.377743557889, 8900.198982091642, 8934.28525717954, 8968.820623587622, 7843.882341764992, 7994.5203287802915, 8088.757337279891, 8097.797555061171, 8108.675652973815, 7589.734359297398, 7818.022747156606, 7917.208279172037, 7926.009248843895, 8065.637046332812, 6688.83277918056, 6689.565178263398, 6831.146106736658, 6842.213145488134, 6843.692033858588, 4873.147199240189, 4925.916298414343, 4991.625628077982, 5044.218146187347, 5059.747012649426, 5185.870353241199, 5240.528352448298, 5272.7100009499845, 5275.7362131894015, 5296.867578310573], "value": 4681.35238128551, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.36033374585827, 334.5416779012752, 337.5004992610936, 338.55818157304725, 344.1087583159616, 5489.039418101836, 5574.693391863446, 5649.519790817785, 5657.5856035991, 5690.9146362804595, 5543.279373681416, 5589.189567512708, 5608.61633805632, 5612.298462692163, 5622.746976386063, 4351.73889566627, 4366.257736184841, 4366.97816510917, 4367.366731823891, 4381.518033016366, 4047.394774676519, 4246.851360202393, 4254.957450425487, 4261.190373828978, 4268.146370725852, 4235.729281215638, 4249.1714115747445, 4252.766097864616, 4253.383259427396, 4267.765272909989, 4211.199872024321, 4314.1371725654835, 4323.913521729579, 4325.178216138924, 4340.52254252032, 3702.87039953603, 3703.8147792706345, 3787.3561494545993, 3790.753601015953, 3794.544654641433, 5391.919121213185, 5411.18832175173, 5412.864678383072, 5421.566274698014, 5436.782528698847, 4919.434265059493, 4921.753912304406, 4925.532074452921, 4932.802687892516, 4935.679180853233, 5564.1931919871795, 5796.942030579682, 5801.3618501965175, 5821.243238379026, 5824.068149096124, 4105.712600117993, 4120.0, 4120.196561670476, 4155.397467367215, 4163.271427500205, 5708.172315014342, 5806.6516009040015, 5971.970140149315, 6002.559385747433, 6047.304559975615, 4167.791610419466, 4190.916181676349, 4193.874183774492, 4206.26390381682, 4214.810333534998, 4171.520275168334, 4209.768462734518, 4261.296886013835, 4264.0, 4269.252880745857, 4756.262779269219, 4875.171220892456, 4891.902161956741, 4949.406071271471, 4986.501349865057, 5772.163036359789, 5840.3575606683235, 5865.618734782311, 5885.440883116097, 5894.8821023579285, 1456.4392708806974, 1467.7798330250334, 1481.6666250093858, 1490.299559207171, 1495.2075400037997, 907.3920473282916, 940.6472572785206, 942.8261814041562, 953.5280036382036, 968.1722127580957, 4863.1732605457155, 4943.480934501826, 4964.510646805944, 4978.809323897473, 5000.724960127155, 5177.301064356339, 5185.0, 5271.841844744664, 5296.3379577552805, 5371.62398632092, 4970.353853998957, 4997.225430058346, 5081.780372710523, 5197.870053248624, 5690.573207009491, 3214.421404147229, 3240.238543942172, 3262.983685081607, 3263.2494526259093, 3272.885449009273, 6108.816735497942, 6146.262448506119, 6166.876662466726, 6174.660393678301, 6324.33594472583, 6143.92481315768, 6152.2924863640355, 6164.291106522807, 6211.503079753609, 6238.844028899314, 6253.53098517613, 6272.655003974825, 6291.402316779899, 6342.016987366873, 6360.745570177233, 5809.215755872903, 6067.787627433018, 6068.848278793065, 6097.75608975636, 6101.359357267601, 5946.443029497184, 5950.166976623363, 5972.163897054329, 6044.969775151096, 6048.395160484092, 5972.283326000907, 6003.609765365237, 6161.44546990773, 6174.104754810617, 6188.504919606511, 4214.925194075491, 4245.405643209891, 4258.829646814217, 4274.529801721746, 4280.935785963151, 5946.494547963472, 6090.0, 6111.205543279345, 6119.816405507842, 6156.630602163885, 5781.0, 5819.0, 5836.941630583639, 5856.677882716492, 5926.348101708895, 5846.590738648254, 5855.0, 5876.0, 5892.143974647972, 5924.140999555127, 5593.552515798808, 5676.829695109153, 5780.248567686174, 5784.1034639630925, 5788.797392091256, 5840.415958404125, 5895.970520147372, 5914.0, 5925.4370834770625, 5934.97032514852, 5524.723763811713, 5696.20253164549, 5737.483626473638, 5744.253247077853, 5785.669296061845], "value": 4396.854277767731, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [726.654838951498, 739.8668239716849, 787.1577412168978, 812.122907260159, 845.7631863078338, 12615.747685046304, 13002.089853710244, 13043.086983911106, 13073.215607063583, 13084.803727944076, 13619.319034048307, 13674.863251367484, 13831.446742130327, 15349.462768803094, 15420.922895385536, 818.6807145213371, 818.8321394114192, 826.8925039744855, 827.5117680568463, 828.9212524810164, 770.4760762681375, 826.3678286111129, 829.1418381974657, 831.5094094484253, 832.5712258187039, 849.0321034021221, 853.1724227499346, 856.9271611912994, 858.8368210040104, 860.8364410761967, 852.9829403411959, 853.1511146409331, 855.4054931822386, 855.9614817333235, 856.1823458597025, 621.6332363905318, 623.0996210475864, 623.2738859228992, 623.7317953280087, 624.6439529468205, 14273.500427485093, 14282.428702851978, 14322.785158222636, 14329.426822927071, 14331.928340358232, 14601.269936503133, 14631.63420914475, 14632.853671463256, 14687.192204428753, 14714.117152970748, 11339.603113891057, 11744.882551174464, 11771.23486973344, 11804.350760708157, 12240.265584064984, 3787.2993496203017, 3838.7888666123354, 3964.0288129408477, 4034.838606455738, 4035.7578545287083, 74602.62698686526, 75926.0, 76217.61891190508, 76427.23572764256, 76622.6168869152, 11441.713957151138, 11609.825852612217, 11639.301641901513, 11708.94145529284, 11713.590024349278, 21517.955794199526, 21636.24273150432, 21664.783352166276, 21739.782602173775, 21866.344009679735, 8518.148185181431, 8532.786680332918, 8796.252318552995, 8821.647134114692, 8985.955070224607, 4759.23852183649, 4914.336564563738, 4942.678725882806, 4978.850634480971, 4996.550310472075, 3573.8213089345427, 3621.239539696693, 3691.0587800110798, 3703.2963736889906, 3703.6111208323277, 600.0249594409086, 602.764921680545, 605.6214865708932, 615.2862679292, 618.848382146377, 705.8800003999332, 721.3255606008399, 748.6743266679013, 752.7741677496729, 767.0718430698805, 9464.621415143318, 9472.763180920532, 9501.0, 9663.178629816404, 9670.854937175947, 692.5083190934392, 701.0010734703129, 720.2077714513993, 734.2694019450681, 736.3041925380571, 4538.500764915857, 4602.7008244464005, 4669.112868554964, 4677.742724150205, 4755.096531659043, 108143.0, 109405.0, 109432.4528377369, 111038.44480777545, 115932.42033789777, 82483.0, 89455.55272223728, 92825.53587232156, 94037.5298123505, 94307.0, 53155.468445315826, 69672.30327696759, 73815.89276160861, 82504.0, 86887.56556217179, 9690.224782017563, 10488.895111048792, 10493.422861742678, 10607.840882386925, 10613.522391492246, 48083.27875081806, 48092.27861582149, 49689.0, 50664.24003639875, 51489.742551287, 46570.37003704854, 64092.0, 70421.0, 70858.29141708722, 76021.6198919024, 12968.8054679178, 13192.142510736772, 13221.669458263621, 13420.731585368434, 13693.931530342285, 15433.768493472831, 15438.0, 15465.381384744484, 15477.922610386877, 15484.225788710293, 13357.332133393485, 13920.51278205258, 13950.651233719238, 14431.2062836545, 14457.349419275948, 13983.300834958009, 14450.205238711971, 14675.706485870009, 15161.166135862191, 15198.620034498783, 10813.837792433276, 13476.865231347561, 14118.858811411754, 14516.401003799197, 14520.491782787552, 11218.270812397168, 11298.265612735146, 11580.36308003068, 11682.70793230176, 11981.041516678819, 11298.435078246219, 11319.547218111513, 11328.830067549157, 11797.233179843282, 11835.585754498552], "value": 7524.381669902534, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1548.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 107.0, 113.0, 111.0, 111.0, 112.0, 111.0, 111.0, 112.0, 114.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 127.0, 154.0, 171.0, 129.0, 162.0, 156.0, 130.0, 201.0, 131.0], "value": 151.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 165.0, 163.0, 171.0, 167.0, 167.0, 164.0, 163.0, 165.0], "value": 165.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 164.0, 76.0, 76.0, 74.0, 75.0, 163.0, 74.0], "value": 92.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 145.0, 85.0, 87.0, 86.0, 132.0, 86.0, 85.0, 144.0], "value": 102.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 146.0, 147.0, 148.0, 148.0, 148.0, 147.0, 148.0, 148.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 58.0, 57.0, 60.0, 60.0, 58.0, 61.0, 58.0, 58.0], "value": 59.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 62.0, 61.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 81.0, 87.0, 84.0, 84.0, 84.0, 91.0, 106.0, 88.0], "value": 87.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 134.0, 131.0, 139.0, 123.0, 125.0, 123.0, 123.0, 131.0, 131.0], "value": 128.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 163.0, 159.0, 162.0, 165.0, 161.0, 161.0, 162.0], "value": 162.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 64.0, 65.0, 62.0, 67.0, 63.0, 68.0, 65.0], "value": 64.5, "unit": "score"}]}]} 02:40:38 INFO - Return code: 0 02:40:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:40:38 ERROR - # TBPL SUCCESS # 02:40:38 INFO - Running post-action listener: _resource_record_post_action 02:40:38 INFO - ##### 02:40:38 INFO - ##### Finished run-tests step (success) 02:40:38 INFO - ##### 02:40:38 INFO - Running post-run listener: _resource_record_post_run 02:40:38 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 558268416; Read time: 16; Write time: 634400 02:40:38 INFO - TinderboxPrint: CPU usage
13.5% 02:40:38 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 02:40:38 INFO - TinderboxPrint: I/O write bytes / time
558,268,416 / 634,400 02:40:38 INFO - TinderboxPrint: CPU idle
8,224.0 (86.5%) 02:40:38 INFO - TinderboxPrint: CPU user
1,225.6 (12.9%) 02:40:38 INFO - TinderboxPrint: Swap in / out
0 / 0 02:40:38 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 265113600; Read time: 0; Write time: 327068 02:40:38 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292511744; Read time: 16; Write time: 307292 02:40:38 INFO - Running post-run listener: _upload_blobber_files 02:40:38 INFO - Blob upload gear active. 02:40:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:40:38 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:40:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:40:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:40:39 INFO - (blobuploader) - INFO - Open directory for files ... 02:40:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:40:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:40:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:40:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:40:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:40:39 INFO - (blobuploader) - INFO - Done attempting. 02:40:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:40:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:40:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:40:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:40:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:40:41 INFO - (blobuploader) - INFO - Done attempting. 02:40:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:40:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:40:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:40:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:40:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:40:45 INFO - (blobuploader) - INFO - Done attempting. 02:40:45 INFO - (blobuploader) - INFO - Iteration through files over. 02:40:45 INFO - Return code: 0 02:40:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:40:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:40:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/47d53b68a31d328398dbb47f0652cb39b62a1f7ea6c2b1b6dac1785abb41fd41fb603807d4cc8d8889cf70bb3b38a04832617508fb68bc81c1b326ba050992d9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/348dd4ad5ee91ef78c3596834224a7c6f734090dd987fafed4593b4384b0c735617227eb2384eebb0731683f4ef80e3af418087156f098d54df3f55863be465d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/148d24bcf33bc08e1912611d10703fa3f4f504dc7f1533c8a477a631b1ab7411166ef2e28855cf271036f6c7619018f953dc70ac0eafd15d5cf86ad501a87ad4"} 02:40:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:40:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:40:45 INFO - Contents: 02:40:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/47d53b68a31d328398dbb47f0652cb39b62a1f7ea6c2b1b6dac1785abb41fd41fb603807d4cc8d8889cf70bb3b38a04832617508fb68bc81c1b326ba050992d9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/348dd4ad5ee91ef78c3596834224a7c6f734090dd987fafed4593b4384b0c735617227eb2384eebb0731683f4ef80e3af418087156f098d54df3f55863be465d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/148d24bcf33bc08e1912611d10703fa3f4f504dc7f1533c8a477a631b1ab7411166ef2e28855cf271036f6c7619018f953dc70ac0eafd15d5cf86ad501a87ad4"} 02:40:45 INFO - Running post-run listener: copy_logs_to_upload_dir 02:40:45 INFO - Copying logs to upload dir... 02:40:45 INFO - mkdir: /builds/slave/test/build/upload/logs 02:40:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.433603 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-06-15 02:40:43.787483) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-15 02:40:43.790998) ========= 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=c6927cf182745ad25b1d38b9000001fe-1465974564.938806-1672166689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/47d53b68a31d328398dbb47f0652cb39b62a1f7ea6c2b1b6dac1785abb41fd41fb603807d4cc8d8889cf70bb3b38a04832617508fb68bc81c1b326ba050992d9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/348dd4ad5ee91ef78c3596834224a7c6f734090dd987fafed4593b4384b0c735617227eb2384eebb0731683f4ef80e3af418087156f098d54df3f55863be465d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/148d24bcf33bc08e1912611d10703fa3f4f504dc7f1533c8a477a631b1ab7411166ef2e28855cf271036f6c7619018f953dc70ac0eafd15d5cf86ad501a87ad4"} build_url:https://queue.taskcluster.net/v1/task/BqmXjc4-T8a-gPRYbhKsXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011496 build_url: 'https://queue.taskcluster.net/v1/task/BqmXjc4-T8a-gPRYbhKsXQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/47d53b68a31d328398dbb47f0652cb39b62a1f7ea6c2b1b6dac1785abb41fd41fb603807d4cc8d8889cf70bb3b38a04832617508fb68bc81c1b326ba050992d9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/348dd4ad5ee91ef78c3596834224a7c6f734090dd987fafed4593b4384b0c735617227eb2384eebb0731683f4ef80e3af418087156f098d54df3f55863be465d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/148d24bcf33bc08e1912611d10703fa3f4f504dc7f1533c8a477a631b1ab7411166ef2e28855cf271036f6c7619018f953dc70ac0eafd15d5cf86ad501a87ad4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-15 02:40:43.817883) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 02:40:43.818302) ========= 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=c6927cf182745ad25b1d38b9000001fe-1465974564.938806-1672166689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004444 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 02:40:43.900971) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-15 02:40:43.901343) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-15 02:40:43.901761) ========= ========= Total master_lag: 0.19 =========