builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-052 starttime: 1466597248.18 results: success (0) buildid: 20160622023033 builduid: e2a0309dcb61499e8896316cbf6a664b revision: a1746be133dff55de7588c846aaafbc30534b8bd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 05:07:28.181723) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 05:07:28.182311) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 05:07:28.182631) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 05:07:28.198912) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 05:07:28.199292) ========= 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=826874ccc97bd7bf541b4875000001d5-1466597247.999232-1222158116 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-22 05:07:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 87.9M=0s 2016-06-22 05:07:28 (87.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.083421 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 05:07:28.299105) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 05:07:28.299540) ========= 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=826874ccc97bd7bf541b4875000001d5-1466597247.999232-1222158116 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016441 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 05:07:28.353582) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 05:07:28.354156) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a1746be133dff55de7588c846aaafbc30534b8bd --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 a1746be133dff55de7588c846aaafbc30534b8bd --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=826874ccc97bd7bf541b4875000001d5-1466597247.999232-1222158116 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-22 05:07:28,913 truncating revision to first 12 chars 2016-06-22 05:07:28,913 Setting DEBUG logging. 2016-06-22 05:07:28,913 attempt 1/10 2016-06-22 05:07:28,913 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a1746be133df?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-22 05:07:29,223 unpacking tar archive at: fx-team-a1746be133df/testing/mozharness/ program finished with exit code 0 elapsedTime=0.706154 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 05:07:29.076481) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 05:07:29.077159) ========= script_repo_revision: a1746be133dff55de7588c846aaafbc30534b8bd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 05:07:29.077934) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 05:07:29.078588) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 05:07:29.090420) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-06-22 05:07:29.090727) ========= /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=826874ccc97bd7bf541b4875000001d5-1466597247.999232-1222158116 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:07:29 INFO - MultiFileLogger online at 20160622 05:07:29 in /builds/slave/test 05:07:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:07:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:07:29 INFO - {'append_to_log': False, 05:07:29 INFO - 'base_work_dir': '/builds/slave/test', 05:07:29 INFO - 'blob_upload_branch': 'Fx-Team', 05:07:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:07:29 INFO - 'branch': 'Fx-Team', 05:07:29 INFO - 'buildbot_json_path': 'buildprops.json', 05:07:29 INFO - 'config_files': ('talos/linux_config.py',), 05:07:29 INFO - 'default_actions': ('clobber', 05:07:29 INFO - 'read-buildbot-config', 05:07:29 INFO - 'download-and-extract', 05:07:29 INFO - 'populate-webroot', 05:07:29 INFO - 'create-virtualenv', 05:07:29 INFO - 'install', 05:07:29 INFO - 'run-tests'), 05:07:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:07:29 INFO - 'download_minidump_stackwalk': True, 05:07:29 INFO - 'download_symbols': 'ondemand', 05:07:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:07:29 INFO - 'tooltool.py': '/tools/tooltool.py', 05:07:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:07:29 INFO - '/tools/misc-python/virtualenv.py')}, 05:07:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:07:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:07:29 INFO - 'installer_path': 'installer.exe', 05:07:29 INFO - 'log_level': 'info', 05:07:29 INFO - 'log_name': 'talos', 05:07:29 INFO - 'log_to_console': True, 05:07:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:07:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:07:29 INFO - 'opt_config_files': (), 05:07:29 INFO - 'pip_index': False, 05:07:29 INFO - 'sps_profile': False, 05:07:29 INFO - 'sps_profile_interval': 0, 05:07:29 INFO - 'suite': 'dromaeojs', 05:07:29 INFO - 'system_bits': '32', 05:07:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:07:29 INFO - 'title': 'talos-linux64-ix-052', 05:07:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:07:29 INFO - 'use_talos_json': True, 05:07:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:07:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:07:29 INFO - 'work_dir': 'build'} 05:07:29 INFO - ##### 05:07:29 INFO - ##### Running clobber step. 05:07:29 INFO - ##### 05:07:29 INFO - Running pre-action listener: _resource_record_pre_action 05:07:29 INFO - Running main action method: clobber 05:07:29 INFO - rmtree: /builds/slave/test/build 05:07:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:07:30 INFO - Running post-action listener: _resource_record_post_action 05:07:30 INFO - ##### 05:07:30 INFO - ##### Finished clobber step (success) 05:07:30 INFO - ##### 05:07:30 INFO - ##### 05:07:30 INFO - ##### Running read-buildbot-config step. 05:07:30 INFO - ##### 05:07:30 INFO - Running pre-action listener: _resource_record_pre_action 05:07:30 INFO - Running main action method: read_buildbot_config 05:07:30 INFO - Using buildbot properties: 05:07:30 INFO - { 05:07:30 INFO - "project": "", 05:07:30 INFO - "product": "firefox", 05:07:30 INFO - "script_repo_revision": "production", 05:07:30 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:07:30 INFO - "repository": "", 05:07:30 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:07:30 INFO - "buildid": "20160622023033", 05:07:30 INFO - "pgo_build": "True", 05:07:30 INFO - "basedir": "/builds/slave/test", 05:07:30 INFO - "buildnumber": 1274, 05:07:30 INFO - "slavename": "talos-linux64-ix-052", 05:07:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:07:30 INFO - "platform": "ubuntu64_hw", 05:07:30 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:07:30 INFO - "branch": "fx-team", 05:07:30 INFO - "repo_path": "integration/fx-team", 05:07:30 INFO - "revision": "a1746be133dff55de7588c846aaafbc30534b8bd", 05:07:30 INFO - "stage_platform": "linux64-pgo", 05:07:30 INFO - "builduid": "e2a0309dcb61499e8896316cbf6a664b", 05:07:30 INFO - "slavebuilddir": "test" 05:07:30 INFO - } 05:07:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:07:30 INFO - Running post-action listener: _resource_record_post_action 05:07:30 INFO - ##### 05:07:30 INFO - ##### Finished read-buildbot-config step (success) 05:07:30 INFO - ##### 05:07:30 INFO - ##### 05:07:30 INFO - ##### Running download-and-extract step. 05:07:30 INFO - ##### 05:07:30 INFO - Running pre-action listener: _resource_record_pre_action 05:07:30 INFO - Running main action method: download_and_extract 05:07:30 INFO - mkdir: /builds/slave/test/build/tests 05:07:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:30 INFO - https://queue.taskcluster.net/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:07:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:07:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:07:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:07:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:07:31 INFO - Downloaded 1361 bytes. 05:07:31 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:07:31 INFO - Using the following test package requirements: 05:07:31 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:07:31 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:07:31 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:07:31 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:31 INFO - u'jsshell-linux-x86_64.zip'], 05:07:31 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:07:31 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:07:31 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:07:31 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:07:31 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:07:31 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:07:31 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:07:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:31 INFO - https://queue.taskcluster.net/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:07:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:07:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:07:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:07:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:07:34 INFO - Downloaded 24268127 bytes. 05:07:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:07:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:07:35 INFO - Return code: 0 05:07:35 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:07:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:35 INFO - https://queue.taskcluster.net/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:07:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:07:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:07:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:07:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:07:36 INFO - Downloaded 24268127 bytes. 05:07:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:07:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:07:38 INFO - Return code: 0 05:07:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:38 INFO - https://queue.taskcluster.net/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:07:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:07:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:07:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:07:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:07:40 INFO - Downloaded 14405384 bytes. 05:07:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:07:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:07:40 INFO - Return code: 0 05:07:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:40 INFO - https://queue.taskcluster.net/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:07:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:07:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:07:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:07:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:07:42 INFO - Downloaded 60133052 bytes. 05:07:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:07:42 INFO - mkdir: /builds/slave/test/properties 05:07:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:07:42 INFO - Writing to file /builds/slave/test/properties/build_url 05:07:42 INFO - Contents: 05:07:42 INFO - build_url:https://queue.taskcluster.net/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:07:43 INFO - Running post-action listener: _resource_record_post_action 05:07:43 INFO - Running post-action listener: set_extra_try_arguments 05:07:43 INFO - ##### 05:07:43 INFO - ##### Finished download-and-extract step (success) 05:07:43 INFO - ##### 05:07:43 INFO - ##### 05:07:43 INFO - ##### Running populate-webroot step. 05:07:43 INFO - ##### 05:07:43 INFO - Running pre-action listener: _resource_record_pre_action 05:07:43 INFO - Running main action method: populate_webroot 05:07:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:07:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:07:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:07:43 INFO - '--tppagecycles', 05:07:43 INFO - '7'], 05:07:43 INFO - 'tests': ['tsvgm']}}, 05:07:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:07:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:07:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:07:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:07:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:07:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:07:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:43 INFO - 'talos_options': ['--disable-e10s'], 05:07:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:07:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:07:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:43 INFO - 'talos_options': ['--disable-e10s'], 05:07:43 INFO - 'tests': ['damp', 'tps']}, 05:07:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:43 INFO - 'tests': ['damp', 'tps']}, 05:07:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:07:43 INFO - 'tests': ['dromaeo_dom']}, 05:07:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:07:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:07:43 INFO - 'tests': ['basic_compositor_video']}, 05:07:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:07:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:07:43 INFO - 'tests': ['a11yr', 05:07:43 INFO - 'ts_paint', 05:07:43 INFO - 'tpaint', 05:07:43 INFO - 'sessionrestore', 05:07:43 INFO - 'sessionrestore_no_auto_restore', 05:07:43 INFO - 'tabpaint']}, 05:07:43 INFO - 'other-e10s': {'tests': ['a11yr', 05:07:43 INFO - 'ts_paint', 05:07:43 INFO - 'tpaint', 05:07:43 INFO - 'sessionrestore', 05:07:43 INFO - 'sessionrestore_no_auto_restore', 05:07:43 INFO - 'tabpaint']}, 05:07:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:07:43 INFO - 'ts_paint', 05:07:43 INFO - 'tpaint', 05:07:43 INFO - 'sessionrestore', 05:07:43 INFO - 'sessionrestore_no_auto_restore', 05:07:43 INFO - 'tabpaint']}, 05:07:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:07:43 INFO - 'ts_paint', 05:07:43 INFO - 'tpaint', 05:07:43 INFO - 'sessionrestore', 05:07:43 INFO - 'sessionrestore_no_auto_restore', 05:07:43 INFO - 'tabpaint']}, 05:07:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:07:43 INFO - 'tests': ['a11yr', 05:07:43 INFO - 'ts_paint', 05:07:43 INFO - 'tpaint', 05:07:43 INFO - 'sessionrestore', 05:07:43 INFO - 'sessionrestore_no_auto_restore', 05:07:43 INFO - 'tabpaint']}, 05:07:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:07:43 INFO - 'tests': ['a11yr', 05:07:43 INFO - 'ts_paint', 05:07:43 INFO - 'tpaint', 05:07:43 INFO - 'sessionrestore', 05:07:43 INFO - 'sessionrestore_no_auto_restore', 05:07:43 INFO - 'tabpaint']}, 05:07:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:07:43 INFO - 'tests': ['tsvgx', 05:07:43 INFO - 'tsvgr_opacity', 05:07:43 INFO - 'tart', 05:07:43 INFO - 'tscrollx', 05:07:43 INFO - 'cart']}, 05:07:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:07:43 INFO - 'tsvgr_opacity', 05:07:43 INFO - 'tart', 05:07:43 INFO - 'tscrollx', 05:07:43 INFO - 'cart']}, 05:07:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:43 INFO - 'talos_options': ['--disable-e10s'], 05:07:43 INFO - 'tests': ['tp5o']}, 05:07:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:43 INFO - 'tests': ['tp5o']}, 05:07:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:43 INFO - 'talos_options': ['--disable-e10s', 05:07:43 INFO - '--xperf_path', 05:07:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:07:43 INFO - 'tests': ['tp5n']}, 05:07:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:43 INFO - 'talos_options': ['--xperf_path', 05:07:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:07:43 INFO - 'tests': ['tp5n']}}, 05:07:43 INFO - 'talos.zip': {'path': '', 05:07:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:07:43 INFO - Running post-action listener: _resource_record_post_action 05:07:43 INFO - ##### 05:07:43 INFO - ##### Finished populate-webroot step (success) 05:07:43 INFO - ##### 05:07:43 INFO - ##### 05:07:43 INFO - ##### Running create-virtualenv step. 05:07:43 INFO - ##### 05:07:43 INFO - Running pre-action listener: _resource_record_pre_action 05:07:43 INFO - Running main action method: create_virtualenv 05:07:43 INFO - Creating virtualenv /builds/slave/test/build/venv 05:07:43 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:07:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:07:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:07:43 INFO - Using real prefix '/usr' 05:07:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:07:43 INFO - Installing distribute.............................................................................................................................................................................................done. 05:07:45 INFO - Installing pip.................done. 05:07:45 INFO - Return code: 0 05:07:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:07:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2115abff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22bd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234c1c0>, '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 0x234d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x234d550>, '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': '826874ccc97bd7bf541b4875000001d5-1466597247.999232-1222158116', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:07:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:07:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:07:45 INFO - Using env: {'DISPLAY': ':0', 05:07:45 INFO - 'HOME': '/home/cltbld', 05:07:45 INFO - 'LANG': 'en_US.UTF-8', 05:07:45 INFO - 'LANGUAGE': 'en_US:en', 05:07:45 INFO - 'LOGNAME': 'cltbld', 05:07:45 INFO - 'MAIL': '/var/mail/cltbld', 05:07:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:45 INFO - 'MOZ_NO_REMOTE': '1', 05:07:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:45 INFO - 'NO_EM_RESTART': '1', 05:07:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:45 INFO - 'PWD': '/builds/slave/test', 05:07:45 INFO - 'SHELL': '/bin/bash', 05:07:45 INFO - 'SHLVL': '1', 05:07:45 INFO - 'TERM': 'linux', 05:07:45 INFO - 'TMOUT': '86400', 05:07:45 INFO - 'USER': 'cltbld', 05:07:45 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466597247.999232-1222158116', 05:07:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:45 INFO - '_': '/tools/buildbot/bin/python'} 05:07:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:45 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:07:45 INFO - Cleaning up... 05:07:46 INFO - Return code: 0 05:07:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:07:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2115abff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22bd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234c1c0>, '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 0x234d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x234d550>, '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': '826874ccc97bd7bf541b4875000001d5-1466597247.999232-1222158116', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:07:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:07:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:07:46 INFO - Using env: {'DISPLAY': ':0', 05:07:46 INFO - 'HOME': '/home/cltbld', 05:07:46 INFO - 'LANG': 'en_US.UTF-8', 05:07:46 INFO - 'LANGUAGE': 'en_US:en', 05:07:46 INFO - 'LOGNAME': 'cltbld', 05:07:46 INFO - 'MAIL': '/var/mail/cltbld', 05:07:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:46 INFO - 'MOZ_NO_REMOTE': '1', 05:07:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:46 INFO - 'NO_EM_RESTART': '1', 05:07:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:46 INFO - 'PWD': '/builds/slave/test', 05:07:46 INFO - 'SHELL': '/bin/bash', 05:07:46 INFO - 'SHLVL': '1', 05:07:46 INFO - 'TERM': 'linux', 05:07:46 INFO - 'TMOUT': '86400', 05:07:46 INFO - 'USER': 'cltbld', 05:07:46 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466597247.999232-1222158116', 05:07:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:46 INFO - '_': '/tools/buildbot/bin/python'} 05:07:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:46 INFO - Downloading/unpacking psutil>=3.1.1 05:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:07:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:07:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:07:48 INFO - Installing collected packages: psutil 05:07:48 INFO - Running setup.py install for psutil 05:07:48 INFO - building 'psutil._psutil_linux' extension 05:07:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:07:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:07:48 INFO - building 'psutil._psutil_posix' extension 05:07:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:07:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:07:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:07:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:07:48 INFO - Successfully installed psutil 05:07:48 INFO - Cleaning up... 05:07:48 INFO - Return code: 0 05:07:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:07:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2115abff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22bd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234c1c0>, '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 0x234d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x234d550>, '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': '826874ccc97bd7bf541b4875000001d5-1466597247.999232-1222158116', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:07:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:07:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:07:48 INFO - Using env: {'DISPLAY': ':0', 05:07:48 INFO - 'HOME': '/home/cltbld', 05:07:48 INFO - 'LANG': 'en_US.UTF-8', 05:07:48 INFO - 'LANGUAGE': 'en_US:en', 05:07:48 INFO - 'LOGNAME': 'cltbld', 05:07:48 INFO - 'MAIL': '/var/mail/cltbld', 05:07:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:48 INFO - 'MOZ_NO_REMOTE': '1', 05:07:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:48 INFO - 'NO_EM_RESTART': '1', 05:07:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:48 INFO - 'PWD': '/builds/slave/test', 05:07:48 INFO - 'SHELL': '/bin/bash', 05:07:48 INFO - 'SHLVL': '1', 05:07:48 INFO - 'TERM': 'linux', 05:07:48 INFO - 'TMOUT': '86400', 05:07:48 INFO - 'USER': 'cltbld', 05:07:48 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466597247.999232-1222158116', 05:07:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:48 INFO - '_': '/tools/buildbot/bin/python'} 05:07:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:07:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:07:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:07:50 INFO - Installing collected packages: mozsystemmonitor 05:07:50 INFO - Running setup.py install for mozsystemmonitor 05:07:50 INFO - Successfully installed mozsystemmonitor 05:07:50 INFO - Cleaning up... 05:07:51 INFO - Return code: 0 05:07:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2115abff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22bd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234c1c0>, '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 0x234d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x234d550>, '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': '826874ccc97bd7bf541b4875000001d5-1466597247.999232-1222158116', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:07:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:07:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:07:51 INFO - Using env: {'DISPLAY': ':0', 05:07:51 INFO - 'HOME': '/home/cltbld', 05:07:51 INFO - 'LANG': 'en_US.UTF-8', 05:07:51 INFO - 'LANGUAGE': 'en_US:en', 05:07:51 INFO - 'LOGNAME': 'cltbld', 05:07:51 INFO - 'MAIL': '/var/mail/cltbld', 05:07:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:51 INFO - 'MOZ_NO_REMOTE': '1', 05:07:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:51 INFO - 'NO_EM_RESTART': '1', 05:07:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:51 INFO - 'PWD': '/builds/slave/test', 05:07:51 INFO - 'SHELL': '/bin/bash', 05:07:51 INFO - 'SHLVL': '1', 05:07:51 INFO - 'TERM': 'linux', 05:07:51 INFO - 'TMOUT': '86400', 05:07:51 INFO - 'USER': 'cltbld', 05:07:51 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466597247.999232-1222158116', 05:07:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:51 INFO - '_': '/tools/buildbot/bin/python'} 05:07:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:51 INFO - Downloading/unpacking jsonschema==2.5.1 05:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:07:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:07: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 05:07: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 05:07: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 05:07: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 05:07: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 05:07: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 05:07:53 INFO - Downloading functools32-3.2.3-2.tar.gz 05:07:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:07:53 INFO - warning: no files found matching '*.txt' 05:07:53 INFO - no previously-included directories found matching 'build' 05:07:53 INFO - no previously-included directories found matching 'dist' 05:07:53 INFO - no previously-included directories found matching '.git*' 05:07:53 INFO - Installing collected packages: jsonschema, functools32 05:07:53 INFO - Running setup.py install for functools32 05:07:53 INFO - warning: no files found matching '*.txt' 05:07:53 INFO - no previously-included directories found matching 'build' 05:07:53 INFO - no previously-included directories found matching 'dist' 05:07:53 INFO - no previously-included directories found matching '.git*' 05:07:53 INFO - Successfully installed jsonschema functools32 05:07:53 INFO - Cleaning up... 05:07:53 INFO - Return code: 0 05:07:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:07:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2115abff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22bd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234c1c0>, '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 0x234d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x234d550>, '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': '826874ccc97bd7bf541b4875000001d5-1466597247.999232-1222158116', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:07:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:07:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:07:53 INFO - Using env: {'DISPLAY': ':0', 05:07:53 INFO - 'HOME': '/home/cltbld', 05:07:53 INFO - 'LANG': 'en_US.UTF-8', 05:07:53 INFO - 'LANGUAGE': 'en_US:en', 05:07:53 INFO - 'LOGNAME': 'cltbld', 05:07:53 INFO - 'MAIL': '/var/mail/cltbld', 05:07:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:53 INFO - 'MOZ_NO_REMOTE': '1', 05:07:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:53 INFO - 'NO_EM_RESTART': '1', 05:07:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:53 INFO - 'PWD': '/builds/slave/test', 05:07:53 INFO - 'SHELL': '/bin/bash', 05:07:53 INFO - 'SHLVL': '1', 05:07:53 INFO - 'TERM': 'linux', 05:07:53 INFO - 'TMOUT': '86400', 05:07:53 INFO - 'USER': 'cltbld', 05:07:53 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466597247.999232-1222158116', 05:07:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:53 INFO - '_': '/tools/buildbot/bin/python'} 05:07:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:53 INFO - Downloading/unpacking blobuploader==1.2.4 05:07: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 05:07: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 05:07: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 05:07: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 05:07: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 05:07: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 05:07:55 INFO - Downloading blobuploader-1.2.4.tar.gz 05:07:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:07:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:07:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:56 INFO - Downloading docopt-0.6.1.tar.gz 05:07:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:07:56 INFO - Installing collected packages: blobuploader, requests, docopt 05:07:56 INFO - Running setup.py install for blobuploader 05:07:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:07:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:07:56 INFO - Running setup.py install for requests 05:07:56 INFO - Running setup.py install for docopt 05:07:57 INFO - Successfully installed blobuploader requests docopt 05:07:57 INFO - Cleaning up... 05:07:57 INFO - Return code: 0 05:07:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:07:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2115abff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22bd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234c1c0>, '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 0x234d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x234d550>, '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': '826874ccc97bd7bf541b4875000001d5-1466597247.999232-1222158116', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:07:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:07:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:07:57 INFO - Using env: {'DISPLAY': ':0', 05:07:57 INFO - 'HOME': '/home/cltbld', 05:07:57 INFO - 'LANG': 'en_US.UTF-8', 05:07:57 INFO - 'LANGUAGE': 'en_US:en', 05:07:57 INFO - 'LOGNAME': 'cltbld', 05:07:57 INFO - 'MAIL': '/var/mail/cltbld', 05:07:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:57 INFO - 'MOZ_NO_REMOTE': '1', 05:07:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:57 INFO - 'NO_EM_RESTART': '1', 05:07:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:57 INFO - 'PWD': '/builds/slave/test', 05:07:57 INFO - 'SHELL': '/bin/bash', 05:07:57 INFO - 'SHLVL': '1', 05:07:57 INFO - 'TERM': 'linux', 05:07:57 INFO - 'TMOUT': '86400', 05:07:57 INFO - 'USER': 'cltbld', 05:07:57 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466597247.999232-1222158116', 05:07:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:57 INFO - '_': '/tools/buildbot/bin/python'} 05:07:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:07:57 INFO - Running setup.py (path:/tmp/pip-TvEHmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:07:57 INFO - Running setup.py (path:/tmp/pip-enD0wh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:07:57 INFO - Running setup.py (path:/tmp/pip-FghrfK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:07:57 INFO - Running setup.py (path:/tmp/pip-Ti6UO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:07:57 INFO - Running setup.py (path:/tmp/pip-AOtDsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:07:57 INFO - Running setup.py (path:/tmp/pip-FS31e9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:07:57 INFO - Running setup.py (path:/tmp/pip-YlIGzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:07:57 INFO - Running setup.py (path:/tmp/pip-yJTgu2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:07:57 INFO - Running setup.py (path:/tmp/pip-Q4I3AM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:07:57 INFO - Running setup.py (path:/tmp/pip-bRVjUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:07:58 INFO - Running setup.py (path:/tmp/pip-GZm1FO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:07:58 INFO - Running setup.py (path:/tmp/pip-59HMvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:07:58 INFO - Running setup.py (path:/tmp/pip-vDK2H_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:07:58 INFO - Running setup.py (path:/tmp/pip-ozfWAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:07:58 INFO - Running setup.py (path:/tmp/pip-DnPQxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:07:58 INFO - Running setup.py (path:/tmp/pip-YJs8KI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:07:58 INFO - Running setup.py (path:/tmp/pip-AZlRNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:07:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:07:58 INFO - Running setup.py install for manifestparser 05:07:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:07:58 INFO - Running setup.py install for mozcrash 05:07:58 INFO - Running setup.py install for mozdebug 05:07:58 INFO - Running setup.py install for mozdevice 05:07:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:07:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:07:58 INFO - Running setup.py install for mozfile 05:07:59 INFO - Running setup.py install for mozhttpd 05:07:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:07:59 INFO - Running setup.py install for mozinfo 05:07:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:07:59 INFO - Running setup.py install for mozInstall 05:07:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:07:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:07:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:07:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:07:59 INFO - Running setup.py install for mozleak 05:07:59 INFO - Running setup.py install for mozlog 05:07:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:07:59 INFO - Running setup.py install for moznetwork 05:07:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:07:59 INFO - Running setup.py install for mozprocess 05:07:59 INFO - Running setup.py install for mozprofile 05:07:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:07:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:07:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:07:59 INFO - Running setup.py install for mozrunner 05:07:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:07:59 INFO - Running setup.py install for mozscreenshot 05:08:00 INFO - Running setup.py install for moztest 05:08:00 INFO - Running setup.py install for mozversion 05:08:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:08:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:08:00 INFO - Cleaning up... 05:08:00 INFO - Return code: 0 05:08:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2115abff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22bd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234c1c0>, '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 0x234d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x234d550>, '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': '826874ccc97bd7bf541b4875000001d5-1466597247.999232-1222158116', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:08:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:08:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:08:00 INFO - Using env: {'DISPLAY': ':0', 05:08:00 INFO - 'HOME': '/home/cltbld', 05:08:00 INFO - 'LANG': 'en_US.UTF-8', 05:08:00 INFO - 'LANGUAGE': 'en_US:en', 05:08:00 INFO - 'LOGNAME': 'cltbld', 05:08:00 INFO - 'MAIL': '/var/mail/cltbld', 05:08:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:00 INFO - 'MOZ_NO_REMOTE': '1', 05:08:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:00 INFO - 'NO_EM_RESTART': '1', 05:08:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:00 INFO - 'PWD': '/builds/slave/test', 05:08:00 INFO - 'SHELL': '/bin/bash', 05:08:00 INFO - 'SHLVL': '1', 05:08:00 INFO - 'TERM': 'linux', 05:08:00 INFO - 'TMOUT': '86400', 05:08:00 INFO - 'USER': 'cltbld', 05:08:00 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466597247.999232-1222158116', 05:08:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:00 INFO - '_': '/tools/buildbot/bin/python'} 05:08:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:08:00 INFO - Running setup.py (path:/tmp/pip-kyp4f6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:08:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:08:00 INFO - Running setup.py (path:/tmp/pip-AibaZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:08:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:08:00 INFO - Running setup.py (path:/tmp/pip-yrKMm6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:08:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:08:00 INFO - Running setup.py (path:/tmp/pip-XWS1_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:08:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:08:00 INFO - Running setup.py (path:/tmp/pip-6T5mfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:08:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:08:00 INFO - Running setup.py (path:/tmp/pip-iap2Yh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:08:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:08:00 INFO - Running setup.py (path:/tmp/pip-jmW4nQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:08:01 INFO - Running setup.py (path:/tmp/pip-qcU26v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:08:01 INFO - Running setup.py (path:/tmp/pip-GLDCL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:08:01 INFO - Running setup.py (path:/tmp/pip-eTbt5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:08:01 INFO - Running setup.py (path:/tmp/pip-00je2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:08:01 INFO - Running setup.py (path:/tmp/pip-2eB4G0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:08:01 INFO - Running setup.py (path:/tmp/pip-S17nvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:08:01 INFO - Running setup.py (path:/tmp/pip-NuXMty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:01 INFO - Running setup.py (path:/tmp/pip-0ycDAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:08:01 INFO - Running setup.py (path:/tmp/pip-TpUqzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:08:01 INFO - Running setup.py (path:/tmp/pip-ZxGSTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:08:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:03 INFO - Downloading blessings-1.6.tar.gz 05:08:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:08:03 INFO - Installing collected packages: blessings 05:08:03 INFO - Running setup.py install for blessings 05:08:03 INFO - Successfully installed blessings 05:08:03 INFO - Cleaning up... 05:08:03 INFO - Return code: 0 05:08:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:08:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:08:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:08:04 INFO - Reading from file tmpfile_stdout 05:08:04 INFO - Current package versions: 05:08:04 INFO - argparse == 1.2.1 05:08:04 INFO - blessings == 1.6 05:08:04 INFO - blobuploader == 1.2.4 05:08:04 INFO - docopt == 0.6.1 05:08:04 INFO - functools32 == 3.2.3-2 05:08:04 INFO - jsonschema == 2.5.1 05:08:04 INFO - manifestparser == 1.1 05:08:04 INFO - mozInstall == 1.12 05:08:04 INFO - mozcrash == 0.17 05:08:04 INFO - mozdebug == 0.1 05:08:04 INFO - mozdevice == 0.48 05:08:04 INFO - mozfile == 1.2 05:08:04 INFO - mozhttpd == 0.7 05:08:04 INFO - mozinfo == 0.9 05:08:04 INFO - mozleak == 0.1 05:08:04 INFO - mozlog == 3.2 05:08:04 INFO - moznetwork == 0.27 05:08:04 INFO - mozprocess == 0.22 05:08:04 INFO - mozprofile == 0.28 05:08:04 INFO - mozrunner == 6.11 05:08:04 INFO - mozscreenshot == 0.1 05:08:04 INFO - mozsystemmonitor == 0.3 05:08:04 INFO - moztest == 0.7 05:08:04 INFO - mozversion == 1.4 05:08:04 INFO - psutil == 3.1.1 05:08:04 INFO - requests == 1.2.3 05:08:04 INFO - wsgiref == 0.1.2 05:08:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2115abff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22bd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234c1c0>, '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 0x234d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x234d550>, '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': '826874ccc97bd7bf541b4875000001d5-1466597247.999232-1222158116', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:08:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:08:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:08:04 INFO - Using env: {'DISPLAY': ':0', 05:08:04 INFO - 'HOME': '/home/cltbld', 05:08:04 INFO - 'LANG': 'en_US.UTF-8', 05:08:04 INFO - 'LANGUAGE': 'en_US:en', 05:08:04 INFO - 'LOGNAME': 'cltbld', 05:08:04 INFO - 'MAIL': '/var/mail/cltbld', 05:08:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:04 INFO - 'MOZ_NO_REMOTE': '1', 05:08:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:04 INFO - 'NO_EM_RESTART': '1', 05:08:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:04 INFO - 'PWD': '/builds/slave/test', 05:08:04 INFO - 'SHELL': '/bin/bash', 05:08:04 INFO - 'SHLVL': '1', 05:08:04 INFO - 'TERM': 'linux', 05:08:04 INFO - 'TMOUT': '86400', 05:08:04 INFO - 'USER': 'cltbld', 05:08:04 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466597247.999232-1222158116', 05:08:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:04 INFO - '_': '/tools/buildbot/bin/python'} 05:08:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:08:04 INFO - Cleaning up... 05:08:04 INFO - Return code: 0 05:08:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2115abff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22bd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234c1c0>, '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 0x234d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x234d550>, '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': '826874ccc97bd7bf541b4875000001d5-1466597247.999232-1222158116', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:08:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:08:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:08:04 INFO - Using env: {'DISPLAY': ':0', 05:08:04 INFO - 'HOME': '/home/cltbld', 05:08:04 INFO - 'LANG': 'en_US.UTF-8', 05:08:04 INFO - 'LANGUAGE': 'en_US:en', 05:08:04 INFO - 'LOGNAME': 'cltbld', 05:08:04 INFO - 'MAIL': '/var/mail/cltbld', 05:08:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:04 INFO - 'MOZ_NO_REMOTE': '1', 05:08:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:04 INFO - 'NO_EM_RESTART': '1', 05:08:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:04 INFO - 'PWD': '/builds/slave/test', 05:08:04 INFO - 'SHELL': '/bin/bash', 05:08:04 INFO - 'SHLVL': '1', 05:08:04 INFO - 'TERM': 'linux', 05:08:04 INFO - 'TMOUT': '86400', 05:08:04 INFO - 'USER': 'cltbld', 05:08:04 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466597247.999232-1222158116', 05:08:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:04 INFO - '_': '/tools/buildbot/bin/python'} 05:08:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:08:04 INFO - Cleaning up... 05:08:04 INFO - Return code: 0 05:08:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2115abff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22bd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234c1c0>, '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 0x234d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x234d550>, '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': '826874ccc97bd7bf541b4875000001d5-1466597247.999232-1222158116', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:08:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:08:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:08:04 INFO - Using env: {'DISPLAY': ':0', 05:08:04 INFO - 'HOME': '/home/cltbld', 05:08:04 INFO - 'LANG': 'en_US.UTF-8', 05:08:04 INFO - 'LANGUAGE': 'en_US:en', 05:08:04 INFO - 'LOGNAME': 'cltbld', 05:08:04 INFO - 'MAIL': '/var/mail/cltbld', 05:08:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:04 INFO - 'MOZ_NO_REMOTE': '1', 05:08:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:04 INFO - 'NO_EM_RESTART': '1', 05:08:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:04 INFO - 'PWD': '/builds/slave/test', 05:08:04 INFO - 'SHELL': '/bin/bash', 05:08:04 INFO - 'SHLVL': '1', 05:08:04 INFO - 'TERM': 'linux', 05:08:04 INFO - 'TMOUT': '86400', 05:08:04 INFO - 'USER': 'cltbld', 05:08:04 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466597247.999232-1222158116', 05:08:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:04 INFO - '_': '/tools/buildbot/bin/python'} 05:08:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:04 INFO - Downloading/unpacking flake8 05:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:08:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:08:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:08:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:08:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:08:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:08:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:08:07 INFO - no previously-included directories found matching 'docs/_build' 05:08:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:08:07 INFO - Running setup.py install for pep8 05:08:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:08:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:08:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:08:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:08:07 INFO - no previously-included directories found matching 'docs/_build' 05:08:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:08:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:08:07 INFO - Cleaning up... 05:08:07 INFO - Return code: 0 05:08:07 INFO - Running post-action listener: _resource_record_post_action 05:08:07 INFO - Running post-action listener: _start_resource_monitoring 05:08:07 INFO - Starting resource monitoring. 05:08:07 INFO - ##### 05:08:07 INFO - ##### Finished create-virtualenv step (success) 05:08:07 INFO - ##### 05:08:07 INFO - ##### 05:08:07 INFO - ##### Running install step. 05:08:07 INFO - ##### 05:08:07 INFO - Running pre-action listener: _resource_record_pre_action 05:08:07 INFO - Running main action method: install 05:08:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:08:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:08:08 INFO - Reading from file tmpfile_stdout 05:08:08 INFO - Detecting whether we're running mozinstall >=1.0... 05:08:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:08:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:08:08 INFO - Reading from file tmpfile_stdout 05:08:08 INFO - Output received: 05:08:08 INFO - Usage: mozinstall [options] installer 05:08:08 INFO - Options: 05:08:08 INFO - -h, --help show this help message and exit 05:08:08 INFO - -d DEST, --destination=DEST 05:08:08 INFO - Directory to install application into. [default: 05:08:08 INFO - "/builds/slave/test"] 05:08:08 INFO - --app=APP Application being installed. [default: firefox] 05:08:08 INFO - mkdir: /builds/slave/test/build/application 05:08:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:08:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:08:25 INFO - Reading from file tmpfile_stdout 05:08:25 INFO - Output received: 05:08:25 INFO - /builds/slave/test/build/application/firefox/firefox 05:08:25 INFO - Running post-action listener: _resource_record_post_action 05:08:25 INFO - ##### 05:08:25 INFO - ##### Finished install step (success) 05:08:25 INFO - ##### 05:08:25 INFO - ##### 05:08:25 INFO - ##### Running run-tests step. 05:08:25 INFO - ##### 05:08:25 INFO - Running pre-action listener: _resource_record_pre_action 05:08:25 INFO - Running main action method: run_tests 05:08:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:08:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:08:25 INFO - Python 2.7.3 05:08:25 INFO - Return code: 0 05:08:25 INFO - grabbing minidump binary from tooltool 05:08:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:25 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 0x234c1c0>, '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 0x234d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x234d550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:08:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:08:25 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:08:25 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:08:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:08:25 INFO - Return code: 0 05:08:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:08:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:08:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:08:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:08:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:08:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:08:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:08:26 INFO - Return code: 0 05:08:26 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/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:08:26 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/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-052 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:08:26 INFO - Using env: {'DISPLAY': ':0', 05:08:26 INFO - 'HOME': '/home/cltbld', 05:08:26 INFO - 'LANG': 'en_US.UTF-8', 05:08:26 INFO - 'LANGUAGE': 'en_US:en', 05:08:26 INFO - 'LOGNAME': 'cltbld', 05:08:26 INFO - 'MAIL': '/var/mail/cltbld', 05:08:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:08:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:08:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:26 INFO - 'MOZ_NO_REMOTE': '1', 05:08:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:08:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:26 INFO - 'NO_EM_RESTART': '1', 05:08:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:26 INFO - 'PWD': '/builds/slave/test', 05:08:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:08:26 INFO - 'SHELL': '/bin/bash', 05:08:26 INFO - 'SHLVL': '1', 05:08:26 INFO - 'TERM': 'linux', 05:08:26 INFO - 'TMOUT': '86400', 05:08:26 INFO - 'USER': 'cltbld', 05:08:26 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466597247.999232-1222158116', 05:08:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:26 INFO - '_': '/tools/buildbot/bin/python'} 05:08:26 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/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:08:26 INFO - mozversion application_buildid: 20160622023033 05:08:26 INFO - mozversion application_changeset: a1746be133dff55de7588c846aaafbc30534b8bd 05:08:26 INFO - mozversion application_display_name: Nightly 05:08:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:08:26 INFO - mozversion application_name: Firefox 05:08:26 INFO - mozversion application_remotingname: firefox 05:08:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:08:26 INFO - mozversion application_vendor: Mozilla 05:08:26 INFO - mozversion application_version: 50.0a1 05:08:26 INFO - mozversion platform_buildid: 20160622023033 05:08:26 INFO - mozversion platform_changeset: a1746be133dff55de7588c846aaafbc30534b8bd 05:08:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:08:26 INFO - mozversion platform_version: 50.0a1 05:08:26 INFO - using testdate: 1466597306 05:08:26 INFO - actual date: 1466597306 05:08:26 INFO - starting webserver on 'localhost:43062' 05:08:26 INFO - SUITE-START | Running 2 tests 05:08:26 INFO - TEST-START | dromaeo_css 05:08:26 INFO - operating with platform_type : linux_ 05:08:26 INFO - Initialising browser for dromaeo_css test... 05:08:26 INFO - TEST-INFO | started process 28139 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7F1vOD/profile http://localhost:43062/getInfo.html) 05:08:30 INFO - PROCESS | 28139 | __metrics Screen width/height:1600/1200 05:08:30 INFO - PROCESS | 28139 | colorDepth:24 05:08:30 INFO - PROCESS | 28139 | Browser inner width/height: 1024/697 05:08:30 INFO - PROCESS | 28139 | __metrics 05:08:30 INFO - PROCESS | 28139 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:08:31 INFO - TEST-INFO | 28139: exit 0 05:08:31 INFO - Browser initialized. 05:08:31 INFO - Running cycle 1/1 for dromaeo_css test... 05:08:31 INFO - TEST-INFO | started process 28219 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7F1vOD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:08:43 INFO - PROCESS | 28219 | RSS: Main: 173780992 05:08:43 INFO - PROCESS | 28219 | 05:09:35 INFO - PROCESS | 28219 | 1466597375293 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:11:42 INFO - PROCESS | 28219 | Cycle 1(1): loaded http://localhost:43062/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43062/tests/dromaeo/cssquery-ext.html) 05:11:43 INFO - PROCESS | 28219 | RSS: Main: 266395648 05:11:43 INFO - PROCESS | 28219 | 05:14:46 INFO - PROCESS | 28219 | Cycle 1(1): loaded http://localhost:43062/tests/dromaeo/cssquery-ext.html (next: http://localhost:43062/tests/dromaeo/cssquery-jquery.html) 05:14:46 INFO - PROCESS | 28219 | RSS: Main: 271994880 05:14:46 INFO - PROCESS | 28219 | 05:17:48 INFO - PROCESS | 28219 | Cycle 1(1): loaded http://localhost:43062/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43062/tests/dromaeo/cssquery-mootools.html) 05:17:49 INFO - PROCESS | 28219 | RSS: Main: 272371712 05:17:49 INFO - PROCESS | 28219 | 05:20:51 INFO - PROCESS | 28219 | Cycle 1(1): loaded http://localhost:43062/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43062/tests/dromaeo/cssquery-prototype.html) 05:20:52 INFO - PROCESS | 28219 | RSS: Main: 264122368 05:20:52 INFO - PROCESS | 28219 | 05:23:54 INFO - PROCESS | 28219 | Cycle 1(1): loaded http://localhost:43062/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43062/tests/dromaeo/cssquery-yui.html) 05:23:55 INFO - PROCESS | 28219 | RSS: Main: 245747712 05:23:55 INFO - PROCESS | 28219 | 05:26:58 INFO - PROCESS | 28219 | Cycle 1(1): loaded http://localhost:43062/tests/dromaeo/cssquery-yui.html (next: http://localhost:43062/tests/dromaeo/cssquery-dojo.html) 05:26:58 INFO - PROCESS | 28219 | RSS: Main: 292941824 05:26:58 INFO - PROCESS | 28219 | 05:26:58 INFO - PROCESS | 28219 | __start_tp_report 05:26:58 INFO - PROCESS | 28219 | _x_x_mozilla_page_load 05:26:58 INFO - PROCESS | 28219 | _x_x_mozilla_page_load_details 05:26:58 INFO - PROCESS | 28219 | |i|pagename|runs| 05:26:58 INFO - PROCESS | 28219 | |0;dojo.html;3070.9712246397457;3114.6573876873554;3120.9687903120976;3130.874765009399;3145.480995635719;5362.195670649405;5394.109971854644;5450.863728406787;5451.700156491392;5490.094134467808;5303.7348132593315;5337.226102215186;5349.893002139955;5384.3807962084375;5402.189671549269;4788.592969597588;4794.065157294329;4837.226043832988;4859.295402166684;4996.875078123039;4897.142999975008;4918.04098200851;4937.802487900498;4952.628552858532;4954.727489988068;4751.16854550454;4782.641301902371;4791.496892826238;4853.053654537367;4938.827141050064;4836.056968891067;4838;4851.151048566487;4931.728754918478;4972.303877457159;4895.0944075345815;4900.803967841282;4901.142300097468;4906.582940450066;4908.680935739201;5202.375714914197;5243.475652434764;5273.709945952971;5279.208118782175;5394.352677678665;5753.827385178452;5757.107648314518;5774.191613174159;5781.942180578225;5800.158976948361;5590.385057643656;5800.274965629296;5831.970840145815;5832.795852145155;5835.503982161521;5340.49265319794;5397.055515284809;5400.540954018913;5430.049741295257;5430.864228394322;5948.315943666447;6009.188759517409;6009.699515024231;6013.6993150342305;6013.729382177812;5490.039243132436;5551.333839939152;5736.885262294731;5753.137029445533;5753.424657534297;5498.80754173602;5735.827925162252;5736.19693242938;5785.334686511021;5792.623479473821;5650.576206784508;5690.174924635905;5692.402297758758;5698.17376480408;5704.030314846486;5538.972305138529;5667.829965101054;5726.141078838207;5727.942720572824;5736.13957906309;4367.497737760134;4393.472783266028;4394.033312671208;4432.49026361966;4437.64498840092;3886.5724770275247;3899.980500097481;3916.706247031484;3922.666573341298;3941.3890846918775;5297.470252974672;5339.946600534023;5341.893162136813;5464.617476776667;5495.670259784426;5691.260136182353;5704.3154821421695;5732.054211055212;5737.3688894221605;5775.595708300462;5409.24270602116;5411.78352865881;5419.972900135553;5421.1055175895535;5426.565874730012;4730.692504987165;4802.591779698695;4803.687760295569;4833;4870.975645121823;5968.194293770459;5977.22296101504;5986.072158815304;5992.370801065913;6027;5753.338366087786;5766.509846663081;5774.249347584787;5774.855628609151;5776.191333213437;5758.942410575841;5795.478406943227;5825.59220854553;5867.501262392574;5957.255343082114;5572.247746554163;5573.414791446839;5574.191742197439;5581.2744343236745;5587.497125258747;5661.830145095653;5664.660120392789;5702.344230413555;5718.914216286842;5724.284464441945;5483.890322193613;5488.862778430571;5507.807226747044;5553.9444605555045;5606.495415412633;5563.221149039218;5564.415736347625;5565.777368905198;5567.192757050286;5572.749226284745;5436.320459942507;5466.617336786387;5468.179773034077;5472.2065300531995;5520.613557050968;5613.410591887793;5642.181883626769;5650.689212093374;5733.082706766897;5740.1102829061565;5552.555795536428;5560.193771903132;5560.416156303691;5568.443155684399;5568.805091821767 05:26:58 INFO - PROCESS | 28219 | |1;ext.html;617.6170774120045;629.6662768732571;630.2216762298564;639.4692405303597;645.054994433155;41853.372199417;43214.9196270093;43278;46932.53067469324;47007.764961175235;45032.774836125776;45677.77161114198;45718.77140614292;45722.54277457224;45758;8863.157999990006;8986.775330616721;9009.729708108767;9010.18908298253;9013.414128081686;8882.378233523656;8913.376063675512;8916.465012099263;8918.28653707705;8923;8900.643974241022;8944.686935957243;8945.77635559113;8947.731568052968;8951.149640784148;8906.198442140207;8909.68816091437;8920.330975176888;8928.776780580472;8932.64269429222;8827.073157318453;8880.511571863544;8884.289256859436;8888.688895888678;8888.911110888874;41948;42359.36460953088;42414.57585424168;42415;42484.36273455901;3599.7660152090293;3703.6296370363016;3758.605346438612;4193.412922190896;4406.294992801137;32230.677693223235;32270;32634.510482342783;32647.6735232647;33821.32357352839;4329.264025115738;4520.615747661453;4557.134144512532;4610.331501932201;4611.44662640482;341380;345617;346775.9999999975;347690;348613;56491.152632710546;56524.43475565274;56624.716876416176;56793.14810277849;56974.43025569774;59466;59485;59730.70134649299;59737;59818;14815.92592037033;14971.625709357353;14992.625184370478;14993.250337483083;15001.099934003994;11401.144914131473;11460.083193344512;11465.598704045318;11471.885281147082;11524;14126.85873141276;15676.216189190494;15739.449119281;15741.842581574037;15997.920010400107;5007.173816320339;5713.085906255063;5900.527957763455;5988;6068.271807383054;997.6408492942535;1091.4433638844246;1096.5668560918393;1102.4322473925934;1112.0214211493833;31481;32353.51469727956;32537.837310813295;32717;33252.33495330128;1087.586717047517;1092.3773449133917;1114.8550688410617;1119.5130118398522;1188.423614546944;16714.855707529983;16955.40656077056;17103.23035463407;17241.74137387915;17352.739708904122;515335;515447;517064;517363;519508;58551.12173317403;58855.70572147112;58857.41142588519;58873.41126588765;58907.11639325414;1249.2067537113999;1346.9663258418618;1371.1019282370064;1374.5257886029303;1379.8413182483941;32176.35647287088;33102.33795324128;33248.66751332456;33628;33811.83094084514;48191;48708.756456217496;48826.26760598665;48839.267410989574;48939.75530122327;305143;306502;306590;306776;307220;38267.6173238264;39233;40611.18777624372;41019.58980410277;43929.34105988477;48407.27389089096;48790.268145978545;48852.2672159925;49414.75292623514;50208.74895625498;40208.396874046324;41092.794536027126;41592.792036039624;42171.36742948797;42579.7871010643;40094.1981160381;40138.598614013485;40575.49385137127;41372.37941430941;41765.79117104395;40596.3910541348;41158.794206029976;41754.79122604368;41787.37318940279;41846.372304416065;34716.652833471344;37015.25969480649;37649.811750942165;37800.81099594484;37907.81046094752;28378.148655540368;28741.856290718413;28753.568696469152;28772.568411473425;28794 05:26:58 INFO - PROCESS | 28219 | |2;jquery.html;390.25461368785625;395.2016925809864;395.9128991621843;397.52694293790404;417.4135339847513;14154.292285385742;16310.347586096543;17984.460466186003;19623.705644415328;19638.607227855435;13902.652433689163;16914.407995720154;18004.459866204;18036;18058.729119063224;5500.6424582402215;5537.307836520435;5726.341470730857;5735.2544169257935;5748.310202775673;3880.2433525462548;4091.2635725569385;5574.219609254687;5606.607537472379;5664.122061080539;5894.764209431618;6235.844103897393;6238.906416403757;6313.873722525546;6318;5654.151877218409;5952.970235148797;5966.910496342558;6275.592086514362;6281.874362512747;5784.13238014297;5786.450287222707;5812.128180772876;5819.098039803837;5829.708514574297;21143.788562114336;21392.89303553488;22168.88915555428;22223.888880555656;22543.436414089614;2307.7807608277185;2326.8022218111482;2329.219711396684;2563.5641940870096;2821.8730157142977;9376.8593471098;9930.851037234448;10111.191104711605;10392.116670083053;10430.530626121843;1958.3635318521538;1985.7418535590282;1999.4401567561106;2098.979010209909;2159;75178.24821751767;78004;79132;80244.5987770069;81564.18435815626;10578.312409693346;10834.295770774874;10913.454327283604;11129.220954533266;11172.817715817067;15347.386104555915;15487.380504779683;15502.689946201239;15505.922470387575;15539.922300388653;6762.8647427052165;7340.449466289942;7833.960830195812;7852.293293603489;8029.5583742894705;7368.742094026683;7402.407807375397;7509.286617771412;7556.319931206218;7587.165411804697;4666.673332866734;4715.905681886412;4738.218193997952;4831.589314908202;4853.563179313879;1955.8533110016806;1977.960440791176;1980;2012.2353505667752;2028.2799606139608;890.3278025091145;939.5396255834592;940.4404379394249;1012.2812802910016;1072.5602502973743;17344.4796656098;19095.904520477587;19122;20079;20152.29466968649;943.3443756589242;956.5360800011989;972.6237374115689;988.6984469736656;1022.2690776095128;10643.308184967953;10855.557544299229;10901.291416057931;10985.340879547093;10998.629283489097;505234;506650;512708;514716;517145;61780.69109654423;71912;84303;88158.11841881627;102680;996.028871849955;1009.5658866687395;1023.3450591621369;1029.0841151375282;1040.2614143957874;17549.385771497935;17602.29590816353;17966.461006169837;18097.276108955495;18241.908790455964;31947.36105277835;32064.51903221407;40007.19985600213;41210.587894121876;44251.778741106085;56796.716016419654;58213.4178658208;64054.67972660107;66391;66455.66772166108;11447.027002704863;12618.936905315415;13102.279374634105;13124.606261812161;13303.401346939218;14134.50529231472;14272.928635357172;14348.06737562055;14622.853771462149;14634;11911.3448760319;11980.58067967617;12628.873711263137;12632.74734505323;12862.549810756578;7409.592472413853;11863.58477453285;12568.120231584067;12640.620781376574;12734.299613521345;12226.572069977508;12228.327441990776;12564.120511564102;13192.406341714837;13305.933470332973;12795.552155674506;12852.100352975202;12945.158564693265;12993.285369304778;13322.467101315839;12523.74952500963;12766.553170639354;12787.942314666301;13048.347582621022;13060.085793994329 05:26:58 INFO - PROCESS | 28219 | |3;mootools.html;1332.540273605607;1488.8287846897606;1522.0411140981182;1637.4841924793689;1809.1044932758277;8375.539345336005;8723.345749068829;8728;8865.246454051397;8923.286137109031;8603.698870539532;8776.868346974785;8800.91199088009;8816.779580510474;8826.161514656098;1922.192679074785;2141.368296352572;2161.027537608075;2167.111484291433;2237.899294531742;2275.12407723027;2283.954320913581;2286.9085236590518;2287.691161693175;2290.7480177180496;2262.6379779235326;2272.1593010586025;2273.4089136824377;2279.2934190400947;2279.350385140235;1884.3028079610563;1937.5253062999514;1940.6797878350055;2141.6145093883097;2229.420350708819;2179.836512261571;2213.0815711479877;2213.435573928638;2214.523877366374;2215.7562668106493;8786.209241168326;8829.33779966505;8832.160944710242;8848.911510884873;8855.07021762712;4973.626977976666;5108.208227724708;5112.054269960032;5117.104506711348;5117.872053198663;3174.190581401751;3269.117338318664;3313.072339744875;3332.4334863073095;3371.2077661749468;1099.4118146791427;1101.432762127505;1131.7623299107197;1140.321508702321;1141.5262665993687;13008.739825203444;13054.216746995211;13077.346132693327;13081.018923580674;13086.738265234642;4425.269830477935;4461.486929003141;4683.625309975194;4692.225782745809;4745.762711864393;10065.396076235449;10076.3954162749;10146.289759716896;10150.238732095122;10152.949235253776;5155.819546315936;5166.741662916839;5170;5173.379194496684;5176.301199338116;4098.282800509958;4474.932876006863;4604.677672562889;4625.699329543569;4711.1519926413575;3726.720495962814;3782.130110074698;3842.51968503937;3879.476270703475;3926.09699769049;1076.0530732954949;1079.5735684404617;1081.8269076947652;1083.3175099687146;1087.923845330835;902.7743064233941;968.2496065549115;993.980120397588;1021.2799777464268;1025.4001409175717;5957.2255606771705;6107.144999700045;6116.602420842631;6119.5410344224365;6131;388.82891527728276;390.04050036908956;390.3481186418688;396.20363070229047;405.2401746724891;4011.117554138085;4084.9387259191135;4139.2135494256;4187.309093999517;4220.388043733641;11308.830367544493;11568.88431115678;11572.6528204154;11624.6512604622;11654.825177622342;11577.652670419733;11656.650300491;11669.35818529989;11669.474873630706;11676.88323116758;8299.170082991774;8353.24820766134;8455.873161902577;8501.574921253912;8501.95749021251;6096.908546371897;6111.297200821785;6137.079438084323;6167.321594624677;6230.065490176328;10457.424841633783;10560.947195263974;10734.83897741519;10763.085137763377;10768.138548916224;10707;10950.835737464104;10986.670399888017;11048.502817373399;11062.557497700323;7748.8450230996195;7781.5331080135375;7784.610769461618;7794.727184548514;7808.180141085331;8836.248918841971;8866.423682460878;8892.555372231493;8926.86609700842;8958.283337332867;7726.266004729542;7867.173946735739;7964.283214510722;7964.6415911282975;8143.226393492609;7666.693332266647;7936.127026027017;8007.75976720676;8042;8073.555954422328;7325.194228634739;7331.560106393634;7417.8145546361775;7433.9256607433235;7588.27911348421;5341.35903691544;5352.090144675492;5378.892422151457;5411.729413529387;5446.727663616724;5286.259923610621;5381.75782089799;5464.480874316933;5497.202905578749;5519.172124181405 05:26:58 INFO - PROCESS | 28219 | |4;prototype.html;303.3008914452187;310.8026403233947;317.4508100985297;332.860198716539;333.15212783466075;4930.6055515558755;5049.419316778572;5247.291615631889;5254.947450525498;5256.185291279853;5211.514718305274;5227.405641279408;5229.60777941654;5247.501487358704;5287.947120528794;4124.814383352741;4126.298529250027;4130.958690413103;4133.586641335857;4138.813753381105;3934.4295077213787;3950.1507175957163;4067.7355971861884;4107.507099148106;4128.8967775805695;4010.518737751474;4024.879253622396;4030.7581545107387;4058.7564746115327;4072.5112986441522;4008.599140085997;4040.696947728932;4044.2315959967514;4048.6356227939477;4065.654419374327;3537.540119784437;3610.2418492116685;3619.457081437779;3630.7458477906557;3638.762820640995;4973.378327709036;4986.650934434591;5063.949360506384;5068.41713202979;5089.185730283137;4613.215753321943;4655.790489427984;4657.976710116462;4662.137504561667;4674.298855171717;5236.9738151309;5401.351837779453;5414.7834086636485;5415.268938693265;5453.209284653703;3869.8645547405986;3871.3805791073573;3906.43356713275;3909.2376986487648;3926.960730392688;5368.812091576776;5490.258815059996;5604.243427137366;5637.746301416446;5660.377358490563;3914.9625349282464;3948.545917219499;3959.0300376407963;3963.623455771697;3966.504186976628;3995.1210733638554;3999.2201520703766;4015.4980627421573;4017.216642754635;4037.8990525237105;4581.725096494221;4688.718676879398;4699;4701.3653156824075;4702.860198609625;5489.2553723138435;5499.7250137492965;5503;5507.339119305709;5518.586106042063;1364.1814911053289;1390.1867407566688;1393.303348325837;1399.54514782694;1400.103933482572;872.646578135856;908.1372695938885;914.679862048291;924.995375023134;928.4243768863348;4695.929561056587;4729.2906064089975;4750.904981900343;4751.40607424072;4753.738544380023;5039.546440820271;5062.443131255559;5067.214581739836;5110.28456016158;5154.917467331902;4544.136903869464;4751.550777012975;4768.690035147704;4802.351682522814;4825.769428795635;2626.6716660417446;2657.4286528396487;2667.7198894116227;2668.3595936974984;2693.8922443102056;5023.974880125576;5097.235414687752;5177.223416487557;5179.663321884065;5215.947840521622;4801.927971080437;5076.7207803571155;5079.263506791494;5088.491150884882;5145.253938179018;4999.425410831201;5067.315912351785;5073.720945347967;5077.771500282496;5106.846794596094;4969.105560999054;4969.602431805374;4997.975010125072;5015.542384231773;5031.088186489111;4735.83424580138;4840.7337596431125;4882.901347196852;4902.485239049991;4960.677555958851;5110.087250267312;5555.416681248411;5666.631668941505;5677.971610141923;5720.3421606515785;3942.8817135485983;3957.4459575660007;3977.105151340925;4004.379321205218;4010.6791456682813;5654.293213348332;5658.688772117408;5660.433956604306;5663.405342438985;5667.064934285797;5226.8954620908125;5466.72666366688;5552.139418389995;5555.694436806015;5556.91664625039;5505.311836020497;5520.944790552204;5524.475174858382;5528.336599608073;5573.219749235192;5252.369715634149;5378.489043540857;5443.951387223167;5495.862603434786;5504.422035686355;5492.917606235989;5543.196236545759;5607.943920560742;5610.971945140248;5628.915566266591;5469.972650136724;5480.232767412645;5496.395396506461;5525.392206857323;5527 05:26:58 INFO - PROCESS | 28219 | |5;yui.html;714.782781588627;738.446165375968;747.5984271564381;780.9613214424816;832.9104098874527;13718.51985180519;14581.19803410812;15452.768208476868;15487.070775753462;16294.42969496068;14704.411823527073;14750;15130.848691513109;15135.24323783812;15145.167015814153;798.2297083314601;800.675726330834;803.6544285957066;804.7585724282721;804.8873157757919;648.2706954675989;763.507537638223;794.6503538443095;797.5374282915894;801.8797180422924;838.5429940682343;840.4117118017382;843.4306842881061;844.0757370679097;847.6651722569612;840.7351684219512;841.5792103948025;841.6591280531334;842.751388340441;842.9030661473917;612.834534675635;613.5030625193607;613.6962203709148;613.9140520327157;614.3856143856144;15092.24538773068;15112.622184445367;15137.318820653098;15234.923825380802;15244.085354878633;15222.923885380613;15239.466618668293;15240.618984525365;15446.304916278794;15475.613109672237;12126.878731212662;12520;12778.744425111445;12805.807912881315;13248.47006119754;3855.094052897567;3971.5829837867186;4026.71812973092;4034.334334834749;4039.6768258539246;68933.65533172352;71023.64488177578;71170;78772.60613696894;80223;12221;12288.324142172267;12290.324032178316;12295.56965506203;12709.618711438672;22718;23087.307380778602;23192.304230873102;23204.883975580015;23648.40878978005;8336.958315208507;8865.64537418509;9018;9122.680706175252;9246.352755307198;4985.252212168204;5013.1978883379215;5017.949820501822;5233.947660523346;5250;3446.207372304384;3541.8760343387858;3572.5355703758346;3573.160307327776;3576.5529308836394;646.8770933522616;662.8177251255943;666.8366250268715;671.3655595462338;679.8164495586165;641.4227195524065;647.2297965421134;683.3132701634925;692.2143367278176;742.1428250370723;9427;9427.670031548863;9445.19715824149;9668.226541876633;9741.9025809741;744.2408743082134;751.9699212031458;761.678072002378;765.9310662040443;773.5668025905511;4194.8112334945;4285.5928686774705;4293.377460268243;4500.797464114057;4613.423322084739;111771;114778.42610786893;115828;117566;117604.41197794127;90635.54682226546;93124;93531;94281;97528.51235743918;54727;57402.7129864348;67439;81985.59007204926;91472.54263728639;8196.50820950721;8304;8462.83074338522;8500.404971652173;8648.913510864812;51760.482395177074;52995;53433.4656653444;53448.73275633597;54947.450525494234;58020.70989645025;70035;71842.28157718565;76011.61994189993;77707;12334.259944403364;12633.93683031579;12811.551595694105;13048.217106973232;13122.294101766709;15101;15194.468193613613;15260.542183734506;15938.203089845692;16117;14051.648708782363;14639.780403293746;14689.779653305422;14702.926485367505;14826;13666.316684165553;13873.79189312141;14292.571222863331;14450.566483005106;14642.414303427744;14024;14912.7763083556;15047.473338433103;15054.849451505344;15066;11833.169744951554;11950.223235489666;11990.646300810848;12108.273503589813;12806.231626102091;11345.659630211107;11849.466773995364;12013.63959081229;12057.638270851538;12122.818157727817 05:26:58 INFO - PROCESS | 28219 | __end_tp_report 05:26:58 INFO - PROCESS | 28219 | __start_cc_report 05:26:58 INFO - PROCESS | 28219 | _x_x_mozilla_cycle_collect,849 05:26:58 INFO - PROCESS | 28219 | __end_cc_report 05:26:58 INFO - PROCESS | 28219 | __startTimestamp1466598418943__endTimestamp 05:26:58 INFO - PROCESS | 28219 | 05:26:58 INFO - PROCESS | 28219 | ------- Summary: start ------- 05:26:58 INFO - PROCESS | 28219 | Number of tests: 6 05:26:58 INFO - PROCESS | 28219 | 05:26:58 INFO - PROCESS | 28219 | [#0] dojo.html Cycles:165 Average:5321.26 Median:5498.81 stddev:605.93 (11.0%) stddev-sans-first:581.50 05:26:58 INFO - PROCESS | 28219 | Values: 3071.0 3114.7 3121.0 3130.9 3145.5 5362.2 5394.1 5450.9 5451.7 5490.1 5303.7 5337.2 5349.9 5384.4 5402.2 4788.6 4794.1 4837.2 4859.3 4996.9 4897.1 4918.0 4937.8 4952.6 4954.7 4751.2 4782.6 4791.5 4853.1 4938.8 4836.1 4838.0 4851.2 4931.7 4972.3 4895.1 4900.8 4901.1 4906.6 4908.7 5202.4 5243.5 5273.7 5279.2 5394.4 5753.8 5757.1 5774.2 5781.9 5800.2 5590.4 5800.3 5832.0 5832.8 5835.5 5340.5 5397.1 5400.5 5430.0 5430.9 5948.3 6009.2 6009.7 6013.7 6013.7 5490.0 5551.3 5736.9 5753.1 5753.4 5498.8 5735.8 5736.2 5785.3 5792.6 5650.6 5690.2 5692.4 5698.2 5704.0 5539.0 5667.8 5726.1 5727.9 5736.1 4367.5 4393.5 4394.0 4432.5 4437.6 3886.6 3900.0 3916.7 3922.7 3941.4 5297.5 5339.9 5341.9 5464.6 5495.7 5691.3 5704.3 5732.1 5737.4 5775.6 5409.2 5411.8 5420.0 5421.1 5426.6 4730.7 4802.6 4803.7 4833.0 4871.0 5968.2 5977.2 5986.1 5992.4 6027.0 5753.3 5766.5 5774.2 5774.9 5776.2 5758.9 5795.5 5825.6 5867.5 5957.3 5572.2 5573.4 5574.2 5581.3 5587.5 5661.8 5664.7 5702.3 5718.9 5724.3 5483.9 5488.9 5507.8 5553.9 5606.5 5563.2 5564.4 5565.8 5567.2 5572.7 5436.3 5466.6 5468.2 5472.2 5520.6 5613.4 5642.2 5650.7 5733.1 5740.1 5552.6 5560.2 5560.4 5568.4 5568.8 05:26:58 INFO - PROCESS | 28219 | 05:26:58 INFO - PROCESS | 28219 | [#1] ext.html Cycles:180 Average:56253.58 Median:23070.71 stddev:105882.82 (458.9%) stddev-sans-first:106097.45 05:26:58 INFO - PROCESS | 28219 | Values: 617.6 629.7 630.2 639.5 645.1 41853.4 43214.9 43278.0 46932.5 47007.8 45032.8 45677.8 45718.8 45722.5 45758.0 8863.2 8986.8 9009.7 9010.2 9013.4 8882.4 8913.4 8916.5 8918.3 8923.0 8900.6 8944.7 8945.8 8947.7 8951.1 8906.2 8909.7 8920.3 8928.8 8932.6 8827.1 8880.5 8884.3 8888.7 8888.9 41948.0 42359.4 42414.6 42415.0 42484.4 3599.8 3703.6 3758.6 4193.4 4406.3 32230.7 32270.0 32634.5 32647.7 33821.3 4329.3 4520.6 4557.1 4610.3 4611.4 341380.0 345617.0 346776.0 347690.0 348613.0 56491.2 56524.4 56624.7 56793.1 56974.4 59466.0 59485.0 59730.7 59737.0 59818.0 14815.9 14971.6 14992.6 14993.3 15001.1 11401.1 11460.1 11465.6 11471.9 11524.0 14126.9 15676.2 15739.4 15741.8 15997.9 5007.2 5713.1 5900.5 5988.0 6068.3 997.6 1091.4 1096.6 1102.4 1112.0 31481.0 32353.5 32537.8 32717.0 33252.3 1087.6 1092.4 1114.9 1119.5 1188.4 16714.9 16955.4 17103.2 17241.7 17352.7 515335.0 515447.0 517064.0 517363.0 519508.0 58551.1 58855.7 58857.4 58873.4 58907.1 1249.2 1347.0 1371.1 1374.5 1379.8 32176.4 33102.3 33248.7 33628.0 33811.8 48191.0 48708.8 48826.3 48839.3 48939.8 305143.0 306502.0 306590.0 306776.0 307220.0 38267.6 39233.0 40611.2 41019.6 43929.3 48407.3 48790.3 48852.3 49414.8 50208.7 40208.4 41092.8 41592.8 42171.4 42579.8 40094.2 40138.6 40575.5 41372.4 41765.8 40596.4 41158.8 41754.8 41787.4 41846.4 34716.7 37015.3 37649.8 37800.8 37907.8 28378.1 28741.9 28753.6 28772.6 28794.0 05:26:58 INFO - PROCESS | 28219 | 05:26:58 INFO - PROCESS | 28219 | [#2] jquery.html Cycles:180 Average:29465.89 Median:11775.95 stddev:83978.38 (713.1%) stddev-sans-first:84185.59 05:26:58 INFO - PROCESS | 28219 | Values: 390.3 395.2 395.9 397.5 417.4 14154.3 16310.3 17984.5 19623.7 19638.6 13902.7 16914.4 18004.5 18036.0 18058.7 5500.6 5537.3 5726.3 5735.3 5748.3 3880.2 4091.3 5574.2 5606.6 5664.1 5894.8 6235.8 6238.9 6313.9 6318.0 5654.2 5953.0 5966.9 6275.6 6281.9 5784.1 5786.5 5812.1 5819.1 5829.7 21143.8 21392.9 22168.9 22223.9 22543.4 2307.8 2326.8 2329.2 2563.6 2821.9 9376.9 9930.9 10111.2 10392.1 10430.5 1958.4 1985.7 1999.4 2099.0 2159.0 75178.2 78004.0 79132.0 80244.6 81564.2 10578.3 10834.3 10913.5 11129.2 11172.8 15347.4 15487.4 15502.7 15505.9 15539.9 6762.9 7340.4 7834.0 7852.3 8029.6 7368.7 7402.4 7509.3 7556.3 7587.2 4666.7 4715.9 4738.2 4831.6 4853.6 1955.9 1978.0 1980.0 2012.2 2028.3 890.3 939.5 940.4 1012.3 1072.6 17344.5 19095.9 19122.0 20079.0 20152.3 943.3 956.5 972.6 988.7 1022.3 10643.3 10855.6 10901.3 10985.3 10998.6 505234.0 506650.0 512708.0 514716.0 517145.0 61780.7 71912.0 84303.0 88158.1 102680.0 996.0 1009.6 1023.3 1029.1 1040.3 17549.4 17602.3 17966.5 18097.3 18241.9 31947.4 32064.5 40007.2 41210.6 44251.8 56796.7 58213.4 64054.7 66391.0 66455.7 11447.0 12618.9 13102.3 13124.6 13303.4 14134.5 14272.9 14348.1 14622.9 14634.0 11911.3 11980.6 12628.9 12632.7 12862.5 7409.6 11863.6 12568.1 12640.6 12734.3 12226.6 12228.3 12564.1 13192.4 13305.9 12795.6 12852.1 12945.2 12993.3 13322.5 12523.7 12766.6 12787.9 13048.3 13060.1 05:26:58 INFO - PROCESS | 28219 | 05:26:58 INFO - PROCESS | 28219 | [#3] mootools.html Cycles:180 Average:5900.58 Median:4163.26 stddev:3525.14 (84.7%) stddev-sans-first:3518.32 05:26:58 INFO - PROCESS | 28219 | Values: 1332.5 1488.8 1522.0 1637.5 1809.1 8375.5 8723.3 8728.0 8865.2 8923.3 8603.7 8776.9 8800.9 8816.8 8826.2 1922.2 2141.4 2161.0 2167.1 2237.9 2275.1 2284.0 2286.9 2287.7 2290.7 2262.6 2272.2 2273.4 2279.3 2279.4 1884.3 1937.5 1940.7 2141.6 2229.4 2179.8 2213.1 2213.4 2214.5 2215.8 8786.2 8829.3 8832.2 8848.9 8855.1 4973.6 5108.2 5112.1 5117.1 5117.9 3174.2 3269.1 3313.1 3332.4 3371.2 1099.4 1101.4 1131.8 1140.3 1141.5 13008.7 13054.2 13077.3 13081.0 13086.7 4425.3 4461.5 4683.6 4692.2 4745.8 10065.4 10076.4 10146.3 10150.2 10152.9 5155.8 5166.7 5170.0 5173.4 5176.3 4098.3 4474.9 4604.7 4625.7 4711.2 3726.7 3782.1 3842.5 3879.5 3926.1 1076.1 1079.6 1081.8 1083.3 1087.9 902.8 968.2 994.0 1021.3 1025.4 5957.2 6107.1 6116.6 6119.5 6131.0 388.8 390.0 390.3 396.2 405.2 4011.1 4084.9 4139.2 4187.3 4220.4 11308.8 11568.9 11572.7 11624.7 11654.8 11577.7 11656.7 11669.4 11669.5 11676.9 8299.2 8353.2 8455.9 8501.6 8502.0 6096.9 6111.3 6137.1 6167.3 6230.1 10457.4 10560.9 10734.8 10763.1 10768.1 10707.0 10950.8 10986.7 11048.5 11062.6 7748.8 7781.5 7784.6 7794.7 7808.2 8836.2 8866.4 8892.6 8926.9 8958.3 7726.3 7867.2 7964.3 7964.6 8143.2 7666.7 7936.1 8007.8 8042.0 8073.6 7325.2 7331.6 7417.8 7433.9 7588.3 5341.4 5352.1 5378.9 5411.7 5446.7 5286.3 5381.8 5464.5 5497.2 5519.2 05:26:58 INFO - PROCESS | 28219 | 05:26:58 INFO - PROCESS | 28219 | [#4] prototype.html Cycles:180 Average:4459.32 Median:4992.31 stddev:1292.18 (25.9%) stddev-sans-first:1257.59 05:26:58 INFO - PROCESS | 28219 | Values: 303.3 310.8 317.5 332.9 333.2 4930.6 5049.4 5247.3 5254.9 5256.2 5211.5 5227.4 5229.6 5247.5 5287.9 4124.8 4126.3 4131.0 4133.6 4138.8 3934.4 3950.2 4067.7 4107.5 4128.9 4010.5 4024.9 4030.8 4058.8 4072.5 4008.6 4040.7 4044.2 4048.6 4065.7 3537.5 3610.2 3619.5 3630.7 3638.8 4973.4 4986.7 5063.9 5068.4 5089.2 4613.2 4655.8 4658.0 4662.1 4674.3 5237.0 5401.4 5414.8 5415.3 5453.2 3869.9 3871.4 3906.4 3909.2 3927.0 5368.8 5490.3 5604.2 5637.7 5660.4 3915.0 3948.5 3959.0 3963.6 3966.5 3995.1 3999.2 4015.5 4017.2 4037.9 4581.7 4688.7 4699.0 4701.4 4702.9 5489.3 5499.7 5503.0 5507.3 5518.6 1364.2 1390.2 1393.3 1399.5 1400.1 872.6 908.1 914.7 925.0 928.4 4695.9 4729.3 4750.9 4751.4 4753.7 5039.5 5062.4 5067.2 5110.3 5154.9 4544.1 4751.6 4768.7 4802.4 4825.8 2626.7 2657.4 2667.7 2668.4 2693.9 5024.0 5097.2 5177.2 5179.7 5215.9 4801.9 5076.7 5079.3 5088.5 5145.3 4999.4 5067.3 5073.7 5077.8 5106.8 4969.1 4969.6 4998.0 5015.5 5031.1 4735.8 4840.7 4882.9 4902.5 4960.7 5110.1 5555.4 5666.6 5678.0 5720.3 3942.9 3957.4 3977.1 4004.4 4010.7 5654.3 5658.7 5660.4 5663.4 5667.1 5226.9 5466.7 5552.1 5555.7 5556.9 5505.3 5520.9 5524.5 5528.3 5573.2 5252.4 5378.5 5444.0 5495.9 5504.4 5492.9 5543.2 5607.9 5611.0 5628.9 5470.0 5480.2 5496.4 5525.4 5527.0 05:26:58 INFO - PROCESS | 28219 | 05:26:58 INFO - PROCESS | 28219 | [#5] yui.html Cycles:180 Average:20370.31 Median:4999.23 stddev:28565.43 (571.4%) stddev-sans-first:28607.44 05:26:58 INFO - PROCESS | 28219 | Values: 714.8 738.4 747.6 781.0 832.9 13718.5 14581.2 15452.8 15487.1 16294.4 14704.4 14750.0 15130.8 15135.2 15145.2 798.2 800.7 803.7 804.8 804.9 648.3 763.5 794.7 797.5 801.9 838.5 840.4 843.4 844.1 847.7 840.7 841.6 841.7 842.8 842.9 612.8 613.5 613.7 613.9 614.4 15092.2 15112.6 15137.3 15234.9 15244.1 15222.9 15239.5 15240.6 15446.3 15475.6 12126.9 12520.0 12778.7 12805.8 13248.5 3855.1 3971.6 4026.7 4034.3 4039.7 68933.7 71023.6 71170.0 78772.6 80223.0 12221.0 12288.3 12290.3 12295.6 12709.6 22718.0 23087.3 23192.3 23204.9 23648.4 8337.0 8865.6 9018.0 9122.7 9246.4 4985.3 5013.2 5017.9 5233.9 5250.0 3446.2 3541.9 3572.5 3573.2 3576.6 646.9 662.8 666.8 671.4 679.8 641.4 647.2 683.3 692.2 742.1 9427.0 9427.7 9445.2 9668.2 9741.9 744.2 752.0 761.7 765.9 773.6 4194.8 4285.6 4293.4 4500.8 4613.4 111771.0 114778.4 115828.0 117566.0 117604.4 90635.5 93124.0 93531.0 94281.0 97528.5 54727.0 57402.7 67439.0 81985.6 91472.5 8196.5 8304.0 8462.8 8500.4 8648.9 51760.5 52995.0 53433.5 53448.7 54947.5 58020.7 70035.0 71842.3 76011.6 77707.0 12334.3 12633.9 12811.6 13048.2 13122.3 15101.0 15194.5 15260.5 15938.2 16117.0 14051.6 14639.8 14689.8 14702.9 14826.0 13666.3 13873.8 14292.6 14450.6 14642.4 14024.0 14912.8 15047.5 15054.8 15066.0 11833.2 11950.2 11990.6 12108.3 12806.2 11345.7 11849.5 12013.6 12057.6 12122.8 05:26:58 INFO - PROCESS | 28219 | -------- Summary: end -------- 05:26:58 INFO - PROCESS | 28219 | 05:26:59 INFO - TEST-INFO | 28219: exit 0 05:26:59 INFO - TEST-OK | dromaeo_css | took 1113340ms 05:26:59 INFO - TEST-START | kraken 05:26:59 INFO - operating with platform_type : linux_ 05:26:59 INFO - Initialising browser for kraken test... 05:26:59 INFO - TEST-INFO | started process 28404 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKf5ir_/profile http://localhost:43062/getInfo.html) 05:27:03 INFO - PROCESS | 28404 | __metrics Screen width/height:1600/1200 05:27:03 INFO - PROCESS | 28404 | colorDepth:24 05:27:03 INFO - PROCESS | 28404 | Browser inner width/height: 1024/697 05:27:03 INFO - PROCESS | 28404 | __metrics 05:27:04 INFO - PROCESS | 28404 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:27:05 INFO - TEST-INFO | 28404: exit 0 05:27:05 INFO - Browser initialized. 05:27:05 INFO - Running cycle 1/1 for kraken test... 05:27:05 INFO - TEST-INFO | started process 28486 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKf5ir_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:27:17 INFO - PROCESS | 28486 | RSS: Main: 173682688 05:27:17 INFO - PROCESS | 28486 | 05:27:19 INFO - PROCESS | 28486 | Cycle 1(1): loaded http://localhost:43062/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43062/tests/kraken/driver.html?testName=audio-beat-detection) 05:27:20 INFO - PROCESS | 28486 | RSS: Main: 232730624 05:27:20 INFO - PROCESS | 28486 | 05:27:23 INFO - PROCESS | 28486 | Cycle 1(1): loaded http://localhost:43062/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43062/tests/kraken/driver.html?testName=audio-dft) 05:27:23 INFO - PROCESS | 28486 | RSS: Main: 220971008 05:27:23 INFO - PROCESS | 28486 | 05:27:26 INFO - PROCESS | 28486 | Cycle 1(1): loaded http://localhost:43062/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43062/tests/kraken/driver.html?testName=audio-fft) 05:27:27 INFO - PROCESS | 28486 | RSS: Main: 286969856 05:27:27 INFO - PROCESS | 28486 | 05:27:29 INFO - PROCESS | 28486 | Cycle 1(1): loaded http://localhost:43062/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43062/tests/kraken/driver.html?testName=audio-oscillator) 05:27:30 INFO - PROCESS | 28486 | RSS: Main: 198664192 05:27:30 INFO - PROCESS | 28486 | 05:27:32 INFO - PROCESS | 28486 | Cycle 1(1): loaded http://localhost:43062/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43062/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:27:32 INFO - PROCESS | 28486 | RSS: Main: 202412032 05:27:32 INFO - PROCESS | 28486 | 05:27:35 INFO - PROCESS | 28486 | Cycle 1(1): loaded http://localhost:43062/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43062/tests/kraken/driver.html?testName=imaging-darkroom) 05:27:36 INFO - PROCESS | 28486 | RSS: Main: 235974656 05:27:36 INFO - PROCESS | 28486 | 05:27:39 INFO - PROCESS | 28486 | Cycle 1(1): loaded http://localhost:43062/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43062/tests/kraken/driver.html?testName=imaging-desaturate) 05:27:40 INFO - PROCESS | 28486 | RSS: Main: 239222784 05:27:40 INFO - PROCESS | 28486 | 05:27:43 INFO - PROCESS | 28486 | Cycle 1(1): loaded http://localhost:43062/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43062/tests/kraken/driver.html?testName=json-parse-financial) 05:27:43 INFO - PROCESS | 28486 | RSS: Main: 238534656 05:27:43 INFO - PROCESS | 28486 | 05:27:45 INFO - PROCESS | 28486 | Cycle 1(1): loaded http://localhost:43062/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43062/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:27:45 INFO - PROCESS | 28486 | RSS: Main: 228204544 05:27:45 INFO - PROCESS | 28486 | 05:27:47 INFO - PROCESS | 28486 | Cycle 1(1): loaded http://localhost:43062/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43062/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:27:48 INFO - PROCESS | 28486 | RSS: Main: 230887424 05:27:48 INFO - PROCESS | 28486 | 05:27:50 INFO - PROCESS | 28486 | Cycle 1(1): loaded http://localhost:43062/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43062/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:27:51 INFO - PROCESS | 28486 | RSS: Main: 236871680 05:27:51 INFO - PROCESS | 28486 | 05:27:53 INFO - PROCESS | 28486 | Cycle 1(1): loaded http://localhost:43062/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43062/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:27:54 INFO - PROCESS | 28486 | RSS: Main: 239640576 05:27:54 INFO - PROCESS | 28486 | 05:27:56 INFO - PROCESS | 28486 | Cycle 1(1): loaded http://localhost:43062/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43062/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:27:57 INFO - PROCESS | 28486 | RSS: Main: 239480832 05:27:57 INFO - PROCESS | 28486 | 05:27:59 INFO - PROCESS | 28486 | Cycle 1(1): loaded http://localhost:43062/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43062/tests/kraken/driver.html?testName=ai-astar) 05:27:59 INFO - PROCESS | 28486 | RSS: Main: 281751552 05:27:59 INFO - PROCESS | 28486 | 05:27:59 INFO - PROCESS | 28486 | __start_tp_report 05:27:59 INFO - PROCESS | 28486 | _x_x_mozilla_page_load 05:27:59 INFO - PROCESS | 28486 | _x_x_mozilla_page_load_details 05:27:59 INFO - PROCESS | 28486 | |i|pagename|runs| 05:27:59 INFO - PROCESS | 28486 | |0;ai-astar;109;106;112;109;110;109;109;109;109;109 05:27:59 INFO - PROCESS | 28486 | |1;audio-beat-detection;155;129;129;193;130;126;155;125;180;129 05:27:59 INFO - PROCESS | 28486 | |2;audio-dft;160;159;170;160;160;161;160;159;160;161 05:27:59 INFO - PROCESS | 28486 | |3;audio-fft;73;74;75;121;76;76;74;73;97;75 05:27:59 INFO - PROCESS | 28486 | |4;audio-oscillator;85;85;107;85;84;85;122;84;84;122 05:27:59 INFO - PROCESS | 28486 | |5;imaging-gaussian-blur;117;117;118;117;117;116;117;116;116;117 05:27:59 INFO - PROCESS | 28486 | |6;imaging-darkroom;145;146;145;144;145;146;144;145;146;144 05:27:59 INFO - PROCESS | 28486 | |7;imaging-desaturate;94;95;95;94;94;94;95;94;95;94 05:27:59 INFO - PROCESS | 28486 | |8;json-parse-financial;59;51;52;52;54;52;53;52;54;54 05:27:59 INFO - PROCESS | 28486 | |9;json-stringify-tinderbox;62;62;64;63;72;62;62;63;63;64 05:27:59 INFO - PROCESS | 28486 | |10;stanford-crypto-aes;80;79;79;79;80;81;82;81;108;80 05:27:59 INFO - PROCESS | 28486 | |11;stanford-crypto-ccm;129;133;128;125;128;122;120;122;123;122 05:27:59 INFO - PROCESS | 28486 | |12;stanford-crypto-pbkdf2;159;165;161;161;161;161;160;161;160;160 05:27:59 INFO - PROCESS | 28486 | |13;stanford-crypto-sha256-iterative;65;64;66;63;64;62;62;64;66;64 05:27:59 INFO - PROCESS | 28486 | __end_tp_report 05:27:59 INFO - PROCESS | 28486 | __start_cc_report 05:27:59 INFO - PROCESS | 28486 | _x_x_mozilla_cycle_collect,1623 05:27:59 INFO - PROCESS | 28486 | __end_cc_report 05:27:59 INFO - PROCESS | 28486 | __startTimestamp1466598479475__endTimestamp 05:27:59 INFO - PROCESS | 28486 | 05:27:59 INFO - PROCESS | 28486 | ------- Summary: start ------- 05:27:59 INFO - PROCESS | 28486 | Number of tests: 14 05:27:59 INFO - PROCESS | 28486 | 05:27:59 INFO - PROCESS | 28486 | [#0] ai-astar Cycles:10 Average:109.10 Median:109.00 stddev:1.45 (1.3%) stddev-sans-first:1.54 05:27:59 INFO - PROCESS | 28486 | Values: 109.0 106.0 112.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 05:27:59 INFO - PROCESS | 28486 | 05:27:59 INFO - PROCESS | 28486 | [#1] audio-beat-detection Cycles:10 Average:145.10 Median:142.50 stddev:24.68 (17.3%) stddev-sans-first:25.92 05:27:59 INFO - PROCESS | 28486 | Values: 155.0 129.0 129.0 193.0 130.0 126.0 155.0 125.0 180.0 129.0 05:27:59 INFO - PROCESS | 28486 | 05:27:59 INFO - PROCESS | 28486 | [#2] audio-dft Cycles:10 Average:161.00 Median:160.00 stddev:3.23 (2.0%) stddev-sans-first:3.41 05:27:59 INFO - PROCESS | 28486 | Values: 160.0 159.0 170.0 160.0 160.0 161.0 160.0 159.0 160.0 161.0 05:27:59 INFO - PROCESS | 28486 | 05:27:59 INFO - PROCESS | 28486 | [#3] audio-fft Cycles:10 Average:81.40 Median:75.00 stddev:15.64 (20.9%) stddev-sans-first:16.29 05:27:59 INFO - PROCESS | 28486 | Values: 73.0 74.0 75.0 121.0 76.0 76.0 74.0 73.0 97.0 75.0 05:27:59 INFO - PROCESS | 28486 | 05:27:59 INFO - PROCESS | 28486 | [#4] audio-oscillator Cycles:10 Average:94.30 Median:84.50 stddev:16.19 (19.2%) stddev-sans-first:16.82 05:27:59 INFO - PROCESS | 28486 | Values: 85.0 85.0 107.0 85.0 84.0 85.0 122.0 84.0 84.0 122.0 05:27:59 INFO - PROCESS | 28486 | 05:27:59 INFO - PROCESS | 28486 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 05:27:59 INFO - PROCESS | 28486 | Values: 117.0 117.0 118.0 117.0 117.0 116.0 117.0 116.0 116.0 117.0 05:27:59 INFO - PROCESS | 28486 | 05:27:59 INFO - PROCESS | 28486 | [#6] imaging-darkroom Cycles:10 Average:145.00 Median:145.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 05:27:59 INFO - PROCESS | 28486 | Values: 145.0 146.0 145.0 144.0 145.0 146.0 144.0 145.0 146.0 144.0 05:27:59 INFO - PROCESS | 28486 | 05:27:59 INFO - PROCESS | 28486 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 05:27:59 INFO - PROCESS | 28486 | Values: 94.0 95.0 95.0 94.0 94.0 94.0 95.0 94.0 95.0 94.0 05:27:59 INFO - PROCESS | 28486 | 05:27:59 INFO - PROCESS | 28486 | [#8] json-parse-financial Cycles:10 Average:53.30 Median:53.50 stddev:2.26 (4.2%) stddev-sans-first:1.12 05:27:59 INFO - PROCESS | 28486 | Values: 59.0 51.0 52.0 52.0 54.0 52.0 53.0 52.0 54.0 54.0 05:27:59 INFO - PROCESS | 28486 | 05:27:59 INFO - PROCESS | 28486 | [#9] json-stringify-tinderbox Cycles:10 Average:63.70 Median:63.00 stddev:3.02 (4.8%) stddev-sans-first:3.14 05:27:59 INFO - PROCESS | 28486 | Values: 62.0 62.0 64.0 63.0 72.0 62.0 62.0 63.0 63.0 64.0 05:27:59 INFO - PROCESS | 28486 | 05:27:59 INFO - PROCESS | 28486 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:80.00 stddev:8.88 (11.1%) stddev-sans-first:9.35 05:27:59 INFO - PROCESS | 28486 | Values: 80.0 79.0 79.0 79.0 80.0 81.0 82.0 81.0 108.0 80.0 05:27:59 INFO - PROCESS | 28486 | 05:27:59 INFO - PROCESS | 28486 | [#11] stanford-crypto-ccm Cycles:10 Average:125.20 Median:126.50 stddev:4.13 (3.3%) stddev-sans-first:4.15 05:27:59 INFO - PROCESS | 28486 | Values: 129.0 133.0 128.0 125.0 128.0 122.0 120.0 122.0 123.0 122.0 05:27:59 INFO - PROCESS | 28486 | 05:27:59 INFO - PROCESS | 28486 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.90 Median:161.00 stddev:1.60 (1.0%) stddev-sans-first:1.54 05:27:59 INFO - PROCESS | 28486 | Values: 159.0 165.0 161.0 161.0 161.0 161.0 160.0 161.0 160.0 160.0 05:27:59 INFO - PROCESS | 28486 | 05:27:59 INFO - PROCESS | 28486 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:64.00 stddev:1.41 (2.2%) stddev-sans-first:1.45 05:27:59 INFO - PROCESS | 28486 | Values: 65.0 64.0 66.0 63.0 64.0 62.0 62.0 64.0 66.0 64.0 05:27:59 INFO - PROCESS | 28486 | -------- Summary: end -------- 05:27:59 INFO - PROCESS | 28486 | 05:28:00 INFO - TEST-INFO | 28486: exit 0 05:28:00 INFO - TEST-OK | kraken | took 60804ms 05:28:00 INFO - SUITE-END | took 1174s 05:28:00 INFO - Completed test suite (00:19:34) 05:28:00 INFO - javascript benchmark 05:28:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3070.9712246397457, 3114.6573876873554, 3120.9687903120976, 3130.874765009399, 3145.480995635719, 5362.195670649405, 5394.109971854644, 5450.863728406787, 5451.700156491392, 5490.094134467808, 5303.7348132593315, 5337.226102215186, 5349.893002139955, 5384.3807962084375, 5402.189671549269, 4788.592969597588, 4794.065157294329, 4837.226043832988, 4859.295402166684, 4996.875078123039, 4897.142999975008, 4918.04098200851, 4937.802487900498, 4952.628552858532, 4954.727489988068, 4751.16854550454, 4782.641301902371, 4791.496892826238, 4853.053654537367, 4938.827141050064, 4836.056968891067, 4838.0, 4851.151048566487, 4931.728754918478, 4972.303877457159, 4895.0944075345815, 4900.803967841282, 4901.142300097468, 4906.582940450066, 4908.680935739201, 5202.375714914197, 5243.475652434764, 5273.709945952971, 5279.208118782175, 5394.352677678665, 5753.827385178452, 5757.107648314518, 5774.191613174159, 5781.942180578225, 5800.158976948361, 5590.385057643656, 5800.274965629296, 5831.970840145815, 5832.795852145155, 5835.503982161521, 5340.49265319794, 5397.055515284809, 5400.540954018913, 5430.049741295257, 5430.864228394322, 5948.315943666447, 6009.188759517409, 6009.699515024231, 6013.6993150342305, 6013.729382177812, 5490.039243132436, 5551.333839939152, 5736.885262294731, 5753.137029445533, 5753.424657534297, 5498.80754173602, 5735.827925162252, 5736.19693242938, 5785.334686511021, 5792.623479473821, 5650.576206784508, 5690.174924635905, 5692.402297758758, 5698.17376480408, 5704.030314846486, 5538.972305138529, 5667.829965101054, 5726.141078838207, 5727.942720572824, 5736.13957906309, 4367.497737760134, 4393.472783266028, 4394.033312671208, 4432.49026361966, 4437.64498840092, 3886.5724770275247, 3899.980500097481, 3916.706247031484, 3922.666573341298, 3941.3890846918775, 5297.470252974672, 5339.946600534023, 5341.893162136813, 5464.617476776667, 5495.670259784426, 5691.260136182353, 5704.3154821421695, 5732.054211055212, 5737.3688894221605, 5775.595708300462, 5409.24270602116, 5411.78352865881, 5419.972900135553, 5421.1055175895535, 5426.565874730012, 4730.692504987165, 4802.591779698695, 4803.687760295569, 4833.0, 4870.975645121823, 5968.194293770459, 5977.22296101504, 5986.072158815304, 5992.370801065913, 6027.0, 5753.338366087786, 5766.509846663081, 5774.249347584787, 5774.855628609151, 5776.191333213437, 5758.942410575841, 5795.478406943227, 5825.59220854553, 5867.501262392574, 5957.255343082114, 5572.247746554163, 5573.414791446839, 5574.191742197439, 5581.2744343236745, 5587.497125258747, 5661.830145095653, 5664.660120392789, 5702.344230413555, 5718.914216286842, 5724.284464441945, 5483.890322193613, 5488.862778430571, 5507.807226747044, 5553.9444605555045, 5606.495415412633, 5563.221149039218, 5564.415736347625, 5565.777368905198, 5567.192757050286, 5572.749226284745, 5436.320459942507, 5466.617336786387, 5468.179773034077, 5472.2065300531995, 5520.613557050968, 5613.410591887793, 5642.181883626769, 5650.689212093374, 5733.082706766897, 5740.1102829061565, 5552.555795536428, 5560.193771903132, 5560.416156303691, 5568.443155684399, 5568.805091821767], "value": 5280.457123599604, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [617.6170774120045, 629.6662768732571, 630.2216762298564, 639.4692405303597, 645.054994433155, 41853.372199417, 43214.9196270093, 43278.0, 46932.53067469324, 47007.764961175235, 45032.774836125776, 45677.77161114198, 45718.77140614292, 45722.54277457224, 45758.0, 8863.157999990006, 8986.775330616721, 9009.729708108767, 9010.18908298253, 9013.414128081686, 8882.378233523656, 8913.376063675512, 8916.465012099263, 8918.28653707705, 8923.0, 8900.643974241022, 8944.686935957243, 8945.77635559113, 8947.731568052968, 8951.149640784148, 8906.198442140207, 8909.68816091437, 8920.330975176888, 8928.776780580472, 8932.64269429222, 8827.073157318453, 8880.511571863544, 8884.289256859436, 8888.688895888678, 8888.911110888874, 41948.0, 42359.36460953088, 42414.57585424168, 42415.0, 42484.36273455901, 3599.7660152090293, 3703.6296370363016, 3758.605346438612, 4193.412922190896, 4406.294992801137, 32230.677693223235, 32270.0, 32634.510482342783, 32647.6735232647, 33821.32357352839, 4329.264025115738, 4520.615747661453, 4557.134144512532, 4610.331501932201, 4611.44662640482, 341380.0, 345617.0, 346775.9999999975, 347690.0, 348613.0, 56491.152632710546, 56524.43475565274, 56624.716876416176, 56793.14810277849, 56974.43025569774, 59466.0, 59485.0, 59730.70134649299, 59737.0, 59818.0, 14815.92592037033, 14971.625709357353, 14992.625184370478, 14993.250337483083, 15001.099934003994, 11401.144914131473, 11460.083193344512, 11465.598704045318, 11471.885281147082, 11524.0, 14126.85873141276, 15676.216189190494, 15739.449119281, 15741.842581574037, 15997.920010400107, 5007.173816320339, 5713.085906255063, 5900.527957763455, 5988.0, 6068.271807383054, 997.6408492942535, 1091.4433638844246, 1096.5668560918393, 1102.4322473925934, 1112.0214211493833, 31481.0, 32353.51469727956, 32537.837310813295, 32717.0, 33252.33495330128, 1087.586717047517, 1092.3773449133917, 1114.8550688410617, 1119.5130118398522, 1188.423614546944, 16714.855707529983, 16955.40656077056, 17103.23035463407, 17241.74137387915, 17352.739708904122, 515335.0, 515447.0, 517064.0, 517363.0, 519508.0, 58551.12173317403, 58855.70572147112, 58857.41142588519, 58873.41126588765, 58907.11639325414, 1249.2067537113999, 1346.9663258418618, 1371.1019282370064, 1374.5257886029303, 1379.8413182483941, 32176.35647287088, 33102.33795324128, 33248.66751332456, 33628.0, 33811.83094084514, 48191.0, 48708.756456217496, 48826.26760598665, 48839.267410989574, 48939.75530122327, 305143.0, 306502.0, 306590.0, 306776.0, 307220.0, 38267.6173238264, 39233.0, 40611.18777624372, 41019.58980410277, 43929.34105988477, 48407.27389089096, 48790.268145978545, 48852.2672159925, 49414.75292623514, 50208.74895625498, 40208.396874046324, 41092.794536027126, 41592.792036039624, 42171.36742948797, 42579.7871010643, 40094.1981160381, 40138.598614013485, 40575.49385137127, 41372.37941430941, 41765.79117104395, 40596.3910541348, 41158.794206029976, 41754.79122604368, 41787.37318940279, 41846.372304416065, 34716.652833471344, 37015.25969480649, 37649.811750942165, 37800.81099594484, 37907.81046094752, 28378.148655540368, 28741.856290718413, 28753.568696469152, 28772.568411473425, 28794.0], "value": 19964.547557278594, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.25461368785625, 395.2016925809864, 395.9128991621843, 397.52694293790404, 417.4135339847513, 14154.292285385742, 16310.347586096543, 17984.460466186003, 19623.705644415328, 19638.607227855435, 13902.652433689163, 16914.407995720154, 18004.459866204, 18036.0, 18058.729119063224, 5500.6424582402215, 5537.307836520435, 5726.341470730857, 5735.2544169257935, 5748.310202775673, 3880.2433525462548, 4091.2635725569385, 5574.219609254687, 5606.607537472379, 5664.122061080539, 5894.764209431618, 6235.844103897393, 6238.906416403757, 6313.873722525546, 6318.0, 5654.151877218409, 5952.970235148797, 5966.910496342558, 6275.592086514362, 6281.874362512747, 5784.13238014297, 5786.450287222707, 5812.128180772876, 5819.098039803837, 5829.708514574297, 21143.788562114336, 21392.89303553488, 22168.88915555428, 22223.888880555656, 22543.436414089614, 2307.7807608277185, 2326.8022218111482, 2329.219711396684, 2563.5641940870096, 2821.8730157142977, 9376.8593471098, 9930.851037234448, 10111.191104711605, 10392.116670083053, 10430.530626121843, 1958.3635318521538, 1985.7418535590282, 1999.4401567561106, 2098.979010209909, 2159.0, 75178.24821751767, 78004.0, 79132.0, 80244.5987770069, 81564.18435815626, 10578.312409693346, 10834.295770774874, 10913.454327283604, 11129.220954533266, 11172.817715817067, 15347.386104555915, 15487.380504779683, 15502.689946201239, 15505.922470387575, 15539.922300388653, 6762.8647427052165, 7340.449466289942, 7833.960830195812, 7852.293293603489, 8029.5583742894705, 7368.742094026683, 7402.407807375397, 7509.286617771412, 7556.319931206218, 7587.165411804697, 4666.673332866734, 4715.905681886412, 4738.218193997952, 4831.589314908202, 4853.563179313879, 1955.8533110016806, 1977.960440791176, 1980.0, 2012.2353505667752, 2028.2799606139608, 890.3278025091145, 939.5396255834592, 940.4404379394249, 1012.2812802910016, 1072.5602502973743, 17344.4796656098, 19095.904520477587, 19122.0, 20079.0, 20152.29466968649, 943.3443756589242, 956.5360800011989, 972.6237374115689, 988.6984469736656, 1022.2690776095128, 10643.308184967953, 10855.557544299229, 10901.291416057931, 10985.340879547093, 10998.629283489097, 505234.0, 506650.0, 512708.0, 514716.0, 517145.0, 61780.69109654423, 71912.0, 84303.0, 88158.11841881627, 102680.0, 996.028871849955, 1009.5658866687395, 1023.3450591621369, 1029.0841151375282, 1040.2614143957874, 17549.385771497935, 17602.29590816353, 17966.461006169837, 18097.276108955495, 18241.908790455964, 31947.36105277835, 32064.51903221407, 40007.19985600213, 41210.587894121876, 44251.778741106085, 56796.716016419654, 58213.4178658208, 64054.67972660107, 66391.0, 66455.66772166108, 11447.027002704863, 12618.936905315415, 13102.279374634105, 13124.606261812161, 13303.401346939218, 14134.50529231472, 14272.928635357172, 14348.06737562055, 14622.853771462149, 14634.0, 11911.3448760319, 11980.58067967617, 12628.873711263137, 12632.74734505323, 12862.549810756578, 7409.592472413853, 11863.58477453285, 12568.120231584067, 12640.620781376574, 12734.299613521345, 12226.572069977508, 12228.327441990776, 12564.120511564102, 13192.406341714837, 13305.933470332973, 12795.552155674506, 12852.100352975202, 12945.158564693265, 12993.285369304778, 13322.467101315839, 12523.74952500963, 12766.553170639354, 12787.942314666301, 13048.347582621022, 13060.085793994329], "value": 9412.76423328915, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1332.540273605607, 1488.8287846897606, 1522.0411140981182, 1637.4841924793689, 1809.1044932758277, 8375.539345336005, 8723.345749068829, 8728.0, 8865.246454051397, 8923.286137109031, 8603.698870539532, 8776.868346974785, 8800.91199088009, 8816.779580510474, 8826.161514656098, 1922.192679074785, 2141.368296352572, 2161.027537608075, 2167.111484291433, 2237.899294531742, 2275.12407723027, 2283.954320913581, 2286.9085236590518, 2287.691161693175, 2290.7480177180496, 2262.6379779235326, 2272.1593010586025, 2273.4089136824377, 2279.2934190400947, 2279.350385140235, 1884.3028079610563, 1937.5253062999514, 1940.6797878350055, 2141.6145093883097, 2229.420350708819, 2179.836512261571, 2213.0815711479877, 2213.435573928638, 2214.523877366374, 2215.7562668106493, 8786.209241168326, 8829.33779966505, 8832.160944710242, 8848.911510884873, 8855.07021762712, 4973.626977976666, 5108.208227724708, 5112.054269960032, 5117.104506711348, 5117.872053198663, 3174.190581401751, 3269.117338318664, 3313.072339744875, 3332.4334863073095, 3371.2077661749468, 1099.4118146791427, 1101.432762127505, 1131.7623299107197, 1140.321508702321, 1141.5262665993687, 13008.739825203444, 13054.216746995211, 13077.346132693327, 13081.018923580674, 13086.738265234642, 4425.269830477935, 4461.486929003141, 4683.625309975194, 4692.225782745809, 4745.762711864393, 10065.396076235449, 10076.3954162749, 10146.289759716896, 10150.238732095122, 10152.949235253776, 5155.819546315936, 5166.741662916839, 5170.0, 5173.379194496684, 5176.301199338116, 4098.282800509958, 4474.932876006863, 4604.677672562889, 4625.699329543569, 4711.1519926413575, 3726.720495962814, 3782.130110074698, 3842.51968503937, 3879.476270703475, 3926.09699769049, 1076.0530732954949, 1079.5735684404617, 1081.8269076947652, 1083.3175099687146, 1087.923845330835, 902.7743064233941, 968.2496065549115, 993.980120397588, 1021.2799777464268, 1025.4001409175717, 5957.2255606771705, 6107.144999700045, 6116.602420842631, 6119.5410344224365, 6131.0, 388.82891527728276, 390.04050036908956, 390.3481186418688, 396.20363070229047, 405.2401746724891, 4011.117554138085, 4084.9387259191135, 4139.2135494256, 4187.309093999517, 4220.388043733641, 11308.830367544493, 11568.88431115678, 11572.6528204154, 11624.6512604622, 11654.825177622342, 11577.652670419733, 11656.650300491, 11669.35818529989, 11669.474873630706, 11676.88323116758, 8299.170082991774, 8353.24820766134, 8455.873161902577, 8501.574921253912, 8501.95749021251, 6096.908546371897, 6111.297200821785, 6137.079438084323, 6167.321594624677, 6230.065490176328, 10457.424841633783, 10560.947195263974, 10734.83897741519, 10763.085137763377, 10768.138548916224, 10707.0, 10950.835737464104, 10986.670399888017, 11048.502817373399, 11062.557497700323, 7748.8450230996195, 7781.5331080135375, 7784.610769461618, 7794.727184548514, 7808.180141085331, 8836.248918841971, 8866.423682460878, 8892.555372231493, 8926.86609700842, 8958.283337332867, 7726.266004729542, 7867.173946735739, 7964.283214510722, 7964.6415911282975, 8143.226393492609, 7666.693332266647, 7936.127026027017, 8007.75976720676, 8042.0, 8073.555954422328, 7325.194228634739, 7331.560106393634, 7417.8145546361775, 7433.9256607433235, 7588.27911348421, 5341.35903691544, 5352.090144675492, 5378.892422151457, 5411.729413529387, 5446.727663616724, 5286.259923610621, 5381.75782089799, 5464.480874316933, 5497.202905578749, 5519.172124181405], "value": 4534.351945153904, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.3008914452187, 310.8026403233947, 317.4508100985297, 332.860198716539, 333.15212783466075, 4930.6055515558755, 5049.419316778572, 5247.291615631889, 5254.947450525498, 5256.185291279853, 5211.514718305274, 5227.405641279408, 5229.60777941654, 5247.501487358704, 5287.947120528794, 4124.814383352741, 4126.298529250027, 4130.958690413103, 4133.586641335857, 4138.813753381105, 3934.4295077213787, 3950.1507175957163, 4067.7355971861884, 4107.507099148106, 4128.8967775805695, 4010.518737751474, 4024.879253622396, 4030.7581545107387, 4058.7564746115327, 4072.5112986441522, 4008.599140085997, 4040.696947728932, 4044.2315959967514, 4048.6356227939477, 4065.654419374327, 3537.540119784437, 3610.2418492116685, 3619.457081437779, 3630.7458477906557, 3638.762820640995, 4973.378327709036, 4986.650934434591, 5063.949360506384, 5068.41713202979, 5089.185730283137, 4613.215753321943, 4655.790489427984, 4657.976710116462, 4662.137504561667, 4674.298855171717, 5236.9738151309, 5401.351837779453, 5414.7834086636485, 5415.268938693265, 5453.209284653703, 3869.8645547405986, 3871.3805791073573, 3906.43356713275, 3909.2376986487648, 3926.960730392688, 5368.812091576776, 5490.258815059996, 5604.243427137366, 5637.746301416446, 5660.377358490563, 3914.9625349282464, 3948.545917219499, 3959.0300376407963, 3963.623455771697, 3966.504186976628, 3995.1210733638554, 3999.2201520703766, 4015.4980627421573, 4017.216642754635, 4037.8990525237105, 4581.725096494221, 4688.718676879398, 4699.0, 4701.3653156824075, 4702.860198609625, 5489.2553723138435, 5499.7250137492965, 5503.0, 5507.339119305709, 5518.586106042063, 1364.1814911053289, 1390.1867407566688, 1393.303348325837, 1399.54514782694, 1400.103933482572, 872.646578135856, 908.1372695938885, 914.679862048291, 924.995375023134, 928.4243768863348, 4695.929561056587, 4729.2906064089975, 4750.904981900343, 4751.40607424072, 4753.738544380023, 5039.546440820271, 5062.443131255559, 5067.214581739836, 5110.28456016158, 5154.917467331902, 4544.136903869464, 4751.550777012975, 4768.690035147704, 4802.351682522814, 4825.769428795635, 2626.6716660417446, 2657.4286528396487, 2667.7198894116227, 2668.3595936974984, 2693.8922443102056, 5023.974880125576, 5097.235414687752, 5177.223416487557, 5179.663321884065, 5215.947840521622, 4801.927971080437, 5076.7207803571155, 5079.263506791494, 5088.491150884882, 5145.253938179018, 4999.425410831201, 5067.315912351785, 5073.720945347967, 5077.771500282496, 5106.846794596094, 4969.105560999054, 4969.602431805374, 4997.975010125072, 5015.542384231773, 5031.088186489111, 4735.83424580138, 4840.7337596431125, 4882.901347196852, 4902.485239049991, 4960.677555958851, 5110.087250267312, 5555.416681248411, 5666.631668941505, 5677.971610141923, 5720.3421606515785, 3942.8817135485983, 3957.4459575660007, 3977.105151340925, 4004.379321205218, 4010.6791456682813, 5654.293213348332, 5658.688772117408, 5660.433956604306, 5663.405342438985, 5667.064934285797, 5226.8954620908125, 5466.72666366688, 5552.139418389995, 5555.694436806015, 5556.91664625039, 5505.311836020497, 5520.944790552204, 5524.475174858382, 5528.336599608073, 5573.219749235192, 5252.369715634149, 5378.489043540857, 5443.951387223167, 5495.862603434786, 5504.422035686355, 5492.917606235989, 5543.196236545759, 5607.943920560742, 5610.971945140248, 5628.915566266591, 5469.972650136724, 5480.232767412645, 5496.395396506461, 5525.392206857323, 5527.0], "value": 4048.2580632286044, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.782781588627, 738.446165375968, 747.5984271564381, 780.9613214424816, 832.9104098874527, 13718.51985180519, 14581.19803410812, 15452.768208476868, 15487.070775753462, 16294.42969496068, 14704.411823527073, 14750.0, 15130.848691513109, 15135.24323783812, 15145.167015814153, 798.2297083314601, 800.675726330834, 803.6544285957066, 804.7585724282721, 804.8873157757919, 648.2706954675989, 763.507537638223, 794.6503538443095, 797.5374282915894, 801.8797180422924, 838.5429940682343, 840.4117118017382, 843.4306842881061, 844.0757370679097, 847.6651722569612, 840.7351684219512, 841.5792103948025, 841.6591280531334, 842.751388340441, 842.9030661473917, 612.834534675635, 613.5030625193607, 613.6962203709148, 613.9140520327157, 614.3856143856144, 15092.24538773068, 15112.622184445367, 15137.318820653098, 15234.923825380802, 15244.085354878633, 15222.923885380613, 15239.466618668293, 15240.618984525365, 15446.304916278794, 15475.613109672237, 12126.878731212662, 12520.0, 12778.744425111445, 12805.807912881315, 13248.47006119754, 3855.094052897567, 3971.5829837867186, 4026.71812973092, 4034.334334834749, 4039.6768258539246, 68933.65533172352, 71023.64488177578, 71170.0, 78772.60613696894, 80223.0, 12221.0, 12288.324142172267, 12290.324032178316, 12295.56965506203, 12709.618711438672, 22718.0, 23087.307380778602, 23192.304230873102, 23204.883975580015, 23648.40878978005, 8336.958315208507, 8865.64537418509, 9018.0, 9122.680706175252, 9246.352755307198, 4985.252212168204, 5013.1978883379215, 5017.949820501822, 5233.947660523346, 5250.0, 3446.207372304384, 3541.8760343387858, 3572.5355703758346, 3573.160307327776, 3576.5529308836394, 646.8770933522616, 662.8177251255943, 666.8366250268715, 671.3655595462338, 679.8164495586165, 641.4227195524065, 647.2297965421134, 683.3132701634925, 692.2143367278176, 742.1428250370723, 9427.0, 9427.670031548863, 9445.19715824149, 9668.226541876633, 9741.9025809741, 744.2408743082134, 751.9699212031458, 761.678072002378, 765.9310662040443, 773.5668025905511, 4194.8112334945, 4285.5928686774705, 4293.377460268243, 4500.797464114057, 4613.423322084739, 111771.0, 114778.42610786893, 115828.0, 117566.0, 117604.41197794127, 90635.54682226546, 93124.0, 93531.0, 94281.0, 97528.51235743918, 54727.0, 57402.7129864348, 67439.0, 81985.59007204926, 91472.54263728639, 8196.50820950721, 8304.0, 8462.83074338522, 8500.404971652173, 8648.913510864812, 51760.482395177074, 52995.0, 53433.4656653444, 53448.73275633597, 54947.450525494234, 58020.70989645025, 70035.0, 71842.28157718565, 76011.61994189993, 77707.0, 12334.259944403364, 12633.93683031579, 12811.551595694105, 13048.217106973232, 13122.294101766709, 15101.0, 15194.468193613613, 15260.542183734506, 15938.203089845692, 16117.0, 14051.648708782363, 14639.780403293746, 14689.779653305422, 14702.926485367505, 14826.0, 13666.316684165553, 13873.79189312141, 14292.571222863331, 14450.566483005106, 14642.414303427744, 14024.0, 14912.7763083556, 15047.473338433103, 15054.849451505344, 15066.0, 11833.169744951554, 11950.223235489666, 11990.646300810848, 12108.273503589813, 12806.231626102091, 11345.659630211107, 11849.466773995364, 12013.63959081229, 12057.638270851538, 12122.818157727817], "value": 7623.042950384871, "unit": "score"}], "name": "dromaeo_css", "value": 7196.168671152996, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 106.0, 112.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 129.0, 129.0, 193.0, 130.0, 126.0, 155.0, 125.0, 180.0, 129.0], "value": 145.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 170.0, 160.0, 160.0, 161.0, 160.0, 159.0, 160.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 75.0, 121.0, 76.0, 76.0, 74.0, 73.0, 97.0, 75.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 107.0, 85.0, 84.0, 85.0, 122.0, 84.0, 84.0, 122.0], "value": 94.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 144.0, 145.0, 146.0, 144.0, 145.0, 146.0, 144.0], "value": 145.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 95.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 51.0, 52.0, 52.0, 54.0, 52.0, 53.0, 52.0, 54.0, 54.0], "value": 53.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 64.0, 63.0, 72.0, 62.0, 62.0, 63.0, 63.0, 64.0], "value": 63.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 79.0, 80.0, 81.0, 82.0, 81.0, 108.0, 80.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 133.0, 128.0, 125.0, 128.0, 122.0, 120.0, 122.0, 123.0, 122.0], "value": 125.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 165.0, 161.0, 161.0, 161.0, 161.0, 160.0, 161.0, 160.0, 160.0], "value": 160.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 66.0, 63.0, 64.0, 62.0, 62.0, 64.0, 66.0, 64.0], "value": 64.0, "unit": "score"}], "name": "kraken", "value": 1497.1000000000001, "alertThreshold": 2.0}]} 05:28:00 INFO - Return code: 0 05:28:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:28:00 INFO - # TBPL SUCCESS # 05:28:00 INFO - Running post-action listener: _resource_record_post_action 05:28:00 INFO - ##### 05:28:00 INFO - ##### Finished run-tests step (success) 05:28:00 INFO - ##### 05:28:00 INFO - Running post-run listener: _resource_record_post_run 05:28:00 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 510308352; Read time: 0; Write time: 428348 05:28:00 INFO - TinderboxPrint: CPU usage
13.2% 05:28:00 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 05:28:00 INFO - TinderboxPrint: I/O write bytes / time
510,308,352 / 428,348 05:28:00 INFO - TinderboxPrint: CPU idle
8,252.9 (86.7%) 05:28:00 INFO - TinderboxPrint: CPU user
1,212.7 (12.7%) 05:28:00 INFO - TinderboxPrint: Swap in / out
0 / 0 05:28:00 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 214306816; Read time: 0; Write time: 252680 05:28:00 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 296001536; Read time: 0; Write time: 175668 05:28:01 INFO - Running post-run listener: _upload_blobber_files 05:28:01 INFO - Blob upload gear active. 05:28:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:28:01 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:28:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:28:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:28:01 INFO - (blobuploader) - INFO - Open directory for files ... 05:28:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:28:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:28:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:28:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:28:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:28:02 INFO - (blobuploader) - INFO - Done attempting. 05:28:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:28:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:28:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:28:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:28:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:28:05 INFO - (blobuploader) - INFO - Done attempting. 05:28:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:28:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:28:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:28:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:28:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:28:06 INFO - (blobuploader) - INFO - Done attempting. 05:28:06 INFO - (blobuploader) - INFO - Iteration through files over. 05:28:06 INFO - Return code: 0 05:28:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:28:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:28:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/282656069746bf33f7c2bfde6313de5968dff25a1df0737730925c3bfb93f0208de2f48ccfdf7f2cd1007bc746fdcbc85a66fa952da7b328898cacdd6ec1e360", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/56fcd20a680cc8c9d02fb9f6c40a012bf2ad7fe9029496a5174320b53cc791b66b793edfe2bce0defb59f5d775fb777ddbe840fe05a983ffda67acd0de528f0f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f8abaa8f3b4bbce79d7c77dfd4c04b1fb160c7e06df9a6f928b5e0c2bba0331c74147a43ce98870f03b1b3340848edfaa95c070217603ce1b3ceb6282d7edcf9"} 05:28:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:28:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:28:06 INFO - Contents: 05:28:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/282656069746bf33f7c2bfde6313de5968dff25a1df0737730925c3bfb93f0208de2f48ccfdf7f2cd1007bc746fdcbc85a66fa952da7b328898cacdd6ec1e360", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/56fcd20a680cc8c9d02fb9f6c40a012bf2ad7fe9029496a5174320b53cc791b66b793edfe2bce0defb59f5d775fb777ddbe840fe05a983ffda67acd0de528f0f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f8abaa8f3b4bbce79d7c77dfd4c04b1fb160c7e06df9a6f928b5e0c2bba0331c74147a43ce98870f03b1b3340848edfaa95c070217603ce1b3ceb6282d7edcf9"} 05:28:06 INFO - Running post-run listener: copy_logs_to_upload_dir 05:28:06 INFO - Copying logs to upload dir... 05:28:06 INFO - mkdir: /builds/slave/test/build/upload/logs 05:28:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.940083 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-06-22 05:28:06.045067) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 05:28:06.048585) ========= 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=826874ccc97bd7bf541b4875000001d5-1466597247.999232-1222158116 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/282656069746bf33f7c2bfde6313de5968dff25a1df0737730925c3bfb93f0208de2f48ccfdf7f2cd1007bc746fdcbc85a66fa952da7b328898cacdd6ec1e360", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/56fcd20a680cc8c9d02fb9f6c40a012bf2ad7fe9029496a5174320b53cc791b66b793edfe2bce0defb59f5d775fb777ddbe840fe05a983ffda67acd0de528f0f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f8abaa8f3b4bbce79d7c77dfd4c04b1fb160c7e06df9a6f928b5e0c2bba0331c74147a43ce98870f03b1b3340848edfaa95c070217603ce1b3ceb6282d7edcf9"} build_url:https://queue.taskcluster.net/v1/task/KqrGmej5SOSZZs78nL-_5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011178 build_url: 'https://queue.taskcluster.net/v1/task/KqrGmej5SOSZZs78nL-_5g/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/282656069746bf33f7c2bfde6313de5968dff25a1df0737730925c3bfb93f0208de2f48ccfdf7f2cd1007bc746fdcbc85a66fa952da7b328898cacdd6ec1e360", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/56fcd20a680cc8c9d02fb9f6c40a012bf2ad7fe9029496a5174320b53cc791b66b793edfe2bce0defb59f5d775fb777ddbe840fe05a983ffda67acd0de528f0f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f8abaa8f3b4bbce79d7c77dfd4c04b1fb160c7e06df9a6f928b5e0c2bba0331c74147a43ce98870f03b1b3340848edfaa95c070217603ce1b3ceb6282d7edcf9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 05:28:06.076637) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 05:28:06.077171) ========= 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=826874ccc97bd7bf541b4875000001d5-1466597247.999232-1222158116 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004548 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 05:28:06.160095) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 05:28:06.160676) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 05:28:06.161290) ========= ========= Total master_lag: 0.18 =========