builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-053 starttime: 1465214982.43 results: success (0) buildid: 20160606023017 builduid: 50c16143107247e9b93adb79d5a30ca1 revision: a48604c3b4956734c5cae80d350f7890eb9d4aa2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 05:09:42.433840) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 05:09:42.434231) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 05:09:42.434513) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 05:09:42.455055) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:09:42.455365) ========= 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=920470bf432669ad7e3a5387000001ca-1465214641.383333-935213545 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-06 05:09:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.2M=0s 2016-06-06 05:09:43 (46.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116883 ========= master_lag: 0.16 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:09:42.735413) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:09:42.735737) ========= 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=920470bf432669ad7e3a5387000001ca-1465214641.383333-935213545 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019361 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:09:42.780662) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:09:42.781013) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a48604c3b4956734c5cae80d350f7890eb9d4aa2 --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 a48604c3b4956734c5cae80d350f7890eb9d4aa2 --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=920470bf432669ad7e3a5387000001ca-1465214641.383333-935213545 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-06 05:09:43,950 truncating revision to first 12 chars 2016-06-06 05:09:43,950 Setting DEBUG logging. 2016-06-06 05:09:43,950 attempt 1/10 2016-06-06 05:09:43,950 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a48604c3b495?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-06 05:09:44,270 unpacking tar archive at: fx-team-a48604c3b495/testing/mozharness/ program finished with exit code 0 elapsedTime=0.669120 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:09:43.469111) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 05:09:43.469431) ========= script_repo_revision: a48604c3b4956734c5cae80d350f7890eb9d4aa2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 05:09:43.469872) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 05:09:43.470137) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 05:09:43.480905) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-06-06 05:09:43.481174) ========= /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=920470bf432669ad7e3a5387000001ca-1465214641.383333-935213545 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:09:44 INFO - MultiFileLogger online at 20160606 05:09:44 in /builds/slave/test 05:09:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:09:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:09:44 INFO - {'append_to_log': False, 05:09:44 INFO - 'base_work_dir': '/builds/slave/test', 05:09:44 INFO - 'blob_upload_branch': 'Fx-Team', 05:09:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:09:44 INFO - 'branch': 'Fx-Team', 05:09:44 INFO - 'buildbot_json_path': 'buildprops.json', 05:09:44 INFO - 'config_files': ('talos/linux_config.py',), 05:09:44 INFO - 'default_actions': ('clobber', 05:09:44 INFO - 'read-buildbot-config', 05:09:44 INFO - 'download-and-extract', 05:09:44 INFO - 'populate-webroot', 05:09:44 INFO - 'create-virtualenv', 05:09:44 INFO - 'install', 05:09:44 INFO - 'run-tests'), 05:09:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:09:44 INFO - 'download_minidump_stackwalk': True, 05:09:44 INFO - 'download_symbols': 'ondemand', 05:09:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:09:44 INFO - 'tooltool.py': '/tools/tooltool.py', 05:09:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:09:44 INFO - '/tools/misc-python/virtualenv.py')}, 05:09:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:09:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:09:44 INFO - 'installer_path': 'installer.exe', 05:09:44 INFO - 'log_level': 'info', 05:09:44 INFO - 'log_name': 'talos', 05:09:44 INFO - 'log_to_console': True, 05:09:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:09:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:09:44 INFO - 'opt_config_files': (), 05:09:44 INFO - 'pip_index': False, 05:09:44 INFO - 'sps_profile': False, 05:09:44 INFO - 'sps_profile_interval': 0, 05:09:44 INFO - 'suite': 'dromaeojs', 05:09:44 INFO - 'system_bits': '32', 05:09:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:09:44 INFO - 'title': 'talos-linux64-ix-053', 05:09:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:09:44 INFO - 'use_talos_json': True, 05:09:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:09:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:09:44 INFO - 'work_dir': 'build'} 05:09:44 INFO - ##### 05:09:44 INFO - ##### Running clobber step. 05:09:44 INFO - ##### 05:09:44 INFO - Running pre-action listener: _resource_record_pre_action 05:09:44 INFO - Running main action method: clobber 05:09:44 INFO - rmtree: /builds/slave/test/build 05:09:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:09:45 INFO - Running post-action listener: _resource_record_post_action 05:09:45 INFO - ##### 05:09:45 INFO - ##### Finished clobber step (success) 05:09:45 INFO - ##### 05:09:45 INFO - ##### 05:09:45 INFO - ##### Running read-buildbot-config step. 05:09:45 INFO - ##### 05:09:45 INFO - Running pre-action listener: _resource_record_pre_action 05:09:45 INFO - Running main action method: read_buildbot_config 05:09:45 INFO - Using buildbot properties: 05:09:45 INFO - { 05:09:45 INFO - "project": "", 05:09:45 INFO - "product": "firefox", 05:09:45 INFO - "script_repo_revision": "production", 05:09:45 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:09:45 INFO - "repository": "", 05:09:45 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:09:45 INFO - "buildid": "20160606023017", 05:09:45 INFO - "pgo_build": "True", 05:09:45 INFO - "basedir": "/builds/slave/test", 05:09:45 INFO - "buildnumber": 772, 05:09:45 INFO - "slavename": "talos-linux64-ix-053", 05:09:45 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:09:45 INFO - "platform": "ubuntu64_hw", 05:09:45 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:09:45 INFO - "branch": "fx-team", 05:09:45 INFO - "repo_path": "integration/fx-team", 05:09:45 INFO - "revision": "a48604c3b4956734c5cae80d350f7890eb9d4aa2", 05:09:45 INFO - "stage_platform": "linux64-pgo", 05:09:45 INFO - "builduid": "50c16143107247e9b93adb79d5a30ca1", 05:09:45 INFO - "slavebuilddir": "test" 05:09:45 INFO - } 05:09:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 05:09:45 INFO - Running post-action listener: _resource_record_post_action 05:09:45 INFO - ##### 05:09:45 INFO - ##### Finished read-buildbot-config step (success) 05:09:45 INFO - ##### 05:09:45 INFO - ##### 05:09:45 INFO - ##### Running download-and-extract step. 05:09:45 INFO - ##### 05:09:45 INFO - Running pre-action listener: _resource_record_pre_action 05:09:45 INFO - Running main action method: download_and_extract 05:09:45 INFO - mkdir: /builds/slave/test/build/tests 05:09:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:45 INFO - https://queue.taskcluster.net/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:09:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:09:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:09:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:09:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:09:46 INFO - Downloaded 1361 bytes. 05:09:46 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:09:46 INFO - Using the following test package requirements: 05:09:46 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:09:46 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:09:46 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:09:46 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:46 INFO - u'jsshell-linux-x86_64.zip'], 05:09:46 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:09:46 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:09:46 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:09:46 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:09:46 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:09:46 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:09:46 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05: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')]} 05:09:46 INFO - https://queue.taskcluster.net/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:09:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:09:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:09:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:09:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:09:50 INFO - Downloaded 24440907 bytes. 05:09:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:09:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:09:51 INFO - Return code: 0 05:09:51 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05: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')]} 05:09:51 INFO - https://queue.taskcluster.net/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:09:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:09:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:09:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:09:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:09:53 INFO - Downloaded 24440907 bytes. 05:09:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:09:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:09:54 INFO - Return code: 0 05: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')]} 05:09:54 INFO - https://queue.taskcluster.net/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:09:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:09:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:09:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:09:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:09:55 INFO - Downloaded 10833369 bytes. 05:09:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:09:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:09:56 INFO - Return code: 0 05:09:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:56 INFO - https://queue.taskcluster.net/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:09:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:09:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:09:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:09:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:09:57 INFO - Downloaded 59189488 bytes. 05:09:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:09:57 INFO - mkdir: /builds/slave/test/properties 05:09:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:09:57 INFO - Writing to file /builds/slave/test/properties/build_url 05:09:57 INFO - Contents: 05:09:57 INFO - build_url:https://queue.taskcluster.net/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:09:58 INFO - Running post-action listener: _resource_record_post_action 05:09:58 INFO - Running post-action listener: set_extra_try_arguments 05:09:58 INFO - ##### 05:09:58 INFO - ##### Finished download-and-extract step (success) 05:09:58 INFO - ##### 05:09:58 INFO - ##### 05:09:58 INFO - ##### Running populate-webroot step. 05:09:58 INFO - ##### 05:09:58 INFO - Running pre-action listener: _resource_record_pre_action 05:09:58 INFO - Running main action method: populate_webroot 05:09:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:09:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:09:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:09:58 INFO - '--tppagecycles', 05:09:58 INFO - '7'], 05:09:58 INFO - 'tests': ['tsvgm']}}, 05:09:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:09:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:09:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:09:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:09:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:09:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:09:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:58 INFO - 'talos_options': ['--disable-e10s'], 05:09:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:09:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:09:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:58 INFO - 'talos_options': ['--disable-e10s'], 05:09:58 INFO - 'tests': ['damp', 'tps']}, 05:09:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:58 INFO - 'tests': ['damp', 'tps']}, 05:09:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:09:58 INFO - 'tests': ['dromaeo_dom']}, 05:09:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:09:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:09:58 INFO - 'tests': ['a11yr', 05:09:58 INFO - 'ts_paint', 05:09:58 INFO - 'tpaint', 05:09:58 INFO - 'sessionrestore', 05:09:58 INFO - 'sessionrestore_no_auto_restore', 05:09:58 INFO - 'tabpaint']}, 05:09:58 INFO - 'other-e10s': {'tests': ['a11yr', 05:09:58 INFO - 'ts_paint', 05:09:58 INFO - 'tpaint', 05:09:58 INFO - 'sessionrestore', 05:09:58 INFO - 'sessionrestore_no_auto_restore', 05:09:58 INFO - 'tabpaint']}, 05:09:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:09:58 INFO - 'ts_paint', 05:09:58 INFO - 'tpaint', 05:09:58 INFO - 'sessionrestore', 05:09:58 INFO - 'sessionrestore_no_auto_restore', 05:09:58 INFO - 'tabpaint']}, 05:09:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:09:58 INFO - 'ts_paint', 05:09:58 INFO - 'tpaint', 05:09:58 INFO - 'sessionrestore', 05:09:58 INFO - 'sessionrestore_no_auto_restore', 05:09:58 INFO - 'tabpaint']}, 05:09:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:09:58 INFO - 'tests': ['a11yr', 05:09:58 INFO - 'ts_paint', 05:09:58 INFO - 'tpaint', 05:09:58 INFO - 'sessionrestore', 05:09:58 INFO - 'sessionrestore_no_auto_restore', 05:09:58 INFO - 'tabpaint']}, 05:09:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:09:58 INFO - 'tests': ['a11yr', 05:09:58 INFO - 'ts_paint', 05:09:58 INFO - 'tpaint', 05:09:58 INFO - 'sessionrestore', 05:09:58 INFO - 'sessionrestore_no_auto_restore', 05:09:58 INFO - 'tabpaint']}, 05:09:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:09:58 INFO - 'tests': ['tsvgx', 05:09:58 INFO - 'tsvgr_opacity', 05:09:58 INFO - 'tart', 05:09:58 INFO - 'tscrollx', 05:09:58 INFO - 'cart']}, 05:09:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:09:58 INFO - 'tsvgr_opacity', 05:09:58 INFO - 'tart', 05:09:58 INFO - 'tscrollx', 05:09:58 INFO - 'cart']}, 05:09:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:58 INFO - 'talos_options': ['--disable-e10s'], 05:09:58 INFO - 'tests': ['tp5o']}, 05:09:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:58 INFO - 'tests': ['tp5o']}, 05:09:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:58 INFO - 'talos_options': ['--disable-e10s', 05:09:58 INFO - '--xperf_path', 05:09:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:09:58 INFO - 'tests': ['tp5n']}, 05:09:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:58 INFO - 'talos_options': ['--xperf_path', 05:09:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:09:58 INFO - 'tests': ['tp5n']}}, 05:09:58 INFO - 'talos.zip': {'path': '', 05:09:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:09:58 INFO - Running post-action listener: _resource_record_post_action 05:09:58 INFO - ##### 05:09:58 INFO - ##### Finished populate-webroot step (success) 05:09:58 INFO - ##### 05:09:58 INFO - ##### 05:09:58 INFO - ##### Running create-virtualenv step. 05:09:58 INFO - ##### 05:09:58 INFO - Running pre-action listener: _resource_record_pre_action 05:09:58 INFO - Running main action method: create_virtualenv 05:09:58 INFO - Creating virtualenv /builds/slave/test/build/venv 05:09:58 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:09:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:09:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:09:58 INFO - Using real prefix '/usr' 05:09:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:09:58 INFO - Installing distribute.............................................................................................................................................................................................done. 05:10:00 INFO - Installing pip.................done. 05:10:00 INFO - Return code: 0 05:10:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:10:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:00 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 0x7f41b9b86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2390350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241f1c0>, '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 0x24200c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2420550>, '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': '920470bf432669ad7e3a5387000001ca-1465214641.383333-935213545', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:10:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:10:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:10:00 INFO - Using env: {'DISPLAY': ':0', 05:10:00 INFO - 'HOME': '/home/cltbld', 05:10:00 INFO - 'LANG': 'en_US.UTF-8', 05:10:00 INFO - 'LANGUAGE': 'en_US:en', 05:10:00 INFO - 'LOGNAME': 'cltbld', 05:10:00 INFO - 'MAIL': '/var/mail/cltbld', 05:10:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:00 INFO - 'MOZ_NO_REMOTE': '1', 05:10:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:00 INFO - 'NO_EM_RESTART': '1', 05:10:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:00 INFO - 'PWD': '/builds/slave/test', 05:10:00 INFO - 'SHELL': '/bin/bash', 05:10:00 INFO - 'SHLVL': '1', 05:10:00 INFO - 'TERM': 'linux', 05:10:00 INFO - 'TMOUT': '86400', 05:10:00 INFO - 'USER': 'cltbld', 05:10:00 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465214641.383333-935213545', 05:10:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:00 INFO - '_': '/tools/buildbot/bin/python'} 05:10:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:10:01 INFO - Cleaning up... 05:10:01 INFO - Return code: 0 05:10:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05: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')]} 05:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05: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')]} 05:10:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05: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', '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 0x7f41b9b86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2390350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241f1c0>, '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 0x24200c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2420550>, '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': '920470bf432669ad7e3a5387000001ca-1465214641.383333-935213545', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05: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', 'psutil>=3.1.1'] in /builds/slave/test/build 05: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 psutil>=3.1.1 05:10:01 INFO - Using env: {'DISPLAY': ':0', 05:10:01 INFO - 'HOME': '/home/cltbld', 05:10:01 INFO - 'LANG': 'en_US.UTF-8', 05:10:01 INFO - 'LANGUAGE': 'en_US:en', 05:10:01 INFO - 'LOGNAME': 'cltbld', 05:10:01 INFO - 'MAIL': '/var/mail/cltbld', 05:10:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:01 INFO - 'MOZ_NO_REMOTE': '1', 05:10:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:01 INFO - 'NO_EM_RESTART': '1', 05:10:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:01 INFO - 'PWD': '/builds/slave/test', 05:10:01 INFO - 'SHELL': '/bin/bash', 05:10:01 INFO - 'SHLVL': '1', 05:10:01 INFO - 'TERM': 'linux', 05:10:01 INFO - 'TMOUT': '86400', 05:10:01 INFO - 'USER': 'cltbld', 05:10:01 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465214641.383333-935213545', 05:10:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:01 INFO - '_': '/tools/buildbot/bin/python'} 05:10:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:01 INFO - Downloading/unpacking psutil>=3.1.1 05:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:10:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:10:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:10:03 INFO - Installing collected packages: psutil 05:10:03 INFO - Running setup.py install for psutil 05:10:03 INFO - building 'psutil._psutil_linux' extension 05:10:03 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:10:03 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:10:03 INFO - building 'psutil._psutil_posix' extension 05:10:03 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:10:03 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:10:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:10:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:10:03 INFO - Successfully installed psutil 05:10:03 INFO - Cleaning up... 05:10:03 INFO - Return code: 0 05:10:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:10:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:03 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 0x7f41b9b86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2390350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241f1c0>, '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 0x24200c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2420550>, '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': '920470bf432669ad7e3a5387000001ca-1465214641.383333-935213545', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:10:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:10:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:10:03 INFO - Using env: {'DISPLAY': ':0', 05:10:03 INFO - 'HOME': '/home/cltbld', 05:10:03 INFO - 'LANG': 'en_US.UTF-8', 05:10:03 INFO - 'LANGUAGE': 'en_US:en', 05:10:03 INFO - 'LOGNAME': 'cltbld', 05:10:03 INFO - 'MAIL': '/var/mail/cltbld', 05:10:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:03 INFO - 'MOZ_NO_REMOTE': '1', 05:10:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:03 INFO - 'NO_EM_RESTART': '1', 05:10:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:03 INFO - 'PWD': '/builds/slave/test', 05:10:03 INFO - 'SHELL': '/bin/bash', 05:10:03 INFO - 'SHLVL': '1', 05:10:03 INFO - 'TERM': 'linux', 05:10:03 INFO - 'TMOUT': '86400', 05:10:03 INFO - 'USER': 'cltbld', 05:10:03 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465214641.383333-935213545', 05:10:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:03 INFO - '_': '/tools/buildbot/bin/python'} 05:10:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 05: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 05: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 05: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 05: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 05: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 05: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 05:10:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:10:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:10:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:10:06 INFO - Installing collected packages: mozsystemmonitor 05:10:06 INFO - Running setup.py install for mozsystemmonitor 05:10:06 INFO - Successfully installed mozsystemmonitor 05:10:06 INFO - Cleaning up... 05:10:06 INFO - Return code: 0 05:10:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:06 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 0x7f41b9b86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2390350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241f1c0>, '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 0x24200c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2420550>, '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': '920470bf432669ad7e3a5387000001ca-1465214641.383333-935213545', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:10:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:10:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:10:06 INFO - Using env: {'DISPLAY': ':0', 05:10:06 INFO - 'HOME': '/home/cltbld', 05:10:06 INFO - 'LANG': 'en_US.UTF-8', 05:10:06 INFO - 'LANGUAGE': 'en_US:en', 05:10:06 INFO - 'LOGNAME': 'cltbld', 05:10:06 INFO - 'MAIL': '/var/mail/cltbld', 05:10:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:06 INFO - 'MOZ_NO_REMOTE': '1', 05:10:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:06 INFO - 'NO_EM_RESTART': '1', 05:10:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:06 INFO - 'PWD': '/builds/slave/test', 05:10:06 INFO - 'SHELL': '/bin/bash', 05:10:06 INFO - 'SHLVL': '1', 05:10:06 INFO - 'TERM': 'linux', 05:10:06 INFO - 'TMOUT': '86400', 05:10:06 INFO - 'USER': 'cltbld', 05:10:06 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465214641.383333-935213545', 05:10:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:06 INFO - '_': '/tools/buildbot/bin/python'} 05:10:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:06 INFO - Downloading/unpacking jsonschema==2.5.1 05:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:10:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:08 INFO - Downloading functools32-3.2.3-2.tar.gz 05:10:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:10:08 INFO - warning: no files found matching '*.txt' 05:10:08 INFO - no previously-included directories found matching 'build' 05:10:08 INFO - no previously-included directories found matching 'dist' 05:10:08 INFO - no previously-included directories found matching '.git*' 05:10:08 INFO - Installing collected packages: jsonschema, functools32 05:10:08 INFO - Running setup.py install for functools32 05:10:08 INFO - warning: no files found matching '*.txt' 05:10:08 INFO - no previously-included directories found matching 'build' 05:10:08 INFO - no previously-included directories found matching 'dist' 05:10:08 INFO - no previously-included directories found matching '.git*' 05:10:08 INFO - Successfully installed jsonschema functools32 05:10:08 INFO - Cleaning up... 05:10:08 INFO - Return code: 0 05:10:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:10:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:08 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 0x7f41b9b86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2390350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241f1c0>, '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 0x24200c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2420550>, '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': '920470bf432669ad7e3a5387000001ca-1465214641.383333-935213545', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:10:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:10:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:10:08 INFO - Using env: {'DISPLAY': ':0', 05:10:08 INFO - 'HOME': '/home/cltbld', 05:10:08 INFO - 'LANG': 'en_US.UTF-8', 05:10:08 INFO - 'LANGUAGE': 'en_US:en', 05:10:08 INFO - 'LOGNAME': 'cltbld', 05:10:08 INFO - 'MAIL': '/var/mail/cltbld', 05:10:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:08 INFO - 'MOZ_NO_REMOTE': '1', 05:10:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:08 INFO - 'NO_EM_RESTART': '1', 05:10:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:08 INFO - 'PWD': '/builds/slave/test', 05:10:08 INFO - 'SHELL': '/bin/bash', 05:10:08 INFO - 'SHLVL': '1', 05:10:08 INFO - 'TERM': 'linux', 05:10:08 INFO - 'TMOUT': '86400', 05:10:08 INFO - 'USER': 'cltbld', 05:10:08 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465214641.383333-935213545', 05:10:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:08 INFO - '_': '/tools/buildbot/bin/python'} 05:10:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:08 INFO - Downloading/unpacking blobuploader==1.2.4 05:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:10 INFO - Downloading blobuploader-1.2.4.tar.gz 05:10:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:10:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:10:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:10:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:11 INFO - Downloading docopt-0.6.1.tar.gz 05:10:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:10:11 INFO - Installing collected packages: blobuploader, requests, docopt 05:10:11 INFO - Running setup.py install for blobuploader 05:10:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:10:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:10:11 INFO - Running setup.py install for requests 05:10:12 INFO - Running setup.py install for docopt 05:10:12 INFO - Successfully installed blobuploader requests docopt 05:10:12 INFO - Cleaning up... 05:10:12 INFO - Return code: 0 05:10:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:10:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:12 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 0x7f41b9b86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2390350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241f1c0>, '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 0x24200c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2420550>, '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': '920470bf432669ad7e3a5387000001ca-1465214641.383333-935213545', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:10:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:10:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:10:12 INFO - Using env: {'DISPLAY': ':0', 05:10:12 INFO - 'HOME': '/home/cltbld', 05:10:12 INFO - 'LANG': 'en_US.UTF-8', 05:10:12 INFO - 'LANGUAGE': 'en_US:en', 05:10:12 INFO - 'LOGNAME': 'cltbld', 05:10:12 INFO - 'MAIL': '/var/mail/cltbld', 05:10:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:12 INFO - 'MOZ_NO_REMOTE': '1', 05:10:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:12 INFO - 'NO_EM_RESTART': '1', 05:10:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:12 INFO - 'PWD': '/builds/slave/test', 05:10:12 INFO - 'SHELL': '/bin/bash', 05:10:12 INFO - 'SHLVL': '1', 05:10:12 INFO - 'TERM': 'linux', 05:10:12 INFO - 'TMOUT': '86400', 05:10:12 INFO - 'USER': 'cltbld', 05:10:12 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465214641.383333-935213545', 05:10:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:12 INFO - '_': '/tools/buildbot/bin/python'} 05:10:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:10:12 INFO - Running setup.py (path:/tmp/pip-9jSzIV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:10:12 INFO - Running setup.py (path:/tmp/pip-O4jELD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:10:12 INFO - Running setup.py (path:/tmp/pip-FR3uDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:10:12 INFO - Running setup.py (path:/tmp/pip-yDj_CB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:10:12 INFO - Running setup.py (path:/tmp/pip-ZCO5N3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:10:12 INFO - Running setup.py (path:/tmp/pip-RerPOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:10:12 INFO - Running setup.py (path:/tmp/pip-9jdF4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:10:12 INFO - Running setup.py (path:/tmp/pip-TWoRz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:10:13 INFO - Running setup.py (path:/tmp/pip-HDlMmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:10:13 INFO - Running setup.py (path:/tmp/pip-cXgIex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:10:13 INFO - Running setup.py (path:/tmp/pip-QHUrsZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:10:13 INFO - Running setup.py (path:/tmp/pip-ZzB8gN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:10:13 INFO - Running setup.py (path:/tmp/pip-L2MsnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:10:13 INFO - Running setup.py (path:/tmp/pip-kCxoHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:10:13 INFO - Running setup.py (path:/tmp/pip-UatMYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:10:13 INFO - Running setup.py (path:/tmp/pip-Lekejv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:10:13 INFO - Running setup.py (path:/tmp/pip-6ufOG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:10:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:10:13 INFO - Running setup.py install for manifestparser 05:10:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:10:13 INFO - Running setup.py install for mozcrash 05:10:13 INFO - Running setup.py install for mozdebug 05:10:13 INFO - Running setup.py install for mozdevice 05:10:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:10:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:10:14 INFO - Running setup.py install for mozfile 05:10:14 INFO - Running setup.py install for mozhttpd 05:10:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:10:14 INFO - Running setup.py install for mozinfo 05:10:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:10:14 INFO - Running setup.py install for mozInstall 05:10:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:10:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:10:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:10:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:10:14 INFO - Running setup.py install for mozleak 05:10:14 INFO - Running setup.py install for mozlog 05:10:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:10:14 INFO - Running setup.py install for moznetwork 05:10:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:10:14 INFO - Running setup.py install for mozprocess 05:10:14 INFO - Running setup.py install for mozprofile 05:10:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:10:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:10:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:10:15 INFO - Running setup.py install for mozrunner 05:10:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:10:15 INFO - Running setup.py install for mozscreenshot 05:10:15 INFO - Running setup.py install for moztest 05:10:15 INFO - Running setup.py install for mozversion 05:10:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:10:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:10:15 INFO - Cleaning up... 05:10:15 INFO - Return code: 0 05:10:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:10:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:15 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 0x7f41b9b86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2390350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241f1c0>, '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 0x24200c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2420550>, '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': '920470bf432669ad7e3a5387000001ca-1465214641.383333-935213545', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:10:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:10:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:10:15 INFO - Using env: {'DISPLAY': ':0', 05:10:15 INFO - 'HOME': '/home/cltbld', 05:10:15 INFO - 'LANG': 'en_US.UTF-8', 05:10:15 INFO - 'LANGUAGE': 'en_US:en', 05:10:15 INFO - 'LOGNAME': 'cltbld', 05:10:15 INFO - 'MAIL': '/var/mail/cltbld', 05:10:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:15 INFO - 'MOZ_NO_REMOTE': '1', 05:10:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:15 INFO - 'NO_EM_RESTART': '1', 05:10:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:15 INFO - 'PWD': '/builds/slave/test', 05:10:15 INFO - 'SHELL': '/bin/bash', 05:10:15 INFO - 'SHLVL': '1', 05:10:15 INFO - 'TERM': 'linux', 05:10:15 INFO - 'TMOUT': '86400', 05:10:15 INFO - 'USER': 'cltbld', 05:10:15 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465214641.383333-935213545', 05:10:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:15 INFO - '_': '/tools/buildbot/bin/python'} 05:10:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:10:15 INFO - Running setup.py (path:/tmp/pip-6YOvC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:10:15 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:10:15 INFO - Running setup.py (path:/tmp/pip-MWR0_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:10:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:10:15 INFO - Running setup.py (path:/tmp/pip-sV_aeT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:10:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:10:15 INFO - Running setup.py (path:/tmp/pip-tybxxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:10:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:10:15 INFO - Running setup.py (path:/tmp/pip-URvtuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:10:16 INFO - Running setup.py (path:/tmp/pip-t8DI8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:10:16 INFO - Running setup.py (path:/tmp/pip-ah5RQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:10:16 INFO - Running setup.py (path:/tmp/pip-edD5lZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:10:16 INFO - Running setup.py (path:/tmp/pip-Hi5q7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:10:16 INFO - Running setup.py (path:/tmp/pip-Djshd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:10:16 INFO - Running setup.py (path:/tmp/pip-UIFYgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:10:16 INFO - Running setup.py (path:/tmp/pip-y4NURr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:10:16 INFO - Running setup.py (path:/tmp/pip-D46OLw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:10:16 INFO - Running setup.py (path:/tmp/pip-D5dG0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:10:16 INFO - Running setup.py (path:/tmp/pip-PnO1lX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:10:16 INFO - Running setup.py (path:/tmp/pip-DT0E5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:10:16 INFO - Running setup.py (path:/tmp/pip-CFcb7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:10:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:10:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:18 INFO - Downloading blessings-1.6.tar.gz 05:10:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:10:18 INFO - Installing collected packages: blessings 05:10:18 INFO - Running setup.py install for blessings 05:10:18 INFO - Successfully installed blessings 05:10:18 INFO - Cleaning up... 05:10:19 INFO - Return code: 0 05:10:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:10:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:10:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:10:19 INFO - Reading from file tmpfile_stdout 05:10:19 INFO - Current package versions: 05:10:19 INFO - argparse == 1.2.1 05:10:19 INFO - blessings == 1.6 05:10:19 INFO - blobuploader == 1.2.4 05:10:19 INFO - docopt == 0.6.1 05:10:19 INFO - functools32 == 3.2.3-2 05:10:19 INFO - jsonschema == 2.5.1 05:10:19 INFO - manifestparser == 1.1 05:10:19 INFO - mozInstall == 1.12 05:10:19 INFO - mozcrash == 0.17 05:10:19 INFO - mozdebug == 0.1 05:10:19 INFO - mozdevice == 0.48 05:10:19 INFO - mozfile == 1.2 05:10:19 INFO - mozhttpd == 0.7 05:10:19 INFO - mozinfo == 0.9 05:10:19 INFO - mozleak == 0.1 05:10:19 INFO - mozlog == 3.2 05:10:19 INFO - moznetwork == 0.27 05:10:19 INFO - mozprocess == 0.22 05:10:19 INFO - mozprofile == 0.28 05:10:19 INFO - mozrunner == 6.11 05:10:19 INFO - mozscreenshot == 0.1 05:10:19 INFO - mozsystemmonitor == 0.3 05:10:19 INFO - moztest == 0.7 05:10:19 INFO - mozversion == 1.4 05:10:19 INFO - psutil == 3.1.1 05:10:19 INFO - requests == 1.2.3 05:10:19 INFO - wsgiref == 0.1.2 05:10:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:10:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:19 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 0x7f41b9b86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2390350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241f1c0>, '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 0x24200c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2420550>, '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': '920470bf432669ad7e3a5387000001ca-1465214641.383333-935213545', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:10:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:10:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:10:19 INFO - Using env: {'DISPLAY': ':0', 05:10:19 INFO - 'HOME': '/home/cltbld', 05:10:19 INFO - 'LANG': 'en_US.UTF-8', 05:10:19 INFO - 'LANGUAGE': 'en_US:en', 05:10:19 INFO - 'LOGNAME': 'cltbld', 05:10:19 INFO - 'MAIL': '/var/mail/cltbld', 05:10:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:19 INFO - 'MOZ_NO_REMOTE': '1', 05:10:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:19 INFO - 'NO_EM_RESTART': '1', 05:10:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:19 INFO - 'PWD': '/builds/slave/test', 05:10:19 INFO - 'SHELL': '/bin/bash', 05:10:19 INFO - 'SHLVL': '1', 05:10:19 INFO - 'TERM': 'linux', 05:10:19 INFO - 'TMOUT': '86400', 05:10:19 INFO - 'USER': 'cltbld', 05:10:19 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465214641.383333-935213545', 05:10:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:19 INFO - '_': '/tools/buildbot/bin/python'} 05:10:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:10:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:10:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:10:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:10:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:10:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:10:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:10:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:10:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:10:19 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:10:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:10:19 INFO - Cleaning up... 05:10:19 INFO - Return code: 0 05:10:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:10:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:19 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 0x7f41b9b86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2390350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241f1c0>, '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 0x24200c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2420550>, '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': '920470bf432669ad7e3a5387000001ca-1465214641.383333-935213545', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:10:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:10:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:10:19 INFO - Using env: {'DISPLAY': ':0', 05:10:19 INFO - 'HOME': '/home/cltbld', 05:10:19 INFO - 'LANG': 'en_US.UTF-8', 05:10:19 INFO - 'LANGUAGE': 'en_US:en', 05:10:19 INFO - 'LOGNAME': 'cltbld', 05:10:19 INFO - 'MAIL': '/var/mail/cltbld', 05:10:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:19 INFO - 'MOZ_NO_REMOTE': '1', 05:10:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:19 INFO - 'NO_EM_RESTART': '1', 05:10:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:19 INFO - 'PWD': '/builds/slave/test', 05:10:19 INFO - 'SHELL': '/bin/bash', 05:10:19 INFO - 'SHLVL': '1', 05:10:19 INFO - 'TERM': 'linux', 05:10:19 INFO - 'TMOUT': '86400', 05:10:19 INFO - 'USER': 'cltbld', 05:10:19 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465214641.383333-935213545', 05:10:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:19 INFO - '_': '/tools/buildbot/bin/python'} 05:10:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:10:19 INFO - Cleaning up... 05:10:19 INFO - Return code: 0 05:10:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:10:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:19 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 0x7f41b9b86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2390350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241f1c0>, '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 0x24200c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2420550>, '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': '920470bf432669ad7e3a5387000001ca-1465214641.383333-935213545', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:10:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:10:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:10:19 INFO - Using env: {'DISPLAY': ':0', 05:10:19 INFO - 'HOME': '/home/cltbld', 05:10:19 INFO - 'LANG': 'en_US.UTF-8', 05:10:19 INFO - 'LANGUAGE': 'en_US:en', 05:10:19 INFO - 'LOGNAME': 'cltbld', 05:10:19 INFO - 'MAIL': '/var/mail/cltbld', 05:10:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:19 INFO - 'MOZ_NO_REMOTE': '1', 05:10:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:19 INFO - 'NO_EM_RESTART': '1', 05:10:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:19 INFO - 'PWD': '/builds/slave/test', 05:10:19 INFO - 'SHELL': '/bin/bash', 05:10:19 INFO - 'SHLVL': '1', 05:10:19 INFO - 'TERM': 'linux', 05:10:19 INFO - 'TMOUT': '86400', 05:10:19 INFO - 'USER': 'cltbld', 05:10:19 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465214641.383333-935213545', 05:10:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:19 INFO - '_': '/tools/buildbot/bin/python'} 05:10:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:19 INFO - Downloading/unpacking flake8 05:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:10:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:10:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:10:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:10:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:10:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:10:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:10:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:10:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:10:22 INFO - no previously-included directories found matching 'docs/_build' 05:10:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:10:22 INFO - Running setup.py install for pep8 05:10:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:10:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:10:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:10:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:10:22 INFO - no previously-included directories found matching 'docs/_build' 05:10:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:10:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:10:22 INFO - Cleaning up... 05:10:22 INFO - Return code: 0 05:10:22 INFO - Running post-action listener: _resource_record_post_action 05:10:22 INFO - Running post-action listener: _start_resource_monitoring 05:10:22 INFO - Starting resource monitoring. 05:10:22 INFO - ##### 05:10:22 INFO - ##### Finished create-virtualenv step (success) 05:10:22 INFO - ##### 05:10:22 INFO - ##### 05:10:22 INFO - ##### Running install step. 05:10:22 INFO - ##### 05:10:22 INFO - Running pre-action listener: _resource_record_pre_action 05:10:22 INFO - Running main action method: install 05:10:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:10:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:10:22 INFO - Reading from file tmpfile_stdout 05:10:22 INFO - Detecting whether we're running mozinstall >=1.0... 05:10:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:10:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:10:23 INFO - Reading from file tmpfile_stdout 05:10:23 INFO - Output received: 05:10:23 INFO - Usage: mozinstall [options] installer 05:10:23 INFO - Options: 05:10:23 INFO - -h, --help show this help message and exit 05:10:23 INFO - -d DEST, --destination=DEST 05:10:23 INFO - Directory to install application into. [default: 05:10:23 INFO - "/builds/slave/test"] 05:10:23 INFO - --app=APP Application being installed. [default: firefox] 05:10:23 INFO - mkdir: /builds/slave/test/build/application 05:10:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:10:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:10:39 INFO - Reading from file tmpfile_stdout 05:10:39 INFO - Output received: 05:10:39 INFO - /builds/slave/test/build/application/firefox/firefox 05:10:39 INFO - Running post-action listener: _resource_record_post_action 05:10:39 INFO - ##### 05:10:39 INFO - ##### Finished install step (success) 05:10:39 INFO - ##### 05:10:39 INFO - ##### 05:10:39 INFO - ##### Running run-tests step. 05:10:39 INFO - ##### 05:10:39 INFO - Running pre-action listener: _resource_record_pre_action 05:10:39 INFO - Running main action method: run_tests 05:10:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:10:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:10:39 INFO - Python 2.7.3 05:10:39 INFO - Return code: 0 05:10:39 INFO - grabbing minidump binary from tooltool 05:10:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:39 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 0x241f1c0>, '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 0x24200c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2420550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:10:39 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:10:39 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:10:39 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:10:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:10:39 INFO - Return code: 0 05:10:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:10:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:10:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:10:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:10:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:10:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:10:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:10:40 INFO - Return code: 0 05:10:40 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/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:10:40 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/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:10:40 INFO - Using env: {'DISPLAY': ':0', 05:10:40 INFO - 'HOME': '/home/cltbld', 05:10:40 INFO - 'LANG': 'en_US.UTF-8', 05:10:40 INFO - 'LANGUAGE': 'en_US:en', 05:10:40 INFO - 'LOGNAME': 'cltbld', 05:10:40 INFO - 'MAIL': '/var/mail/cltbld', 05:10:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:10:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:10:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:40 INFO - 'MOZ_NO_REMOTE': '1', 05:10:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:10:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:40 INFO - 'NO_EM_RESTART': '1', 05:10:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:40 INFO - 'PWD': '/builds/slave/test', 05:10:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:10:40 INFO - 'SHELL': '/bin/bash', 05:10:40 INFO - 'SHLVL': '1', 05:10:40 INFO - 'TERM': 'linux', 05:10:40 INFO - 'TMOUT': '86400', 05:10:40 INFO - 'USER': 'cltbld', 05:10:40 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465214641.383333-935213545', 05:10:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:40 INFO - '_': '/tools/buildbot/bin/python'} 05:10:40 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/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:10:41 INFO - mozversion application_buildid: 20160606023017 05:10:41 INFO - mozversion application_changeset: a48604c3b4956734c5cae80d350f7890eb9d4aa2 05:10:41 INFO - mozversion application_display_name: Nightly 05:10:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:10:41 INFO - mozversion application_name: Firefox 05:10:41 INFO - mozversion application_remotingname: firefox 05:10:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:10:41 INFO - mozversion application_vendor: Mozilla 05:10:41 INFO - mozversion application_version: 49.0a1 05:10:41 INFO - mozversion platform_buildid: 20160606023017 05:10:41 INFO - mozversion platform_changeset: a48604c3b4956734c5cae80d350f7890eb9d4aa2 05:10:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:10:41 INFO - mozversion platform_version: 49.0a1 05:10:41 INFO - using testdate: 1465215041 05:10:41 INFO - actual date: 1465215041 05:10:41 INFO - starting webserver on 'localhost:44588' 05:10:41 INFO - SUITE-START | Running 2 tests 05:10:41 INFO - TEST-START | dromaeo_css 05:10:41 INFO - operating with platform_type : linux_ 05:10:41 INFO - Initialising browser for dromaeo_css test... 05:10:41 INFO - TEST-INFO | started process 9435 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmeznjO/profile http://localhost:44588/getInfo.html) 05:10:45 INFO - PROCESS | 9435 | __metrics Screen width/height:1600/1200 05:10:45 INFO - PROCESS | 9435 | colorDepth:24 05:10:45 INFO - PROCESS | 9435 | Browser inner width/height: 1024/697 05:10:45 INFO - PROCESS | 9435 | __metrics 05:10:46 ERROR - PROCESS | 9435 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:10:47 INFO - TEST-INFO | 9435: exit 0 05:10:47 INFO - Browser initialized. 05:10:47 INFO - Running cycle 1/1 for dromaeo_css test... 05:10:47 INFO - TEST-INFO | started process 9517 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmeznjO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:10:59 INFO - PROCESS | 9517 | RSS: Main: 156389376 05:10:59 INFO - PROCESS | 9517 | 05:11:50 INFO - PROCESS | 9517 | 1465215110438 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:13:58 INFO - PROCESS | 9517 | Cycle 1(1): loaded http://localhost:44588/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44588/tests/dromaeo/cssquery-ext.html) 05:13:59 INFO - PROCESS | 9517 | RSS: Main: 241946624 05:13:59 INFO - PROCESS | 9517 | 05:17:01 INFO - PROCESS | 9517 | Cycle 1(1): loaded http://localhost:44588/tests/dromaeo/cssquery-ext.html (next: http://localhost:44588/tests/dromaeo/cssquery-jquery.html) 05:17:02 INFO - PROCESS | 9517 | RSS: Main: 243372032 05:17:02 INFO - PROCESS | 9517 | 05:20:04 INFO - PROCESS | 9517 | Cycle 1(1): loaded http://localhost:44588/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44588/tests/dromaeo/cssquery-mootools.html) 05:20:05 INFO - PROCESS | 9517 | RSS: Main: 252076032 05:20:05 INFO - PROCESS | 9517 | 05:23:07 INFO - PROCESS | 9517 | Cycle 1(1): loaded http://localhost:44588/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44588/tests/dromaeo/cssquery-prototype.html) 05:23:07 INFO - PROCESS | 9517 | RSS: Main: 238407680 05:23:07 INFO - PROCESS | 9517 | 05:26:10 INFO - PROCESS | 9517 | Cycle 1(1): loaded http://localhost:44588/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44588/tests/dromaeo/cssquery-yui.html) 05:26:10 INFO - PROCESS | 9517 | RSS: Main: 226181120 05:26:10 INFO - PROCESS | 9517 | 05:29:13 INFO - PROCESS | 9517 | Cycle 1(1): loaded http://localhost:44588/tests/dromaeo/cssquery-yui.html (next: http://localhost:44588/tests/dromaeo/cssquery-dojo.html) 05:29:13 INFO - PROCESS | 9517 | RSS: Main: 276115456 05:29:13 INFO - PROCESS | 9517 | 05:29:13 INFO - PROCESS | 9517 | __start_tp_report 05:29:13 INFO - PROCESS | 9517 | _x_x_mozilla_page_load 05:29:13 INFO - PROCESS | 9517 | _x_x_mozilla_page_load_details 05:29:13 INFO - PROCESS | 9517 | |i|pagename|runs| 05:29:13 INFO - PROCESS | 9517 | |0;dojo.html;3131.530270459431;3158.2104473881514;3186.2830863055815;3204.8077115373094;3218.388506183825;5132.948670513294;5191.558717509007;5361.812336568221;5419.512243898049;5522.17167424886;5382.300300960879;5409.215663728757;5433.26650902129;5441.020616289066;5501.257330260413;4842.782074806633;4858.368412106422;4885.926711099336;4917.926231106519;5083.745812709368;4978.103941290567;5014.924776128361;5020.3724534433195;5020.648554601179;5053.722045287508;4787.257975013878;4804.519548045202;4842.515748425165;4843.491433399495;4932.926006109911;4799.6400269979895;4809.78355973982;4812.663113582051;4818.638602104857;4875.731834749087;4788.209945359012;4805.567498925078;4807.158747219222;4818.662693611449;4850.490698476645;5080.74596270185;5127.53852153308;5263.105272103751;5307.230451584537;5328.600354973392;5816.825495235107;5844.941550584483;5853.063509838448;5869.236999190078;5876.971529982279;5833.445822646841;5890.941090589082;5892.793752218695;5906.438888305647;5917.852053698649;5287.762050707727;5369.221462887859;5447.754851031674;5453.836384908459;5500.532454741352;5995.340512543617;5998.190244316961;5999.670018149044;6002.399760023963;6036.6679832609625;5763.740631671585;5803.622764520293;5811.651300921958;5813.94186058134;5816.418358164235;5553.250311208016;5708.80019199326;5752.02215623345;5753.252077230017;5803.47768700819;5738.397468265855;5750.626209296466;5751.8562035949435;5761.39505351932;5779.133130030529;5551.833444996657;5716.314042314949;5762.30852297727;5768.394318596571;5778.566607504454;4283.22901877665;4300.053988122608;4300.8709738707885;4310.54739252374;4315.395844581761;3872.4191371294532;3885.4560361549406;3886.941695874564;3910.3547914593773;3912.6478616924046;5341.439148889388;5408.4050754416985;5429.95014636392;5479.0959491684225;5540.889182216333;5698.515626171822;5762.855928601818;5771.85570360736;5810.738516766671;5827.038538641077;5515.586331025189;5524.364698059774;5526.668399896019;5527.640703354269;5531.806386776443;4732.219183834698;4826.300186472942;4830.541098595628;4831.758412079453;4868.537488938545;6007.219061521974;6102.09542342839;6102.095423428478;6127.6782420562195;6145.324014358506;5872.970635146797;5878.441548052928;5879.882402351844;5880.588358814842;5910.143029260647;5755.539556835527;5960.433758792908;5960.552958528041;6093.116498107838;6124;5733.283339582552;5744.885102297847;5747;5753.683547404933;5795;5770.6249093808765;5795.913061304168;5825.417458254141;5825.621334613236;5826.184334193301;5546.057170281143;5550.833474995757;5565.916511252415;5577.498025177753;5661.377248502579;5593.1889875966945;5593.216949627137;5595.468430499096;5598.10430331145;5599.272094627672;5468.125099983983;5503.064479038653;5511.421300763523;5511.751971161388;5573.3869274380595;5512.586556008235;5555;5594.804181853616;5608.46719561641;5685.147227915846;5466.781328746805;5487.862803429946;5491.039068163135;5536.916946245729;5543.223948647112 05:29:13 INFO - PROCESS | 9517 | |1;ext.html;594.8393933637915;620.2990620598723;634.419506151871;645.1580687203198;648.2318452633632;33853.83073084634;42964.355534667004;43769.78115109424;43833.12333753323;47844.2823357649;45052.09895802082;45751.54248457515;45863.541364586345;45877.31184032242;45909.31136032962;8698.217160455557;8819.77950551235;8859.77850553738;8886.60010299538;8887.73336799897;8738.126187381244;8901.376903616749;8902.243309318716;8905.064968178345;8907.688230911886;8875.423097498675;8955.910440895574;8972.50651214183;8980.146886045815;8980.236679882219;8874.866876996817;8889.199972002518;8934.910650893473;8936.41913275635;8939.374243802904;8726.607302671395;8803.119688031209;8828.42615230008;8829.293656507463;8839.204471597523;42342;42876.57123428757;42892.57107428917;42897.14205715868;42963.35554966678;3532.293541291752;3687.907802304937;3690.9630903690886;3708.332500149972;3813.694904407641;32574.674253257403;32730.345393092244;32945.835270823496;32971.340573188645;34238;4266.807993640294;4413.293872980308;4492.550744925514;4517.412736344287;4547.8635640930825;375987;377058;377550;377962;378707;52395.214071788956;61932;62510;63799.08602741832;63854.680726597;62624;63053.684731576046;63197;63258;63328.68335658292;16751.581210469834;16914.83085169157;16920.746188807178;16924;16929.238184281738;11686.065114790796;12751.744965100832;12919.741605168032;12924.353782311035;13107.344632768323;16975.490735277963;17029.48911532656;17044.573885652957;17050.573735656708;17102.315907363565;5826.941730582725;5871.178035075093;5896.204012458264;5918.970405147947;6027.60820546663;1032.5818043692316;1136.4261048170786;1149.8846119264301;1187.0859438232685;1199.4182821331647;32666.673333266837;33039;33266.16834579106;33293;33706.325873482885;1104.6078642081945;1188.0020782542533;1213.4842691855927;1224.9995044500258;1268.8731126887237;16736;17331.133443327784;17456.214470348867;17490.03804790749;17683.20425580852;511446;512324;516775;516878;518497;57322.42677573171;57640;57679;57687;57754.42245577575;1236.9505219791108;1358.456617353047;1380.3581334679423;1505.9774103388459;1597.448880136328;30309;34404.48393274153;34548.309033819685;34914.47628285527;35051.82474087715;50965.49034509608;52311.47688523066;52442.73778631083;52509;52516.73741631267;491446;491958;492098;492677;496942;38396.808015959745;43607.78196108999;43861;44063.77968110267;45025;48848.5115148844;49179.754101229264;49483.25775113448;50081.499185007684;50335.496645034546;40943.795281023406;41365.793171033954;41872.79063604662;42314.36528452014;42568.57431425646;41115.794421027706;41363.7931810339;41633.79183104186;42110.36834447547;42147.3677894838;41407.37888931729;42057.57942420537;42386.36420453634;42461.36307955445;42806;36119.27761444704;36804.81597592102;37468.81265593764;37916.24167516579;37986.62013379831;28405;28713.712862871103;28806.567901481914;28893.422131557672;28915.710842892142 05:29:13 INFO - PROCESS | 9517 | |2;jquery.html;390.6698839480638;392.068836513281;393.51990571502773;401.6004075944435;414.62269334905244;14103.294835258248;16940.745888811678;18076.63846723065;19716;19776.70334944977;15436.151011694352;17732.20205090771;18484.630307393843;18734.344297949574;19643.705344419846;5646.830595082154;5804.506616937565;5815.244018277639;5831.650100993933;5853.122031695238;4010.3984402339593;5799.333076696171;5846.327672317674;6113.419225173624;6438.871222575545;6416.03759436086;6451.129097571838;6460.806175814733;6470.838229044264;6477.514186436013;6280.277768056686;6392.968035159841;6430.839229019265;6467.482601391877;6473.223213214421;5491.643043202219;5617.269754931874;5624.465675760796;5643.209950606918;5646.6894320812335;22841.88579057111;23438.414039649146;23507.647385289234;23832.165874194492;23837.284881453583;2433.9391515212083;2510.6987161540733;2550.852116547561;2562.9487410251877;2909.5199292116777;13768.862311376859;13770.586882393543;14057.437702491889;14349.426022959069;14730.926345368205;1926.4317026477083;1933.9601622031082;1992.4421162074643;2010.0854111379288;2061.9278325258692;61984;81407;83392.16607833904;84060.57969710113;84180;10260;10334.328268662663;10534.315269507457;10863.130949524018;11040;14848.331825067899;14969.700605987819;14970.550883473514;14979.775303370458;14989.175595342143;8303.501789892625;8566.314694824523;8584.356173287028;8656.78358041054;8660.740177794676;6903.965480172567;8313.508326502882;8453.66185352579;8479.279261262862;8670.436421632574;6168.167297414881;6439.420452159235;6608.603483790988;6694.163229596301;6696.799096027127;1864.636395902786;1866.6826639471321;1874.8687591868438;1944.5041514414017;1957.5791204891016;921.1663444582664;1008.7125169326706;1021.2595867995792;1034.5706531789224;1076.9084627806724;19594.003529099988;20055.29806456767;20423;20441.693374599392;20470.488237794176;1001.3341128149699;1021.0555236406443;1081.2377274021796;1089.1939964426267;1099.395332567085;10571.841422378671;11642.88357116435;11674.824877626843;11697.649070527897;11711.76576468483;506308.4053739197;518280;530718;533171;534471;87694;90157.54921225483;90525.54737226272;90634;91437.54281228551;1043.0716662170673;1048.2452634103433;1069.6042464288264;1070.817960946641;1085.0560012788767;17675.292988280326;17794.822051779316;18029.188686508875;18209.635807284045;18495.352662656744;40190.19619607533;40601.375944961874;41398.1720365597;41967;42685.359719603606;54091.45908540864;55816.44183558112;56126;56948.430515694316;57102.143467848844;8532.50681130812;8761.080086590817;8784.516851573226;8879.778005549913;8987.157632685414;13283.667908301983;13320.733585328433;13491.32543372847;13875.583732487637;13883.583492495241;11691.240069395462;11720.238184517979;12013;12107.273563586214;12260.14179007461;11561;11704.063674905818;11726.179167458196;12066.457009434422;12265.26408415498;11879.762404751684;11905.583304584297;12086.879131208927;12245.571405000783;12436.564720234748;8547.102554231964;8582.871256931026;8582.957085214784;8683.82632347337;8808.339374546806;12011.939940300243;12057.914787669151;12134.817977730165;12146.696332591757;12221.083418743807 05:29:13 INFO - PROCESS | 9517 | |3;mootools.html;1322.004708646288;1543.9073655580662;1567.7099736548737;1710.5638062294113;1826.844718198953;8291.543965081926;8641.308695304377;8671.39300248982;8948.686795962143;8958.86561701575;8646.308295336374;8801.251893589037;8840.425372350808;8854.513001784899;8895.822083558342;2055.311470657324;2334.6264597664335;2338.4387746940697;2372.9644055339186;2393.9281821545296;2427.66012758214;2436.4883374491287;2443.389152711822;2446.070493212577;2446.192756390387;2308.7806658367426;2330.82518811089;2348.5420343033115;2349.823763217757;2351.0478256306137;2030.1270453704974;2266.705328307326;2308.4921317310163;2342.543204075206;2345.57779599672;2339.543788961153;2342.426105604138;2364.4443555764383;2367.3016460144127;2368.27767530903;8758.518281494515;8799.384043116985;8833.33749968755;8840.939087309564;8869.866951995726;5196.168613021936;5374.892502149935;5377.623566350357;5380.865478363033;5386.434424385422;3286.9835650821833;3440.415129428003;3481.9651803481893;3532.717382609385;3543.433050711874;1095.5179720922847;1150.3558007515817;1162.4129814443736;1170.461587669673;1194.2297218294239;12369;12377.381130943417;12395.318257495834;12413.131080824345;12415.503379864795;4567.634589232854;4691.507391723888;4748.287756836433;4749.833755818529;4774.618030557547;10367.896321036844;10395.84406233907;10406.843897341547;10417.062464378243;10421.322614030216;5372.62391632582;5375.247465354853;5380.91928621071;5383.650062745909;5394.649347792381;4289.914201715948;4840.661153719206;4985.651004429655;4990.950090499121;4996.775145118479;4028.456158418576;4063.6460428250302;4121.443605113332;4121.5466298707115;4274.337477690963;1267.3726505379896;1290.2323117744927;1293.2176033499786;1324.7549203397402;1332.3538084029237;836.3601844588894;906.5875026862761;936.4615346175976;940.0270719804969;955.2978560757838;5921.3190483094995;5952.583319167703;6058.303295121117;6134.447899689049;6381.010943303795;930.8039169666946;964.5322018820866;981.5533932061038;987.3779518903189;993.7068564773409;3972.6424621784176;4058.3100872851687;4068.4100805383055;4084.591540845892;4086.203190377907;10253.692389228187;10815.78368432627;10827.917208279108;10837;10852.457377131112;10420.895791042145;10617.89382106169;10696.411697356565;10703.678889633324;10911.672649820519;7938.603069846485;7993.560354180576;8025.5585942773705;8032.1164671886045;8048.879266811003;5678.574106942078;5720.914186287292;5820.417958204146;5824.301083869963;5897.3807750187325;9664.130228279488;9670.274729395183;9776.511174441108;9782.41305521671;9797.412155270707;9641.517924103908;9830.606775729177;9960.651377201762;10003.749906252402;10006.149477294512;6847.1098757163245;7192.856142877218;7387.1874093848555;7425.7029718810645;7524.774256772305;8789.604467798836;8830.249428798625;8844.557772111497;8883.111688831064;8936.374453788172;7739;7929.246721561442;8007.119216886022;8029.638666260149;8055.7583272501915;7484.70061197546;7510.924890751023;7600.42996775233;7709.267619576131;7944.245296696805;6810.625415601991;6963.6170010647875;6976.895346569907;6995.370416662525;6997.4052205561065;4864.343313652612;4997.350344455198;5172.7155006475;5184.870378240575;5219.686818790885;5125.92311115341;5131.3842338918075;5147.433782284021;5191.974040129775;5255.080360936897 05:29:13 INFO - PROCESS | 9517 | |4;prototype.html;319.4633016532228;327.24896362847267;332.0784822118621;335.1687814220731;335.65595264853516;5128.717920514379;5145.871353216172;5216.165413533835;5316.54809341206;5356.241535609155;5233.764480598373;5284.471552844713;5287.735613219343;5291.31212942318;5291.68249905006;4147.129102888397;4163.68772342074;4178.9999999999845;4185.644220241283;4208.558101399355;4072.1855628874346;4125.958740412602;4193.245215861144;4193.853215137471;4194.97902510487;4082.6937979651643;4090.877273681794;4110.97944510277;4129.359949207877;4139.56534563871;4114.835406583733;4129.587041295877;4135.793210339471;4139.3583994480905;4140.958590414118;3683.8710645127294;3689.1883785567134;3696.5398667526447;3713.832877520518;3724.2179142380132;4943.1957335572615;5035.697858128524;5059.406287019614;5097.8215762448135;5116.799776096277;4600.9769951150365;4680;4698.3689134085025;4711.740854253015;4740.834070807505;5421.783128674848;5423.403425623178;5433.701146436944;5465.644733092376;5468.9726551367385;3683.5395575553057;3899.2006638639295;3916.4908561886773;3937.7834219117935;3939.546952100488;5416.83749487516;5599.972000140014;5613.214150019001;5666.263385759866;5721.7711291548285;3839.886432934418;3893.279743247508;3912.7065470089856;3923.548791888912;4026.657734092635;3807.143392736612;4013.9598604013586;4032.850637568338;4054.722762329857;4062.857799976987;4514.164879497303;4545.340925565841;4565.840195593139;4589.2198326284615;4617.360836902918;5430.321209848769;5482.972585137049;5498.45015498447;5509.311336082989;5518.2826232590305;1370.7327071221016;1396.4763213794827;1404.5505438259863;1410.6951070259968;1416.1786164025048;892.906244844295;893.8257039877292;894.7449976756593;904.1320332480892;915.9725208243764;4718.976405117953;4737.620990320766;4763.666543341933;4779.259214821708;4801.567858892717;4753.738544380023;4988.750562471934;4993.625478089158;5045.344105266292;5047.369078865142;4692.225782745877;4740.265258884879;4755.262934245197;4786.473487916326;4806.615470762331;2648.4041090754813;2655.00437335999;2675.919722408331;2681.3832818451474;2682.8792704328353;4849.37838699396;5129.614729150962;5143.6656617320505;5179.689218646893;5193.610479214074;5047.974760126176;5065.594752419797;5094.898102037939;5096.337476128079;5147.9961407525925;5118.846434606968;5125.692458452505;5151.356080489939;5172.250023746611;5178.659764451907;4902.166631672553;5197.870053248699;5660.198201890091;5664.405237450009;5664.94093189673;5319.547838433622;5383.273258110105;5576.749046292845;5589.385167631476;5591.916121258266;5882.911661342494;5895.764169433346;5903.26209223847;5904.675242861684;5944.8811023780145;4118.423420721041;4153.792310384409;4154.854580089683;4161.459010328638;4166.520850102277;5436.782528698966;5583;5608.6073974821375;5622.493975542221;5685.971570142123;5484.451554844483;5487;5494.972525137348;5500.889982200253;5566.526845218202;5272.920906186334;5490.5882058844945;5514.408228132771;5542.725173210104;5569.693666848362;5456.645318054314;5458.5087342139395;5470.018839732275;5470.288862447856;5471.06991811401;5558.138488534284;5580.325902229396;5613.971930140323;5627.212190293444;5641.702408445998;5206.739663016759;5461.344638643388;5470.370907345706;5514.531264842533;5515.951969125853 05:29:13 INFO - PROCESS | 9517 | |5;yui.html;725.4522835259385;737.9483436159471;773.2885745114494;832.8042909916169;867.3148212911802;14611.707765844703;14848.703025939489;15282.235888205601;15328.15695136767;15382;14892.627684307898;15158.84841151588;15159.772603410958;15170.165640889747;15181.620459488518;681.5944513014748;690.0718533572337;690.4786885901137;802.2338666573409;815.8816971539123;691.2983321928222;801.4229754576695;817.1134319263606;817.8486979908736;829.050736906242;836.9623366948501;837.815680550278;838.0446291228005;838.1911455445494;839.7522730794431;704.7145905908116;828.511178404741;828.581566309013;829.5644786487112;830.5265998380926;606.2300877885106;619.8760247950428;619.9597026193283;625.7121724006962;626.0890404461497;14935.402583896632;15072.849271507253;15128.092314461168;15151.469698560497;15152.696946061016;13940.16359018452;14388.712225755426;14508.419663213459;14704.632384190374;14856.960012799109;12875.613731587973;13151.868481315256;13364.665883352896;13370.866291337059;13441.596752097355;4424.933625995613;4498.6211028206835;4558.418665451886;4610.9308360374625;4760.5001474844985;69489.65255173742;69506.30493695049;70127;70307.29692703059;70409.29590704078;11103.72240693989;11151.38667373286;11208;11262.436878156059;11476.31142131458;20364.185432582828;20389.592208155755;20421.387358378975;20421.48946276355;20435.182592696423;7772.742941931686;8336.541490218096;8394.580270986426;8447.957760211282;8509.702160424355;4557.886052848706;4668.229742092584;4692.1084993851055;4771.260454629538;4776.188048031773;3512.8594856205978;3636.2363903580545;3640.162762564625;3643.362411577963;3651.6165802590344;595.7944509144338;608.4189598933008;621.1397214857454;622.4802290087828;636.3096040795696;615.9137720719103;625.5277265664395;640.9712411579349;645.0227904724346;650.3431534150542;8930;9651.227901767841;9685.225181985425;9710.368826026426;9812;549.5521150262604;647.2233320015999;674.8751480975938;694.7116946467261;723.4465633790155;4411.867643970686;4548.272276435754;4550.613197878151;4562.840300589463;4582.450105987303;110724.4463777692;112710;113355;115968;116378.4181079106;98113;98694;99737.50131249297;99762;100097;86430;87941.99999999872;88001.55999219963;89215.10784892198;90042;8506.234438900528;8723.607437665447;8727.738167854974;8743.256823170103;9101.271898248257;51813.48186518087;51888;52454.73772631113;54161;54778.45221547734;73134.63432682803;75926.24073759191;77147;78974.21025789669;79401.60299198468;11111.444427778417;11114.555417783522;11214;11869.287842729464;12109.091818113853;12630.936845316082;12940.870591293966;13294.867051329364;13302.002349823608;13366.465341386236;11939.940300298791;12189.085818563466;12475.875241247835;12517.624471265877;12878.67803304925;11735.823962640396;11895.583654572049;11965.109194747585;12101.757964840477;12144.817827732415;11910.56668846978;12062.819057713965;12340.074494413135;12441.626751197478;12451.25292482454;9813.901860981585;9886.50567471609;9935.403875767477;10068.84896726535;10372.377657340583;9948.552315145691;10355.378677279386;10442.216833737348;10451.425171615634;10491.580336786443 05:29:13 INFO - PROCESS | 9517 | __end_tp_report 05:29:13 INFO - PROCESS | 9517 | __start_cc_report 05:29:13 INFO - PROCESS | 9517 | _x_x_mozilla_cycle_collect,1023 05:29:13 INFO - PROCESS | 9517 | __end_cc_report 05:29:13 INFO - PROCESS | 9517 | __startTimestamp1465216153749__endTimestamp 05:29:13 INFO - PROCESS | 9517 | 05:29:13 INFO - PROCESS | 9517 | ------- Summary: start ------- 05:29:13 INFO - PROCESS | 9517 | Number of tests: 6 05:29:13 INFO - PROCESS | 9517 | 05:29:13 INFO - PROCESS | 9517 | [#0] dojo.html Cycles:165 Average:5357.09 Median:5536.92 stddev:632.57 (11.4%) stddev-sans-first:609.94 05:29:13 INFO - PROCESS | 9517 | Values: 3131.5 3158.2 3186.3 3204.8 3218.4 5132.9 5191.6 5361.8 5419.5 5522.2 5382.3 5409.2 5433.3 5441.0 5501.3 4842.8 4858.4 4885.9 4917.9 5083.7 4978.1 5014.9 5020.4 5020.6 5053.7 4787.3 4804.5 4842.5 4843.5 4932.9 4799.6 4809.8 4812.7 4818.6 4875.7 4788.2 4805.6 4807.2 4818.7 4850.5 5080.7 5127.5 5263.1 5307.2 5328.6 5816.8 5844.9 5853.1 5869.2 5877.0 5833.4 5890.9 5892.8 5906.4 5917.9 5287.8 5369.2 5447.8 5453.8 5500.5 5995.3 5998.2 5999.7 6002.4 6036.7 5763.7 5803.6 5811.7 5813.9 5816.4 5553.3 5708.8 5752.0 5753.3 5803.5 5738.4 5750.6 5751.9 5761.4 5779.1 5551.8 5716.3 5762.3 5768.4 5778.6 4283.2 4300.1 4300.9 4310.5 4315.4 3872.4 3885.5 3886.9 3910.4 3912.6 5341.4 5408.4 5430.0 5479.1 5540.9 5698.5 5762.9 5771.9 5810.7 5827.0 5515.6 5524.4 5526.7 5527.6 5531.8 4732.2 4826.3 4830.5 4831.8 4868.5 6007.2 6102.1 6102.1 6127.7 6145.3 5873.0 5878.4 5879.9 5880.6 5910.1 5755.5 5960.4 5960.6 6093.1 6124.0 5733.3 5744.9 5747.0 5753.7 5795.0 5770.6 5795.9 5825.4 5825.6 5826.2 5546.1 5550.8 5565.9 5577.5 5661.4 5593.2 5593.2 5595.5 5598.1 5599.3 5468.1 5503.1 5511.4 5511.8 5573.4 5512.6 5555.0 5594.8 5608.5 5685.1 5466.8 5487.9 5491.0 5536.9 5543.2 05:29:13 INFO - PROCESS | 9517 | 05:29:13 INFO - PROCESS | 9517 | [#1] ext.html Cycles:180 Average:62820.25 Median:42894.86 stddev:123387.75 (287.7%) stddev-sans-first:123645.43 05:29:13 INFO - PROCESS | 9517 | Values: 594.8 620.3 634.4 645.2 648.2 33853.8 42964.4 43769.8 43833.1 47844.3 45052.1 45751.5 45863.5 45877.3 45909.3 8698.2 8819.8 8859.8 8886.6 8887.7 8738.1 8901.4 8902.2 8905.1 8907.7 8875.4 8955.9 8972.5 8980.1 8980.2 8874.9 8889.2 8934.9 8936.4 8939.4 8726.6 8803.1 8828.4 8829.3 8839.2 42342.0 42876.6 42892.6 42897.1 42963.4 3532.3 3687.9 3691.0 3708.3 3813.7 32574.7 32730.3 32945.8 32971.3 34238.0 4266.8 4413.3 4492.6 4517.4 4547.9 375987.0 377058.0 377550.0 377962.0 378707.0 52395.2 61932.0 62510.0 63799.1 63854.7 62624.0 63053.7 63197.0 63258.0 63328.7 16751.6 16914.8 16920.7 16924.0 16929.2 11686.1 12751.7 12919.7 12924.4 13107.3 16975.5 17029.5 17044.6 17050.6 17102.3 5826.9 5871.2 5896.2 5919.0 6027.6 1032.6 1136.4 1149.9 1187.1 1199.4 32666.7 33039.0 33266.2 33293.0 33706.3 1104.6 1188.0 1213.5 1225.0 1268.9 16736.0 17331.1 17456.2 17490.0 17683.2 511446.0 512324.0 516775.0 516878.0 518497.0 57322.4 57640.0 57679.0 57687.0 57754.4 1237.0 1358.5 1380.4 1506.0 1597.4 30309.0 34404.5 34548.3 34914.5 35051.8 50965.5 52311.5 52442.7 52509.0 52516.7 491446.0 491958.0 492098.0 492677.0 496942.0 38396.8 43607.8 43861.0 44063.8 45025.0 48848.5 49179.8 49483.3 50081.5 50335.5 40943.8 41365.8 41872.8 42314.4 42568.6 41115.8 41363.8 41633.8 42110.4 42147.4 41407.4 42057.6 42386.4 42461.4 42806.0 36119.3 36804.8 37468.8 37916.2 37986.6 28405.0 28713.7 28806.6 28893.4 28915.7 05:29:13 INFO - PROCESS | 9517 | 05:29:13 INFO - PROCESS | 9517 | [#2] jquery.html Cycles:180 Average:30052.33 Median:23473.03 stddev:86194.24 (367.2%) stddev-sans-first:86407.27 05:29:13 INFO - PROCESS | 9517 | Values: 390.7 392.1 393.5 401.6 414.6 14103.3 16940.7 18076.6 19716.0 19776.7 15436.2 17732.2 18484.6 18734.3 19643.7 5646.8 5804.5 5815.2 5831.7 5853.1 4010.4 5799.3 5846.3 6113.4 6438.9 6416.0 6451.1 6460.8 6470.8 6477.5 6280.3 6393.0 6430.8 6467.5 6473.2 5491.6 5617.3 5624.5 5643.2 5646.7 22841.9 23438.4 23507.6 23832.2 23837.3 2433.9 2510.7 2550.9 2562.9 2909.5 13768.9 13770.6 14057.4 14349.4 14730.9 1926.4 1934.0 1992.4 2010.1 2061.9 61984.0 81407.0 83392.2 84060.6 84180.0 10260.0 10334.3 10534.3 10863.1 11040.0 14848.3 14969.7 14970.6 14979.8 14989.2 8303.5 8566.3 8584.4 8656.8 8660.7 6904.0 8313.5 8453.7 8479.3 8670.4 6168.2 6439.4 6608.6 6694.2 6696.8 1864.6 1866.7 1874.9 1944.5 1957.6 921.2 1008.7 1021.3 1034.6 1076.9 19594.0 20055.3 20423.0 20441.7 20470.5 1001.3 1021.1 1081.2 1089.2 1099.4 10571.8 11642.9 11674.8 11697.6 11711.8 506308.4 518280.0 530718.0 533171.0 534471.0 87694.0 90157.5 90525.5 90634.0 91437.5 1043.1 1048.2 1069.6 1070.8 1085.1 17675.3 17794.8 18029.2 18209.6 18495.4 40190.2 40601.4 41398.2 41967.0 42685.4 54091.5 55816.4 56126.0 56948.4 57102.1 8532.5 8761.1 8784.5 8879.8 8987.2 13283.7 13320.7 13491.3 13875.6 13883.6 11691.2 11720.2 12013.0 12107.3 12260.1 11561.0 11704.1 11726.2 12066.5 12265.3 11879.8 11905.6 12086.9 12245.6 12436.6 8547.1 8582.9 8583.0 8683.8 8808.3 12011.9 12057.9 12134.8 12146.7 12221.1 05:29:13 INFO - PROCESS | 9517 | 05:29:13 INFO - PROCESS | 9517 | [#3] mootools.html Cycles:180 Average:5791.14 Median:5139.41 stddev:3254.27 (63.3%) stddev-sans-first:3246.07 05:29:13 INFO - PROCESS | 9517 | Values: 1322.0 1543.9 1567.7 1710.6 1826.8 8291.5 8641.3 8671.4 8948.7 8958.9 8646.3 8801.3 8840.4 8854.5 8895.8 2055.3 2334.6 2338.4 2373.0 2393.9 2427.7 2436.5 2443.4 2446.1 2446.2 2308.8 2330.8 2348.5 2349.8 2351.0 2030.1 2266.7 2308.5 2342.5 2345.6 2339.5 2342.4 2364.4 2367.3 2368.3 8758.5 8799.4 8833.3 8840.9 8869.9 5196.2 5374.9 5377.6 5380.9 5386.4 3287.0 3440.4 3482.0 3532.7 3543.4 1095.5 1150.4 1162.4 1170.5 1194.2 12369.0 12377.4 12395.3 12413.1 12415.5 4567.6 4691.5 4748.3 4749.8 4774.6 10367.9 10395.8 10406.8 10417.1 10421.3 5372.6 5375.2 5380.9 5383.7 5394.6 4289.9 4840.7 4985.7 4991.0 4996.8 4028.5 4063.6 4121.4 4121.5 4274.3 1267.4 1290.2 1293.2 1324.8 1332.4 836.4 906.6 936.5 940.0 955.3 5921.3 5952.6 6058.3 6134.4 6381.0 930.8 964.5 981.6 987.4 993.7 3972.6 4058.3 4068.4 4084.6 4086.2 10253.7 10815.8 10827.9 10837.0 10852.5 10420.9 10617.9 10696.4 10703.7 10911.7 7938.6 7993.6 8025.6 8032.1 8048.9 5678.6 5720.9 5820.4 5824.3 5897.4 9664.1 9670.3 9776.5 9782.4 9797.4 9641.5 9830.6 9960.7 10003.7 10006.1 6847.1 7192.9 7387.2 7425.7 7524.8 8789.6 8830.2 8844.6 8883.1 8936.4 7739.0 7929.2 8007.1 8029.6 8055.8 7484.7 7510.9 7600.4 7709.3 7944.2 6810.6 6963.6 6976.9 6995.4 6997.4 4864.3 4997.4 5172.7 5184.9 5219.7 5125.9 5131.4 5147.4 5192.0 5255.1 05:29:13 INFO - PROCESS | 9517 | 05:29:13 INFO - PROCESS | 9517 | [#4] prototype.html Cycles:180 Average:4516.03 Median:5062.50 stddev:1314.04 (26.0%) stddev-sans-first:1279.41 05:29:13 INFO - PROCESS | 9517 | Values: 319.5 327.2 332.1 335.2 335.7 5128.7 5145.9 5216.2 5316.5 5356.2 5233.8 5284.5 5287.7 5291.3 5291.7 4147.1 4163.7 4179.0 4185.6 4208.6 4072.2 4126.0 4193.2 4193.9 4195.0 4082.7 4090.9 4111.0 4129.4 4139.6 4114.8 4129.6 4135.8 4139.4 4141.0 3683.9 3689.2 3696.5 3713.8 3724.2 4943.2 5035.7 5059.4 5097.8 5116.8 4601.0 4680.0 4698.4 4711.7 4740.8 5421.8 5423.4 5433.7 5465.6 5469.0 3683.5 3899.2 3916.5 3937.8 3939.5 5416.8 5600.0 5613.2 5666.3 5721.8 3839.9 3893.3 3912.7 3923.5 4026.7 3807.1 4014.0 4032.9 4054.7 4062.9 4514.2 4545.3 4565.8 4589.2 4617.4 5430.3 5483.0 5498.5 5509.3 5518.3 1370.7 1396.5 1404.6 1410.7 1416.2 892.9 893.8 894.7 904.1 916.0 4719.0 4737.6 4763.7 4779.3 4801.6 4753.7 4988.8 4993.6 5045.3 5047.4 4692.2 4740.3 4755.3 4786.5 4806.6 2648.4 2655.0 2675.9 2681.4 2682.9 4849.4 5129.6 5143.7 5179.7 5193.6 5048.0 5065.6 5094.9 5096.3 5148.0 5118.8 5125.7 5151.4 5172.3 5178.7 4902.2 5197.9 5660.2 5664.4 5664.9 5319.5 5383.3 5576.7 5589.4 5591.9 5882.9 5895.8 5903.3 5904.7 5944.9 4118.4 4153.8 4154.9 4161.5 4166.5 5436.8 5583.0 5608.6 5622.5 5686.0 5484.5 5487.0 5495.0 5500.9 5566.5 5272.9 5490.6 5514.4 5542.7 5569.7 5456.6 5458.5 5470.0 5470.3 5471.1 5558.1 5580.3 5614.0 5627.2 5641.7 5206.7 5461.3 5470.4 5514.5 5516.0 05:29:13 INFO - PROCESS | 9517 | 05:29:13 INFO - PROCESS | 9517 | [#5] yui.html Cycles:180 Average:20501.67 Median:4773.72 stddev:29901.02 (626.4%) stddev-sans-first:29948.03 05:29:13 INFO - PROCESS | 9517 | Values: 725.5 737.9 773.3 832.8 867.3 14611.7 14848.7 15282.2 15328.2 15382.0 14892.6 15158.8 15159.8 15170.2 15181.6 681.6 690.1 690.5 802.2 815.9 691.3 801.4 817.1 817.8 829.1 837.0 837.8 838.0 838.2 839.8 704.7 828.5 828.6 829.6 830.5 606.2 619.9 620.0 625.7 626.1 14935.4 15072.8 15128.1 15151.5 15152.7 13940.2 14388.7 14508.4 14704.6 14857.0 12875.6 13151.9 13364.7 13370.9 13441.6 4424.9 4498.6 4558.4 4610.9 4760.5 69489.7 69506.3 70127.0 70307.3 70409.3 11103.7 11151.4 11208.0 11262.4 11476.3 20364.2 20389.6 20421.4 20421.5 20435.2 7772.7 8336.5 8394.6 8448.0 8509.7 4557.9 4668.2 4692.1 4771.3 4776.2 3512.9 3636.2 3640.2 3643.4 3651.6 595.8 608.4 621.1 622.5 636.3 615.9 625.5 641.0 645.0 650.3 8930.0 9651.2 9685.2 9710.4 9812.0 549.6 647.2 674.9 694.7 723.4 4411.9 4548.3 4550.6 4562.8 4582.5 110724.4 112710.0 113355.0 115968.0 116378.4 98113.0 98694.0 99737.5 99762.0 100097.0 86430.0 87942.0 88001.6 89215.1 90042.0 8506.2 8723.6 8727.7 8743.3 9101.3 51813.5 51888.0 52454.7 54161.0 54778.5 73134.6 75926.2 77147.0 78974.2 79401.6 11111.4 11114.6 11214.0 11869.3 12109.1 12630.9 12940.9 13294.9 13302.0 13366.5 11939.9 12189.1 12475.9 12517.6 12878.7 11735.8 11895.6 11965.1 12101.8 12144.8 11910.6 12062.8 12340.1 12441.6 12451.3 9813.9 9886.5 9935.4 10068.8 10372.4 9948.6 10355.4 10442.2 10451.4 10491.6 05:29:13 INFO - PROCESS | 9517 | -------- Summary: end -------- 05:29:13 INFO - PROCESS | 9517 | 05:29:14 INFO - TEST-INFO | 9517: exit 0 05:29:14 INFO - TEST-OK | dromaeo_css | took 1113384ms 05:29:14 INFO - TEST-START | kraken 05:29:14 INFO - operating with platform_type : linux_ 05:29:14 INFO - Initialising browser for kraken test... 05:29:14 INFO - TEST-INFO | started process 9701 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeHBiYT/profile http://localhost:44588/getInfo.html) 05:29:18 INFO - PROCESS | 9701 | __metrics Screen width/height:1600/1200 05:29:18 INFO - PROCESS | 9701 | colorDepth:24 05:29:18 INFO - PROCESS | 9701 | Browser inner width/height: 1024/697 05:29:18 INFO - PROCESS | 9701 | __metrics 05:29:19 ERROR - PROCESS | 9701 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:29:20 INFO - TEST-INFO | 9701: exit 0 05:29:20 INFO - Browser initialized. 05:29:20 INFO - Running cycle 1/1 for kraken test... 05:29:20 INFO - TEST-INFO | started process 9784 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeHBiYT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:29:32 INFO - PROCESS | 9784 | RSS: Main: 157368320 05:29:32 INFO - PROCESS | 9784 | 05:29:34 INFO - PROCESS | 9784 | Cycle 1(1): loaded http://localhost:44588/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44588/tests/kraken/driver.html?testName=audio-beat-detection) 05:29:35 INFO - PROCESS | 9784 | RSS: Main: 214999040 05:29:35 INFO - PROCESS | 9784 | 05:29:38 INFO - PROCESS | 9784 | Cycle 1(1): loaded http://localhost:44588/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44588/tests/kraken/driver.html?testName=audio-dft) 05:29:39 INFO - PROCESS | 9784 | RSS: Main: 201383936 05:29:39 INFO - PROCESS | 9784 | 05:29:42 INFO - PROCESS | 9784 | Cycle 1(1): loaded http://localhost:44588/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44588/tests/kraken/driver.html?testName=audio-fft) 05:29:42 INFO - PROCESS | 9784 | RSS: Main: 268763136 05:29:42 INFO - PROCESS | 9784 | 05:29:44 INFO - PROCESS | 9784 | Cycle 1(1): loaded http://localhost:44588/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44588/tests/kraken/driver.html?testName=audio-oscillator) 05:29:45 INFO - PROCESS | 9784 | RSS: Main: 179572736 05:29:45 INFO - PROCESS | 9784 | 05:29:47 INFO - PROCESS | 9784 | Cycle 1(1): loaded http://localhost:44588/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44588/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:29:48 INFO - PROCESS | 9784 | RSS: Main: 184209408 05:29:48 INFO - PROCESS | 9784 | 05:29:51 INFO - PROCESS | 9784 | Cycle 1(1): loaded http://localhost:44588/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44588/tests/kraken/driver.html?testName=imaging-darkroom) 05:29:51 INFO - PROCESS | 9784 | RSS: Main: 217964544 05:29:51 INFO - PROCESS | 9784 | 05:29:55 INFO - PROCESS | 9784 | Cycle 1(1): loaded http://localhost:44588/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44588/tests/kraken/driver.html?testName=imaging-desaturate) 05:29:55 INFO - PROCESS | 9784 | RSS: Main: 220266496 05:29:55 INFO - PROCESS | 9784 | 05:29:58 INFO - PROCESS | 9784 | Cycle 1(1): loaded http://localhost:44588/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44588/tests/kraken/driver.html?testName=json-parse-financial) 05:29:59 INFO - PROCESS | 9784 | RSS: Main: 220372992 05:29:59 INFO - PROCESS | 9784 | 05:30:00 INFO - PROCESS | 9784 | Cycle 1(1): loaded http://localhost:44588/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44588/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:30:01 INFO - PROCESS | 9784 | RSS: Main: 206364672 05:30:01 INFO - PROCESS | 9784 | 05:30:03 INFO - PROCESS | 9784 | Cycle 1(1): loaded http://localhost:44588/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44588/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:30:03 INFO - PROCESS | 9784 | RSS: Main: 209485824 05:30:03 INFO - PROCESS | 9784 | 05:30:05 INFO - PROCESS | 9784 | Cycle 1(1): loaded http://localhost:44588/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44588/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:30:06 INFO - PROCESS | 9784 | RSS: Main: 216928256 05:30:06 INFO - PROCESS | 9784 | 05:30:08 INFO - PROCESS | 9784 | Cycle 1(1): loaded http://localhost:44588/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44588/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:30:09 INFO - PROCESS | 9784 | RSS: Main: 224829440 05:30:09 INFO - PROCESS | 9784 | 05:30:12 INFO - PROCESS | 9784 | Cycle 1(1): loaded http://localhost:44588/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44588/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:30:12 INFO - PROCESS | 9784 | RSS: Main: 224858112 05:30:12 INFO - PROCESS | 9784 | 05:30:14 INFO - PROCESS | 9784 | Cycle 1(1): loaded http://localhost:44588/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44588/tests/kraken/driver.html?testName=ai-astar) 05:30:14 INFO - PROCESS | 9784 | RSS: Main: 267202560 05:30:14 INFO - PROCESS | 9784 | 05:30:14 INFO - PROCESS | 9784 | __start_tp_report 05:30:14 INFO - PROCESS | 9784 | _x_x_mozilla_page_load 05:30:14 INFO - PROCESS | 9784 | _x_x_mozilla_page_load_details 05:30:14 INFO - PROCESS | 9784 | |i|pagename|runs| 05:30:14 INFO - PROCESS | 9784 | |0;ai-astar;112;106;110;113;112;113;112;111;111;111 05:30:14 INFO - PROCESS | 9784 | |1;audio-beat-detection;159;125;127;178;126;139;152;141;182;124 05:30:14 INFO - PROCESS | 9784 | |2;audio-dft;160;162;160;161;161;160;162;160;161;162 05:30:14 INFO - PROCESS | 9784 | |3;audio-fft;74;74;76;122;74;76;75;75;97;75 05:30:14 INFO - PROCESS | 9784 | |4;audio-oscillator;84;84;110;84;84;84;130;84;85;120 05:30:14 INFO - PROCESS | 9784 | |5;imaging-gaussian-blur;116;117;116;117;117;117;117;116;117;117 05:30:14 INFO - PROCESS | 9784 | |6;imaging-darkroom;147;146;147;147;147;147;148;147;147;146 05:30:14 INFO - PROCESS | 9784 | |7;imaging-desaturate;95;95;95;95;94;96;95;94;95;95 05:30:14 INFO - PROCESS | 9784 | |8;json-parse-financial;54;53;54;53;52;53;54;53;53;54 05:30:14 INFO - PROCESS | 9784 | |9;json-stringify-tinderbox;63;62;61;61;62;61;61;62;61;61 05:30:14 INFO - PROCESS | 9784 | |10;stanford-crypto-aes;81;80;86;80;84;79;81;81;115;81 05:30:14 INFO - PROCESS | 9784 | |11;stanford-crypto-ccm;121;123;121;121;129;118;117;134;143;129 05:30:14 INFO - PROCESS | 9784 | |12;stanford-crypto-pbkdf2;159;159;162;158;157;161;163;164;161;160 05:30:14 INFO - PROCESS | 9784 | |13;stanford-crypto-sha256-iterative;64;63;63;63;63;62;62;65;62;63 05:30:14 INFO - PROCESS | 9784 | __end_tp_report 05:30:14 INFO - PROCESS | 9784 | __start_cc_report 05:30:14 INFO - PROCESS | 9784 | _x_x_mozilla_cycle_collect,1645 05:30:14 INFO - PROCESS | 9784 | __end_cc_report 05:30:14 INFO - PROCESS | 9784 | __startTimestamp1465216214729__endTimestamp 05:30:14 INFO - PROCESS | 9784 | 05:30:14 INFO - PROCESS | 9784 | ------- Summary: start ------- 05:30:14 INFO - PROCESS | 9784 | Number of tests: 14 05:30:14 INFO - PROCESS | 9784 | 05:30:14 INFO - PROCESS | 9784 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.00 stddev:2.02 (1.8%) stddev-sans-first:2.12 05:30:14 INFO - PROCESS | 9784 | Values: 112.0 106.0 110.0 113.0 112.0 113.0 112.0 111.0 111.0 111.0 05:30:14 INFO - PROCESS | 9784 | 05:30:14 INFO - PROCESS | 9784 | [#1] audio-beat-detection Cycles:10 Average:145.30 Median:146.50 stddev:21.81 (14.9%) stddev-sans-first:22.56 05:30:14 INFO - PROCESS | 9784 | Values: 159.0 125.0 127.0 178.0 126.0 139.0 152.0 141.0 182.0 124.0 05:30:14 INFO - PROCESS | 9784 | 05:30:14 INFO - PROCESS | 9784 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.88 (0.5%) stddev-sans-first:0.87 05:30:14 INFO - PROCESS | 9784 | Values: 160.0 162.0 160.0 161.0 161.0 160.0 162.0 160.0 161.0 162.0 05:30:14 INFO - PROCESS | 9784 | 05:30:14 INFO - PROCESS | 9784 | [#3] audio-fft Cycles:10 Average:81.80 Median:75.00 stddev:15.76 (21.0%) stddev-sans-first:16.46 05:30:14 INFO - PROCESS | 9784 | Values: 74.0 74.0 76.0 122.0 74.0 76.0 75.0 75.0 97.0 75.0 05:30:14 INFO - PROCESS | 9784 | 05:30:14 INFO - PROCESS | 9784 | [#4] audio-oscillator Cycles:10 Average:94.90 Median:84.00 stddev:17.95 (21.4%) stddev-sans-first:18.60 05:30:14 INFO - PROCESS | 9784 | Values: 84.0 84.0 110.0 84.0 84.0 84.0 130.0 84.0 85.0 120.0 05:30:14 INFO - PROCESS | 9784 | 05:30:14 INFO - PROCESS | 9784 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 05:30:14 INFO - PROCESS | 9784 | Values: 116.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 05:30:14 INFO - PROCESS | 9784 | 05:30:14 INFO - PROCESS | 9784 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 05:30:14 INFO - PROCESS | 9784 | Values: 147.0 146.0 147.0 147.0 147.0 147.0 148.0 147.0 147.0 146.0 05:30:14 INFO - PROCESS | 9784 | 05:30:14 INFO - PROCESS | 9784 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 05:30:14 INFO - PROCESS | 9784 | Values: 95.0 95.0 95.0 95.0 94.0 96.0 95.0 94.0 95.0 95.0 05:30:14 INFO - PROCESS | 9784 | 05:30:14 INFO - PROCESS | 9784 | [#8] json-parse-financial Cycles:10 Average:53.30 Median:53.50 stddev:0.67 (1.3%) stddev-sans-first:0.67 05:30:14 INFO - PROCESS | 9784 | Values: 54.0 53.0 54.0 53.0 52.0 53.0 54.0 53.0 53.0 54.0 05:30:14 INFO - PROCESS | 9784 | 05:30:14 INFO - PROCESS | 9784 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:61.50 stddev:0.71 (1.1%) stddev-sans-first:0.50 05:30:14 INFO - PROCESS | 9784 | Values: 63.0 62.0 61.0 61.0 62.0 61.0 61.0 62.0 61.0 61.0 05:30:14 INFO - PROCESS | 9784 | 05:30:14 INFO - PROCESS | 9784 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:81.00 stddev:10.81 (13.3%) stddev-sans-first:11.38 05:30:14 INFO - PROCESS | 9784 | Values: 81.0 80.0 86.0 80.0 84.0 79.0 81.0 81.0 115.0 81.0 05:30:14 INFO - PROCESS | 9784 | 05:30:14 INFO - PROCESS | 9784 | [#11] stanford-crypto-ccm Cycles:10 Average:125.60 Median:126.00 stddev:8.15 (6.5%) stddev-sans-first:8.48 05:30:14 INFO - PROCESS | 9784 | Values: 121.0 123.0 121.0 121.0 129.0 118.0 117.0 134.0 143.0 129.0 05:30:14 INFO - PROCESS | 9784 | 05:30:14 INFO - PROCESS | 9784 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.40 Median:161.00 stddev:2.22 (1.4%) stddev-sans-first:2.30 05:30:14 INFO - PROCESS | 9784 | Values: 159.0 159.0 162.0 158.0 157.0 161.0 163.0 164.0 161.0 160.0 05:30:14 INFO - PROCESS | 9784 | 05:30:14 INFO - PROCESS | 9784 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.00 stddev:0.94 (1.5%) stddev-sans-first:0.93 05:30:14 INFO - PROCESS | 9784 | Values: 64.0 63.0 63.0 63.0 63.0 62.0 62.0 65.0 62.0 63.0 05:30:14 INFO - PROCESS | 9784 | -------- Summary: end -------- 05:30:14 INFO - PROCESS | 9784 | 05:30:15 INFO - TEST-INFO | 9784: exit 0 05:30:15 INFO - TEST-OK | kraken | took 61281ms 05:30:15 INFO - SUITE-END | took 1174s 05:30:15 INFO - Completed test suite (00:19:34) 05:30:15 INFO - javascript benchmark 05:30:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3131.530270459431, 3158.2104473881514, 3186.2830863055815, 3204.8077115373094, 3218.388506183825, 5132.948670513294, 5191.558717509007, 5361.812336568221, 5419.512243898049, 5522.17167424886, 5382.300300960879, 5409.215663728757, 5433.26650902129, 5441.020616289066, 5501.257330260413, 4842.782074806633, 4858.368412106422, 4885.926711099336, 4917.926231106519, 5083.745812709368, 4978.103941290567, 5014.924776128361, 5020.3724534433195, 5020.648554601179, 5053.722045287508, 4787.257975013878, 4804.519548045202, 4842.515748425165, 4843.491433399495, 4932.926006109911, 4799.6400269979895, 4809.78355973982, 4812.663113582051, 4818.638602104857, 4875.731834749087, 4788.209945359012, 4805.567498925078, 4807.158747219222, 4818.662693611449, 4850.490698476645, 5080.74596270185, 5127.53852153308, 5263.105272103751, 5307.230451584537, 5328.600354973392, 5816.825495235107, 5844.941550584483, 5853.063509838448, 5869.236999190078, 5876.971529982279, 5833.445822646841, 5890.941090589082, 5892.793752218695, 5906.438888305647, 5917.852053698649, 5287.762050707727, 5369.221462887859, 5447.754851031674, 5453.836384908459, 5500.532454741352, 5995.340512543617, 5998.190244316961, 5999.670018149044, 6002.399760023963, 6036.6679832609625, 5763.740631671585, 5803.622764520293, 5811.651300921958, 5813.94186058134, 5816.418358164235, 5553.250311208016, 5708.80019199326, 5752.02215623345, 5753.252077230017, 5803.47768700819, 5738.397468265855, 5750.626209296466, 5751.8562035949435, 5761.39505351932, 5779.133130030529, 5551.833444996657, 5716.314042314949, 5762.30852297727, 5768.394318596571, 5778.566607504454, 4283.22901877665, 4300.053988122608, 4300.8709738707885, 4310.54739252374, 4315.395844581761, 3872.4191371294532, 3885.4560361549406, 3886.941695874564, 3910.3547914593773, 3912.6478616924046, 5341.439148889388, 5408.4050754416985, 5429.95014636392, 5479.0959491684225, 5540.889182216333, 5698.515626171822, 5762.855928601818, 5771.85570360736, 5810.738516766671, 5827.038538641077, 5515.586331025189, 5524.364698059774, 5526.668399896019, 5527.640703354269, 5531.806386776443, 4732.219183834698, 4826.300186472942, 4830.541098595628, 4831.758412079453, 4868.537488938545, 6007.219061521974, 6102.09542342839, 6102.095423428478, 6127.6782420562195, 6145.324014358506, 5872.970635146797, 5878.441548052928, 5879.882402351844, 5880.588358814842, 5910.143029260647, 5755.539556835527, 5960.433758792908, 5960.552958528041, 6093.116498107838, 6124.0, 5733.283339582552, 5744.885102297847, 5747.0, 5753.683547404933, 5795.0, 5770.6249093808765, 5795.913061304168, 5825.417458254141, 5825.621334613236, 5826.184334193301, 5546.057170281143, 5550.833474995757, 5565.916511252415, 5577.498025177753, 5661.377248502579, 5593.1889875966945, 5593.216949627137, 5595.468430499096, 5598.10430331145, 5599.272094627672, 5468.125099983983, 5503.064479038653, 5511.421300763523, 5511.751971161388, 5573.3869274380595, 5512.586556008235, 5555.0, 5594.804181853616, 5608.46719561641, 5685.147227915846, 5466.781328746805, 5487.862803429946, 5491.039068163135, 5536.916946245729, 5543.223948647112], "value": 5313.614972552756, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.8393933637915, 620.2990620598723, 634.419506151871, 645.1580687203198, 648.2318452633632, 33853.83073084634, 42964.355534667004, 43769.78115109424, 43833.12333753323, 47844.2823357649, 45052.09895802082, 45751.54248457515, 45863.541364586345, 45877.31184032242, 45909.31136032962, 8698.217160455557, 8819.77950551235, 8859.77850553738, 8886.60010299538, 8887.73336799897, 8738.126187381244, 8901.376903616749, 8902.243309318716, 8905.064968178345, 8907.688230911886, 8875.423097498675, 8955.910440895574, 8972.50651214183, 8980.146886045815, 8980.236679882219, 8874.866876996817, 8889.199972002518, 8934.910650893473, 8936.41913275635, 8939.374243802904, 8726.607302671395, 8803.119688031209, 8828.42615230008, 8829.293656507463, 8839.204471597523, 42342.0, 42876.57123428757, 42892.57107428917, 42897.14205715868, 42963.35554966678, 3532.293541291752, 3687.907802304937, 3690.9630903690886, 3708.332500149972, 3813.694904407641, 32574.674253257403, 32730.345393092244, 32945.835270823496, 32971.340573188645, 34238.0, 4266.807993640294, 4413.293872980308, 4492.550744925514, 4517.412736344287, 4547.8635640930825, 375987.0, 377058.0, 377550.0, 377962.0, 378707.0, 52395.214071788956, 61932.0, 62510.0, 63799.08602741832, 63854.680726597, 62624.0, 63053.684731576046, 63197.0, 63258.0, 63328.68335658292, 16751.581210469834, 16914.83085169157, 16920.746188807178, 16924.0, 16929.238184281738, 11686.065114790796, 12751.744965100832, 12919.741605168032, 12924.353782311035, 13107.344632768323, 16975.490735277963, 17029.48911532656, 17044.573885652957, 17050.573735656708, 17102.315907363565, 5826.941730582725, 5871.178035075093, 5896.204012458264, 5918.970405147947, 6027.60820546663, 1032.5818043692316, 1136.4261048170786, 1149.8846119264301, 1187.0859438232685, 1199.4182821331647, 32666.673333266837, 33039.0, 33266.16834579106, 33293.0, 33706.325873482885, 1104.6078642081945, 1188.0020782542533, 1213.4842691855927, 1224.9995044500258, 1268.8731126887237, 16736.0, 17331.133443327784, 17456.214470348867, 17490.03804790749, 17683.20425580852, 511446.0, 512324.0, 516775.0, 516878.0, 518497.0, 57322.42677573171, 57640.0, 57679.0, 57687.0, 57754.42245577575, 1236.9505219791108, 1358.456617353047, 1380.3581334679423, 1505.9774103388459, 1597.448880136328, 30309.0, 34404.48393274153, 34548.309033819685, 34914.47628285527, 35051.82474087715, 50965.49034509608, 52311.47688523066, 52442.73778631083, 52509.0, 52516.73741631267, 491446.0, 491958.0, 492098.0, 492677.0, 496942.0, 38396.808015959745, 43607.78196108999, 43861.0, 44063.77968110267, 45025.0, 48848.5115148844, 49179.754101229264, 49483.25775113448, 50081.499185007684, 50335.496645034546, 40943.795281023406, 41365.793171033954, 41872.79063604662, 42314.36528452014, 42568.57431425646, 41115.794421027706, 41363.7931810339, 41633.79183104186, 42110.36834447547, 42147.3677894838, 41407.37888931729, 42057.57942420537, 42386.36420453634, 42461.36307955445, 42806.0, 36119.27761444704, 36804.81597592102, 37468.81265593764, 37916.24167516579, 37986.62013379831, 28405.0, 28713.712862871103, 28806.567901481914, 28893.422131557672, 28915.710842892142], "value": 20699.531313091524, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.6698839480638, 392.068836513281, 393.51990571502773, 401.6004075944435, 414.62269334905244, 14103.294835258248, 16940.745888811678, 18076.63846723065, 19716.0, 19776.70334944977, 15436.151011694352, 17732.20205090771, 18484.630307393843, 18734.344297949574, 19643.705344419846, 5646.830595082154, 5804.506616937565, 5815.244018277639, 5831.650100993933, 5853.122031695238, 4010.3984402339593, 5799.333076696171, 5846.327672317674, 6113.419225173624, 6438.871222575545, 6416.03759436086, 6451.129097571838, 6460.806175814733, 6470.838229044264, 6477.514186436013, 6280.277768056686, 6392.968035159841, 6430.839229019265, 6467.482601391877, 6473.223213214421, 5491.643043202219, 5617.269754931874, 5624.465675760796, 5643.209950606918, 5646.6894320812335, 22841.88579057111, 23438.414039649146, 23507.647385289234, 23832.165874194492, 23837.284881453583, 2433.9391515212083, 2510.6987161540733, 2550.852116547561, 2562.9487410251877, 2909.5199292116777, 13768.862311376859, 13770.586882393543, 14057.437702491889, 14349.426022959069, 14730.926345368205, 1926.4317026477083, 1933.9601622031082, 1992.4421162074643, 2010.0854111379288, 2061.9278325258692, 61984.0, 81407.0, 83392.16607833904, 84060.57969710113, 84180.0, 10260.0, 10334.328268662663, 10534.315269507457, 10863.130949524018, 11040.0, 14848.331825067899, 14969.700605987819, 14970.550883473514, 14979.775303370458, 14989.175595342143, 8303.501789892625, 8566.314694824523, 8584.356173287028, 8656.78358041054, 8660.740177794676, 6903.965480172567, 8313.508326502882, 8453.66185352579, 8479.279261262862, 8670.436421632574, 6168.167297414881, 6439.420452159235, 6608.603483790988, 6694.163229596301, 6696.799096027127, 1864.636395902786, 1866.6826639471321, 1874.8687591868438, 1944.5041514414017, 1957.5791204891016, 921.1663444582664, 1008.7125169326706, 1021.2595867995792, 1034.5706531789224, 1076.9084627806724, 19594.003529099988, 20055.29806456767, 20423.0, 20441.693374599392, 20470.488237794176, 1001.3341128149699, 1021.0555236406443, 1081.2377274021796, 1089.1939964426267, 1099.395332567085, 10571.841422378671, 11642.88357116435, 11674.824877626843, 11697.649070527897, 11711.76576468483, 506308.4053739197, 518280.0, 530718.0, 533171.0, 534471.0, 87694.0, 90157.54921225483, 90525.54737226272, 90634.0, 91437.54281228551, 1043.0716662170673, 1048.2452634103433, 1069.6042464288264, 1070.817960946641, 1085.0560012788767, 17675.292988280326, 17794.822051779316, 18029.188686508875, 18209.635807284045, 18495.352662656744, 40190.19619607533, 40601.375944961874, 41398.1720365597, 41967.0, 42685.359719603606, 54091.45908540864, 55816.44183558112, 56126.0, 56948.430515694316, 57102.143467848844, 8532.50681130812, 8761.080086590817, 8784.516851573226, 8879.778005549913, 8987.157632685414, 13283.667908301983, 13320.733585328433, 13491.32543372847, 13875.583732487637, 13883.583492495241, 11691.240069395462, 11720.238184517979, 12013.0, 12107.273563586214, 12260.14179007461, 11561.0, 11704.063674905818, 11726.179167458196, 12066.457009434422, 12265.26408415498, 11879.762404751684, 11905.583304584297, 12086.879131208927, 12245.571405000783, 12436.564720234748, 8547.102554231964, 8582.871256931026, 8582.957085214784, 8683.82632347337, 8808.339374546806, 12011.939940300243, 12057.914787669151, 12134.817977730165, 12146.696332591757, 12221.083418743807], "value": 9563.966006415241, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1322.004708646288, 1543.9073655580662, 1567.7099736548737, 1710.5638062294113, 1826.844718198953, 8291.543965081926, 8641.308695304377, 8671.39300248982, 8948.686795962143, 8958.86561701575, 8646.308295336374, 8801.251893589037, 8840.425372350808, 8854.513001784899, 8895.822083558342, 2055.311470657324, 2334.6264597664335, 2338.4387746940697, 2372.9644055339186, 2393.9281821545296, 2427.66012758214, 2436.4883374491287, 2443.389152711822, 2446.070493212577, 2446.192756390387, 2308.7806658367426, 2330.82518811089, 2348.5420343033115, 2349.823763217757, 2351.0478256306137, 2030.1270453704974, 2266.705328307326, 2308.4921317310163, 2342.543204075206, 2345.57779599672, 2339.543788961153, 2342.426105604138, 2364.4443555764383, 2367.3016460144127, 2368.27767530903, 8758.518281494515, 8799.384043116985, 8833.33749968755, 8840.939087309564, 8869.866951995726, 5196.168613021936, 5374.892502149935, 5377.623566350357, 5380.865478363033, 5386.434424385422, 3286.9835650821833, 3440.415129428003, 3481.9651803481893, 3532.717382609385, 3543.433050711874, 1095.5179720922847, 1150.3558007515817, 1162.4129814443736, 1170.461587669673, 1194.2297218294239, 12369.0, 12377.381130943417, 12395.318257495834, 12413.131080824345, 12415.503379864795, 4567.634589232854, 4691.507391723888, 4748.287756836433, 4749.833755818529, 4774.618030557547, 10367.896321036844, 10395.84406233907, 10406.843897341547, 10417.062464378243, 10421.322614030216, 5372.62391632582, 5375.247465354853, 5380.91928621071, 5383.650062745909, 5394.649347792381, 4289.914201715948, 4840.661153719206, 4985.651004429655, 4990.950090499121, 4996.775145118479, 4028.456158418576, 4063.6460428250302, 4121.443605113332, 4121.5466298707115, 4274.337477690963, 1267.3726505379896, 1290.2323117744927, 1293.2176033499786, 1324.7549203397402, 1332.3538084029237, 836.3601844588894, 906.5875026862761, 936.4615346175976, 940.0270719804969, 955.2978560757838, 5921.3190483094995, 5952.583319167703, 6058.303295121117, 6134.447899689049, 6381.010943303795, 930.8039169666946, 964.5322018820866, 981.5533932061038, 987.3779518903189, 993.7068564773409, 3972.6424621784176, 4058.3100872851687, 4068.4100805383055, 4084.591540845892, 4086.203190377907, 10253.692389228187, 10815.78368432627, 10827.917208279108, 10837.0, 10852.457377131112, 10420.895791042145, 10617.89382106169, 10696.411697356565, 10703.678889633324, 10911.672649820519, 7938.603069846485, 7993.560354180576, 8025.5585942773705, 8032.1164671886045, 8048.879266811003, 5678.574106942078, 5720.914186287292, 5820.417958204146, 5824.301083869963, 5897.3807750187325, 9664.130228279488, 9670.274729395183, 9776.511174441108, 9782.41305521671, 9797.412155270707, 9641.517924103908, 9830.606775729177, 9960.651377201762, 10003.749906252402, 10006.149477294512, 6847.1098757163245, 7192.856142877218, 7387.1874093848555, 7425.7029718810645, 7524.774256772305, 8789.604467798836, 8830.249428798625, 8844.557772111497, 8883.111688831064, 8936.374453788172, 7739.0, 7929.246721561442, 8007.119216886022, 8029.638666260149, 8055.7583272501915, 7484.70061197546, 7510.924890751023, 7600.42996775233, 7709.267619576131, 7944.245296696805, 6810.625415601991, 6963.6170010647875, 6976.895346569907, 6995.370416662525, 6997.4052205561065, 4864.343313652612, 4997.350344455198, 5172.7155006475, 5184.870378240575, 5219.686818790885, 5125.92311115341, 5131.3842338918075, 5147.433782284021, 5191.974040129775, 5255.080360936897], "value": 4652.775259448969, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.4633016532228, 327.24896362847267, 332.0784822118621, 335.1687814220731, 335.65595264853516, 5128.717920514379, 5145.871353216172, 5216.165413533835, 5316.54809341206, 5356.241535609155, 5233.764480598373, 5284.471552844713, 5287.735613219343, 5291.31212942318, 5291.68249905006, 4147.129102888397, 4163.68772342074, 4178.9999999999845, 4185.644220241283, 4208.558101399355, 4072.1855628874346, 4125.958740412602, 4193.245215861144, 4193.853215137471, 4194.97902510487, 4082.6937979651643, 4090.877273681794, 4110.97944510277, 4129.359949207877, 4139.56534563871, 4114.835406583733, 4129.587041295877, 4135.793210339471, 4139.3583994480905, 4140.958590414118, 3683.8710645127294, 3689.1883785567134, 3696.5398667526447, 3713.832877520518, 3724.2179142380132, 4943.1957335572615, 5035.697858128524, 5059.406287019614, 5097.8215762448135, 5116.799776096277, 4600.9769951150365, 4680.0, 4698.3689134085025, 4711.740854253015, 4740.834070807505, 5421.783128674848, 5423.403425623178, 5433.701146436944, 5465.644733092376, 5468.9726551367385, 3683.5395575553057, 3899.2006638639295, 3916.4908561886773, 3937.7834219117935, 3939.546952100488, 5416.83749487516, 5599.972000140014, 5613.214150019001, 5666.263385759866, 5721.7711291548285, 3839.886432934418, 3893.279743247508, 3912.7065470089856, 3923.548791888912, 4026.657734092635, 3807.143392736612, 4013.9598604013586, 4032.850637568338, 4054.722762329857, 4062.857799976987, 4514.164879497303, 4545.340925565841, 4565.840195593139, 4589.2198326284615, 4617.360836902918, 5430.321209848769, 5482.972585137049, 5498.45015498447, 5509.311336082989, 5518.2826232590305, 1370.7327071221016, 1396.4763213794827, 1404.5505438259863, 1410.6951070259968, 1416.1786164025048, 892.906244844295, 893.8257039877292, 894.7449976756593, 904.1320332480892, 915.9725208243764, 4718.976405117953, 4737.620990320766, 4763.666543341933, 4779.259214821708, 4801.567858892717, 4753.738544380023, 4988.750562471934, 4993.625478089158, 5045.344105266292, 5047.369078865142, 4692.225782745877, 4740.265258884879, 4755.262934245197, 4786.473487916326, 4806.615470762331, 2648.4041090754813, 2655.00437335999, 2675.919722408331, 2681.3832818451474, 2682.8792704328353, 4849.37838699396, 5129.614729150962, 5143.6656617320505, 5179.689218646893, 5193.610479214074, 5047.974760126176, 5065.594752419797, 5094.898102037939, 5096.337476128079, 5147.9961407525925, 5118.846434606968, 5125.692458452505, 5151.356080489939, 5172.250023746611, 5178.659764451907, 4902.166631672553, 5197.870053248699, 5660.198201890091, 5664.405237450009, 5664.94093189673, 5319.547838433622, 5383.273258110105, 5576.749046292845, 5589.385167631476, 5591.916121258266, 5882.911661342494, 5895.764169433346, 5903.26209223847, 5904.675242861684, 5944.8811023780145, 4118.423420721041, 4153.792310384409, 4154.854580089683, 4161.459010328638, 4166.520850102277, 5436.782528698966, 5583.0, 5608.6073974821375, 5622.493975542221, 5685.971570142123, 5484.451554844483, 5487.0, 5494.972525137348, 5500.889982200253, 5566.526845218202, 5272.920906186334, 5490.5882058844945, 5514.408228132771, 5542.725173210104, 5569.693666848362, 5456.645318054314, 5458.5087342139395, 5470.018839732275, 5470.288862447856, 5471.06991811401, 5558.138488534284, 5580.325902229396, 5613.971930140323, 5627.212190293444, 5641.702408445998, 5206.739663016759, 5461.344638643388, 5470.370907345706, 5514.531264842533, 5515.951969125853], "value": 4098.355893174355, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.4522835259385, 737.9483436159471, 773.2885745114494, 832.8042909916169, 867.3148212911802, 14611.707765844703, 14848.703025939489, 15282.235888205601, 15328.15695136767, 15382.0, 14892.627684307898, 15158.84841151588, 15159.772603410958, 15170.165640889747, 15181.620459488518, 681.5944513014748, 690.0718533572337, 690.4786885901137, 802.2338666573409, 815.8816971539123, 691.2983321928222, 801.4229754576695, 817.1134319263606, 817.8486979908736, 829.050736906242, 836.9623366948501, 837.815680550278, 838.0446291228005, 838.1911455445494, 839.7522730794431, 704.7145905908116, 828.511178404741, 828.581566309013, 829.5644786487112, 830.5265998380926, 606.2300877885106, 619.8760247950428, 619.9597026193283, 625.7121724006962, 626.0890404461497, 14935.402583896632, 15072.849271507253, 15128.092314461168, 15151.469698560497, 15152.696946061016, 13940.16359018452, 14388.712225755426, 14508.419663213459, 14704.632384190374, 14856.960012799109, 12875.613731587973, 13151.868481315256, 13364.665883352896, 13370.866291337059, 13441.596752097355, 4424.933625995613, 4498.6211028206835, 4558.418665451886, 4610.9308360374625, 4760.5001474844985, 69489.65255173742, 69506.30493695049, 70127.0, 70307.29692703059, 70409.29590704078, 11103.72240693989, 11151.38667373286, 11208.0, 11262.436878156059, 11476.31142131458, 20364.185432582828, 20389.592208155755, 20421.387358378975, 20421.48946276355, 20435.182592696423, 7772.742941931686, 8336.541490218096, 8394.580270986426, 8447.957760211282, 8509.702160424355, 4557.886052848706, 4668.229742092584, 4692.1084993851055, 4771.260454629538, 4776.188048031773, 3512.8594856205978, 3636.2363903580545, 3640.162762564625, 3643.362411577963, 3651.6165802590344, 595.7944509144338, 608.4189598933008, 621.1397214857454, 622.4802290087828, 636.3096040795696, 615.9137720719103, 625.5277265664395, 640.9712411579349, 645.0227904724346, 650.3431534150542, 8930.0, 9651.227901767841, 9685.225181985425, 9710.368826026426, 9812.0, 549.5521150262604, 647.2233320015999, 674.8751480975938, 694.7116946467261, 723.4465633790155, 4411.867643970686, 4548.272276435754, 4550.613197878151, 4562.840300589463, 4582.450105987303, 110724.4463777692, 112710.0, 113355.0, 115968.0, 116378.4181079106, 98113.0, 98694.0, 99737.50131249297, 99762.0, 100097.0, 86430.0, 87941.99999999872, 88001.55999219963, 89215.10784892198, 90042.0, 8506.234438900528, 8723.607437665447, 8727.738167854974, 8743.256823170103, 9101.271898248257, 51813.48186518087, 51888.0, 52454.73772631113, 54161.0, 54778.45221547734, 73134.63432682803, 75926.24073759191, 77147.0, 78974.21025789669, 79401.60299198468, 11111.444427778417, 11114.555417783522, 11214.0, 11869.287842729464, 12109.091818113853, 12630.936845316082, 12940.870591293966, 13294.867051329364, 13302.002349823608, 13366.465341386236, 11939.940300298791, 12189.085818563466, 12475.875241247835, 12517.624471265877, 12878.67803304925, 11735.823962640396, 11895.583654572049, 11965.109194747585, 12101.757964840477, 12144.817827732415, 11910.56668846978, 12062.819057713965, 12340.074494413135, 12441.626751197478, 12451.25292482454, 9813.901860981585, 9886.50567471609, 9935.403875767477, 10068.84896726535, 10372.377657340583, 9948.552315145691, 10355.378677279386, 10442.216833737348, 10451.425171615634, 10491.580336786443], "value": 7343.378410486733, "unit": "score"}], "name": "dromaeo_css", "value": 7267.343899663195, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 110.0, 113.0, 112.0, 113.0, 112.0, 111.0, 111.0, 111.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 125.0, 127.0, 178.0, 126.0, 139.0, 152.0, 141.0, 182.0, 124.0], "value": 145.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 160.0, 161.0, 161.0, 160.0, 162.0, 160.0, 161.0, 162.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 122.0, 74.0, 76.0, 75.0, 75.0, 97.0, 75.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 110.0, 84.0, 84.0, 84.0, 130.0, 84.0, 85.0, 120.0], "value": 94.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 146.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 96.0, 95.0, 94.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 53.0, 52.0, 53.0, 54.0, 53.0, 53.0, 54.0], "value": 53.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 61.0, 61.0, 62.0, 61.0, 61.0, 62.0, 61.0, 61.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 86.0, 80.0, 84.0, 79.0, 81.0, 81.0, 115.0, 81.0], "value": 84.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 123.0, 121.0, 121.0, 129.0, 118.0, 117.0, 134.0, 143.0, 129.0], "value": 125.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 159.0, 162.0, 158.0, 157.0, 161.0, 163.0, 164.0, 161.0, 160.0], "value": 160.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 63.0, 63.0, 62.0, 62.0, 65.0, 62.0, 63.0], "value": 63.0, "unit": "score"}], "name": "kraken", "value": 1501.1, "alertThreshold": 2.0}]} 05:30:15 INFO - Return code: 0 05:30:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:30:16 ERROR - # TBPL SUCCESS # 05:30:16 INFO - Running post-action listener: _resource_record_post_action 05:30:16 INFO - ##### 05:30:16 INFO - ##### Finished run-tests step (success) 05:30:16 INFO - ##### 05:30:16 INFO - Running post-run listener: _resource_record_post_run 05:30:16 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 8192; Write bytes: 550948864; Read time: 148; Write time: 491468 05:30:16 INFO - TinderboxPrint: CPU usage
13.2% 05:30:16 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 148 05:30:16 INFO - TinderboxPrint: I/O write bytes / time
550,948,864 / 491,468 05:30:16 INFO - TinderboxPrint: CPU idle
8,264.2 (86.8%) 05:30:16 INFO - TinderboxPrint: CPU user
1,212.1 (12.7%) 05:30:16 INFO - TinderboxPrint: Swap in / out
0 / 0 05:30:16 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 225853440; Read time: 0; Write time: 241888 05:30:16 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 8192; Write bytes: 291262464; Read time: 148; Write time: 241472 05:30:16 INFO - Running post-run listener: _upload_blobber_files 05:30:16 INFO - Blob upload gear active. 05:30:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:30:16 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:30:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:30:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:30:17 INFO - (blobuploader) - INFO - Open directory for files ... 05:30:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:30:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:30:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:30:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:30:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:30:17 INFO - (blobuploader) - INFO - Done attempting. 05:30:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:30:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:30:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:30:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:30:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:30:21 INFO - (blobuploader) - INFO - Done attempting. 05:30:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:30:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:30:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:30:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:30:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:30:22 INFO - (blobuploader) - INFO - Done attempting. 05:30:22 INFO - (blobuploader) - INFO - Iteration through files over. 05:30:22 INFO - Return code: 0 05:30:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:30:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:30:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1dd0a8eaf0734e54d29cd742acb5d65838f6cb0a5128867f82a91c823b37b8a4e9e281e6ed54a5c2d06918f03b5a7fb668ba65041fe6104a72c9e80aa5abb777", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c4b3108de7af1f26e1308e37e60ac74ef578168c3153764a1347905b5f7ee2b1df4fad7b08e6271d96fc3a966dcd4d761b1669624ad1c8442f439ecea6726658", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fdfefcbe034cf2dd42b2da2ec95abb0d0e36f91bb05343d68c7980fbb5b016fda176351bd6912e8543216f0378fb06ef3bc2ecd5cd50ebba47e4ba5961f640e6"} 05:30:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:30:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:30:22 INFO - Contents: 05:30:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1dd0a8eaf0734e54d29cd742acb5d65838f6cb0a5128867f82a91c823b37b8a4e9e281e6ed54a5c2d06918f03b5a7fb668ba65041fe6104a72c9e80aa5abb777", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c4b3108de7af1f26e1308e37e60ac74ef578168c3153764a1347905b5f7ee2b1df4fad7b08e6271d96fc3a966dcd4d761b1669624ad1c8442f439ecea6726658", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fdfefcbe034cf2dd42b2da2ec95abb0d0e36f91bb05343d68c7980fbb5b016fda176351bd6912e8543216f0378fb06ef3bc2ecd5cd50ebba47e4ba5961f640e6"} 05:30:22 INFO - Running post-run listener: copy_logs_to_upload_dir 05:30:22 INFO - Copying logs to upload dir... 05:30:22 INFO - mkdir: /builds/slave/test/build/upload/logs 05:30:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.717198 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-06-06 05:30:21.207178) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 05:30:21.210853) ========= 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=920470bf432669ad7e3a5387000001ca-1465214641.383333-935213545 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/1dd0a8eaf0734e54d29cd742acb5d65838f6cb0a5128867f82a91c823b37b8a4e9e281e6ed54a5c2d06918f03b5a7fb668ba65041fe6104a72c9e80aa5abb777", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c4b3108de7af1f26e1308e37e60ac74ef578168c3153764a1347905b5f7ee2b1df4fad7b08e6271d96fc3a966dcd4d761b1669624ad1c8442f439ecea6726658", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fdfefcbe034cf2dd42b2da2ec95abb0d0e36f91bb05343d68c7980fbb5b016fda176351bd6912e8543216f0378fb06ef3bc2ecd5cd50ebba47e4ba5961f640e6"} build_url:https://queue.taskcluster.net/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011488 build_url: 'https://queue.taskcluster.net/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1dd0a8eaf0734e54d29cd742acb5d65838f6cb0a5128867f82a91c823b37b8a4e9e281e6ed54a5c2d06918f03b5a7fb668ba65041fe6104a72c9e80aa5abb777", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c4b3108de7af1f26e1308e37e60ac74ef578168c3153764a1347905b5f7ee2b1df4fad7b08e6271d96fc3a966dcd4d761b1669624ad1c8442f439ecea6726658", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fdfefcbe034cf2dd42b2da2ec95abb0d0e36f91bb05343d68c7980fbb5b016fda176351bd6912e8543216f0378fb06ef3bc2ecd5cd50ebba47e4ba5961f640e6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 05:30:21.237428) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:30:21.237766) ========= 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=920470bf432669ad7e3a5387000001ca-1465214641.383333-935213545 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004659 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:30:21.322803) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 05:30:21.323386) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 05:30:21.323909) ========= ========= Total master_lag: 0.31 =========