builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-030 starttime: 1467029240.57 results: success (0) buildid: 20160627023004 builduid: 3464b57a3a514b4db223c1cbf73f3b98 revision: 9688cac5afbe215406ac95aa1a7972960666ca1c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 05:07:20.574673) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 05:07:20.575291) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 05:07:20.575632) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 05:07:20.591930) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 05:07:20.592437) ========= 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=4ac8d263c7293b36a1be1aed000001be-1467028020.970765-1361796438 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 05:07:21-- 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% 114M=0s 2016-06-27 05:07:21 (114 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123010 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 05:07:20.739979) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 05:07:20.740348) ========= 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=4ac8d263c7293b36a1be1aed000001be-1467028020.970765-1361796438 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017085 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 05:07:20.794151) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-27 05:07:20.795037) ========= 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=4ac8d263c7293b36a1be1aed000001be-1467028020.970765-1361796438 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 05:07:21,265 truncating revision to first 12 chars 2016-06-27 05:07:21,265 Setting DEBUG logging. 2016-06-27 05:07:21,265 attempt 1/10 2016-06-27 05:07:21,265 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:07:22,385 unpacking tar archive at: fx-team-9688cac5afbe/testing/mozharness/ program finished with exit code 0 elapsedTime=1.454319 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-27 05:07:22.267892) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 05:07:22.268230) ========= script_repo_revision: 9688cac5afbe215406ac95aa1a7972960666ca1c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 05:07:22.268732) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 05:07:22.269059) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 05:07:22.280502) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-06-27 05:07:22.280841) ========= /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=4ac8d263c7293b36a1be1aed000001be-1467028020.970765-1361796438 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:07:22 INFO - MultiFileLogger online at 20160627 05:07:22 in /builds/slave/test 05:07:22 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:07:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:07:22 INFO - {'append_to_log': False, 05:07:22 INFO - 'base_work_dir': '/builds/slave/test', 05:07:22 INFO - 'blob_upload_branch': 'Fx-Team', 05:07:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:07:22 INFO - 'branch': 'Fx-Team', 05:07:22 INFO - 'buildbot_json_path': 'buildprops.json', 05:07:22 INFO - 'config_files': ('talos/linux_config.py',), 05:07:22 INFO - 'default_actions': ('clobber', 05:07:22 INFO - 'read-buildbot-config', 05:07:22 INFO - 'download-and-extract', 05:07:22 INFO - 'populate-webroot', 05:07:22 INFO - 'create-virtualenv', 05:07:22 INFO - 'install', 05:07:22 INFO - 'run-tests'), 05:07:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:07:22 INFO - 'download_minidump_stackwalk': True, 05:07:22 INFO - 'download_symbols': 'ondemand', 05:07:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:07:22 INFO - 'tooltool.py': '/tools/tooltool.py', 05:07:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:07:22 INFO - '/tools/misc-python/virtualenv.py')}, 05:07:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:07:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:07:22 INFO - 'installer_path': 'installer.exe', 05:07:22 INFO - 'log_level': 'info', 05:07:22 INFO - 'log_name': 'talos', 05:07:22 INFO - 'log_to_console': True, 05:07:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:07:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:07:22 INFO - 'opt_config_files': (), 05:07:22 INFO - 'pip_index': False, 05:07:22 INFO - 'sps_profile': False, 05:07:22 INFO - 'sps_profile_interval': 0, 05:07:22 INFO - 'suite': 'dromaeojs', 05:07:22 INFO - 'system_bits': '32', 05:07:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:07:22 INFO - 'title': 'talos-linux64-ix-030', 05:07:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:07:22 INFO - 'use_talos_json': True, 05:07:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:07:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:07:22 INFO - 'work_dir': 'build'} 05:07:22 INFO - ##### 05:07:22 INFO - ##### Running clobber step. 05:07:22 INFO - ##### 05:07:22 INFO - Running pre-action listener: _resource_record_pre_action 05:07:22 INFO - Running main action method: clobber 05:07:22 INFO - rmtree: /builds/slave/test/build 05:07:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:07:23 INFO - Running post-action listener: _resource_record_post_action 05:07:23 INFO - ##### 05:07:23 INFO - ##### Finished clobber step (success) 05:07:23 INFO - ##### 05:07:23 INFO - ##### 05:07:23 INFO - ##### Running read-buildbot-config step. 05:07:23 INFO - ##### 05:07:23 INFO - Running pre-action listener: _resource_record_pre_action 05:07:23 INFO - Running main action method: read_buildbot_config 05:07:23 INFO - Using buildbot properties: 05:07:23 INFO - { 05:07:23 INFO - "project": "", 05:07:23 INFO - "product": "firefox", 05:07:23 INFO - "script_repo_revision": "production", 05:07:23 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:07:23 INFO - "repository": "", 05:07:23 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:07:23 INFO - "buildid": "20160627023004", 05:07:23 INFO - "pgo_build": "True", 05:07:23 INFO - "basedir": "/builds/slave/test", 05:07:23 INFO - "buildnumber": 835, 05:07:23 INFO - "slavename": "talos-linux64-ix-030", 05:07:23 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:07:23 INFO - "platform": "ubuntu64_hw", 05:07:23 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:07:23 INFO - "branch": "fx-team", 05:07:23 INFO - "repo_path": "integration/fx-team", 05:07:23 INFO - "revision": "9688cac5afbe215406ac95aa1a7972960666ca1c", 05:07:23 INFO - "stage_platform": "linux64-pgo", 05:07:23 INFO - "builduid": "3464b57a3a514b4db223c1cbf73f3b98", 05:07:23 INFO - "slavebuilddir": "test" 05:07:23 INFO - } 05:07:23 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:07:23 INFO - Running post-action listener: _resource_record_post_action 05:07:23 INFO - ##### 05:07:23 INFO - ##### Finished read-buildbot-config step (success) 05:07:23 INFO - ##### 05:07:23 INFO - ##### 05:07:23 INFO - ##### Running download-and-extract step. 05:07:23 INFO - ##### 05:07:23 INFO - Running pre-action listener: _resource_record_pre_action 05:07:23 INFO - Running main action method: download_and_extract 05:07:23 INFO - mkdir: /builds/slave/test/build/tests 05:07:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:23 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:07:23 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:07:23 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:07:23 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:07:23 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:07:29 INFO - Downloaded 1361 bytes. 05:07:29 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:07:29 INFO - Using the following test package requirements: 05:07:29 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:07:29 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:07:29 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:07:29 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:29 INFO - u'jsshell-linux-x86_64.zip'], 05:07:29 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:07:29 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:07:29 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:07:29 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:07:29 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:07:29 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:07:29 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:07: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:07:29 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:07: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.common.tests.zip 05:07: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.common.tests.zip 05:07: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.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:07: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.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:07:32 INFO - Downloaded 24279277 bytes. 05:07:32 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:07:32 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:07:33 INFO - Return code: 0 05:07:33 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:07:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:33 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:07:33 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:07:33 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:07:33 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:07:33 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:07:36 INFO - Downloaded 24279277 bytes. 05:07:36 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:07:36 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:07:37 INFO - Return code: 0 05:07:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:37 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:07:37 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:07:37 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:07:37 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:07:37 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:07:38 INFO - Downloaded 14405240 bytes. 05:07:38 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:07:38 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:07:38 INFO - Return code: 0 05:07:38 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:07:38 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:07:38 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:07:38 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:07:38 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:07:38 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:07:40 INFO - Downloaded 60184040 bytes. 05:07:40 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:07:40 INFO - mkdir: /builds/slave/test/properties 05:07:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:07:40 INFO - Writing to file /builds/slave/test/properties/build_url 05:07:40 INFO - Contents: 05:07:40 INFO - build_url:https://queue.taskcluster.net/v1/task/Gdjo8yWkT3OU03su9oXUug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:07:41 INFO - Running post-action listener: _resource_record_post_action 05:07:41 INFO - Running post-action listener: set_extra_try_arguments 05:07:41 INFO - ##### 05:07:41 INFO - ##### Finished download-and-extract step (success) 05:07:41 INFO - ##### 05:07:41 INFO - ##### 05:07:41 INFO - ##### Running populate-webroot step. 05:07:41 INFO - ##### 05:07:41 INFO - Running pre-action listener: _resource_record_pre_action 05:07:41 INFO - Running main action method: populate_webroot 05:07:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:07:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:07:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:07:41 INFO - '--tppagecycles', 05:07:41 INFO - '7'], 05:07:41 INFO - 'tests': ['tsvgm']}}, 05:07:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:07:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:07:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:07:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:07:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:07:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:07:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:41 INFO - 'talos_options': ['--disable-e10s'], 05:07:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:07:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:07:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:41 INFO - 'talos_options': ['--disable-e10s'], 05:07:41 INFO - 'tests': ['damp', 'tps']}, 05:07:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:41 INFO - 'tests': ['damp', 'tps']}, 05:07:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:07:41 INFO - 'tests': ['dromaeo_dom']}, 05:07:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:07:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:07:41 INFO - 'tests': ['basic_compositor_video']}, 05:07:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:07:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:07:41 INFO - 'tests': ['a11yr', 05:07:41 INFO - 'ts_paint', 05:07:41 INFO - 'tpaint', 05:07:41 INFO - 'sessionrestore', 05:07:41 INFO - 'sessionrestore_no_auto_restore', 05:07:41 INFO - 'tabpaint']}, 05:07:41 INFO - 'other-e10s': {'tests': ['a11yr', 05:07:41 INFO - 'ts_paint', 05:07:41 INFO - 'tpaint', 05:07:41 INFO - 'sessionrestore', 05:07:41 INFO - 'sessionrestore_no_auto_restore', 05:07:41 INFO - 'tabpaint']}, 05:07:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:07:41 INFO - 'ts_paint', 05:07:41 INFO - 'tpaint', 05:07:41 INFO - 'sessionrestore', 05:07:41 INFO - 'sessionrestore_no_auto_restore', 05:07:41 INFO - 'tabpaint']}, 05:07:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:07:41 INFO - 'ts_paint', 05:07:41 INFO - 'tpaint', 05:07:41 INFO - 'sessionrestore', 05:07:41 INFO - 'sessionrestore_no_auto_restore', 05:07:41 INFO - 'tabpaint']}, 05:07:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:07:41 INFO - 'tests': ['a11yr', 05:07:41 INFO - 'ts_paint', 05:07:41 INFO - 'tpaint', 05:07:41 INFO - 'sessionrestore', 05:07:41 INFO - 'sessionrestore_no_auto_restore', 05:07:41 INFO - 'tabpaint']}, 05:07:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:07:41 INFO - 'tests': ['a11yr', 05:07:41 INFO - 'ts_paint', 05:07:41 INFO - 'tpaint', 05:07:41 INFO - 'sessionrestore', 05:07:41 INFO - 'sessionrestore_no_auto_restore', 05:07:41 INFO - 'tabpaint']}, 05:07:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:07:41 INFO - 'tests': ['tsvgx', 05:07:41 INFO - 'tsvgr_opacity', 05:07:41 INFO - 'tart', 05:07:41 INFO - 'tscrollx', 05:07:41 INFO - 'cart']}, 05:07:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:07:41 INFO - 'tsvgr_opacity', 05:07:41 INFO - 'tart', 05:07:41 INFO - 'tscrollx', 05:07:41 INFO - 'cart']}, 05:07:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:41 INFO - 'talos_options': ['--disable-e10s'], 05:07:41 INFO - 'tests': ['tp5o']}, 05:07:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:41 INFO - 'tests': ['tp5o']}, 05:07:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:41 INFO - 'talos_options': ['--disable-e10s', 05:07:41 INFO - '--xperf_path', 05:07:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:07:41 INFO - 'tests': ['tp5n']}, 05:07:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:41 INFO - 'talos_options': ['--xperf_path', 05:07:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:07:41 INFO - 'tests': ['tp5n']}}, 05:07:41 INFO - 'talos.zip': {'path': '', 05:07:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:07:41 INFO - Running post-action listener: _resource_record_post_action 05:07:41 INFO - ##### 05:07:41 INFO - ##### Finished populate-webroot step (success) 05:07:41 INFO - ##### 05:07:41 INFO - ##### 05:07:41 INFO - ##### Running create-virtualenv step. 05:07:41 INFO - ##### 05:07:41 INFO - Running pre-action listener: _resource_record_pre_action 05:07:41 INFO - Running main action method: create_virtualenv 05:07:41 INFO - Creating virtualenv /builds/slave/test/build/venv 05:07:41 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:07:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:07:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:07:41 INFO - Using real prefix '/usr' 05:07:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:07:41 INFO - Installing distribute.............................................................................................................................................................................................done. 05:07:43 INFO - Installing pip.................done. 05:07:43 INFO - Return code: 0 05:07:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:07: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:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07: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:07:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f08a3d44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d7480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a666f0>, '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 0x1a675f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a67aa0>, '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': '4ac8d263c7293b36a1be1aed000001be-1467028020.970765-1361796438', '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:07: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', 'pip>=1.5'] in /builds/slave/test/build 05:07: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 pip>=1.5 05:07:43 INFO - Using env: {'DISPLAY': ':0', 05:07:43 INFO - 'HOME': '/home/cltbld', 05:07:43 INFO - 'LANG': 'en_US.UTF-8', 05:07:43 INFO - 'LANGUAGE': 'en_US:en', 05:07:43 INFO - 'LOGNAME': 'cltbld', 05:07:43 INFO - 'MAIL': '/var/mail/cltbld', 05:07:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:43 INFO - 'MOZ_NO_REMOTE': '1', 05:07:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:43 INFO - 'NO_EM_RESTART': '1', 05:07:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:43 INFO - 'PWD': '/builds/slave/test', 05:07:43 INFO - 'SHELL': '/bin/bash', 05:07:43 INFO - 'SHLVL': '1', 05:07:43 INFO - 'TERM': 'linux', 05:07:43 INFO - 'TMOUT': '86400', 05:07:43 INFO - 'USER': 'cltbld', 05:07:43 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1467028020.970765-1361796438', 05:07:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:43 INFO - '_': '/tools/buildbot/bin/python'} 05:07:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:44 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:07:44 INFO - Cleaning up... 05:07:44 INFO - Return code: 0 05:07:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:07:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f08a3d44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d7480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a666f0>, '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 0x1a675f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a67aa0>, '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': '4ac8d263c7293b36a1be1aed000001be-1467028020.970765-1361796438', '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:07:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:07:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:07:44 INFO - Using env: {'DISPLAY': ':0', 05:07:44 INFO - 'HOME': '/home/cltbld', 05:07:44 INFO - 'LANG': 'en_US.UTF-8', 05:07:44 INFO - 'LANGUAGE': 'en_US:en', 05:07:44 INFO - 'LOGNAME': 'cltbld', 05:07:44 INFO - 'MAIL': '/var/mail/cltbld', 05:07:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:44 INFO - 'MOZ_NO_REMOTE': '1', 05:07:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:44 INFO - 'NO_EM_RESTART': '1', 05:07:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:44 INFO - 'PWD': '/builds/slave/test', 05:07:44 INFO - 'SHELL': '/bin/bash', 05:07:44 INFO - 'SHLVL': '1', 05:07:44 INFO - 'TERM': 'linux', 05:07:44 INFO - 'TMOUT': '86400', 05:07:44 INFO - 'USER': 'cltbld', 05:07:44 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1467028020.970765-1361796438', 05:07:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:44 INFO - '_': '/tools/buildbot/bin/python'} 05:07:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:44 INFO - Downloading/unpacking psutil>=3.1.1 05:07: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:07: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:07: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:07: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:07: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:07: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:07:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:07:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:07:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:07:46 INFO - Installing collected packages: psutil 05:07:46 INFO - Running setup.py install for psutil 05:07:46 INFO - building 'psutil._psutil_linux' extension 05:07:46 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:07:46 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:07:46 INFO - building 'psutil._psutil_posix' extension 05:07:46 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:07:46 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:07:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:07:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:07:46 INFO - Successfully installed psutil 05:07:46 INFO - Cleaning up... 05:07:46 INFO - Return code: 0 05:07:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:07: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:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07: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:07:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f08a3d44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d7480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a666f0>, '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 0x1a675f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a67aa0>, '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': '4ac8d263c7293b36a1be1aed000001be-1467028020.970765-1361796438', '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:07: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:07: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 mozsystemmonitor==0.3 05:07:46 INFO - Using env: {'DISPLAY': ':0', 05:07:46 INFO - 'HOME': '/home/cltbld', 05:07:46 INFO - 'LANG': 'en_US.UTF-8', 05:07:46 INFO - 'LANGUAGE': 'en_US:en', 05:07:46 INFO - 'LOGNAME': 'cltbld', 05:07:46 INFO - 'MAIL': '/var/mail/cltbld', 05:07:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:46 INFO - 'MOZ_NO_REMOTE': '1', 05:07:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:46 INFO - 'NO_EM_RESTART': '1', 05:07:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:46 INFO - 'PWD': '/builds/slave/test', 05:07:46 INFO - 'SHELL': '/bin/bash', 05:07:46 INFO - 'SHLVL': '1', 05:07:46 INFO - 'TERM': 'linux', 05:07:46 INFO - 'TMOUT': '86400', 05:07:46 INFO - 'USER': 'cltbld', 05:07:46 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1467028020.970765-1361796438', 05:07:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:46 INFO - '_': '/tools/buildbot/bin/python'} 05:07:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:07:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:07:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:07:49 INFO - Installing collected packages: mozsystemmonitor 05:07:49 INFO - Running setup.py install for mozsystemmonitor 05:07:49 INFO - Successfully installed mozsystemmonitor 05:07:49 INFO - Cleaning up... 05:07:49 INFO - Return code: 0 05:07:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:07:49 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:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:49 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:07:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:49 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 0x7f08a3d44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d7480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a666f0>, '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 0x1a675f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a67aa0>, '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': '4ac8d263c7293b36a1be1aed000001be-1467028020.970765-1361796438', '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:07:49 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:07:49 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:07:49 INFO - Using env: {'DISPLAY': ':0', 05:07:49 INFO - 'HOME': '/home/cltbld', 05:07:49 INFO - 'LANG': 'en_US.UTF-8', 05:07:49 INFO - 'LANGUAGE': 'en_US:en', 05:07:49 INFO - 'LOGNAME': 'cltbld', 05:07:49 INFO - 'MAIL': '/var/mail/cltbld', 05:07:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:49 INFO - 'MOZ_NO_REMOTE': '1', 05:07:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:49 INFO - 'NO_EM_RESTART': '1', 05:07:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:49 INFO - 'PWD': '/builds/slave/test', 05:07:49 INFO - 'SHELL': '/bin/bash', 05:07:49 INFO - 'SHLVL': '1', 05:07:49 INFO - 'TERM': 'linux', 05:07:49 INFO - 'TMOUT': '86400', 05:07:49 INFO - 'USER': 'cltbld', 05:07:49 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1467028020.970765-1361796438', 05:07:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:49 INFO - '_': '/tools/buildbot/bin/python'} 05:07:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:49 INFO - Downloading/unpacking jsonschema==2.5.1 05:07: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:07: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:07: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:07: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:07: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:07: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:07:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:07:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:07: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:07: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:07: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:07: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:07: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:07: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:07:51 INFO - Downloading functools32-3.2.3-2.tar.gz 05:07:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:07:51 INFO - warning: no files found matching '*.txt' 05:07:51 INFO - no previously-included directories found matching 'build' 05:07:51 INFO - no previously-included directories found matching 'dist' 05:07:51 INFO - no previously-included directories found matching '.git*' 05:07:51 INFO - Installing collected packages: jsonschema, functools32 05:07:51 INFO - Running setup.py install for functools32 05:07:51 INFO - warning: no files found matching '*.txt' 05:07:51 INFO - no previously-included directories found matching 'build' 05:07:51 INFO - no previously-included directories found matching 'dist' 05:07:51 INFO - no previously-included directories found matching '.git*' 05:07:51 INFO - Successfully installed jsonschema functools32 05:07:51 INFO - Cleaning up... 05:07:51 INFO - Return code: 0 05:07:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f08a3d44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d7480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a666f0>, '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 0x1a675f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a67aa0>, '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': '4ac8d263c7293b36a1be1aed000001be-1467028020.970765-1361796438', '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:07:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:07:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:07:51 INFO - Using env: {'DISPLAY': ':0', 05:07:51 INFO - 'HOME': '/home/cltbld', 05:07:51 INFO - 'LANG': 'en_US.UTF-8', 05:07:51 INFO - 'LANGUAGE': 'en_US:en', 05:07:51 INFO - 'LOGNAME': 'cltbld', 05:07:51 INFO - 'MAIL': '/var/mail/cltbld', 05:07:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:51 INFO - 'MOZ_NO_REMOTE': '1', 05:07:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:51 INFO - 'NO_EM_RESTART': '1', 05:07:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:51 INFO - 'PWD': '/builds/slave/test', 05:07:51 INFO - 'SHELL': '/bin/bash', 05:07:51 INFO - 'SHLVL': '1', 05:07:51 INFO - 'TERM': 'linux', 05:07:51 INFO - 'TMOUT': '86400', 05:07:51 INFO - 'USER': 'cltbld', 05:07:51 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1467028020.970765-1361796438', 05:07:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:51 INFO - '_': '/tools/buildbot/bin/python'} 05:07:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:52 INFO - Downloading/unpacking blobuploader==1.2.4 05:07:52 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:07:52 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:07:52 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:07:52 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:07:52 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:07:52 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:07:53 INFO - Downloading blobuploader-1.2.4.tar.gz 05:07:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:07:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:07:54 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:07:54 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:07:54 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:07:54 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:07:54 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:07:54 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:07:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:07:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:07:54 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:07:54 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:07:54 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:07:54 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:07:54 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:07:54 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:07:54 INFO - Downloading docopt-0.6.1.tar.gz 05:07:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:07:54 INFO - Installing collected packages: blobuploader, requests, docopt 05:07:54 INFO - Running setup.py install for blobuploader 05:07:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:07:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:07:54 INFO - Running setup.py install for requests 05:07:55 INFO - Running setup.py install for docopt 05:07:55 INFO - Successfully installed blobuploader requests docopt 05:07:55 INFO - Cleaning up... 05:07:55 INFO - Return code: 0 05:07:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:07: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:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07: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:07:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:55 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 0x7f08a3d44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d7480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a666f0>, '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 0x1a675f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a67aa0>, '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': '4ac8d263c7293b36a1be1aed000001be-1467028020.970765-1361796438', '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:07:55 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:07:55 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:07:55 INFO - Using env: {'DISPLAY': ':0', 05:07:55 INFO - 'HOME': '/home/cltbld', 05:07:55 INFO - 'LANG': 'en_US.UTF-8', 05:07:55 INFO - 'LANGUAGE': 'en_US:en', 05:07:55 INFO - 'LOGNAME': 'cltbld', 05:07:55 INFO - 'MAIL': '/var/mail/cltbld', 05:07:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:55 INFO - 'MOZ_NO_REMOTE': '1', 05:07:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:55 INFO - 'NO_EM_RESTART': '1', 05:07:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:55 INFO - 'PWD': '/builds/slave/test', 05:07:55 INFO - 'SHELL': '/bin/bash', 05:07:55 INFO - 'SHLVL': '1', 05:07:55 INFO - 'TERM': 'linux', 05:07:55 INFO - 'TMOUT': '86400', 05:07:55 INFO - 'USER': 'cltbld', 05:07:55 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1467028020.970765-1361796438', 05:07:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:55 INFO - '_': '/tools/buildbot/bin/python'} 05:07:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:07:55 INFO - Running setup.py (path:/tmp/pip-wjKPrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:07:55 INFO - Running setup.py (path:/tmp/pip-ZZjzLn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:07:55 INFO - Running setup.py (path:/tmp/pip-Vw9cb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:07:55 INFO - Running setup.py (path:/tmp/pip-Y2XPHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:07:55 INFO - Running setup.py (path:/tmp/pip-84lB_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:07:55 INFO - Running setup.py (path:/tmp/pip-SPqtep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:07:55 INFO - Running setup.py (path:/tmp/pip-MznBDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:07:56 INFO - Running setup.py (path:/tmp/pip-Jjy1j8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:07:56 INFO - Running setup.py (path:/tmp/pip-Vbe0Ng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:07:56 INFO - Running setup.py (path:/tmp/pip-M0nEa1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:07:56 INFO - Running setup.py (path:/tmp/pip-PkxQ0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:07:56 INFO - Running setup.py (path:/tmp/pip-GKgwJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:07:56 INFO - Running setup.py (path:/tmp/pip-85WDMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:07:56 INFO - Running setup.py (path:/tmp/pip-psnPJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:07:56 INFO - Running setup.py (path:/tmp/pip-MLALVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:07:56 INFO - Running setup.py (path:/tmp/pip-7ExYeM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:07:56 INFO - Running setup.py (path:/tmp/pip-p0iMGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:07:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:07:56 INFO - Running setup.py install for manifestparser 05:07:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:07:56 INFO - Running setup.py install for mozcrash 05:07:56 INFO - Running setup.py install for mozdebug 05:07:57 INFO - Running setup.py install for mozdevice 05:07:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:07:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:07:57 INFO - Running setup.py install for mozfile 05:07:57 INFO - Running setup.py install for mozhttpd 05:07:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:07:57 INFO - Running setup.py install for mozinfo 05:07:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:07:57 INFO - Running setup.py install for mozInstall 05:07:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:07:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:07:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:07:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:07:57 INFO - Running setup.py install for mozleak 05:07:57 INFO - Running setup.py install for mozlog 05:07:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:07:57 INFO - Running setup.py install for moznetwork 05:07:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:07:57 INFO - Running setup.py install for mozprocess 05:07:58 INFO - Running setup.py install for mozprofile 05:07:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:07:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:07:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:07:58 INFO - Running setup.py install for mozrunner 05:07:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:07:58 INFO - Running setup.py install for mozscreenshot 05:07:58 INFO - Running setup.py install for moztest 05:07:58 INFO - Running setup.py install for mozversion 05:07:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:07:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:07:58 INFO - Cleaning up... 05:07:58 INFO - Return code: 0 05:07:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:07:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:58 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 0x7f08a3d44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d7480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a666f0>, '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 0x1a675f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a67aa0>, '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': '4ac8d263c7293b36a1be1aed000001be-1467028020.970765-1361796438', '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:07:58 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:07:58 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:07:58 INFO - Using env: {'DISPLAY': ':0', 05:07:58 INFO - 'HOME': '/home/cltbld', 05:07:58 INFO - 'LANG': 'en_US.UTF-8', 05:07:58 INFO - 'LANGUAGE': 'en_US:en', 05:07:58 INFO - 'LOGNAME': 'cltbld', 05:07:58 INFO - 'MAIL': '/var/mail/cltbld', 05:07:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:58 INFO - 'MOZ_NO_REMOTE': '1', 05:07:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:58 INFO - 'NO_EM_RESTART': '1', 05:07:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:58 INFO - 'PWD': '/builds/slave/test', 05:07:58 INFO - 'SHELL': '/bin/bash', 05:07:58 INFO - 'SHLVL': '1', 05:07:58 INFO - 'TERM': 'linux', 05:07:58 INFO - 'TMOUT': '86400', 05:07:58 INFO - 'USER': 'cltbld', 05:07:58 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1467028020.970765-1361796438', 05:07:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:58 INFO - '_': '/tools/buildbot/bin/python'} 05:07:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:07:58 INFO - Running setup.py (path:/tmp/pip-NMwwKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:07:58 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:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:07:58 INFO - Running setup.py (path:/tmp/pip-_wGNCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:07:58 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:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:07:58 INFO - Running setup.py (path:/tmp/pip-arP2hh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:07:58 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:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:07:59 INFO - Running setup.py (path:/tmp/pip-Mju2NA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:07:59 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:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:07:59 INFO - Running setup.py (path:/tmp/pip-RVyg6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:07:59 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:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:07:59 INFO - Running setup.py (path:/tmp/pip-buEsIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:07:59 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:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:07:59 INFO - Running setup.py (path:/tmp/pip-iHi6Yt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:07:59 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:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:07:59 INFO - Running setup.py (path:/tmp/pip-7dCtfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:07:59 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:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:07:59 INFO - Running setup.py (path:/tmp/pip-FhPJPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:07:59 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:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:07:59 INFO - Running setup.py (path:/tmp/pip-TBFLdR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:07:59 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:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:07:59 INFO - Running setup.py (path:/tmp/pip-_VaDnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:07:59 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:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:07:59 INFO - Running setup.py (path:/tmp/pip-HD1dGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:07:59 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:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:07:59 INFO - Running setup.py (path:/tmp/pip-voKs8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:07:59 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:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:07:59 INFO - Running setup.py (path:/tmp/pip-dYooAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:07:59 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:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:07:59 INFO - Running setup.py (path:/tmp/pip-xKeer_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:07:59 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:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:07:59 INFO - Running setup.py (path:/tmp/pip-gRyIVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:07:59 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:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:07:59 INFO - Running setup.py (path:/tmp/pip-OuMGbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:08:00 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:08:00 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:08:00 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:08:00 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:08:00 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:08:00 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:08:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:08: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:08: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:08: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:08: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:08: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:08: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:08:01 INFO - Downloading blessings-1.6.tar.gz 05:08:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:08:02 INFO - Installing collected packages: blessings 05:08:02 INFO - Running setup.py install for blessings 05:08:02 INFO - Successfully installed blessings 05:08:02 INFO - Cleaning up... 05:08:02 INFO - Return code: 0 05:08:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:08:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:08:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:08:02 INFO - Reading from file tmpfile_stdout 05:08:02 INFO - Current package versions: 05:08:02 INFO - argparse == 1.2.1 05:08:02 INFO - blessings == 1.6 05:08:02 INFO - blobuploader == 1.2.4 05:08:02 INFO - docopt == 0.6.1 05:08:02 INFO - functools32 == 3.2.3-2 05:08:02 INFO - jsonschema == 2.5.1 05:08:02 INFO - manifestparser == 1.1 05:08:02 INFO - mozInstall == 1.12 05:08:02 INFO - mozcrash == 0.17 05:08:02 INFO - mozdebug == 0.1 05:08:02 INFO - mozdevice == 0.48 05:08:02 INFO - mozfile == 1.2 05:08:02 INFO - mozhttpd == 0.7 05:08:02 INFO - mozinfo == 0.9 05:08:02 INFO - mozleak == 0.1 05:08:02 INFO - mozlog == 3.2 05:08:02 INFO - moznetwork == 0.27 05:08:02 INFO - mozprocess == 0.22 05:08:02 INFO - mozprofile == 0.28 05:08:02 INFO - mozrunner == 6.11 05:08:02 INFO - mozscreenshot == 0.1 05:08:02 INFO - mozsystemmonitor == 0.3 05:08:02 INFO - moztest == 0.7 05:08:02 INFO - mozversion == 1.4 05:08:02 INFO - psutil == 3.1.1 05:08:02 INFO - requests == 1.2.3 05:08:02 INFO - wsgiref == 0.1.2 05:08:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:02 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 0x7f08a3d44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d7480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a666f0>, '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 0x1a675f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a67aa0>, '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': '4ac8d263c7293b36a1be1aed000001be-1467028020.970765-1361796438', '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:08:02 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:08:02 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:08:02 INFO - Using env: {'DISPLAY': ':0', 05:08:02 INFO - 'HOME': '/home/cltbld', 05:08:02 INFO - 'LANG': 'en_US.UTF-8', 05:08:02 INFO - 'LANGUAGE': 'en_US:en', 05:08:02 INFO - 'LOGNAME': 'cltbld', 05:08:02 INFO - 'MAIL': '/var/mail/cltbld', 05:08:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:02 INFO - 'MOZ_NO_REMOTE': '1', 05:08:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:02 INFO - 'NO_EM_RESTART': '1', 05:08:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:02 INFO - 'PWD': '/builds/slave/test', 05:08:02 INFO - 'SHELL': '/bin/bash', 05:08:02 INFO - 'SHLVL': '1', 05:08:02 INFO - 'TERM': 'linux', 05:08:02 INFO - 'TMOUT': '86400', 05:08:02 INFO - 'USER': 'cltbld', 05:08:02 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1467028020.970765-1361796438', 05:08:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:02 INFO - '_': '/tools/buildbot/bin/python'} 05:08:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:02 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:08:02 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:08:02 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:08:02 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:08:02 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:08:02 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:08:02 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:08:02 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:08:02 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:08:02 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:08:02 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:08:02 INFO - Cleaning up... 05:08:02 INFO - Return code: 0 05:08:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:08:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:02 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 0x7f08a3d44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d7480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a666f0>, '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 0x1a675f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a67aa0>, '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': '4ac8d263c7293b36a1be1aed000001be-1467028020.970765-1361796438', '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:08:02 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:08:02 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:08:02 INFO - Using env: {'DISPLAY': ':0', 05:08:02 INFO - 'HOME': '/home/cltbld', 05:08:02 INFO - 'LANG': 'en_US.UTF-8', 05:08:02 INFO - 'LANGUAGE': 'en_US:en', 05:08:02 INFO - 'LOGNAME': 'cltbld', 05:08:02 INFO - 'MAIL': '/var/mail/cltbld', 05:08:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:02 INFO - 'MOZ_NO_REMOTE': '1', 05:08:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:02 INFO - 'NO_EM_RESTART': '1', 05:08:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:02 INFO - 'PWD': '/builds/slave/test', 05:08:02 INFO - 'SHELL': '/bin/bash', 05:08:02 INFO - 'SHLVL': '1', 05:08:02 INFO - 'TERM': 'linux', 05:08:02 INFO - 'TMOUT': '86400', 05:08:02 INFO - 'USER': 'cltbld', 05:08:02 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1467028020.970765-1361796438', 05:08:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:02 INFO - '_': '/tools/buildbot/bin/python'} 05:08:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:08:02 INFO - Cleaning up... 05:08:02 INFO - Return code: 0 05:08:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:08:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:02 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 0x7f08a3d44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d7480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a666f0>, '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 0x1a675f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a67aa0>, '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': '4ac8d263c7293b36a1be1aed000001be-1467028020.970765-1361796438', '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:08:02 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:08:02 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:08:02 INFO - Using env: {'DISPLAY': ':0', 05:08:02 INFO - 'HOME': '/home/cltbld', 05:08:02 INFO - 'LANG': 'en_US.UTF-8', 05:08:02 INFO - 'LANGUAGE': 'en_US:en', 05:08:02 INFO - 'LOGNAME': 'cltbld', 05:08:02 INFO - 'MAIL': '/var/mail/cltbld', 05:08:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:02 INFO - 'MOZ_NO_REMOTE': '1', 05:08:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:02 INFO - 'NO_EM_RESTART': '1', 05:08:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:02 INFO - 'PWD': '/builds/slave/test', 05:08:02 INFO - 'SHELL': '/bin/bash', 05:08:02 INFO - 'SHLVL': '1', 05:08:02 INFO - 'TERM': 'linux', 05:08:02 INFO - 'TMOUT': '86400', 05:08:02 INFO - 'USER': 'cltbld', 05:08:02 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1467028020.970765-1361796438', 05:08:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:02 INFO - '_': '/tools/buildbot/bin/python'} 05:08:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:03 INFO - Downloading/unpacking flake8 05:08:03 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:08:03 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:08:03 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:08:03 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:08:03 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:08:03 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:08:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:08:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:08:04 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:08:04 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:08:04 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:08:04 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:08:04 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:08:04 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:08:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:08:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:08:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:08:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:08:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:08:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:08:05 INFO - no previously-included directories found matching 'docs/_build' 05:08:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:08:05 INFO - Running setup.py install for pep8 05:08:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:08:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:08:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:08:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:08:05 INFO - no previously-included directories found matching 'docs/_build' 05:08:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:08:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:08:05 INFO - Cleaning up... 05:08:05 INFO - Return code: 0 05:08:05 INFO - Running post-action listener: _resource_record_post_action 05:08:05 INFO - Running post-action listener: _start_resource_monitoring 05:08:05 INFO - Starting resource monitoring. 05:08:05 INFO - ##### 05:08:05 INFO - ##### Finished create-virtualenv step (success) 05:08:05 INFO - ##### 05:08:05 INFO - ##### 05:08:05 INFO - ##### Running install step. 05:08:05 INFO - ##### 05:08:05 INFO - Running pre-action listener: _resource_record_pre_action 05:08:05 INFO - Running main action method: install 05:08:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:08:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:08:06 INFO - Reading from file tmpfile_stdout 05:08:06 INFO - Detecting whether we're running mozinstall >=1.0... 05:08:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:08:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:08:06 INFO - Reading from file tmpfile_stdout 05:08:06 INFO - Output received: 05:08:06 INFO - Usage: mozinstall [options] installer 05:08:06 INFO - Options: 05:08:06 INFO - -h, --help show this help message and exit 05:08:06 INFO - -d DEST, --destination=DEST 05:08:06 INFO - Directory to install application into. [default: 05:08:06 INFO - "/builds/slave/test"] 05:08:06 INFO - --app=APP Application being installed. [default: firefox] 05:08:06 INFO - mkdir: /builds/slave/test/build/application 05:08:06 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:08:06 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:08:23 INFO - Reading from file tmpfile_stdout 05:08:23 INFO - Output received: 05:08:23 INFO - /builds/slave/test/build/application/firefox/firefox 05:08:23 INFO - Running post-action listener: _resource_record_post_action 05:08:23 INFO - ##### 05:08:23 INFO - ##### Finished install step (success) 05:08:23 INFO - ##### 05:08:23 INFO - ##### 05:08:23 INFO - ##### Running run-tests step. 05:08:23 INFO - ##### 05:08:23 INFO - Running pre-action listener: _resource_record_pre_action 05:08:23 INFO - Running main action method: run_tests 05:08:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:08:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:08:23 INFO - Python 2.7.3 05:08:23 INFO - Return code: 0 05:08:23 INFO - grabbing minidump binary from tooltool 05:08:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:23 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 0x1a666f0>, '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 0x1a675f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a67aa0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:08:23 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:08:23 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:08:23 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:08:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:08:23 INFO - Return code: 0 05:08:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:08:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:08:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:08:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:08:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:08:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:08:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:08:24 INFO - Return code: 0 05:08:24 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-030', '--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:08:24 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-030 --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:08:24 INFO - Using env: {'DISPLAY': ':0', 05:08:24 INFO - 'HOME': '/home/cltbld', 05:08:24 INFO - 'LANG': 'en_US.UTF-8', 05:08:24 INFO - 'LANGUAGE': 'en_US:en', 05:08:24 INFO - 'LOGNAME': 'cltbld', 05:08:24 INFO - 'MAIL': '/var/mail/cltbld', 05:08:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:08:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:08:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:24 INFO - 'MOZ_NO_REMOTE': '1', 05:08:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:08:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:24 INFO - 'NO_EM_RESTART': '1', 05:08:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:24 INFO - 'PWD': '/builds/slave/test', 05:08:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:08:24 INFO - 'SHELL': '/bin/bash', 05:08:24 INFO - 'SHLVL': '1', 05:08:24 INFO - 'TERM': 'linux', 05:08:24 INFO - 'TMOUT': '86400', 05:08:24 INFO - 'USER': 'cltbld', 05:08:24 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1467028020.970765-1361796438', 05:08:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:24 INFO - '_': '/tools/buildbot/bin/python'} 05:08:24 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-030', '--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:08:24 INFO - mozversion application_buildid: 20160627023004 05:08:24 INFO - mozversion application_changeset: 9688cac5afbe215406ac95aa1a7972960666ca1c 05:08:24 INFO - mozversion application_display_name: Nightly 05:08:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:08:24 INFO - mozversion application_name: Firefox 05:08:24 INFO - mozversion application_remotingname: firefox 05:08:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:08:24 INFO - mozversion application_vendor: Mozilla 05:08:24 INFO - mozversion application_version: 50.0a1 05:08:24 INFO - mozversion platform_buildid: 20160627023004 05:08:24 INFO - mozversion platform_changeset: 9688cac5afbe215406ac95aa1a7972960666ca1c 05:08:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:08:24 INFO - mozversion platform_version: 50.0a1 05:08:24 INFO - using testdate: 1467029304 05:08:24 INFO - actual date: 1467029304 05:08:24 INFO - starting webserver on 'localhost:56981' 05:08:24 INFO - SUITE-START | Running 2 tests 05:08:24 INFO - TEST-START | dromaeo_css 05:08:24 INFO - operating with platform_type : linux_ 05:08:24 INFO - Initialising browser for dromaeo_css test... 05:08:24 INFO - TEST-INFO | started process 24787 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVSTO4E/profile http://localhost:56981/getInfo.html) 05:08:28 INFO - PROCESS | 24787 | __metrics Screen width/height:1600/1200 05:08:28 INFO - PROCESS | 24787 | colorDepth:24 05:08:28 INFO - PROCESS | 24787 | Browser inner width/height: 1024/697 05:08:28 INFO - PROCESS | 24787 | __metrics 05:08:29 INFO - PROCESS | 24787 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:08:30 INFO - TEST-INFO | 24787: exit 0 05:08:30 INFO - Browser initialized. 05:08:30 INFO - Running cycle 1/1 for dromaeo_css test... 05:08:30 INFO - TEST-INFO | started process 24871 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVSTO4E/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:08:42 INFO - PROCESS | 24871 | RSS: Main: 173645824 05:08:42 INFO - PROCESS | 24871 | 05:09:33 INFO - PROCESS | 24871 | 1467029373174 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:11:42 INFO - PROCESS | 24871 | Cycle 1(1): loaded http://localhost:56981/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56981/tests/dromaeo/cssquery-ext.html) 05:11:43 INFO - PROCESS | 24871 | RSS: Main: 253075456 05:11:43 INFO - PROCESS | 24871 | 05:14:45 INFO - PROCESS | 24871 | Cycle 1(1): loaded http://localhost:56981/tests/dromaeo/cssquery-ext.html (next: http://localhost:56981/tests/dromaeo/cssquery-jquery.html) 05:14:46 INFO - PROCESS | 24871 | RSS: Main: 257974272 05:14:46 INFO - PROCESS | 24871 | 05:17:48 INFO - PROCESS | 24871 | Cycle 1(1): loaded http://localhost:56981/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56981/tests/dromaeo/cssquery-mootools.html) 05:17:49 INFO - PROCESS | 24871 | RSS: Main: 252448768 05:17:49 INFO - PROCESS | 24871 | 05:20:51 INFO - PROCESS | 24871 | Cycle 1(1): loaded http://localhost:56981/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56981/tests/dromaeo/cssquery-prototype.html) 05:20:51 INFO - PROCESS | 24871 | RSS: Main: 249458688 05:20:51 INFO - PROCESS | 24871 | 05:23:54 INFO - PROCESS | 24871 | Cycle 1(1): loaded http://localhost:56981/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56981/tests/dromaeo/cssquery-yui.html) 05:23:55 INFO - PROCESS | 24871 | RSS: Main: 219906048 05:23:55 INFO - PROCESS | 24871 | 05:26:57 INFO - PROCESS | 24871 | Cycle 1(1): loaded http://localhost:56981/tests/dromaeo/cssquery-yui.html (next: http://localhost:56981/tests/dromaeo/cssquery-dojo.html) 05:26:57 INFO - PROCESS | 24871 | RSS: Main: 298078208 05:26:57 INFO - PROCESS | 24871 | 05:26:57 INFO - PROCESS | 24871 | __start_tp_report 05:26:57 INFO - PROCESS | 24871 | _x_x_mozilla_page_load 05:26:57 INFO - PROCESS | 24871 | _x_x_mozilla_page_load_details 05:26:57 INFO - PROCESS | 24871 | |i|pagename|runs| 05:26:57 INFO - PROCESS | 24871 | |0;dojo.html;3082.4759790835556;3092.567040614314;3123.1099136746016;3152.6216853977526;3187.235063584739;5292.444293349201;5296.761645725942;5327.600429967749;5393.4336894626085;5431.402545719968;5379.596530260226;5391.32608423947;5394.8921021579645;5450.972745136279;5457.099578569531;4840.636952228588;4911.484294149116;4934.679245849008;4943.6539442239055;5049.823256186034;4957.380327459067;4965.950340496585;4970.751462426864;4996.250562415648;5019.0463811875625;4855.781489832966;4856.125897338477;4859.125357435661;4890.559849613534;4906.779194936236;4833.03339332135;4847.806087756486;4852.369192005052;4921.926171107436;4963.60291176705;4875.8781030474165;4887.437944636376;4891.804327826882;4904.803807847682;4939.975300123512;5244.554212891909;5314.867128321823;5392.595555333366;5405.540529055035;5468.699221542814;5841.7371218295275;5869.4717475427415;5883.941160588382;5916.822495325147;5925.940740592582;5685.687287199203;5897.469227769521;5915.290165180206;5930.3773103823905;5953.166556682068;5352.545033672142;5373.247745315659;5417.6478528895495;5507.146392309199;5518.117101263779;6004.189434426384;6023.789167379121;6025.0661147522205;6026.397360263939;6034.336223015464;5754.539636829128;5755.913661295084;5771.422857714279;5774.191613174159;5776.104703770922;5640.520555752807;5740.483356497935;5797.507211886952;5802;5832.125181222766;5779.711014449261;5788.0449725795615;5824.737886795019;5825.446582574648;5830.562707796932;5686.886262274731;5783.190353350535;5819.970900145557;5848.64908105515;5852.795152169653;4380.6933514653665;4412.536683648171;4415.072834704748;4444.355568442557;4445.51099379068;3939.03493644059;3944.112574670676;3950.644442000234;3968.3055465294037;3985.501812273466;5351.063563876306;5359.249705041298;5509.834704958857;5514.6691198528215;5515.255440515479;5693.572982026365;5736.196932429463;5765.740541675635;5773.336066352339;5811.070228763378;5442.401335853053;5443.129099344165;5451.781928722886;5457.181422786613;5461.317335333083;4895.877603059952;4928.753562321869;4965.776540055706;4984.077945580079;5046.167382381939;5998.700064996733;6013.1581578579035;6016.518678505709;6021.57848950578;6061.4544690977145;5743.942560574341;5756.481916627524;5757.424257574209;5757.453041961007;5759.222504961776;5774;5854.824355269348;5929.495992840657;5954.07711804671;5998.370171132143;5672.290963629546;5681.630694004876;5683.090705487102;5683.346415162144;5685.232493613309;5729.656220626775;5732.684702341411;5767.5674324425;5776.595638305446;5786.855328616818;5494.725263736877;5589.692566908859;5612.663240205601;5645.463680950304;5665.886682266414;5650.378458369494;5653.519450846724;5656.264685590847;5661.886762264814;5666.716664166857;5389.461053894579;5554.722263886871;5564.582656300713;5564.944350556442;5569;5526.392096869422;5642.351129620146;5647.463490968352;5671.631343962629;5714.114312281603;5489;5588.38527761954;5590;5594.496495315441;5602.971985140048 05:26:57 INFO - PROCESS | 24871 | |1;ext.html;594.8542607061271;624.6096189881324;631.7978246960975;633.6989929783356;636.5003472274265;30440.69559304409;30770.53844192336;42517.14965700688;43158.784206079006;43261.35107973383;41052;44394.7780261099;44439;44463.33305000419;44485.555144448546;8901.955490222555;9049.506831372848;9061.637534498612;9066;9067.410618309788;8744.562771861381;8921.375503714742;8923.95538022309;8930.330225233134;8934.419262747933;8964.910350896505;9013.278937685001;9022.729318120468;9023.774405639879;9024.503652299121;8909.643614255421;8947.105289471066;8952.552372381355;8960.507172105565;8964.50695211763;8732.912670873273;8795.692150774692;8800.427972181851;8804.779880502974;8808.691695790681;42369;42432.57567424317;42757.57242427567;42848.78575607102;42872.57127428717;3488.4069708149677;3636.727245456575;3650.7444478886487;3656.3601369760186;3950.407438884162;32075.51886721701;32543.186420339443;32677.83661081703;33004.83497582521;33079;4259.91480170398;4324.82700691972;4339.631131353839;4342.978285108586;4448.3549885266775;329446;330381;330634;332021;332297;58350.4164958345;58387.416125839045;58601;58691.70654146702;58818.41181588215;35411;36221.27557448889;36278.8186059068;37623;37635;14719.116852988855;14804.185769782765;14804.407823687146;14822.851771482146;14833.332500037524;10833.67498975032;10867.728306792393;10877.564897404174;10880.67357979262;10885.619003334845;19503.609927801364;19525.121369538403;19721.802781972285;19731.309404171072;19753.308634197732;6828.419584335288;7131.286871312931;7187.173475050332;7257.419406447471;7309.817254568678;946.6639343033262;1022.8721409823772;1027.3322340478599;1031.9845202321972;1059.7403636109202;31811.204719881724;32073.9545824573;32220.516692249636;32229.194270143435;32348;1027.5119318323887;1081.9891801082047;1105.5688281570194;1140.914431417647;1180.2564384437749;16832.495025149266;17250.309987600605;17261.91369043147;17283.827161728474;17361.47915562535;529544;532198;535016;537931;545032;57761.71119144378;58222.4177758217;58315.708421457624;58375;58381.41618583845;1229.8893099620898;1306.764782339188;1358.1868205944977;1362.6865820861258;1390.2145287912297;31055.68944310528;33027.174320642174;33036.66963330432;33233.83383083069;33368.66631333656;49373.50626493689;49697;50015.749921250164;50311;50388;380406;384035;384494;384693;385392;24889.87555062213;27154.456910862067;27981.72018279791;28021.719782801913;28086.2978425541;47224;47249;47339;47375.28937065878;48858.5114148854;40367.596324036385;40638.79680601578;40797.1840563193;41122.794386027876;41960.370594441716;40204.597954020086;40327.39508907427;41266.38100428436;41529.79235103805;43290.78354608207;41049.589504105774;41271.58728412678;43272.783636081615;43995.78002110097;44204.33693494536;37821.43267851039;42492.36261456019;42929.78535107304;43161.56838431701;43374.566254337056;31606.841965790023;32187;32469;32523.837380812944;32897.506537402434 05:26:57 INFO - PROCESS | 24871 | |2;jquery.html;386.35864464988117;391.71209161266466;393.2873672531306;399.6962308645429;403.12320702472135;15144.01563898346;16368.508944731648;18013.36953206638;19111.139998700073;19130.90434547827;17761.20074596643;18681.252809830647;19081.332153374635;19583.314583989562;19599.510012249702;1744.1802352894183;1745.4327343613313;1745.70323045082;1746.0658547676996;2102.8959796107088;3944.960550394502;5554.1113421852515;5622.522085622706;5849.824505264849;5945.464908158265;5872.618279811799;5893.5579831512805;5905.616134951214;5927.970360148215;5945.464908158265;5752.050911599602;5886.735096920627;5991.310999235056;6003.249593800775;6004.159417681506;5537.418571050022;5798.275215598051;5806.82579522615;5807.390224026459;5830.067189249742;14446;14698.55904322872;14699.63250918725;14722.70554588913;15459.536213913489;2443.816713746476;2527.646129541866;2746.4644394343113;2750.6561679790025;2839.190830613286;10221.846672299922;10308.278420510567;10383.117435018032;10893.237473376867;10899.019088282013;1938.3506525314037;1941.9028249039247;1979.7525309336334;1994.5013746563359;2073.9896300518553;80545;80780.59609701972;81779;84172.57913710453;84208.15791842065;11048.226624136394;11199.272047316897;11389.715257118638;11518.827217591743;11637.301761894314;15845.286962086733;15852.682946341009;15884.444044458389;16009.27958241882;16030.358785648443;7654.081510218809;7754.953081334061;7758.612069396508;7780.92219077802;7872.881906771403;7104.609246491493;7147.356737893615;7160.176579693298;7224.096987876515;7297.233790452032;4816.735079570657;4832.299316599074;4860.6111511079025;4894.702903730515;4964.90070198594;1812.9909350453427;1816.2030128877393;1849.9445016649522;1959.2456904092028;1983.2959299448487;913.3697748553477;950.2493030505823;977.1108291454742;989.2135752077116;1006.2201793609864;18872.339468118826;19479.318223862098;19690.70463943042;19876.70184947227;19895.303664371677;977.0473788056588;985.6796541124163;995.9253056020683;1041.6093964763213;1043.2384359417667;10595.94702026485;10987.133041848845;11029.393383363831;11038.337699738042;11127.833082503768;450972;457192;460861;466159;466221.33778662456;89706;89794.55102724445;91292;92140.53929730308;92980;993.4833886379187;995.1590905684685;1010.3382284603597;1011.4538149399389;1016.217512515359;17401.56496087608;17622.29510819553;17777.555561111076;17846.643067138844;17924.372646957294;41522.37716434195;41824.163516728884;42909.14181716286;43105;43408.782956085015;58620;58761;59167.40832591619;59970.70014649899;60682.69658651679;8616.698415555426;9013.549322533978;9079.68221112258;9132.49771262587;9160.450372977642;10255.128314093387;12795.488180472677;13628;13674.179549227078;13988.720225595227;9461;11055.557777688802;11242.213045086766;11717.12121590867;12305.876941230474;12049.75900481968;12157.45291461904;12157.574484892986;12194;12418.75162496727;11763.588274410355;12449.190802597803;12495.500179992698;12540.498380064695;12829.93585032069;9021.684241051531;9144.26845852317;9290.907090929275;9325.393849399767;9326.533673316442;9178.082191780768;11077.446127693422;12112.454939527566;12206;12213.816792747939 05:26:57 INFO - PROCESS | 24871 | |3;mootools.html;1333.433290851388;1463.4292625875903;1480.0231846980992;1498.220925118938;1503.902246353987;8354.707585234519;8786.472811631307;8788.077251888548;8994.820103597924;9002.504862232574;8735.475871447701;8866.069062748415;8936.55317234139;8946.731598052053;8961.865572016424;1994.5512259741515;2204.1073365287084;2261.185973049701;2299.8850057497143;2331.976680233193;2343.0744855781954;2351.929442116739;2352.282553821084;2352.623580227164;2355.8350915435926;2302.1712183613886;2324.081987614891;2359.2686267257204;2360.8347415680823;2361.9645705314433;1888.9149988250492;2196.516766311409;2246.786555277246;2281.258590957945;2287.2452090809993;2230.4200907763934;2239.9216027439124;2259.4690247791755;2260.0055975370783;2263.411513006614;8953.23897468716;8970.86543701845;9043.366964312501;9044.41211321262;9047.411918225294;5169.896602067975;5311.070562651521;5319.441458646825;5319.494648008433;5323.547498462635;3241.4813629819114;3354.1446931032674;3441.0881116504147;3441.4493681010917;3459.9827000864834;1085.180688580117;1086.4513420722485;1095.9342439453658;1099.6810924831789;1103.0734183286079;12700.110992230548;12702.364881755968;12704.237745735285;12716.173448725804;12726.300053497054;4759.571638552547;4772.281650989082;4855.927161092586;4875.853724388274;4897.751073476241;10436.060754532129;10482.318649287772;10485.633002844865;10486.37081775096;10511.211659125596;5267.525922666979;5390.9191362129595;5393.973030134903;5394.595405344615;5396.703181325065;4203.852865149705;4850.854474365704;4992.850214493571;5010.148274793294;5051.747412629354;4005.2292645136527;4017.397390391465;4058.0869304406274;4097.221527909687;4225.746455212636;1286.0611753420055;1291.251074376878;1299.2204677193797;1310.7968264918952;1321.0290436529144;895.6820328783189;907.4011152639226;911.4941207629829;919.6965001549472;941.223490620241;5884.205632239678;5925.585209035326;6124.969375153096;6132.202813634199;6250.218722659668;985.6944347252374;996.1781530237583;999.81003609314;1001.4942454060653;1101.9008289254007;4110.897227569335;4150.5641907599875;4193.559676233952;4252.829886804493;4284.571542845752;11125.443727813577;11469.082473402275;11491.138164637685;11519.30884146954;11543;10408.271421000458;11341.546338146547;11382.373969431761;11385.08919286455;11386.316820990767;8030.83938321242;8333.208345207195;8388.580570971428;8397.874031889527;8408.033076196316;5778.797742079007;5852.736626851717;5854.092615644582;5874;6063.484603808549;10183.694489165337;10317.226208034277;10329.535170917177;10377.9481102594;10431.478426078818;10773.084287835622;10774;10786.838197426889;10846.132309415385;10916.399598022184;7129.429645628441;7779.455438119504;7936.880946785918;7960.601969901366;8096.987876515435;8831.867521987304;8839.558022098998;8941.46351218929;8951.104889511258;8954.328425367994;7634.656440460081;7737.535747855147;7757.68969241224;7790.182030886902;8059.959700201462;7472.402207823252;7736.535807851547;7813.921860781319;7941.126476087741;7952.443328966917;6829.873070943438;7030.472714546328;7079.044329015723;7104.573725576482;7119.572825630272;5196.53231209193;5237.476252374732;5302.628815982998;5343.492368225013;5351.518363347317;5095.184770436712;5135.486451354835;5182.766775495036;5277.525022747817;5373.543248823894 05:26:57 INFO - PROCESS | 24871 | |4;prototype.html;326.90356344878273;332.7523371890351;332.9483929990852;334.23960489885513;338.3216650615515;5118.411382690992;5173.3533308336455;5244.160934250516;5312;5347.6256662033675;5255.553277971377;5274.780175859316;5301.443348448415;5304.9204261936;5308.256844041837;4147.543770185284;4159.251334759742;4170.666346692257;4185.644220241268;4224.8732538023905;3953;3957.544882338539;4212.368144778293;4216.093539888923;4238.894027649302;4158.480189976253;4183.853565125221;4194.203101410722;4198.530514319994;4198.769067701275;4203.726757760751;4213.494380674308;4223.556526564697;4231.746095234295;4238.5761423857675;3649.708023358125;3699.6115407882053;3779.790467050545;3791.696664266852;3798.2593394288124;5101.821436249714;5114.641975061747;5138.612574604836;5155.711072231942;5200.609954253408;4696.647751418623;4709.481956984729;4710.905781884378;4713.6464765142755;4720.622350212009;5345.305110335631;5452.863678408032;5496.835094947118;5503.6147469677135;5515.834524964257;4041.2321658884716;4045.4943132108488;4047.271491131595;4068.572799856002;4079.4084857695766;5703.686297253691;5716.256886604715;5721.34204566476;5728.51307638847;5740.6268592541355;3956.4460975463458;4132.524759652619;4147.817871906492;4161.375793630979;4165.479315085614;4156.896077598024;4193.098483825992;4193.287141186006;4209.410682504452;4217.704760666786;4639.652026098056;4719.598834099072;4725.267583524559;4726.716397016121;4759.333693282943;5439.198812611508;5553.361363443256;5561.582881283839;5571.860703482364;5581.386047534768;1436.4110714606961;1442.596073099534;1448.2324368084933;1450.187894778927;1455.5196785060905;906.309732349164;938.4885237545554;942.5672977074807;957.9760505987406;960.8949707835905;4692.249240121564;4722.834700785525;4780.5858041688725;4808.663393562487;4831.371921650163;4943.703377797344;5023.824166154167;5024.0956627807345;5030.2957585938;5042.050400515666;4662.953370466252;4744.430668319824;4810.5670489655395;4840.322354870321;5041.395032596112;2994.6855580164206;3011.3073992981736;3021.561873528326;3032.651245106841;3049.359634476785;5983.730732117066;5990.610610310316;5993;6004.069369247686;6012.759489620366;5550.944490555124;5806.970965145148;5828.105865593614;5839.416058394211;5874.324452687995;5882.323532793698;5883.205767221456;5898.321693005273;5923.297938788257;5925.229720136354;5529.341197640611;5606.523445507178;5652.434756524314;5677.460641239241;5692.658440493584;5633.38032816398;5639.605227634026;5646.548276137817;5648.887022259614;5649.293838270216;5877.588568800143;5915.811149874574;5927.4665280125;5949.672767997802;5959.851003724942;3628.3468975584647;3848.9037774055873;4012.538558065743;4069.1251380953236;4082.2039702257775;5574.108142697149;5647.181158731879;5673.035583950656;5674.460926212003;5700.3444603871085;5522.641028333145;5533.142362933751;5562.944370556243;5568.387477377566;5577.8047768327915;5258;5454.59090568201;5540.506771952718;5541.833744987657;5547.5007249347755;5380.520356901883;5398.757055932414;5404.919016196698;5458.699771512446;5476.17857321405;5363.410024897336;5568.220449137205;5578.163275508706;5584.664920104644;5606.327240731139;5429.375621803543;5460.426655201306;5471.753771080391;5476.986757449885;5489.780408783604 05:26:57 INFO - PROCESS | 24871 | |5;yui.html;742.261449857392;749.2582343479957;768.1281745219175;806.862833318336;817.5993763056102;13923.512677056306;14349.426022959082;14362.210078445694;14432.422703091865;14446.422143114289;14318.355673994669;14518.709625807503;14522.927385363058;14535.854641453583;14555.345009474573;663.9004149377583;779.1779672445567;792.579932635704;792.9722459713911;800.1758189065243;775.9146493885668;782.2959336597052;783.0955246690054;784.6076961519241;784.8116452051495;684.4626967830254;842.6755699055877;843.0936743001267;843.3548335523329;844.2654890245495;816.346922462031;823.17271142502;829.6473998550592;830.8421399933993;831.9625616847256;593.0955293177938;594.6491569973693;594.6759016336107;595.9433853783884;596.3201949777257;13841.30793460323;13901.721965560733;13903.374348154357;13913.443462261497;13927.721445571133;14196;14503.27483625825;14506.782398264035;14734.410623575151;14753.483628072965;12691.365431728469;12719.936400318033;12882.227066376048;12921.353932303442;13198.60404187876;4454.13144436835;4485.237509623372;4496.64026877849;4527.660425468103;4651.651126165517;74660.62669686617;75037.24962750412;75065.62467187684;75127.62436187784;75291.24708752897;11536;11600.18798684084;11724.237924534878;11919.582814601446;11942.283462992249;21354.572908542053;21365.57268854614;21375.144994200058;21387.89306053491;21499;8139.511629302261;8256.174382561696;8330.541820199947;8410.915890841135;8656.8701469478;4793.400824896888;4801.231802911588;4938.135826230396;4943.653944223942;5007.624428167902;3510.8420121094614;3626.782393056425;3627.256412435497;3629.1108678373967;3631.7094632429344;528.9029000014959;562.9577781666392;638.9169407976933;671.8320419895026;676.3067855448106;705.2453874354494;728.883378659412;754.2344520311888;755.7945077601217;769.2730369800597;9118.680846170484;9156.084391560924;9257.814843703089;9329.533523323807;9490.762730931643;610.3408319015452;656.6847913001691;682.6211452643731;754.1892465599393;764.2720136046254;4426;4527.705699129546;4552.6813123081065;4563.178627847019;4622.451766692338;74336.62831685915;115071.42464287793;116059;120888.39555802164;121177;97060.51469742606;97310;97625.51187244018;99242;100463;89206;89454;90462.54768726115;91489.54255228682;93040.99999999865;8894.555272236234;8970.084811868683;8995.145461181177;9053.456792592466;9061.68284110053;49005;50008;50029.49970500248;51227;52626.21060684016;71320;75550;75600.24399755932;77478;78716;12173.513059477522;12184.939075304566;12307.75384492323;12313.56902508408;12568.811467827807;13380.19718816874;13659.317034148055;13730.93134534361;14007.159570425807;14035.298235088001;8946.955265223633;13662;14060.296985150497;14337.746199570438;14470.204138772047;13886.444542218198;14048.508302209373;14060.648483787987;14442.783358249424;14445.499525213485;13498;14011.579652610439;14130.50543230982;14710.117392956457;14886.10683359002;11287.548498060314;11854;12039.63881083569;12137.332446715516;12182.634520964386;11760.324915841647;12053.337066461429;12067.336296503776;12166.148369614042;12462.31457269859 05:26:57 INFO - PROCESS | 24871 | __end_tp_report 05:26:57 INFO - PROCESS | 24871 | __start_cc_report 05:26:57 INFO - PROCESS | 24871 | _x_x_mozilla_cycle_collect,1041 05:26:57 INFO - PROCESS | 24871 | __end_cc_report 05:26:57 INFO - PROCESS | 24871 | __startTimestamp1467030417756__endTimestamp 05:26:57 INFO - PROCESS | 24871 | 05:26:57 INFO - PROCESS | 24871 | ------- Summary: start ------- 05:26:57 INFO - PROCESS | 24871 | Number of tests: 6 05:26:57 INFO - PROCESS | 24871 | 05:26:57 INFO - PROCESS | 24871 | [#0] dojo.html Cycles:165 Average:5372.96 Median:5569.00 stddev:614.80 (11.0%) stddev-sans-first:589.85 05:26:57 INFO - PROCESS | 24871 | Values: 3082.5 3092.6 3123.1 3152.6 3187.2 5292.4 5296.8 5327.6 5393.4 5431.4 5379.6 5391.3 5394.9 5451.0 5457.1 4840.6 4911.5 4934.7 4943.7 5049.8 4957.4 4966.0 4970.8 4996.3 5019.0 4855.8 4856.1 4859.1 4890.6 4906.8 4833.0 4847.8 4852.4 4921.9 4963.6 4875.9 4887.4 4891.8 4904.8 4940.0 5244.6 5314.9 5392.6 5405.5 5468.7 5841.7 5869.5 5883.9 5916.8 5925.9 5685.7 5897.5 5915.3 5930.4 5953.2 5352.5 5373.2 5417.6 5507.1 5518.1 6004.2 6023.8 6025.1 6026.4 6034.3 5754.5 5755.9 5771.4 5774.2 5776.1 5640.5 5740.5 5797.5 5802.0 5832.1 5779.7 5788.0 5824.7 5825.4 5830.6 5686.9 5783.2 5820.0 5848.6 5852.8 4380.7 4412.5 4415.1 4444.4 4445.5 3939.0 3944.1 3950.6 3968.3 3985.5 5351.1 5359.2 5509.8 5514.7 5515.3 5693.6 5736.2 5765.7 5773.3 5811.1 5442.4 5443.1 5451.8 5457.2 5461.3 4895.9 4928.8 4965.8 4984.1 5046.2 5998.7 6013.2 6016.5 6021.6 6061.5 5743.9 5756.5 5757.4 5757.5 5759.2 5774.0 5854.8 5929.5 5954.1 5998.4 5672.3 5681.6 5683.1 5683.3 5685.2 5729.7 5732.7 5767.6 5776.6 5786.9 5494.7 5589.7 5612.7 5645.5 5665.9 5650.4 5653.5 5656.3 5661.9 5666.7 5389.5 5554.7 5564.6 5564.9 5569.0 5526.4 5642.4 5647.5 5671.6 5714.1 5489.0 5588.4 5590.0 5594.5 5603.0 05:26:57 INFO - PROCESS | 24871 | 05:26:57 INFO - PROCESS | 24871 | [#1] ext.html Cycles:180 Average:57685.89 Median:41268.98 stddev:112848.62 (273.4%) stddev-sans-first:113083.78 05:26:57 INFO - PROCESS | 24871 | Values: 594.9 624.6 631.8 633.7 636.5 30440.7 30770.5 42517.1 43158.8 43261.4 41052.0 44394.8 44439.0 44463.3 44485.6 8902.0 9049.5 9061.6 9066.0 9067.4 8744.6 8921.4 8924.0 8930.3 8934.4 8964.9 9013.3 9022.7 9023.8 9024.5 8909.6 8947.1 8952.6 8960.5 8964.5 8732.9 8795.7 8800.4 8804.8 8808.7 42369.0 42432.6 42757.6 42848.8 42872.6 3488.4 3636.7 3650.7 3656.4 3950.4 32075.5 32543.2 32677.8 33004.8 33079.0 4259.9 4324.8 4339.6 4343.0 4448.4 329446.0 330381.0 330634.0 332021.0 332297.0 58350.4 58387.4 58601.0 58691.7 58818.4 35411.0 36221.3 36278.8 37623.0 37635.0 14719.1 14804.2 14804.4 14822.9 14833.3 10833.7 10867.7 10877.6 10880.7 10885.6 19503.6 19525.1 19721.8 19731.3 19753.3 6828.4 7131.3 7187.2 7257.4 7309.8 946.7 1022.9 1027.3 1032.0 1059.7 31811.2 32074.0 32220.5 32229.2 32348.0 1027.5 1082.0 1105.6 1140.9 1180.3 16832.5 17250.3 17261.9 17283.8 17361.5 529544.0 532198.0 535016.0 537931.0 545032.0 57761.7 58222.4 58315.7 58375.0 58381.4 1229.9 1306.8 1358.2 1362.7 1390.2 31055.7 33027.2 33036.7 33233.8 33368.7 49373.5 49697.0 50015.7 50311.0 50388.0 380406.0 384035.0 384494.0 384693.0 385392.0 24889.9 27154.5 27981.7 28021.7 28086.3 47224.0 47249.0 47339.0 47375.3 48858.5 40367.6 40638.8 40797.2 41122.8 41960.4 40204.6 40327.4 41266.4 41529.8 43290.8 41049.6 41271.6 43272.8 43995.8 44204.3 37821.4 42492.4 42929.8 43161.6 43374.6 31606.8 32187.0 32469.0 32523.8 32897.5 05:26:57 INFO - PROCESS | 24871 | 05:26:57 INFO - PROCESS | 24871 | [#2] jquery.html Cycles:180 Average:27940.38 Median:2637.06 stddev:76151.49 (2887.7%) stddev-sans-first:76337.02 05:26:57 INFO - PROCESS | 24871 | Values: 386.4 391.7 393.3 399.7 403.1 15144.0 16368.5 18013.4 19111.1 19130.9 17761.2 18681.3 19081.3 19583.3 19599.5 1744.2 1745.4 1745.7 1746.1 2102.9 3945.0 5554.1 5622.5 5849.8 5945.5 5872.6 5893.6 5905.6 5928.0 5945.5 5752.1 5886.7 5991.3 6003.2 6004.2 5537.4 5798.3 5806.8 5807.4 5830.1 14446.0 14698.6 14699.6 14722.7 15459.5 2443.8 2527.6 2746.5 2750.7 2839.2 10221.8 10308.3 10383.1 10893.2 10899.0 1938.4 1941.9 1979.8 1994.5 2074.0 80545.0 80780.6 81779.0 84172.6 84208.2 11048.2 11199.3 11389.7 11518.8 11637.3 15845.3 15852.7 15884.4 16009.3 16030.4 7654.1 7755.0 7758.6 7780.9 7872.9 7104.6 7147.4 7160.2 7224.1 7297.2 4816.7 4832.3 4860.6 4894.7 4964.9 1813.0 1816.2 1849.9 1959.2 1983.3 913.4 950.2 977.1 989.2 1006.2 18872.3 19479.3 19690.7 19876.7 19895.3 977.0 985.7 995.9 1041.6 1043.2 10595.9 10987.1 11029.4 11038.3 11127.8 450972.0 457192.0 460861.0 466159.0 466221.3 89706.0 89794.6 91292.0 92140.5 92980.0 993.5 995.2 1010.3 1011.5 1016.2 17401.6 17622.3 17777.6 17846.6 17924.4 41522.4 41824.2 42909.1 43105.0 43408.8 58620.0 58761.0 59167.4 59970.7 60682.7 8616.7 9013.5 9079.7 9132.5 9160.5 10255.1 12795.5 13628.0 13674.2 13988.7 9461.0 11055.6 11242.2 11717.1 12305.9 12049.8 12157.5 12157.6 12194.0 12418.8 11763.6 12449.2 12495.5 12540.5 12829.9 9021.7 9144.3 9290.9 9325.4 9326.5 9178.1 11077.4 12112.5 12206.0 12213.8 05:26:57 INFO - PROCESS | 24871 | 05:26:57 INFO - PROCESS | 24871 | [#3] mootools.html Cycles:180 Average:5910.93 Median:4853.39 stddev:3421.20 (70.5%) stddev-sans-first:3413.50 05:26:57 INFO - PROCESS | 24871 | Values: 1333.4 1463.4 1480.0 1498.2 1503.9 8354.7 8786.5 8788.1 8994.8 9002.5 8735.5 8866.1 8936.6 8946.7 8961.9 1994.6 2204.1 2261.2 2299.9 2332.0 2343.1 2351.9 2352.3 2352.6 2355.8 2302.2 2324.1 2359.3 2360.8 2362.0 1888.9 2196.5 2246.8 2281.3 2287.2 2230.4 2239.9 2259.5 2260.0 2263.4 8953.2 8970.9 9043.4 9044.4 9047.4 5169.9 5311.1 5319.4 5319.5 5323.5 3241.5 3354.1 3441.1 3441.4 3460.0 1085.2 1086.5 1095.9 1099.7 1103.1 12700.1 12702.4 12704.2 12716.2 12726.3 4759.6 4772.3 4855.9 4875.9 4897.8 10436.1 10482.3 10485.6 10486.4 10511.2 5267.5 5390.9 5394.0 5394.6 5396.7 4203.9 4850.9 4992.9 5010.1 5051.7 4005.2 4017.4 4058.1 4097.2 4225.7 1286.1 1291.3 1299.2 1310.8 1321.0 895.7 907.4 911.5 919.7 941.2 5884.2 5925.6 6125.0 6132.2 6250.2 985.7 996.2 999.8 1001.5 1101.9 4110.9 4150.6 4193.6 4252.8 4284.6 11125.4 11469.1 11491.1 11519.3 11543.0 10408.3 11341.5 11382.4 11385.1 11386.3 8030.8 8333.2 8388.6 8397.9 8408.0 5778.8 5852.7 5854.1 5874.0 6063.5 10183.7 10317.2 10329.5 10377.9 10431.5 10773.1 10774.0 10786.8 10846.1 10916.4 7129.4 7779.5 7936.9 7960.6 8097.0 8831.9 8839.6 8941.5 8951.1 8954.3 7634.7 7737.5 7757.7 7790.2 8060.0 7472.4 7736.5 7813.9 7941.1 7952.4 6829.9 7030.5 7079.0 7104.6 7119.6 5196.5 5237.5 5302.6 5343.5 5351.5 5095.2 5135.5 5182.8 5277.5 5373.5 05:26:57 INFO - PROCESS | 24871 | 05:26:57 INFO - PROCESS | 24871 | [#4] prototype.html Cycles:180 Average:4635.74 Median:5186.98 stddev:1348.55 (26.0%) stddev-sans-first:1312.98 05:26:57 INFO - PROCESS | 24871 | Values: 326.9 332.8 332.9 334.2 338.3 5118.4 5173.4 5244.2 5312.0 5347.6 5255.6 5274.8 5301.4 5304.9 5308.3 4147.5 4159.3 4170.7 4185.6 4224.9 3953.0 3957.5 4212.4 4216.1 4238.9 4158.5 4183.9 4194.2 4198.5 4198.8 4203.7 4213.5 4223.6 4231.7 4238.6 3649.7 3699.6 3779.8 3791.7 3798.3 5101.8 5114.6 5138.6 5155.7 5200.6 4696.6 4709.5 4710.9 4713.6 4720.6 5345.3 5452.9 5496.8 5503.6 5515.8 4041.2 4045.5 4047.3 4068.6 4079.4 5703.7 5716.3 5721.3 5728.5 5740.6 3956.4 4132.5 4147.8 4161.4 4165.5 4156.9 4193.1 4193.3 4209.4 4217.7 4639.7 4719.6 4725.3 4726.7 4759.3 5439.2 5553.4 5561.6 5571.9 5581.4 1436.4 1442.6 1448.2 1450.2 1455.5 906.3 938.5 942.6 958.0 960.9 4692.2 4722.8 4780.6 4808.7 4831.4 4943.7 5023.8 5024.1 5030.3 5042.1 4663.0 4744.4 4810.6 4840.3 5041.4 2994.7 3011.3 3021.6 3032.7 3049.4 5983.7 5990.6 5993.0 6004.1 6012.8 5550.9 5807.0 5828.1 5839.4 5874.3 5882.3 5883.2 5898.3 5923.3 5925.2 5529.3 5606.5 5652.4 5677.5 5692.7 5633.4 5639.6 5646.5 5648.9 5649.3 5877.6 5915.8 5927.5 5949.7 5959.9 3628.3 3848.9 4012.5 4069.1 4082.2 5574.1 5647.2 5673.0 5674.5 5700.3 5522.6 5533.1 5562.9 5568.4 5577.8 5258.0 5454.6 5540.5 5541.8 5547.5 5380.5 5398.8 5404.9 5458.7 5476.2 5363.4 5568.2 5578.2 5584.7 5606.3 5429.4 5460.4 5471.8 5477.0 5489.8 05:26:57 INFO - PROCESS | 24871 | 05:26:57 INFO - PROCESS | 24871 | [#5] yui.html Cycles:180 Average:20710.28 Median:26903.12 stddev:29810.70 (110.8%) stddev-sans-first:29856.62 05:26:57 INFO - PROCESS | 24871 | Values: 742.3 749.3 768.1 806.9 817.6 13923.5 14349.4 14362.2 14432.4 14446.4 14318.4 14518.7 14522.9 14535.9 14555.3 663.9 779.2 792.6 793.0 800.2 775.9 782.3 783.1 784.6 784.8 684.5 842.7 843.1 843.4 844.3 816.3 823.2 829.6 830.8 832.0 593.1 594.6 594.7 595.9 596.3 13841.3 13901.7 13903.4 13913.4 13927.7 14196.0 14503.3 14506.8 14734.4 14753.5 12691.4 12719.9 12882.2 12921.4 13198.6 4454.1 4485.2 4496.6 4527.7 4651.7 74660.6 75037.2 75065.6 75127.6 75291.2 11536.0 11600.2 11724.2 11919.6 11942.3 21354.6 21365.6 21375.1 21387.9 21499.0 8139.5 8256.2 8330.5 8410.9 8656.9 4793.4 4801.2 4938.1 4943.7 5007.6 3510.8 3626.8 3627.3 3629.1 3631.7 528.9 563.0 638.9 671.8 676.3 705.2 728.9 754.2 755.8 769.3 9118.7 9156.1 9257.8 9329.5 9490.8 610.3 656.7 682.6 754.2 764.3 4426.0 4527.7 4552.7 4563.2 4622.5 74336.6 115071.4 116059.0 120888.4 121177.0 97060.5 97310.0 97625.5 99242.0 100463.0 89206.0 89454.0 90462.5 91489.5 93041.0 8894.6 8970.1 8995.1 9053.5 9061.7 49005.0 50008.0 50029.5 51227.0 52626.2 71320.0 75550.0 75600.2 77478.0 78716.0 12173.5 12184.9 12307.8 12313.6 12568.8 13380.2 13659.3 13730.9 14007.2 14035.3 8947.0 13662.0 14060.3 14337.7 14470.2 13886.4 14048.5 14060.6 14442.8 14445.5 13498.0 14011.6 14130.5 14710.1 14886.1 11287.5 11854.0 12039.6 12137.3 12182.6 11760.3 12053.3 12067.3 12166.1 12462.3 05:26:57 INFO - PROCESS | 24871 | -------- Summary: end -------- 05:26:57 INFO - PROCESS | 24871 | 05:26:58 INFO - TEST-INFO | 24871: exit 0 05:26:58 INFO - TEST-OK | dromaeo_css | took 1113953ms 05:26:58 INFO - TEST-START | kraken 05:26:58 INFO - operating with platform_type : linux_ 05:26:58 INFO - Initialising browser for kraken test... 05:26:58 INFO - TEST-INFO | started process 25054 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjDPPSy/profile http://localhost:56981/getInfo.html) 05:27:02 INFO - PROCESS | 25054 | __metrics Screen width/height:1600/1200 05:27:02 INFO - PROCESS | 25054 | colorDepth:24 05:27:02 INFO - PROCESS | 25054 | Browser inner width/height: 1024/697 05:27:02 INFO - PROCESS | 25054 | __metrics 05:27:03 INFO - PROCESS | 25054 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:27:04 INFO - TEST-INFO | 25054: exit 0 05:27:04 INFO - Browser initialized. 05:27:04 INFO - Running cycle 1/1 for kraken test... 05:27:04 INFO - TEST-INFO | started process 25133 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjDPPSy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:27:16 INFO - PROCESS | 25133 | RSS: Main: 173883392 05:27:16 INFO - PROCESS | 25133 | 05:27:19 INFO - PROCESS | 25133 | Cycle 1(1): loaded http://localhost:56981/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56981/tests/kraken/driver.html?testName=audio-beat-detection) 05:27:20 INFO - PROCESS | 25133 | RSS: Main: 232083456 05:27:20 INFO - PROCESS | 25133 | 05:27:22 INFO - PROCESS | 25133 | Cycle 1(1): loaded http://localhost:56981/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56981/tests/kraken/driver.html?testName=audio-dft) 05:27:23 INFO - PROCESS | 25133 | RSS: Main: 221130752 05:27:23 INFO - PROCESS | 25133 | 05:27:26 INFO - PROCESS | 25133 | Cycle 1(1): loaded http://localhost:56981/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56981/tests/kraken/driver.html?testName=audio-fft) 05:27:27 INFO - PROCESS | 25133 | RSS: Main: 286052352 05:27:27 INFO - PROCESS | 25133 | 05:27:29 INFO - PROCESS | 25133 | Cycle 1(1): loaded http://localhost:56981/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56981/tests/kraken/driver.html?testName=audio-oscillator) 05:27:29 INFO - PROCESS | 25133 | RSS: Main: 197107712 05:27:29 INFO - PROCESS | 25133 | 05:27:31 INFO - PROCESS | 25133 | Cycle 1(1): loaded http://localhost:56981/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56981/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:27:32 INFO - PROCESS | 25133 | RSS: Main: 200830976 05:27:32 INFO - PROCESS | 25133 | 05:27:35 INFO - PROCESS | 25133 | Cycle 1(1): loaded http://localhost:56981/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56981/tests/kraken/driver.html?testName=imaging-darkroom) 05:27:36 INFO - PROCESS | 25133 | RSS: Main: 237477888 05:27:36 INFO - PROCESS | 25133 | 05:27:39 INFO - PROCESS | 25133 | Cycle 1(1): loaded http://localhost:56981/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56981/tests/kraken/driver.html?testName=imaging-desaturate) 05:27:40 INFO - PROCESS | 25133 | RSS: Main: 237547520 05:27:40 INFO - PROCESS | 25133 | 05:27:42 INFO - PROCESS | 25133 | Cycle 1(1): loaded http://localhost:56981/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56981/tests/kraken/driver.html?testName=json-parse-financial) 05:27:43 INFO - PROCESS | 25133 | RSS: Main: 237457408 05:27:43 INFO - PROCESS | 25133 | 05:27:45 INFO - PROCESS | 25133 | Cycle 1(1): loaded http://localhost:56981/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56981/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:27:45 INFO - PROCESS | 25133 | RSS: Main: 225411072 05:27:45 INFO - PROCESS | 25133 | 05:27:47 INFO - PROCESS | 25133 | Cycle 1(1): loaded http://localhost:56981/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56981/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:27:48 INFO - PROCESS | 25133 | RSS: Main: 227184640 05:27:48 INFO - PROCESS | 25133 | 05:27:50 INFO - PROCESS | 25133 | Cycle 1(1): loaded http://localhost:56981/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56981/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:27:50 INFO - PROCESS | 25133 | RSS: Main: 235081728 05:27:50 INFO - PROCESS | 25133 | 05:27:53 INFO - PROCESS | 25133 | Cycle 1(1): loaded http://localhost:56981/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56981/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:27:53 INFO - PROCESS | 25133 | RSS: Main: 250777600 05:27:53 INFO - PROCESS | 25133 | 05:27:56 INFO - PROCESS | 25133 | Cycle 1(1): loaded http://localhost:56981/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56981/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:27:57 INFO - PROCESS | 25133 | RSS: Main: 244396032 05:27:57 INFO - PROCESS | 25133 | 05:27:58 INFO - PROCESS | 25133 | Cycle 1(1): loaded http://localhost:56981/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56981/tests/kraken/driver.html?testName=ai-astar) 05:27:59 INFO - PROCESS | 25133 | RSS: Main: 286613504 05:27:59 INFO - PROCESS | 25133 | 05:27:59 INFO - PROCESS | 25133 | __start_tp_report 05:27:59 INFO - PROCESS | 25133 | _x_x_mozilla_page_load 05:27:59 INFO - PROCESS | 25133 | _x_x_mozilla_page_load_details 05:27:59 INFO - PROCESS | 25133 | |i|pagename|runs| 05:27:59 INFO - PROCESS | 25133 | |0;ai-astar;103;109;109;109;109;109;109;109;110;109 05:27:59 INFO - PROCESS | 25133 | |1;audio-beat-detection;154;131;133;191;126;131;127;150;161;135 05:27:59 INFO - PROCESS | 25133 | |2;audio-dft;163;160;161;162;161;161;162;163;163;162 05:27:59 INFO - PROCESS | 25133 | |3;audio-fft;74;75;76;131;76;76;73;76;104;75 05:27:59 INFO - PROCESS | 25133 | |4;audio-oscillator;86;86;115;86;84;86;120;85;87;120 05:27:59 INFO - PROCESS | 25133 | |5;imaging-gaussian-blur;118;117;118;117;116;117;117;117;117;116 05:27:59 INFO - PROCESS | 25133 | |6;imaging-darkroom;146;147;145;146;146;146;145;145;146;146 05:27:59 INFO - PROCESS | 25133 | |7;imaging-desaturate;96;95;95;96;95;95;95;95;98;95 05:27:59 INFO - PROCESS | 25133 | |8;json-parse-financial;54;64;52;54;54;52;53;53;54;54 05:27:59 INFO - PROCESS | 25133 | |9;json-stringify-tinderbox;62;63;62;62;62;62;63;62;62;63 05:27:59 INFO - PROCESS | 25133 | |10;stanford-crypto-aes;79;79;78;78;89;80;79;80;125;79 05:27:59 INFO - PROCESS | 25133 | |11;stanford-crypto-ccm;120;126;128;123;125;129;127;136;124;123 05:27:59 INFO - PROCESS | 25133 | |12;stanford-crypto-pbkdf2;162;160;161;165;156;160;159;165;158;156 05:27:59 INFO - PROCESS | 25133 | |13;stanford-crypto-sha256-iterative;64;63;63;62;62;63;62;63;66;62 05:27:59 INFO - PROCESS | 25133 | __end_tp_report 05:27:59 INFO - PROCESS | 25133 | __start_cc_report 05:27:59 INFO - PROCESS | 25133 | _x_x_mozilla_cycle_collect,1636 05:27:59 INFO - PROCESS | 25133 | __end_cc_report 05:27:59 INFO - PROCESS | 25133 | __startTimestamp1467030479116__endTimestamp 05:27:59 INFO - PROCESS | 25133 | 05:27:59 INFO - PROCESS | 25133 | ------- Summary: start ------- 05:27:59 INFO - PROCESS | 25133 | Number of tests: 14 05:27:59 INFO - PROCESS | 25133 | 05:27:59 INFO - PROCESS | 25133 | [#0] ai-astar Cycles:10 Average:108.50 Median:109.00 stddev:1.96 (1.8%) stddev-sans-first:0.33 05:27:59 INFO - PROCESS | 25133 | Values: 103.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 110.0 109.0 05:27:59 INFO - PROCESS | 25133 | 05:27:59 INFO - PROCESS | 25133 | [#1] audio-beat-detection Cycles:10 Average:143.90 Median:142.50 stddev:20.51 (14.4%) stddev-sans-first:21.43 05:27:59 INFO - PROCESS | 25133 | Values: 154.0 131.0 133.0 191.0 126.0 131.0 127.0 150.0 161.0 135.0 05:27:59 INFO - PROCESS | 25133 | 05:27:59 INFO - PROCESS | 25133 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.03 (0.6%) stddev-sans-first:1.00 05:27:59 INFO - PROCESS | 25133 | Values: 163.0 160.0 161.0 162.0 161.0 161.0 162.0 163.0 163.0 162.0 05:27:59 INFO - PROCESS | 25133 | 05:27:59 INFO - PROCESS | 25133 | [#3] audio-fft Cycles:10 Average:83.60 Median:75.50 stddev:18.99 (25.2%) stddev-sans-first:19.82 05:27:59 INFO - PROCESS | 25133 | Values: 74.0 75.0 76.0 131.0 76.0 76.0 73.0 76.0 104.0 75.0 05:27:59 INFO - PROCESS | 25133 | 05:27:59 INFO - PROCESS | 25133 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:86.00 stddev:15.83 (18.4%) stddev-sans-first:16.42 05:27:59 INFO - PROCESS | 25133 | Values: 86.0 86.0 115.0 86.0 84.0 86.0 120.0 85.0 87.0 120.0 05:27:59 INFO - PROCESS | 25133 | 05:27:59 INFO - PROCESS | 25133 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 05:27:59 INFO - PROCESS | 25133 | Values: 118.0 117.0 118.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 05:27:59 INFO - PROCESS | 25133 | 05:27:59 INFO - PROCESS | 25133 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 05:27:59 INFO - PROCESS | 25133 | Values: 146.0 147.0 145.0 146.0 146.0 146.0 145.0 145.0 146.0 146.0 05:27:59 INFO - PROCESS | 25133 | 05:27:59 INFO - PROCESS | 25133 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.00 stddev:0.97 (1.0%) stddev-sans-first:1.01 05:27:59 INFO - PROCESS | 25133 | Values: 96.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 98.0 95.0 05:27:59 INFO - PROCESS | 25133 | 05:27:59 INFO - PROCESS | 25133 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.00 stddev:3.47 (6.4%) stddev-sans-first:3.68 05:27:59 INFO - PROCESS | 25133 | Values: 54.0 64.0 52.0 54.0 54.0 52.0 53.0 53.0 54.0 54.0 05:27:59 INFO - PROCESS | 25133 | 05:27:59 INFO - PROCESS | 25133 | [#9] json-stringify-tinderbox Cycles:10 Average:62.30 Median:62.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 05:27:59 INFO - PROCESS | 25133 | Values: 62.0 63.0 62.0 62.0 62.0 62.0 63.0 62.0 62.0 63.0 05:27:59 INFO - PROCESS | 25133 | 05:27:59 INFO - PROCESS | 25133 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:79.00 stddev:14.55 (18.4%) stddev-sans-first:15.30 05:27:59 INFO - PROCESS | 25133 | Values: 79.0 79.0 78.0 78.0 89.0 80.0 79.0 80.0 125.0 79.0 05:27:59 INFO - PROCESS | 25133 | 05:27:59 INFO - PROCESS | 25133 | [#11] stanford-crypto-ccm Cycles:10 Average:126.10 Median:126.50 stddev:4.38 (3.5%) stddev-sans-first:4.06 05:27:59 INFO - PROCESS | 25133 | Values: 120.0 126.0 128.0 123.0 125.0 129.0 127.0 136.0 124.0 123.0 05:27:59 INFO - PROCESS | 25133 | 05:27:59 INFO - PROCESS | 25133 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.20 Median:160.50 stddev:3.19 (2.0%) stddev-sans-first:3.32 05:27:59 INFO - PROCESS | 25133 | Values: 162.0 160.0 161.0 165.0 156.0 160.0 159.0 165.0 158.0 156.0 05:27:59 INFO - PROCESS | 25133 | 05:27:59 INFO - PROCESS | 25133 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.00 stddev:1.25 (2.0%) stddev-sans-first:1.27 05:27:59 INFO - PROCESS | 25133 | Values: 64.0 63.0 63.0 62.0 62.0 63.0 62.0 63.0 66.0 62.0 05:27:59 INFO - PROCESS | 25133 | -------- Summary: end -------- 05:27:59 INFO - PROCESS | 25133 | 05:28:00 INFO - TEST-INFO | 25133: exit 0 05:28:00 INFO - TEST-OK | kraken | took 61649ms 05:28:00 INFO - SUITE-END | took 1175s 05:28:00 INFO - Completed test suite (00:19:35) 05:28:00 INFO - javascript benchmark 05:28:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3082.4759790835556, 3092.567040614314, 3123.1099136746016, 3152.6216853977526, 3187.235063584739, 5292.444293349201, 5296.761645725942, 5327.600429967749, 5393.4336894626085, 5431.402545719968, 5379.596530260226, 5391.32608423947, 5394.8921021579645, 5450.972745136279, 5457.099578569531, 4840.636952228588, 4911.484294149116, 4934.679245849008, 4943.6539442239055, 5049.823256186034, 4957.380327459067, 4965.950340496585, 4970.751462426864, 4996.250562415648, 5019.0463811875625, 4855.781489832966, 4856.125897338477, 4859.125357435661, 4890.559849613534, 4906.779194936236, 4833.03339332135, 4847.806087756486, 4852.369192005052, 4921.926171107436, 4963.60291176705, 4875.8781030474165, 4887.437944636376, 4891.804327826882, 4904.803807847682, 4939.975300123512, 5244.554212891909, 5314.867128321823, 5392.595555333366, 5405.540529055035, 5468.699221542814, 5841.7371218295275, 5869.4717475427415, 5883.941160588382, 5916.822495325147, 5925.940740592582, 5685.687287199203, 5897.469227769521, 5915.290165180206, 5930.3773103823905, 5953.166556682068, 5352.545033672142, 5373.247745315659, 5417.6478528895495, 5507.146392309199, 5518.117101263779, 6004.189434426384, 6023.789167379121, 6025.0661147522205, 6026.397360263939, 6034.336223015464, 5754.539636829128, 5755.913661295084, 5771.422857714279, 5774.191613174159, 5776.104703770922, 5640.520555752807, 5740.483356497935, 5797.507211886952, 5802.0, 5832.125181222766, 5779.711014449261, 5788.0449725795615, 5824.737886795019, 5825.446582574648, 5830.562707796932, 5686.886262274731, 5783.190353350535, 5819.970900145557, 5848.64908105515, 5852.795152169653, 4380.6933514653665, 4412.536683648171, 4415.072834704748, 4444.355568442557, 4445.51099379068, 3939.03493644059, 3944.112574670676, 3950.644442000234, 3968.3055465294037, 3985.501812273466, 5351.063563876306, 5359.249705041298, 5509.834704958857, 5514.6691198528215, 5515.255440515479, 5693.572982026365, 5736.196932429463, 5765.740541675635, 5773.336066352339, 5811.070228763378, 5442.401335853053, 5443.129099344165, 5451.781928722886, 5457.181422786613, 5461.317335333083, 4895.877603059952, 4928.753562321869, 4965.776540055706, 4984.077945580079, 5046.167382381939, 5998.700064996733, 6013.1581578579035, 6016.518678505709, 6021.57848950578, 6061.4544690977145, 5743.942560574341, 5756.481916627524, 5757.424257574209, 5757.453041961007, 5759.222504961776, 5774.0, 5854.824355269348, 5929.495992840657, 5954.07711804671, 5998.370171132143, 5672.290963629546, 5681.630694004876, 5683.090705487102, 5683.346415162144, 5685.232493613309, 5729.656220626775, 5732.684702341411, 5767.5674324425, 5776.595638305446, 5786.855328616818, 5494.725263736877, 5589.692566908859, 5612.663240205601, 5645.463680950304, 5665.886682266414, 5650.378458369494, 5653.519450846724, 5656.264685590847, 5661.886762264814, 5666.716664166857, 5389.461053894579, 5554.722263886871, 5564.582656300713, 5564.944350556442, 5569.0, 5526.392096869422, 5642.351129620146, 5647.463490968352, 5671.631343962629, 5714.114312281603, 5489.0, 5588.38527761954, 5590.0, 5594.496495315441, 5602.971985140048], "value": 5331.233506624112, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.8542607061271, 624.6096189881324, 631.7978246960975, 633.6989929783356, 636.5003472274265, 30440.69559304409, 30770.53844192336, 42517.14965700688, 43158.784206079006, 43261.35107973383, 41052.0, 44394.7780261099, 44439.0, 44463.33305000419, 44485.555144448546, 8901.955490222555, 9049.506831372848, 9061.637534498612, 9066.0, 9067.410618309788, 8744.562771861381, 8921.375503714742, 8923.95538022309, 8930.330225233134, 8934.419262747933, 8964.910350896505, 9013.278937685001, 9022.729318120468, 9023.774405639879, 9024.503652299121, 8909.643614255421, 8947.105289471066, 8952.552372381355, 8960.507172105565, 8964.50695211763, 8732.912670873273, 8795.692150774692, 8800.427972181851, 8804.779880502974, 8808.691695790681, 42369.0, 42432.57567424317, 42757.57242427567, 42848.78575607102, 42872.57127428717, 3488.4069708149677, 3636.727245456575, 3650.7444478886487, 3656.3601369760186, 3950.407438884162, 32075.51886721701, 32543.186420339443, 32677.83661081703, 33004.83497582521, 33079.0, 4259.91480170398, 4324.82700691972, 4339.631131353839, 4342.978285108586, 4448.3549885266775, 329446.0, 330381.0, 330634.0, 332021.0, 332297.0, 58350.4164958345, 58387.416125839045, 58601.0, 58691.70654146702, 58818.41181588215, 35411.0, 36221.27557448889, 36278.8186059068, 37623.0, 37635.0, 14719.116852988855, 14804.185769782765, 14804.407823687146, 14822.851771482146, 14833.332500037524, 10833.67498975032, 10867.728306792393, 10877.564897404174, 10880.67357979262, 10885.619003334845, 19503.609927801364, 19525.121369538403, 19721.802781972285, 19731.309404171072, 19753.308634197732, 6828.419584335288, 7131.286871312931, 7187.173475050332, 7257.419406447471, 7309.817254568678, 946.6639343033262, 1022.8721409823772, 1027.3322340478599, 1031.9845202321972, 1059.7403636109202, 31811.204719881724, 32073.9545824573, 32220.516692249636, 32229.194270143435, 32348.0, 1027.5119318323887, 1081.9891801082047, 1105.5688281570194, 1140.914431417647, 1180.2564384437749, 16832.495025149266, 17250.309987600605, 17261.91369043147, 17283.827161728474, 17361.47915562535, 529544.0, 532198.0, 535016.0, 537931.0, 545032.0, 57761.71119144378, 58222.4177758217, 58315.708421457624, 58375.0, 58381.41618583845, 1229.8893099620898, 1306.764782339188, 1358.1868205944977, 1362.6865820861258, 1390.2145287912297, 31055.68944310528, 33027.174320642174, 33036.66963330432, 33233.83383083069, 33368.66631333656, 49373.50626493689, 49697.0, 50015.749921250164, 50311.0, 50388.0, 380406.0, 384035.0, 384494.0, 384693.0, 385392.0, 24889.87555062213, 27154.456910862067, 27981.72018279791, 28021.719782801913, 28086.2978425541, 47224.0, 47249.0, 47339.0, 47375.28937065878, 48858.5114148854, 40367.596324036385, 40638.79680601578, 40797.1840563193, 41122.794386027876, 41960.370594441716, 40204.597954020086, 40327.39508907427, 41266.38100428436, 41529.79235103805, 43290.78354608207, 41049.589504105774, 41271.58728412678, 43272.783636081615, 43995.78002110097, 44204.33693494536, 37821.43267851039, 42492.36261456019, 42929.78535107304, 43161.56838431701, 43374.566254337056, 31606.841965790023, 32187.0, 32469.0, 32523.837380812944, 32897.506537402434], "value": 19750.378958049416, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.35864464988117, 391.71209161266466, 393.2873672531306, 399.6962308645429, 403.12320702472135, 15144.01563898346, 16368.508944731648, 18013.36953206638, 19111.139998700073, 19130.90434547827, 17761.20074596643, 18681.252809830647, 19081.332153374635, 19583.314583989562, 19599.510012249702, 1744.1802352894183, 1745.4327343613313, 1745.70323045082, 1746.0658547676996, 2102.8959796107088, 3944.960550394502, 5554.1113421852515, 5622.522085622706, 5849.824505264849, 5945.464908158265, 5872.618279811799, 5893.5579831512805, 5905.616134951214, 5927.970360148215, 5945.464908158265, 5752.050911599602, 5886.735096920627, 5991.310999235056, 6003.249593800775, 6004.159417681506, 5537.418571050022, 5798.275215598051, 5806.82579522615, 5807.390224026459, 5830.067189249742, 14446.0, 14698.55904322872, 14699.63250918725, 14722.70554588913, 15459.536213913489, 2443.816713746476, 2527.646129541866, 2746.4644394343113, 2750.6561679790025, 2839.190830613286, 10221.846672299922, 10308.278420510567, 10383.117435018032, 10893.237473376867, 10899.019088282013, 1938.3506525314037, 1941.9028249039247, 1979.7525309336334, 1994.5013746563359, 2073.9896300518553, 80545.0, 80780.59609701972, 81779.0, 84172.57913710453, 84208.15791842065, 11048.226624136394, 11199.272047316897, 11389.715257118638, 11518.827217591743, 11637.301761894314, 15845.286962086733, 15852.682946341009, 15884.444044458389, 16009.27958241882, 16030.358785648443, 7654.081510218809, 7754.953081334061, 7758.612069396508, 7780.92219077802, 7872.881906771403, 7104.609246491493, 7147.356737893615, 7160.176579693298, 7224.096987876515, 7297.233790452032, 4816.735079570657, 4832.299316599074, 4860.6111511079025, 4894.702903730515, 4964.90070198594, 1812.9909350453427, 1816.2030128877393, 1849.9445016649522, 1959.2456904092028, 1983.2959299448487, 913.3697748553477, 950.2493030505823, 977.1108291454742, 989.2135752077116, 1006.2201793609864, 18872.339468118826, 19479.318223862098, 19690.70463943042, 19876.70184947227, 19895.303664371677, 977.0473788056588, 985.6796541124163, 995.9253056020683, 1041.6093964763213, 1043.2384359417667, 10595.94702026485, 10987.133041848845, 11029.393383363831, 11038.337699738042, 11127.833082503768, 450972.0, 457192.0, 460861.0, 466159.0, 466221.33778662456, 89706.0, 89794.55102724445, 91292.0, 92140.53929730308, 92980.0, 993.4833886379187, 995.1590905684685, 1010.3382284603597, 1011.4538149399389, 1016.217512515359, 17401.56496087608, 17622.29510819553, 17777.555561111076, 17846.643067138844, 17924.372646957294, 41522.37716434195, 41824.163516728884, 42909.14181716286, 43105.0, 43408.782956085015, 58620.0, 58761.0, 59167.40832591619, 59970.70014649899, 60682.69658651679, 8616.698415555426, 9013.549322533978, 9079.68221112258, 9132.49771262587, 9160.450372977642, 10255.128314093387, 12795.488180472677, 13628.0, 13674.179549227078, 13988.720225595227, 9461.0, 11055.557777688802, 11242.213045086766, 11717.12121590867, 12305.876941230474, 12049.75900481968, 12157.45291461904, 12157.574484892986, 12194.0, 12418.75162496727, 11763.588274410355, 12449.190802597803, 12495.500179992698, 12540.498380064695, 12829.93585032069, 9021.684241051531, 9144.26845852317, 9290.907090929275, 9325.393849399767, 9326.533673316442, 9178.082191780768, 11077.446127693422, 12112.454939527566, 12206.0, 12213.816792747939], "value": 8868.718989004501, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1333.433290851388, 1463.4292625875903, 1480.0231846980992, 1498.220925118938, 1503.902246353987, 8354.707585234519, 8786.472811631307, 8788.077251888548, 8994.820103597924, 9002.504862232574, 8735.475871447701, 8866.069062748415, 8936.55317234139, 8946.731598052053, 8961.865572016424, 1994.5512259741515, 2204.1073365287084, 2261.185973049701, 2299.8850057497143, 2331.976680233193, 2343.0744855781954, 2351.929442116739, 2352.282553821084, 2352.623580227164, 2355.8350915435926, 2302.1712183613886, 2324.081987614891, 2359.2686267257204, 2360.8347415680823, 2361.9645705314433, 1888.9149988250492, 2196.516766311409, 2246.786555277246, 2281.258590957945, 2287.2452090809993, 2230.4200907763934, 2239.9216027439124, 2259.4690247791755, 2260.0055975370783, 2263.411513006614, 8953.23897468716, 8970.86543701845, 9043.366964312501, 9044.41211321262, 9047.411918225294, 5169.896602067975, 5311.070562651521, 5319.441458646825, 5319.494648008433, 5323.547498462635, 3241.4813629819114, 3354.1446931032674, 3441.0881116504147, 3441.4493681010917, 3459.9827000864834, 1085.180688580117, 1086.4513420722485, 1095.9342439453658, 1099.6810924831789, 1103.0734183286079, 12700.110992230548, 12702.364881755968, 12704.237745735285, 12716.173448725804, 12726.300053497054, 4759.571638552547, 4772.281650989082, 4855.927161092586, 4875.853724388274, 4897.751073476241, 10436.060754532129, 10482.318649287772, 10485.633002844865, 10486.37081775096, 10511.211659125596, 5267.525922666979, 5390.9191362129595, 5393.973030134903, 5394.595405344615, 5396.703181325065, 4203.852865149705, 4850.854474365704, 4992.850214493571, 5010.148274793294, 5051.747412629354, 4005.2292645136527, 4017.397390391465, 4058.0869304406274, 4097.221527909687, 4225.746455212636, 1286.0611753420055, 1291.251074376878, 1299.2204677193797, 1310.7968264918952, 1321.0290436529144, 895.6820328783189, 907.4011152639226, 911.4941207629829, 919.6965001549472, 941.223490620241, 5884.205632239678, 5925.585209035326, 6124.969375153096, 6132.202813634199, 6250.218722659668, 985.6944347252374, 996.1781530237583, 999.81003609314, 1001.4942454060653, 1101.9008289254007, 4110.897227569335, 4150.5641907599875, 4193.559676233952, 4252.829886804493, 4284.571542845752, 11125.443727813577, 11469.082473402275, 11491.138164637685, 11519.30884146954, 11543.0, 10408.271421000458, 11341.546338146547, 11382.373969431761, 11385.08919286455, 11386.316820990767, 8030.83938321242, 8333.208345207195, 8388.580570971428, 8397.874031889527, 8408.033076196316, 5778.797742079007, 5852.736626851717, 5854.092615644582, 5874.0, 6063.484603808549, 10183.694489165337, 10317.226208034277, 10329.535170917177, 10377.9481102594, 10431.478426078818, 10773.084287835622, 10774.0, 10786.838197426889, 10846.132309415385, 10916.399598022184, 7129.429645628441, 7779.455438119504, 7936.880946785918, 7960.601969901366, 8096.987876515435, 8831.867521987304, 8839.558022098998, 8941.46351218929, 8951.104889511258, 8954.328425367994, 7634.656440460081, 7737.535747855147, 7757.68969241224, 7790.182030886902, 8059.959700201462, 7472.402207823252, 7736.535807851547, 7813.921860781319, 7941.126476087741, 7952.443328966917, 6829.873070943438, 7030.472714546328, 7079.044329015723, 7104.573725576482, 7119.572825630272, 5196.53231209193, 5237.476252374732, 5302.628815982998, 5343.492368225013, 5351.518363347317, 5095.184770436712, 5135.486451354835, 5182.766775495036, 5277.525022747817, 5373.543248823894], "value": 4688.858495027072, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.90356344878273, 332.7523371890351, 332.9483929990852, 334.23960489885513, 338.3216650615515, 5118.411382690992, 5173.3533308336455, 5244.160934250516, 5312.0, 5347.6256662033675, 5255.553277971377, 5274.780175859316, 5301.443348448415, 5304.9204261936, 5308.256844041837, 4147.543770185284, 4159.251334759742, 4170.666346692257, 4185.644220241268, 4224.8732538023905, 3953.0, 3957.544882338539, 4212.368144778293, 4216.093539888923, 4238.894027649302, 4158.480189976253, 4183.853565125221, 4194.203101410722, 4198.530514319994, 4198.769067701275, 4203.726757760751, 4213.494380674308, 4223.556526564697, 4231.746095234295, 4238.5761423857675, 3649.708023358125, 3699.6115407882053, 3779.790467050545, 3791.696664266852, 3798.2593394288124, 5101.821436249714, 5114.641975061747, 5138.612574604836, 5155.711072231942, 5200.609954253408, 4696.647751418623, 4709.481956984729, 4710.905781884378, 4713.6464765142755, 4720.622350212009, 5345.305110335631, 5452.863678408032, 5496.835094947118, 5503.6147469677135, 5515.834524964257, 4041.2321658884716, 4045.4943132108488, 4047.271491131595, 4068.572799856002, 4079.4084857695766, 5703.686297253691, 5716.256886604715, 5721.34204566476, 5728.51307638847, 5740.6268592541355, 3956.4460975463458, 4132.524759652619, 4147.817871906492, 4161.375793630979, 4165.479315085614, 4156.896077598024, 4193.098483825992, 4193.287141186006, 4209.410682504452, 4217.704760666786, 4639.652026098056, 4719.598834099072, 4725.267583524559, 4726.716397016121, 4759.333693282943, 5439.198812611508, 5553.361363443256, 5561.582881283839, 5571.860703482364, 5581.386047534768, 1436.4110714606961, 1442.596073099534, 1448.2324368084933, 1450.187894778927, 1455.5196785060905, 906.309732349164, 938.4885237545554, 942.5672977074807, 957.9760505987406, 960.8949707835905, 4692.249240121564, 4722.834700785525, 4780.5858041688725, 4808.663393562487, 4831.371921650163, 4943.703377797344, 5023.824166154167, 5024.0956627807345, 5030.2957585938, 5042.050400515666, 4662.953370466252, 4744.430668319824, 4810.5670489655395, 4840.322354870321, 5041.395032596112, 2994.6855580164206, 3011.3073992981736, 3021.561873528326, 3032.651245106841, 3049.359634476785, 5983.730732117066, 5990.610610310316, 5993.0, 6004.069369247686, 6012.759489620366, 5550.944490555124, 5806.970965145148, 5828.105865593614, 5839.416058394211, 5874.324452687995, 5882.323532793698, 5883.205767221456, 5898.321693005273, 5923.297938788257, 5925.229720136354, 5529.341197640611, 5606.523445507178, 5652.434756524314, 5677.460641239241, 5692.658440493584, 5633.38032816398, 5639.605227634026, 5646.548276137817, 5648.887022259614, 5649.293838270216, 5877.588568800143, 5915.811149874574, 5927.4665280125, 5949.672767997802, 5959.851003724942, 3628.3468975584647, 3848.9037774055873, 4012.538558065743, 4069.1251380953236, 4082.2039702257775, 5574.108142697149, 5647.181158731879, 5673.035583950656, 5674.460926212003, 5700.3444603871085, 5522.641028333145, 5533.142362933751, 5562.944370556243, 5568.387477377566, 5577.8047768327915, 5258.0, 5454.59090568201, 5540.506771952718, 5541.833744987657, 5547.5007249347755, 5380.520356901883, 5398.757055932414, 5404.919016196698, 5458.699771512446, 5476.17857321405, 5363.410024897336, 5568.220449137205, 5578.163275508706, 5584.664920104644, 5606.327240731139, 5429.375621803543, 5460.426655201306, 5471.753771080391, 5476.986757449885, 5489.780408783604], "value": 4208.767273159508, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [742.261449857392, 749.2582343479957, 768.1281745219175, 806.862833318336, 817.5993763056102, 13923.512677056306, 14349.426022959082, 14362.210078445694, 14432.422703091865, 14446.422143114289, 14318.355673994669, 14518.709625807503, 14522.927385363058, 14535.854641453583, 14555.345009474573, 663.9004149377583, 779.1779672445567, 792.579932635704, 792.9722459713911, 800.1758189065243, 775.9146493885668, 782.2959336597052, 783.0955246690054, 784.6076961519241, 784.8116452051495, 684.4626967830254, 842.6755699055877, 843.0936743001267, 843.3548335523329, 844.2654890245495, 816.346922462031, 823.17271142502, 829.6473998550592, 830.8421399933993, 831.9625616847256, 593.0955293177938, 594.6491569973693, 594.6759016336107, 595.9433853783884, 596.3201949777257, 13841.30793460323, 13901.721965560733, 13903.374348154357, 13913.443462261497, 13927.721445571133, 14196.0, 14503.27483625825, 14506.782398264035, 14734.410623575151, 14753.483628072965, 12691.365431728469, 12719.936400318033, 12882.227066376048, 12921.353932303442, 13198.60404187876, 4454.13144436835, 4485.237509623372, 4496.64026877849, 4527.660425468103, 4651.651126165517, 74660.62669686617, 75037.24962750412, 75065.62467187684, 75127.62436187784, 75291.24708752897, 11536.0, 11600.18798684084, 11724.237924534878, 11919.582814601446, 11942.283462992249, 21354.572908542053, 21365.57268854614, 21375.144994200058, 21387.89306053491, 21499.0, 8139.511629302261, 8256.174382561696, 8330.541820199947, 8410.915890841135, 8656.8701469478, 4793.400824896888, 4801.231802911588, 4938.135826230396, 4943.653944223942, 5007.624428167902, 3510.8420121094614, 3626.782393056425, 3627.256412435497, 3629.1108678373967, 3631.7094632429344, 528.9029000014959, 562.9577781666392, 638.9169407976933, 671.8320419895026, 676.3067855448106, 705.2453874354494, 728.883378659412, 754.2344520311888, 755.7945077601217, 769.2730369800597, 9118.680846170484, 9156.084391560924, 9257.814843703089, 9329.533523323807, 9490.762730931643, 610.3408319015452, 656.6847913001691, 682.6211452643731, 754.1892465599393, 764.2720136046254, 4426.0, 4527.705699129546, 4552.6813123081065, 4563.178627847019, 4622.451766692338, 74336.62831685915, 115071.42464287793, 116059.0, 120888.39555802164, 121177.0, 97060.51469742606, 97310.0, 97625.51187244018, 99242.0, 100463.0, 89206.0, 89454.0, 90462.54768726115, 91489.54255228682, 93040.99999999865, 8894.555272236234, 8970.084811868683, 8995.145461181177, 9053.456792592466, 9061.68284110053, 49005.0, 50008.0, 50029.49970500248, 51227.0, 52626.21060684016, 71320.0, 75550.0, 75600.24399755932, 77478.0, 78716.0, 12173.513059477522, 12184.939075304566, 12307.75384492323, 12313.56902508408, 12568.811467827807, 13380.19718816874, 13659.317034148055, 13730.93134534361, 14007.159570425807, 14035.298235088001, 8946.955265223633, 13662.0, 14060.296985150497, 14337.746199570438, 14470.204138772047, 13886.444542218198, 14048.508302209373, 14060.648483787987, 14442.783358249424, 14445.499525213485, 13498.0, 14011.579652610439, 14130.50543230982, 14710.117392956457, 14886.10683359002, 11287.548498060314, 11854.0, 12039.63881083569, 12137.332446715516, 12182.634520964386, 11760.324915841647, 12053.337066461429, 12067.336296503776, 12166.148369614042, 12462.31457269859], "value": 7531.234706159408, "unit": "score"}], "name": "dromaeo_css", "value": 7195.583224781615, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0], "value": 108.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 131.0, 133.0, 191.0, 126.0, 131.0, 127.0, 150.0, 161.0, 135.0], "value": 143.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 161.0, 162.0, 161.0, 161.0, 162.0, 163.0, 163.0, 162.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 131.0, 76.0, 76.0, 73.0, 76.0, 104.0, 75.0], "value": 83.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 115.0, 86.0, 84.0, 86.0, 120.0, 85.0, 87.0, 120.0], "value": 95.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 98.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 64.0, 52.0, 54.0, 54.0, 52.0, 53.0, 53.0, 54.0, 54.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 62.0, 62.0, 63.0, 62.0, 62.0, 63.0], "value": 62.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 78.0, 78.0, 89.0, 80.0, 79.0, 80.0, 125.0, 79.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 126.0, 128.0, 123.0, 125.0, 129.0, 127.0, 136.0, 124.0, 123.0], "value": 126.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 161.0, 165.0, 156.0, 160.0, 159.0, 165.0, 158.0, 156.0], "value": 160.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 62.0, 62.0, 63.0, 62.0, 63.0, 66.0, 62.0], "value": 63.0, "unit": "score"}], "name": "kraken", "value": 1502.2, "alertThreshold": 2.0}]} 05:28:00 INFO - Return code: 0 05:28:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:28:00 INFO - # TBPL SUCCESS # 05:28:00 INFO - Running post-action listener: _resource_record_post_action 05:28:00 INFO - ##### 05:28:00 INFO - ##### Finished run-tests step (success) 05:28:00 INFO - ##### 05:28:00 INFO - Running post-run listener: _resource_record_post_run 05:28:00 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 12288; Write bytes: 551661568; Read time: 200; Write time: 604164 05:28:00 INFO - TinderboxPrint: CPU usage
13.2% 05:28:00 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 200 05:28:00 INFO - TinderboxPrint: I/O write bytes / time
551,661,568 / 604,164 05:28:00 INFO - TinderboxPrint: CPU idle
8,273.3 (86.8%) 05:28:00 INFO - TinderboxPrint: CPU user
1,204.6 (12.6%) 05:28:00 INFO - TinderboxPrint: Swap in / out
0 / 0 05:28:00 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 257101824; Read time: 136; Write time: 317816 05:28:00 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 8192; Write bytes: 294559744; Read time: 64; Write time: 286348 05:28:01 INFO - Running post-run listener: _upload_blobber_files 05:28:01 INFO - Blob upload gear active. 05:28:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:28:01 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:28:01 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:28:01 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:28:01 INFO - (blobuploader) - INFO - Open directory for files ... 05:28:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:28:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:28:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:28:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:28:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:28:02 INFO - (blobuploader) - INFO - Done attempting. 05:28:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:28:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:28:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:28:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:28:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:28:03 INFO - (blobuploader) - INFO - Done attempting. 05:28:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:28:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:28:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:28:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:28:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:28:08 INFO - (blobuploader) - INFO - Done attempting. 05:28:08 INFO - (blobuploader) - INFO - Iteration through files over. 05:28:08 INFO - Return code: 0 05:28:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:28:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:28:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ecc4a694d877b718d372d6fc5325ea40250734ff4bcbe6616a63caddb68b68b00a318b21ea3ad22f9c48c0d5828d160e2956ce901e5ccaa58f3cba05ba56cfd4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a460202adb1303501c1c1d49f7f07d9b79d4c25bf9f96a7cd2e6eea6745009609ccfe6fed39712348b3bebab53fa7d847a610db90efc3acc1b8c414350f15966", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cd854d3a93d1ba76d5baa2a1adc9e4f0dd15e10c401b2fac652d90ba5742f57e0d5a9a315d6d2784390fdcae16d2efcb88458405f25a0c9dae8219989f7ac395"} 05:28:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:28:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:28:08 INFO - Contents: 05:28:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ecc4a694d877b718d372d6fc5325ea40250734ff4bcbe6616a63caddb68b68b00a318b21ea3ad22f9c48c0d5828d160e2956ce901e5ccaa58f3cba05ba56cfd4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a460202adb1303501c1c1d49f7f07d9b79d4c25bf9f96a7cd2e6eea6745009609ccfe6fed39712348b3bebab53fa7d847a610db90efc3acc1b8c414350f15966", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cd854d3a93d1ba76d5baa2a1adc9e4f0dd15e10c401b2fac652d90ba5742f57e0d5a9a315d6d2784390fdcae16d2efcb88458405f25a0c9dae8219989f7ac395"} 05:28:08 INFO - Running post-run listener: copy_logs_to_upload_dir 05:28:08 INFO - Copying logs to upload dir... 05:28:08 INFO - mkdir: /builds/slave/test/build/upload/logs 05:28:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.525249 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-06-27 05:28:07.831474) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 05:28:07.834676) ========= 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=4ac8d263c7293b36a1be1aed000001be-1467028020.970765-1361796438 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/ecc4a694d877b718d372d6fc5325ea40250734ff4bcbe6616a63caddb68b68b00a318b21ea3ad22f9c48c0d5828d160e2956ce901e5ccaa58f3cba05ba56cfd4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a460202adb1303501c1c1d49f7f07d9b79d4c25bf9f96a7cd2e6eea6745009609ccfe6fed39712348b3bebab53fa7d847a610db90efc3acc1b8c414350f15966", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cd854d3a93d1ba76d5baa2a1adc9e4f0dd15e10c401b2fac652d90ba5742f57e0d5a9a315d6d2784390fdcae16d2efcb88458405f25a0c9dae8219989f7ac395"} 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.011246 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/ecc4a694d877b718d372d6fc5325ea40250734ff4bcbe6616a63caddb68b68b00a318b21ea3ad22f9c48c0d5828d160e2956ce901e5ccaa58f3cba05ba56cfd4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a460202adb1303501c1c1d49f7f07d9b79d4c25bf9f96a7cd2e6eea6745009609ccfe6fed39712348b3bebab53fa7d847a610db90efc3acc1b8c414350f15966", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cd854d3a93d1ba76d5baa2a1adc9e4f0dd15e10c401b2fac652d90ba5742f57e0d5a9a315d6d2784390fdcae16d2efcb88458405f25a0c9dae8219989f7ac395"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 05:28:07.859915) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 05:28:07.860344) ========= 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=4ac8d263c7293b36a1be1aed000001be-1467028020.970765-1361796438 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004482 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 05:28:07.944413) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 05:28:07.944725) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 05:28:07.945021) ========= ========= Total master_lag: 0.20 =========