builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-021 starttime: 1465873765.69 results: success (0) buildid: 20160613173002 builduid: 80fc03783fe5462ebf300e02e53d6767 revision: 79bcc05ef105fb5362888694307faa261615c34d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-13 20:09:25.693806) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-13 20:09:25.694228) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-13 20:09:25.694525) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-13 20:09:25.722237) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 20:09:25.722498) ========= 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=df17445c3590ff7897617a0e00000225-1465871653.425313-1002655259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-13 20:09:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.8M=0s 2016-06-13 20:09:25 (46.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.145340 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 20:09:25.886177) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 20:09:25.886454) ========= 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=df17445c3590ff7897617a0e00000225-1465871653.425313-1002655259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019496 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 20:09:25.940667) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 20:09:25.940967) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 79bcc05ef105fb5362888694307faa261615c34d --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 79bcc05ef105fb5362888694307faa261615c34d --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=df17445c3590ff7897617a0e00000225-1465871653.425313-1002655259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-13 20:09:26,054 truncating revision to first 12 chars 2016-06-13 20:09:26,054 Setting DEBUG logging. 2016-06-13 20:09:26,054 attempt 1/10 2016-06-13 20:09:26,054 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/79bcc05ef105?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-13 20:09:26,401 unpacking tar archive at: fx-team-79bcc05ef105/testing/mozharness/ program finished with exit code 0 elapsedTime=0.842691 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 20:09:26.796779) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-13 20:09:26.797090) ========= script_repo_revision: 79bcc05ef105fb5362888694307faa261615c34d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-13 20:09:26.797867) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-13 20:09:26.798137) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-13 20:09:26.807002) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-13 20:09:26.807269) ========= /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=df17445c3590ff7897617a0e00000225-1465871653.425313-1002655259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:09:27 INFO - MultiFileLogger online at 20160613 20:09:27 in /builds/slave/test 20:09:27 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 20:09:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:09:27 INFO - {'append_to_log': False, 20:09:27 INFO - 'base_work_dir': '/builds/slave/test', 20:09:27 INFO - 'blob_upload_branch': 'Fx-Team', 20:09:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:09:27 INFO - 'branch': 'Fx-Team', 20:09:27 INFO - 'buildbot_json_path': 'buildprops.json', 20:09:27 INFO - 'config_files': ('talos/linux_config.py',), 20:09:27 INFO - 'default_actions': ('clobber', 20:09:27 INFO - 'read-buildbot-config', 20:09:27 INFO - 'download-and-extract', 20:09:27 INFO - 'populate-webroot', 20:09:27 INFO - 'create-virtualenv', 20:09:27 INFO - 'install', 20:09:27 INFO - 'run-tests'), 20:09:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:09:27 INFO - 'download_minidump_stackwalk': True, 20:09:27 INFO - 'download_symbols': 'ondemand', 20:09:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:09:27 INFO - 'tooltool.py': '/tools/tooltool.py', 20:09:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:09:27 INFO - '/tools/misc-python/virtualenv.py')}, 20:09:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:09:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:09:27 INFO - 'installer_path': 'installer.exe', 20:09:27 INFO - 'log_level': 'info', 20:09:27 INFO - 'log_name': 'talos', 20:09:27 INFO - 'log_to_console': True, 20:09:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:09:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:09:27 INFO - 'opt_config_files': (), 20:09:27 INFO - 'pip_index': False, 20:09:27 INFO - 'sps_profile': False, 20:09:27 INFO - 'sps_profile_interval': 0, 20:09:27 INFO - 'suite': 'dromaeojs', 20:09:27 INFO - 'system_bits': '32', 20:09:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:09:27 INFO - 'title': 'talos-linux64-ix-021', 20:09:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:09:27 INFO - 'use_talos_json': True, 20:09:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:09:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:09:27 INFO - 'work_dir': 'build'} 20:09:27 INFO - ##### 20:09:27 INFO - ##### Running clobber step. 20:09:27 INFO - ##### 20:09:27 INFO - Running pre-action listener: _resource_record_pre_action 20:09:27 INFO - Running main action method: clobber 20:09:27 INFO - rmtree: /builds/slave/test/build 20:09:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:09:27 INFO - Running post-action listener: _resource_record_post_action 20:09:27 INFO - ##### 20:09:27 INFO - ##### Finished clobber step (success) 20:09:27 INFO - ##### 20:09:27 INFO - ##### 20:09:27 INFO - ##### Running read-buildbot-config step. 20:09:27 INFO - ##### 20:09:27 INFO - Running pre-action listener: _resource_record_pre_action 20:09:27 INFO - Running main action method: read_buildbot_config 20:09:27 INFO - Using buildbot properties: 20:09:27 INFO - { 20:09:27 INFO - "project": "", 20:09:27 INFO - "product": "firefox", 20:09:27 INFO - "script_repo_revision": "production", 20:09:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:09:27 INFO - "repository": "", 20:09:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 20:09:27 INFO - "buildid": "20160613173002", 20:09:27 INFO - "pgo_build": "True", 20:09:27 INFO - "basedir": "/builds/slave/test", 20:09:27 INFO - "buildnumber": 184, 20:09:27 INFO - "slavename": "talos-linux64-ix-021", 20:09:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:09:27 INFO - "platform": "ubuntu64_hw", 20:09:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:09:27 INFO - "branch": "fx-team", 20:09:27 INFO - "repo_path": "integration/fx-team", 20:09:27 INFO - "revision": "79bcc05ef105fb5362888694307faa261615c34d", 20:09:27 INFO - "stage_platform": "linux64-pgo", 20:09:27 INFO - "builduid": "80fc03783fe5462ebf300e02e53d6767", 20:09:27 INFO - "slavebuilddir": "test" 20:09:27 INFO - } 20:09:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/VdRlrr5EToObkXHZ4mSutA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 20:09:27 INFO - Running post-action listener: _resource_record_post_action 20:09:27 INFO - ##### 20:09:27 INFO - ##### Finished read-buildbot-config step (success) 20:09:27 INFO - ##### 20:09:27 INFO - ##### 20:09:27 INFO - ##### Running download-and-extract step. 20:09:27 INFO - ##### 20:09:27 INFO - Running pre-action listener: _resource_record_pre_action 20:09:27 INFO - Running main action method: download_and_extract 20:09:27 INFO - mkdir: /builds/slave/test/build/tests 20:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:27 INFO - https://queue.taskcluster.net/v1/task/VdRlrr5EToObkXHZ4mSutA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:09:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdRlrr5EToObkXHZ4mSutA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:09:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdRlrr5EToObkXHZ4mSutA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:09:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdRlrr5EToObkXHZ4mSutA/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 20:09:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdRlrr5EToObkXHZ4mSutA/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 20:09:29 INFO - Downloaded 1361 bytes. 20:09:29 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:09:29 INFO - Using the following test package requirements: 20:09:29 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:09:29 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:09:29 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:09:29 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:29 INFO - u'jsshell-linux-x86_64.zip'], 20:09:29 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:09:29 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:09:29 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:09:29 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:09:29 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:09:29 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:09:29 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:09:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:29 INFO - https://queue.taskcluster.net/v1/task/VdRlrr5EToObkXHZ4mSutA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:09:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdRlrr5EToObkXHZ4mSutA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:09:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdRlrr5EToObkXHZ4mSutA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:09:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdRlrr5EToObkXHZ4mSutA/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 20:09:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdRlrr5EToObkXHZ4mSutA/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 20:09:31 INFO - Downloaded 24219727 bytes. 20:09:31 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'] 20:09:31 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 20:09:32 INFO - Return code: 0 20:09:32 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 20:09:32 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')]} 20:09:32 INFO - https://queue.taskcluster.net/v1/task/VdRlrr5EToObkXHZ4mSutA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:09:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdRlrr5EToObkXHZ4mSutA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:09:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdRlrr5EToObkXHZ4mSutA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:09:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdRlrr5EToObkXHZ4mSutA/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 20:09:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdRlrr5EToObkXHZ4mSutA/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 20:09:35 INFO - Downloaded 24219727 bytes. 20:09:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:09:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:09:37 INFO - Return code: 0 20:09:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:37 INFO - https://queue.taskcluster.net/v1/task/VdRlrr5EToObkXHZ4mSutA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:09:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdRlrr5EToObkXHZ4mSutA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:09:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdRlrr5EToObkXHZ4mSutA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:09:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdRlrr5EToObkXHZ4mSutA/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 20:09:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdRlrr5EToObkXHZ4mSutA/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 20:09:38 INFO - Downloaded 14405384 bytes. 20:09:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:09:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 20:09:38 INFO - Return code: 0 20:09: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')]} 20:09:38 INFO - https://queue.taskcluster.net/v1/task/VdRlrr5EToObkXHZ4mSutA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:09:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdRlrr5EToObkXHZ4mSutA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:09:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdRlrr5EToObkXHZ4mSutA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:09:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdRlrr5EToObkXHZ4mSutA/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 20:09:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdRlrr5EToObkXHZ4mSutA/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 20:09:39 INFO - Downloaded 59358540 bytes. 20:09:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VdRlrr5EToObkXHZ4mSutA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:09:39 INFO - mkdir: /builds/slave/test/properties 20:09:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:09:39 INFO - Writing to file /builds/slave/test/properties/build_url 20:09:39 INFO - Contents: 20:09:39 INFO - build_url:https://queue.taskcluster.net/v1/task/VdRlrr5EToObkXHZ4mSutA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:09:40 INFO - Running post-action listener: _resource_record_post_action 20:09:40 INFO - Running post-action listener: set_extra_try_arguments 20:09:40 INFO - ##### 20:09:40 INFO - ##### Finished download-and-extract step (success) 20:09:40 INFO - ##### 20:09:40 INFO - ##### 20:09:40 INFO - ##### Running populate-webroot step. 20:09:40 INFO - ##### 20:09:40 INFO - Running pre-action listener: _resource_record_pre_action 20:09:40 INFO - Running main action method: populate_webroot 20:09:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:09:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:09:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:09:40 INFO - '--tppagecycles', 20:09:40 INFO - '7'], 20:09:40 INFO - 'tests': ['tsvgm']}}, 20:09:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:09:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:09:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:09:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:09:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:09:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:09:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:40 INFO - 'talos_options': ['--disable-e10s'], 20:09:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:09:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:09:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:40 INFO - 'talos_options': ['--disable-e10s'], 20:09:40 INFO - 'tests': ['damp', 'tps']}, 20:09:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:40 INFO - 'tests': ['damp', 'tps']}, 20:09:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:09:40 INFO - 'tests': ['dromaeo_dom']}, 20:09:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:09:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:09:40 INFO - 'tests': ['basic_compositor_video']}, 20:09:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:09:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:09:40 INFO - 'tests': ['a11yr', 20:09:40 INFO - 'ts_paint', 20:09:40 INFO - 'tpaint', 20:09:40 INFO - 'sessionrestore', 20:09:40 INFO - 'sessionrestore_no_auto_restore', 20:09:40 INFO - 'tabpaint']}, 20:09:40 INFO - 'other-e10s': {'tests': ['a11yr', 20:09:40 INFO - 'ts_paint', 20:09:40 INFO - 'tpaint', 20:09:40 INFO - 'sessionrestore', 20:09:40 INFO - 'sessionrestore_no_auto_restore', 20:09:40 INFO - 'tabpaint']}, 20:09:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:09:40 INFO - 'ts_paint', 20:09:40 INFO - 'tpaint', 20:09:40 INFO - 'sessionrestore', 20:09:40 INFO - 'sessionrestore_no_auto_restore', 20:09:40 INFO - 'tabpaint']}, 20:09:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:09:40 INFO - 'ts_paint', 20:09:40 INFO - 'tpaint', 20:09:40 INFO - 'sessionrestore', 20:09:40 INFO - 'sessionrestore_no_auto_restore', 20:09:40 INFO - 'tabpaint']}, 20:09:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:09:40 INFO - 'tests': ['a11yr', 20:09:40 INFO - 'ts_paint', 20:09:40 INFO - 'tpaint', 20:09:40 INFO - 'sessionrestore', 20:09:40 INFO - 'sessionrestore_no_auto_restore', 20:09:40 INFO - 'tabpaint']}, 20:09:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:09:40 INFO - 'tests': ['a11yr', 20:09:40 INFO - 'ts_paint', 20:09:40 INFO - 'tpaint', 20:09:40 INFO - 'sessionrestore', 20:09:40 INFO - 'sessionrestore_no_auto_restore', 20:09:40 INFO - 'tabpaint']}, 20:09:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:09:40 INFO - 'tests': ['tsvgx', 20:09:40 INFO - 'tsvgr_opacity', 20:09:40 INFO - 'tart', 20:09:40 INFO - 'tscrollx', 20:09:40 INFO - 'cart']}, 20:09:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:09:40 INFO - 'tsvgr_opacity', 20:09:40 INFO - 'tart', 20:09:40 INFO - 'tscrollx', 20:09:40 INFO - 'cart']}, 20:09:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:40 INFO - 'talos_options': ['--disable-e10s'], 20:09:40 INFO - 'tests': ['tp5o']}, 20:09:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:40 INFO - 'tests': ['tp5o']}, 20:09:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:40 INFO - 'talos_options': ['--disable-e10s', 20:09:40 INFO - '--xperf_path', 20:09:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:09:40 INFO - 'tests': ['tp5n']}, 20:09:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:40 INFO - 'talos_options': ['--xperf_path', 20:09:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:09:40 INFO - 'tests': ['tp5n']}}, 20:09:40 INFO - 'talos.zip': {'path': '', 20:09:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:09:40 INFO - Running post-action listener: _resource_record_post_action 20:09:40 INFO - ##### 20:09:40 INFO - ##### Finished populate-webroot step (success) 20:09:40 INFO - ##### 20:09:40 INFO - ##### 20:09:40 INFO - ##### Running create-virtualenv step. 20:09:40 INFO - ##### 20:09:40 INFO - Running pre-action listener: _resource_record_pre_action 20:09:40 INFO - Running main action method: create_virtualenv 20:09:40 INFO - Creating virtualenv /builds/slave/test/build/venv 20:09:40 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 20:09:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:09:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:09:40 INFO - Using real prefix '/usr' 20:09:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:09:41 INFO - Installing distribute.............................................................................................................................................................................................done. 20:09:43 INFO - Installing pip.................done. 20:09:43 INFO - Return code: 0 20:09:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f20e91acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1164350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f31c0>, '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 0x11f40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f4550>, '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': 'df17445c3590ff7897617a0e00000225-1465871653.425313-1002655259', '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 20:09:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:09:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:09:43 INFO - Using env: {'DISPLAY': ':0', 20:09:43 INFO - 'HOME': '/home/cltbld', 20:09:43 INFO - 'LANG': 'en_US.UTF-8', 20:09:43 INFO - 'LANGUAGE': 'en_US:en', 20:09:43 INFO - 'LOGNAME': 'cltbld', 20:09:43 INFO - 'MAIL': '/var/mail/cltbld', 20:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:43 INFO - 'MOZ_NO_REMOTE': '1', 20:09:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:43 INFO - 'NO_EM_RESTART': '1', 20:09:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:43 INFO - 'PWD': '/builds/slave/test', 20:09:43 INFO - 'SHELL': '/bin/bash', 20:09:43 INFO - 'SHLVL': '1', 20:09:43 INFO - 'TERM': 'linux', 20:09:43 INFO - 'TMOUT': '86400', 20:09:43 INFO - 'USER': 'cltbld', 20:09:43 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465871653.425313-1002655259', 20:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:43 INFO - '_': '/tools/buildbot/bin/python'} 20:09:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 20:09:43 INFO - Cleaning up... 20:09:43 INFO - Return code: 0 20:09:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f20e91acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1164350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f31c0>, '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 0x11f40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f4550>, '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': 'df17445c3590ff7897617a0e00000225-1465871653.425313-1002655259', '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 20:09:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:09:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:09:43 INFO - Using env: {'DISPLAY': ':0', 20:09:43 INFO - 'HOME': '/home/cltbld', 20:09:43 INFO - 'LANG': 'en_US.UTF-8', 20:09:43 INFO - 'LANGUAGE': 'en_US:en', 20:09:43 INFO - 'LOGNAME': 'cltbld', 20:09:43 INFO - 'MAIL': '/var/mail/cltbld', 20:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:43 INFO - 'MOZ_NO_REMOTE': '1', 20:09:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:43 INFO - 'NO_EM_RESTART': '1', 20:09:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:43 INFO - 'PWD': '/builds/slave/test', 20:09:43 INFO - 'SHELL': '/bin/bash', 20:09:43 INFO - 'SHLVL': '1', 20:09:43 INFO - 'TERM': 'linux', 20:09:43 INFO - 'TMOUT': '86400', 20:09:43 INFO - 'USER': 'cltbld', 20:09:43 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465871653.425313-1002655259', 20:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:43 INFO - '_': '/tools/buildbot/bin/python'} 20:09:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:43 INFO - Downloading/unpacking psutil>=3.1.1 20:09:43 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 20:09:43 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 20:09:43 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 20:09:43 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 20:09:43 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 20:09:43 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 20:09:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:09:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:09:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:09:45 INFO - Installing collected packages: psutil 20:09:45 INFO - Running setup.py install for psutil 20:09:45 INFO - building 'psutil._psutil_linux' extension 20:09:45 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 20:09:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 20:09:46 INFO - building 'psutil._psutil_posix' extension 20:09:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 20:09:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 20:09:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:09:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:09:46 INFO - Successfully installed psutil 20:09:46 INFO - Cleaning up... 20:09:46 INFO - Return code: 0 20:09:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:09: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')]} 20:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09: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')]} 20:09:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f20e91acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1164350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f31c0>, '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 0x11f40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f4550>, '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': 'df17445c3590ff7897617a0e00000225-1465871653.425313-1002655259', '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 20:09:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:09:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:09:46 INFO - Using env: {'DISPLAY': ':0', 20:09:46 INFO - 'HOME': '/home/cltbld', 20:09:46 INFO - 'LANG': 'en_US.UTF-8', 20:09:46 INFO - 'LANGUAGE': 'en_US:en', 20:09:46 INFO - 'LOGNAME': 'cltbld', 20:09:46 INFO - 'MAIL': '/var/mail/cltbld', 20:09:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:46 INFO - 'MOZ_NO_REMOTE': '1', 20:09:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:46 INFO - 'NO_EM_RESTART': '1', 20:09:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:46 INFO - 'PWD': '/builds/slave/test', 20:09:46 INFO - 'SHELL': '/bin/bash', 20:09:46 INFO - 'SHLVL': '1', 20:09:46 INFO - 'TERM': 'linux', 20:09:46 INFO - 'TMOUT': '86400', 20:09:46 INFO - 'USER': 'cltbld', 20:09:46 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465871653.425313-1002655259', 20:09:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:46 INFO - '_': '/tools/buildbot/bin/python'} 20:09:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:09: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 20:09: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 20:09: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 20:09: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 20:09: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 20:09: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 20:09:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:09:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:09:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:09:48 INFO - Installing collected packages: mozsystemmonitor 20:09:48 INFO - Running setup.py install for mozsystemmonitor 20:09:48 INFO - Successfully installed mozsystemmonitor 20:09:48 INFO - Cleaning up... 20:09:48 INFO - Return code: 0 20:09:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:09: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')]} 20:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09: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')]} 20:09:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f20e91acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1164350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f31c0>, '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 0x11f40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f4550>, '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': 'df17445c3590ff7897617a0e00000225-1465871653.425313-1002655259', '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 20:09:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:09:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:09:48 INFO - Using env: {'DISPLAY': ':0', 20:09:48 INFO - 'HOME': '/home/cltbld', 20:09:48 INFO - 'LANG': 'en_US.UTF-8', 20:09:48 INFO - 'LANGUAGE': 'en_US:en', 20:09:48 INFO - 'LOGNAME': 'cltbld', 20:09:48 INFO - 'MAIL': '/var/mail/cltbld', 20:09:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:48 INFO - 'MOZ_NO_REMOTE': '1', 20:09:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:48 INFO - 'NO_EM_RESTART': '1', 20:09:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:48 INFO - 'PWD': '/builds/slave/test', 20:09:48 INFO - 'SHELL': '/bin/bash', 20:09:48 INFO - 'SHLVL': '1', 20:09:48 INFO - 'TERM': 'linux', 20:09:48 INFO - 'TMOUT': '86400', 20:09:48 INFO - 'USER': 'cltbld', 20:09:48 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465871653.425313-1002655259', 20:09:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:48 INFO - '_': '/tools/buildbot/bin/python'} 20:09:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:48 INFO - Downloading/unpacking jsonschema==2.5.1 20:09: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 20:09: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 20:09: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 20:09: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 20:09: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 20:09: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 20:09:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:09:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:50 INFO - Downloading functools32-3.2.3-2.tar.gz 20:09:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:09:51 INFO - warning: no files found matching '*.txt' 20:09:51 INFO - no previously-included directories found matching 'build' 20:09:51 INFO - no previously-included directories found matching 'dist' 20:09:51 INFO - no previously-included directories found matching '.git*' 20:09:51 INFO - Installing collected packages: jsonschema, functools32 20:09:51 INFO - Running setup.py install for functools32 20:09:51 INFO - warning: no files found matching '*.txt' 20:09:51 INFO - no previously-included directories found matching 'build' 20:09:51 INFO - no previously-included directories found matching 'dist' 20:09:51 INFO - no previously-included directories found matching '.git*' 20:09:51 INFO - Successfully installed jsonschema functools32 20:09:51 INFO - Cleaning up... 20:09:51 INFO - Return code: 0 20:09:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:09: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')]} 20:09:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09: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')]} 20:09:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f20e91acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1164350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f31c0>, '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 0x11f40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f4550>, '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': 'df17445c3590ff7897617a0e00000225-1465871653.425313-1002655259', '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 20:09:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:09:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:09:51 INFO - Using env: {'DISPLAY': ':0', 20:09:51 INFO - 'HOME': '/home/cltbld', 20:09:51 INFO - 'LANG': 'en_US.UTF-8', 20:09:51 INFO - 'LANGUAGE': 'en_US:en', 20:09:51 INFO - 'LOGNAME': 'cltbld', 20:09:51 INFO - 'MAIL': '/var/mail/cltbld', 20:09:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:51 INFO - 'MOZ_NO_REMOTE': '1', 20:09:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:51 INFO - 'NO_EM_RESTART': '1', 20:09:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:51 INFO - 'PWD': '/builds/slave/test', 20:09:51 INFO - 'SHELL': '/bin/bash', 20:09:51 INFO - 'SHLVL': '1', 20:09:51 INFO - 'TERM': 'linux', 20:09:51 INFO - 'TMOUT': '86400', 20:09:51 INFO - 'USER': 'cltbld', 20:09:51 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465871653.425313-1002655259', 20:09:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:51 INFO - '_': '/tools/buildbot/bin/python'} 20:09:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:51 INFO - Downloading/unpacking blobuploader==1.2.4 20:09: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 20:09: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 20:09: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 20:09: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 20:09: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 20:09: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 20:09:53 INFO - Downloading blobuploader-1.2.4.tar.gz 20:09:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:09:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:09: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 20:09: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 20:09: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 20:09: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 20:09: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 20:09: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 20:09:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:09:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:09: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 20:09: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 20:09: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 20:09: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 20:09: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 20:09: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 20:09:54 INFO - Downloading docopt-0.6.1.tar.gz 20:09:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:09:54 INFO - Installing collected packages: blobuploader, requests, docopt 20:09:54 INFO - Running setup.py install for blobuploader 20:09:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:09:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:09:54 INFO - Running setup.py install for requests 20:09:54 INFO - Running setup.py install for docopt 20:09:54 INFO - Successfully installed blobuploader requests docopt 20:09:54 INFO - Cleaning up... 20:09:54 INFO - Return code: 0 20:09:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f20e91acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1164350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f31c0>, '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 0x11f40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f4550>, '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': 'df17445c3590ff7897617a0e00000225-1465871653.425313-1002655259', '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 20:09:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:09:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:09:54 INFO - Using env: {'DISPLAY': ':0', 20:09:54 INFO - 'HOME': '/home/cltbld', 20:09:54 INFO - 'LANG': 'en_US.UTF-8', 20:09:54 INFO - 'LANGUAGE': 'en_US:en', 20:09:54 INFO - 'LOGNAME': 'cltbld', 20:09:54 INFO - 'MAIL': '/var/mail/cltbld', 20:09:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:54 INFO - 'MOZ_NO_REMOTE': '1', 20:09:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:54 INFO - 'NO_EM_RESTART': '1', 20:09:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:54 INFO - 'PWD': '/builds/slave/test', 20:09:54 INFO - 'SHELL': '/bin/bash', 20:09:54 INFO - 'SHLVL': '1', 20:09:54 INFO - 'TERM': 'linux', 20:09:54 INFO - 'TMOUT': '86400', 20:09:54 INFO - 'USER': 'cltbld', 20:09:54 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465871653.425313-1002655259', 20:09:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:54 INFO - '_': '/tools/buildbot/bin/python'} 20:09:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:09:54 INFO - Running setup.py (path:/tmp/pip-Bl1il5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:09:54 INFO - Running setup.py (path:/tmp/pip-gRctj1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:09:55 INFO - Running setup.py (path:/tmp/pip-mxtKIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:09:55 INFO - Running setup.py (path:/tmp/pip-A_7vbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:09:55 INFO - Running setup.py (path:/tmp/pip-CDLJLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:09:55 INFO - Running setup.py (path:/tmp/pip-bnaI2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:09:55 INFO - Running setup.py (path:/tmp/pip-9ob0HB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:09:55 INFO - Running setup.py (path:/tmp/pip-R51wSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:09:55 INFO - Running setup.py (path:/tmp/pip-4KE7wU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:09:55 INFO - Running setup.py (path:/tmp/pip-SLPCEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:09:55 INFO - Running setup.py (path:/tmp/pip-59hicz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:09:55 INFO - Running setup.py (path:/tmp/pip-oUct6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:09:55 INFO - Running setup.py (path:/tmp/pip-3jcuRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:09:55 INFO - Running setup.py (path:/tmp/pip-i4Acoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:09:55 INFO - Running setup.py (path:/tmp/pip-NpbGy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:09:56 INFO - Running setup.py (path:/tmp/pip-Yas2xm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:09:56 INFO - Running setup.py (path:/tmp/pip-Y53Ty_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:09:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:09:56 INFO - Running setup.py install for manifestparser 20:09:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:09:56 INFO - Running setup.py install for mozcrash 20:09:56 INFO - Running setup.py install for mozdebug 20:09:56 INFO - Running setup.py install for mozdevice 20:09:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:09:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:09:56 INFO - Running setup.py install for mozfile 20:09:56 INFO - Running setup.py install for mozhttpd 20:09:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:09:56 INFO - Running setup.py install for mozinfo 20:09:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:09:56 INFO - Running setup.py install for mozInstall 20:09:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:09:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:09:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:09:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:09:56 INFO - Running setup.py install for mozleak 20:09:57 INFO - Running setup.py install for mozlog 20:09:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:09:57 INFO - Running setup.py install for moznetwork 20:09:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:09:57 INFO - Running setup.py install for mozprocess 20:09:57 INFO - Running setup.py install for mozprofile 20:09:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:09:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:09:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:09:57 INFO - Running setup.py install for mozrunner 20:09:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:09:57 INFO - Running setup.py install for mozscreenshot 20:09:57 INFO - Running setup.py install for moztest 20:09:57 INFO - Running setup.py install for mozversion 20:09:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:09:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:09:57 INFO - Cleaning up... 20:09:57 INFO - Return code: 0 20:09:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:09: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')]} 20:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09: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')]} 20:09:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:57 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 0x7f20e91acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1164350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f31c0>, '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 0x11f40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f4550>, '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': 'df17445c3590ff7897617a0e00000225-1465871653.425313-1002655259', '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 20:09:57 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 20:09:57 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 20:09:57 INFO - Using env: {'DISPLAY': ':0', 20:09:57 INFO - 'HOME': '/home/cltbld', 20:09:57 INFO - 'LANG': 'en_US.UTF-8', 20:09:57 INFO - 'LANGUAGE': 'en_US:en', 20:09:57 INFO - 'LOGNAME': 'cltbld', 20:09:57 INFO - 'MAIL': '/var/mail/cltbld', 20:09:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:57 INFO - 'MOZ_NO_REMOTE': '1', 20:09:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:57 INFO - 'NO_EM_RESTART': '1', 20:09:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:57 INFO - 'PWD': '/builds/slave/test', 20:09:57 INFO - 'SHELL': '/bin/bash', 20:09:57 INFO - 'SHLVL': '1', 20:09:57 INFO - 'TERM': 'linux', 20:09:57 INFO - 'TMOUT': '86400', 20:09:57 INFO - 'USER': 'cltbld', 20:09:57 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465871653.425313-1002655259', 20:09:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:57 INFO - '_': '/tools/buildbot/bin/python'} 20:09:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:09:58 INFO - Running setup.py (path:/tmp/pip-e_qp2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 20:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:09:58 INFO - Running setup.py (path:/tmp/pip-ss8YiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:09:58 INFO - Running setup.py (path:/tmp/pip-gdt4Ur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:09:58 INFO - Running setup.py (path:/tmp/pip-YY_CiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:09:58 INFO - Running setup.py (path:/tmp/pip-AvqPeO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 20:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:09:58 INFO - Running setup.py (path:/tmp/pip-2X9vtr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 20:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:09:58 INFO - Running setup.py (path:/tmp/pip-PwULpj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 20:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:09:58 INFO - Running setup.py (path:/tmp/pip-UaggBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 20:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:09:58 INFO - Running setup.py (path:/tmp/pip-0ea2Qw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:09:58 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)) 20:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:09:58 INFO - Running setup.py (path:/tmp/pip-TeXDXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:09:58 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)) 20:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:09:58 INFO - Running setup.py (path:/tmp/pip-GDwiQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:09:58 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)) 20:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:09:58 INFO - Running setup.py (path:/tmp/pip-mkJzz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:09:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:09:59 INFO - Running setup.py (path:/tmp/pip-ObuEfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:09:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 20:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:09:59 INFO - Running setup.py (path:/tmp/pip-UvAy3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:09:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:09:59 INFO - Running setup.py (path:/tmp/pip-HdNY4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:09:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 20:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:09:59 INFO - Running setup.py (path:/tmp/pip-4p1Kiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:09:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 20:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:09:59 INFO - Running setup.py (path:/tmp/pip-I0b21j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:09:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 20:09:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:09:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:09:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:09:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:09:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:09:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:09:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:01 INFO - Downloading blessings-1.6.tar.gz 20:10:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:10:01 INFO - Installing collected packages: blessings 20:10:01 INFO - Running setup.py install for blessings 20:10:01 INFO - Successfully installed blessings 20:10:01 INFO - Cleaning up... 20:10:01 INFO - Return code: 0 20:10:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:10:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:10:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:10:01 INFO - Reading from file tmpfile_stdout 20:10:01 INFO - Current package versions: 20:10:01 INFO - argparse == 1.2.1 20:10:01 INFO - blessings == 1.6 20:10:01 INFO - blobuploader == 1.2.4 20:10:01 INFO - docopt == 0.6.1 20:10:01 INFO - functools32 == 3.2.3-2 20:10:01 INFO - jsonschema == 2.5.1 20:10:01 INFO - manifestparser == 1.1 20:10:01 INFO - mozInstall == 1.12 20:10:01 INFO - mozcrash == 0.17 20:10:01 INFO - mozdebug == 0.1 20:10:01 INFO - mozdevice == 0.48 20:10:01 INFO - mozfile == 1.2 20:10:01 INFO - mozhttpd == 0.7 20:10:01 INFO - mozinfo == 0.9 20:10:01 INFO - mozleak == 0.1 20:10:01 INFO - mozlog == 3.2 20:10:01 INFO - moznetwork == 0.27 20:10:01 INFO - mozprocess == 0.22 20:10:01 INFO - mozprofile == 0.28 20:10:01 INFO - mozrunner == 6.11 20:10:01 INFO - mozscreenshot == 0.1 20:10:01 INFO - mozsystemmonitor == 0.3 20:10:01 INFO - moztest == 0.7 20:10:01 INFO - mozversion == 1.4 20:10:01 INFO - psutil == 3.1.1 20:10:01 INFO - requests == 1.2.3 20:10:01 INFO - wsgiref == 0.1.2 20:10:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:10:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f20e91acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1164350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f31c0>, '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 0x11f40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f4550>, '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': 'df17445c3590ff7897617a0e00000225-1465871653.425313-1002655259', '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 20:10:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 20:10:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:10:01 INFO - Using env: {'DISPLAY': ':0', 20:10:01 INFO - 'HOME': '/home/cltbld', 20:10:01 INFO - 'LANG': 'en_US.UTF-8', 20:10:01 INFO - 'LANGUAGE': 'en_US:en', 20:10:01 INFO - 'LOGNAME': 'cltbld', 20:10:01 INFO - 'MAIL': '/var/mail/cltbld', 20:10:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:01 INFO - 'MOZ_NO_REMOTE': '1', 20:10:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:01 INFO - 'NO_EM_RESTART': '1', 20:10:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:01 INFO - 'PWD': '/builds/slave/test', 20:10:01 INFO - 'SHELL': '/bin/bash', 20:10:01 INFO - 'SHLVL': '1', 20:10:01 INFO - 'TERM': 'linux', 20:10:01 INFO - 'TMOUT': '86400', 20:10:01 INFO - 'USER': 'cltbld', 20:10:01 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465871653.425313-1002655259', 20:10:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:01 INFO - '_': '/tools/buildbot/bin/python'} 20:10:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:01 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)) 20:10:01 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)) 20:10:01 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)) 20:10:01 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)) 20:10:01 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)) 20:10:01 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)) 20:10:01 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)) 20:10:01 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)) 20:10:01 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)) 20:10:01 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)) 20:10:01 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)) 20:10:01 INFO - Cleaning up... 20:10:01 INFO - Return code: 0 20:10:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:10:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:01 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 0x7f20e91acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1164350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f31c0>, '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 0x11f40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f4550>, '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': 'df17445c3590ff7897617a0e00000225-1465871653.425313-1002655259', '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 20:10:01 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 20:10:01 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 20:10:01 INFO - Using env: {'DISPLAY': ':0', 20:10:01 INFO - 'HOME': '/home/cltbld', 20:10:01 INFO - 'LANG': 'en_US.UTF-8', 20:10:01 INFO - 'LANGUAGE': 'en_US:en', 20:10:01 INFO - 'LOGNAME': 'cltbld', 20:10:01 INFO - 'MAIL': '/var/mail/cltbld', 20:10:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:01 INFO - 'MOZ_NO_REMOTE': '1', 20:10:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:01 INFO - 'NO_EM_RESTART': '1', 20:10:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:01 INFO - 'PWD': '/builds/slave/test', 20:10:01 INFO - 'SHELL': '/bin/bash', 20:10:01 INFO - 'SHLVL': '1', 20:10:01 INFO - 'TERM': 'linux', 20:10:01 INFO - 'TMOUT': '86400', 20:10:01 INFO - 'USER': 'cltbld', 20:10:01 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465871653.425313-1002655259', 20:10:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:01 INFO - '_': '/tools/buildbot/bin/python'} 20:10:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:10:02 INFO - Cleaning up... 20:10:02 INFO - Return code: 0 20:10:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:10:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f20e91acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1164350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f31c0>, '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 0x11f40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f4550>, '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': 'df17445c3590ff7897617a0e00000225-1465871653.425313-1002655259', '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 20:10:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 20:10:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 20:10:02 INFO - Using env: {'DISPLAY': ':0', 20:10:02 INFO - 'HOME': '/home/cltbld', 20:10:02 INFO - 'LANG': 'en_US.UTF-8', 20:10:02 INFO - 'LANGUAGE': 'en_US:en', 20:10:02 INFO - 'LOGNAME': 'cltbld', 20:10:02 INFO - 'MAIL': '/var/mail/cltbld', 20:10:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:02 INFO - 'MOZ_NO_REMOTE': '1', 20:10:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:02 INFO - 'NO_EM_RESTART': '1', 20:10:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:02 INFO - 'PWD': '/builds/slave/test', 20:10:02 INFO - 'SHELL': '/bin/bash', 20:10:02 INFO - 'SHLVL': '1', 20:10:02 INFO - 'TERM': 'linux', 20:10:02 INFO - 'TMOUT': '86400', 20:10:02 INFO - 'USER': 'cltbld', 20:10:02 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465871653.425313-1002655259', 20:10:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:02 INFO - '_': '/tools/buildbot/bin/python'} 20:10:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:02 INFO - Downloading/unpacking flake8 20:10:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:10:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:10: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 20:10: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 20:10: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 20:10: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 20:10: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 20:10: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 20:10:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:10:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:10: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 20:10: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 20:10: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 20:10: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 20:10: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 20:10: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 20:10:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:10: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 20:10: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 20:10: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 20:10: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 20:10: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 20:10: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 20:10:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:10:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:10:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:10:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:10:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:10:04 INFO - no previously-included directories found matching 'docs/_build' 20:10:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:10:05 INFO - Running setup.py install for pep8 20:10:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:10:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:10:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:10:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:10:05 INFO - no previously-included directories found matching 'docs/_build' 20:10:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:10:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:10:05 INFO - Cleaning up... 20:10:05 INFO - Return code: 0 20:10:05 INFO - Running post-action listener: _resource_record_post_action 20:10:05 INFO - Running post-action listener: _start_resource_monitoring 20:10:05 INFO - Starting resource monitoring. 20:10:05 INFO - ##### 20:10:05 INFO - ##### Finished create-virtualenv step (success) 20:10:05 INFO - ##### 20:10:05 INFO - ##### 20:10:05 INFO - ##### Running install step. 20:10:05 INFO - ##### 20:10:05 INFO - Running pre-action listener: _resource_record_pre_action 20:10:05 INFO - Running main action method: install 20:10:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:10:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:10:05 INFO - Reading from file tmpfile_stdout 20:10:05 INFO - Detecting whether we're running mozinstall >=1.0... 20:10:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:10:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:10:05 INFO - Reading from file tmpfile_stdout 20:10:05 INFO - Output received: 20:10:05 INFO - Usage: mozinstall [options] installer 20:10:05 INFO - Options: 20:10:05 INFO - -h, --help show this help message and exit 20:10:05 INFO - -d DEST, --destination=DEST 20:10:05 INFO - Directory to install application into. [default: 20:10:05 INFO - "/builds/slave/test"] 20:10:05 INFO - --app=APP Application being installed. [default: firefox] 20:10:05 INFO - mkdir: /builds/slave/test/build/application 20:10:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:10:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:10:22 INFO - Reading from file tmpfile_stdout 20:10:22 INFO - Output received: 20:10:22 INFO - /builds/slave/test/build/application/firefox/firefox 20:10:22 INFO - Running post-action listener: _resource_record_post_action 20:10:22 INFO - ##### 20:10:22 INFO - ##### Finished install step (success) 20:10:22 INFO - ##### 20:10:22 INFO - ##### 20:10:22 INFO - ##### Running run-tests step. 20:10:22 INFO - ##### 20:10:22 INFO - Running pre-action listener: _resource_record_pre_action 20:10:22 INFO - Running main action method: run_tests 20:10:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:10:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:10:22 INFO - Python 2.7.3 20:10:22 INFO - Return code: 0 20:10:22 INFO - grabbing minidump binary from tooltool 20:10:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:22 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f31c0>, '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 0x11f40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f4550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:10:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 20:10:22 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 20:10:22 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 20:10:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:10:22 INFO - Return code: 0 20:10:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:10:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:10:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:10:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:10:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:10:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:10:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:10:23 INFO - Return code: 0 20:10:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VdRlrr5EToObkXHZ4mSutA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 20:10:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VdRlrr5EToObkXHZ4mSutA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --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 20:10:23 INFO - Using env: {'DISPLAY': ':0', 20:10:23 INFO - 'HOME': '/home/cltbld', 20:10:23 INFO - 'LANG': 'en_US.UTF-8', 20:10:23 INFO - 'LANGUAGE': 'en_US:en', 20:10:23 INFO - 'LOGNAME': 'cltbld', 20:10:23 INFO - 'MAIL': '/var/mail/cltbld', 20:10:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:10:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:10:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:23 INFO - 'MOZ_NO_REMOTE': '1', 20:10:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:10:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:23 INFO - 'NO_EM_RESTART': '1', 20:10:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:23 INFO - 'PWD': '/builds/slave/test', 20:10:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:10:23 INFO - 'SHELL': '/bin/bash', 20:10:23 INFO - 'SHLVL': '1', 20:10:23 INFO - 'TERM': 'linux', 20:10:23 INFO - 'TMOUT': '86400', 20:10:23 INFO - 'USER': 'cltbld', 20:10:23 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465871653.425313-1002655259', 20:10:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:23 INFO - '_': '/tools/buildbot/bin/python'} 20:10:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VdRlrr5EToObkXHZ4mSutA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 20:10:23 INFO - mozversion application_buildid: 20160613173002 20:10:23 INFO - mozversion application_changeset: 79bcc05ef105fb5362888694307faa261615c34d 20:10:23 INFO - mozversion application_display_name: Nightly 20:10:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:10:23 INFO - mozversion application_name: Firefox 20:10:23 INFO - mozversion application_remotingname: firefox 20:10:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:10:23 INFO - mozversion application_vendor: Mozilla 20:10:23 INFO - mozversion application_version: 50.0a1 20:10:23 INFO - mozversion platform_buildid: 20160613173002 20:10:23 INFO - mozversion platform_changeset: 79bcc05ef105fb5362888694307faa261615c34d 20:10:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:10:23 INFO - mozversion platform_version: 50.0a1 20:10:23 INFO - using testdate: 1465873823 20:10:23 INFO - actual date: 1465873823 20:10:23 INFO - starting webserver on 'localhost:52502' 20:10:23 INFO - SUITE-START | Running 2 tests 20:10:23 INFO - TEST-START | dromaeo_css 20:10:23 INFO - operating with platform_type : linux_ 20:10:23 INFO - Initialising browser for dromaeo_css test... 20:10:23 INFO - TEST-INFO | started process 4906 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ4r7VX/profile http://localhost:52502/getInfo.html) 20:10:28 INFO - PROCESS | 4906 | __metrics Screen width/height:1600/1200 20:10:28 INFO - PROCESS | 4906 | colorDepth:24 20:10:28 INFO - PROCESS | 4906 | Browser inner width/height: 1024/697 20:10:28 INFO - PROCESS | 4906 | __metrics 20:10:30 INFO - PROCESS | 4906 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:10:30 INFO - PROCESS | 4906 | console.error: PushService: 20:10:30 INFO - PROCESS | 4906 | stateChangeProcessEnqueue: Error transitioning state 20:10:30 INFO - PROCESS | 4906 | UnknownError 20:10:31 INFO - TEST-INFO | 4906: exit 0 20:10:31 INFO - Browser initialized. 20:10:31 INFO - Running cycle 1/1 for dromaeo_css test... 20:10:31 INFO - TEST-INFO | started process 4988 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ4r7VX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:10:43 INFO - PROCESS | 4988 | RSS: Main: 178020352 20:10:43 INFO - PROCESS | 4988 | 20:11:33 INFO - PROCESS | 4988 | 1465873893752 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] 20:13:43 INFO - PROCESS | 4988 | Cycle 1(1): loaded http://localhost:52502/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52502/tests/dromaeo/cssquery-ext.html) 20:13:44 INFO - PROCESS | 4988 | RSS: Main: 306081792 20:13:44 INFO - PROCESS | 4988 | 20:16:46 INFO - PROCESS | 4988 | Cycle 1(1): loaded http://localhost:52502/tests/dromaeo/cssquery-ext.html (next: http://localhost:52502/tests/dromaeo/cssquery-jquery.html) 20:16:47 INFO - PROCESS | 4988 | RSS: Main: 260911104 20:16:47 INFO - PROCESS | 4988 | 20:19:49 INFO - PROCESS | 4988 | Cycle 1(1): loaded http://localhost:52502/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52502/tests/dromaeo/cssquery-mootools.html) 20:19:49 INFO - PROCESS | 4988 | RSS: Main: 267583488 20:19:49 INFO - PROCESS | 4988 | 20:22:51 INFO - PROCESS | 4988 | Cycle 1(1): loaded http://localhost:52502/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52502/tests/dromaeo/cssquery-prototype.html) 20:22:52 INFO - PROCESS | 4988 | RSS: Main: 267415552 20:22:52 INFO - PROCESS | 4988 | 20:25:55 INFO - PROCESS | 4988 | Cycle 1(1): loaded http://localhost:52502/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52502/tests/dromaeo/cssquery-yui.html) 20:25:55 INFO - PROCESS | 4988 | RSS: Main: 244375552 20:25:55 INFO - PROCESS | 4988 | 20:28:58 INFO - PROCESS | 4988 | Cycle 1(1): loaded http://localhost:52502/tests/dromaeo/cssquery-yui.html (next: http://localhost:52502/tests/dromaeo/cssquery-dojo.html) 20:28:58 INFO - PROCESS | 4988 | RSS: Main: 320147456 20:28:58 INFO - PROCESS | 4988 | 20:28:58 INFO - PROCESS | 4988 | __start_tp_report 20:28:58 INFO - PROCESS | 4988 | _x_x_mozilla_page_load 20:28:58 INFO - PROCESS | 4988 | _x_x_mozilla_page_load_details 20:28:58 INFO - PROCESS | 4988 | |i|pagename|runs| 20:28:58 INFO - PROCESS | 4988 | |0;dojo.html;3096.210466331085;3125.2343175921887;3126.702963218494;3171.7938334008286;3174.396864595725;5316.0962636351815;5419.891602167954;5422.213779002042;5473.151661492465;5476.260704804855;5414.052540805363;5427.782888684458;5432.619716619838;5477.315335583052;5496.642718223323;4872.7563621818945;4946.406431228258;4951.183054795954;4956.826511072113;5161.76772045257;5049.823256186016;5060.848174554751;5098.898022039557;5115.9488405116035;5119.846404607849;4861.538153875394;4910.312556242129;4911.68074075184;4926.876828079291;4992.500749925015;4876.414830220361;4938.827141050082;4941.481144479814;5002.24966255061;5050.090983622947;4945.332380128672;4983.775730092155;4987.825426110068;4993.400791904958;5039.193729003378;5308.283381743492;5421.620486565942;5470.56235501159;5478.096114141202;5552.77788888444;5899.410058994109;5934.139549765303;5959.165716799652;5961.254843144607;5963.224780778471;5799.5650326225705;5990.371011043865;5995.040793473024;6011.669358185298;6014.037753959389;5403.8108666196495;5476.726163691799;5480.698561579112;5548.69482178484;5552.139418390076;6050.515958723292;6063.514918806485;6066.393360663898;6066.817995460143;6068.605540639933;5627.212190293362;5632.52123569493;5822.679752613562;5823.621464604787;5823.94176058234;5750;5792.739326730307;5834.649921004669;5846.532277417797;5848.064309710426;5712.65724056558;5742.48317651405;5756.539476841843;5757.971210144006;5759.22250496186;5705.486506214461;5736.942630573641;5778.768849245983;5791.942080579141;5792.420757924258;4413.6248418884115;4438.778061096997;4457.77711114443;4472.306792447176;4523;3967.543732470745;3971.4241434991764;3984.2828290907337;4014.41790940312;4014.658754005884;5571.470710282517;5571.916421253684;5572.3870374258795;5574.58190635704;5579.804706835242;5764.337101233412;5800.071988481907;5824.213731146326;5848.181254624356;5875.059990401515;5537.8061767837935;5541.667499950016;5545.445455454423;5549.361823390362;5549.417311182267;4937.308776771183;5079.619028572872;5084.567811736044;5087.262346959744;5143.485651434827;6023.69881505923;6060.727267272983;6066.514678825772;6119.5410344224365;6129.233845769189;5862.560307976833;5862.648241105548;5864.296284445893;5866.413358664099;5868.4424979626865;5856.648601083949;6063.696815159313;6082.057281121433;6093.847653808691;6106;5760.855978600569;5809.390014048633;5812.593118481665;5824.621399609012;5869.73586188614;5888.823335299948;5935.762569497172;5936.525077993664;5941.524678025661;5943.197668314895;5586.804461843816;5670.404607516151;5687.77248910039;5791.391903850035;5797.420257974169;5706.686132262766;5706.714664266687;5714.485696287354;5720;5754.395788442153;5584.301962254718;5638.069718496402;5642.210090587239;5645.237892884408;5646.209530665628;5586.050371436947;5605.243292155506;5717.656940583578;5719.170720245458;5740.799072032459;5559.72201389937;5586.329640443173;5592.496675299242;5603.075492543685;5605.943940560543 20:28:58 INFO - PROCESS | 4988 | |1;ext.html;567.29088639201;623.8877002139616;626;633.2812258087072;643.6395618453663;30730.539041914362;31567.842160789194;42203.78898105513;43055;43060.13879722403;37967.62032379676;39392.60607393925;39451.40822887659;39514.407283890694;40312;8821.735347939572;8979.102089791035;8991.190792828644;8993;8997.235235005033;8847.646094156225;8953.10468953106;8953.955230223872;8954.462732236087;8954.910450895506;8965.820683586324;8988;8995.41529800564;9002.954985225064;9004.774880628003;8935.151160639729;8971.910280897173;8982.910170898273;8983.595738191765;8983.685571004984;8857.158569935846;8923.866142007875;8929.73210803677;8930.017698053209;8932;42355.36466952998;42358.78820605908;42489.57510424887;42516.36225456621;42533.78733106345;3583.4624806279007;3627.419612861956;3737.906552336186;3908.2378936107184;4135.56576559463;31933.52099718506;32210.677893221004;32272;32360;33612.831935840164;4166.312558427856;4198.223328684173;4204.747715137101;4226.704130710851;4386.583274588909;337565;338425;338492;339686.3015684931;340220;57150;57252;57699.42300576941;57755.711221444464;57789;33846.96918184917;35042.64957350445;35107;35135.4729679055;60854.39145608576;16278.26747796352;16426.096564688818;16437.91781041111;16465.094419806785;16471.752923706154;12349.506019759288;12448.75102497945;12456.501739930483;12462.43919023646;12472.75054498923;19944.60110797776;20019.499512512302;20085.196592136443;20096;20148.697769533468;7113.324234197743;7240.384567311838;7287.323915499464;7461.216572259943;7562.546247225074;981.764376549623;1027.8509616105623;1065.6589891234885;1114.6043154680135;1139.663799179244;31886.202844929063;31981.360372792413;32070.19824504406;32179;32492.83753581217;1097.182598963777;1103.8178700514325;1121.9214654974237;1142.0578023130784;1142.2917790969486;16320.83679163217;17017.149142542825;17114;17221.7416738749;17272.506697169283;557193;557973;561929;564948;567102;58289.41710582925;58756;58850.705746470994;58939.705301473216;58943.41056589465;1256.7926292161692;1375.8555351687928;1403.9789403158961;1408.3310427547037;1413.5405993052093;31622.209444763146;33145.33709325848;33388.332233355686;33725.66274337225;34022.82988585041;50964.74517627388;51362.74318628383;51516.74241628768;51525.227121592456;51563.22655160101;398784;408243;408369;408842;409420;25346.493070138862;26656.866715667074;27206.863965680044;27795.861020694767;29275.268118297212;47737.76131119322;48091;48821.267680985526;48830;49355.766105847644;40200.39699404453;41699.37450938178;42002.159956801304;42037;42097.36853947255;40737.79631101825;40942.79528602338;41855.790721047415;41972;42179.367309491;39965.651865683605;40933.38599920944;41003;41608.791956040026;41714.58285417107;35261;36522;36596.0850978717;36624.81687591545;37305;26736.331591710365;26953;27248.318792030357;27295.45409091847;27614.376634219716 20:28:58 INFO - PROCESS | 4988 | |2;jquery.html;404.87651266363747;414.35567692238595;414.419812262832;427.41230807639494;437.676119671443;18185.818141818578;19026.80973190268;19677.704834427477;19738.30915917945;20024.399268021945;12224;12391.814122788166;12520.499180032788;12552.748945021094;12842.614721558344;5239.973800130994;5245.186996015624;5409.215663728757;5425.3489581250105;5460.890782184354;5332.840014799563;5391.433899440561;5397.2443857859735;5423.620346575742;5437.32033495813;5372.247885296062;5421.539169170625;5421.756020979065;5421.756020979065;5428.4028756836915;5206.661566998152;5288.65623734456;5319.627626066177;5345.251664766916;5456.972715136419;5085.440601533828;5160.25176349431;5171.01750667372;5172.379314482287;5173.482651734834;21848.672269915965;22656.773432265632;23480.76519234803;23587.410314742097;23593.528129437316;2538.1370334086314;2608.5695860183046;2668.6530751002247;2711.850848203348;2909.9127026189035;9853.556589953469;9894.257930655229;10010.449425281606;10464.162866970624;10582.365058096539;1858.9721154182698;1947.4352437793023;1949.756280464942;1974.8025197480138;2002.1791065663153;54145;79779.6011019947;80348;80741;82210.58894705489;11329.830052549218;11524.078073754079;11585.189036767513;11589.884101159048;11727.706807329714;16187.676246475005;16342.75485867713;16377.42679006229;16396.26216820246;16401.1799410029;7850.725224617111;7936.174679823557;7950.4832185907735;8062.879056814152;8099.109097999215;7476.1776204617445;7533.4349923755935;7620.085589729268;7710.306072453506;7765.611719414007;4641.350210970467;4706.764661766898;4734.100520901018;4761.833350829;4803.087413391444;1946.2896042944506;1969.2615269274022;1998.4803950972562;2027;2048.1704909511673;891.2825175733467;978.3347323819871;989.6684610655367;1046.99476502617;1068.1241382066787;18579.256829726928;18605.441836744918;18894.05529723508;19124.139413726414;19669.21323147087;954.7947191353892;955.6607404371487;981.9018098190267;1003.4230317567428;1044.9059584637266;10313.1233845124;10849.90777628372;10861.329628259766;10866.293690910066;10886.782264354668;473633;474836;476631;479117;491669;65811;85036;86188.56905715431;94158.52920735352;95420;944.3389627260945;945.3618807305041;963.5904740485265;974.9902500975041;976.8730065091493;17404.73892891633;17501.29994800194;17743.29026838912;17842.5539361517;18179.272829086687;41802.79098604488;42171.7891410541;42748.572514274456;43935.56064439315;43941.340879887466;58967.41032589619;59004;59697.403025970925;60646.238607332234;61513.077303841375;8854.690085847222;8905.955470222607;8974.820503590023;9059.547022648972;9070.229030532479;13015.674608134872;14001.369938353002;14140.01019928595;14337.713245735236;14913.850861491246;12232.204906681038;12480.126391152533;12504.562340318045;12616.684582885135;12693.4287957044;10769.192310576582;12158.513659453523;12200.267983920992;12422.503099875903;12755.553555625509;12090.32773780954;12209.450574724337;12234.388280586114;12462.688432789253;13160.341982901009;8963.238124759468;9059.229965452747;9095.135962083592;9132.817343652956;9302.16280534755;9066.90933090687;11582.478788454371;11876.940615296868;12033.157678962389;12180.330081845583 20:28:58 INFO - PROCESS | 4988 | |3;mootools.html;1339.0894191949483;1485.48750681015;1506.4275575281395;1653.6527329260855;1777.751114843922;8669.999999999993;9024.052474490183;9051.637934482622;9313.627454901796;9323.114304141096;9002.054784247657;9184.724458266246;9206.401583897043;9213.815723685522;9220.492872891988;2066.380085974202;2129.510212651091;2130.020190712274;2398.988005059977;2433;2386.78518933296;2460.360306320352;2463.051725085846;2480.082369523279;2481.3424442522746;2423.7091549014144;2440.2923152285816;2446.483180428137;2448.5959816630234;2469.5431345201105;2120.321497120922;2361.8582885026954;2387.761223877607;2399.1363109280733;2404.6873906392234;2421.0436877433317;2463.8521688698734;2463.987680061606;2464.8151388645742;2467.5558399488086;9083.863742043875;9156.725298241063;9156.8626470603;9170.633174673005;9172;5174.663646862942;5293.39126000511;5305.177697456862;5311.6189790654325;5312.389075256357;3125.1718294651937;3156.6527681954967;3231.7576181786226;3253.951190732117;3256.1208473712204;1086.2287775679276;1095.950682219302;1101.4602844606165;1105.237386203517;1124.1456493065248;12997.545085921947;13012.86987130126;13023.413946372437;13044.08691391603;13065.085444018923;4842.443119041285;4969.552740253394;5003.649744517922;5012.924806127911;5055.721935293521;10822.404767737693;10846.728831779112;10853.620123295805;10856.945715271531;10866.45667716611;5322.840314790563;5333.359996800409;5374.865628359323;5382.192671099367;5503.532199762985;4268.893277668083;4581.839635612738;4703.153432382135;4748.406449193851;4811.446683631357;4063.4920634920636;4097.09863829957;4162.292410290258;4188;4196.349565817303;1325.3174615073244;1331.3942156318851;1345.5156143788229;1353.7680710553545;1355.7462090981526;908.6002159049997;972.7081875437482;974.5809302000208;1017.2014968249888;1021.4230302548023;6184.381561843869;6186.1648677428875;6295.842603934938;6331.986882098934;6503.382178693017;960.558143254097;985.6451677396132;1009.2934945538153;1019.6482213636284;1021.6526381030485;4233.5554766749665;4264.978675106605;4431.734095954189;4444.2000439920475;4524.615407690383;11313;11654.53381864716;11821.527138914347;11822.645320640395;11830.112741544246;11030.834537481944;11414.771704565863;11628.418579071013;11665.125115616192;11686.47410866513;8555.230029297392;8650.740477785677;8671.306295496344;8738.563071846382;8744.300455963508;6270.717817698123;6451.580647257913;6518.57629254097;6532.510061745483;6542.378474044958;10399.428031458343;10609.840852387066;10772;10787.190960677824;10809.783804324026;10705.197110216921;10853.34879907208;10863.239573229797;10878.292910960763;10920.672379828618;7226.277372262732;7929.207079292025;8129.959350203448;8156.796080098045;8291.33669306442;9052.864207036768;9057.365984381293;9152.862707059532;9161.26709863196;9172.220361269367;7884.329831964347;8137.918620813716;8222.506649601042;8267.090620031911;8318.584070796556;7932.206779322021;8077.232662897015;8112.513249205066;8143.063547691854;8164.591770411337;7347.15507716598;7414.332710056121;7525.661345239368;7535.321821036133;7567;5557.749901254372;5571.359293681278;5580.609357344947;5581.6371935824045;5646.407127251579;5320.733963301742;5378.892422151614;5485.75314110858;5593.664380137205;5793.275840519935 20:28:58 INFO - PROCESS | 4988 | |4;prototype.html;317.11841081792625;332.26900818199965;332.5826088259235;333.29508090388833;336.3743437206795;5109.182530795074;5179.559737422314;5236.345456817893;5301.469853014702;5343;5192.844214673556;5228.111221092414;5231.633785635007;5231.712255825928;5245.763940622672;4128.483939507561;4132.814023368941;4136.58634136587;4146.6268035876765;4147.440095587102;3932.6460618544324;3947.9013024674327;4127.442795222637;4141.5237247716595;4147.274227010276;4088.4276201331836;4123.670106391482;4137.627613514783;4139.917201655965;4151.709380343377;4111.280525907954;4113.716887127658;4129.442525259082;4141.461609990712;4149.97925010376;3367.1750421146976;3683.189698266404;3693.372126738434;3695.815209239554;3706.9073273168115;5109.770060347256;5112.41207261166;5119.513646203642;5174.28350116192;5176;4652.674312798105;4658.930116048262;4672.042231342567;4673.686525170028;4691.366665500182;5334.893302133935;5335.226392173152;5420.674759514442;5479.972600137014;5504;3941.625545573195;3946.664533514626;3964.8215830287704;3969.233691007503;3973.940390894139;5665.810179862234;5676.460736230051;5679.346875109332;5685.299482745704;5703.5152012079025;4009.939850902239;4050.635442810102;4051.47330846988;4055.9391609125296;4085.754854708727;3854.7879866607045;4074.062965517888;4077.734947228421;4084.7549147050677;4086.8569600063856;4639.257718765049;4652.767361631905;4653.60444362233;4655.627549796008;4656.95343046572;5381.461853814587;5434.2392065110125;5440.510354068153;5479.753411096431;5496.972515137399;1305.3734207580414;1313.487739781486;1396.1483495068;1402.9859701403059;1416.5042235217797;892.2995448572839;904.9502277374808;917.0233701108299;922.2391526990126;935.4340623922565;4744.928826067612;4755.619550435957;4764.475907650156;4764.95235047652;4765.928511072337;4976.875578110504;4977.43662014063;4992.625553083533;5010.1983682611335;5036.874078148002;4516.548345165457;4760.619150467955;4787.42550893895;4824.686395384359;4826.8069277228515;2669.7997650176317;2671.3321669582606;2675.2776750277317;2677.5180467516034;2683.396235846958;5175.223716442564;5192.948070519246;5196.740162991835;5229.346331708536;5304.389995150607;4737.360456338419;5077.644564880423;5079.2381142828135;5104.3109180260935;5141.228815677603;5170;5181.35233095863;5184.248283998723;5189.792408303701;5192.584593232532;4982.7259500727805;4983.551480366785;5009.5491405773655;5013.298138260573;5083.262926875656;4698.812047518061;4734.644901632322;4958.801647934042;4968.559117855782;5040.891003979119;5102.821401250939;5146.562542183956;5149.403684857706;5163.922541161961;5198.934218485277;3667.376545987242;3677.3380791457794;3682.429223470366;3691.53855768029;3845.8269377877505;5460.399356070909;5585.972070139624;5598.608097433141;5602.803901863415;5634.915476267777;5437.728113594384;5477.698726570077;5478.726063696879;5490.533304668988;5521.420250873761;5258.053550360972;5473.72631368422;5478.808241711521;5487.807926722546;5500.4048825840055;5324.760385782572;5341.145416733304;5382.865428364322;5392.433794451526;5414.620976531605;5438.673679579238;5464.808731694372;5503.862403439946;5515.448455154453;5518.2826232589505;5197.636165468381;5351.170568561879;5494.148406996922;5510.752016159363;5539.362973258127 20:28:58 INFO - PROCESS | 4988 | |5;yui.html;714.4534431160166;736.778966310107;753.1226121568374;774.0363247756544;831.6590198018812;14775.999999999987;16114.35542578297;16115.355385784584;16149.75775363369;16159.434419795309;14693.1918744469;14897.478588249414;14935.327910244037;14977.101373917572;15021.549353519413;822.1326500541926;832.3590835057003;832.4921797703396;832.5254604875223;832.7918020494876;692.3353580562641;811.1442428238236;814.5804910471112;833.9833203335929;843.0810416645854;869.460934220784;875.1729615513342;875.6234819027816;876.8334016536837;877.7410663854179;872.9912700872974;873.2926329672954;873.5064688451005;873.8077622922979;874.0603850860318;529.8225094593316;616.9444749972479;631.3307893632764;631.4506379449862;634.3846468925135;15199.544013679497;15205.239738013166;15241.085534867943;15242.237888105661;15273.159976201305;13470;14103.858961410357;14289.142651440947;14332.856671433257;14361.712765744627;13227.140235884637;13326.073708502738;13332.200067995855;13397.66505837352;13906.58280251594;4398.692091553593;4440.289553671397;4443.355713421568;4547.567981041796;4589.059242855206;76215.6189219056;76905;77053;77137.61431192808;77441.61279193568;10634.680959571226;11026.669199924016;11214.66356009321;11575.13186511015;11626.593069242535;20317;20456.59086818285;20489.795102049087;20503.38489845307;20520.07659655319;8100.149484304181;8117.715879944174;8141.51150930946;8260.132686067876;8290.4611200273;4490.618297444688;4783.4499032611;4878.707277563358;4999.075171093359;5100.209467532539;3668.9082772930356;3811.561670407883;3811.6950643948417;3815.027168072124;3819.6371344722206;626.9749210031639;644.690548536705;644.9677516124175;654.1104098426136;660.643252643567;587.4930802491596;646.208394716478;725.8802297620939;744.181400459501;749.2058418076856;9385.90614093864;9630.855537166948;9806.852897206547;10190.643327483502;10324;594.1384991761876;611.272585623107;642.6447071483055;670.0552221367946;718.762808273279;4598.425196850394;4625.537446255347;4630.83792067276;4698.248280275139;4703.129920964632;116958;117115;117280;117941;120781;79659;84211;94024;100260.29046617543;101192;88665.55667221623;90074.09925900657;90155.54922225478;90443.09556904346;90722.54638726765;10215.23385746087;10345.529565394663;10557.524911378852;10573.52419141125;10608.734781630521;49712.502874970785;50064.24903626522;51282.48717512777;53192.0744359064;53265;70555;72167.63916180386;72623.27376726165;75103;76338;13054.804177937149;13334.133221349213;13382.397792099573;13431.86568134306;13674.863251367358;14717.779233311294;14837.258137092886;14918;14990.850091498945;15905.284262208459;14082.929585352007;14138.929305353407;14595.197264150574;14607.488737894548;14738.55784326472;13756.449742010207;13869.167849929037;14005.299735013412;14154.221517816619;14418.711625767635;13554.661133471742;13558.86441135576;13986.650333741738;14084.788728169291;14420.206888620807;11293.322400655987;11453.828192577284;11485.138614603771;11867.347295898464;11880.762384752084;11336.829947550958;11534.711632209262;11597.88402115968;11875.703107422383;11909.82135267989 20:28:58 INFO - PROCESS | 4988 | __end_tp_report 20:28:58 INFO - PROCESS | 4988 | __start_cc_report 20:28:58 INFO - PROCESS | 4988 | _x_x_mozilla_cycle_collect,1083 20:28:58 INFO - PROCESS | 4988 | __end_cc_report 20:28:58 INFO - PROCESS | 4988 | __startTimestamp1465874938747__endTimestamp 20:28:58 INFO - PROCESS | 4988 | 20:28:58 INFO - PROCESS | 4988 | ------- Summary: start ------- 20:28:58 INFO - PROCESS | 4988 | Number of tests: 6 20:28:58 INFO - PROCESS | 4988 | 20:28:58 INFO - PROCESS | 4988 | [#0] dojo.html Cycles:165 Average:5437.41 Median:5605.24 stddev:623.01 (11.1%) stddev-sans-first:597.23 20:28:58 INFO - PROCESS | 4988 | Values: 3096.2 3125.2 3126.7 3171.8 3174.4 5316.1 5419.9 5422.2 5473.2 5476.3 5414.1 5427.8 5432.6 5477.3 5496.6 4872.8 4946.4 4951.2 4956.8 5161.8 5049.8 5060.8 5098.9 5115.9 5119.8 4861.5 4910.3 4911.7 4926.9 4992.5 4876.4 4938.8 4941.5 5002.2 5050.1 4945.3 4983.8 4987.8 4993.4 5039.2 5308.3 5421.6 5470.6 5478.1 5552.8 5899.4 5934.1 5959.2 5961.3 5963.2 5799.6 5990.4 5995.0 6011.7 6014.0 5403.8 5476.7 5480.7 5548.7 5552.1 6050.5 6063.5 6066.4 6066.8 6068.6 5627.2 5632.5 5822.7 5823.6 5823.9 5750.0 5792.7 5834.6 5846.5 5848.1 5712.7 5742.5 5756.5 5758.0 5759.2 5705.5 5736.9 5778.8 5791.9 5792.4 4413.6 4438.8 4457.8 4472.3 4523.0 3967.5 3971.4 3984.3 4014.4 4014.7 5571.5 5571.9 5572.4 5574.6 5579.8 5764.3 5800.1 5824.2 5848.2 5875.1 5537.8 5541.7 5545.4 5549.4 5549.4 4937.3 5079.6 5084.6 5087.3 5143.5 6023.7 6060.7 6066.5 6119.5 6129.2 5862.6 5862.6 5864.3 5866.4 5868.4 5856.6 6063.7 6082.1 6093.8 6106.0 5760.9 5809.4 5812.6 5824.6 5869.7 5888.8 5935.8 5936.5 5941.5 5943.2 5586.8 5670.4 5687.8 5791.4 5797.4 5706.7 5706.7 5714.5 5720.0 5754.4 5584.3 5638.1 5642.2 5645.2 5646.2 5586.1 5605.2 5717.7 5719.2 5740.8 5559.7 5586.3 5592.5 5603.1 5605.9 20:28:58 INFO - PROCESS | 4988 | 20:28:58 INFO - PROCESS | 4988 | [#1] ext.html Cycles:180 Average:59073.57 Median:224887.69 stddev:118342.86 (52.6%) stddev-sans-first:118593.31 20:28:58 INFO - PROCESS | 4988 | Values: 567.3 623.9 626.0 633.3 643.6 30730.5 31567.8 42203.8 43055.0 43060.1 37967.6 39392.6 39451.4 39514.4 40312.0 8821.7 8979.1 8991.2 8993.0 8997.2 8847.6 8953.1 8954.0 8954.5 8954.9 8965.8 8988.0 8995.4 9003.0 9004.8 8935.2 8971.9 8982.9 8983.6 8983.7 8857.2 8923.9 8929.7 8930.0 8932.0 42355.4 42358.8 42489.6 42516.4 42533.8 3583.5 3627.4 3737.9 3908.2 4135.6 31933.5 32210.7 32272.0 32360.0 33612.8 4166.3 4198.2 4204.7 4226.7 4386.6 337565.0 338425.0 338492.0 339686.3 340220.0 57150.0 57252.0 57699.4 57755.7 57789.0 33847.0 35042.6 35107.0 35135.5 60854.4 16278.3 16426.1 16437.9 16465.1 16471.8 12349.5 12448.8 12456.5 12462.4 12472.8 19944.6 20019.5 20085.2 20096.0 20148.7 7113.3 7240.4 7287.3 7461.2 7562.5 981.8 1027.9 1065.7 1114.6 1139.7 31886.2 31981.4 32070.2 32179.0 32492.8 1097.2 1103.8 1121.9 1142.1 1142.3 16320.8 17017.1 17114.0 17221.7 17272.5 557193.0 557973.0 561929.0 564948.0 567102.0 58289.4 58756.0 58850.7 58939.7 58943.4 1256.8 1375.9 1404.0 1408.3 1413.5 31622.2 33145.3 33388.3 33725.7 34022.8 50964.7 51362.7 51516.7 51525.2 51563.2 398784.0 408243.0 408369.0 408842.0 409420.0 25346.5 26656.9 27206.9 27795.9 29275.3 47737.8 48091.0 48821.3 48830.0 49355.8 40200.4 41699.4 42002.2 42037.0 42097.4 40737.8 40942.8 41855.8 41972.0 42179.4 39965.7 40933.4 41003.0 41608.8 41714.6 35261.0 36522.0 36596.1 36624.8 37305.0 26736.3 26953.0 27248.3 27295.5 27614.4 20:28:58 INFO - PROCESS | 4988 | 20:28:58 INFO - PROCESS | 4988 | [#2] jquery.html Cycles:180 Average:28352.71 Median:21299.60 stddev:78917.47 (370.5%) stddev-sans-first:79110.96 20:28:58 INFO - PROCESS | 4988 | Values: 404.9 414.4 414.4 427.4 437.7 18185.8 19026.8 19677.7 19738.3 20024.4 12224.0 12391.8 12520.5 12552.7 12842.6 5240.0 5245.2 5409.2 5425.3 5460.9 5332.8 5391.4 5397.2 5423.6 5437.3 5372.2 5421.5 5421.8 5421.8 5428.4 5206.7 5288.7 5319.6 5345.3 5457.0 5085.4 5160.3 5171.0 5172.4 5173.5 21848.7 22656.8 23480.8 23587.4 23593.5 2538.1 2608.6 2668.7 2711.9 2909.9 9853.6 9894.3 10010.4 10464.2 10582.4 1859.0 1947.4 1949.8 1974.8 2002.2 54145.0 79779.6 80348.0 80741.0 82210.6 11329.8 11524.1 11585.2 11589.9 11727.7 16187.7 16342.8 16377.4 16396.3 16401.2 7850.7 7936.2 7950.5 8062.9 8099.1 7476.2 7533.4 7620.1 7710.3 7765.6 4641.4 4706.8 4734.1 4761.8 4803.1 1946.3 1969.3 1998.5 2027.0 2048.2 891.3 978.3 989.7 1047.0 1068.1 18579.3 18605.4 18894.1 19124.1 19669.2 954.8 955.7 981.9 1003.4 1044.9 10313.1 10849.9 10861.3 10866.3 10886.8 473633.0 474836.0 476631.0 479117.0 491669.0 65811.0 85036.0 86188.6 94158.5 95420.0 944.3 945.4 963.6 975.0 976.9 17404.7 17501.3 17743.3 17842.6 18179.3 41802.8 42171.8 42748.6 43935.6 43941.3 58967.4 59004.0 59697.4 60646.2 61513.1 8854.7 8906.0 8974.8 9059.5 9070.2 13015.7 14001.4 14140.0 14337.7 14913.9 12232.2 12480.1 12504.6 12616.7 12693.4 10769.2 12158.5 12200.3 12422.5 12755.6 12090.3 12209.5 12234.4 12462.7 13160.3 8963.2 9059.2 9095.1 9132.8 9302.2 9066.9 11582.5 11876.9 12033.2 12180.3 20:28:58 INFO - PROCESS | 4988 | 20:28:58 INFO - PROCESS | 4988 | [#3] mootools.html Cycles:180 Average:6088.37 Median:4553.23 stddev:3512.85 (77.2%) stddev-sans-first:3504.57 20:28:58 INFO - PROCESS | 4988 | Values: 1339.1 1485.5 1506.4 1653.7 1777.8 8670.0 9024.1 9051.6 9313.6 9323.1 9002.1 9184.7 9206.4 9213.8 9220.5 2066.4 2129.5 2130.0 2399.0 2433.0 2386.8 2460.4 2463.1 2480.1 2481.3 2423.7 2440.3 2446.5 2448.6 2469.5 2120.3 2361.9 2387.8 2399.1 2404.7 2421.0 2463.9 2464.0 2464.8 2467.6 9083.9 9156.7 9156.9 9170.6 9172.0 5174.7 5293.4 5305.2 5311.6 5312.4 3125.2 3156.7 3231.8 3254.0 3256.1 1086.2 1096.0 1101.5 1105.2 1124.1 12997.5 13012.9 13023.4 13044.1 13065.1 4842.4 4969.6 5003.6 5012.9 5055.7 10822.4 10846.7 10853.6 10856.9 10866.5 5322.8 5333.4 5374.9 5382.2 5503.5 4268.9 4581.8 4703.2 4748.4 4811.4 4063.5 4097.1 4162.3 4188.0 4196.3 1325.3 1331.4 1345.5 1353.8 1355.7 908.6 972.7 974.6 1017.2 1021.4 6184.4 6186.2 6295.8 6332.0 6503.4 960.6 985.6 1009.3 1019.6 1021.7 4233.6 4265.0 4431.7 4444.2 4524.6 11313.0 11654.5 11821.5 11822.6 11830.1 11030.8 11414.8 11628.4 11665.1 11686.5 8555.2 8650.7 8671.3 8738.6 8744.3 6270.7 6451.6 6518.6 6532.5 6542.4 10399.4 10609.8 10772.0 10787.2 10809.8 10705.2 10853.3 10863.2 10878.3 10920.7 7226.3 7929.2 8130.0 8156.8 8291.3 9052.9 9057.4 9152.9 9161.3 9172.2 7884.3 8137.9 8222.5 8267.1 8318.6 7932.2 8077.2 8112.5 8143.1 8164.6 7347.2 7414.3 7525.7 7535.3 7567.0 5557.7 5571.4 5580.6 5581.6 5646.4 5320.7 5378.9 5485.8 5593.7 5793.3 20:28:58 INFO - PROCESS | 4988 | 20:28:58 INFO - PROCESS | 4988 | [#4] prototype.html Cycles:180 Average:4454.13 Median:5009.87 stddev:1282.27 (25.6%) stddev-sans-first:1247.71 20:28:58 INFO - PROCESS | 4988 | Values: 317.1 332.3 332.6 333.3 336.4 5109.2 5179.6 5236.3 5301.5 5343.0 5192.8 5228.1 5231.6 5231.7 5245.8 4128.5 4132.8 4136.6 4146.6 4147.4 3932.6 3947.9 4127.4 4141.5 4147.3 4088.4 4123.7 4137.6 4139.9 4151.7 4111.3 4113.7 4129.4 4141.5 4150.0 3367.2 3683.2 3693.4 3695.8 3706.9 5109.8 5112.4 5119.5 5174.3 5176.0 4652.7 4658.9 4672.0 4673.7 4691.4 5334.9 5335.2 5420.7 5480.0 5504.0 3941.6 3946.7 3964.8 3969.2 3973.9 5665.8 5676.5 5679.3 5685.3 5703.5 4009.9 4050.6 4051.5 4055.9 4085.8 3854.8 4074.1 4077.7 4084.8 4086.9 4639.3 4652.8 4653.6 4655.6 4657.0 5381.5 5434.2 5440.5 5479.8 5497.0 1305.4 1313.5 1396.1 1403.0 1416.5 892.3 905.0 917.0 922.2 935.4 4744.9 4755.6 4764.5 4765.0 4765.9 4976.9 4977.4 4992.6 5010.2 5036.9 4516.5 4760.6 4787.4 4824.7 4826.8 2669.8 2671.3 2675.3 2677.5 2683.4 5175.2 5192.9 5196.7 5229.3 5304.4 4737.4 5077.6 5079.2 5104.3 5141.2 5170.0 5181.4 5184.2 5189.8 5192.6 4982.7 4983.6 5009.5 5013.3 5083.3 4698.8 4734.6 4958.8 4968.6 5040.9 5102.8 5146.6 5149.4 5163.9 5198.9 3667.4 3677.3 3682.4 3691.5 3845.8 5460.4 5586.0 5598.6 5602.8 5634.9 5437.7 5477.7 5478.7 5490.5 5521.4 5258.1 5473.7 5478.8 5487.8 5500.4 5324.8 5341.1 5382.9 5392.4 5414.6 5438.7 5464.8 5503.9 5515.4 5518.3 5197.6 5351.2 5494.1 5510.8 5539.4 20:28:58 INFO - PROCESS | 4988 | 20:28:58 INFO - PROCESS | 4988 | [#5] yui.html Cycles:180 Average:20945.41 Median:4441.82 stddev:29888.01 (672.9%) stddev-sans-first:29933.25 20:28:58 INFO - PROCESS | 4988 | Values: 714.5 736.8 753.1 774.0 831.7 14776.0 16114.4 16115.4 16149.8 16159.4 14693.2 14897.5 14935.3 14977.1 15021.5 822.1 832.4 832.5 832.5 832.8 692.3 811.1 814.6 834.0 843.1 869.5 875.2 875.6 876.8 877.7 873.0 873.3 873.5 873.8 874.1 529.8 616.9 631.3 631.5 634.4 15199.5 15205.2 15241.1 15242.2 15273.2 13470.0 14103.9 14289.1 14332.9 14361.7 13227.1 13326.1 13332.2 13397.7 13906.6 4398.7 4440.3 4443.4 4547.6 4589.1 76215.6 76905.0 77053.0 77137.6 77441.6 10634.7 11026.7 11214.7 11575.1 11626.6 20317.0 20456.6 20489.8 20503.4 20520.1 8100.1 8117.7 8141.5 8260.1 8290.5 4490.6 4783.4 4878.7 4999.1 5100.2 3668.9 3811.6 3811.7 3815.0 3819.6 627.0 644.7 645.0 654.1 660.6 587.5 646.2 725.9 744.2 749.2 9385.9 9630.9 9806.9 10190.6 10324.0 594.1 611.3 642.6 670.1 718.8 4598.4 4625.5 4630.8 4698.2 4703.1 116958.0 117115.0 117280.0 117941.0 120781.0 79659.0 84211.0 94024.0 100260.3 101192.0 88665.6 90074.1 90155.5 90443.1 90722.5 10215.2 10345.5 10557.5 10573.5 10608.7 49712.5 50064.2 51282.5 53192.1 53265.0 70555.0 72167.6 72623.3 75103.0 76338.0 13054.8 13334.1 13382.4 13431.9 13674.9 14717.8 14837.3 14918.0 14990.9 15905.3 14082.9 14138.9 14595.2 14607.5 14738.6 13756.4 13869.2 14005.3 14154.2 14418.7 13554.7 13558.9 13986.7 14084.8 14420.2 11293.3 11453.8 11485.1 11867.3 11880.8 11336.8 11534.7 11597.9 11875.7 11909.8 20:28:58 INFO - PROCESS | 4988 | -------- Summary: end -------- 20:28:58 INFO - PROCESS | 4988 | 20:28:59 INFO - TEST-INFO | 4988: exit 0 20:28:59 INFO - TEST-OK | dromaeo_css | took 1115992ms 20:28:59 INFO - TEST-START | kraken 20:28:59 INFO - operating with platform_type : linux_ 20:28:59 INFO - Initialising browser for kraken test... 20:28:59 INFO - TEST-INFO | started process 5173 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplgaaoj/profile http://localhost:52502/getInfo.html) 20:29:04 INFO - PROCESS | 5173 | __metrics Screen width/height:1600/1200 20:29:04 INFO - PROCESS | 5173 | colorDepth:24 20:29:04 INFO - PROCESS | 5173 | Browser inner width/height: 1024/697 20:29:04 INFO - PROCESS | 5173 | __metrics 20:29:05 INFO - PROCESS | 5173 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:29:05 INFO - PROCESS | 5173 | console.error: PushService: 20:29:05 INFO - PROCESS | 5173 | stateChangeProcessEnqueue: Error transitioning state 20:29:05 INFO - PROCESS | 5173 | UnknownError 20:29:06 INFO - TEST-INFO | 5173: exit 0 20:29:06 INFO - Browser initialized. 20:29:06 INFO - Running cycle 1/1 for kraken test... 20:29:06 INFO - TEST-INFO | started process 5255 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplgaaoj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:29:18 INFO - PROCESS | 5255 | RSS: Main: 177541120 20:29:18 INFO - PROCESS | 5255 | 20:29:21 INFO - PROCESS | 5255 | Cycle 1(1): loaded http://localhost:52502/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52502/tests/kraken/driver.html?testName=audio-beat-detection) 20:29:21 INFO - PROCESS | 5255 | RSS: Main: 236437504 20:29:21 INFO - PROCESS | 5255 | 20:29:24 INFO - PROCESS | 5255 | Cycle 1(1): loaded http://localhost:52502/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52502/tests/kraken/driver.html?testName=audio-dft) 20:29:25 INFO - PROCESS | 5255 | RSS: Main: 224018432 20:29:25 INFO - PROCESS | 5255 | 20:29:28 INFO - PROCESS | 5255 | Cycle 1(1): loaded http://localhost:52502/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52502/tests/kraken/driver.html?testName=audio-fft) 20:29:29 INFO - PROCESS | 5255 | RSS: Main: 290537472 20:29:29 INFO - PROCESS | 5255 | 20:29:31 INFO - PROCESS | 5255 | Cycle 1(1): loaded http://localhost:52502/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52502/tests/kraken/driver.html?testName=audio-oscillator) 20:29:31 INFO - PROCESS | 5255 | RSS: Main: 201158656 20:29:31 INFO - PROCESS | 5255 | 20:29:33 INFO - PROCESS | 5255 | Cycle 1(1): loaded http://localhost:52502/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52502/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:29:34 INFO - PROCESS | 5255 | RSS: Main: 205332480 20:29:34 INFO - PROCESS | 5255 | 20:29:37 INFO - PROCESS | 5255 | Cycle 1(1): loaded http://localhost:52502/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52502/tests/kraken/driver.html?testName=imaging-darkroom) 20:29:38 INFO - PROCESS | 5255 | RSS: Main: 240103424 20:29:38 INFO - PROCESS | 5255 | 20:29:41 INFO - PROCESS | 5255 | Cycle 1(1): loaded http://localhost:52502/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52502/tests/kraken/driver.html?testName=imaging-desaturate) 20:29:42 INFO - PROCESS | 5255 | RSS: Main: 241623040 20:29:42 INFO - PROCESS | 5255 | 20:29:45 INFO - PROCESS | 5255 | Cycle 1(1): loaded http://localhost:52502/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52502/tests/kraken/driver.html?testName=json-parse-financial) 20:29:45 INFO - PROCESS | 5255 | RSS: Main: 241713152 20:29:45 INFO - PROCESS | 5255 | 20:29:47 INFO - PROCESS | 5255 | Cycle 1(1): loaded http://localhost:52502/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52502/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:29:47 INFO - PROCESS | 5255 | RSS: Main: 230633472 20:29:47 INFO - PROCESS | 5255 | 20:29:49 INFO - PROCESS | 5255 | Cycle 1(1): loaded http://localhost:52502/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52502/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:29:50 INFO - PROCESS | 5255 | RSS: Main: 236036096 20:29:50 INFO - PROCESS | 5255 | 20:29:52 INFO - PROCESS | 5255 | Cycle 1(1): loaded http://localhost:52502/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52502/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:29:52 INFO - PROCESS | 5255 | RSS: Main: 238718976 20:29:52 INFO - PROCESS | 5255 | 20:29:55 INFO - PROCESS | 5255 | Cycle 1(1): loaded http://localhost:52502/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52502/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:29:56 INFO - PROCESS | 5255 | RSS: Main: 242823168 20:29:56 INFO - PROCESS | 5255 | 20:29:58 INFO - PROCESS | 5255 | Cycle 1(1): loaded http://localhost:52502/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52502/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:29:59 INFO - PROCESS | 5255 | RSS: Main: 242909184 20:29:59 INFO - PROCESS | 5255 | 20:30:01 INFO - PROCESS | 5255 | Cycle 1(1): loaded http://localhost:52502/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52502/tests/kraken/driver.html?testName=ai-astar) 20:30:01 INFO - PROCESS | 5255 | RSS: Main: 285483008 20:30:01 INFO - PROCESS | 5255 | 20:30:01 INFO - PROCESS | 5255 | __start_tp_report 20:30:01 INFO - PROCESS | 5255 | _x_x_mozilla_page_load 20:30:01 INFO - PROCESS | 5255 | _x_x_mozilla_page_load_details 20:30:01 INFO - PROCESS | 5255 | |i|pagename|runs| 20:30:01 INFO - PROCESS | 5255 | |0;ai-astar;110;104;109;110;110;109;108;109;110;111 20:30:01 INFO - PROCESS | 5255 | |1;audio-beat-detection;150;124;129;178;126;126;152;124;158;124 20:30:01 INFO - PROCESS | 5255 | |2;audio-dft;162;161;162;161;162;162;162;162;161;163 20:30:01 INFO - PROCESS | 5255 | |3;audio-fft;76;76;77;117;77;83;74;75;99;76 20:30:01 INFO - PROCESS | 5255 | |4;audio-oscillator;86;84;117;85;85;87;125;86;84;124 20:30:01 INFO - PROCESS | 5255 | |5;imaging-gaussian-blur;117;116;117;116;117;117;117;116;116;117 20:30:01 INFO - PROCESS | 5255 | |6;imaging-darkroom;145;146;145;145;146;146;146;146;147;146 20:30:01 INFO - PROCESS | 5255 | |7;imaging-desaturate;96;97;96;96;96;96;96;96;96;96 20:30:01 INFO - PROCESS | 5255 | |8;json-parse-financial;52;54;57;54;53;54;54;54;52;54 20:30:01 INFO - PROCESS | 5255 | |9;json-stringify-tinderbox;59;59;60;60;60;59;60;60;61;61 20:30:01 INFO - PROCESS | 5255 | |10;stanford-crypto-aes;83;82;83;83;89;83;83;90;118;83 20:30:01 INFO - PROCESS | 5255 | |11;stanford-crypto-ccm;125;122;129;129;121;121;122;127;136;137 20:30:01 INFO - PROCESS | 5255 | |12;stanford-crypto-pbkdf2;166;166;167;167;164;160;160;159;160;162 20:30:01 INFO - PROCESS | 5255 | |13;stanford-crypto-sha256-iterative;66;63;67;69;67;62;71;62;62;62 20:30:01 INFO - PROCESS | 5255 | __end_tp_report 20:30:01 INFO - PROCESS | 5255 | __start_cc_report 20:30:01 INFO - PROCESS | 5255 | _x_x_mozilla_cycle_collect,1622 20:30:01 INFO - PROCESS | 5255 | __end_cc_report 20:30:01 INFO - PROCESS | 5255 | __startTimestamp1465875001277__endTimestamp 20:30:01 INFO - PROCESS | 5255 | 20:30:01 INFO - PROCESS | 5255 | ------- Summary: start ------- 20:30:01 INFO - PROCESS | 5255 | Number of tests: 14 20:30:01 INFO - PROCESS | 5255 | 20:30:01 INFO - PROCESS | 5255 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.00 stddev:1.94 (1.8%) stddev-sans-first:2.03 20:30:01 INFO - PROCESS | 5255 | Values: 110.0 104.0 109.0 110.0 110.0 109.0 108.0 109.0 110.0 111.0 20:30:01 INFO - PROCESS | 5255 | 20:30:01 INFO - PROCESS | 5255 | [#1] audio-beat-detection Cycles:10 Average:139.10 Median:139.50 stddev:19.10 (13.7%) stddev-sans-first:19.85 20:30:01 INFO - PROCESS | 5255 | Values: 150.0 124.0 129.0 178.0 126.0 126.0 152.0 124.0 158.0 124.0 20:30:01 INFO - PROCESS | 5255 | 20:30:01 INFO - PROCESS | 5255 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 20:30:01 INFO - PROCESS | 5255 | Values: 162.0 161.0 162.0 161.0 162.0 162.0 162.0 162.0 161.0 163.0 20:30:01 INFO - PROCESS | 5255 | 20:30:01 INFO - PROCESS | 5255 | [#3] audio-fft Cycles:10 Average:83.00 Median:76.50 stddev:14.05 (18.4%) stddev-sans-first:14.67 20:30:01 INFO - PROCESS | 5255 | Values: 76.0 76.0 77.0 117.0 77.0 83.0 74.0 75.0 99.0 76.0 20:30:01 INFO - PROCESS | 5255 | 20:30:01 INFO - PROCESS | 5255 | [#4] audio-oscillator Cycles:10 Average:96.30 Median:85.00 stddev:17.88 (21.0%) stddev-sans-first:18.57 20:30:01 INFO - PROCESS | 5255 | Values: 86.0 84.0 117.0 85.0 85.0 87.0 125.0 86.0 84.0 124.0 20:30:01 INFO - PROCESS | 5255 | 20:30:01 INFO - PROCESS | 5255 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 20:30:01 INFO - PROCESS | 5255 | Values: 117.0 116.0 117.0 116.0 117.0 117.0 117.0 116.0 116.0 117.0 20:30:01 INFO - PROCESS | 5255 | 20:30:01 INFO - PROCESS | 5255 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 20:30:01 INFO - PROCESS | 5255 | Values: 145.0 146.0 145.0 145.0 146.0 146.0 146.0 146.0 147.0 146.0 20:30:01 INFO - PROCESS | 5255 | 20:30:01 INFO - PROCESS | 5255 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 20:30:01 INFO - PROCESS | 5255 | Values: 96.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 20:30:01 INFO - PROCESS | 5255 | 20:30:01 INFO - PROCESS | 5255 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:1.40 (2.6%) stddev-sans-first:1.32 20:30:01 INFO - PROCESS | 5255 | Values: 52.0 54.0 57.0 54.0 53.0 54.0 54.0 54.0 52.0 54.0 20:30:01 INFO - PROCESS | 5255 | 20:30:01 INFO - PROCESS | 5255 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:60.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 20:30:01 INFO - PROCESS | 5255 | Values: 59.0 59.0 60.0 60.0 60.0 59.0 60.0 60.0 61.0 61.0 20:30:01 INFO - PROCESS | 5255 | 20:30:01 INFO - PROCESS | 5255 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:83.00 stddev:11.01 (13.3%) stddev-sans-first:11.54 20:30:01 INFO - PROCESS | 5255 | Values: 83.0 82.0 83.0 83.0 89.0 83.0 83.0 90.0 118.0 83.0 20:30:01 INFO - PROCESS | 5255 | 20:30:01 INFO - PROCESS | 5255 | [#11] stanford-crypto-ccm Cycles:10 Average:126.90 Median:128.00 stddev:5.92 (4.6%) stddev-sans-first:6.23 20:30:01 INFO - PROCESS | 5255 | Values: 125.0 122.0 129.0 129.0 121.0 121.0 122.0 127.0 136.0 137.0 20:30:01 INFO - PROCESS | 5255 | 20:30:01 INFO - PROCESS | 5255 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.10 Median:165.00 stddev:3.25 (2.0%) stddev-sans-first:3.27 20:30:01 INFO - PROCESS | 5255 | Values: 166.0 166.0 167.0 167.0 164.0 160.0 160.0 159.0 160.0 162.0 20:30:01 INFO - PROCESS | 5255 | 20:30:01 INFO - PROCESS | 5255 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:66.50 stddev:3.35 (5.0%) stddev-sans-first:3.54 20:30:01 INFO - PROCESS | 5255 | Values: 66.0 63.0 67.0 69.0 67.0 62.0 71.0 62.0 62.0 62.0 20:30:01 INFO - PROCESS | 5255 | -------- Summary: end -------- 20:30:01 INFO - PROCESS | 5255 | 20:30:02 INFO - TEST-INFO | 5255: exit 0 20:30:02 INFO - TEST-OK | kraken | took 62614ms 20:30:02 INFO - SUITE-END | took 1178s 20:30:02 INFO - Completed test suite (00:19:38) 20:30:02 INFO - javascript benchmark 20:30:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3096.210466331085, 3125.2343175921887, 3126.702963218494, 3171.7938334008286, 3174.396864595725, 5316.0962636351815, 5419.891602167954, 5422.213779002042, 5473.151661492465, 5476.260704804855, 5414.052540805363, 5427.782888684458, 5432.619716619838, 5477.315335583052, 5496.642718223323, 4872.7563621818945, 4946.406431228258, 4951.183054795954, 4956.826511072113, 5161.76772045257, 5049.823256186016, 5060.848174554751, 5098.898022039557, 5115.9488405116035, 5119.846404607849, 4861.538153875394, 4910.312556242129, 4911.68074075184, 4926.876828079291, 4992.500749925015, 4876.414830220361, 4938.827141050082, 4941.481144479814, 5002.24966255061, 5050.090983622947, 4945.332380128672, 4983.775730092155, 4987.825426110068, 4993.400791904958, 5039.193729003378, 5308.283381743492, 5421.620486565942, 5470.56235501159, 5478.096114141202, 5552.77788888444, 5899.410058994109, 5934.139549765303, 5959.165716799652, 5961.254843144607, 5963.224780778471, 5799.5650326225705, 5990.371011043865, 5995.040793473024, 6011.669358185298, 6014.037753959389, 5403.8108666196495, 5476.726163691799, 5480.698561579112, 5548.69482178484, 5552.139418390076, 6050.515958723292, 6063.514918806485, 6066.393360663898, 6066.817995460143, 6068.605540639933, 5627.212190293362, 5632.52123569493, 5822.679752613562, 5823.621464604787, 5823.94176058234, 5750.0, 5792.739326730307, 5834.649921004669, 5846.532277417797, 5848.064309710426, 5712.65724056558, 5742.48317651405, 5756.539476841843, 5757.971210144006, 5759.22250496186, 5705.486506214461, 5736.942630573641, 5778.768849245983, 5791.942080579141, 5792.420757924258, 4413.6248418884115, 4438.778061096997, 4457.77711114443, 4472.306792447176, 4523.0, 3967.543732470745, 3971.4241434991764, 3984.2828290907337, 4014.41790940312, 4014.658754005884, 5571.470710282517, 5571.916421253684, 5572.3870374258795, 5574.58190635704, 5579.804706835242, 5764.337101233412, 5800.071988481907, 5824.213731146326, 5848.181254624356, 5875.059990401515, 5537.8061767837935, 5541.667499950016, 5545.445455454423, 5549.361823390362, 5549.417311182267, 4937.308776771183, 5079.619028572872, 5084.567811736044, 5087.262346959744, 5143.485651434827, 6023.69881505923, 6060.727267272983, 6066.514678825772, 6119.5410344224365, 6129.233845769189, 5862.560307976833, 5862.648241105548, 5864.296284445893, 5866.413358664099, 5868.4424979626865, 5856.648601083949, 6063.696815159313, 6082.057281121433, 6093.847653808691, 6106.0, 5760.855978600569, 5809.390014048633, 5812.593118481665, 5824.621399609012, 5869.73586188614, 5888.823335299948, 5935.762569497172, 5936.525077993664, 5941.524678025661, 5943.197668314895, 5586.804461843816, 5670.404607516151, 5687.77248910039, 5791.391903850035, 5797.420257974169, 5706.686132262766, 5706.714664266687, 5714.485696287354, 5720.0, 5754.395788442153, 5584.301962254718, 5638.069718496402, 5642.210090587239, 5645.237892884408, 5646.209530665628, 5586.050371436947, 5605.243292155506, 5717.656940583578, 5719.170720245458, 5740.799072032459, 5559.72201389937, 5586.329640443173, 5592.496675299242, 5603.075492543685, 5605.943940560543], "value": 5394.817831192907, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.29088639201, 623.8877002139616, 626.0, 633.2812258087072, 643.6395618453663, 30730.539041914362, 31567.842160789194, 42203.78898105513, 43055.0, 43060.13879722403, 37967.62032379676, 39392.60607393925, 39451.40822887659, 39514.407283890694, 40312.0, 8821.735347939572, 8979.102089791035, 8991.190792828644, 8993.0, 8997.235235005033, 8847.646094156225, 8953.10468953106, 8953.955230223872, 8954.462732236087, 8954.910450895506, 8965.820683586324, 8988.0, 8995.41529800564, 9002.954985225064, 9004.774880628003, 8935.151160639729, 8971.910280897173, 8982.910170898273, 8983.595738191765, 8983.685571004984, 8857.158569935846, 8923.866142007875, 8929.73210803677, 8930.017698053209, 8932.0, 42355.36466952998, 42358.78820605908, 42489.57510424887, 42516.36225456621, 42533.78733106345, 3583.4624806279007, 3627.419612861956, 3737.906552336186, 3908.2378936107184, 4135.56576559463, 31933.52099718506, 32210.677893221004, 32272.0, 32360.0, 33612.831935840164, 4166.312558427856, 4198.223328684173, 4204.747715137101, 4226.704130710851, 4386.583274588909, 337565.0, 338425.0, 338492.0, 339686.3015684931, 340220.0, 57150.0, 57252.0, 57699.42300576941, 57755.711221444464, 57789.0, 33846.96918184917, 35042.64957350445, 35107.0, 35135.4729679055, 60854.39145608576, 16278.26747796352, 16426.096564688818, 16437.91781041111, 16465.094419806785, 16471.752923706154, 12349.506019759288, 12448.75102497945, 12456.501739930483, 12462.43919023646, 12472.75054498923, 19944.60110797776, 20019.499512512302, 20085.196592136443, 20096.0, 20148.697769533468, 7113.324234197743, 7240.384567311838, 7287.323915499464, 7461.216572259943, 7562.546247225074, 981.764376549623, 1027.8509616105623, 1065.6589891234885, 1114.6043154680135, 1139.663799179244, 31886.202844929063, 31981.360372792413, 32070.19824504406, 32179.0, 32492.83753581217, 1097.182598963777, 1103.8178700514325, 1121.9214654974237, 1142.0578023130784, 1142.2917790969486, 16320.83679163217, 17017.149142542825, 17114.0, 17221.7416738749, 17272.506697169283, 557193.0, 557973.0, 561929.0, 564948.0, 567102.0, 58289.41710582925, 58756.0, 58850.705746470994, 58939.705301473216, 58943.41056589465, 1256.7926292161692, 1375.8555351687928, 1403.9789403158961, 1408.3310427547037, 1413.5405993052093, 31622.209444763146, 33145.33709325848, 33388.332233355686, 33725.66274337225, 34022.82988585041, 50964.74517627388, 51362.74318628383, 51516.74241628768, 51525.227121592456, 51563.22655160101, 398784.0, 408243.0, 408369.0, 408842.0, 409420.0, 25346.493070138862, 26656.866715667074, 27206.863965680044, 27795.861020694767, 29275.268118297212, 47737.76131119322, 48091.0, 48821.267680985526, 48830.0, 49355.766105847644, 40200.39699404453, 41699.37450938178, 42002.159956801304, 42037.0, 42097.36853947255, 40737.79631101825, 40942.79528602338, 41855.790721047415, 41972.0, 42179.367309491, 39965.651865683605, 40933.38599920944, 41003.0, 41608.791956040026, 41714.58285417107, 35261.0, 36522.0, 36596.0850978717, 36624.81687591545, 37305.0, 26736.331591710365, 26953.0, 27248.318792030357, 27295.45409091847, 27614.376634219716], "value": 19857.01753390145, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.87651266363747, 414.35567692238595, 414.419812262832, 427.41230807639494, 437.676119671443, 18185.818141818578, 19026.80973190268, 19677.704834427477, 19738.30915917945, 20024.399268021945, 12224.0, 12391.814122788166, 12520.499180032788, 12552.748945021094, 12842.614721558344, 5239.973800130994, 5245.186996015624, 5409.215663728757, 5425.3489581250105, 5460.890782184354, 5332.840014799563, 5391.433899440561, 5397.2443857859735, 5423.620346575742, 5437.32033495813, 5372.247885296062, 5421.539169170625, 5421.756020979065, 5421.756020979065, 5428.4028756836915, 5206.661566998152, 5288.65623734456, 5319.627626066177, 5345.251664766916, 5456.972715136419, 5085.440601533828, 5160.25176349431, 5171.01750667372, 5172.379314482287, 5173.482651734834, 21848.672269915965, 22656.773432265632, 23480.76519234803, 23587.410314742097, 23593.528129437316, 2538.1370334086314, 2608.5695860183046, 2668.6530751002247, 2711.850848203348, 2909.9127026189035, 9853.556589953469, 9894.257930655229, 10010.449425281606, 10464.162866970624, 10582.365058096539, 1858.9721154182698, 1947.4352437793023, 1949.756280464942, 1974.8025197480138, 2002.1791065663153, 54145.0, 79779.6011019947, 80348.0, 80741.0, 82210.58894705489, 11329.830052549218, 11524.078073754079, 11585.189036767513, 11589.884101159048, 11727.706807329714, 16187.676246475005, 16342.75485867713, 16377.42679006229, 16396.26216820246, 16401.1799410029, 7850.725224617111, 7936.174679823557, 7950.4832185907735, 8062.879056814152, 8099.109097999215, 7476.1776204617445, 7533.4349923755935, 7620.085589729268, 7710.306072453506, 7765.611719414007, 4641.350210970467, 4706.764661766898, 4734.100520901018, 4761.833350829, 4803.087413391444, 1946.2896042944506, 1969.2615269274022, 1998.4803950972562, 2027.0, 2048.1704909511673, 891.2825175733467, 978.3347323819871, 989.6684610655367, 1046.99476502617, 1068.1241382066787, 18579.256829726928, 18605.441836744918, 18894.05529723508, 19124.139413726414, 19669.21323147087, 954.7947191353892, 955.6607404371487, 981.9018098190267, 1003.4230317567428, 1044.9059584637266, 10313.1233845124, 10849.90777628372, 10861.329628259766, 10866.293690910066, 10886.782264354668, 473633.0, 474836.0, 476631.0, 479117.0, 491669.0, 65811.0, 85036.0, 86188.56905715431, 94158.52920735352, 95420.0, 944.3389627260945, 945.3618807305041, 963.5904740485265, 974.9902500975041, 976.8730065091493, 17404.73892891633, 17501.29994800194, 17743.29026838912, 17842.5539361517, 18179.272829086687, 41802.79098604488, 42171.7891410541, 42748.572514274456, 43935.56064439315, 43941.340879887466, 58967.41032589619, 59004.0, 59697.403025970925, 60646.238607332234, 61513.077303841375, 8854.690085847222, 8905.955470222607, 8974.820503590023, 9059.547022648972, 9070.229030532479, 13015.674608134872, 14001.369938353002, 14140.01019928595, 14337.713245735236, 14913.850861491246, 12232.204906681038, 12480.126391152533, 12504.562340318045, 12616.684582885135, 12693.4287957044, 10769.192310576582, 12158.513659453523, 12200.267983920992, 12422.503099875903, 12755.553555625509, 12090.32773780954, 12209.450574724337, 12234.388280586114, 12462.688432789253, 13160.341982901009, 8963.238124759468, 9059.229965452747, 9095.135962083592, 9132.817343652956, 9302.16280534755, 9066.90933090687, 11582.478788454371, 11876.940615296868, 12033.157678962389, 12180.330081845583], "value": 9136.097264529531, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1339.0894191949483, 1485.48750681015, 1506.4275575281395, 1653.6527329260855, 1777.751114843922, 8669.999999999993, 9024.052474490183, 9051.637934482622, 9313.627454901796, 9323.114304141096, 9002.054784247657, 9184.724458266246, 9206.401583897043, 9213.815723685522, 9220.492872891988, 2066.380085974202, 2129.510212651091, 2130.020190712274, 2398.988005059977, 2433.0, 2386.78518933296, 2460.360306320352, 2463.051725085846, 2480.082369523279, 2481.3424442522746, 2423.7091549014144, 2440.2923152285816, 2446.483180428137, 2448.5959816630234, 2469.5431345201105, 2120.321497120922, 2361.8582885026954, 2387.761223877607, 2399.1363109280733, 2404.6873906392234, 2421.0436877433317, 2463.8521688698734, 2463.987680061606, 2464.8151388645742, 2467.5558399488086, 9083.863742043875, 9156.725298241063, 9156.8626470603, 9170.633174673005, 9172.0, 5174.663646862942, 5293.39126000511, 5305.177697456862, 5311.6189790654325, 5312.389075256357, 3125.1718294651937, 3156.6527681954967, 3231.7576181786226, 3253.951190732117, 3256.1208473712204, 1086.2287775679276, 1095.950682219302, 1101.4602844606165, 1105.237386203517, 1124.1456493065248, 12997.545085921947, 13012.86987130126, 13023.413946372437, 13044.08691391603, 13065.085444018923, 4842.443119041285, 4969.552740253394, 5003.649744517922, 5012.924806127911, 5055.721935293521, 10822.404767737693, 10846.728831779112, 10853.620123295805, 10856.945715271531, 10866.45667716611, 5322.840314790563, 5333.359996800409, 5374.865628359323, 5382.192671099367, 5503.532199762985, 4268.893277668083, 4581.839635612738, 4703.153432382135, 4748.406449193851, 4811.446683631357, 4063.4920634920636, 4097.09863829957, 4162.292410290258, 4188.0, 4196.349565817303, 1325.3174615073244, 1331.3942156318851, 1345.5156143788229, 1353.7680710553545, 1355.7462090981526, 908.6002159049997, 972.7081875437482, 974.5809302000208, 1017.2014968249888, 1021.4230302548023, 6184.381561843869, 6186.1648677428875, 6295.842603934938, 6331.986882098934, 6503.382178693017, 960.558143254097, 985.6451677396132, 1009.2934945538153, 1019.6482213636284, 1021.6526381030485, 4233.5554766749665, 4264.978675106605, 4431.734095954189, 4444.2000439920475, 4524.615407690383, 11313.0, 11654.53381864716, 11821.527138914347, 11822.645320640395, 11830.112741544246, 11030.834537481944, 11414.771704565863, 11628.418579071013, 11665.125115616192, 11686.47410866513, 8555.230029297392, 8650.740477785677, 8671.306295496344, 8738.563071846382, 8744.300455963508, 6270.717817698123, 6451.580647257913, 6518.57629254097, 6532.510061745483, 6542.378474044958, 10399.428031458343, 10609.840852387066, 10772.0, 10787.190960677824, 10809.783804324026, 10705.197110216921, 10853.34879907208, 10863.239573229797, 10878.292910960763, 10920.672379828618, 7226.277372262732, 7929.207079292025, 8129.959350203448, 8156.796080098045, 8291.33669306442, 9052.864207036768, 9057.365984381293, 9152.862707059532, 9161.26709863196, 9172.220361269367, 7884.329831964347, 8137.918620813716, 8222.506649601042, 8267.090620031911, 8318.584070796556, 7932.206779322021, 8077.232662897015, 8112.513249205066, 8143.063547691854, 8164.591770411337, 7347.15507716598, 7414.332710056121, 7525.661345239368, 7535.321821036133, 7567.0, 5557.749901254372, 5571.359293681278, 5580.609357344947, 5581.6371935824045, 5646.407127251579, 5320.733963301742, 5378.892422151614, 5485.75314110858, 5593.664380137205, 5793.275840519935], "value": 4833.016027985636, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.11841081792625, 332.26900818199965, 332.5826088259235, 333.29508090388833, 336.3743437206795, 5109.182530795074, 5179.559737422314, 5236.345456817893, 5301.469853014702, 5343.0, 5192.844214673556, 5228.111221092414, 5231.633785635007, 5231.712255825928, 5245.763940622672, 4128.483939507561, 4132.814023368941, 4136.58634136587, 4146.6268035876765, 4147.440095587102, 3932.6460618544324, 3947.9013024674327, 4127.442795222637, 4141.5237247716595, 4147.274227010276, 4088.4276201331836, 4123.670106391482, 4137.627613514783, 4139.917201655965, 4151.709380343377, 4111.280525907954, 4113.716887127658, 4129.442525259082, 4141.461609990712, 4149.97925010376, 3367.1750421146976, 3683.189698266404, 3693.372126738434, 3695.815209239554, 3706.9073273168115, 5109.770060347256, 5112.41207261166, 5119.513646203642, 5174.28350116192, 5176.0, 4652.674312798105, 4658.930116048262, 4672.042231342567, 4673.686525170028, 4691.366665500182, 5334.893302133935, 5335.226392173152, 5420.674759514442, 5479.972600137014, 5504.0, 3941.625545573195, 3946.664533514626, 3964.8215830287704, 3969.233691007503, 3973.940390894139, 5665.810179862234, 5676.460736230051, 5679.346875109332, 5685.299482745704, 5703.5152012079025, 4009.939850902239, 4050.635442810102, 4051.47330846988, 4055.9391609125296, 4085.754854708727, 3854.7879866607045, 4074.062965517888, 4077.734947228421, 4084.7549147050677, 4086.8569600063856, 4639.257718765049, 4652.767361631905, 4653.60444362233, 4655.627549796008, 4656.95343046572, 5381.461853814587, 5434.2392065110125, 5440.510354068153, 5479.753411096431, 5496.972515137399, 1305.3734207580414, 1313.487739781486, 1396.1483495068, 1402.9859701403059, 1416.5042235217797, 892.2995448572839, 904.9502277374808, 917.0233701108299, 922.2391526990126, 935.4340623922565, 4744.928826067612, 4755.619550435957, 4764.475907650156, 4764.95235047652, 4765.928511072337, 4976.875578110504, 4977.43662014063, 4992.625553083533, 5010.1983682611335, 5036.874078148002, 4516.548345165457, 4760.619150467955, 4787.42550893895, 4824.686395384359, 4826.8069277228515, 2669.7997650176317, 2671.3321669582606, 2675.2776750277317, 2677.5180467516034, 2683.396235846958, 5175.223716442564, 5192.948070519246, 5196.740162991835, 5229.346331708536, 5304.389995150607, 4737.360456338419, 5077.644564880423, 5079.2381142828135, 5104.3109180260935, 5141.228815677603, 5170.0, 5181.35233095863, 5184.248283998723, 5189.792408303701, 5192.584593232532, 4982.7259500727805, 4983.551480366785, 5009.5491405773655, 5013.298138260573, 5083.262926875656, 4698.812047518061, 4734.644901632322, 4958.801647934042, 4968.559117855782, 5040.891003979119, 5102.821401250939, 5146.562542183956, 5149.403684857706, 5163.922541161961, 5198.934218485277, 3667.376545987242, 3677.3380791457794, 3682.429223470366, 3691.53855768029, 3845.8269377877505, 5460.399356070909, 5585.972070139624, 5598.608097433141, 5602.803901863415, 5634.915476267777, 5437.728113594384, 5477.698726570077, 5478.726063696879, 5490.533304668988, 5521.420250873761, 5258.053550360972, 5473.72631368422, 5478.808241711521, 5487.807926722546, 5500.4048825840055, 5324.760385782572, 5341.145416733304, 5382.865428364322, 5392.433794451526, 5414.620976531605, 5438.673679579238, 5464.808731694372, 5503.862403439946, 5515.448455154453, 5518.2826232589505, 5197.636165468381, 5351.170568561879, 5494.148406996922, 5510.752016159363, 5539.362973258127], "value": 4048.356054324429, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.4534431160166, 736.778966310107, 753.1226121568374, 774.0363247756544, 831.6590198018812, 14775.999999999987, 16114.35542578297, 16115.355385784584, 16149.75775363369, 16159.434419795309, 14693.1918744469, 14897.478588249414, 14935.327910244037, 14977.101373917572, 15021.549353519413, 822.1326500541926, 832.3590835057003, 832.4921797703396, 832.5254604875223, 832.7918020494876, 692.3353580562641, 811.1442428238236, 814.5804910471112, 833.9833203335929, 843.0810416645854, 869.460934220784, 875.1729615513342, 875.6234819027816, 876.8334016536837, 877.7410663854179, 872.9912700872974, 873.2926329672954, 873.5064688451005, 873.8077622922979, 874.0603850860318, 529.8225094593316, 616.9444749972479, 631.3307893632764, 631.4506379449862, 634.3846468925135, 15199.544013679497, 15205.239738013166, 15241.085534867943, 15242.237888105661, 15273.159976201305, 13470.0, 14103.858961410357, 14289.142651440947, 14332.856671433257, 14361.712765744627, 13227.140235884637, 13326.073708502738, 13332.200067995855, 13397.66505837352, 13906.58280251594, 4398.692091553593, 4440.289553671397, 4443.355713421568, 4547.567981041796, 4589.059242855206, 76215.6189219056, 76905.0, 77053.0, 77137.61431192808, 77441.61279193568, 10634.680959571226, 11026.669199924016, 11214.66356009321, 11575.13186511015, 11626.593069242535, 20317.0, 20456.59086818285, 20489.795102049087, 20503.38489845307, 20520.07659655319, 8100.149484304181, 8117.715879944174, 8141.51150930946, 8260.132686067876, 8290.4611200273, 4490.618297444688, 4783.4499032611, 4878.707277563358, 4999.075171093359, 5100.209467532539, 3668.9082772930356, 3811.561670407883, 3811.6950643948417, 3815.027168072124, 3819.6371344722206, 626.9749210031639, 644.690548536705, 644.9677516124175, 654.1104098426136, 660.643252643567, 587.4930802491596, 646.208394716478, 725.8802297620939, 744.181400459501, 749.2058418076856, 9385.90614093864, 9630.855537166948, 9806.852897206547, 10190.643327483502, 10324.0, 594.1384991761876, 611.272585623107, 642.6447071483055, 670.0552221367946, 718.762808273279, 4598.425196850394, 4625.537446255347, 4630.83792067276, 4698.248280275139, 4703.129920964632, 116958.0, 117115.0, 117280.0, 117941.0, 120781.0, 79659.0, 84211.0, 94024.0, 100260.29046617543, 101192.0, 88665.55667221623, 90074.09925900657, 90155.54922225478, 90443.09556904346, 90722.54638726765, 10215.23385746087, 10345.529565394663, 10557.524911378852, 10573.52419141125, 10608.734781630521, 49712.502874970785, 50064.24903626522, 51282.48717512777, 53192.0744359064, 53265.0, 70555.0, 72167.63916180386, 72623.27376726165, 75103.0, 76338.0, 13054.804177937149, 13334.133221349213, 13382.397792099573, 13431.86568134306, 13674.863251367358, 14717.779233311294, 14837.258137092886, 14918.0, 14990.850091498945, 15905.284262208459, 14082.929585352007, 14138.929305353407, 14595.197264150574, 14607.488737894548, 14738.55784326472, 13756.449742010207, 13869.167849929037, 14005.299735013412, 14154.221517816619, 14418.711625767635, 13554.661133471742, 13558.86441135576, 13986.650333741738, 14084.788728169291, 14420.206888620807, 11293.322400655987, 11453.828192577284, 11485.138614603771, 11867.347295898464, 11880.762384752084, 11336.829947550958, 11534.711632209262, 11597.88402115968, 11875.703107422383, 11909.82135267989], "value": 7683.405204754418, "unit": "score"}], "name": "dromaeo_css", "value": 7265.929623374338, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 104.0, 109.0, 110.0, 110.0, 109.0, 108.0, 109.0, 110.0, 111.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 124.0, 129.0, 178.0, 126.0, 126.0, 152.0, 124.0, 158.0, 124.0], "value": 139.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 161.0, 162.0, 162.0, 162.0, 162.0, 161.0, 163.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 117.0, 77.0, 83.0, 74.0, 75.0, 99.0, 76.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 117.0, 85.0, 85.0, 87.0, 125.0, 86.0, 84.0, 124.0], "value": 96.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 54.0, 57.0, 54.0, 53.0, 54.0, 54.0, 54.0, 52.0, 54.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 60.0, 60.0, 60.0, 59.0, 60.0, 60.0, 61.0, 61.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 83.0, 83.0, 89.0, 83.0, 83.0, 90.0, 118.0, 83.0], "value": 87.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 122.0, 129.0, 129.0, 121.0, 121.0, 122.0, 127.0, 136.0, 137.0], "value": 126.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 167.0, 167.0, 164.0, 160.0, 160.0, 159.0, 160.0, 162.0], "value": 163.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 67.0, 69.0, 67.0, 62.0, 71.0, 62.0, 62.0, 62.0], "value": 65.1, "unit": "score"}], "name": "kraken", "value": 1504.1999999999998, "alertThreshold": 2.0}]} 20:30:02 INFO - Return code: 0 20:30:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:30:02 INFO - # TBPL SUCCESS # 20:30:02 INFO - Running post-action listener: _resource_record_post_action 20:30:02 INFO - ##### 20:30:02 INFO - ##### Finished run-tests step (success) 20:30:02 INFO - ##### 20:30:02 INFO - Running post-run listener: _resource_record_post_run 20:30:02 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 8192; Write bytes: 563183616; Read time: 308; Write time: 1683960 20:30:02 INFO - TinderboxPrint: CPU usage
13.4% 20:30:02 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 308 20:30:02 INFO - TinderboxPrint: I/O write bytes / time
563,183,616 / 1,683,960 20:30:02 INFO - TinderboxPrint: CPU idle
8,269.8 (86.6%) 20:30:02 INFO - TinderboxPrint: CPU user
1,216.8 (12.7%) 20:30:02 INFO - TinderboxPrint: Swap in / out
0 / 0 20:30:02 INFO - install - Wall time: 17s; CPU: 21.0%; Read bytes: 0; Write bytes: 240644096; Read time: 0; Write time: 1172196 20:30:02 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 8192; Write bytes: 294178816; Read time: 308; Write time: 491252 20:30:03 INFO - Running post-run listener: _upload_blobber_files 20:30:03 INFO - Blob upload gear active. 20:30:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:30:03 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 20:30:03 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'] 20:30:03 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 20:30:03 INFO - (blobuploader) - INFO - Open directory for files ... 20:30:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:30:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:30:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:30:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:30:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:30:08 INFO - (blobuploader) - INFO - Done attempting. 20:30:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:30:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:30:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:30:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:30:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:30:09 INFO - (blobuploader) - INFO - Done attempting. 20:30:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:30:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:30:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:30:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:30:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:30:10 INFO - (blobuploader) - INFO - Done attempting. 20:30:10 INFO - (blobuploader) - INFO - Iteration through files over. 20:30:10 INFO - Return code: 0 20:30:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:30:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:30:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2a2b8d58db7e87dee14c0c523b200be9ea28a2914c9d56dccb1df5686636e3ed86deed5cf3f68484135687f19a98b1d616f403ae8ea5c9f2342306a49eb737bb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/be1fd3eafcb049a21dcab4bc3837377306f64aa58c3754f91fe6e5d863874fb17814a820374e4e241f61462882e78c4a00cef7d10d0179712c9a971aec05734f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1bff55784cb684dbcc38dd281347033e3b69eebd890a9f669f596000c1c54dc5dbc5e28dfaba27194bc2594d14df606ce2f6852c941e52a997a4719d1c51c76e"} 20:30:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:30:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:30:10 INFO - Contents: 20:30:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2a2b8d58db7e87dee14c0c523b200be9ea28a2914c9d56dccb1df5686636e3ed86deed5cf3f68484135687f19a98b1d616f403ae8ea5c9f2342306a49eb737bb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/be1fd3eafcb049a21dcab4bc3837377306f64aa58c3754f91fe6e5d863874fb17814a820374e4e241f61462882e78c4a00cef7d10d0179712c9a971aec05734f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1bff55784cb684dbcc38dd281347033e3b69eebd890a9f669f596000c1c54dc5dbc5e28dfaba27194bc2594d14df606ce2f6852c941e52a997a4719d1c51c76e"} 20:30:10 INFO - Running post-run listener: copy_logs_to_upload_dir 20:30:10 INFO - Copying logs to upload dir... 20:30:10 INFO - mkdir: /builds/slave/test/build/upload/logs 20:30:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.391403 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-13 20:30:10.224424) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-13 20:30:10.228118) ========= 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=df17445c3590ff7897617a0e00000225-1465871653.425313-1002655259 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/2a2b8d58db7e87dee14c0c523b200be9ea28a2914c9d56dccb1df5686636e3ed86deed5cf3f68484135687f19a98b1d616f403ae8ea5c9f2342306a49eb737bb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/be1fd3eafcb049a21dcab4bc3837377306f64aa58c3754f91fe6e5d863874fb17814a820374e4e241f61462882e78c4a00cef7d10d0179712c9a971aec05734f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1bff55784cb684dbcc38dd281347033e3b69eebd890a9f669f596000c1c54dc5dbc5e28dfaba27194bc2594d14df606ce2f6852c941e52a997a4719d1c51c76e"} build_url:https://queue.taskcluster.net/v1/task/VdRlrr5EToObkXHZ4mSutA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011479 build_url: 'https://queue.taskcluster.net/v1/task/VdRlrr5EToObkXHZ4mSutA/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/2a2b8d58db7e87dee14c0c523b200be9ea28a2914c9d56dccb1df5686636e3ed86deed5cf3f68484135687f19a98b1d616f403ae8ea5c9f2342306a49eb737bb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/be1fd3eafcb049a21dcab4bc3837377306f64aa58c3754f91fe6e5d863874fb17814a820374e4e241f61462882e78c4a00cef7d10d0179712c9a971aec05734f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1bff55784cb684dbcc38dd281347033e3b69eebd890a9f669f596000c1c54dc5dbc5e28dfaba27194bc2594d14df606ce2f6852c941e52a997a4719d1c51c76e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-13 20:30:10.255255) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 20:30:10.255709) ========= 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=df17445c3590ff7897617a0e00000225-1465871653.425313-1002655259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004494 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 20:30:10.344449) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-13 20:30:10.344906) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-13 20:30:10.345200) ========= ========= Total master_lag: 0.19 =========