builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-047 starttime: 1467029710.32 results: success (0) buildid: 20160627023004 builduid: 3464b57a3a514b4db223c1cbf73f3b98 revision: 9688cac5afbe215406ac95aa1a7972960666ca1c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 05:15:10.322464) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 05:15:10.322928) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 05:15:10.323437) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 05:15:10.376794) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 05:15:10.377134) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1467028509.732530-115788635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 05:15:10-- 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% 41.0M=0s 2016-06-27 05:15:10 (41.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124048 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 05:15:10.529728) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 05:15:10.531137) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1467028509.732530-115788635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021188 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 05:15:10.585854) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 05:15:10.589253) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9688cac5afbe215406ac95aa1a7972960666ca1c --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 9688cac5afbe215406ac95aa1a7972960666ca1c --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1467028509.732530-115788635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 05:15:10,606 truncating revision to first 12 chars 2016-06-27 05:15:10,606 Setting DEBUG logging. 2016-06-27 05:15:10,606 attempt 1/10 2016-06-27 05:15:10,606 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9688cac5afbe?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 05:15:10,947 unpacking tar archive at: fx-team-9688cac5afbe/testing/mozharness/ program finished with exit code 0 elapsedTime=0.750950 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 05:15:11.361334) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 05:15:11.361675) ========= script_repo_revision: 9688cac5afbe215406ac95aa1a7972960666ca1c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 05:15:11.362170) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 05:15:11.362496) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 05:15:11.393573) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-06-27 05:15:11.393910) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1467028509.732530-115788635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:15:11 INFO - MultiFileLogger online at 20160627 05:15:11 in /builds/slave/test 05:15:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:15:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:15:11 INFO - {'append_to_log': False, 05:15:11 INFO - 'base_work_dir': '/builds/slave/test', 05:15:11 INFO - 'blob_upload_branch': 'Fx-Team', 05:15:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:15:11 INFO - 'branch': 'Fx-Team', 05:15:11 INFO - 'buildbot_json_path': 'buildprops.json', 05:15:11 INFO - 'config_files': ('talos/linux_config.py',), 05:15:11 INFO - 'default_actions': ('clobber', 05:15:11 INFO - 'read-buildbot-config', 05:15:11 INFO - 'download-and-extract', 05:15:11 INFO - 'populate-webroot', 05:15:11 INFO - 'create-virtualenv', 05:15:11 INFO - 'install', 05:15:11 INFO - 'run-tests'), 05:15:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:15:11 INFO - 'download_minidump_stackwalk': True, 05:15:11 INFO - 'download_symbols': 'ondemand', 05:15:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:15:11 INFO - 'tooltool.py': '/tools/tooltool.py', 05:15:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:15:11 INFO - '/tools/misc-python/virtualenv.py')}, 05:15:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:15:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:15:11 INFO - 'installer_path': 'installer.exe', 05:15:11 INFO - 'log_level': 'info', 05:15:11 INFO - 'log_name': 'talos', 05:15:11 INFO - 'log_to_console': True, 05:15:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:15:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:15:11 INFO - 'opt_config_files': (), 05:15:11 INFO - 'pip_index': False, 05:15:11 INFO - 'sps_profile': False, 05:15:11 INFO - 'sps_profile_interval': 0, 05:15:11 INFO - 'suite': 'dromaeojs', 05:15:11 INFO - 'system_bits': '32', 05:15:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:15:11 INFO - 'title': 'talos-linux64-ix-047', 05:15:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:15:11 INFO - 'use_talos_json': True, 05:15:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:15:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:15:11 INFO - 'work_dir': 'build'} 05:15:11 INFO - ##### 05:15:11 INFO - ##### Running clobber step. 05:15:11 INFO - ##### 05:15:11 INFO - Running pre-action listener: _resource_record_pre_action 05:15:11 INFO - Running main action method: clobber 05:15:11 INFO - rmtree: /builds/slave/test/build 05:15:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:15:12 INFO - Running post-action listener: _resource_record_post_action 05:15:12 INFO - ##### 05:15:12 INFO - ##### Finished clobber step (success) 05:15:12 INFO - ##### 05:15:12 INFO - ##### 05:15:12 INFO - ##### Running read-buildbot-config step. 05:15:12 INFO - ##### 05:15:12 INFO - Running pre-action listener: _resource_record_pre_action 05:15:12 INFO - Running main action method: read_buildbot_config 05:15:12 INFO - Using buildbot properties: 05:15:12 INFO - { 05:15:12 INFO - "project": "", 05:15:12 INFO - "product": "firefox", 05:15:12 INFO - "script_repo_revision": "production", 05:15:12 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:15:12 INFO - "repository": "", 05:15:12 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:15:12 INFO - "buildid": "20160627023004", 05:15:12 INFO - "pgo_build": "True", 05:15:12 INFO - "basedir": "/builds/slave/test", 05:15:12 INFO - "buildnumber": 1282, 05:15:12 INFO - "slavename": "talos-linux64-ix-047", 05:15:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:15:12 INFO - "platform": "ubuntu64_hw", 05:15:12 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:15:12 INFO - "branch": "fx-team", 05:15:12 INFO - "repo_path": "integration/fx-team", 05:15:12 INFO - "revision": "9688cac5afbe215406ac95aa1a7972960666ca1c", 05:15:12 INFO - "stage_platform": "linux64-pgo", 05:15:12 INFO - "builduid": "3464b57a3a514b4db223c1cbf73f3b98", 05:15:12 INFO - "slavebuilddir": "test" 05:15:12 INFO - } 05:15:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/Gdjo8yWkT3OU03su9oXUug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:15:12 INFO - Running post-action listener: _resource_record_post_action 05:15:12 INFO - ##### 05:15:12 INFO - ##### Finished read-buildbot-config step (success) 05:15:12 INFO - ##### 05:15:12 INFO - ##### 05:15:12 INFO - ##### Running download-and-extract step. 05:15:12 INFO - ##### 05:15:12 INFO - Running pre-action listener: _resource_record_pre_action 05:15:12 INFO - Running main action method: download_and_extract 05:15:12 INFO - mkdir: /builds/slave/test/build/tests 05:15:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:12 INFO - https://queue.taskcluster.net/v1/task/Gdjo8yWkT3OU03su9oXUug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:15:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gdjo8yWkT3OU03su9oXUug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:15:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gdjo8yWkT3OU03su9oXUug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:15:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gdjo8yWkT3OU03su9oXUug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:15:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gdjo8yWkT3OU03su9oXUug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:15:20 INFO - Downloaded 1361 bytes. 05:15:20 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:15:20 INFO - Using the following test package requirements: 05:15:20 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:15:20 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:15:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:15:20 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:15:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:15:20 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:15:20 INFO - u'jsshell-linux-x86_64.zip'], 05:15:20 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:15:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:15:20 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:15:20 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:15:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:15:20 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:15:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:15:20 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:15:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:15:20 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:15:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:15:20 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:15:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:20 INFO - https://queue.taskcluster.net/v1/task/Gdjo8yWkT3OU03su9oXUug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:15:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gdjo8yWkT3OU03su9oXUug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:15:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gdjo8yWkT3OU03su9oXUug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:15:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gdjo8yWkT3OU03su9oXUug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:15:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gdjo8yWkT3OU03su9oXUug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:15:24 INFO - Downloaded 24279277 bytes. 05:15:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:15:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:15:25 INFO - Return code: 0 05:15:25 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:15:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:25 INFO - https://queue.taskcluster.net/v1/task/Gdjo8yWkT3OU03su9oXUug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:15:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gdjo8yWkT3OU03su9oXUug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:15:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gdjo8yWkT3OU03su9oXUug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:15:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gdjo8yWkT3OU03su9oXUug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:15:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gdjo8yWkT3OU03su9oXUug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:15:28 INFO - Downloaded 24279277 bytes. 05:15:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:15:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:15:29 INFO - Return code: 0 05:15:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:29 INFO - https://queue.taskcluster.net/v1/task/Gdjo8yWkT3OU03su9oXUug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:15:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gdjo8yWkT3OU03su9oXUug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:15:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gdjo8yWkT3OU03su9oXUug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:15:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gdjo8yWkT3OU03su9oXUug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:15:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gdjo8yWkT3OU03su9oXUug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:15:30 INFO - Downloaded 14405240 bytes. 05:15:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:15:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:15:31 INFO - Return code: 0 05:15: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')]} 05:15:31 INFO - https://queue.taskcluster.net/v1/task/Gdjo8yWkT3OU03su9oXUug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:15:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gdjo8yWkT3OU03su9oXUug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:15:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gdjo8yWkT3OU03su9oXUug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:15:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gdjo8yWkT3OU03su9oXUug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:15:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gdjo8yWkT3OU03su9oXUug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:15:37 INFO - Downloaded 60184040 bytes. 05:15:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Gdjo8yWkT3OU03su9oXUug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:15:37 INFO - mkdir: /builds/slave/test/properties 05:15:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:15:37 INFO - Writing to file /builds/slave/test/properties/build_url 05:15:37 INFO - Contents: 05:15:37 INFO - build_url:https://queue.taskcluster.net/v1/task/Gdjo8yWkT3OU03su9oXUug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:15:38 INFO - Running post-action listener: _resource_record_post_action 05:15:38 INFO - Running post-action listener: set_extra_try_arguments 05:15:38 INFO - ##### 05:15:38 INFO - ##### Finished download-and-extract step (success) 05:15:38 INFO - ##### 05:15:38 INFO - ##### 05:15:38 INFO - ##### Running populate-webroot step. 05:15:38 INFO - ##### 05:15:38 INFO - Running pre-action listener: _resource_record_pre_action 05:15:38 INFO - Running main action method: populate_webroot 05:15:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:15:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:15:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:15:38 INFO - '--tppagecycles', 05:15:38 INFO - '7'], 05:15:38 INFO - 'tests': ['tsvgm']}}, 05:15:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:15:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:15:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:15:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:15:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:15:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:15:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:38 INFO - 'talos_options': ['--disable-e10s'], 05:15:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:15:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:15:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:38 INFO - 'talos_options': ['--disable-e10s'], 05:15:38 INFO - 'tests': ['damp', 'tps']}, 05:15:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:38 INFO - 'tests': ['damp', 'tps']}, 05:15:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:15:38 INFO - 'tests': ['dromaeo_dom']}, 05:15:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:15:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:15:38 INFO - 'tests': ['basic_compositor_video']}, 05:15:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:15:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:15:38 INFO - 'tests': ['a11yr', 05:15:38 INFO - 'ts_paint', 05:15:38 INFO - 'tpaint', 05:15:38 INFO - 'sessionrestore', 05:15:38 INFO - 'sessionrestore_no_auto_restore', 05:15:38 INFO - 'tabpaint']}, 05:15:38 INFO - 'other-e10s': {'tests': ['a11yr', 05:15:38 INFO - 'ts_paint', 05:15:38 INFO - 'tpaint', 05:15:38 INFO - 'sessionrestore', 05:15:38 INFO - 'sessionrestore_no_auto_restore', 05:15:38 INFO - 'tabpaint']}, 05:15:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:15:38 INFO - 'ts_paint', 05:15:38 INFO - 'tpaint', 05:15:38 INFO - 'sessionrestore', 05:15:38 INFO - 'sessionrestore_no_auto_restore', 05:15:38 INFO - 'tabpaint']}, 05:15:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:15:38 INFO - 'ts_paint', 05:15:38 INFO - 'tpaint', 05:15:38 INFO - 'sessionrestore', 05:15:38 INFO - 'sessionrestore_no_auto_restore', 05:15:38 INFO - 'tabpaint']}, 05:15:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:15:38 INFO - 'tests': ['a11yr', 05:15:38 INFO - 'ts_paint', 05:15:38 INFO - 'tpaint', 05:15:38 INFO - 'sessionrestore', 05:15:38 INFO - 'sessionrestore_no_auto_restore', 05:15:38 INFO - 'tabpaint']}, 05:15:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:15:38 INFO - 'tests': ['a11yr', 05:15:38 INFO - 'ts_paint', 05:15:38 INFO - 'tpaint', 05:15:38 INFO - 'sessionrestore', 05:15:38 INFO - 'sessionrestore_no_auto_restore', 05:15:38 INFO - 'tabpaint']}, 05:15:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:15:38 INFO - 'tests': ['tsvgx', 05:15:38 INFO - 'tsvgr_opacity', 05:15:38 INFO - 'tart', 05:15:38 INFO - 'tscrollx', 05:15:38 INFO - 'cart']}, 05:15:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:15:38 INFO - 'tsvgr_opacity', 05:15:38 INFO - 'tart', 05:15:38 INFO - 'tscrollx', 05:15:38 INFO - 'cart']}, 05:15:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:38 INFO - 'talos_options': ['--disable-e10s'], 05:15:38 INFO - 'tests': ['tp5o']}, 05:15:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:38 INFO - 'tests': ['tp5o']}, 05:15:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:38 INFO - 'talos_options': ['--disable-e10s', 05:15:38 INFO - '--xperf_path', 05:15:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:15:38 INFO - 'tests': ['tp5n']}, 05:15:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:38 INFO - 'talos_options': ['--xperf_path', 05:15:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:15:38 INFO - 'tests': ['tp5n']}}, 05:15:38 INFO - 'talos.zip': {'path': '', 05:15:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:15:38 INFO - Running post-action listener: _resource_record_post_action 05:15:38 INFO - ##### 05:15:38 INFO - ##### Finished populate-webroot step (success) 05:15:38 INFO - ##### 05:15:38 INFO - ##### 05:15:38 INFO - ##### Running create-virtualenv step. 05:15:38 INFO - ##### 05:15:38 INFO - Running pre-action listener: _resource_record_pre_action 05:15:38 INFO - Running main action method: create_virtualenv 05:15:38 INFO - Creating virtualenv /builds/slave/test/build/venv 05:15:38 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:15:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:15:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:15:38 INFO - Using real prefix '/usr' 05:15:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:15:38 INFO - Installing distribute.............................................................................................................................................................................................done. 05:15:40 INFO - Installing pip.................done. 05:15:40 INFO - Return code: 0 05:15:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:15:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0051f9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2174590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2203570>, '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 0x2204470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2204920>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467028509.732530-115788635', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:15:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:15:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:15:40 INFO - Using env: {'DISPLAY': ':0', 05:15:40 INFO - 'HOME': '/home/cltbld', 05:15:40 INFO - 'LANG': 'en_US.UTF-8', 05:15:40 INFO - 'LANGUAGE': 'en_US:en', 05:15:40 INFO - 'LOGNAME': 'cltbld', 05:15:40 INFO - 'MAIL': '/var/mail/cltbld', 05:15:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:40 INFO - 'MOZ_NO_REMOTE': '1', 05:15:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:40 INFO - 'NO_EM_RESTART': '1', 05:15:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:40 INFO - 'PWD': '/builds/slave/test', 05:15:40 INFO - 'SHELL': '/bin/bash', 05:15:40 INFO - 'SHLVL': '1', 05:15:40 INFO - 'TERM': 'linux', 05:15:40 INFO - 'TMOUT': '86400', 05:15:40 INFO - 'USER': 'cltbld', 05:15:40 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467028509.732530-115788635', 05:15:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:40 INFO - '_': '/tools/buildbot/bin/python'} 05:15:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:41 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:15:41 INFO - Cleaning up... 05:15:41 INFO - Return code: 0 05:15:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:15: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')]} 05:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15: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')]} 05:15:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15: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', '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 0x7f0051f9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2174590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2203570>, '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 0x2204470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2204920>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467028509.732530-115788635', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:15: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', 'psutil>=3.1.1'] in /builds/slave/test/build 05:15: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 psutil>=3.1.1 05:15:41 INFO - Using env: {'DISPLAY': ':0', 05:15:41 INFO - 'HOME': '/home/cltbld', 05:15:41 INFO - 'LANG': 'en_US.UTF-8', 05:15:41 INFO - 'LANGUAGE': 'en_US:en', 05:15:41 INFO - 'LOGNAME': 'cltbld', 05:15:41 INFO - 'MAIL': '/var/mail/cltbld', 05:15:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:41 INFO - 'MOZ_NO_REMOTE': '1', 05:15:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:41 INFO - 'NO_EM_RESTART': '1', 05:15:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:41 INFO - 'PWD': '/builds/slave/test', 05:15:41 INFO - 'SHELL': '/bin/bash', 05:15:41 INFO - 'SHLVL': '1', 05:15:41 INFO - 'TERM': 'linux', 05:15:41 INFO - 'TMOUT': '86400', 05:15:41 INFO - 'USER': 'cltbld', 05:15:41 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467028509.732530-115788635', 05:15:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:41 INFO - '_': '/tools/buildbot/bin/python'} 05:15:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:41 INFO - Downloading/unpacking psutil>=3.1.1 05:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:15:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:15:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:15:43 INFO - Installing collected packages: psutil 05:15:43 INFO - Running setup.py install for psutil 05:15:43 INFO - building 'psutil._psutil_linux' extension 05:15:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:15:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:15:43 INFO - building 'psutil._psutil_posix' extension 05:15:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:15:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:15:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:15:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:15:43 INFO - Successfully installed psutil 05:15:43 INFO - Cleaning up... 05:15:43 INFO - Return code: 0 05:15:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:15:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0051f9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2174590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2203570>, '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 0x2204470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2204920>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467028509.732530-115788635', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:15:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:15:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:15:43 INFO - Using env: {'DISPLAY': ':0', 05:15:43 INFO - 'HOME': '/home/cltbld', 05:15:43 INFO - 'LANG': 'en_US.UTF-8', 05:15:43 INFO - 'LANGUAGE': 'en_US:en', 05:15:43 INFO - 'LOGNAME': 'cltbld', 05:15:43 INFO - 'MAIL': '/var/mail/cltbld', 05:15:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:43 INFO - 'MOZ_NO_REMOTE': '1', 05:15:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:43 INFO - 'NO_EM_RESTART': '1', 05:15:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:43 INFO - 'PWD': '/builds/slave/test', 05:15:43 INFO - 'SHELL': '/bin/bash', 05:15:43 INFO - 'SHLVL': '1', 05:15:43 INFO - 'TERM': 'linux', 05:15:43 INFO - 'TMOUT': '86400', 05:15:43 INFO - 'USER': 'cltbld', 05:15:43 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467028509.732530-115788635', 05:15:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:43 INFO - '_': '/tools/buildbot/bin/python'} 05:15:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:15:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:15:46 INFO - Installing collected packages: mozsystemmonitor 05:15:46 INFO - Running setup.py install for mozsystemmonitor 05:15:46 INFO - Successfully installed mozsystemmonitor 05:15:46 INFO - Cleaning up... 05:15:46 INFO - Return code: 0 05:15:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0051f9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2174590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2203570>, '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 0x2204470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2204920>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467028509.732530-115788635', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:15:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:15:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:15:46 INFO - Using env: {'DISPLAY': ':0', 05:15:46 INFO - 'HOME': '/home/cltbld', 05:15:46 INFO - 'LANG': 'en_US.UTF-8', 05:15:46 INFO - 'LANGUAGE': 'en_US:en', 05:15:46 INFO - 'LOGNAME': 'cltbld', 05:15:46 INFO - 'MAIL': '/var/mail/cltbld', 05:15:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:46 INFO - 'MOZ_NO_REMOTE': '1', 05:15:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:46 INFO - 'NO_EM_RESTART': '1', 05:15:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:46 INFO - 'PWD': '/builds/slave/test', 05:15:46 INFO - 'SHELL': '/bin/bash', 05:15:46 INFO - 'SHLVL': '1', 05:15:46 INFO - 'TERM': 'linux', 05:15:46 INFO - 'TMOUT': '86400', 05:15:46 INFO - 'USER': 'cltbld', 05:15:46 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467028509.732530-115788635', 05:15:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:46 INFO - '_': '/tools/buildbot/bin/python'} 05:15:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:46 INFO - Downloading/unpacking jsonschema==2.5.1 05:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:15:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:48 INFO - Downloading functools32-3.2.3-2.tar.gz 05:15:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:15:48 INFO - warning: no files found matching '*.txt' 05:15:48 INFO - no previously-included directories found matching 'build' 05:15:48 INFO - no previously-included directories found matching 'dist' 05:15:48 INFO - no previously-included directories found matching '.git*' 05:15:48 INFO - Installing collected packages: jsonschema, functools32 05:15:48 INFO - Running setup.py install for functools32 05:15:48 INFO - warning: no files found matching '*.txt' 05:15:48 INFO - no previously-included directories found matching 'build' 05:15:48 INFO - no previously-included directories found matching 'dist' 05:15:48 INFO - no previously-included directories found matching '.git*' 05:15:48 INFO - Successfully installed jsonschema functools32 05:15:48 INFO - Cleaning up... 05:15:48 INFO - Return code: 0 05:15:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:15:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0051f9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2174590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2203570>, '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 0x2204470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2204920>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467028509.732530-115788635', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:15:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:15:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:15:48 INFO - Using env: {'DISPLAY': ':0', 05:15:48 INFO - 'HOME': '/home/cltbld', 05:15:48 INFO - 'LANG': 'en_US.UTF-8', 05:15:48 INFO - 'LANGUAGE': 'en_US:en', 05:15:48 INFO - 'LOGNAME': 'cltbld', 05:15:48 INFO - 'MAIL': '/var/mail/cltbld', 05:15:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:48 INFO - 'MOZ_NO_REMOTE': '1', 05:15:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:48 INFO - 'NO_EM_RESTART': '1', 05:15:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:48 INFO - 'PWD': '/builds/slave/test', 05:15:48 INFO - 'SHELL': '/bin/bash', 05:15:48 INFO - 'SHLVL': '1', 05:15:48 INFO - 'TERM': 'linux', 05:15:48 INFO - 'TMOUT': '86400', 05:15:48 INFO - 'USER': 'cltbld', 05:15:48 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467028509.732530-115788635', 05:15:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:48 INFO - '_': '/tools/buildbot/bin/python'} 05:15:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:49 INFO - Downloading/unpacking blobuploader==1.2.4 05:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:50 INFO - Downloading blobuploader-1.2.4.tar.gz 05:15:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:15:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:15:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:51 INFO - Downloading docopt-0.6.1.tar.gz 05:15:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:15:51 INFO - Installing collected packages: blobuploader, requests, docopt 05:15:51 INFO - Running setup.py install for blobuploader 05:15:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:15:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:15:51 INFO - Running setup.py install for requests 05:15:52 INFO - Running setup.py install for docopt 05:15:52 INFO - Successfully installed blobuploader requests docopt 05:15:52 INFO - Cleaning up... 05:15:52 INFO - Return code: 0 05:15:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:15:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:52 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 0x7f0051f9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2174590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2203570>, '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 0x2204470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2204920>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467028509.732530-115788635', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:15:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:15:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:15:52 INFO - Using env: {'DISPLAY': ':0', 05:15:52 INFO - 'HOME': '/home/cltbld', 05:15:52 INFO - 'LANG': 'en_US.UTF-8', 05:15:52 INFO - 'LANGUAGE': 'en_US:en', 05:15:52 INFO - 'LOGNAME': 'cltbld', 05:15:52 INFO - 'MAIL': '/var/mail/cltbld', 05:15:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:52 INFO - 'MOZ_NO_REMOTE': '1', 05:15:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:52 INFO - 'NO_EM_RESTART': '1', 05:15:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:52 INFO - 'PWD': '/builds/slave/test', 05:15:52 INFO - 'SHELL': '/bin/bash', 05:15:52 INFO - 'SHLVL': '1', 05:15:52 INFO - 'TERM': 'linux', 05:15:52 INFO - 'TMOUT': '86400', 05:15:52 INFO - 'USER': 'cltbld', 05:15:52 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467028509.732530-115788635', 05:15:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:52 INFO - '_': '/tools/buildbot/bin/python'} 05:15:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:15:52 INFO - Running setup.py (path:/tmp/pip-OzNS_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:15:52 INFO - Running setup.py (path:/tmp/pip-cwvr5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:15:52 INFO - Running setup.py (path:/tmp/pip-6OlZTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:15:52 INFO - Running setup.py (path:/tmp/pip-FIMLQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:15:52 INFO - Running setup.py (path:/tmp/pip-4PNRS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:15:52 INFO - Running setup.py (path:/tmp/pip-lMjATF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:15:52 INFO - Running setup.py (path:/tmp/pip-j_LlI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:15:53 INFO - Running setup.py (path:/tmp/pip-96K0_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:15:53 INFO - Running setup.py (path:/tmp/pip-PlmhQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:15:53 INFO - Running setup.py (path:/tmp/pip-95MZES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:15:53 INFO - Running setup.py (path:/tmp/pip-gpXDFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:15:53 INFO - Running setup.py (path:/tmp/pip-AilC7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:15:53 INFO - Running setup.py (path:/tmp/pip-GnDXD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:15:53 INFO - Running setup.py (path:/tmp/pip-KaUuOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:15:53 INFO - Running setup.py (path:/tmp/pip-pXuFxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:15:53 INFO - Running setup.py (path:/tmp/pip-ckJKiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:15:53 INFO - Running setup.py (path:/tmp/pip-nBDqw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:15:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:15:53 INFO - Running setup.py install for manifestparser 05:15:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:15:53 INFO - Running setup.py install for mozcrash 05:15:54 INFO - Running setup.py install for mozdebug 05:15:54 INFO - Running setup.py install for mozdevice 05:15:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:15:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:15:54 INFO - Running setup.py install for mozfile 05:15:54 INFO - Running setup.py install for mozhttpd 05:15:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:15:54 INFO - Running setup.py install for mozinfo 05:15:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:15:54 INFO - Running setup.py install for mozInstall 05:15:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:15:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:15:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:15:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:15:54 INFO - Running setup.py install for mozleak 05:15:54 INFO - Running setup.py install for mozlog 05:15:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:15:54 INFO - Running setup.py install for moznetwork 05:15:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:15:54 INFO - Running setup.py install for mozprocess 05:15:55 INFO - Running setup.py install for mozprofile 05:15:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:15:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:15:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:15:55 INFO - Running setup.py install for mozrunner 05:15:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:15:55 INFO - Running setup.py install for mozscreenshot 05:15:55 INFO - Running setup.py install for moztest 05:15:55 INFO - Running setup.py install for mozversion 05:15:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:15:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:15:55 INFO - Cleaning up... 05:15:55 INFO - Return code: 0 05:15:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:15:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:55 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 0x7f0051f9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2174590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2203570>, '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 0x2204470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2204920>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467028509.732530-115788635', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:15:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:15:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:15:55 INFO - Using env: {'DISPLAY': ':0', 05:15:55 INFO - 'HOME': '/home/cltbld', 05:15:55 INFO - 'LANG': 'en_US.UTF-8', 05:15:55 INFO - 'LANGUAGE': 'en_US:en', 05:15:55 INFO - 'LOGNAME': 'cltbld', 05:15:55 INFO - 'MAIL': '/var/mail/cltbld', 05:15:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:55 INFO - 'MOZ_NO_REMOTE': '1', 05:15:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:55 INFO - 'NO_EM_RESTART': '1', 05:15:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:55 INFO - 'PWD': '/builds/slave/test', 05:15:55 INFO - 'SHELL': '/bin/bash', 05:15:55 INFO - 'SHLVL': '1', 05:15:55 INFO - 'TERM': 'linux', 05:15:55 INFO - 'TMOUT': '86400', 05:15:55 INFO - 'USER': 'cltbld', 05:15:55 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467028509.732530-115788635', 05:15:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:55 INFO - '_': '/tools/buildbot/bin/python'} 05:15:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:15:55 INFO - Running setup.py (path:/tmp/pip-0VsD47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:15:55 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:15:55 INFO - Running setup.py (path:/tmp/pip-O7Wh61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:15:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:15:55 INFO - Running setup.py (path:/tmp/pip-RbX3lO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:15:56 INFO - Running setup.py (path:/tmp/pip-Jue0Z0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:15:56 INFO - Running setup.py (path:/tmp/pip-Zo1SBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:15:56 INFO - Running setup.py (path:/tmp/pip-yeAlQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:15:56 INFO - Running setup.py (path:/tmp/pip-qiijm_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:15:56 INFO - Running setup.py (path:/tmp/pip-z19p7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:15:56 INFO - Running setup.py (path:/tmp/pip-B4nFSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:15:56 INFO - Running setup.py (path:/tmp/pip-2Uzgh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:15:56 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)) 05:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:15:56 INFO - Running setup.py (path:/tmp/pip-kUa9R7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:15:56 INFO - Running setup.py (path:/tmp/pip-kIOYT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:15:56 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)) 05:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:15:56 INFO - Running setup.py (path:/tmp/pip-DnHQAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:15:56 INFO - Running setup.py (path:/tmp/pip-5kVuU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:15:56 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)) 05:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:15:56 INFO - Running setup.py (path:/tmp/pip-nMYzX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:15:56 INFO - Running setup.py (path:/tmp/pip-c74sSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:15:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:15:57 INFO - Running setup.py (path:/tmp/pip-5grFzs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:15:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:15:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:15:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:15:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:15:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:15:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:15:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:58 INFO - Downloading blessings-1.6.tar.gz 05:15:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:15:59 INFO - Installing collected packages: blessings 05:15:59 INFO - Running setup.py install for blessings 05:15:59 INFO - Successfully installed blessings 05:15:59 INFO - Cleaning up... 05:15:59 INFO - Return code: 0 05:15:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:15:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:15:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:15:59 INFO - Reading from file tmpfile_stdout 05:15:59 INFO - Current package versions: 05:15:59 INFO - argparse == 1.2.1 05:15:59 INFO - blessings == 1.6 05:15:59 INFO - blobuploader == 1.2.4 05:15:59 INFO - docopt == 0.6.1 05:15:59 INFO - functools32 == 3.2.3-2 05:15:59 INFO - jsonschema == 2.5.1 05:15:59 INFO - manifestparser == 1.1 05:15:59 INFO - mozInstall == 1.12 05:15:59 INFO - mozcrash == 0.17 05:15:59 INFO - mozdebug == 0.1 05:15:59 INFO - mozdevice == 0.48 05:15:59 INFO - mozfile == 1.2 05:15:59 INFO - mozhttpd == 0.7 05:15:59 INFO - mozinfo == 0.9 05:15:59 INFO - mozleak == 0.1 05:15:59 INFO - mozlog == 3.2 05:15:59 INFO - moznetwork == 0.27 05:15:59 INFO - mozprocess == 0.22 05:15:59 INFO - mozprofile == 0.28 05:15:59 INFO - mozrunner == 6.11 05:15:59 INFO - mozscreenshot == 0.1 05:15:59 INFO - mozsystemmonitor == 0.3 05:15:59 INFO - moztest == 0.7 05:15:59 INFO - mozversion == 1.4 05:15:59 INFO - psutil == 3.1.1 05:15:59 INFO - requests == 1.2.3 05:15:59 INFO - wsgiref == 0.1.2 05:15:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:59 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 0x7f0051f9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2174590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2203570>, '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 0x2204470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2204920>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467028509.732530-115788635', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:15:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:15:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:15:59 INFO - Using env: {'DISPLAY': ':0', 05:15:59 INFO - 'HOME': '/home/cltbld', 05:15:59 INFO - 'LANG': 'en_US.UTF-8', 05:15:59 INFO - 'LANGUAGE': 'en_US:en', 05:15:59 INFO - 'LOGNAME': 'cltbld', 05:15:59 INFO - 'MAIL': '/var/mail/cltbld', 05:15:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:59 INFO - 'MOZ_NO_REMOTE': '1', 05:15:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:59 INFO - 'NO_EM_RESTART': '1', 05:15:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:59 INFO - 'PWD': '/builds/slave/test', 05:15:59 INFO - 'SHELL': '/bin/bash', 05:15:59 INFO - 'SHLVL': '1', 05:15:59 INFO - 'TERM': 'linux', 05:15:59 INFO - 'TMOUT': '86400', 05:15:59 INFO - 'USER': 'cltbld', 05:15:59 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467028509.732530-115788635', 05:15:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:59 INFO - '_': '/tools/buildbot/bin/python'} 05:15:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:15:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:15:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:15:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:15:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:15:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:15:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:15:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:15:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:15:59 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:15:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:15:59 INFO - Cleaning up... 05:15:59 INFO - Return code: 0 05:15:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:59 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 0x7f0051f9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2174590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2203570>, '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 0x2204470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2204920>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467028509.732530-115788635', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:15:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:15:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:15:59 INFO - Using env: {'DISPLAY': ':0', 05:15:59 INFO - 'HOME': '/home/cltbld', 05:15:59 INFO - 'LANG': 'en_US.UTF-8', 05:15:59 INFO - 'LANGUAGE': 'en_US:en', 05:15:59 INFO - 'LOGNAME': 'cltbld', 05:15:59 INFO - 'MAIL': '/var/mail/cltbld', 05:15:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:59 INFO - 'MOZ_NO_REMOTE': '1', 05:15:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:59 INFO - 'NO_EM_RESTART': '1', 05:15:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:59 INFO - 'PWD': '/builds/slave/test', 05:15:59 INFO - 'SHELL': '/bin/bash', 05:15:59 INFO - 'SHLVL': '1', 05:15:59 INFO - 'TERM': 'linux', 05:15:59 INFO - 'TMOUT': '86400', 05:15:59 INFO - 'USER': 'cltbld', 05:15:59 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467028509.732530-115788635', 05:15:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:59 INFO - '_': '/tools/buildbot/bin/python'} 05:15:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:15:59 INFO - Cleaning up... 05:15:59 INFO - Return code: 0 05:15:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:59 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 0x7f0051f9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2174590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2203570>, '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 0x2204470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2204920>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467028509.732530-115788635', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:15:59 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 05:15:59 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 05:15:59 INFO - Using env: {'DISPLAY': ':0', 05:15:59 INFO - 'HOME': '/home/cltbld', 05:15:59 INFO - 'LANG': 'en_US.UTF-8', 05:15:59 INFO - 'LANGUAGE': 'en_US:en', 05:15:59 INFO - 'LOGNAME': 'cltbld', 05:15:59 INFO - 'MAIL': '/var/mail/cltbld', 05:15:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:59 INFO - 'MOZ_NO_REMOTE': '1', 05:15:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:59 INFO - 'NO_EM_RESTART': '1', 05:15:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:59 INFO - 'PWD': '/builds/slave/test', 05:15:59 INFO - 'SHELL': '/bin/bash', 05:15:59 INFO - 'SHLVL': '1', 05:15:59 INFO - 'TERM': 'linux', 05:15:59 INFO - 'TMOUT': '86400', 05:15:59 INFO - 'USER': 'cltbld', 05:15:59 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467028509.732530-115788635', 05:15:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:59 INFO - '_': '/tools/buildbot/bin/python'} 05:16:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:00 INFO - Downloading/unpacking flake8 05:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:16:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:16:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:16:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:16:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:16:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:16:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:16:02 INFO - no previously-included directories found matching 'docs/_build' 05:16:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:16:02 INFO - Running setup.py install for pep8 05:16:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:16:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:16:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:16:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:16:02 INFO - no previously-included directories found matching 'docs/_build' 05:16:02 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:16:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:16:02 INFO - Cleaning up... 05:16:03 INFO - Return code: 0 05:16:03 INFO - Running post-action listener: _resource_record_post_action 05:16:03 INFO - Running post-action listener: _start_resource_monitoring 05:16:03 INFO - Starting resource monitoring. 05:16:03 INFO - ##### 05:16:03 INFO - ##### Finished create-virtualenv step (success) 05:16:03 INFO - ##### 05:16:03 INFO - ##### 05:16:03 INFO - ##### Running install step. 05:16:03 INFO - ##### 05:16:03 INFO - Running pre-action listener: _resource_record_pre_action 05:16:03 INFO - Running main action method: install 05:16:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:16:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:16:03 INFO - Reading from file tmpfile_stdout 05:16:03 INFO - Detecting whether we're running mozinstall >=1.0... 05:16:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:16:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:16:03 INFO - Reading from file tmpfile_stdout 05:16:03 INFO - Output received: 05:16:03 INFO - Usage: mozinstall [options] installer 05:16:03 INFO - Options: 05:16:03 INFO - -h, --help show this help message and exit 05:16:03 INFO - -d DEST, --destination=DEST 05:16:03 INFO - Directory to install application into. [default: 05:16:03 INFO - "/builds/slave/test"] 05:16:03 INFO - --app=APP Application being installed. [default: firefox] 05:16:03 INFO - mkdir: /builds/slave/test/build/application 05:16:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:16:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:16:20 INFO - Reading from file tmpfile_stdout 05:16:20 INFO - Output received: 05:16:20 INFO - /builds/slave/test/build/application/firefox/firefox 05:16:20 INFO - Running post-action listener: _resource_record_post_action 05:16:20 INFO - ##### 05:16:20 INFO - ##### Finished install step (success) 05:16:20 INFO - ##### 05:16:20 INFO - ##### 05:16:20 INFO - ##### Running run-tests step. 05:16:20 INFO - ##### 05:16:20 INFO - Running pre-action listener: _resource_record_pre_action 05:16:20 INFO - Running main action method: run_tests 05:16:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:16:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:16:20 INFO - Python 2.7.3 05:16:20 INFO - Return code: 0 05:16:20 INFO - grabbing minidump binary from tooltool 05:16:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:20 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 0x2203570>, '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 0x2204470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2204920>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:16:20 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:16:20 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:16:20 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:16:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:16:20 INFO - Return code: 0 05:16:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:16:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:16:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:16:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:16:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:16:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:16:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:16:21 INFO - Return code: 0 05:16:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Gdjo8yWkT3OU03su9oXUug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:16:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Gdjo8yWkT3OU03su9oXUug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:16:21 INFO - Using env: {'DISPLAY': ':0', 05:16:21 INFO - 'HOME': '/home/cltbld', 05:16:21 INFO - 'LANG': 'en_US.UTF-8', 05:16:21 INFO - 'LANGUAGE': 'en_US:en', 05:16:21 INFO - 'LOGNAME': 'cltbld', 05:16:21 INFO - 'MAIL': '/var/mail/cltbld', 05:16:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:16:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:16:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:21 INFO - 'MOZ_NO_REMOTE': '1', 05:16:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:16:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:21 INFO - 'NO_EM_RESTART': '1', 05:16:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:21 INFO - 'PWD': '/builds/slave/test', 05:16:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:16:21 INFO - 'SHELL': '/bin/bash', 05:16:21 INFO - 'SHLVL': '1', 05:16:21 INFO - 'TERM': 'linux', 05:16:21 INFO - 'TMOUT': '86400', 05:16:21 INFO - 'USER': 'cltbld', 05:16:21 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467028509.732530-115788635', 05:16:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:21 INFO - '_': '/tools/buildbot/bin/python'} 05:16:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Gdjo8yWkT3OU03su9oXUug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:16:21 INFO - mozversion application_buildid: 20160627023004 05:16:21 INFO - mozversion application_changeset: 9688cac5afbe215406ac95aa1a7972960666ca1c 05:16:21 INFO - mozversion application_display_name: Nightly 05:16:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:16:21 INFO - mozversion application_name: Firefox 05:16:21 INFO - mozversion application_remotingname: firefox 05:16:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:16:21 INFO - mozversion application_vendor: Mozilla 05:16:21 INFO - mozversion application_version: 50.0a1 05:16:21 INFO - mozversion platform_buildid: 20160627023004 05:16:21 INFO - mozversion platform_changeset: 9688cac5afbe215406ac95aa1a7972960666ca1c 05:16:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:16:21 INFO - mozversion platform_version: 50.0a1 05:16:21 INFO - using testdate: 1467029781 05:16:21 INFO - actual date: 1467029781 05:16:21 INFO - starting webserver on 'localhost:35768' 05:16:21 INFO - SUITE-START | Running 2 tests 05:16:21 INFO - TEST-START | dromaeo_css 05:16:21 INFO - operating with platform_type : linux_ 05:16:21 INFO - Initialising browser for dromaeo_css test... 05:16:21 INFO - TEST-INFO | started process 21877 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm8TxNj/profile http://localhost:35768/getInfo.html) 05:16:25 INFO - PROCESS | 21877 | __metrics Screen width/height:1600/1200 05:16:25 INFO - PROCESS | 21877 | colorDepth:24 05:16:25 INFO - PROCESS | 21877 | Browser inner width/height: 1024/697 05:16:25 INFO - PROCESS | 21877 | __metrics 05:16:26 INFO - PROCESS | 21877 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:16:27 INFO - TEST-INFO | 21877: exit 0 05:16:27 INFO - Browser initialized. 05:16:27 INFO - Running cycle 1/1 for dromaeo_css test... 05:16:27 INFO - TEST-INFO | started process 21962 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm8TxNj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:16:39 INFO - PROCESS | 21962 | RSS: Main: 174026752 05:16:39 INFO - PROCESS | 21962 | 05:17:30 INFO - PROCESS | 21962 | 1467029850674 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:19:40 INFO - PROCESS | 21962 | Cycle 1(1): loaded http://localhost:35768/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35768/tests/dromaeo/cssquery-ext.html) 05:19:41 INFO - PROCESS | 21962 | RSS: Main: 304582656 05:19:41 INFO - PROCESS | 21962 | 05:22:43 INFO - PROCESS | 21962 | Cycle 1(1): loaded http://localhost:35768/tests/dromaeo/cssquery-ext.html (next: http://localhost:35768/tests/dromaeo/cssquery-jquery.html) 05:22:44 INFO - PROCESS | 21962 | RSS: Main: 257974272 05:22:44 INFO - PROCESS | 21962 | 05:25:46 INFO - PROCESS | 21962 | Cycle 1(1): loaded http://localhost:35768/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35768/tests/dromaeo/cssquery-mootools.html) 05:25:46 INFO - PROCESS | 21962 | RSS: Main: 254369792 05:25:46 INFO - PROCESS | 21962 | 05:28:48 INFO - PROCESS | 21962 | Cycle 1(1): loaded http://localhost:35768/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35768/tests/dromaeo/cssquery-prototype.html) 05:28:49 INFO - PROCESS | 21962 | RSS: Main: 248340480 05:28:49 INFO - PROCESS | 21962 | 05:31:51 INFO - PROCESS | 21962 | Cycle 1(1): loaded http://localhost:35768/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35768/tests/dromaeo/cssquery-yui.html) 05:31:52 INFO - PROCESS | 21962 | RSS: Main: 245088256 05:31:52 INFO - PROCESS | 21962 | 05:34:55 INFO - PROCESS | 21962 | Cycle 1(1): loaded http://localhost:35768/tests/dromaeo/cssquery-yui.html (next: http://localhost:35768/tests/dromaeo/cssquery-dojo.html) 05:34:55 INFO - PROCESS | 21962 | RSS: Main: 285310976 05:34:55 INFO - PROCESS | 21962 | 05:34:55 INFO - PROCESS | 21962 | __start_tp_report 05:34:55 INFO - PROCESS | 21962 | _x_x_mozilla_page_load 05:34:55 INFO - PROCESS | 21962 | _x_x_mozilla_page_load_details 05:34:55 INFO - PROCESS | 21962 | |i|pagename|runs| 05:34:55 INFO - PROCESS | 21962 | |0;dojo.html;3158.810471371718;3171.4767063434533;3188.6492485826557;3189.282411457421;3236.1585987643207;5315.388730296007;5350.866228344294;5433.320834895638;5512;5550.528205102561;5417.349918009844;5424.0779067558515;5431.266778984846;5485.040117979358;5491.368492623349;4867.610591152699;4955.776990035439;4967.70193788372;4976.178930476467;5090.694558326494;4953.257011448276;4975.8258460953875;5011.1481048221885;5014.2979982802435;5046.394432668085;4877.317175595419;4879.170541008037;4926.088673595378;4926.753662316905;4952.380952380952;4912.557869791736;4920.655554111214;4923.08922849274;4936.48166942473;4974.204127339608;4911.189653707134;4954.628402869799;4958.727270000185;4963.354763880672;5009.749512524396;5295.629305948585;5347.304850369466;5401.540869026137;5431.348238211401;5432.320959880015;5839.824805255849;5841.269841269841;5878.382769809151;5892.675902825343;5897.3218079920925;5907.527397808165;5911.615744976562;5927.436893495111;5938.109283607493;5950.1372301016545;5317.361916569997;5350.571954243651;5383.246345511631;5404.567634589223;5484.506394424521;5955.37468565803;5959.106134079836;5959.106134079922;5962.284525856925;5986.790462333797;5568.6658800472105;5750.338711048283;5753.798617048383;5756.769729210785;5757.395473475309;5790.36306006339;5853.443922827325;5855.765769369263;5893.499052580493;5899.056151015817;5854.092615644497;5862.413758624103;5863.589548731633;5865.472107510344;5868.119782032644;5794.594378393472;5802.448767367094;5865.648061116347;5866.208061911672;5869.266341707286;4391.824327026947;4430.579094985971;4431.7562534060935;4434.091011342667;4462.308342206963;3980.880573582739;3984.1234928316303;3994.9001274967777;4018.3972404139026;4054.918901621951;5581.832545023656;5594.636348637326;5602.775888964396;5603.159526071122;5643.633163844337;5656.717164141859;5756.165356023437;5768.192453056576;5788.421157884178;5945.227120474311;5543.805966791143;5545.77816887328;5545.916811247835;5551.694656793834;5553.333599968029;5041.899162016739;5043.470435604282;5049.495050494995;5049.697018178921;5099.745012749348;5891.970540147272;5982.222311099529;6065;6065.181200537871;6115.969420152871;5857.121431785266;5861.706914654165;5865;5866.3547009828035;5869.8239052828485;5827.096799996008;6083.422074902877;6106.45041946227;6110.419510146529;6112;5671.914921276101;5674.319081710221;5722.027255366681;5755.539556835527;5764.279465066867;5820;5851.590388672752;5852.707364631837;5852.736626851717;5859.2090067842;5560.638558493685;5599.580031497735;5690.487856092972;5693.373728889902;5698.572607054571;5608.270924779753;5683.857903552279;5687.5449964001955;5690.203371527907;5741.913871292018;5591.217229587943;5596.440355964533;5596.720163991703;5598.580106492111;5598.580106492111;5587.1339942309005;5613.943860561342;5629.887402252014;5703.714814259188;5766.250387449605;5461.617686761889;5462.781488740406;5497.532709719719;5531.8893622128135;5571.554275657856 05:34:55 INFO - PROCESS | 21962 | |1;ext.html;581.566732784076;603.2911329188203;624.241546520977;625.7152995387099;639.5299454900644;42326.36510452342;43619.78190109049;43700.56299437005;43714;47439;44473.77763111188;44515.10969780602;44790.10419791602;44847;44861;8722.127787221274;8840.823183536326;8888.466691998468;8919.197272245498;8923.10768923109;8765.298776097898;8948.463092214455;8977.685780997666;8987.640494380217;9000.8649870252;9025.548722563879;9033.457992520469;9036.45781253127;9036.954815225914;9102.499362535058;8864.423812452202;8924.910750892474;8925.464472131693;8929.553522323922;8935.508547029944;8769.210771030574;8882.245009174228;8922.375433719642;8931.37480376374;8931.464112153291;41710.79144604288;42047.789761051;42209;42213.577864221275;42216.78891605522;3657.2868290683327;3695.2978934002454;3732.1602639405914;3763.604821493731;3936.5079365079364;32157.1960700982;32397.676023239936;32783.6721632783;33208.833955830305;33222.973945588186;3612.9341844155774;3624.9275014499563;3656.9675376088626;3672.192117734094;3761.1913438610554;308861;309681;310454;310511;311298;50739.746301269;57121.428785712444;57143.42856571464;57180.14229786557;57209.71395143081;35346.82326588402;36143.81928090343;36259.456108158396;38192.61807381891;60410;14541.054831435922;14592.197429141499;14662.266886655625;14662.560123196321;14674.55976320712;10393.688189354332;10416.427096509764;10443.216758743125;10445.164386849034;10445.321054131457;19476.318328858422;19583.216671333274;19646.901765491082;19809.603807923762;19837.702434463496;7069.762791511465;7121.537100088478;7303;7337.229590892986;7341.192468828424;960.6829746183743;1029.1972261635935;1052.5474046160225;1090.9618163364244;1094.6332978452149;32293;32493.187670307958;32552.348953020806;32895.83552082224;32955.67044329574;1107.789519991199;1148.4085695866636;1160.7446361800392;1163.8021536338842;1164.1618035014776;16508.77674848301;17106.743398849027;17183.226754796066;17211.741823872653;17570.82429175692;525544;529717;533423;533490;534604;58774;59578.702106490055;59600.40399595949;59615;59618.403815962156;1224.6815827884636;1294.1911305434103;1354.945802167922;1355.1530293566718;1357.9660508487366;32049;32875.835620821745;33466.83266583652;33722;33739.662603373654;50395.49604503908;50804;50833.74583127061;50990.23514647209;51012.23481647852;381331;381529;382131;382468;383056;24787;24845.751542484344;27752.58371124475;27775.722242777312;28667.56998645064;48309.27536086891;48358.758206208746;48379;48949.8328427726;49390.50609493859;40071.1985760289;40322.1935561293;40629.59370406258;40783.38824917688;41951.58048419599;40363;40933.79533102315;40965.951702415354;41183.176336472505;41189.1762164761;39889.601103988585;40588.94110588918;41313;41411.79294103631;44432.77783611061;34736.478952815225;37244.25511489809;37415.81292093522;38205;38308.23383532369;27781.722182777914;27870.44259114847;27921.860390697915;28386.716132838406;28404 05:34:55 INFO - PROCESS | 21962 | |2;jquery.html;382.9540455145383;386.1100164121699;396.7361704466528;396.77582166076184;415.8544509421703;14335.426582936696;16181.352745890179;18155.546111347205;19470;19580.902095489502;13073.681150995499;13995.300234988235;17047.829521704778;17085.40201092962;17460.56348591286;5499;5589.189567512708;5658.490735833774;5715.1998720179;5735.08238681811;3748.3253014457387;5635.408282130379;5813.82558523245;5877.2065771121;5973.701314934236;6002.009668404708;6010.819675409723;6022.036474164134;6023.066424704156;6027.517798576126;5995.4304341087745;6228.564000519943;6522.608643481359;6533.705983230766;6535.2484464286745;5086.415062267813;5809.941900581025;5839.737211825478;5844.970775146139;5851.941480585182;13593;13849.19960405151;13853;13858.584242472742;15718.921405393014;2244.584751820902;2262.8981695823563;2343.7070366204225;2404.446977195255;2460.987695061513;10453;10747.140228781678;12609.495620175274;13493.2578708171;13987.510437134753;1864.0586503815623;1914.9521261968562;1924.980750192494;1944.6694062009492;1958.265650381107;79553.60223198905;83749.58125209397;84151.57924210401;84822.15177848205;84927.57536212403;10854.511546980404;11030.889691102986;11083.445827708743;11218.326900386002;11228.831567526493;15508.92245538765;15588.844111558967;15637.296321665552;15650.217489125725;15683.372665093268;7291.52605080668;7440.441966852508;7480.663370148356;7511.586862722494;7517.398608111338;7031.437485001187;7078.504504684725;7139.82150446243;7256.383207427428;7273.3453989141235;4722.858314250578;4771.451283102488;4775.904481910412;4840.467548569654;4850.936329588015;1785.9642807143784;1858.7490688756845;1913.9043047847551;1956.9706454403195;2010.45717656232;991.7173605522391;998.5606333213362;1005.5374527717186;1034.9482525873675;1123.3652986062848;18100.45698629043;18913.14890829916;19092.427227183205;19136.80863191378;19358.128884200243;975.6097560975667;987.9697222208288;1007.596961215505;1010.757418219622;1023.5291765787821;9888.851667224853;10682.519286631965;10804.1896857736;10820.13438924884;10824.891751082547;426114;429726;436236;436832.60588061676;440129;91491.71270718152;91620.54189729008;91771;92262.53868730614;93138.53430732802;982.3958265666564;991.0386924683046;1021.5403068619152;1025.5487585462372;1026.4046852825343;16523.173841307645;16525.66948661044;16640.75038874442;16965.406210783058;17232.827671723622;42104;43248.783756081015;43401.782991084845;43898.341524876516;43945.78027109972;53147.46852531425;54443.45556544384;55909.16136257878;61845.69077154585;62207.37792622197;8502.44734092282;8533.914660853561;8561.914380856111;8670.176333248332;8724.476531408136;8753.868691969752;13259.933700331436;13373.39819708135;13816.24010679382;14118.152910825384;11120.833187502356;11865.881341186478;12105.213161144497;12150.331731754839;12209.816852747039;11640.708982275512;11678.532858685558;12023.398830058288;12260.26438413698;12306.692332691397;12007.399630018639;12014.279143251433;12197.878021220029;12399;12564.120511564102;7558.811029724301;7989.560574168244;8937.642494300415;9094.090590940854;9180.862287065565;11897.167198296036;12065.457054432747;12105.81841272364;12115.878841211828;12164.330961797186 05:34:55 INFO - PROCESS | 21962 | |3;mootools.html;1341.4634146341457;1460.2917584971287;1494.5292232946622;1535.1019653502701;1677.3458351243016;8247.587620618968;8635.481871087732;8651.04838467768;8868.46789192649;8881.46711197327;8587.05542390338;8769.254613357856;8769.56152192391;8773.824523509526;8780.912190878089;1995.451250905998;2243.4391402149463;2313.8893331201034;2359.9764002360016;2391.3184742348435;2305.5043165719367;2320.373499155227;2320.466292752668;2320.5474932388192;2321.9071237150492;2313.7801908818637;2316.119874447716;2346.3547524430833;2351.0478256306224;2351.318117745852;1943.2712732725229;2227.1091563374616;2286.965695514569;2290.5876942150408;2300.1144559344607;2322.93031209064;2325.3256555598855;2341.098677009347;2343.1915988983774;2343.379004563792;9099.909000909973;9135.817283654289;9185.954070229673;9211.493367864765;9213.355065145442;5327.786888524454;5467.234587157801;5468.890622187574;5469.371022332443;5469.972650136764;3220;3307.5534802801553;3364.158960259935;3376.9155771105675;3417.3848707232687;1045.900639439252;1052.2739309876238;1053.8261186904151;1061.2040969273046;1085.7991271614776;12420.875791242062;12534.561290354884;12534.874651253462;12554.623361299084;12556.434960426803;4658.7437690926645;4717.622590192776;4818.855434336975;4820.734859582757;4827.324174615556;10464.581416743245;10473.895261047444;10496.68509944703;10506.73733156662;10512.842307365396;5200.193969934666;5205.037068142406;5210.687358758487;5212.400573934046;5216.37403511581;4379.759113248802;4751.619870410359;4866.902661946812;4879.1461494238365;4948.307236986825;4099.262132816062;4107.507099148122;4126.1128857295225;4168.353905144708;4175.394567787715;1266.4364357860848;1299.4217573179844;1309.1948451702135;1319.2546211390725;1319.3930791835862;895.8656201569817;1016.434690576504;1017.8320577104695;1018.3686114608989;1018.8369860822232;5929.703514824241;5976.7908123215475;6046.183765191643;6197.721102550396;6260.749570017239;905.158202871336;918.7840857398639;951.1772316945792;975.317277905469;994.5723338964315;4111.342185250405;4254.42565253693;4283.2932566126865;4291.871243862689;4352.847650332286;10936.835947460795;11300.94349528247;11303.547858085749;11370.54517819278;11468.770624587461;11225;11329.150313726503;11331.093512518979;11364.602238921598;11366.943165284121;7918.208179182036;8221.958890205391;8381.329493640495;8520.659173633108;8525.147485251426;5938.6354260378475;6095.1466794647895;6160;6162.168107305456;6186.19579454668;10473.633422830164;10521.579136834442;10554.313969591953;10687.46562671879;10702.785944280915;10364.948175259377;10597.15222782191;10824.4046577439;10830.350178989285;10850.511726972147;7331.963340183265;7978.8005299865645;8145.389095817956;8210.630521626661;8584.270337021173;8577.185167409087;8745.300375970035;8762.912370876466;8825.470471771714;8832.91167088321;7542.736004239825;7570.394368450621;7648.464607477423;7784.532928024337;7840.647170877211;7805.2194780521495;7807.843843123219;7854.960725196337;7858;7870.173631768582;6975.511714179958;7045.929540704527;7065.858682826212;7068.752593659197;7074.929250707427;5008.874778130576;5136.768845401891;5143.768530416065;5264.4735526448585;5346.331708536433;4998.950010499849;5006.974965125151;5055.368078990126;5071.949280507148;5163.509466600667 05:34:55 INFO - PROCESS | 21962 | |4;prototype.html;319.1542412606592;332.88848235840993;333.9816310102946;343.5396568598078;344.1327853808403;5053.216751403529;5229.790808367666;5232.659877107995;5308.124159513681;5331.493508116732;5237.7381130943495;5254.527092561669;5279.076161671711;5288.5504732097725;5291.708956007418;4182.184474027566;4185.602367775056;4187.183499217654;4200.537940826506;4220.746755194698;4028.8992775180564;4159.812808423628;4191.895202619944;4207.095474472988;4212.747235165884;4073.205724883649;4093.4269202311702;4105.659773928862;4123.412486192822;4179.101493178966;4158.37624356346;4162.334026555736;4171.645410140141;4178.289690752549;4199.958000419987;3676.0149519259567;3744.55065392152;3763.849446022156;3768.888177987473;3774.660280574734;5139.691618502902;5143.794248230066;5145.819896303611;5159.664621799571;5187.8184263550975;4768.642351823627;4780;4791.233402655594;4807.086653535817;4821.325014497938;5153.123968925292;5458.6724796512335;5494.972525137348;5533.972330138364;5550.500454959073;3967.841286348543;3981.900452488682;3984.342583473723;3984.940225896614;4003.8798836034966;5380.192971054334;5475.972620136914;5642.463965923231;5694.943050569483;5730.369659337512;4007.919841603152;4010.3382941814857;4028.3554631259444;4028.879133625996;4036.858709945138;4057.660971879273;4075.59244075596;4089.386592011222;4099.282625540519;4113.095119073799;4449.666275029385;4560.042391097841;4644.883877903079;4653.674242803039;4710.88222794426;5416.214648875891;5458.61789674719;5484.670919744828;5485.9725701371235;5486.177073439016;1379.2138481065697;1417.8369487508862;1418.1136789506559;1424.5512663511167;1425.6863490032176;875.8335916176034;901.6889173235223;906.959186836594;928.8621438737628;940.4686352210979;4681.882952926204;4709.317149013443;4717.646176536705;4743.079052983548;4745.833895813699;4934.605231581537;4948.901021979612;4954.455009948902;4962.667546253255;4967.950320496821;4715.958206956562;4751.859553707085;4765.880852978634;4795.930604413178;4971.328870602495;2966.5401862710883;2969.728157959163;3005.248687828043;3017.9245518862203;3026.546018097303;5740.598158128974;5794.391588883191;5796.608983744472;5798.82603521895;5820.476157145878;5515.549260936373;5645.125005624135;5714.142878568248;5737.3688894221605;5755.884882302331;5779.88440231193;5817.621854579524;5828.300603927556;5834.854128646818;5840.328362238312;5419.268398766116;5597.944020559742;5630.451625802937;5640.774369025193;5644.604877658525;5305.2307415423775;5560.19377190297;5574;5577.888442231214;5600.859978500407;5671.829845104653;5877.294724633071;5900.557458190567;5902.907962027039;5915.526757859447;4030.717849750489;4036.6367026967714;4055.4930633670792;4070.0842310479907;4091.304478238647;5396.595255355943;5606.6636001840025;5618.297712785902;5618.606697531133;5731.684757338219;5545.833624991256;5567.387587365468;5576.888462230651;5584.497395234448;5588.580856435702;5439.4288599696465;5476.58925580591;5501.477359650827;5539.556835453073;5567.192757050286;5151.253068305;5392.218128371443;5394.676319420847;5426.321709786277;5440.428754980829;5466.1527463243265;5506.201600767947;5507.339119305709;5511.925174590916;5520.392756796668;5128.230765385222;5371.543418809445;5388.46115388458;5420.728963551728;5424.159255315432 05:34:55 INFO - PROCESS | 21962 | |5;yui.html;683.8495530983182;709.6026225313825;754.2909664914976;763.4655740981312;788.668759121169;13204.801927971075;13837.861621383783;13975.231362275072;14355.569332920017;14363.138211707279;12565.497380104785;12569.685757856058;12681.239125652468;12704.682382940431;12757.489700411996;660.0561197487591;787.8857565652977;795.101535265151;807.4993504027511;811.3063330852125;783.3263393481601;786.6066966516742;786.7049856303886;786.8268980824238;787.3976408047848;819.0785366462729;823.567626995826;823.6129019360891;824.3652387661497;824.9670013199465;685.9984422742801;852.1393392673383;872.733816186063;872.9214370706667;877.1535468273147;591.7130191856946;592.6532978207754;612.6905912514152;615.4799194680488;616.0420546050889;13755.243461609607;13832;13876.098053626481;13881.097728647606;13896.16623002623;14643.853561464462;14940.252987350588;15062.171580563065;15130.621734456616;15187.164705941168;11005.119590432827;11090.55637774488;11153.72115697106;11263.66209013731;11271.661850144508;3953;3960.2475529649273;3962.5443074046566;3967.841286348543;4011.8997025074314;76693.23306766861;76767;76957.61521192415;77926;78081;11456.140789440658;11596.826047609293;11657.76684466306;11792.705182370339;11918.344491052902;22722.886385568298;22888.65667014996;22893.656595151086;22947.426314342276;23014.309570712907;8610.13898610134;8710.47737135774;8728.345374096969;8740.431871928304;8815.294776417999;4552.362669226245;4663.3937588114;4690.319903614025;4715.221988371949;4739.881502962454;3692.2615476904725;3821.407681809324;3823.101571130782;3829.2532956073856;4006.258842114218;577.6245440463732;610.1701685707434;684.5379368925956;694.7846167688033;703.4126504368807;605.7455868535226;764.6176911544228;774.4462709162975;781.6677911887425;784.5371230973753;9506.33455658111;9879.950600246953;9885.357451765612;9943;10228;680.4148432348177;701.9438444924393;778.2995304226241;787.6022608582629;789.8578255913991;4558.407407037064;4685.508021657745;4742.430908291027;4763.809447622057;4910.754462276872;118675.40662296633;119540;120431;121916;123820;102953;103080.48459757653;103691;103817.48091259495;103822.48088759658;89963;91296.54351728199;92460.5435445353;92835;92971;9321.20769734553;9335.57989890443;9393.81212375735;9470.905290947278;9477.289203309641;51662;52118.739406302724;52243.73878130585;53186.46813531815;54097;70655.64672176607;78181.60909195417;78408;79760.82152606061;80749.59625201837;12410;12419.813702794647;12643.114981951176;12940.611781646565;13563.93218033943;14211.786823197866;14607;14631.82945364347;14762.704745905237;15512.457064002705;10624.946875265574;12640.74718505643;12867.420966056363;13455.596332110052;13623.250721210428;9251.814963700823;12626.936865315982;13441.395137219044;13771.586852394445;14386;13144.934275328944;13416.731665366833;13443;14248.216348100954;14388.674516175388;11321.264117832314;11357.101925903911;11849.526018959144;11850.703732406413;12239.388030598613;11025.393603351893;11384.601538946097;11410.771784564096;11507.252028618113;11706.941465292619 05:34:55 INFO - PROCESS | 21962 | __end_tp_report 05:34:55 INFO - PROCESS | 21962 | __start_cc_report 05:34:55 INFO - PROCESS | 21962 | _x_x_mozilla_cycle_collect,1078 05:34:55 INFO - PROCESS | 21962 | __end_cc_report 05:34:55 INFO - PROCESS | 21962 | __startTimestamp1467030895465__endTimestamp 05:34:55 INFO - PROCESS | 21962 | 05:34:55 INFO - PROCESS | 21962 | ------- Summary: start ------- 05:34:55 INFO - PROCESS | 21962 | Number of tests: 6 05:34:55 INFO - PROCESS | 21962 | 05:34:55 INFO - PROCESS | 21962 | [#0] dojo.html Cycles:165 Average:5414.56 Median:5596.72 stddev:612.00 (10.9%) stddev-sans-first:587.73 05:34:55 INFO - PROCESS | 21962 | Values: 3158.8 3171.5 3188.6 3189.3 3236.2 5315.4 5350.9 5433.3 5512.0 5550.5 5417.3 5424.1 5431.3 5485.0 5491.4 4867.6 4955.8 4967.7 4976.2 5090.7 4953.3 4975.8 5011.1 5014.3 5046.4 4877.3 4879.2 4926.1 4926.8 4952.4 4912.6 4920.7 4923.1 4936.5 4974.2 4911.2 4954.6 4958.7 4963.4 5009.7 5295.6 5347.3 5401.5 5431.3 5432.3 5839.8 5841.3 5878.4 5892.7 5897.3 5907.5 5911.6 5927.4 5938.1 5950.1 5317.4 5350.6 5383.2 5404.6 5484.5 5955.4 5959.1 5959.1 5962.3 5986.8 5568.7 5750.3 5753.8 5756.8 5757.4 5790.4 5853.4 5855.8 5893.5 5899.1 5854.1 5862.4 5863.6 5865.5 5868.1 5794.6 5802.4 5865.6 5866.2 5869.3 4391.8 4430.6 4431.8 4434.1 4462.3 3980.9 3984.1 3994.9 4018.4 4054.9 5581.8 5594.6 5602.8 5603.2 5643.6 5656.7 5756.2 5768.2 5788.4 5945.2 5543.8 5545.8 5545.9 5551.7 5553.3 5041.9 5043.5 5049.5 5049.7 5099.7 5892.0 5982.2 6065.0 6065.2 6116.0 5857.1 5861.7 5865.0 5866.4 5869.8 5827.1 6083.4 6106.5 6110.4 6112.0 5671.9 5674.3 5722.0 5755.5 5764.3 5820.0 5851.6 5852.7 5852.7 5859.2 5560.6 5599.6 5690.5 5693.4 5698.6 5608.3 5683.9 5687.5 5690.2 5741.9 5591.2 5596.4 5596.7 5598.6 5598.6 5587.1 5613.9 5629.9 5703.7 5766.3 5461.6 5462.8 5497.5 5531.9 5571.6 05:34:55 INFO - PROCESS | 21962 | 05:34:55 INFO - PROCESS | 21962 | [#1] ext.html Cycles:180 Average:56935.79 Median:40342.60 stddev:110820.05 (274.7%) stddev-sans-first:111050.16 05:34:55 INFO - PROCESS | 21962 | Values: 581.6 603.3 624.2 625.7 639.5 42326.4 43619.8 43700.6 43714.0 47439.0 44473.8 44515.1 44790.1 44847.0 44861.0 8722.1 8840.8 8888.5 8919.2 8923.1 8765.3 8948.5 8977.7 8987.6 9000.9 9025.5 9033.5 9036.5 9037.0 9102.5 8864.4 8924.9 8925.5 8929.6 8935.5 8769.2 8882.2 8922.4 8931.4 8931.5 41710.8 42047.8 42209.0 42213.6 42216.8 3657.3 3695.3 3732.2 3763.6 3936.5 32157.2 32397.7 32783.7 33208.8 33223.0 3612.9 3624.9 3657.0 3672.2 3761.2 308861.0 309681.0 310454.0 310511.0 311298.0 50739.7 57121.4 57143.4 57180.1 57209.7 35346.8 36143.8 36259.5 38192.6 60410.0 14541.1 14592.2 14662.3 14662.6 14674.6 10393.7 10416.4 10443.2 10445.2 10445.3 19476.3 19583.2 19646.9 19809.6 19837.7 7069.8 7121.5 7303.0 7337.2 7341.2 960.7 1029.2 1052.5 1091.0 1094.6 32293.0 32493.2 32552.3 32895.8 32955.7 1107.8 1148.4 1160.7 1163.8 1164.2 16508.8 17106.7 17183.2 17211.7 17570.8 525544.0 529717.0 533423.0 533490.0 534604.0 58774.0 59578.7 59600.4 59615.0 59618.4 1224.7 1294.2 1354.9 1355.2 1358.0 32049.0 32875.8 33466.8 33722.0 33739.7 50395.5 50804.0 50833.7 50990.2 51012.2 381331.0 381529.0 382131.0 382468.0 383056.0 24787.0 24845.8 27752.6 27775.7 28667.6 48309.3 48358.8 48379.0 48949.8 49390.5 40071.2 40322.2 40629.6 40783.4 41951.6 40363.0 40933.8 40966.0 41183.2 41189.2 39889.6 40588.9 41313.0 41411.8 44432.8 34736.5 37244.3 37415.8 38205.0 38308.2 27781.7 27870.4 27921.9 28386.7 28404.0 05:34:55 INFO - PROCESS | 21962 | 05:34:55 INFO - PROCESS | 21962 | [#2] jquery.html Cycles:180 Average:27193.26 Median:2432.72 stddev:71978.97 (2958.8%) stddev-sans-first:72152.74 05:34:55 INFO - PROCESS | 21962 | Values: 383.0 386.1 396.7 396.8 415.9 14335.4 16181.4 18155.5 19470.0 19580.9 13073.7 13995.3 17047.8 17085.4 17460.6 5499.0 5589.2 5658.5 5715.2 5735.1 3748.3 5635.4 5813.8 5877.2 5973.7 6002.0 6010.8 6022.0 6023.1 6027.5 5995.4 6228.6 6522.6 6533.7 6535.2 5086.4 5809.9 5839.7 5845.0 5851.9 13593.0 13849.2 13853.0 13858.6 15718.9 2244.6 2262.9 2343.7 2404.4 2461.0 10453.0 10747.1 12609.5 13493.3 13987.5 1864.1 1915.0 1925.0 1944.7 1958.3 79553.6 83749.6 84151.6 84822.2 84927.6 10854.5 11030.9 11083.4 11218.3 11228.8 15508.9 15588.8 15637.3 15650.2 15683.4 7291.5 7440.4 7480.7 7511.6 7517.4 7031.4 7078.5 7139.8 7256.4 7273.3 4722.9 4771.5 4775.9 4840.5 4850.9 1786.0 1858.7 1913.9 1957.0 2010.5 991.7 998.6 1005.5 1034.9 1123.4 18100.5 18913.1 19092.4 19136.8 19358.1 975.6 988.0 1007.6 1010.8 1023.5 9888.9 10682.5 10804.2 10820.1 10824.9 426114.0 429726.0 436236.0 436832.6 440129.0 91491.7 91620.5 91771.0 92262.5 93138.5 982.4 991.0 1021.5 1025.5 1026.4 16523.2 16525.7 16640.8 16965.4 17232.8 42104.0 43248.8 43401.8 43898.3 43945.8 53147.5 54443.5 55909.2 61845.7 62207.4 8502.4 8533.9 8561.9 8670.2 8724.5 8753.9 13259.9 13373.4 13816.2 14118.2 11120.8 11865.9 12105.2 12150.3 12209.8 11640.7 11678.5 12023.4 12260.3 12306.7 12007.4 12014.3 12197.9 12399.0 12564.1 7558.8 7989.6 8937.6 9094.1 9180.9 11897.2 12065.5 12105.8 12115.9 12164.3 05:34:55 INFO - PROCESS | 21962 | 05:34:55 INFO - PROCESS | 21962 | [#3] mootools.html Cycles:180 Average:5909.45 Median:4688.18 stddev:3410.38 (72.7%) stddev-sans-first:3402.66 05:34:55 INFO - PROCESS | 21962 | Values: 1341.5 1460.3 1494.5 1535.1 1677.3 8247.6 8635.5 8651.0 8868.5 8881.5 8587.1 8769.3 8769.6 8773.8 8780.9 1995.5 2243.4 2313.9 2360.0 2391.3 2305.5 2320.4 2320.5 2320.5 2321.9 2313.8 2316.1 2346.4 2351.0 2351.3 1943.3 2227.1 2287.0 2290.6 2300.1 2322.9 2325.3 2341.1 2343.2 2343.4 9099.9 9135.8 9186.0 9211.5 9213.4 5327.8 5467.2 5468.9 5469.4 5470.0 3220.0 3307.6 3364.2 3376.9 3417.4 1045.9 1052.3 1053.8 1061.2 1085.8 12420.9 12534.6 12534.9 12554.6 12556.4 4658.7 4717.6 4818.9 4820.7 4827.3 10464.6 10473.9 10496.7 10506.7 10512.8 5200.2 5205.0 5210.7 5212.4 5216.4 4379.8 4751.6 4866.9 4879.1 4948.3 4099.3 4107.5 4126.1 4168.4 4175.4 1266.4 1299.4 1309.2 1319.3 1319.4 895.9 1016.4 1017.8 1018.4 1018.8 5929.7 5976.8 6046.2 6197.7 6260.7 905.2 918.8 951.2 975.3 994.6 4111.3 4254.4 4283.3 4291.9 4352.8 10936.8 11300.9 11303.5 11370.5 11468.8 11225.0 11329.2 11331.1 11364.6 11366.9 7918.2 8222.0 8381.3 8520.7 8525.1 5938.6 6095.1 6160.0 6162.2 6186.2 10473.6 10521.6 10554.3 10687.5 10702.8 10364.9 10597.2 10824.4 10830.4 10850.5 7332.0 7978.8 8145.4 8210.6 8584.3 8577.2 8745.3 8762.9 8825.5 8832.9 7542.7 7570.4 7648.5 7784.5 7840.6 7805.2 7807.8 7855.0 7858.0 7870.2 6975.5 7045.9 7065.9 7068.8 7074.9 5008.9 5136.8 5143.8 5264.5 5346.3 4999.0 5007.0 5055.4 5071.9 5163.5 05:34:55 INFO - PROCESS | 21962 | 05:34:55 INFO - PROCESS | 21962 | [#4] prototype.html Cycles:180 Average:4592.87 Median:5152.19 stddev:1330.88 (25.8%) stddev-sans-first:1295.38 05:34:55 INFO - PROCESS | 21962 | Values: 319.2 332.9 334.0 343.5 344.1 5053.2 5229.8 5232.7 5308.1 5331.5 5237.7 5254.5 5279.1 5288.6 5291.7 4182.2 4185.6 4187.2 4200.5 4220.7 4028.9 4159.8 4191.9 4207.1 4212.7 4073.2 4093.4 4105.7 4123.4 4179.1 4158.4 4162.3 4171.6 4178.3 4200.0 3676.0 3744.6 3763.8 3768.9 3774.7 5139.7 5143.8 5145.8 5159.7 5187.8 4768.6 4780.0 4791.2 4807.1 4821.3 5153.1 5458.7 5495.0 5534.0 5550.5 3967.8 3981.9 3984.3 3984.9 4003.9 5380.2 5476.0 5642.5 5694.9 5730.4 4007.9 4010.3 4028.4 4028.9 4036.9 4057.7 4075.6 4089.4 4099.3 4113.1 4449.7 4560.0 4644.9 4653.7 4710.9 5416.2 5458.6 5484.7 5486.0 5486.2 1379.2 1417.8 1418.1 1424.6 1425.7 875.8 901.7 907.0 928.9 940.5 4681.9 4709.3 4717.6 4743.1 4745.8 4934.6 4948.9 4954.5 4962.7 4968.0 4716.0 4751.9 4765.9 4795.9 4971.3 2966.5 2969.7 3005.2 3017.9 3026.5 5740.6 5794.4 5796.6 5798.8 5820.5 5515.5 5645.1 5714.1 5737.4 5755.9 5779.9 5817.6 5828.3 5834.9 5840.3 5419.3 5597.9 5630.5 5640.8 5644.6 5305.2 5560.2 5574.0 5577.9 5600.9 5671.8 5877.3 5900.6 5902.9 5915.5 4030.7 4036.6 4055.5 4070.1 4091.3 5396.6 5606.7 5618.3 5618.6 5731.7 5545.8 5567.4 5576.9 5584.5 5588.6 5439.4 5476.6 5501.5 5539.6 5567.2 5151.3 5392.2 5394.7 5426.3 5440.4 5466.2 5506.2 5507.3 5511.9 5520.4 5128.2 5371.5 5388.5 5420.7 5424.2 05:34:55 INFO - PROCESS | 21962 | 05:34:55 INFO - PROCESS | 21962 | [#5] yui.html Cycles:180 Average:21294.20 Median:4555.39 stddev:31392.92 (689.1%) stddev-sans-first:31442.84 05:34:55 INFO - PROCESS | 21962 | Values: 683.8 709.6 754.3 763.5 788.7 13204.8 13837.9 13975.2 14355.6 14363.1 12565.5 12569.7 12681.2 12704.7 12757.5 660.1 787.9 795.1 807.5 811.3 783.3 786.6 786.7 786.8 787.4 819.1 823.6 823.6 824.4 825.0 686.0 852.1 872.7 872.9 877.2 591.7 592.7 612.7 615.5 616.0 13755.2 13832.0 13876.1 13881.1 13896.2 14643.9 14940.3 15062.2 15130.6 15187.2 11005.1 11090.6 11153.7 11263.7 11271.7 3953.0 3960.2 3962.5 3967.8 4011.9 76693.2 76767.0 76957.6 77926.0 78081.0 11456.1 11596.8 11657.8 11792.7 11918.3 22722.9 22888.7 22893.7 22947.4 23014.3 8610.1 8710.5 8728.3 8740.4 8815.3 4552.4 4663.4 4690.3 4715.2 4739.9 3692.3 3821.4 3823.1 3829.3 4006.3 577.6 610.2 684.5 694.8 703.4 605.7 764.6 774.4 781.7 784.5 9506.3 9880.0 9885.4 9943.0 10228.0 680.4 701.9 778.3 787.6 789.9 4558.4 4685.5 4742.4 4763.8 4910.8 118675.4 119540.0 120431.0 121916.0 123820.0 102953.0 103080.5 103691.0 103817.5 103822.5 89963.0 91296.5 92460.5 92835.0 92971.0 9321.2 9335.6 9393.8 9470.9 9477.3 51662.0 52118.7 52243.7 53186.5 54097.0 70655.6 78181.6 78408.0 79760.8 80749.6 12410.0 12419.8 12643.1 12940.6 13563.9 14211.8 14607.0 14631.8 14762.7 15512.5 10624.9 12640.7 12867.4 13455.6 13623.3 9251.8 12626.9 13441.4 13771.6 14386.0 13144.9 13416.7 13443.0 14248.2 14388.7 11321.3 11357.1 11849.5 11850.7 12239.4 11025.4 11384.6 11410.8 11507.3 11706.9 05:34:55 INFO - PROCESS | 21962 | -------- Summary: end -------- 05:34:55 INFO - PROCESS | 21962 | 05:34:56 INFO - TEST-INFO | 21962: exit 0 05:34:56 INFO - TEST-OK | dromaeo_css | took 1114662ms 05:34:56 INFO - TEST-START | kraken 05:34:56 INFO - operating with platform_type : linux_ 05:34:56 INFO - Initialising browser for kraken test... 05:34:56 INFO - TEST-INFO | started process 22142 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3Px_DK/profile http://localhost:35768/getInfo.html) 05:35:00 INFO - PROCESS | 22142 | __metrics Screen width/height:1600/1200 05:35:00 INFO - PROCESS | 22142 | colorDepth:24 05:35:00 INFO - PROCESS | 22142 | Browser inner width/height: 1024/697 05:35:00 INFO - PROCESS | 22142 | __metrics 05:35:01 INFO - PROCESS | 22142 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:35:01 INFO - TEST-INFO | 22142: exit 0 05:35:01 INFO - Browser initialized. 05:35:01 INFO - Running cycle 1/1 for kraken test... 05:35:01 INFO - TEST-INFO | started process 22227 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3Px_DK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:35:13 INFO - PROCESS | 22227 | RSS: Main: 173015040 05:35:13 INFO - PROCESS | 22227 | 05:35:16 INFO - PROCESS | 22227 | Cycle 1(1): loaded http://localhost:35768/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35768/tests/kraken/driver.html?testName=audio-beat-detection) 05:35:17 INFO - PROCESS | 22227 | RSS: Main: 232103936 05:35:17 INFO - PROCESS | 22227 | 05:35:19 INFO - PROCESS | 22227 | Cycle 1(1): loaded http://localhost:35768/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35768/tests/kraken/driver.html?testName=audio-dft) 05:35:20 INFO - PROCESS | 22227 | RSS: Main: 219627520 05:35:20 INFO - PROCESS | 22227 | 05:35:23 INFO - PROCESS | 22227 | Cycle 1(1): loaded http://localhost:35768/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35768/tests/kraken/driver.html?testName=audio-fft) 05:35:24 INFO - PROCESS | 22227 | RSS: Main: 285835264 05:35:24 INFO - PROCESS | 22227 | 05:35:26 INFO - PROCESS | 22227 | Cycle 1(1): loaded http://localhost:35768/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35768/tests/kraken/driver.html?testName=audio-oscillator) 05:35:26 INFO - PROCESS | 22227 | RSS: Main: 196894720 05:35:26 INFO - PROCESS | 22227 | 05:35:29 INFO - PROCESS | 22227 | Cycle 1(1): loaded http://localhost:35768/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35768/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:35:29 INFO - PROCESS | 22227 | RSS: Main: 202248192 05:35:29 INFO - PROCESS | 22227 | 05:35:32 INFO - PROCESS | 22227 | Cycle 1(1): loaded http://localhost:35768/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35768/tests/kraken/driver.html?testName=imaging-darkroom) 05:35:33 INFO - PROCESS | 22227 | RSS: Main: 237314048 05:35:33 INFO - PROCESS | 22227 | 05:35:36 INFO - PROCESS | 22227 | Cycle 1(1): loaded http://localhost:35768/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35768/tests/kraken/driver.html?testName=imaging-desaturate) 05:35:37 INFO - PROCESS | 22227 | RSS: Main: 238206976 05:35:37 INFO - PROCESS | 22227 | 05:35:40 INFO - PROCESS | 22227 | Cycle 1(1): loaded http://localhost:35768/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35768/tests/kraken/driver.html?testName=json-parse-financial) 05:35:40 INFO - PROCESS | 22227 | RSS: Main: 237838336 05:35:40 INFO - PROCESS | 22227 | 05:35:42 INFO - PROCESS | 22227 | Cycle 1(1): loaded http://localhost:35768/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35768/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:35:42 INFO - PROCESS | 22227 | RSS: Main: 226344960 05:35:42 INFO - PROCESS | 22227 | 05:35:44 INFO - PROCESS | 22227 | Cycle 1(1): loaded http://localhost:35768/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35768/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:35:45 INFO - PROCESS | 22227 | RSS: Main: 227667968 05:35:45 INFO - PROCESS | 22227 | 05:35:47 INFO - PROCESS | 22227 | Cycle 1(1): loaded http://localhost:35768/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35768/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:35:47 INFO - PROCESS | 22227 | RSS: Main: 237072384 05:35:47 INFO - PROCESS | 22227 | 05:35:50 INFO - PROCESS | 22227 | Cycle 1(1): loaded http://localhost:35768/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35768/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:35:51 INFO - PROCESS | 22227 | RSS: Main: 238776320 05:35:51 INFO - PROCESS | 22227 | 05:35:53 INFO - PROCESS | 22227 | Cycle 1(1): loaded http://localhost:35768/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35768/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:35:54 INFO - PROCESS | 22227 | RSS: Main: 239697920 05:35:54 INFO - PROCESS | 22227 | 05:35:56 INFO - PROCESS | 22227 | Cycle 1(1): loaded http://localhost:35768/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35768/tests/kraken/driver.html?testName=ai-astar) 05:35:56 INFO - PROCESS | 22227 | RSS: Main: 281931776 05:35:56 INFO - PROCESS | 22227 | 05:35:56 INFO - PROCESS | 22227 | __start_tp_report 05:35:56 INFO - PROCESS | 22227 | _x_x_mozilla_page_load 05:35:56 INFO - PROCESS | 22227 | _x_x_mozilla_page_load_details 05:35:56 INFO - PROCESS | 22227 | |i|pagename|runs| 05:35:56 INFO - PROCESS | 22227 | |0;ai-astar;100;113;110;110;110;113;109;110;109;108 05:35:56 INFO - PROCESS | 22227 | |1;audio-beat-detection;150;124;130;195;127;126;151;125;161;126 05:35:56 INFO - PROCESS | 22227 | |2;audio-dft;159;161;159;160;161;162;161;160;161;160 05:35:56 INFO - PROCESS | 22227 | |3;audio-fft;75;75;74;118;75;77;75;75;98;77 05:35:56 INFO - PROCESS | 22227 | |4;audio-oscillator;85;85;125;84;84;86;122;84;85;121 05:35:56 INFO - PROCESS | 22227 | |5;imaging-gaussian-blur;116;117;117;116;117;116;117;116;116;117 05:35:56 INFO - PROCESS | 22227 | |6;imaging-darkroom;145;146;146;146;146;145;146;146;145;146 05:35:56 INFO - PROCESS | 22227 | |7;imaging-desaturate;95;96;95;95;95;95;95;96;94;95 05:35:56 INFO - PROCESS | 22227 | |8;json-parse-financial;53;53;54;53;56;53;54;52;54;55 05:35:56 INFO - PROCESS | 22227 | |9;json-stringify-tinderbox;62;62;62;63;64;64;63;62;63;63 05:35:56 INFO - PROCESS | 22227 | |10;stanford-crypto-aes;85;80;84;81;78;79;79;79;98;81 05:35:56 INFO - PROCESS | 22227 | |11;stanford-crypto-ccm;124;123;121;128;119;121;117;119;124;122 05:35:56 INFO - PROCESS | 22227 | |12;stanford-crypto-pbkdf2;160;161;159;163;162;165;159;157;154;160 05:35:56 INFO - PROCESS | 22227 | |13;stanford-crypto-sha256-iterative;64;62;65;61;65;61;62;62;65;60 05:35:56 INFO - PROCESS | 22227 | __end_tp_report 05:35:56 INFO - PROCESS | 22227 | __start_cc_report 05:35:56 INFO - PROCESS | 22227 | _x_x_mozilla_cycle_collect,1632 05:35:56 INFO - PROCESS | 22227 | __end_cc_report 05:35:56 INFO - PROCESS | 22227 | __startTimestamp1467030956286__endTimestamp 05:35:56 INFO - PROCESS | 22227 | 05:35:56 INFO - PROCESS | 22227 | ------- Summary: start ------- 05:35:56 INFO - PROCESS | 22227 | Number of tests: 14 05:35:56 INFO - PROCESS | 22227 | 05:35:56 INFO - PROCESS | 22227 | [#0] ai-astar Cycles:10 Average:109.20 Median:110.00 stddev:3.61 (3.3%) stddev-sans-first:1.72 05:35:56 INFO - PROCESS | 22227 | Values: 100.0 113.0 110.0 110.0 110.0 113.0 109.0 110.0 109.0 108.0 05:35:56 INFO - PROCESS | 22227 | 05:35:56 INFO - PROCESS | 22227 | [#1] audio-beat-detection Cycles:10 Average:141.50 Median:140.00 stddev:23.11 (16.5%) stddev-sans-first:24.31 05:35:56 INFO - PROCESS | 22227 | Values: 150.0 124.0 130.0 195.0 127.0 126.0 151.0 125.0 161.0 126.0 05:35:56 INFO - PROCESS | 22227 | 05:35:56 INFO - PROCESS | 22227 | [#2] audio-dft Cycles:10 Average:160.40 Median:161.00 stddev:0.97 (0.6%) stddev-sans-first:0.88 05:35:56 INFO - PROCESS | 22227 | Values: 159.0 161.0 159.0 160.0 161.0 162.0 161.0 160.0 161.0 160.0 05:35:56 INFO - PROCESS | 22227 | 05:35:56 INFO - PROCESS | 22227 | [#3] audio-fft Cycles:10 Average:81.90 Median:75.00 stddev:14.57 (19.4%) stddev-sans-first:15.24 05:35:56 INFO - PROCESS | 22227 | Values: 75.0 75.0 74.0 118.0 75.0 77.0 75.0 75.0 98.0 77.0 05:35:56 INFO - PROCESS | 22227 | 05:35:56 INFO - PROCESS | 22227 | [#4] audio-oscillator Cycles:10 Average:96.10 Median:84.50 stddev:18.37 (21.7%) stddev-sans-first:19.04 05:35:56 INFO - PROCESS | 22227 | Values: 85.0 85.0 125.0 84.0 84.0 86.0 122.0 84.0 85.0 121.0 05:35:56 INFO - PROCESS | 22227 | 05:35:56 INFO - PROCESS | 22227 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 05:35:56 INFO - PROCESS | 22227 | Values: 116.0 117.0 117.0 116.0 117.0 116.0 117.0 116.0 116.0 117.0 05:35:56 INFO - PROCESS | 22227 | 05:35:56 INFO - PROCESS | 22227 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 05:35:56 INFO - PROCESS | 22227 | Values: 145.0 146.0 146.0 146.0 146.0 145.0 146.0 146.0 145.0 146.0 05:35:56 INFO - PROCESS | 22227 | 05:35:56 INFO - PROCESS | 22227 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 05:35:56 INFO - PROCESS | 22227 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 96.0 94.0 95.0 05:35:56 INFO - PROCESS | 22227 | 05:35:56 INFO - PROCESS | 22227 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.00 stddev:1.16 (2.1%) stddev-sans-first:1.20 05:35:56 INFO - PROCESS | 22227 | Values: 53.0 53.0 54.0 53.0 56.0 53.0 54.0 52.0 54.0 55.0 05:35:56 INFO - PROCESS | 22227 | 05:35:56 INFO - PROCESS | 22227 | [#9] json-stringify-tinderbox Cycles:10 Average:62.80 Median:63.00 stddev:0.79 (1.3%) stddev-sans-first:0.78 05:35:56 INFO - PROCESS | 22227 | Values: 62.0 62.0 62.0 63.0 64.0 64.0 63.0 62.0 63.0 63.0 05:35:56 INFO - PROCESS | 22227 | 05:35:56 INFO - PROCESS | 22227 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:81.00 stddev:5.93 (7.3%) stddev-sans-first:6.21 05:35:56 INFO - PROCESS | 22227 | Values: 85.0 80.0 84.0 81.0 78.0 79.0 79.0 79.0 98.0 81.0 05:35:56 INFO - PROCESS | 22227 | 05:35:56 INFO - PROCESS | 22227 | [#11] stanford-crypto-ccm Cycles:10 Average:121.80 Median:122.50 stddev:3.16 (2.6%) stddev-sans-first:3.24 05:35:56 INFO - PROCESS | 22227 | Values: 124.0 123.0 121.0 128.0 119.0 121.0 117.0 119.0 124.0 122.0 05:35:56 INFO - PROCESS | 22227 | 05:35:56 INFO - PROCESS | 22227 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.00 Median:160.50 stddev:3.09 (1.9%) stddev-sans-first:3.28 05:35:56 INFO - PROCESS | 22227 | Values: 160.0 161.0 159.0 163.0 162.0 165.0 159.0 157.0 154.0 160.0 05:35:56 INFO - PROCESS | 22227 | 05:35:56 INFO - PROCESS | 22227 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:1.89 (3.0%) stddev-sans-first:1.94 05:35:56 INFO - PROCESS | 22227 | Values: 64.0 62.0 65.0 61.0 65.0 61.0 62.0 62.0 65.0 60.0 05:35:56 INFO - PROCESS | 22227 | -------- Summary: end -------- 05:35:56 INFO - PROCESS | 22227 | 05:35:57 INFO - TEST-INFO | 22227: exit 0 05:35:57 INFO - TEST-OK | kraken | took 60971ms 05:35:57 INFO - SUITE-END | took 1175s 05:35:57 INFO - Completed test suite (00:19:35) 05:35:57 INFO - javascript benchmark 05:35:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3158.810471371718, 3171.4767063434533, 3188.6492485826557, 3189.282411457421, 3236.1585987643207, 5315.388730296007, 5350.866228344294, 5433.320834895638, 5512.0, 5550.528205102561, 5417.349918009844, 5424.0779067558515, 5431.266778984846, 5485.040117979358, 5491.368492623349, 4867.610591152699, 4955.776990035439, 4967.70193788372, 4976.178930476467, 5090.694558326494, 4953.257011448276, 4975.8258460953875, 5011.1481048221885, 5014.2979982802435, 5046.394432668085, 4877.317175595419, 4879.170541008037, 4926.088673595378, 4926.753662316905, 4952.380952380952, 4912.557869791736, 4920.655554111214, 4923.08922849274, 4936.48166942473, 4974.204127339608, 4911.189653707134, 4954.628402869799, 4958.727270000185, 4963.354763880672, 5009.749512524396, 5295.629305948585, 5347.304850369466, 5401.540869026137, 5431.348238211401, 5432.320959880015, 5839.824805255849, 5841.269841269841, 5878.382769809151, 5892.675902825343, 5897.3218079920925, 5907.527397808165, 5911.615744976562, 5927.436893495111, 5938.109283607493, 5950.1372301016545, 5317.361916569997, 5350.571954243651, 5383.246345511631, 5404.567634589223, 5484.506394424521, 5955.37468565803, 5959.106134079836, 5959.106134079922, 5962.284525856925, 5986.790462333797, 5568.6658800472105, 5750.338711048283, 5753.798617048383, 5756.769729210785, 5757.395473475309, 5790.36306006339, 5853.443922827325, 5855.765769369263, 5893.499052580493, 5899.056151015817, 5854.092615644497, 5862.413758624103, 5863.589548731633, 5865.472107510344, 5868.119782032644, 5794.594378393472, 5802.448767367094, 5865.648061116347, 5866.208061911672, 5869.266341707286, 4391.824327026947, 4430.579094985971, 4431.7562534060935, 4434.091011342667, 4462.308342206963, 3980.880573582739, 3984.1234928316303, 3994.9001274967777, 4018.3972404139026, 4054.918901621951, 5581.832545023656, 5594.636348637326, 5602.775888964396, 5603.159526071122, 5643.633163844337, 5656.717164141859, 5756.165356023437, 5768.192453056576, 5788.421157884178, 5945.227120474311, 5543.805966791143, 5545.77816887328, 5545.916811247835, 5551.694656793834, 5553.333599968029, 5041.899162016739, 5043.470435604282, 5049.495050494995, 5049.697018178921, 5099.745012749348, 5891.970540147272, 5982.222311099529, 6065.0, 6065.181200537871, 6115.969420152871, 5857.121431785266, 5861.706914654165, 5865.0, 5866.3547009828035, 5869.8239052828485, 5827.096799996008, 6083.422074902877, 6106.45041946227, 6110.419510146529, 6112.0, 5671.914921276101, 5674.319081710221, 5722.027255366681, 5755.539556835527, 5764.279465066867, 5820.0, 5851.590388672752, 5852.707364631837, 5852.736626851717, 5859.2090067842, 5560.638558493685, 5599.580031497735, 5690.487856092972, 5693.373728889902, 5698.572607054571, 5608.270924779753, 5683.857903552279, 5687.5449964001955, 5690.203371527907, 5741.913871292018, 5591.217229587943, 5596.440355964533, 5596.720163991703, 5598.580106492111, 5598.580106492111, 5587.1339942309005, 5613.943860561342, 5629.887402252014, 5703.714814259188, 5766.250387449605, 5461.617686761889, 5462.781488740406, 5497.532709719719, 5531.8893622128135, 5571.554275657856], "value": 5373.698792853068, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.566732784076, 603.2911329188203, 624.241546520977, 625.7152995387099, 639.5299454900644, 42326.36510452342, 43619.78190109049, 43700.56299437005, 43714.0, 47439.0, 44473.77763111188, 44515.10969780602, 44790.10419791602, 44847.0, 44861.0, 8722.127787221274, 8840.823183536326, 8888.466691998468, 8919.197272245498, 8923.10768923109, 8765.298776097898, 8948.463092214455, 8977.685780997666, 8987.640494380217, 9000.8649870252, 9025.548722563879, 9033.457992520469, 9036.45781253127, 9036.954815225914, 9102.499362535058, 8864.423812452202, 8924.910750892474, 8925.464472131693, 8929.553522323922, 8935.508547029944, 8769.210771030574, 8882.245009174228, 8922.375433719642, 8931.37480376374, 8931.464112153291, 41710.79144604288, 42047.789761051, 42209.0, 42213.577864221275, 42216.78891605522, 3657.2868290683327, 3695.2978934002454, 3732.1602639405914, 3763.604821493731, 3936.5079365079364, 32157.1960700982, 32397.676023239936, 32783.6721632783, 33208.833955830305, 33222.973945588186, 3612.9341844155774, 3624.9275014499563, 3656.9675376088626, 3672.192117734094, 3761.1913438610554, 308861.0, 309681.0, 310454.0, 310511.0, 311298.0, 50739.746301269, 57121.428785712444, 57143.42856571464, 57180.14229786557, 57209.71395143081, 35346.82326588402, 36143.81928090343, 36259.456108158396, 38192.61807381891, 60410.0, 14541.054831435922, 14592.197429141499, 14662.266886655625, 14662.560123196321, 14674.55976320712, 10393.688189354332, 10416.427096509764, 10443.216758743125, 10445.164386849034, 10445.321054131457, 19476.318328858422, 19583.216671333274, 19646.901765491082, 19809.603807923762, 19837.702434463496, 7069.762791511465, 7121.537100088478, 7303.0, 7337.229590892986, 7341.192468828424, 960.6829746183743, 1029.1972261635935, 1052.5474046160225, 1090.9618163364244, 1094.6332978452149, 32293.0, 32493.187670307958, 32552.348953020806, 32895.83552082224, 32955.67044329574, 1107.789519991199, 1148.4085695866636, 1160.7446361800392, 1163.8021536338842, 1164.1618035014776, 16508.77674848301, 17106.743398849027, 17183.226754796066, 17211.741823872653, 17570.82429175692, 525544.0, 529717.0, 533423.0, 533490.0, 534604.0, 58774.0, 59578.702106490055, 59600.40399595949, 59615.0, 59618.403815962156, 1224.6815827884636, 1294.1911305434103, 1354.945802167922, 1355.1530293566718, 1357.9660508487366, 32049.0, 32875.835620821745, 33466.83266583652, 33722.0, 33739.662603373654, 50395.49604503908, 50804.0, 50833.74583127061, 50990.23514647209, 51012.23481647852, 381331.0, 381529.0, 382131.0, 382468.0, 383056.0, 24787.0, 24845.751542484344, 27752.58371124475, 27775.722242777312, 28667.56998645064, 48309.27536086891, 48358.758206208746, 48379.0, 48949.8328427726, 49390.50609493859, 40071.1985760289, 40322.1935561293, 40629.59370406258, 40783.38824917688, 41951.58048419599, 40363.0, 40933.79533102315, 40965.951702415354, 41183.176336472505, 41189.1762164761, 39889.601103988585, 40588.94110588918, 41313.0, 41411.79294103631, 44432.77783611061, 34736.478952815225, 37244.25511489809, 37415.81292093522, 38205.0, 38308.23383532369, 27781.722182777914, 27870.44259114847, 27921.860390697915, 28386.716132838406, 28404.0], "value": 19621.277478993183, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.9540455145383, 386.1100164121699, 396.7361704466528, 396.77582166076184, 415.8544509421703, 14335.426582936696, 16181.352745890179, 18155.546111347205, 19470.0, 19580.902095489502, 13073.681150995499, 13995.300234988235, 17047.829521704778, 17085.40201092962, 17460.56348591286, 5499.0, 5589.189567512708, 5658.490735833774, 5715.1998720179, 5735.08238681811, 3748.3253014457387, 5635.408282130379, 5813.82558523245, 5877.2065771121, 5973.701314934236, 6002.009668404708, 6010.819675409723, 6022.036474164134, 6023.066424704156, 6027.517798576126, 5995.4304341087745, 6228.564000519943, 6522.608643481359, 6533.705983230766, 6535.2484464286745, 5086.415062267813, 5809.941900581025, 5839.737211825478, 5844.970775146139, 5851.941480585182, 13593.0, 13849.19960405151, 13853.0, 13858.584242472742, 15718.921405393014, 2244.584751820902, 2262.8981695823563, 2343.7070366204225, 2404.446977195255, 2460.987695061513, 10453.0, 10747.140228781678, 12609.495620175274, 13493.2578708171, 13987.510437134753, 1864.0586503815623, 1914.9521261968562, 1924.980750192494, 1944.6694062009492, 1958.265650381107, 79553.60223198905, 83749.58125209397, 84151.57924210401, 84822.15177848205, 84927.57536212403, 10854.511546980404, 11030.889691102986, 11083.445827708743, 11218.326900386002, 11228.831567526493, 15508.92245538765, 15588.844111558967, 15637.296321665552, 15650.217489125725, 15683.372665093268, 7291.52605080668, 7440.441966852508, 7480.663370148356, 7511.586862722494, 7517.398608111338, 7031.437485001187, 7078.504504684725, 7139.82150446243, 7256.383207427428, 7273.3453989141235, 4722.858314250578, 4771.451283102488, 4775.904481910412, 4840.467548569654, 4850.936329588015, 1785.9642807143784, 1858.7490688756845, 1913.9043047847551, 1956.9706454403195, 2010.45717656232, 991.7173605522391, 998.5606333213362, 1005.5374527717186, 1034.9482525873675, 1123.3652986062848, 18100.45698629043, 18913.14890829916, 19092.427227183205, 19136.80863191378, 19358.128884200243, 975.6097560975667, 987.9697222208288, 1007.596961215505, 1010.757418219622, 1023.5291765787821, 9888.851667224853, 10682.519286631965, 10804.1896857736, 10820.13438924884, 10824.891751082547, 426114.0, 429726.0, 436236.0, 436832.60588061676, 440129.0, 91491.71270718152, 91620.54189729008, 91771.0, 92262.53868730614, 93138.53430732802, 982.3958265666564, 991.0386924683046, 1021.5403068619152, 1025.5487585462372, 1026.4046852825343, 16523.173841307645, 16525.66948661044, 16640.75038874442, 16965.406210783058, 17232.827671723622, 42104.0, 43248.783756081015, 43401.782991084845, 43898.341524876516, 43945.78027109972, 53147.46852531425, 54443.45556544384, 55909.16136257878, 61845.69077154585, 62207.37792622197, 8502.44734092282, 8533.914660853561, 8561.914380856111, 8670.176333248332, 8724.476531408136, 8753.868691969752, 13259.933700331436, 13373.39819708135, 13816.24010679382, 14118.152910825384, 11120.833187502356, 11865.881341186478, 12105.213161144497, 12150.331731754839, 12209.816852747039, 11640.708982275512, 11678.532858685558, 12023.398830058288, 12260.26438413698, 12306.692332691397, 12007.399630018639, 12014.279143251433, 12197.878021220029, 12399.0, 12564.120511564102, 7558.811029724301, 7989.560574168244, 8937.642494300415, 9094.090590940854, 9180.862287065565, 11897.167198296036, 12065.457054432747, 12105.81841272364, 12115.878841211828, 12164.330961797186], "value": 9049.223704283111, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1341.4634146341457, 1460.2917584971287, 1494.5292232946622, 1535.1019653502701, 1677.3458351243016, 8247.587620618968, 8635.481871087732, 8651.04838467768, 8868.46789192649, 8881.46711197327, 8587.05542390338, 8769.254613357856, 8769.56152192391, 8773.824523509526, 8780.912190878089, 1995.451250905998, 2243.4391402149463, 2313.8893331201034, 2359.9764002360016, 2391.3184742348435, 2305.5043165719367, 2320.373499155227, 2320.466292752668, 2320.5474932388192, 2321.9071237150492, 2313.7801908818637, 2316.119874447716, 2346.3547524430833, 2351.0478256306224, 2351.318117745852, 1943.2712732725229, 2227.1091563374616, 2286.965695514569, 2290.5876942150408, 2300.1144559344607, 2322.93031209064, 2325.3256555598855, 2341.098677009347, 2343.1915988983774, 2343.379004563792, 9099.909000909973, 9135.817283654289, 9185.954070229673, 9211.493367864765, 9213.355065145442, 5327.786888524454, 5467.234587157801, 5468.890622187574, 5469.371022332443, 5469.972650136764, 3220.0, 3307.5534802801553, 3364.158960259935, 3376.9155771105675, 3417.3848707232687, 1045.900639439252, 1052.2739309876238, 1053.8261186904151, 1061.2040969273046, 1085.7991271614776, 12420.875791242062, 12534.561290354884, 12534.874651253462, 12554.623361299084, 12556.434960426803, 4658.7437690926645, 4717.622590192776, 4818.855434336975, 4820.734859582757, 4827.324174615556, 10464.581416743245, 10473.895261047444, 10496.68509944703, 10506.73733156662, 10512.842307365396, 5200.193969934666, 5205.037068142406, 5210.687358758487, 5212.400573934046, 5216.37403511581, 4379.759113248802, 4751.619870410359, 4866.902661946812, 4879.1461494238365, 4948.307236986825, 4099.262132816062, 4107.507099148122, 4126.1128857295225, 4168.353905144708, 4175.394567787715, 1266.4364357860848, 1299.4217573179844, 1309.1948451702135, 1319.2546211390725, 1319.3930791835862, 895.8656201569817, 1016.434690576504, 1017.8320577104695, 1018.3686114608989, 1018.8369860822232, 5929.703514824241, 5976.7908123215475, 6046.183765191643, 6197.721102550396, 6260.749570017239, 905.158202871336, 918.7840857398639, 951.1772316945792, 975.317277905469, 994.5723338964315, 4111.342185250405, 4254.42565253693, 4283.2932566126865, 4291.871243862689, 4352.847650332286, 10936.835947460795, 11300.94349528247, 11303.547858085749, 11370.54517819278, 11468.770624587461, 11225.0, 11329.150313726503, 11331.093512518979, 11364.602238921598, 11366.943165284121, 7918.208179182036, 8221.958890205391, 8381.329493640495, 8520.659173633108, 8525.147485251426, 5938.6354260378475, 6095.1466794647895, 6160.0, 6162.168107305456, 6186.19579454668, 10473.633422830164, 10521.579136834442, 10554.313969591953, 10687.46562671879, 10702.785944280915, 10364.948175259377, 10597.15222782191, 10824.4046577439, 10830.350178989285, 10850.511726972147, 7331.963340183265, 7978.8005299865645, 8145.389095817956, 8210.630521626661, 8584.270337021173, 8577.185167409087, 8745.300375970035, 8762.912370876466, 8825.470471771714, 8832.91167088321, 7542.736004239825, 7570.394368450621, 7648.464607477423, 7784.532928024337, 7840.647170877211, 7805.2194780521495, 7807.843843123219, 7854.960725196337, 7858.0, 7870.173631768582, 6975.511714179958, 7045.929540704527, 7065.858682826212, 7068.752593659197, 7074.929250707427, 5008.874778130576, 5136.768845401891, 5143.768530416065, 5264.4735526448585, 5346.331708536433, 4998.950010499849, 5006.974965125151, 5055.368078990126, 5071.949280507148, 5163.509466600667], "value": 4693.4418194442505, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.1542412606592, 332.88848235840993, 333.9816310102946, 343.5396568598078, 344.1327853808403, 5053.216751403529, 5229.790808367666, 5232.659877107995, 5308.124159513681, 5331.493508116732, 5237.7381130943495, 5254.527092561669, 5279.076161671711, 5288.5504732097725, 5291.708956007418, 4182.184474027566, 4185.602367775056, 4187.183499217654, 4200.537940826506, 4220.746755194698, 4028.8992775180564, 4159.812808423628, 4191.895202619944, 4207.095474472988, 4212.747235165884, 4073.205724883649, 4093.4269202311702, 4105.659773928862, 4123.412486192822, 4179.101493178966, 4158.37624356346, 4162.334026555736, 4171.645410140141, 4178.289690752549, 4199.958000419987, 3676.0149519259567, 3744.55065392152, 3763.849446022156, 3768.888177987473, 3774.660280574734, 5139.691618502902, 5143.794248230066, 5145.819896303611, 5159.664621799571, 5187.8184263550975, 4768.642351823627, 4780.0, 4791.233402655594, 4807.086653535817, 4821.325014497938, 5153.123968925292, 5458.6724796512335, 5494.972525137348, 5533.972330138364, 5550.500454959073, 3967.841286348543, 3981.900452488682, 3984.342583473723, 3984.940225896614, 4003.8798836034966, 5380.192971054334, 5475.972620136914, 5642.463965923231, 5694.943050569483, 5730.369659337512, 4007.919841603152, 4010.3382941814857, 4028.3554631259444, 4028.879133625996, 4036.858709945138, 4057.660971879273, 4075.59244075596, 4089.386592011222, 4099.282625540519, 4113.095119073799, 4449.666275029385, 4560.042391097841, 4644.883877903079, 4653.674242803039, 4710.88222794426, 5416.214648875891, 5458.61789674719, 5484.670919744828, 5485.9725701371235, 5486.177073439016, 1379.2138481065697, 1417.8369487508862, 1418.1136789506559, 1424.5512663511167, 1425.6863490032176, 875.8335916176034, 901.6889173235223, 906.959186836594, 928.8621438737628, 940.4686352210979, 4681.882952926204, 4709.317149013443, 4717.646176536705, 4743.079052983548, 4745.833895813699, 4934.605231581537, 4948.901021979612, 4954.455009948902, 4962.667546253255, 4967.950320496821, 4715.958206956562, 4751.859553707085, 4765.880852978634, 4795.930604413178, 4971.328870602495, 2966.5401862710883, 2969.728157959163, 3005.248687828043, 3017.9245518862203, 3026.546018097303, 5740.598158128974, 5794.391588883191, 5796.608983744472, 5798.82603521895, 5820.476157145878, 5515.549260936373, 5645.125005624135, 5714.142878568248, 5737.3688894221605, 5755.884882302331, 5779.88440231193, 5817.621854579524, 5828.300603927556, 5834.854128646818, 5840.328362238312, 5419.268398766116, 5597.944020559742, 5630.451625802937, 5640.774369025193, 5644.604877658525, 5305.2307415423775, 5560.19377190297, 5574.0, 5577.888442231214, 5600.859978500407, 5671.829845104653, 5877.294724633071, 5900.557458190567, 5902.907962027039, 5915.526757859447, 4030.717849750489, 4036.6367026967714, 4055.4930633670792, 4070.0842310479907, 4091.304478238647, 5396.595255355943, 5606.6636001840025, 5618.297712785902, 5618.606697531133, 5731.684757338219, 5545.833624991256, 5567.387587365468, 5576.888462230651, 5584.497395234448, 5588.580856435702, 5439.4288599696465, 5476.58925580591, 5501.477359650827, 5539.556835453073, 5567.192757050286, 5151.253068305, 5392.218128371443, 5394.676319420847, 5426.321709786277, 5440.428754980829, 5466.1527463243265, 5506.201600767947, 5507.339119305709, 5511.925174590916, 5520.392756796668, 5128.230765385222, 5371.543418809445, 5388.46115388458, 5420.728963551728, 5424.159255315432], "value": 4169.90263012424, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [683.8495530983182, 709.6026225313825, 754.2909664914976, 763.4655740981312, 788.668759121169, 13204.801927971075, 13837.861621383783, 13975.231362275072, 14355.569332920017, 14363.138211707279, 12565.497380104785, 12569.685757856058, 12681.239125652468, 12704.682382940431, 12757.489700411996, 660.0561197487591, 787.8857565652977, 795.101535265151, 807.4993504027511, 811.3063330852125, 783.3263393481601, 786.6066966516742, 786.7049856303886, 786.8268980824238, 787.3976408047848, 819.0785366462729, 823.567626995826, 823.6129019360891, 824.3652387661497, 824.9670013199465, 685.9984422742801, 852.1393392673383, 872.733816186063, 872.9214370706667, 877.1535468273147, 591.7130191856946, 592.6532978207754, 612.6905912514152, 615.4799194680488, 616.0420546050889, 13755.243461609607, 13832.0, 13876.098053626481, 13881.097728647606, 13896.16623002623, 14643.853561464462, 14940.252987350588, 15062.171580563065, 15130.621734456616, 15187.164705941168, 11005.119590432827, 11090.55637774488, 11153.72115697106, 11263.66209013731, 11271.661850144508, 3953.0, 3960.2475529649273, 3962.5443074046566, 3967.841286348543, 4011.8997025074314, 76693.23306766861, 76767.0, 76957.61521192415, 77926.0, 78081.0, 11456.140789440658, 11596.826047609293, 11657.76684466306, 11792.705182370339, 11918.344491052902, 22722.886385568298, 22888.65667014996, 22893.656595151086, 22947.426314342276, 23014.309570712907, 8610.13898610134, 8710.47737135774, 8728.345374096969, 8740.431871928304, 8815.294776417999, 4552.362669226245, 4663.3937588114, 4690.319903614025, 4715.221988371949, 4739.881502962454, 3692.2615476904725, 3821.407681809324, 3823.101571130782, 3829.2532956073856, 4006.258842114218, 577.6245440463732, 610.1701685707434, 684.5379368925956, 694.7846167688033, 703.4126504368807, 605.7455868535226, 764.6176911544228, 774.4462709162975, 781.6677911887425, 784.5371230973753, 9506.33455658111, 9879.950600246953, 9885.357451765612, 9943.0, 10228.0, 680.4148432348177, 701.9438444924393, 778.2995304226241, 787.6022608582629, 789.8578255913991, 4558.407407037064, 4685.508021657745, 4742.430908291027, 4763.809447622057, 4910.754462276872, 118675.40662296633, 119540.0, 120431.0, 121916.0, 123820.0, 102953.0, 103080.48459757653, 103691.0, 103817.48091259495, 103822.48088759658, 89963.0, 91296.54351728199, 92460.5435445353, 92835.0, 92971.0, 9321.20769734553, 9335.57989890443, 9393.81212375735, 9470.905290947278, 9477.289203309641, 51662.0, 52118.739406302724, 52243.73878130585, 53186.46813531815, 54097.0, 70655.64672176607, 78181.60909195417, 78408.0, 79760.82152606061, 80749.59625201837, 12410.0, 12419.813702794647, 12643.114981951176, 12940.611781646565, 13563.93218033943, 14211.786823197866, 14607.0, 14631.82945364347, 14762.704745905237, 15512.457064002705, 10624.946875265574, 12640.74718505643, 12867.420966056363, 13455.596332110052, 13623.250721210428, 9251.814963700823, 12626.936865315982, 13441.395137219044, 13771.586852394445, 14386.0, 13144.934275328944, 13416.731665366833, 13443.0, 14248.216348100954, 14388.674516175388, 11321.264117832314, 11357.101925903911, 11849.526018959144, 11850.703732406413, 12239.388030598613, 11025.393603351893, 11384.601538946097, 11410.771784564096, 11507.252028618113, 11706.941465292619], "value": 7553.954899082243, "unit": "score"}], "name": "dromaeo_css", "value": 7215.081967116051, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 113.0, 110.0, 110.0, 110.0, 113.0, 109.0, 110.0, 109.0, 108.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 124.0, 130.0, 195.0, 127.0, 126.0, 151.0, 125.0, 161.0, 126.0], "value": 141.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 161.0, 159.0, 160.0, 161.0, 162.0, 161.0, 160.0, 161.0, 160.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 118.0, 75.0, 77.0, 75.0, 75.0, 98.0, 77.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 125.0, 84.0, 84.0, 86.0, 122.0, 84.0, 85.0, 121.0], "value": 96.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 94.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 54.0, 53.0, 56.0, 53.0, 54.0, 52.0, 54.0, 55.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 63.0, 64.0, 64.0, 63.0, 62.0, 63.0, 63.0], "value": 62.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 80.0, 84.0, 81.0, 78.0, 79.0, 79.0, 79.0, 98.0, 81.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 123.0, 121.0, 128.0, 119.0, 121.0, 117.0, 119.0, 124.0, 122.0], "value": 121.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 159.0, 163.0, 162.0, 165.0, 159.0, 157.0, 154.0, 160.0], "value": 160.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 65.0, 61.0, 65.0, 61.0, 62.0, 62.0, 65.0, 60.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1489.8000000000002, "alertThreshold": 2.0}]} 05:35:57 INFO - Return code: 0 05:35:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:35:57 INFO - # TBPL SUCCESS # 05:35:57 INFO - Running post-action listener: _resource_record_post_action 05:35:57 INFO - ##### 05:35:57 INFO - ##### Finished run-tests step (success) 05:35:57 INFO - ##### 05:35:57 INFO - Running post-run listener: _resource_record_post_run 05:35:57 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 406183936; Read time: 12; Write time: 310152 05:35:57 INFO - TinderboxPrint: CPU usage
13.1% 05:35:57 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 05:35:57 INFO - TinderboxPrint: I/O write bytes / time
406,183,936 / 310,152 05:35:57 INFO - TinderboxPrint: CPU idle
8,275.5 (86.9%) 05:35:57 INFO - TinderboxPrint: CPU user
1,204.9 (12.6%) 05:35:57 INFO - TinderboxPrint: Swap in / out
0 / 0 05:35:57 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 108670976; Read time: 0; Write time: 75368 05:35:57 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 296603648; Read time: 12; Write time: 234776 05:35:58 INFO - Running post-run listener: _upload_blobber_files 05:35:58 INFO - Blob upload gear active. 05:35:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:35:58 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:35:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:35:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:35:58 INFO - (blobuploader) - INFO - Open directory for files ... 05:35:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:35:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:35:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:36:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:36:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:36:01 INFO - (blobuploader) - INFO - Done attempting. 05:36:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:36:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:36:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:36:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:36:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:36:02 INFO - (blobuploader) - INFO - Done attempting. 05:36:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:36:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:36:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:36:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:36:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:36:03 INFO - (blobuploader) - INFO - Done attempting. 05:36:03 INFO - (blobuploader) - INFO - Iteration through files over. 05:36:03 INFO - Return code: 0 05:36:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:36:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:36:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2626521ec93d3aed7b8c8149ab052b5bdfeb7362035dbaaae8bd2ecb072e0276929dfd40782f9b35d913f48bfcab2fffa05856870df1e08859456ff11c105749", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/caa992a11b8e7ef93dd03afbe35156d75e3392662bd2671977f57801424e8778b5c5385a5bc495c0ac499411f86043a0d3fdac068907d75f9b9d92913257373a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b7a5e35687f72aaa0020950767d4a4010fc2088c4439b1a763f0c26ec3e52e4cfe27f13b464c8383a6067b50e0cb21c514806b3f8b10e7e235755cbc074edb8c"} 05:36:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:36:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:36:03 INFO - Contents: 05:36:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2626521ec93d3aed7b8c8149ab052b5bdfeb7362035dbaaae8bd2ecb072e0276929dfd40782f9b35d913f48bfcab2fffa05856870df1e08859456ff11c105749", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/caa992a11b8e7ef93dd03afbe35156d75e3392662bd2671977f57801424e8778b5c5385a5bc495c0ac499411f86043a0d3fdac068907d75f9b9d92913257373a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b7a5e35687f72aaa0020950767d4a4010fc2088c4439b1a763f0c26ec3e52e4cfe27f13b464c8383a6067b50e0cb21c514806b3f8b10e7e235755cbc074edb8c"} 05:36:03 INFO - Running post-run listener: copy_logs_to_upload_dir 05:36:03 INFO - Copying logs to upload dir... 05:36:03 INFO - mkdir: /builds/slave/test/build/upload/logs 05:36:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.169680 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-06-27 05:36:03.586773) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 05:36:03.590462) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1467028509.732530-115788635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2626521ec93d3aed7b8c8149ab052b5bdfeb7362035dbaaae8bd2ecb072e0276929dfd40782f9b35d913f48bfcab2fffa05856870df1e08859456ff11c105749", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/caa992a11b8e7ef93dd03afbe35156d75e3392662bd2671977f57801424e8778b5c5385a5bc495c0ac499411f86043a0d3fdac068907d75f9b9d92913257373a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b7a5e35687f72aaa0020950767d4a4010fc2088c4439b1a763f0c26ec3e52e4cfe27f13b464c8383a6067b50e0cb21c514806b3f8b10e7e235755cbc074edb8c"} build_url:https://queue.taskcluster.net/v1/task/Gdjo8yWkT3OU03su9oXUug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011456 build_url: 'https://queue.taskcluster.net/v1/task/Gdjo8yWkT3OU03su9oXUug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2626521ec93d3aed7b8c8149ab052b5bdfeb7362035dbaaae8bd2ecb072e0276929dfd40782f9b35d913f48bfcab2fffa05856870df1e08859456ff11c105749", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/caa992a11b8e7ef93dd03afbe35156d75e3392662bd2671977f57801424e8778b5c5385a5bc495c0ac499411f86043a0d3fdac068907d75f9b9d92913257373a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b7a5e35687f72aaa0020950767d4a4010fc2088c4439b1a763f0c26ec3e52e4cfe27f13b464c8383a6067b50e0cb21c514806b3f8b10e7e235755cbc074edb8c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 05:36:03.618602) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 05:36:03.619369) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1467028509.732530-115788635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004460 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 05:36:03.703055) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 05:36:03.703804) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 05:36:03.704500) ========= ========= Total master_lag: 0.20 =========