builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-045 starttime: 1465408761.36 results: success (0) buildid: 20160608083003 builduid: 4b7610b436f04373aacdc41b7aeba386 revision: daadc8567a11c6165986c05719fa44a7ed8af839 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 10:59:21.360969) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 10:59:21.361357) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 10:59:21.361660) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 10:59:21.376182) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 10:59:21.376448) ========= 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=4300f881736b422476174874000001bc-1465408552.543183-2078388438 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-08 10:59: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% 46.4M=0s 2016-06-08 10:59:22 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.072114 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 10:59:21.462251) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 10:59:21.462563) ========= 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=4300f881736b422476174874000001bc-1465408552.543183-2078388438 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018352 ========= master_lag: 0.13 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 10:59:21.615687) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 10:59:21.615989) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev daadc8567a11c6165986c05719fa44a7ed8af839 --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 daadc8567a11c6165986c05719fa44a7ed8af839 --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=4300f881736b422476174874000001bc-1465408552.543183-2078388438 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-08 10:59:22,292 truncating revision to first 12 chars 2016-06-08 10:59:22,292 Setting DEBUG logging. 2016-06-08 10:59:22,292 attempt 1/10 2016-06-08 10:59:22,292 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/daadc8567a11?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-08 10:59:22,618 unpacking tar archive at: fx-team-daadc8567a11/testing/mozharness/ program finished with exit code 0 elapsedTime=0.683041 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 10:59:22.329367) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 10:59:22.332717) ========= script_repo_revision: daadc8567a11c6165986c05719fa44a7ed8af839 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 10:59:22.333147) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 10:59:22.333413) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 10:59:22.373911) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-06-08 10:59:22.374244) ========= /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=4300f881736b422476174874000001bc-1465408552.543183-2078388438 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:59:23 INFO - MultiFileLogger online at 20160608 10:59:23 in /builds/slave/test 10:59:23 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 10:59:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:59:23 INFO - {'append_to_log': False, 10:59:23 INFO - 'base_work_dir': '/builds/slave/test', 10:59:23 INFO - 'blob_upload_branch': 'Fx-Team', 10:59:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:59:23 INFO - 'branch': 'Fx-Team', 10:59:23 INFO - 'buildbot_json_path': 'buildprops.json', 10:59:23 INFO - 'config_files': ('talos/linux_config.py',), 10:59:23 INFO - 'default_actions': ('clobber', 10:59:23 INFO - 'read-buildbot-config', 10:59:23 INFO - 'download-and-extract', 10:59:23 INFO - 'populate-webroot', 10:59:23 INFO - 'create-virtualenv', 10:59:23 INFO - 'install', 10:59:23 INFO - 'run-tests'), 10:59:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:59:23 INFO - 'download_minidump_stackwalk': True, 10:59:23 INFO - 'download_symbols': 'ondemand', 10:59:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:59:23 INFO - 'tooltool.py': '/tools/tooltool.py', 10:59:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:59:23 INFO - '/tools/misc-python/virtualenv.py')}, 10:59:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:59:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:59:23 INFO - 'installer_path': 'installer.exe', 10:59:23 INFO - 'log_level': 'info', 10:59:23 INFO - 'log_name': 'talos', 10:59:23 INFO - 'log_to_console': True, 10:59:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:59:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:59:23 INFO - 'opt_config_files': (), 10:59:23 INFO - 'pip_index': False, 10:59:23 INFO - 'sps_profile': False, 10:59:23 INFO - 'sps_profile_interval': 0, 10:59:23 INFO - 'suite': 'dromaeojs', 10:59:23 INFO - 'system_bits': '32', 10:59:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:59:23 INFO - 'title': 'talos-linux64-ix-045', 10:59:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:59:23 INFO - 'use_talos_json': True, 10:59:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:59:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:59:23 INFO - 'work_dir': 'build'} 10:59:23 INFO - ##### 10:59:23 INFO - ##### Running clobber step. 10:59:23 INFO - ##### 10:59:23 INFO - Running pre-action listener: _resource_record_pre_action 10:59:23 INFO - Running main action method: clobber 10:59:23 INFO - rmtree: /builds/slave/test/build 10:59:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:59:23 INFO - Running post-action listener: _resource_record_post_action 10:59:23 INFO - ##### 10:59:23 INFO - ##### Finished clobber step (success) 10:59:23 INFO - ##### 10:59:23 INFO - ##### 10:59:23 INFO - ##### Running read-buildbot-config step. 10:59:23 INFO - ##### 10:59:23 INFO - Running pre-action listener: _resource_record_pre_action 10:59:23 INFO - Running main action method: read_buildbot_config 10:59:23 INFO - Using buildbot properties: 10:59:23 INFO - { 10:59:23 INFO - "project": "", 10:59:23 INFO - "product": "firefox", 10:59:23 INFO - "script_repo_revision": "production", 10:59:23 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:59:23 INFO - "repository": "", 10:59:23 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 10:59:23 INFO - "buildid": "20160608083003", 10:59:23 INFO - "pgo_build": "True", 10:59:23 INFO - "basedir": "/builds/slave/test", 10:59:23 INFO - "buildnumber": 1239, 10:59:23 INFO - "slavename": "talos-linux64-ix-045", 10:59:23 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:59:23 INFO - "platform": "ubuntu64_hw", 10:59:23 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 10:59:23 INFO - "branch": "fx-team", 10:59:23 INFO - "repo_path": "integration/fx-team", 10:59:23 INFO - "revision": "daadc8567a11c6165986c05719fa44a7ed8af839", 10:59:23 INFO - "stage_platform": "linux64-pgo", 10:59:23 INFO - "builduid": "4b7610b436f04373aacdc41b7aeba386", 10:59:23 INFO - "slavebuilddir": "test" 10:59:23 INFO - } 10:59:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 10:59:23 INFO - Running post-action listener: _resource_record_post_action 10:59:23 INFO - ##### 10:59:23 INFO - ##### Finished read-buildbot-config step (success) 10:59:23 INFO - ##### 10:59:23 INFO - ##### 10:59:23 INFO - ##### Running download-and-extract step. 10:59:23 INFO - ##### 10:59:23 INFO - Running pre-action listener: _resource_record_pre_action 10:59:23 INFO - Running main action method: download_and_extract 10:59:23 INFO - mkdir: /builds/slave/test/build/tests 10:59: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')]} 10:59:23 INFO - https://queue.taskcluster.net/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:59:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:59:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:59:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWdkINQuSoCL6xaNjhlcHg/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 10:59:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWdkINQuSoCL6xaNjhlcHg/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 10:59:25 INFO - Downloaded 1361 bytes. 10:59:25 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:59:25 INFO - Using the following test package requirements: 10:59:25 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:59:25 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:59:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:59:25 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:59:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:59:25 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:59:25 INFO - u'jsshell-linux-x86_64.zip'], 10:59:25 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:59:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:59:25 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:59:25 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:59:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:59:25 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:59:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:59:25 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:59:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:59:25 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:59:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:59:25 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:59:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:59:25 INFO - https://queue.taskcluster.net/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:59:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:59:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:59:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWdkINQuSoCL6xaNjhlcHg/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 10:59:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWdkINQuSoCL6xaNjhlcHg/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 10:59:26 INFO - Downloaded 24450436 bytes. 10:59:26 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'] 10:59:26 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 10:59:27 INFO - Return code: 0 10:59:27 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 10:59:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:59:27 INFO - https://queue.taskcluster.net/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:59:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:59:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:59:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWdkINQuSoCL6xaNjhlcHg/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 10:59:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWdkINQuSoCL6xaNjhlcHg/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 10:59:35 INFO - Downloaded 24450436 bytes. 10:59:35 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'] 10:59:35 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 10:59:37 INFO - Return code: 0 10:59: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')]} 10:59:37 INFO - https://queue.taskcluster.net/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:59:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:59:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:59:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWdkINQuSoCL6xaNjhlcHg/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 10:59:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWdkINQuSoCL6xaNjhlcHg/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 10:59:38 INFO - Downloaded 10833369 bytes. 10:59: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'] 10:59: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 10:59:38 INFO - Return code: 0 10:59: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')]} 10:59:38 INFO - https://queue.taskcluster.net/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:59:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:59:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:59:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWdkINQuSoCL6xaNjhlcHg/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 10:59:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWdkINQuSoCL6xaNjhlcHg/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 10:59:40 INFO - Downloaded 59308529 bytes. 10:59:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:59:40 INFO - mkdir: /builds/slave/test/properties 10:59:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:59:40 INFO - Writing to file /builds/slave/test/properties/build_url 10:59:40 INFO - Contents: 10:59:40 INFO - build_url:https://queue.taskcluster.net/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:59:40 INFO - Running post-action listener: _resource_record_post_action 10:59:40 INFO - Running post-action listener: set_extra_try_arguments 10:59:40 INFO - ##### 10:59:40 INFO - ##### Finished download-and-extract step (success) 10:59:40 INFO - ##### 10:59:40 INFO - ##### 10:59:40 INFO - ##### Running populate-webroot step. 10:59:40 INFO - ##### 10:59:40 INFO - Running pre-action listener: _resource_record_pre_action 10:59:40 INFO - Running main action method: populate_webroot 10:59:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:59:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:59:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:59:40 INFO - '--tppagecycles', 10:59:40 INFO - '7'], 10:59:40 INFO - 'tests': ['tsvgm']}}, 10:59:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:59:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:59:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:59:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:59:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:59:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:59:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:59:40 INFO - 'talos_options': ['--disable-e10s'], 10:59:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:59:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:59:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:59:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:59:40 INFO - 'talos_options': ['--disable-e10s'], 10:59:40 INFO - 'tests': ['damp', 'tps']}, 10:59:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:59:40 INFO - 'tests': ['damp', 'tps']}, 10:59:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:59:40 INFO - 'tests': ['dromaeo_dom']}, 10:59:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:59:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:59:40 INFO - 'tests': ['a11yr', 10:59:40 INFO - 'ts_paint', 10:59:40 INFO - 'tpaint', 10:59:40 INFO - 'sessionrestore', 10:59:40 INFO - 'sessionrestore_no_auto_restore', 10:59:40 INFO - 'tabpaint']}, 10:59:40 INFO - 'other-e10s': {'tests': ['a11yr', 10:59:40 INFO - 'ts_paint', 10:59:40 INFO - 'tpaint', 10:59:40 INFO - 'sessionrestore', 10:59:40 INFO - 'sessionrestore_no_auto_restore', 10:59:40 INFO - 'tabpaint']}, 10:59:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:59:40 INFO - 'ts_paint', 10:59:40 INFO - 'tpaint', 10:59:40 INFO - 'sessionrestore', 10:59:40 INFO - 'sessionrestore_no_auto_restore', 10:59:40 INFO - 'tabpaint']}, 10:59:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:59:40 INFO - 'ts_paint', 10:59:40 INFO - 'tpaint', 10:59:40 INFO - 'sessionrestore', 10:59:40 INFO - 'sessionrestore_no_auto_restore', 10:59:40 INFO - 'tabpaint']}, 10:59:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:59:40 INFO - 'tests': ['a11yr', 10:59:40 INFO - 'ts_paint', 10:59:40 INFO - 'tpaint', 10:59:40 INFO - 'sessionrestore', 10:59:40 INFO - 'sessionrestore_no_auto_restore', 10:59:40 INFO - 'tabpaint']}, 10:59:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:59:40 INFO - 'tests': ['a11yr', 10:59:40 INFO - 'ts_paint', 10:59:40 INFO - 'tpaint', 10:59:40 INFO - 'sessionrestore', 10:59:40 INFO - 'sessionrestore_no_auto_restore', 10:59:40 INFO - 'tabpaint']}, 10:59:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:59:40 INFO - 'tests': ['tsvgx', 10:59:40 INFO - 'tsvgr_opacity', 10:59:40 INFO - 'tart', 10:59:40 INFO - 'tscrollx', 10:59:40 INFO - 'cart']}, 10:59:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:59:40 INFO - 'tsvgr_opacity', 10:59:40 INFO - 'tart', 10:59:40 INFO - 'tscrollx', 10:59:40 INFO - 'cart']}, 10:59:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:59:40 INFO - 'talos_options': ['--disable-e10s'], 10:59:40 INFO - 'tests': ['tp5o']}, 10:59:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:59:40 INFO - 'tests': ['tp5o']}, 10:59:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:59:40 INFO - 'talos_options': ['--disable-e10s', 10:59:40 INFO - '--xperf_path', 10:59:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:59:40 INFO - 'tests': ['tp5n']}, 10:59:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:59:40 INFO - 'talos_options': ['--xperf_path', 10:59:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:59:40 INFO - 'tests': ['tp5n']}}, 10:59:40 INFO - 'talos.zip': {'path': '', 10:59:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:59:40 INFO - Running post-action listener: _resource_record_post_action 10:59:40 INFO - ##### 10:59:40 INFO - ##### Finished populate-webroot step (success) 10:59:40 INFO - ##### 10:59:40 INFO - ##### 10:59:40 INFO - ##### Running create-virtualenv step. 10:59:40 INFO - ##### 10:59:40 INFO - Running pre-action listener: _resource_record_pre_action 10:59:40 INFO - Running main action method: create_virtualenv 10:59:40 INFO - Creating virtualenv /builds/slave/test/build/venv 10:59:40 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 10:59:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:59:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:59:41 INFO - Using real prefix '/usr' 10:59:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:59:41 INFO - Installing distribute.............................................................................................................................................................................................done. 10:59:43 INFO - Installing pip.................done. 10:59:43 INFO - Return code: 0 10:59:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:59: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')]} 10:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59: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')]} 10:59:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59: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 0x7f1bae47ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b66110>, '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 0x1ad2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad26c0>, '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': '4300f881736b422476174874000001bc-1465408552.543183-2078388438', '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 10:59: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 10:59: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 10:59:43 INFO - Using env: {'DISPLAY': ':0', 10:59:43 INFO - 'HOME': '/home/cltbld', 10:59:43 INFO - 'LANG': 'en_US.UTF-8', 10:59:43 INFO - 'LANGUAGE': 'en_US:en', 10:59:43 INFO - 'LOGNAME': 'cltbld', 10:59:43 INFO - 'MAIL': '/var/mail/cltbld', 10:59:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:43 INFO - 'MOZ_NO_REMOTE': '1', 10:59:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:43 INFO - 'NO_EM_RESTART': '1', 10:59:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:43 INFO - 'PWD': '/builds/slave/test', 10:59:43 INFO - 'SHELL': '/bin/bash', 10:59:43 INFO - 'SHLVL': '1', 10:59:43 INFO - 'TERM': 'linux', 10:59:43 INFO - 'TMOUT': '86400', 10:59:43 INFO - 'USER': 'cltbld', 10:59:43 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465408552.543183-2078388438', 10:59:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:43 INFO - '_': '/tools/buildbot/bin/python'} 10:59:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:43 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 10:59:43 INFO - Cleaning up... 10:59:43 INFO - Return code: 0 10:59:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:59: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')]} 10:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59: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')]} 10:59:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59: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', '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 0x7f1bae47ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b66110>, '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 0x1ad2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad26c0>, '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': '4300f881736b422476174874000001bc-1465408552.543183-2078388438', '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 10:59: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', 'psutil>=3.1.1'] in /builds/slave/test/build 10:59: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 psutil>=3.1.1 10:59:43 INFO - Using env: {'DISPLAY': ':0', 10:59:43 INFO - 'HOME': '/home/cltbld', 10:59:43 INFO - 'LANG': 'en_US.UTF-8', 10:59:43 INFO - 'LANGUAGE': 'en_US:en', 10:59:43 INFO - 'LOGNAME': 'cltbld', 10:59:43 INFO - 'MAIL': '/var/mail/cltbld', 10:59:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:43 INFO - 'MOZ_NO_REMOTE': '1', 10:59:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:43 INFO - 'NO_EM_RESTART': '1', 10:59:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:43 INFO - 'PWD': '/builds/slave/test', 10:59:43 INFO - 'SHELL': '/bin/bash', 10:59:43 INFO - 'SHLVL': '1', 10:59:43 INFO - 'TERM': 'linux', 10:59:43 INFO - 'TMOUT': '86400', 10:59:43 INFO - 'USER': 'cltbld', 10:59:43 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465408552.543183-2078388438', 10:59:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:43 INFO - '_': '/tools/buildbot/bin/python'} 10:59:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:44 INFO - Downloading/unpacking psutil>=3.1.1 10:59: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 10:59: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 10:59: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 10:59: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 10:59: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 10:59: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 10:59:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:59:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:59:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:59:46 INFO - Installing collected packages: psutil 10:59:46 INFO - Running setup.py install for psutil 10:59:46 INFO - building 'psutil._psutil_linux' extension 10:59: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 10:59: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 10:59:46 INFO - building 'psutil._psutil_posix' extension 10:59: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 10:59: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 10:59:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:59:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:59:46 INFO - Successfully installed psutil 10:59:46 INFO - Cleaning up... 10:59:46 INFO - Return code: 0 10:59:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:59: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')]} 10:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59: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')]} 10:59:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59: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 0x7f1bae47ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b66110>, '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 0x1ad2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad26c0>, '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': '4300f881736b422476174874000001bc-1465408552.543183-2078388438', '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 10:59: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 10:59: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 10:59:46 INFO - Using env: {'DISPLAY': ':0', 10:59:46 INFO - 'HOME': '/home/cltbld', 10:59:46 INFO - 'LANG': 'en_US.UTF-8', 10:59:46 INFO - 'LANGUAGE': 'en_US:en', 10:59:46 INFO - 'LOGNAME': 'cltbld', 10:59:46 INFO - 'MAIL': '/var/mail/cltbld', 10:59:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:46 INFO - 'MOZ_NO_REMOTE': '1', 10:59:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:46 INFO - 'NO_EM_RESTART': '1', 10:59:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:46 INFO - 'PWD': '/builds/slave/test', 10:59:46 INFO - 'SHELL': '/bin/bash', 10:59:46 INFO - 'SHLVL': '1', 10:59:46 INFO - 'TERM': 'linux', 10:59:46 INFO - 'TMOUT': '86400', 10:59:46 INFO - 'USER': 'cltbld', 10:59:46 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465408552.543183-2078388438', 10:59:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:46 INFO - '_': '/tools/buildbot/bin/python'} 10:59:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:59:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:59:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:59:48 INFO - Installing collected packages: mozsystemmonitor 10:59:48 INFO - Running setup.py install for mozsystemmonitor 10:59:48 INFO - Successfully installed mozsystemmonitor 10:59:48 INFO - Cleaning up... 10:59:48 INFO - Return code: 0 10:59:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:59:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1bae47ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b66110>, '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 0x1ad2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad26c0>, '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': '4300f881736b422476174874000001bc-1465408552.543183-2078388438', '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 10:59:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:59:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:59:48 INFO - Using env: {'DISPLAY': ':0', 10:59:48 INFO - 'HOME': '/home/cltbld', 10:59:48 INFO - 'LANG': 'en_US.UTF-8', 10:59:48 INFO - 'LANGUAGE': 'en_US:en', 10:59:48 INFO - 'LOGNAME': 'cltbld', 10:59:48 INFO - 'MAIL': '/var/mail/cltbld', 10:59:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:48 INFO - 'MOZ_NO_REMOTE': '1', 10:59:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:48 INFO - 'NO_EM_RESTART': '1', 10:59:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:48 INFO - 'PWD': '/builds/slave/test', 10:59:48 INFO - 'SHELL': '/bin/bash', 10:59:48 INFO - 'SHLVL': '1', 10:59:48 INFO - 'TERM': 'linux', 10:59:48 INFO - 'TMOUT': '86400', 10:59:48 INFO - 'USER': 'cltbld', 10:59:48 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465408552.543183-2078388438', 10:59:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:48 INFO - '_': '/tools/buildbot/bin/python'} 10:59:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:49 INFO - Downloading/unpacking jsonschema==2.5.1 10:59: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 10:59: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 10:59: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 10:59: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 10:59: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 10:59: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 10:59:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:59:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:59:50 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 10:59:50 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 10:59:50 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 10:59:50 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 10:59:50 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 10:59:50 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 10:59:51 INFO - Downloading functools32-3.2.3-2.tar.gz 10:59:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:59:51 INFO - warning: no files found matching '*.txt' 10:59:51 INFO - no previously-included directories found matching 'build' 10:59:51 INFO - no previously-included directories found matching 'dist' 10:59:51 INFO - no previously-included directories found matching '.git*' 10:59:51 INFO - Installing collected packages: jsonschema, functools32 10:59:51 INFO - Running setup.py install for functools32 10:59:51 INFO - warning: no files found matching '*.txt' 10:59:51 INFO - no previously-included directories found matching 'build' 10:59:51 INFO - no previously-included directories found matching 'dist' 10:59:51 INFO - no previously-included directories found matching '.git*' 10:59:51 INFO - Successfully installed jsonschema functools32 10:59:51 INFO - Cleaning up... 10:59:51 INFO - Return code: 0 10:59:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:59: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')]} 10:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59: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')]} 10:59:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59: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 0x7f1bae47ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b66110>, '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 0x1ad2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad26c0>, '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': '4300f881736b422476174874000001bc-1465408552.543183-2078388438', '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 10:59: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 10:59: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 10:59:51 INFO - Using env: {'DISPLAY': ':0', 10:59:51 INFO - 'HOME': '/home/cltbld', 10:59:51 INFO - 'LANG': 'en_US.UTF-8', 10:59:51 INFO - 'LANGUAGE': 'en_US:en', 10:59:51 INFO - 'LOGNAME': 'cltbld', 10:59:51 INFO - 'MAIL': '/var/mail/cltbld', 10:59:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:51 INFO - 'MOZ_NO_REMOTE': '1', 10:59:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:51 INFO - 'NO_EM_RESTART': '1', 10:59:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:51 INFO - 'PWD': '/builds/slave/test', 10:59:51 INFO - 'SHELL': '/bin/bash', 10:59:51 INFO - 'SHLVL': '1', 10:59:51 INFO - 'TERM': 'linux', 10:59:51 INFO - 'TMOUT': '86400', 10:59:51 INFO - 'USER': 'cltbld', 10:59:51 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465408552.543183-2078388438', 10:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:51 INFO - '_': '/tools/buildbot/bin/python'} 10:59:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:51 INFO - Downloading/unpacking blobuploader==1.2.4 10:59: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 10:59: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 10:59: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 10:59: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 10:59: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 10:59: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 10:59:53 INFO - Downloading blobuploader-1.2.4.tar.gz 10:59:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:59:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:59:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:59:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:59: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 10:59: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 10:59: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 10:59: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 10:59: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 10:59: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 10:59:54 INFO - Downloading docopt-0.6.1.tar.gz 10:59:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:59:54 INFO - Installing collected packages: blobuploader, requests, docopt 10:59:54 INFO - Running setup.py install for blobuploader 10:59:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:59:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:59:54 INFO - Running setup.py install for requests 10:59:54 INFO - Running setup.py install for docopt 10:59:54 INFO - Successfully installed blobuploader requests docopt 10:59:54 INFO - Cleaning up... 10:59:54 INFO - Return code: 0 10:59:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:59:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:59:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:54 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 0x7f1bae47ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b66110>, '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 0x1ad2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad26c0>, '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': '4300f881736b422476174874000001bc-1465408552.543183-2078388438', '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 10:59:54 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 10:59:54 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 10:59:54 INFO - Using env: {'DISPLAY': ':0', 10:59:54 INFO - 'HOME': '/home/cltbld', 10:59:54 INFO - 'LANG': 'en_US.UTF-8', 10:59:54 INFO - 'LANGUAGE': 'en_US:en', 10:59:54 INFO - 'LOGNAME': 'cltbld', 10:59:54 INFO - 'MAIL': '/var/mail/cltbld', 10:59:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:54 INFO - 'MOZ_NO_REMOTE': '1', 10:59:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:54 INFO - 'NO_EM_RESTART': '1', 10:59:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:54 INFO - 'PWD': '/builds/slave/test', 10:59:54 INFO - 'SHELL': '/bin/bash', 10:59:54 INFO - 'SHLVL': '1', 10:59:54 INFO - 'TERM': 'linux', 10:59:54 INFO - 'TMOUT': '86400', 10:59:54 INFO - 'USER': 'cltbld', 10:59:54 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465408552.543183-2078388438', 10:59:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:54 INFO - '_': '/tools/buildbot/bin/python'} 10:59:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:59:55 INFO - Running setup.py (path:/tmp/pip-vhyKfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:59:55 INFO - Running setup.py (path:/tmp/pip-LoCLfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:59:55 INFO - Running setup.py (path:/tmp/pip-ziEwYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:59:55 INFO - Running setup.py (path:/tmp/pip-7Qkrvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:59:55 INFO - Running setup.py (path:/tmp/pip-JgKMr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:59:55 INFO - Running setup.py (path:/tmp/pip-_lbNWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:59:55 INFO - Running setup.py (path:/tmp/pip-hNGe0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:59:55 INFO - Running setup.py (path:/tmp/pip-BW5YhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:59:55 INFO - Running setup.py (path:/tmp/pip-grPAxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:59:55 INFO - Running setup.py (path:/tmp/pip-HY1E3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:59:55 INFO - Running setup.py (path:/tmp/pip-gRhOmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:59:55 INFO - Running setup.py (path:/tmp/pip-mDqp9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:59:56 INFO - Running setup.py (path:/tmp/pip-lVvbDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:59:56 INFO - Running setup.py (path:/tmp/pip-mrP4_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:59:56 INFO - Running setup.py (path:/tmp/pip-WoXb7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:59:56 INFO - Running setup.py (path:/tmp/pip-Zh3ceL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:59:56 INFO - Running setup.py (path:/tmp/pip-ii6j0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:59:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:59:56 INFO - Running setup.py install for manifestparser 10:59:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:59:56 INFO - Running setup.py install for mozcrash 10:59:56 INFO - Running setup.py install for mozdebug 10:59:56 INFO - Running setup.py install for mozdevice 10:59:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:59:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:59:56 INFO - Running setup.py install for mozfile 10:59:56 INFO - Running setup.py install for mozhttpd 10:59:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:59:56 INFO - Running setup.py install for mozinfo 10:59:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:59:57 INFO - Running setup.py install for mozInstall 10:59:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:59:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:59:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:59:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:59:57 INFO - Running setup.py install for mozleak 10:59:57 INFO - Running setup.py install for mozlog 10:59:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:59:57 INFO - Running setup.py install for moznetwork 10:59:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:59:57 INFO - Running setup.py install for mozprocess 10:59:57 INFO - Running setup.py install for mozprofile 10:59:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:59:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:59:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:59:57 INFO - Running setup.py install for mozrunner 10:59:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:59:57 INFO - Running setup.py install for mozscreenshot 10:59:57 INFO - Running setup.py install for moztest 10:59:58 INFO - Running setup.py install for mozversion 10:59:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:59:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:59:58 INFO - Cleaning up... 10:59:58 INFO - Return code: 0 10:59:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:59: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')]} 10:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59: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')]} 10:59:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59: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 0x7f1bae47ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b66110>, '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 0x1ad2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad26c0>, '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': '4300f881736b422476174874000001bc-1465408552.543183-2078388438', '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 10:59: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 10:59: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 10:59:58 INFO - Using env: {'DISPLAY': ':0', 10:59:58 INFO - 'HOME': '/home/cltbld', 10:59:58 INFO - 'LANG': 'en_US.UTF-8', 10:59:58 INFO - 'LANGUAGE': 'en_US:en', 10:59:58 INFO - 'LOGNAME': 'cltbld', 10:59:58 INFO - 'MAIL': '/var/mail/cltbld', 10:59:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:58 INFO - 'MOZ_NO_REMOTE': '1', 10:59:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:58 INFO - 'NO_EM_RESTART': '1', 10:59:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:58 INFO - 'PWD': '/builds/slave/test', 10:59:58 INFO - 'SHELL': '/bin/bash', 10:59:58 INFO - 'SHLVL': '1', 10:59:58 INFO - 'TERM': 'linux', 10:59:58 INFO - 'TMOUT': '86400', 10:59:58 INFO - 'USER': 'cltbld', 10:59:58 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465408552.543183-2078388438', 10:59:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:58 INFO - '_': '/tools/buildbot/bin/python'} 10:59:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:59:58 INFO - Running setup.py (path:/tmp/pip-XUvFQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:59: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)) 10:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:59:58 INFO - Running setup.py (path:/tmp/pip-jVD707-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:59: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)) 10:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:59:58 INFO - Running setup.py (path:/tmp/pip-O7OYA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:59: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)) 10:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:59:58 INFO - Running setup.py (path:/tmp/pip-bneayu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:59:58 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)) 10:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:59:58 INFO - Running setup.py (path:/tmp/pip-E3LICW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:59:58 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)) 10:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:59:58 INFO - Running setup.py (path:/tmp/pip-O2m8oy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:59:58 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)) 10:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:59:58 INFO - Running setup.py (path:/tmp/pip-9m3Mzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:59:58 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)) 10:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:59:58 INFO - Running setup.py (path:/tmp/pip-zebHbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:59:58 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)) 10:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:59:58 INFO - Running setup.py (path:/tmp/pip-X3cYQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:59: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)) 10:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:59:59 INFO - Running setup.py (path:/tmp/pip-xH99Ul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:59: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)) 10:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:59:59 INFO - Running setup.py (path:/tmp/pip-A2E9Ws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:59: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)) 10:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:59:59 INFO - Running setup.py (path:/tmp/pip-3gAyyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:59: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)) 10:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:59:59 INFO - Running setup.py (path:/tmp/pip-9jGxse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:59: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)) 10:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:59:59 INFO - Running setup.py (path:/tmp/pip-P8KLx8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:59: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)) 10:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:59:59 INFO - Running setup.py (path:/tmp/pip-zByy54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:59: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)) 10:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:59:59 INFO - Running setup.py (path:/tmp/pip-VZ68bk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:59: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)) 10:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:59:59 INFO - Running setup.py (path:/tmp/pip-OTCC4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:59:59 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)) 10:59:59 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)) 10:59:59 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)) 10:59:59 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)) 10:59:59 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)) 10:59:59 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)) 10:59:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:59:59 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 10:59:59 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 10:59:59 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 10:59:59 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 10:59:59 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 10:59:59 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 11:00:01 INFO - Downloading blessings-1.6.tar.gz 11:00:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:00:01 INFO - Installing collected packages: blessings 11:00:01 INFO - Running setup.py install for blessings 11:00:01 INFO - Successfully installed blessings 11:00:01 INFO - Cleaning up... 11:00:01 INFO - Return code: 0 11:00:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:00:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:00:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:00:01 INFO - Reading from file tmpfile_stdout 11:00:01 INFO - Current package versions: 11:00:01 INFO - argparse == 1.2.1 11:00:01 INFO - blessings == 1.6 11:00:01 INFO - blobuploader == 1.2.4 11:00:01 INFO - docopt == 0.6.1 11:00:01 INFO - functools32 == 3.2.3-2 11:00:01 INFO - jsonschema == 2.5.1 11:00:01 INFO - manifestparser == 1.1 11:00:01 INFO - mozInstall == 1.12 11:00:01 INFO - mozcrash == 0.17 11:00:01 INFO - mozdebug == 0.1 11:00:01 INFO - mozdevice == 0.48 11:00:01 INFO - mozfile == 1.2 11:00:01 INFO - mozhttpd == 0.7 11:00:01 INFO - mozinfo == 0.9 11:00:01 INFO - mozleak == 0.1 11:00:01 INFO - mozlog == 3.2 11:00:01 INFO - moznetwork == 0.27 11:00:01 INFO - mozprocess == 0.22 11:00:01 INFO - mozprofile == 0.28 11:00:01 INFO - mozrunner == 6.11 11:00:01 INFO - mozscreenshot == 0.1 11:00:01 INFO - mozsystemmonitor == 0.3 11:00:01 INFO - moztest == 0.7 11:00:01 INFO - mozversion == 1.4 11:00:01 INFO - psutil == 3.1.1 11:00:01 INFO - requests == 1.2.3 11:00:01 INFO - wsgiref == 0.1.2 11:00:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:00:01 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')]} 11:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:01 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')]} 11:00:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:01 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 0x7f1bae47ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b66110>, '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 0x1ad2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad26c0>, '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': '4300f881736b422476174874000001bc-1465408552.543183-2078388438', '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 11:00:01 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 11:00:01 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 11:00:01 INFO - Using env: {'DISPLAY': ':0', 11:00:01 INFO - 'HOME': '/home/cltbld', 11:00:01 INFO - 'LANG': 'en_US.UTF-8', 11:00:01 INFO - 'LANGUAGE': 'en_US:en', 11:00:01 INFO - 'LOGNAME': 'cltbld', 11:00:01 INFO - 'MAIL': '/var/mail/cltbld', 11:00:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:01 INFO - 'MOZ_NO_REMOTE': '1', 11:00:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:01 INFO - 'NO_EM_RESTART': '1', 11:00:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:01 INFO - 'PWD': '/builds/slave/test', 11:00:01 INFO - 'SHELL': '/bin/bash', 11:00:01 INFO - 'SHLVL': '1', 11:00:01 INFO - 'TERM': 'linux', 11:00:01 INFO - 'TMOUT': '86400', 11:00:01 INFO - 'USER': 'cltbld', 11:00:01 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465408552.543183-2078388438', 11:00:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:01 INFO - '_': '/tools/buildbot/bin/python'} 11:00:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00: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)) 11:00: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)) 11:00: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)) 11:00: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)) 11:00: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)) 11:00: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)) 11:00: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)) 11:00: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)) 11:00: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)) 11:00: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)) 11:00: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)) 11:00:02 INFO - Cleaning up... 11:00:02 INFO - Return code: 0 11:00:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:00: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')]} 11:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00: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')]} 11:00:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00: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 0x7f1bae47ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b66110>, '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 0x1ad2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad26c0>, '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': '4300f881736b422476174874000001bc-1465408552.543183-2078388438', '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 11:00: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 11:00: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 11:00:02 INFO - Using env: {'DISPLAY': ':0', 11:00:02 INFO - 'HOME': '/home/cltbld', 11:00:02 INFO - 'LANG': 'en_US.UTF-8', 11:00:02 INFO - 'LANGUAGE': 'en_US:en', 11:00:02 INFO - 'LOGNAME': 'cltbld', 11:00:02 INFO - 'MAIL': '/var/mail/cltbld', 11:00:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:02 INFO - 'MOZ_NO_REMOTE': '1', 11:00:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:02 INFO - 'NO_EM_RESTART': '1', 11:00:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:02 INFO - 'PWD': '/builds/slave/test', 11:00:02 INFO - 'SHELL': '/bin/bash', 11:00:02 INFO - 'SHLVL': '1', 11:00:02 INFO - 'TERM': 'linux', 11:00:02 INFO - 'TMOUT': '86400', 11:00:02 INFO - 'USER': 'cltbld', 11:00:02 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465408552.543183-2078388438', 11:00:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:02 INFO - '_': '/tools/buildbot/bin/python'} 11:00:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:00:02 INFO - Cleaning up... 11:00:02 INFO - Return code: 0 11:00:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:00: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')]} 11:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00: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')]} 11:00:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00: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 0x7f1bae47ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b66110>, '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 0x1ad2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad26c0>, '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': '4300f881736b422476174874000001bc-1465408552.543183-2078388438', '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 11:00: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 11:00: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 11:00:02 INFO - Using env: {'DISPLAY': ':0', 11:00:02 INFO - 'HOME': '/home/cltbld', 11:00:02 INFO - 'LANG': 'en_US.UTF-8', 11:00:02 INFO - 'LANGUAGE': 'en_US:en', 11:00:02 INFO - 'LOGNAME': 'cltbld', 11:00:02 INFO - 'MAIL': '/var/mail/cltbld', 11:00:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:02 INFO - 'MOZ_NO_REMOTE': '1', 11:00:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:02 INFO - 'NO_EM_RESTART': '1', 11:00:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:02 INFO - 'PWD': '/builds/slave/test', 11:00:02 INFO - 'SHELL': '/bin/bash', 11:00:02 INFO - 'SHLVL': '1', 11:00:02 INFO - 'TERM': 'linux', 11:00:02 INFO - 'TMOUT': '86400', 11:00:02 INFO - 'USER': 'cltbld', 11:00:02 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465408552.543183-2078388438', 11:00:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:02 INFO - '_': '/tools/buildbot/bin/python'} 11:00:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:02 INFO - Downloading/unpacking flake8 11:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:00:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:00: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 11:00: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 11:00: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 11:00: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 11:00: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 11:00: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 11:00:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:00:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:00: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 11:00: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 11:00: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 11:00: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 11:00: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 11:00: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 11:00:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:00: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 11:00: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 11:00: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 11:00: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 11:00: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 11:00: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 11:00:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:00:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:00:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:00:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:00:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:00:05 INFO - no previously-included directories found matching 'docs/_build' 11:00:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:00:05 INFO - Running setup.py install for pep8 11:00:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:00:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:00:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:00:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:00:05 INFO - no previously-included directories found matching 'docs/_build' 11:00:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:00:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:00:05 INFO - Cleaning up... 11:00:05 INFO - Return code: 0 11:00:05 INFO - Running post-action listener: _resource_record_post_action 11:00:05 INFO - Running post-action listener: _start_resource_monitoring 11:00:05 INFO - Starting resource monitoring. 11:00:05 INFO - ##### 11:00:05 INFO - ##### Finished create-virtualenv step (success) 11:00:05 INFO - ##### 11:00:05 INFO - ##### 11:00:05 INFO - ##### Running install step. 11:00:05 INFO - ##### 11:00:05 INFO - Running pre-action listener: _resource_record_pre_action 11:00:05 INFO - Running main action method: install 11:00:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:00:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:00:05 INFO - Reading from file tmpfile_stdout 11:00:05 INFO - Detecting whether we're running mozinstall >=1.0... 11:00:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:00:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:00:05 INFO - Reading from file tmpfile_stdout 11:00:05 INFO - Output received: 11:00:05 INFO - Usage: mozinstall [options] installer 11:00:05 INFO - Options: 11:00:05 INFO - -h, --help show this help message and exit 11:00:05 INFO - -d DEST, --destination=DEST 11:00:05 INFO - Directory to install application into. [default: 11:00:05 INFO - "/builds/slave/test"] 11:00:05 INFO - --app=APP Application being installed. [default: firefox] 11:00:05 INFO - mkdir: /builds/slave/test/build/application 11:00:05 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'] 11:00:05 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 11:00:22 INFO - Reading from file tmpfile_stdout 11:00:22 INFO - Output received: 11:00:22 INFO - /builds/slave/test/build/application/firefox/firefox 11:00:22 INFO - Running post-action listener: _resource_record_post_action 11:00:22 INFO - ##### 11:00:22 INFO - ##### Finished install step (success) 11:00:22 INFO - ##### 11:00:22 INFO - ##### 11:00:22 INFO - ##### Running run-tests step. 11:00:22 INFO - ##### 11:00:22 INFO - Running pre-action listener: _resource_record_pre_action 11:00:22 INFO - Running main action method: run_tests 11:00:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:00:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:00:22 INFO - Python 2.7.3 11:00:22 INFO - Return code: 0 11:00:22 INFO - grabbing minidump binary from tooltool 11:00:22 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')]} 11:00:22 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 0x1b66110>, '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 0x1ad2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad26c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:00:22 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 11:00:22 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 11:00:22 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 11:00:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:00:22 INFO - Return code: 0 11:00:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:00:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:00:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:00:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:00:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:00:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:00:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:00:23 INFO - Return code: 0 11:00:23 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/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 11:00:23 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/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --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 11:00:23 INFO - Using env: {'DISPLAY': ':0', 11:00:23 INFO - 'HOME': '/home/cltbld', 11:00:23 INFO - 'LANG': 'en_US.UTF-8', 11:00:23 INFO - 'LANGUAGE': 'en_US:en', 11:00:23 INFO - 'LOGNAME': 'cltbld', 11:00:23 INFO - 'MAIL': '/var/mail/cltbld', 11:00:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:00:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:00:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:23 INFO - 'MOZ_NO_REMOTE': '1', 11:00:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:00:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:23 INFO - 'NO_EM_RESTART': '1', 11:00:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:23 INFO - 'PWD': '/builds/slave/test', 11:00:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:00:23 INFO - 'SHELL': '/bin/bash', 11:00:23 INFO - 'SHLVL': '1', 11:00:23 INFO - 'TERM': 'linux', 11:00:23 INFO - 'TMOUT': '86400', 11:00:23 INFO - 'USER': 'cltbld', 11:00:23 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465408552.543183-2078388438', 11:00:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:23 INFO - '_': '/tools/buildbot/bin/python'} 11:00:23 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/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 11:00:23 INFO - mozversion application_buildid: 20160608083003 11:00:23 INFO - mozversion application_changeset: daadc8567a11c6165986c05719fa44a7ed8af839 11:00:23 INFO - mozversion application_display_name: Nightly 11:00:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:00:23 INFO - mozversion application_name: Firefox 11:00:23 INFO - mozversion application_remotingname: firefox 11:00:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:00:23 INFO - mozversion application_vendor: Mozilla 11:00:23 INFO - mozversion application_version: 50.0a1 11:00:23 INFO - mozversion platform_buildid: 20160608083003 11:00:23 INFO - mozversion platform_changeset: daadc8567a11c6165986c05719fa44a7ed8af839 11:00:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:00:23 INFO - mozversion platform_version: 50.0a1 11:00:23 INFO - using testdate: 1465408823 11:00:23 INFO - actual date: 1465408823 11:00:23 INFO - starting webserver on 'localhost:42998' 11:00:23 INFO - SUITE-START | Running 2 tests 11:00:23 INFO - TEST-START | dromaeo_css 11:00:23 INFO - operating with platform_type : linux_ 11:00:23 INFO - Initialising browser for dromaeo_css test... 11:00:23 INFO - TEST-INFO | started process 16215 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWFe7Te/profile http://localhost:42998/getInfo.html) 11:00:27 INFO - PROCESS | 16215 | __metrics Screen width/height:1600/1200 11:00:27 INFO - PROCESS | 16215 | colorDepth:24 11:00:27 INFO - PROCESS | 16215 | Browser inner width/height: 1024/697 11:00:27 INFO - PROCESS | 16215 | __metrics 11:00:29 ERROR - PROCESS | 16215 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:00:29 INFO - PROCESS | 16215 | console.error: PushService: 11:00:29 INFO - PROCESS | 16215 | stateChangeProcessEnqueue: Error transitioning state 11:00:29 INFO - PROCESS | 16215 | UnknownError 11:00:30 INFO - TEST-INFO | 16215: exit 0 11:00:30 INFO - Browser initialized. 11:00:30 INFO - Running cycle 1/1 for dromaeo_css test... 11:00:30 INFO - TEST-INFO | started process 16296 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWFe7Te/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:00:41 INFO - PROCESS | 16296 | RSS: Main: 156016640 11:00:41 INFO - PROCESS | 16296 | 11:01:32 INFO - PROCESS | 16296 | 1465408892758 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] 11:03:41 INFO - PROCESS | 16296 | Cycle 1(1): loaded http://localhost:42998/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42998/tests/dromaeo/cssquery-ext.html) 11:03:42 INFO - PROCESS | 16296 | RSS: Main: 268021760 11:03:42 INFO - PROCESS | 16296 | 11:06:44 INFO - PROCESS | 16296 | Cycle 1(1): loaded http://localhost:42998/tests/dromaeo/cssquery-ext.html (next: http://localhost:42998/tests/dromaeo/cssquery-jquery.html) 11:06:45 INFO - PROCESS | 16296 | RSS: Main: 236527616 11:06:45 INFO - PROCESS | 16296 | 11:09:47 INFO - PROCESS | 16296 | Cycle 1(1): loaded http://localhost:42998/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42998/tests/dromaeo/cssquery-mootools.html) 11:09:47 INFO - PROCESS | 16296 | RSS: Main: 245055488 11:09:47 INFO - PROCESS | 16296 | 11:12:49 INFO - PROCESS | 16296 | Cycle 1(1): loaded http://localhost:42998/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42998/tests/dromaeo/cssquery-prototype.html) 11:12:50 INFO - PROCESS | 16296 | RSS: Main: 243097600 11:12:50 INFO - PROCESS | 16296 | 11:15:53 INFO - PROCESS | 16296 | Cycle 1(1): loaded http://localhost:42998/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42998/tests/dromaeo/cssquery-yui.html) 11:15:53 INFO - PROCESS | 16296 | RSS: Main: 222932992 11:15:53 INFO - PROCESS | 16296 | 11:18:56 INFO - PROCESS | 16296 | Cycle 1(1): loaded http://localhost:42998/tests/dromaeo/cssquery-yui.html (next: http://localhost:42998/tests/dromaeo/cssquery-dojo.html) 11:18:56 INFO - PROCESS | 16296 | RSS: Main: 272527360 11:18:56 INFO - PROCESS | 16296 | 11:18:56 INFO - PROCESS | 16296 | __start_tp_report 11:18:56 INFO - PROCESS | 16296 | _x_x_mozilla_page_load 11:18:56 INFO - PROCESS | 16296 | _x_x_mozilla_page_load_details 11:18:56 INFO - PROCESS | 16296 | |i|pagename|runs| 11:18:56 INFO - PROCESS | 16296 | |0;dojo.html;3160.8577614007368;3166.841657917105;3207.16613680443;3228.24136327963;3249.3826173027123;5167.328247327842;5209.687418754877;5335.173048177534;5415.64798288111;5463.808766693167;5275.709835959021;5282.630215884889;5327.946720532794;5353.170258609912;5428.077226871432;4768.237082066861;4774.832880849171;4840.709557426548;4842.66101372904;4917.508249175072;4895.6083513318845;4905.950940490585;4909.950900491003;4912.238603016538;4956.7025978441225;4730.6925049871825;4765.451973023112;4794.544518270759;4911.82808601699;4966.15575352191;4842;4846.830360937351;4849.321095046696;4851.611871050308;4852.199387101124;4745.762711864393;4818.831340903087;4820.879478013043;4833.734144622044;4854.393200849894;5094.5160209780015;5095.184770436749;5144.5369916707305;5252;5268.473152684739;5603.7478313475995;5661.377248502661;5665.773369065232;5672.716364181816;5675.262215911905;5529.806456773994;5569.443055694439;5601.467860553241;5605.047141985872;5741.339745929188;5318.22885681574;5368.30212072432;5371.75827087782;5377.462253774591;5391.946080539223;5476.123820188751;5835.212246346774;5835.562332825055;5837.270341207349;5843.3864444233595;5525.917111243334;5595.160725891067;5606.85982850432;5636.18275350072;5672.659640421588;5712.914306285409;5715.457031581993;5726.141078838207;5744.942550574524;5792.7103644818435;5513.669179849142;5618.297712785902;5694.373618901917;5703.17303990919;5703.429657034263;5662.17898404729;5703.515201207861;5714.828555143269;5725.828225153252;5762.078067509262;4351.369051487517;4358.847440339573;4363.170997510526;4370.453693288339;4399.450068741407;3787.867424640124;3802.08749900022;3833.1758671885677;3919.451276821247;3934.901627459279;5246.895062098737;5299.33758280215;5317.122674758699;5331.280277162611;5369.865753356119;5670.092785154356;5674.829755107354;5676.744546495418;5680.147977803363;5713.22871412354;5138.87152821175;5304.946950530522;5309.41596424393;5339.679619222859;5420.539254163361;4918.631102667314;4924.0890435268875;4924.285978533164;4930.11257973561;4955.1576232039915;6001.5198784097165;6002.639841609517;6005.819825405245;6007.3992600739575;6010.188624535719;5530.585206109638;5676.091825307931;5734.397888221677;5735.54115670737;5811.854703632443;5950.166976623363;5964.9105263420215;5966.433188847052;5973.522118230618;5975.133605627247;5672.461116193955;5682.431756824284;5688.687122208153;5689.971550142222;5693.174489699053;5487.094629386266;5684.289463817023;5715.685637289989;5767.221425107557;5813.273340832396;5596.216529685766;5636.577256705681;5639.7744090237575;5649.096144616841;5656.915146272727;5351.331083614548;5629.577781666473;5646.689432081275;5647.3787883333625;5648;5430.70131142791;5446.1558458439;5480.342358916955;5528.281323427928;5537.9169312459535;5619.381867994599;5621.297337832771;5652.095664693629;5675.091985282335;5685.914711279417;5234.7906083756225;5490.972545137249;5520.282363292747;5520.420355862577;5534.1975413565615 11:18:56 INFO - PROCESS | 16296 | |1;ext.html;566.6883214232174;609.7896225802098;611.4252602553596;626.0609086370445;640.8718256348732;31729.206769830736;32233;34617.48073778895;43255;44193;45640;45932.311015334795;46098.53901460984;46184.53815461844;46217.537824621744;8672.566371681422;8832.293416526663;8846.734597962039;8859.069797671249;8859.335549833757;8675.522846243486;8863.734087977371;8880.023197448276;8891.644334226623;8892.199702026815;8944.731658050268;8984.640614375417;8992.505412202327;8993.370464067519;8999.23506501948;8854.114588541159;8889.199972002518;8929.285657147477;8929.955350223272;8934.597943092576;8795.912040879573;8860.822783544358;8865.778355541099;8877.156670116394;8885.111488851127;41864.581354186375;41977.79011104955;42300;42328.78835605833;42396;3576.910577235564;4104.958950410517;4173.08192197716;4200.957990420087;4308.310670292738;32188.356232875445;32298;32498;32518.69925202989;32743.50884736731;4133.545310015896;4238.321868501056;4295.72077814941;4337.674674399401;4370.497392799837;235627;236440;236518;237114;237686;58378;58559.414405856245;58630.413695862495;58799.11801322983;58956;63463.682681586295;63515;63521;63526;63687;16797.244124014447;16860.57848553796;16935;16987.490375288762;17006.319747209975;13346.265955372548;13462.394192261176;13464.192148470927;13483.19100853952;13484.932575337256;13484.528041518499;14890.329935152944;17809.7328540072;17930.641387172185;18066.90966545185;6705.664716764142;6742.797716068526;6762.425193858478;6779.610179913106;6821.727130914807;719.7438392005421;1097.0017284271435;1110.4225802582612;1128.6794450492944;1212.5271144253747;32302.515462268086;32408;32501.51247731286;32559;32646.836765816493;976.8534719792088;1087.7443800706828;1107.684309971654;1144.9981266391908;1151.2459339132881;16259.512214633343;16547.83452165463;16598.25307861149;16696.666066678597;16778.412755553498;547909;554035;554705;555654;556570;54494;55780.721096394256;55881.44118558844;55900.720496397254;56047.43952560504;1232.0697873105928;1327.4159369877223;1371.0539727588132;1371.4788380415378;1378.7656098463285;29725;33439.83280083584;33608.32783344368;33760.49359259564;33823;51329.23006154836;52391.47608524018;52468.212976804614;52542;52712.47287527076;493372;512202;513764;513844;514385;37228.62771372252;41560;41802.37296440495;43048.83413990341;43193.784031079646;44418;45090.77454612706;45408.09183816371;49133.75433122811;49847.50152498428;40772.388414174406;42277.54449110129;42367.788161059;42376.57623423726;42398.576014239465;41550.58449415588;42362;42453.78773106238;42965.355519666606;44483.329250428236;41327;41444.055476607304;41917.58082419137;42045;42474.787626062905;35615.28769424545;37611.62388376081;37777;38541.42187867128;38603.2279354417;28244.576331355456;28293;28351.29121771972;28573.714262857105;28685 11:18:56 INFO - PROCESS | 16296 | |2;jquery.html;390.81241004317917;392.15881933253155;397.3761194923967;407.23236698822717;419.17631853408045;13769.311534423288;16316.918415407936;17808.465746027625;19536.12087456066;19557.608847823052;14793.03845250058;16837.32650693974;17641.64716705665;18134.81865181348;18871;5517.862053448665;5684.090545512719;5712.343080545749;5713.14302854571;5714.314282286132;4060.8984775380554;5522.3649280332875;5658.575606829484;5799;6102.328743838197;6152.0156774915795;6168.105624684418;6170.105334726462;6171.59884607499;6181.845453863667;6083.78706745264;6114.480269177126;6228.22147231596;6230.813075607739;6234.127222188898;5334.519893209591;5518.944810551883;5520.337559492847;5521.558275337963;5533.446655334475;18852.81147188524;18966.43100706981;18988.5252868678;19425.4172374829;22407;2218.389942765736;2274.7725227477285;2301.6777651128855;2356.8232382571205;2952.5571164325306;12761.808572871414;13099.934500327437;13935.58193254204;14404.927975360057;14448;1902.2200897631903;1947.4157752674141;1984.900754962246;2005.3382383813453;2027.5133967847758;76169.23830761678;77440.61279693621;77487;80085.59957200177;82031;10107.292489525662;10273.897261027294;10301.9484902575;10459.84310235347;10475.47622618866;14330.49843255481;14456.783148252785;14465.566033018817;14528.128312301296;14530.273486325641;8000.239977202156;8261.545614991233;8327.292180164633;8414.326853851677;8454.535000575028;7932.246436588515;8013.2387423194705;8034.276915077671;8120.918790812135;8135.3898457615915;5700.942990570041;6023.6385816851125;6290.528210384239;6492.285848556655;6537.627098309314;1889.6976483762533;1935.6032013437211;1962.077823422989;1968.4586738646701;1985.900704964746;865.0614083719109;940.5297351324338;959.822432849925;1015.137133436573;1048.7640280936728;17958.371456998942;18328.266869325078;18681.719774203397;18782.248710051717;18985.810141898404;970.3983530211173;1006.2654262388497;1006.6476733143342;1045.2996492350144;1084.7233955341337;10457.222272213741;10802.542473565316;10894.541753762853;10897.813645489046;10918.1811364148;434142;434411;443501;443752;478630;51578.48421515812;65320.34679653238;79960.60019699864;80558.19441805624;80876.19123808686;1004.3973615830444;1025.7948410317965;1034.524118905297;1050.1074087025968;1061.851340812287;16564.668706626042;16568.420105296256;16850.241739121524;16851.24169412355;17005.48983530496;27245.86377068181;35284.294314114086;39098;39612.207755844145;39950.2009959805;49468.505314947826;51548;51806.48193518168;52017.479825202776;52023.73988130035;6198.256209254918;7937.563434011185;8090.110087890445;8134.75595732129;8315.750527484186;12454.128211025503;12472.314022728837;12648.810267845805;12806.87193128094;12879.806802897776;10863.402512861869;11229.606963756229;11453.541858325907;11461.885381146081;11548.538058477567;10991.39547324873;11155.49800258974;11169.162312826407;11398.886011139783;11447.713807154887;11309.547618095185;11353.48909299067;11485.081193504333;11579.42102894835;11610.593629222936;8184;8271.627776750182;8291.709790157316;8491.405601607828;8533.146685331665;11226.719332016764;11270.436478175894;11288.32270063766;11343.716407089889;11388.259763115371 11:18:56 INFO - PROCESS | 16296 | |3;mootools.html;1353.688651610129;1499.108030721721;1512.8411516790736;1672.2809192047423;1853.0456814740403;8271.793205169866;8625.353098517613;8627.439216450926;8892.688755893545;8906.643734250638;8577.957110214456;8665.046844847062;8740.169683880036;8742.213200811926;8762;1955.7359756432913;2223.9332820015343;2323.7211534615826;2329.8136149108113;2350.2596682045187;2318.733345665253;2368.4078980254935;2369.099742098;2369.3484291819714;2371.620540713486;2273.9090436382526;2320.164740693349;2321.5240875620457;2323.326235391743;2329.790318871301;1950.161430584848;2228.097620463715;2305.020366344297;2307.676925230469;2321.7794309540736;2239.540894116702;2267.0591704442636;2272.2388000020014;2275.419767959176;2279;8835.072317406644;8846.911530884674;8861.379703420764;8886.066962968924;8890.511021893793;5125.154349532323;5258.2638430619745;5260.079486089919;5261.237120617528;5265.631405801595;3176.993224209369;3265.510173473974;3275.901722948315;3286.079897628668;3335.382954153489;1091.8307662312354;1103.1064837481586;1124.5333186727498;1129.2772625519674;1131.3325138168439;12324.383780810924;12487.75024499514;12572.937135314356;12584.874151258462;12639.115261931669;4476.731396116244;4602.930956035662;4666.440027196758;4736.100140973204;4747.382840230748;10605.89394106049;10623.681289561326;10648.946755266174;10666.839997400046;10675.893241067646;4620.330052142421;5218.504242096995;5281.894362112736;5282.498162674539;5285.762140703678;4677.158111539888;4828.517148285144;4844.781984810692;4847.878803029882;4856.053069651454;4017.5091443305337;4071.368937814584;4115.312721784054;4258.041940563348;4270.08193238449;1261.4386597964;1286.5561381323428;1292.3409061378763;1306.5427100514935;1325.5228117877557;816.8570500162448;902.9683961061463;918.196577994255;925.144241576539;963.7349728824629;5841.707914604252;6002.608526182693;6063.575549711566;6069.3627169147485;6089.147519347206;986.3785814936545;995.2038369304528;995.6266400099962;1006.8187726209206;1022.2639699416409;4140.37894315855;4168.374743788456;4170.687198460067;4180.456540649696;4233.216854881856;11030.338179709242;11269.436528173559;11372.772544549229;11373.431328433546;11397.430128493708;11097.722556936142;11212.49543770516;11213.71965700864;11220.719482012852;11232.550697972152;7880.64537095832;8173.223543763214;8422.78943026417;8467.66129354819;8529.232369086812;6149.938500615115;6258.186435763321;6259.718312675849;6361.840953976188;6387.808365749035;9998.500074996367;10296.227782916461;10457.529411176667;10493.737656558647;10502.78994420092;9868.111869931741;10204.285700001226;10562.577496900038;10581.52383142745;10586.576536938745;6953.721851125898;7628.313451789366;7890.48711833729;7929.563873986755;8092.433529652868;8796.120387961153;8808.911910881065;8879;8894.42186257891;8899.021107678022;7605.961970190114;7894.407919406182;7914.485558438683;7936.246056624612;7987.64055617487;7671.38628909697;7719.845603088019;7731.304182623591;7859.528428294092;7881.211878812073;7182.928170718435;7211.3870321023305;7250.166230883516;7255.310745479171;7257.891131632924;5004.724740139327;5114.1305977984575;5253.973730131325;5258.447862974485;5341.439148889466;5195.168772996453;5203.401608814884;5305.920411193758;5329.920051199313;5444.673319600836 11:18:56 INFO - PROCESS | 16296 | |4;prototype.html;307.91532328609634;313.49840255591056;315.31261849168806;320.349690129038;323.5163430671147;5217.321748172737;5273.393559740631;5281.973590132044;5314.52169304763;5361.142217245232;5224.555912747412;5269;5281.947180528194;5286.735663216843;5292.417834038252;3878.8448462061483;3929.4695216145883;4082.5509193988787;4090.611391917778;4103.138340948404;4019.1559772447677;4078.143589846121;4091.8747344480207;4092.7544347339253;4094.815733291994;3874.3607304794814;4046.6358027777496;4047.271491131595;4050.453188819516;4067.8169482373214;3884.7280690351686;4031.536373317062;4063.2889244382113;4067.5118985721606;4073.551909289976;3544.291141771656;3547.219611685425;3553.400969563707;3557.324108419392;3561.12752375667;4977.9751101244265;5006.499350065001;5034.4713805050305;5041.042201981649;5041.9747901260625;4526.8868278292975;4575.519570445122;4588.197065513556;4595.540445955377;4634.884127896796;5426.806102657409;5436.565074794007;5489.286392768914;5498.862528436781;5501.312335958005;3895.8831235062994;3898.649121579043;3905.1018265799025;3910.960890391088;3925.960740392588;5422.91865622016;5605.747741351649;5628.971855140739;5636.998865402764;5664.405237450091;3909.179072394829;3930.9803450983136;3931.7051221158526;3931.724779265424;3932.134930315326;3959.7822119783114;3962.3660214365564;3978.3435733104293;4004.3192657248337;4011.1777085697363;4476.216662084187;4563.520830312836;4597.126545956257;4622.705642420127;4624.398828152386;5438.211459338374;5441.211024401439;5455.699936503531;5475.6440831345835;5486.643368181056;1391.325207274471;1391.4016972701634;1395.162902258657;1398.2030242761732;1398.3427788939182;878.1789027259533;901.756525738047;907.491804589432;956.3114557518714;972.9416235025922;5191.299174611455;5197.792088316501;5214.869628259248;5232.3459567554055;5237.214417837355;5491.258680078138;5528.364238112588;5533.98009726447;5540.36285827127;5551.666899986014;4999.010488818567;5182.32629758129;5187.377514698185;5200.8959820803375;5222.764975576109;2927.638648028634;2954.852257387122;2955.0053713743137;2982.373701522661;2989;5496.422875598005;5707.600467967285;5708.372079071299;5737.475510775245;5738.282714660668;5631.211630371751;5688.175214593861;5689.2603961485565;5696.487316141567;5729.799457018984;5662.8301150965535;5672.602917795714;5686.630369026;5738.454846789548;5748.223989761329;5300.549453296513;5553.222548843246;5554.833354999357;5580.214331413908;5596.608237423341;5437.918431223456;5491.341039075336;5493.7802487900035;5501.889962200654;5502.312210973629;5710.942890571041;5734.025215713422;5770.13447982806;5784.797532086357;5791.160281759206;3920.1963597463023;4005.499312585927;4009.258287216874;4028.2144981728284;4031.6090948622677;5552.194931734795;5556.361018482926;5631.831045068655;5634.52106570946;5668.971655141698;5325.600579956441;5374.811881584125;5417.864553386197;5448.809291674773;5457.508824205841;5394.840109376503;5401.6218864679095;5417.83286685329;5421.647592906448;5428.809991650273;5178.456262092426;5223.7910483580235;5263.947360526346;5302.920456193237;5320.308359913187;5427.158790387496;5428.37573679032;5445.141300817103;5449.264349312792;5478.096114141282;5312.688980293585;5368.463153684756;5372.489613486712;5388.407275199804;5397.59518036141 11:18:56 INFO - PROCESS | 16296 | |5;yui.html;678.9083473731046;730.9086364204475;765.93489553388;778.9104253010905;842.4776638484141;17066.402675906345;17994.370197043107;18024.279028838846;18466.16902239399;18766.906165469154;16143.757843632326;16596.83403165968;16991.150442477887;16993.150342482888;17119.657606847857;683.1017212365748;827.1769589258666;831.4221615976868;834.8038211020405;835.807764214231;802.1016461563057;820.1019883227856;826.3554427546524;831.0359982420393;831.5468069901888;875.9824803503926;878.0429332028089;878.2315473960285;878.3280790195505;879.1604018162672;708.3129364516411;834.8246868157634;870.8606622940331;870.8998465176522;871.255076909243;630.3885231325606;630.713025573363;632.3139393757779;633.0788702437987;637.1812221295659;15876.206189690469;15913;15942.282597283034;15945.362185512566;15961.12213828239;13165.60503184906;13199.472021119143;13452.260125693083;13470.39383227757;13721.931390342985;13494.392752326168;13494.730105397935;13647;13703;13761.105528140639;4435.645148388121;4436.223660859337;4490.640748740093;4502.977485112586;4707.905841883177;76769.23230767733;77744.61127694325;77784;78494.60752696257;79495.20504794936;10626.267469855347;10699;10735.57057717698;10777.191710621735;11218.495167717472;20975.265865694626;21041;21085.051172697265;21143.25998590042;21176.15295388198;8487.405881588353;8526.78683032929;8573.399862009599;8736.519491428033;8770.736877893672;4338.761368124783;4460.687751857404;4495.662825288116;4627.3521706961055;4877.756112194376;3339.816310102919;3419.2990436960363;3420.264643101745;3428.6057103432927;3470.774399664014;606.535999960031;609.3814778000333;612.1735656863289;616.5037145098149;636.3604577399684;509.5465036117858;609.2080295615682;610.0696437932189;628.3182746719768;650.0541711809307;9328.34701570897;9530.142287194185;9722.805543889224;9728.416295022322;9910.950445247727;655.6492276631978;670.7618795327588;673.7406098652054;687.7833482453011;704.7040243097911;4332.155229730172;5017.648764586444;5409.918016396737;5468.7539060742365;5479.0959491683425;73003;86558;112599;119423.40288298503;120046.39976800235;66231.66884165548;98624.50687746516;102828.48585757172;103337.48331258296;104857;84354.82258870565;87154;89236.10763892278;89809.55095224612;90589.54705226564;10039.693198435938;10298.3820970742;10307.793844123225;10364.844527332247;10431.895681043092;50554.74722626364;50899.491005089476;51113;52470.73764631152;52909.7354513225;47921.520784791705;59103.70448147732;79412.60293698494;80233;80972.19027809646;12595.685107872376;12621.05342099328;12950.417231224428;13304.866951330363;13555.254461004344;13715.177089374669;13840.515581954583;14723.484678036217;15140.848591514385;15298.005629634039;12817.615471535868;12873.291968941798;13174.60476185716;13894.305284735925;14608.853911461174;14019.369128389042;14120.646983825487;14386.928065359607;14643.487477938646;15134.697306053597;13738.450461981409;13765.311734413039;14203.928980355033;14323.212223327817;14849.40602375893;10717.41054241993;10841.837372439577;11092.33445993243;11369.658910232707;11550.94224528872;11138.498767555317;11273.605423810128;11627.6511704649;11808.468618912342;11814 11:18:56 INFO - PROCESS | 16296 | __end_tp_report 11:18:56 INFO - PROCESS | 16296 | __start_cc_report 11:18:56 INFO - PROCESS | 16296 | _x_x_mozilla_cycle_collect,892 11:18:56 INFO - PROCESS | 16296 | __end_cc_report 11:18:56 INFO - PROCESS | 16296 | __startTimestamp1465409936868__endTimestamp 11:18:56 INFO - PROCESS | 16296 | 11:18:56 INFO - PROCESS | 16296 | ------- Summary: start ------- 11:18:56 INFO - PROCESS | 16296 | Number of tests: 6 11:18:56 INFO - PROCESS | 16296 | 11:18:56 INFO - PROCESS | 16296 | [#0] dojo.html Cycles:165 Average:5293.53 Median:5490.97 stddev:595.18 (10.8%) stddev-sans-first:573.01 11:18:56 INFO - PROCESS | 16296 | Values: 3160.9 3166.8 3207.2 3228.2 3249.4 5167.3 5209.7 5335.2 5415.6 5463.8 5275.7 5282.6 5327.9 5353.2 5428.1 4768.2 4774.8 4840.7 4842.7 4917.5 4895.6 4906.0 4910.0 4912.2 4956.7 4730.7 4765.5 4794.5 4911.8 4966.2 4842.0 4846.8 4849.3 4851.6 4852.2 4745.8 4818.8 4820.9 4833.7 4854.4 5094.5 5095.2 5144.5 5252.0 5268.5 5603.7 5661.4 5665.8 5672.7 5675.3 5529.8 5569.4 5601.5 5605.0 5741.3 5318.2 5368.3 5371.8 5377.5 5391.9 5476.1 5835.2 5835.6 5837.3 5843.4 5525.9 5595.2 5606.9 5636.2 5672.7 5712.9 5715.5 5726.1 5744.9 5792.7 5513.7 5618.3 5694.4 5703.2 5703.4 5662.2 5703.5 5714.8 5725.8 5762.1 4351.4 4358.8 4363.2 4370.5 4399.5 3787.9 3802.1 3833.2 3919.5 3934.9 5246.9 5299.3 5317.1 5331.3 5369.9 5670.1 5674.8 5676.7 5680.1 5713.2 5138.9 5304.9 5309.4 5339.7 5420.5 4918.6 4924.1 4924.3 4930.1 4955.2 6001.5 6002.6 6005.8 6007.4 6010.2 5530.6 5676.1 5734.4 5735.5 5811.9 5950.2 5964.9 5966.4 5973.5 5975.1 5672.5 5682.4 5688.7 5690.0 5693.2 5487.1 5684.3 5715.7 5767.2 5813.3 5596.2 5636.6 5639.8 5649.1 5656.9 5351.3 5629.6 5646.7 5647.4 5648.0 5430.7 5446.2 5480.3 5528.3 5537.9 5619.4 5621.3 5652.1 5675.1 5685.9 5234.8 5491.0 5520.3 5520.4 5534.2 11:18:56 INFO - PROCESS | 16296 | 11:18:56 INFO - PROCESS | 16296 | [#1] ext.html Cycles:180 Average:60030.92 Median:42426.18 stddev:121376.48 (286.1%) stddev-sans-first:121634.86 11:18:56 INFO - PROCESS | 16296 | Values: 566.7 609.8 611.4 626.1 640.9 31729.2 32233.0 34617.5 43255.0 44193.0 45640.0 45932.3 46098.5 46184.5 46217.5 8672.6 8832.3 8846.7 8859.1 8859.3 8675.5 8863.7 8880.0 8891.6 8892.2 8944.7 8984.6 8992.5 8993.4 8999.2 8854.1 8889.2 8929.3 8930.0 8934.6 8795.9 8860.8 8865.8 8877.2 8885.1 41864.6 41977.8 42300.0 42328.8 42396.0 3576.9 4105.0 4173.1 4201.0 4308.3 32188.4 32298.0 32498.0 32518.7 32743.5 4133.5 4238.3 4295.7 4337.7 4370.5 235627.0 236440.0 236518.0 237114.0 237686.0 58378.0 58559.4 58630.4 58799.1 58956.0 63463.7 63515.0 63521.0 63526.0 63687.0 16797.2 16860.6 16935.0 16987.5 17006.3 13346.3 13462.4 13464.2 13483.2 13484.9 13484.5 14890.3 17809.7 17930.6 18066.9 6705.7 6742.8 6762.4 6779.6 6821.7 719.7 1097.0 1110.4 1128.7 1212.5 32302.5 32408.0 32501.5 32559.0 32646.8 976.9 1087.7 1107.7 1145.0 1151.2 16259.5 16547.8 16598.3 16696.7 16778.4 547909.0 554035.0 554705.0 555654.0 556570.0 54494.0 55780.7 55881.4 55900.7 56047.4 1232.1 1327.4 1371.1 1371.5 1378.8 29725.0 33439.8 33608.3 33760.5 33823.0 51329.2 52391.5 52468.2 52542.0 52712.5 493372.0 512202.0 513764.0 513844.0 514385.0 37228.6 41560.0 41802.4 43048.8 43193.8 44418.0 45090.8 45408.1 49133.8 49847.5 40772.4 42277.5 42367.8 42376.6 42398.6 41550.6 42362.0 42453.8 42965.4 44483.3 41327.0 41444.1 41917.6 42045.0 42474.8 35615.3 37611.6 37777.0 38541.4 38603.2 28244.6 28293.0 28351.3 28573.7 28685.0 11:18:56 INFO - PROCESS | 16296 | 11:18:56 INFO - PROCESS | 16296 | [#2] jquery.html Cycles:180 Average:26641.91 Median:12312.69 stddev:73474.61 (596.7%) stddev-sans-first:73654.29 11:18:56 INFO - PROCESS | 16296 | Values: 390.8 392.2 397.4 407.2 419.2 13769.3 16316.9 17808.5 19536.1 19557.6 14793.0 16837.3 17641.6 18134.8 18871.0 5517.9 5684.1 5712.3 5713.1 5714.3 4060.9 5522.4 5658.6 5799.0 6102.3 6152.0 6168.1 6170.1 6171.6 6181.8 6083.8 6114.5 6228.2 6230.8 6234.1 5334.5 5518.9 5520.3 5521.6 5533.4 18852.8 18966.4 18988.5 19425.4 22407.0 2218.4 2274.8 2301.7 2356.8 2952.6 12761.8 13099.9 13935.6 14404.9 14448.0 1902.2 1947.4 1984.9 2005.3 2027.5 76169.2 77440.6 77487.0 80085.6 82031.0 10107.3 10273.9 10301.9 10459.8 10475.5 14330.5 14456.8 14465.6 14528.1 14530.3 8000.2 8261.5 8327.3 8414.3 8454.5 7932.2 8013.2 8034.3 8120.9 8135.4 5700.9 6023.6 6290.5 6492.3 6537.6 1889.7 1935.6 1962.1 1968.5 1985.9 865.1 940.5 959.8 1015.1 1048.8 17958.4 18328.3 18681.7 18782.2 18985.8 970.4 1006.3 1006.6 1045.3 1084.7 10457.2 10802.5 10894.5 10897.8 10918.2 434142.0 434411.0 443501.0 443752.0 478630.0 51578.5 65320.3 79960.6 80558.2 80876.2 1004.4 1025.8 1034.5 1050.1 1061.9 16564.7 16568.4 16850.2 16851.2 17005.5 27245.9 35284.3 39098.0 39612.2 39950.2 49468.5 51548.0 51806.5 52017.5 52023.7 6198.3 7937.6 8090.1 8134.8 8315.8 12454.1 12472.3 12648.8 12806.9 12879.8 10863.4 11229.6 11453.5 11461.9 11548.5 10991.4 11155.5 11169.2 11398.9 11447.7 11309.5 11353.5 11485.1 11579.4 11610.6 8184.0 8271.6 8291.7 8491.4 8533.1 11226.7 11270.4 11288.3 11343.7 11388.3 11:18:56 INFO - PROCESS | 16296 | 11:18:56 INFO - PROCESS | 16296 | [#3] mootools.html Cycles:180 Average:5883.64 Median:4741.74 stddev:3383.90 (71.4%) stddev-sans-first:3376.26 11:18:56 INFO - PROCESS | 16296 | Values: 1353.7 1499.1 1512.8 1672.3 1853.0 8271.8 8625.4 8627.4 8892.7 8906.6 8578.0 8665.0 8740.2 8742.2 8762.0 1955.7 2223.9 2323.7 2329.8 2350.3 2318.7 2368.4 2369.1 2369.3 2371.6 2273.9 2320.2 2321.5 2323.3 2329.8 1950.2 2228.1 2305.0 2307.7 2321.8 2239.5 2267.1 2272.2 2275.4 2279.0 8835.1 8846.9 8861.4 8886.1 8890.5 5125.2 5258.3 5260.1 5261.2 5265.6 3177.0 3265.5 3275.9 3286.1 3335.4 1091.8 1103.1 1124.5 1129.3 1131.3 12324.4 12487.8 12572.9 12584.9 12639.1 4476.7 4602.9 4666.4 4736.1 4747.4 10605.9 10623.7 10648.9 10666.8 10675.9 4620.3 5218.5 5281.9 5282.5 5285.8 4677.2 4828.5 4844.8 4847.9 4856.1 4017.5 4071.4 4115.3 4258.0 4270.1 1261.4 1286.6 1292.3 1306.5 1325.5 816.9 903.0 918.2 925.1 963.7 5841.7 6002.6 6063.6 6069.4 6089.1 986.4 995.2 995.6 1006.8 1022.3 4140.4 4168.4 4170.7 4180.5 4233.2 11030.3 11269.4 11372.8 11373.4 11397.4 11097.7 11212.5 11213.7 11220.7 11232.6 7880.6 8173.2 8422.8 8467.7 8529.2 6149.9 6258.2 6259.7 6361.8 6387.8 9998.5 10296.2 10457.5 10493.7 10502.8 9868.1 10204.3 10562.6 10581.5 10586.6 6953.7 7628.3 7890.5 7929.6 8092.4 8796.1 8808.9 8879.0 8894.4 8899.0 7606.0 7894.4 7914.5 7936.2 7987.6 7671.4 7719.8 7731.3 7859.5 7881.2 7182.9 7211.4 7250.2 7255.3 7257.9 5004.7 5114.1 5254.0 5258.4 5341.4 5195.2 5203.4 5305.9 5329.9 5444.7 11:18:56 INFO - PROCESS | 16296 | 11:18:56 INFO - PROCESS | 16296 | [#4] prototype.html Cycles:180 Average:4571.96 Median:5271.20 stddev:1343.93 (25.5%) stddev-sans-first:1309.03 11:18:56 INFO - PROCESS | 16296 | Values: 307.9 313.5 315.3 320.3 323.5 5217.3 5273.4 5282.0 5314.5 5361.1 5224.6 5269.0 5281.9 5286.7 5292.4 3878.8 3929.5 4082.6 4090.6 4103.1 4019.2 4078.1 4091.9 4092.8 4094.8 3874.4 4046.6 4047.3 4050.5 4067.8 3884.7 4031.5 4063.3 4067.5 4073.6 3544.3 3547.2 3553.4 3557.3 3561.1 4978.0 5006.5 5034.5 5041.0 5042.0 4526.9 4575.5 4588.2 4595.5 4634.9 5426.8 5436.6 5489.3 5498.9 5501.3 3895.9 3898.6 3905.1 3911.0 3926.0 5422.9 5605.7 5629.0 5637.0 5664.4 3909.2 3931.0 3931.7 3931.7 3932.1 3959.8 3962.4 3978.3 4004.3 4011.2 4476.2 4563.5 4597.1 4622.7 4624.4 5438.2 5441.2 5455.7 5475.6 5486.6 1391.3 1391.4 1395.2 1398.2 1398.3 878.2 901.8 907.5 956.3 972.9 5191.3 5197.8 5214.9 5232.3 5237.2 5491.3 5528.4 5534.0 5540.4 5551.7 4999.0 5182.3 5187.4 5200.9 5222.8 2927.6 2954.9 2955.0 2982.4 2989.0 5496.4 5707.6 5708.4 5737.5 5738.3 5631.2 5688.2 5689.3 5696.5 5729.8 5662.8 5672.6 5686.6 5738.5 5748.2 5300.5 5553.2 5554.8 5580.2 5596.6 5437.9 5491.3 5493.8 5501.9 5502.3 5710.9 5734.0 5770.1 5784.8 5791.2 3920.2 4005.5 4009.3 4028.2 4031.6 5552.2 5556.4 5631.8 5634.5 5669.0 5325.6 5374.8 5417.9 5448.8 5457.5 5394.8 5401.6 5417.8 5421.6 5428.8 5178.5 5223.8 5263.9 5302.9 5320.3 5427.2 5428.4 5445.1 5449.3 5478.1 5312.7 5368.5 5372.5 5388.4 5397.6 11:18:56 INFO - PROCESS | 16296 | 11:18:56 INFO - PROCESS | 16296 | [#5] yui.html Cycles:180 Average:20547.12 Median:4475.66 stddev:28874.62 (645.1%) stddev-sans-first:28917.08 11:18:56 INFO - PROCESS | 16296 | Values: 678.9 730.9 765.9 778.9 842.5 17066.4 17994.4 18024.3 18466.2 18766.9 16143.8 16596.8 16991.2 16993.2 17119.7 683.1 827.2 831.4 834.8 835.8 802.1 820.1 826.4 831.0 831.5 876.0 878.0 878.2 878.3 879.2 708.3 834.8 870.9 870.9 871.3 630.4 630.7 632.3 633.1 637.2 15876.2 15913.0 15942.3 15945.4 15961.1 13165.6 13199.5 13452.3 13470.4 13721.9 13494.4 13494.7 13647.0 13703.0 13761.1 4435.6 4436.2 4490.6 4503.0 4707.9 76769.2 77744.6 77784.0 78494.6 79495.2 10626.3 10699.0 10735.6 10777.2 11218.5 20975.3 21041.0 21085.1 21143.3 21176.2 8487.4 8526.8 8573.4 8736.5 8770.7 4338.8 4460.7 4495.7 4627.4 4877.8 3339.8 3419.3 3420.3 3428.6 3470.8 606.5 609.4 612.2 616.5 636.4 509.5 609.2 610.1 628.3 650.1 9328.3 9530.1 9722.8 9728.4 9911.0 655.6 670.8 673.7 687.8 704.7 4332.2 5017.6 5409.9 5468.8 5479.1 73003.0 86558.0 112599.0 119423.4 120046.4 66231.7 98624.5 102828.5 103337.5 104857.0 84354.8 87154.0 89236.1 89809.6 90589.5 10039.7 10298.4 10307.8 10364.8 10431.9 50554.7 50899.5 51113.0 52470.7 52909.7 47921.5 59103.7 79412.6 80233.0 80972.2 12595.7 12621.1 12950.4 13304.9 13555.3 13715.2 13840.5 14723.5 15140.8 15298.0 12817.6 12873.3 13174.6 13894.3 14608.9 14019.4 14120.6 14386.9 14643.5 15134.7 13738.5 13765.3 14203.9 14323.2 14849.4 10717.4 10841.8 11092.3 11369.7 11550.9 11138.5 11273.6 11627.7 11808.5 11814.0 11:18:56 INFO - PROCESS | 16296 | -------- Summary: end -------- 11:18:56 INFO - PROCESS | 16296 | 11:18:57 INFO - TEST-INFO | 16296: exit 0 11:18:57 INFO - TEST-OK | dromaeo_css | took 1113688ms 11:18:57 INFO - TEST-START | kraken 11:18:57 INFO - operating with platform_type : linux_ 11:18:57 INFO - Initialising browser for kraken test... 11:18:57 INFO - TEST-INFO | started process 16477 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFqXRZ8/profile http://localhost:42998/getInfo.html) 11:19:01 INFO - PROCESS | 16477 | __metrics Screen width/height:1600/1200 11:19:01 INFO - PROCESS | 16477 | colorDepth:24 11:19:01 INFO - PROCESS | 16477 | Browser inner width/height: 1024/697 11:19:01 INFO - PROCESS | 16477 | __metrics 11:19:02 ERROR - PROCESS | 16477 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:19:03 INFO - PROCESS | 16477 | console.error: PushService: 11:19:03 INFO - PROCESS | 16477 | stateChangeProcessEnqueue: Error transitioning state 11:19:03 INFO - PROCESS | 16477 | UnknownError 11:19:03 INFO - TEST-INFO | 16477: exit 0 11:19:03 INFO - Browser initialized. 11:19:03 INFO - Running cycle 1/1 for kraken test... 11:19:03 INFO - TEST-INFO | started process 16558 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFqXRZ8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:19:15 INFO - PROCESS | 16558 | RSS: Main: 156155904 11:19:15 INFO - PROCESS | 16558 | 11:19:18 INFO - PROCESS | 16558 | Cycle 1(1): loaded http://localhost:42998/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42998/tests/kraken/driver.html?testName=audio-beat-detection) 11:19:18 INFO - PROCESS | 16558 | RSS: Main: 214642688 11:19:18 INFO - PROCESS | 16558 | 11:19:21 INFO - PROCESS | 16558 | Cycle 1(1): loaded http://localhost:42998/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42998/tests/kraken/driver.html?testName=audio-dft) 11:19:22 INFO - PROCESS | 16558 | RSS: Main: 200826880 11:19:22 INFO - PROCESS | 16558 | 11:19:25 INFO - PROCESS | 16558 | Cycle 1(1): loaded http://localhost:42998/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42998/tests/kraken/driver.html?testName=audio-fft) 11:19:25 INFO - PROCESS | 16558 | RSS: Main: 267943936 11:19:25 INFO - PROCESS | 16558 | 11:19:27 INFO - PROCESS | 16558 | Cycle 1(1): loaded http://localhost:42998/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42998/tests/kraken/driver.html?testName=audio-oscillator) 11:19:28 INFO - PROCESS | 16558 | RSS: Main: 178712576 11:19:28 INFO - PROCESS | 16558 | 11:19:30 INFO - PROCESS | 16558 | Cycle 1(1): loaded http://localhost:42998/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42998/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:19:31 INFO - PROCESS | 16558 | RSS: Main: 183451648 11:19:31 INFO - PROCESS | 16558 | 11:19:34 INFO - PROCESS | 16558 | Cycle 1(1): loaded http://localhost:42998/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42998/tests/kraken/driver.html?testName=imaging-darkroom) 11:19:34 INFO - PROCESS | 16558 | RSS: Main: 218390528 11:19:34 INFO - PROCESS | 16558 | 11:19:38 INFO - PROCESS | 16558 | Cycle 1(1): loaded http://localhost:42998/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42998/tests/kraken/driver.html?testName=imaging-desaturate) 11:19:38 INFO - PROCESS | 16558 | RSS: Main: 220160000 11:19:38 INFO - PROCESS | 16558 | 11:19:41 INFO - PROCESS | 16558 | Cycle 1(1): loaded http://localhost:42998/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42998/tests/kraken/driver.html?testName=json-parse-financial) 11:19:42 INFO - PROCESS | 16558 | RSS: Main: 221196288 11:19:42 INFO - PROCESS | 16558 | 11:19:43 INFO - PROCESS | 16558 | Cycle 1(1): loaded http://localhost:42998/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42998/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:19:44 INFO - PROCESS | 16558 | RSS: Main: 206970880 11:19:44 INFO - PROCESS | 16558 | 11:19:46 INFO - PROCESS | 16558 | Cycle 1(1): loaded http://localhost:42998/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42998/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:19:46 INFO - PROCESS | 16558 | RSS: Main: 211632128 11:19:46 INFO - PROCESS | 16558 | 11:19:48 INFO - PROCESS | 16558 | Cycle 1(1): loaded http://localhost:42998/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42998/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:19:49 INFO - PROCESS | 16558 | RSS: Main: 218767360 11:19:49 INFO - PROCESS | 16558 | 11:19:51 INFO - PROCESS | 16558 | Cycle 1(1): loaded http://localhost:42998/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42998/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:19:52 INFO - PROCESS | 16558 | RSS: Main: 222515200 11:19:52 INFO - PROCESS | 16558 | 11:19:55 INFO - PROCESS | 16558 | Cycle 1(1): loaded http://localhost:42998/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42998/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:19:55 INFO - PROCESS | 16558 | RSS: Main: 222306304 11:19:55 INFO - PROCESS | 16558 | 11:19:57 INFO - PROCESS | 16558 | Cycle 1(1): loaded http://localhost:42998/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42998/tests/kraken/driver.html?testName=ai-astar) 11:19:57 INFO - PROCESS | 16558 | RSS: Main: 265273344 11:19:57 INFO - PROCESS | 16558 | 11:19:57 INFO - PROCESS | 16558 | __start_tp_report 11:19:57 INFO - PROCESS | 16558 | _x_x_mozilla_page_load 11:19:57 INFO - PROCESS | 16558 | _x_x_mozilla_page_load_details 11:19:57 INFO - PROCESS | 16558 | |i|pagename|runs| 11:19:57 INFO - PROCESS | 16558 | |0;ai-astar;111;105;109;109;110;109;108;109;110;108 11:19:57 INFO - PROCESS | 16558 | |1;audio-beat-detection;149;125;130;185;132;156;146;127;195;133 11:19:57 INFO - PROCESS | 16558 | |2;audio-dft;161;160;161;161;159;159;161;162;161;161 11:19:57 INFO - PROCESS | 16558 | |3;audio-fft;75;74;75;114;78;76;75;75;99;75 11:19:57 INFO - PROCESS | 16558 | |4;audio-oscillator;92;86;114;85;85;85;114;83;85;133 11:19:57 INFO - PROCESS | 16558 | |5;imaging-gaussian-blur;116;117;116;117;117;117;118;117;116;117 11:19:57 INFO - PROCESS | 16558 | |6;imaging-darkroom;145;145;146;145;145;146;147;145;146;146 11:19:57 INFO - PROCESS | 16558 | |7;imaging-desaturate;95;95;94;95;95;95;95;95;95;95 11:19:57 INFO - PROCESS | 16558 | |8;json-parse-financial;53;53;55;55;54;54;55;54;53;54 11:19:57 INFO - PROCESS | 16558 | |9;json-stringify-tinderbox;63;63;63;63;63;63;62;62;63;61 11:19:57 INFO - PROCESS | 16558 | |10;stanford-crypto-aes;79;83;79;83;80;80;80;81;134;79 11:19:57 INFO - PROCESS | 16558 | |11;stanford-crypto-ccm;120;124;128;121;126;124;120;124;133;137 11:19:57 INFO - PROCESS | 16558 | |12;stanford-crypto-pbkdf2;159;163;161;161;161;163;165;164;167;162 11:19:57 INFO - PROCESS | 16558 | |13;stanford-crypto-sha256-iterative;63;64;73;63;63;64;63;63;62;61 11:19:57 INFO - PROCESS | 16558 | __end_tp_report 11:19:57 INFO - PROCESS | 16558 | __start_cc_report 11:19:57 INFO - PROCESS | 16558 | _x_x_mozilla_cycle_collect,1634 11:19:57 INFO - PROCESS | 16558 | __end_cc_report 11:19:57 INFO - PROCESS | 16558 | __startTimestamp1465409997865__endTimestamp 11:19:57 INFO - PROCESS | 16558 | 11:19:57 INFO - PROCESS | 16558 | ------- Summary: start ------- 11:19:57 INFO - PROCESS | 16558 | Number of tests: 14 11:19:57 INFO - PROCESS | 16558 | 11:19:57 INFO - PROCESS | 16558 | [#0] ai-astar Cycles:10 Average:108.80 Median:109.00 stddev:1.62 (1.5%) stddev-sans-first:1.51 11:19:57 INFO - PROCESS | 16558 | Values: 111.0 105.0 109.0 109.0 110.0 109.0 108.0 109.0 110.0 108.0 11:19:57 INFO - PROCESS | 16558 | 11:19:57 INFO - PROCESS | 16558 | [#1] audio-beat-detection Cycles:10 Average:147.80 Median:147.50 stddev:24.54 (16.6%) stddev-sans-first:26.03 11:19:57 INFO - PROCESS | 16558 | Values: 149.0 125.0 130.0 185.0 132.0 156.0 146.0 127.0 195.0 133.0 11:19:57 INFO - PROCESS | 16558 | 11:19:57 INFO - PROCESS | 16558 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 11:19:57 INFO - PROCESS | 16558 | Values: 161.0 160.0 161.0 161.0 159.0 159.0 161.0 162.0 161.0 161.0 11:19:57 INFO - PROCESS | 16558 | 11:19:57 INFO - PROCESS | 16558 | [#3] audio-fft Cycles:10 Average:81.60 Median:75.00 stddev:13.63 (18.2%) stddev-sans-first:14.25 11:19:57 INFO - PROCESS | 16558 | Values: 75.0 74.0 75.0 114.0 78.0 76.0 75.0 75.0 99.0 75.0 11:19:57 INFO - PROCESS | 16558 | 11:19:57 INFO - PROCESS | 16558 | [#4] audio-oscillator Cycles:10 Average:96.20 Median:85.00 stddev:17.59 (20.7%) stddev-sans-first:18.59 11:19:57 INFO - PROCESS | 16558 | Values: 92.0 86.0 114.0 85.0 85.0 85.0 114.0 83.0 85.0 133.0 11:19:57 INFO - PROCESS | 16558 | 11:19:57 INFO - PROCESS | 16558 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 11:19:57 INFO - PROCESS | 16558 | Values: 116.0 117.0 116.0 117.0 117.0 117.0 118.0 117.0 116.0 117.0 11:19:57 INFO - PROCESS | 16558 | 11:19:57 INFO - PROCESS | 16558 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 11:19:57 INFO - PROCESS | 16558 | Values: 145.0 145.0 146.0 145.0 145.0 146.0 147.0 145.0 146.0 146.0 11:19:57 INFO - PROCESS | 16558 | 11:19:57 INFO - PROCESS | 16558 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:19:57 INFO - PROCESS | 16558 | Values: 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 11:19:57 INFO - PROCESS | 16558 | 11:19:57 INFO - PROCESS | 16558 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:0.82 (1.5%) stddev-sans-first:0.78 11:19:57 INFO - PROCESS | 16558 | Values: 53.0 53.0 55.0 55.0 54.0 54.0 55.0 54.0 53.0 54.0 11:19:57 INFO - PROCESS | 16558 | 11:19:57 INFO - PROCESS | 16558 | [#9] json-stringify-tinderbox Cycles:10 Average:62.60 Median:63.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 11:19:57 INFO - PROCESS | 16558 | Values: 63.0 63.0 63.0 63.0 63.0 63.0 62.0 62.0 63.0 61.0 11:19:57 INFO - PROCESS | 16558 | 11:19:57 INFO - PROCESS | 16558 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:80.00 stddev:17.00 (21.3%) stddev-sans-first:17.85 11:19:57 INFO - PROCESS | 16558 | Values: 79.0 83.0 79.0 83.0 80.0 80.0 80.0 81.0 134.0 79.0 11:19:57 INFO - PROCESS | 16558 | 11:19:57 INFO - PROCESS | 16558 | [#11] stanford-crypto-ccm Cycles:10 Average:125.70 Median:125.00 stddev:5.60 (4.5%) stddev-sans-first:5.55 11:19:57 INFO - PROCESS | 16558 | Values: 120.0 124.0 128.0 121.0 126.0 124.0 120.0 124.0 133.0 137.0 11:19:57 INFO - PROCESS | 16558 | 11:19:57 INFO - PROCESS | 16558 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.60 Median:163.00 stddev:2.32 (1.4%) stddev-sans-first:2.06 11:19:57 INFO - PROCESS | 16558 | Values: 159.0 163.0 161.0 161.0 161.0 163.0 165.0 164.0 167.0 162.0 11:19:57 INFO - PROCESS | 16558 | 11:19:57 INFO - PROCESS | 16558 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:63.00 stddev:3.31 (5.3%) stddev-sans-first:3.50 11:19:57 INFO - PROCESS | 16558 | Values: 63.0 64.0 73.0 63.0 63.0 64.0 63.0 63.0 62.0 61.0 11:19:57 INFO - PROCESS | 16558 | -------- Summary: end -------- 11:19:57 INFO - PROCESS | 16558 | 11:19:58 INFO - TEST-INFO | 16558: exit 0 11:19:58 INFO - TEST-OK | kraken | took 61273ms 11:19:58 INFO - SUITE-END | took 1174s 11:19:59 INFO - Completed test suite (00:19:35) 11:19:59 INFO - javascript benchmark 11:19:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3160.8577614007368, 3166.841657917105, 3207.16613680443, 3228.24136327963, 3249.3826173027123, 5167.328247327842, 5209.687418754877, 5335.173048177534, 5415.64798288111, 5463.808766693167, 5275.709835959021, 5282.630215884889, 5327.946720532794, 5353.170258609912, 5428.077226871432, 4768.237082066861, 4774.832880849171, 4840.709557426548, 4842.66101372904, 4917.508249175072, 4895.6083513318845, 4905.950940490585, 4909.950900491003, 4912.238603016538, 4956.7025978441225, 4730.6925049871825, 4765.451973023112, 4794.544518270759, 4911.82808601699, 4966.15575352191, 4842.0, 4846.830360937351, 4849.321095046696, 4851.611871050308, 4852.199387101124, 4745.762711864393, 4818.831340903087, 4820.879478013043, 4833.734144622044, 4854.393200849894, 5094.5160209780015, 5095.184770436749, 5144.5369916707305, 5252.0, 5268.473152684739, 5603.7478313475995, 5661.377248502661, 5665.773369065232, 5672.716364181816, 5675.262215911905, 5529.806456773994, 5569.443055694439, 5601.467860553241, 5605.047141985872, 5741.339745929188, 5318.22885681574, 5368.30212072432, 5371.75827087782, 5377.462253774591, 5391.946080539223, 5476.123820188751, 5835.212246346774, 5835.562332825055, 5837.270341207349, 5843.3864444233595, 5525.917111243334, 5595.160725891067, 5606.85982850432, 5636.18275350072, 5672.659640421588, 5712.914306285409, 5715.457031581993, 5726.141078838207, 5744.942550574524, 5792.7103644818435, 5513.669179849142, 5618.297712785902, 5694.373618901917, 5703.17303990919, 5703.429657034263, 5662.17898404729, 5703.515201207861, 5714.828555143269, 5725.828225153252, 5762.078067509262, 4351.369051487517, 4358.847440339573, 4363.170997510526, 4370.453693288339, 4399.450068741407, 3787.867424640124, 3802.08749900022, 3833.1758671885677, 3919.451276821247, 3934.901627459279, 5246.895062098737, 5299.33758280215, 5317.122674758699, 5331.280277162611, 5369.865753356119, 5670.092785154356, 5674.829755107354, 5676.744546495418, 5680.147977803363, 5713.22871412354, 5138.87152821175, 5304.946950530522, 5309.41596424393, 5339.679619222859, 5420.539254163361, 4918.631102667314, 4924.0890435268875, 4924.285978533164, 4930.11257973561, 4955.1576232039915, 6001.5198784097165, 6002.639841609517, 6005.819825405245, 6007.3992600739575, 6010.188624535719, 5530.585206109638, 5676.091825307931, 5734.397888221677, 5735.54115670737, 5811.854703632443, 5950.166976623363, 5964.9105263420215, 5966.433188847052, 5973.522118230618, 5975.133605627247, 5672.461116193955, 5682.431756824284, 5688.687122208153, 5689.971550142222, 5693.174489699053, 5487.094629386266, 5684.289463817023, 5715.685637289989, 5767.221425107557, 5813.273340832396, 5596.216529685766, 5636.577256705681, 5639.7744090237575, 5649.096144616841, 5656.915146272727, 5351.331083614548, 5629.577781666473, 5646.689432081275, 5647.3787883333625, 5648.0, 5430.70131142791, 5446.1558458439, 5480.342358916955, 5528.281323427928, 5537.9169312459535, 5619.381867994599, 5621.297337832771, 5652.095664693629, 5675.091985282335, 5685.914711279417, 5234.7906083756225, 5490.972545137249, 5520.282363292747, 5520.420355862577, 5534.1975413565615], "value": 5254.703707840058, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.6883214232174, 609.7896225802098, 611.4252602553596, 626.0609086370445, 640.8718256348732, 31729.206769830736, 32233.0, 34617.48073778895, 43255.0, 44193.0, 45640.0, 45932.311015334795, 46098.53901460984, 46184.53815461844, 46217.537824621744, 8672.566371681422, 8832.293416526663, 8846.734597962039, 8859.069797671249, 8859.335549833757, 8675.522846243486, 8863.734087977371, 8880.023197448276, 8891.644334226623, 8892.199702026815, 8944.731658050268, 8984.640614375417, 8992.505412202327, 8993.370464067519, 8999.23506501948, 8854.114588541159, 8889.199972002518, 8929.285657147477, 8929.955350223272, 8934.597943092576, 8795.912040879573, 8860.822783544358, 8865.778355541099, 8877.156670116394, 8885.111488851127, 41864.581354186375, 41977.79011104955, 42300.0, 42328.78835605833, 42396.0, 3576.910577235564, 4104.958950410517, 4173.08192197716, 4200.957990420087, 4308.310670292738, 32188.356232875445, 32298.0, 32498.0, 32518.69925202989, 32743.50884736731, 4133.545310015896, 4238.321868501056, 4295.72077814941, 4337.674674399401, 4370.497392799837, 235627.0, 236440.0, 236518.0, 237114.0, 237686.0, 58378.0, 58559.414405856245, 58630.413695862495, 58799.11801322983, 58956.0, 63463.682681586295, 63515.0, 63521.0, 63526.0, 63687.0, 16797.244124014447, 16860.57848553796, 16935.0, 16987.490375288762, 17006.319747209975, 13346.265955372548, 13462.394192261176, 13464.192148470927, 13483.19100853952, 13484.932575337256, 13484.528041518499, 14890.329935152944, 17809.7328540072, 17930.641387172185, 18066.90966545185, 6705.664716764142, 6742.797716068526, 6762.425193858478, 6779.610179913106, 6821.727130914807, 719.7438392005421, 1097.0017284271435, 1110.4225802582612, 1128.6794450492944, 1212.5271144253747, 32302.515462268086, 32408.0, 32501.51247731286, 32559.0, 32646.836765816493, 976.8534719792088, 1087.7443800706828, 1107.684309971654, 1144.9981266391908, 1151.2459339132881, 16259.512214633343, 16547.83452165463, 16598.25307861149, 16696.666066678597, 16778.412755553498, 547909.0, 554035.0, 554705.0, 555654.0, 556570.0, 54494.0, 55780.721096394256, 55881.44118558844, 55900.720496397254, 56047.43952560504, 1232.0697873105928, 1327.4159369877223, 1371.0539727588132, 1371.4788380415378, 1378.7656098463285, 29725.0, 33439.83280083584, 33608.32783344368, 33760.49359259564, 33823.0, 51329.23006154836, 52391.47608524018, 52468.212976804614, 52542.0, 52712.47287527076, 493372.0, 512202.0, 513764.0, 513844.0, 514385.0, 37228.62771372252, 41560.0, 41802.37296440495, 43048.83413990341, 43193.784031079646, 44418.0, 45090.77454612706, 45408.09183816371, 49133.75433122811, 49847.50152498428, 40772.388414174406, 42277.54449110129, 42367.788161059, 42376.57623423726, 42398.576014239465, 41550.58449415588, 42362.0, 42453.78773106238, 42965.355519666606, 44483.329250428236, 41327.0, 41444.055476607304, 41917.58082419137, 42045.0, 42474.787626062905, 35615.28769424545, 37611.62388376081, 37777.0, 38541.42187867128, 38603.2279354417, 28244.576331355456, 28293.0, 28351.29121771972, 28573.714262857105, 28685.0], "value": 20249.618308993588, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.81241004317917, 392.15881933253155, 397.3761194923967, 407.23236698822717, 419.17631853408045, 13769.311534423288, 16316.918415407936, 17808.465746027625, 19536.12087456066, 19557.608847823052, 14793.03845250058, 16837.32650693974, 17641.64716705665, 18134.81865181348, 18871.0, 5517.862053448665, 5684.090545512719, 5712.343080545749, 5713.14302854571, 5714.314282286132, 4060.8984775380554, 5522.3649280332875, 5658.575606829484, 5799.0, 6102.328743838197, 6152.0156774915795, 6168.105624684418, 6170.105334726462, 6171.59884607499, 6181.845453863667, 6083.78706745264, 6114.480269177126, 6228.22147231596, 6230.813075607739, 6234.127222188898, 5334.519893209591, 5518.944810551883, 5520.337559492847, 5521.558275337963, 5533.446655334475, 18852.81147188524, 18966.43100706981, 18988.5252868678, 19425.4172374829, 22407.0, 2218.389942765736, 2274.7725227477285, 2301.6777651128855, 2356.8232382571205, 2952.5571164325306, 12761.808572871414, 13099.934500327437, 13935.58193254204, 14404.927975360057, 14448.0, 1902.2200897631903, 1947.4157752674141, 1984.900754962246, 2005.3382383813453, 2027.5133967847758, 76169.23830761678, 77440.61279693621, 77487.0, 80085.59957200177, 82031.0, 10107.292489525662, 10273.897261027294, 10301.9484902575, 10459.84310235347, 10475.47622618866, 14330.49843255481, 14456.783148252785, 14465.566033018817, 14528.128312301296, 14530.273486325641, 8000.239977202156, 8261.545614991233, 8327.292180164633, 8414.326853851677, 8454.535000575028, 7932.246436588515, 8013.2387423194705, 8034.276915077671, 8120.918790812135, 8135.3898457615915, 5700.942990570041, 6023.6385816851125, 6290.528210384239, 6492.285848556655, 6537.627098309314, 1889.6976483762533, 1935.6032013437211, 1962.077823422989, 1968.4586738646701, 1985.900704964746, 865.0614083719109, 940.5297351324338, 959.822432849925, 1015.137133436573, 1048.7640280936728, 17958.371456998942, 18328.266869325078, 18681.719774203397, 18782.248710051717, 18985.810141898404, 970.3983530211173, 1006.2654262388497, 1006.6476733143342, 1045.2996492350144, 1084.7233955341337, 10457.222272213741, 10802.542473565316, 10894.541753762853, 10897.813645489046, 10918.1811364148, 434142.0, 434411.0, 443501.0, 443752.0, 478630.0, 51578.48421515812, 65320.34679653238, 79960.60019699864, 80558.19441805624, 80876.19123808686, 1004.3973615830444, 1025.7948410317965, 1034.524118905297, 1050.1074087025968, 1061.851340812287, 16564.668706626042, 16568.420105296256, 16850.241739121524, 16851.24169412355, 17005.48983530496, 27245.86377068181, 35284.294314114086, 39098.0, 39612.207755844145, 39950.2009959805, 49468.505314947826, 51548.0, 51806.48193518168, 52017.479825202776, 52023.73988130035, 6198.256209254918, 7937.563434011185, 8090.110087890445, 8134.75595732129, 8315.750527484186, 12454.128211025503, 12472.314022728837, 12648.810267845805, 12806.87193128094, 12879.806802897776, 10863.402512861869, 11229.606963756229, 11453.541858325907, 11461.885381146081, 11548.538058477567, 10991.39547324873, 11155.49800258974, 11169.162312826407, 11398.886011139783, 11447.713807154887, 11309.547618095185, 11353.48909299067, 11485.081193504333, 11579.42102894835, 11610.593629222936, 8184.0, 8271.627776750182, 8291.709790157316, 8491.405601607828, 8533.146685331665, 11226.719332016764, 11270.436478175894, 11288.32270063766, 11343.716407089889, 11388.259763115371], "value": 9039.240317645792, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1353.688651610129, 1499.108030721721, 1512.8411516790736, 1672.2809192047423, 1853.0456814740403, 8271.793205169866, 8625.353098517613, 8627.439216450926, 8892.688755893545, 8906.643734250638, 8577.957110214456, 8665.046844847062, 8740.169683880036, 8742.213200811926, 8762.0, 1955.7359756432913, 2223.9332820015343, 2323.7211534615826, 2329.8136149108113, 2350.2596682045187, 2318.733345665253, 2368.4078980254935, 2369.099742098, 2369.3484291819714, 2371.620540713486, 2273.9090436382526, 2320.164740693349, 2321.5240875620457, 2323.326235391743, 2329.790318871301, 1950.161430584848, 2228.097620463715, 2305.020366344297, 2307.676925230469, 2321.7794309540736, 2239.540894116702, 2267.0591704442636, 2272.2388000020014, 2275.419767959176, 2279.0, 8835.072317406644, 8846.911530884674, 8861.379703420764, 8886.066962968924, 8890.511021893793, 5125.154349532323, 5258.2638430619745, 5260.079486089919, 5261.237120617528, 5265.631405801595, 3176.993224209369, 3265.510173473974, 3275.901722948315, 3286.079897628668, 3335.382954153489, 1091.8307662312354, 1103.1064837481586, 1124.5333186727498, 1129.2772625519674, 1131.3325138168439, 12324.383780810924, 12487.75024499514, 12572.937135314356, 12584.874151258462, 12639.115261931669, 4476.731396116244, 4602.930956035662, 4666.440027196758, 4736.100140973204, 4747.382840230748, 10605.89394106049, 10623.681289561326, 10648.946755266174, 10666.839997400046, 10675.893241067646, 4620.330052142421, 5218.504242096995, 5281.894362112736, 5282.498162674539, 5285.762140703678, 4677.158111539888, 4828.517148285144, 4844.781984810692, 4847.878803029882, 4856.053069651454, 4017.5091443305337, 4071.368937814584, 4115.312721784054, 4258.041940563348, 4270.08193238449, 1261.4386597964, 1286.5561381323428, 1292.3409061378763, 1306.5427100514935, 1325.5228117877557, 816.8570500162448, 902.9683961061463, 918.196577994255, 925.144241576539, 963.7349728824629, 5841.707914604252, 6002.608526182693, 6063.575549711566, 6069.3627169147485, 6089.147519347206, 986.3785814936545, 995.2038369304528, 995.6266400099962, 1006.8187726209206, 1022.2639699416409, 4140.37894315855, 4168.374743788456, 4170.687198460067, 4180.456540649696, 4233.216854881856, 11030.338179709242, 11269.436528173559, 11372.772544549229, 11373.431328433546, 11397.430128493708, 11097.722556936142, 11212.49543770516, 11213.71965700864, 11220.719482012852, 11232.550697972152, 7880.64537095832, 8173.223543763214, 8422.78943026417, 8467.66129354819, 8529.232369086812, 6149.938500615115, 6258.186435763321, 6259.718312675849, 6361.840953976188, 6387.808365749035, 9998.500074996367, 10296.227782916461, 10457.529411176667, 10493.737656558647, 10502.78994420092, 9868.111869931741, 10204.285700001226, 10562.577496900038, 10581.52383142745, 10586.576536938745, 6953.721851125898, 7628.313451789366, 7890.48711833729, 7929.563873986755, 8092.433529652868, 8796.120387961153, 8808.911910881065, 8879.0, 8894.42186257891, 8899.021107678022, 7605.961970190114, 7894.407919406182, 7914.485558438683, 7936.246056624612, 7987.64055617487, 7671.38628909697, 7719.845603088019, 7731.304182623591, 7859.528428294092, 7881.211878812073, 7182.928170718435, 7211.3870321023305, 7250.166230883516, 7255.310745479171, 7257.891131632924, 5004.724740139327, 5114.1305977984575, 5253.973730131325, 5258.447862974485, 5341.439148889466, 5195.168772996453, 5203.401608814884, 5305.920411193758, 5329.920051199313, 5444.673319600836], "value": 4681.5000489190825, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.91532328609634, 313.49840255591056, 315.31261849168806, 320.349690129038, 323.5163430671147, 5217.321748172737, 5273.393559740631, 5281.973590132044, 5314.52169304763, 5361.142217245232, 5224.555912747412, 5269.0, 5281.947180528194, 5286.735663216843, 5292.417834038252, 3878.8448462061483, 3929.4695216145883, 4082.5509193988787, 4090.611391917778, 4103.138340948404, 4019.1559772447677, 4078.143589846121, 4091.8747344480207, 4092.7544347339253, 4094.815733291994, 3874.3607304794814, 4046.6358027777496, 4047.271491131595, 4050.453188819516, 4067.8169482373214, 3884.7280690351686, 4031.536373317062, 4063.2889244382113, 4067.5118985721606, 4073.551909289976, 3544.291141771656, 3547.219611685425, 3553.400969563707, 3557.324108419392, 3561.12752375667, 4977.9751101244265, 5006.499350065001, 5034.4713805050305, 5041.042201981649, 5041.9747901260625, 4526.8868278292975, 4575.519570445122, 4588.197065513556, 4595.540445955377, 4634.884127896796, 5426.806102657409, 5436.565074794007, 5489.286392768914, 5498.862528436781, 5501.312335958005, 3895.8831235062994, 3898.649121579043, 3905.1018265799025, 3910.960890391088, 3925.960740392588, 5422.91865622016, 5605.747741351649, 5628.971855140739, 5636.998865402764, 5664.405237450091, 3909.179072394829, 3930.9803450983136, 3931.7051221158526, 3931.724779265424, 3932.134930315326, 3959.7822119783114, 3962.3660214365564, 3978.3435733104293, 4004.3192657248337, 4011.1777085697363, 4476.216662084187, 4563.520830312836, 4597.126545956257, 4622.705642420127, 4624.398828152386, 5438.211459338374, 5441.211024401439, 5455.699936503531, 5475.6440831345835, 5486.643368181056, 1391.325207274471, 1391.4016972701634, 1395.162902258657, 1398.2030242761732, 1398.3427788939182, 878.1789027259533, 901.756525738047, 907.491804589432, 956.3114557518714, 972.9416235025922, 5191.299174611455, 5197.792088316501, 5214.869628259248, 5232.3459567554055, 5237.214417837355, 5491.258680078138, 5528.364238112588, 5533.98009726447, 5540.36285827127, 5551.666899986014, 4999.010488818567, 5182.32629758129, 5187.377514698185, 5200.8959820803375, 5222.764975576109, 2927.638648028634, 2954.852257387122, 2955.0053713743137, 2982.373701522661, 2989.0, 5496.422875598005, 5707.600467967285, 5708.372079071299, 5737.475510775245, 5738.282714660668, 5631.211630371751, 5688.175214593861, 5689.2603961485565, 5696.487316141567, 5729.799457018984, 5662.8301150965535, 5672.602917795714, 5686.630369026, 5738.454846789548, 5748.223989761329, 5300.549453296513, 5553.222548843246, 5554.833354999357, 5580.214331413908, 5596.608237423341, 5437.918431223456, 5491.341039075336, 5493.7802487900035, 5501.889962200654, 5502.312210973629, 5710.942890571041, 5734.025215713422, 5770.13447982806, 5784.797532086357, 5791.160281759206, 3920.1963597463023, 4005.499312585927, 4009.258287216874, 4028.2144981728284, 4031.6090948622677, 5552.194931734795, 5556.361018482926, 5631.831045068655, 5634.52106570946, 5668.971655141698, 5325.600579956441, 5374.811881584125, 5417.864553386197, 5448.809291674773, 5457.508824205841, 5394.840109376503, 5401.6218864679095, 5417.83286685329, 5421.647592906448, 5428.809991650273, 5178.456262092426, 5223.7910483580235, 5263.947360526346, 5302.920456193237, 5320.308359913187, 5427.158790387496, 5428.37573679032, 5445.141300817103, 5449.264349312792, 5478.096114141282, 5312.688980293585, 5368.463153684756, 5372.489613486712, 5388.407275199804, 5397.59518036141], "value": 4140.812976298561, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [678.9083473731046, 730.9086364204475, 765.93489553388, 778.9104253010905, 842.4776638484141, 17066.402675906345, 17994.370197043107, 18024.279028838846, 18466.16902239399, 18766.906165469154, 16143.757843632326, 16596.83403165968, 16991.150442477887, 16993.150342482888, 17119.657606847857, 683.1017212365748, 827.1769589258666, 831.4221615976868, 834.8038211020405, 835.807764214231, 802.1016461563057, 820.1019883227856, 826.3554427546524, 831.0359982420393, 831.5468069901888, 875.9824803503926, 878.0429332028089, 878.2315473960285, 878.3280790195505, 879.1604018162672, 708.3129364516411, 834.8246868157634, 870.8606622940331, 870.8998465176522, 871.255076909243, 630.3885231325606, 630.713025573363, 632.3139393757779, 633.0788702437987, 637.1812221295659, 15876.206189690469, 15913.0, 15942.282597283034, 15945.362185512566, 15961.12213828239, 13165.60503184906, 13199.472021119143, 13452.260125693083, 13470.39383227757, 13721.931390342985, 13494.392752326168, 13494.730105397935, 13647.0, 13703.0, 13761.105528140639, 4435.645148388121, 4436.223660859337, 4490.640748740093, 4502.977485112586, 4707.905841883177, 76769.23230767733, 77744.61127694325, 77784.0, 78494.60752696257, 79495.20504794936, 10626.267469855347, 10699.0, 10735.57057717698, 10777.191710621735, 11218.495167717472, 20975.265865694626, 21041.0, 21085.051172697265, 21143.25998590042, 21176.15295388198, 8487.405881588353, 8526.78683032929, 8573.399862009599, 8736.519491428033, 8770.736877893672, 4338.761368124783, 4460.687751857404, 4495.662825288116, 4627.3521706961055, 4877.756112194376, 3339.816310102919, 3419.2990436960363, 3420.264643101745, 3428.6057103432927, 3470.774399664014, 606.535999960031, 609.3814778000333, 612.1735656863289, 616.5037145098149, 636.3604577399684, 509.5465036117858, 609.2080295615682, 610.0696437932189, 628.3182746719768, 650.0541711809307, 9328.34701570897, 9530.142287194185, 9722.805543889224, 9728.416295022322, 9910.950445247727, 655.6492276631978, 670.7618795327588, 673.7406098652054, 687.7833482453011, 704.7040243097911, 4332.155229730172, 5017.648764586444, 5409.918016396737, 5468.7539060742365, 5479.0959491683425, 73003.0, 86558.0, 112599.0, 119423.40288298503, 120046.39976800235, 66231.66884165548, 98624.50687746516, 102828.48585757172, 103337.48331258296, 104857.0, 84354.82258870565, 87154.0, 89236.10763892278, 89809.55095224612, 90589.54705226564, 10039.693198435938, 10298.3820970742, 10307.793844123225, 10364.844527332247, 10431.895681043092, 50554.74722626364, 50899.491005089476, 51113.0, 52470.73764631152, 52909.7354513225, 47921.520784791705, 59103.70448147732, 79412.60293698494, 80233.0, 80972.19027809646, 12595.685107872376, 12621.05342099328, 12950.417231224428, 13304.866951330363, 13555.254461004344, 13715.177089374669, 13840.515581954583, 14723.484678036217, 15140.848591514385, 15298.005629634039, 12817.615471535868, 12873.291968941798, 13174.60476185716, 13894.305284735925, 14608.853911461174, 14019.369128389042, 14120.646983825487, 14386.928065359607, 14643.487477938646, 15134.697306053597, 13738.450461981409, 13765.311734413039, 14203.928980355033, 14323.212223327817, 14849.40602375893, 10717.41054241993, 10841.837372439577, 11092.33445993243, 11369.658910232707, 11550.94224528872, 11138.498767555317, 11273.605423810128, 11627.6511704649, 11808.468618912342, 11814.0], "value": 7629.157474334898, "unit": "score"}], "name": "dromaeo_css", "value": 7225.175177770564, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 109.0, 109.0, 110.0, 109.0, 108.0, 109.0, 110.0, 108.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 125.0, 130.0, 185.0, 132.0, 156.0, 146.0, 127.0, 195.0, 133.0], "value": 147.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 161.0, 159.0, 159.0, 161.0, 162.0, 161.0, 161.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 114.0, 78.0, 76.0, 75.0, 75.0, 99.0, 75.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 86.0, 114.0, 85.0, 85.0, 85.0, 114.0, 83.0, 85.0, 133.0], "value": 96.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 118.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 147.0, 145.0, 146.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 55.0, 55.0, 54.0, 54.0, 55.0, 54.0, 53.0, 54.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 62.0, 62.0, 63.0, 61.0], "value": 62.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 83.0, 79.0, 83.0, 80.0, 80.0, 80.0, 81.0, 134.0, 79.0], "value": 85.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 124.0, 128.0, 121.0, 126.0, 124.0, 120.0, 124.0, 133.0, 137.0], "value": 125.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 163.0, 161.0, 161.0, 161.0, 163.0, 165.0, 164.0, 167.0, 162.0], "value": 162.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 73.0, 63.0, 63.0, 64.0, 63.0, 63.0, 62.0, 61.0], "value": 63.9, "unit": "score"}], "name": "kraken", "value": 1506.9, "alertThreshold": 2.0}]} 11:19:59 INFO - Return code: 0 11:19:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:19:59 ERROR - # TBPL SUCCESS # 11:19:59 INFO - Running post-action listener: _resource_record_post_action 11:19:59 INFO - ##### 11:19:59 INFO - ##### Finished run-tests step (success) 11:19:59 INFO - ##### 11:19:59 INFO - Running post-run listener: _resource_record_post_run 11:19:59 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 541380608; Read time: 220; Write time: 470988 11:19:59 INFO - TinderboxPrint: CPU usage
13.1% 11:19:59 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 220 11:19:59 INFO - TinderboxPrint: I/O write bytes / time
541,380,608 / 470,988 11:19:59 INFO - TinderboxPrint: CPU idle
8,270.6 (86.9%) 11:19:59 INFO - TinderboxPrint: CPU user
1,207.3 (12.7%) 11:19:59 INFO - TinderboxPrint: Swap in / out
0 / 0 11:19:59 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 248197120; Read time: 0; Write time: 232876 11:19:59 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292548608; Read time: 220; Write time: 238084 11:19:59 INFO - Running post-run listener: _upload_blobber_files 11:19:59 INFO - Blob upload gear active. 11:19:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:19:59 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:19:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:19:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:20:00 INFO - (blobuploader) - INFO - Open directory for files ... 11:20:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:20:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:20:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:20:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:20:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:20:00 INFO - (blobuploader) - INFO - Done attempting. 11:20:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:20:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:20:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:20:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:20:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:20:04 INFO - (blobuploader) - INFO - Done attempting. 11:20:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:20:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:20:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:20:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:20:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:20:05 INFO - (blobuploader) - INFO - Done attempting. 11:20:05 INFO - (blobuploader) - INFO - Iteration through files over. 11:20:05 INFO - Return code: 0 11:20:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:20:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:20:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a30b2cd8074c6b9156a6beddc39ab3ede525e23f4dd5028e915483a5de3851e0cda37c68da40d0865c386e8b775c88646b8b3c9bb61e8fe27504b2b0d3243dcc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/77dc4a2f6341617c6a3164ee1638342d773fd1c617b5e53b954e696600ac5f503189fcc5bfaacc3df67862ed396ce0f3828d7be8dcf4472c83efecc2e8fe1ec4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d69c1038084a732fdd9e194e5a8229f91d97954f113c7ec015f52ab56378e4e9c31ba5fb7f7af2e379005093ea84639481f032db151d363cd367efbb5fcae23c"} 11:20:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:20:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:20:05 INFO - Contents: 11:20:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a30b2cd8074c6b9156a6beddc39ab3ede525e23f4dd5028e915483a5de3851e0cda37c68da40d0865c386e8b775c88646b8b3c9bb61e8fe27504b2b0d3243dcc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/77dc4a2f6341617c6a3164ee1638342d773fd1c617b5e53b954e696600ac5f503189fcc5bfaacc3df67862ed396ce0f3828d7be8dcf4472c83efecc2e8fe1ec4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d69c1038084a732fdd9e194e5a8229f91d97954f113c7ec015f52ab56378e4e9c31ba5fb7f7af2e379005093ea84639481f032db151d363cd367efbb5fcae23c"} 11:20:05 INFO - Running post-run listener: copy_logs_to_upload_dir 11:20:05 INFO - Copying logs to upload dir... 11:20:05 INFO - mkdir: /builds/slave/test/build/upload/logs 11:20:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.675222 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-06-08 11:20:05.068639) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 11:20:05.072050) ========= 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=4300f881736b422476174874000001bc-1465408552.543183-2078388438 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/a30b2cd8074c6b9156a6beddc39ab3ede525e23f4dd5028e915483a5de3851e0cda37c68da40d0865c386e8b775c88646b8b3c9bb61e8fe27504b2b0d3243dcc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/77dc4a2f6341617c6a3164ee1638342d773fd1c617b5e53b954e696600ac5f503189fcc5bfaacc3df67862ed396ce0f3828d7be8dcf4472c83efecc2e8fe1ec4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d69c1038084a732fdd9e194e5a8229f91d97954f113c7ec015f52ab56378e4e9c31ba5fb7f7af2e379005093ea84639481f032db151d363cd367efbb5fcae23c"} build_url:https://queue.taskcluster.net/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011312 build_url: 'https://queue.taskcluster.net/v1/task/RWdkINQuSoCL6xaNjhlcHg/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/a30b2cd8074c6b9156a6beddc39ab3ede525e23f4dd5028e915483a5de3851e0cda37c68da40d0865c386e8b775c88646b8b3c9bb61e8fe27504b2b0d3243dcc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/77dc4a2f6341617c6a3164ee1638342d773fd1c617b5e53b954e696600ac5f503189fcc5bfaacc3df67862ed396ce0f3828d7be8dcf4472c83efecc2e8fe1ec4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d69c1038084a732fdd9e194e5a8229f91d97954f113c7ec015f52ab56378e4e9c31ba5fb7f7af2e379005093ea84639481f032db151d363cd367efbb5fcae23c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 11:20:05.098060) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 11:20:05.098457) ========= 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=4300f881736b422476174874000001bc-1465408552.543183-2078388438 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004416 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 11:20:05.180557) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 11:20:05.180878) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 11:20:05.181199) ========= ========= Total master_lag: 0.29 =========