builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-034 starttime: 1465571698.09 results: success (0) buildid: 20160610064430 builduid: e80828f8848c482ab4eeac0a91f438a1 revision: acffab47253e0c19e586ed827470fec2819f7112 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 08:14:58.094442) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 08:14:58.094915) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 08:14:58.095205) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 08:14:58.110467) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 08:14:58.110792) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1465571697.524368-1478220865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-10 08:14:58-- 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% 19.1M=0.001s 2016-06-10 08:14:58 (19.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.089457 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 08:14:58.214166) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 08:14:58.214523) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1465571697.524368-1478220865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016231 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 08:14:58.265508) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-10 08:14:58.267266) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev acffab47253e0c19e586ed827470fec2819f7112 --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 acffab47253e0c19e586ed827470fec2819f7112 --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=d6bbd613908ccac0c6c9cb47000001f7-1465571697.524368-1478220865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-10 08:14:58,471 truncating revision to first 12 chars 2016-06-10 08:14:58,471 Setting DEBUG logging. 2016-06-10 08:14:58,471 attempt 1/10 2016-06-10 08:14:58,471 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/acffab47253e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-10 08:14:59,143 unpacking tar archive at: fx-team-acffab47253e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.012114 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-10 08:14:59.293844) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 08:14:59.294430) ========= script_repo_revision: acffab47253e0c19e586ed827470fec2819f7112 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 08:14:59.295109) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 08:14:59.295621) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 08:14:59.306869) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-10 08:14:59.307283) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=d6bbd613908ccac0c6c9cb47000001f7-1465571697.524368-1478220865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:14:59 INFO - MultiFileLogger online at 20160610 08:14:59 in /builds/slave/test 08:14:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 08:14:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:14:59 INFO - {'append_to_log': False, 08:14:59 INFO - 'base_work_dir': '/builds/slave/test', 08:14:59 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:14:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:14:59 INFO - 'branch': 'Fx-Team-Non-PGO', 08:14:59 INFO - 'buildbot_json_path': 'buildprops.json', 08:14:59 INFO - 'config_files': ('talos/linux_config.py',), 08:14:59 INFO - 'default_actions': ('clobber', 08:14:59 INFO - 'read-buildbot-config', 08:14:59 INFO - 'download-and-extract', 08:14:59 INFO - 'populate-webroot', 08:14:59 INFO - 'create-virtualenv', 08:14:59 INFO - 'install', 08:14:59 INFO - 'run-tests'), 08:14:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:14:59 INFO - 'download_minidump_stackwalk': True, 08:14:59 INFO - 'download_symbols': 'ondemand', 08:14:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:14:59 INFO - 'tooltool.py': '/tools/tooltool.py', 08:14:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:14:59 INFO - '/tools/misc-python/virtualenv.py')}, 08:14:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:14:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:14:59 INFO - 'installer_path': 'installer.exe', 08:14:59 INFO - 'log_level': 'info', 08:14:59 INFO - 'log_name': 'talos', 08:14:59 INFO - 'log_to_console': True, 08:14:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:14:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:14:59 INFO - 'opt_config_files': (), 08:14:59 INFO - 'pip_index': False, 08:14:59 INFO - 'sps_profile': False, 08:14:59 INFO - 'sps_profile_interval': 0, 08:14:59 INFO - 'suite': 'dromaeojs-e10s', 08:14:59 INFO - 'system_bits': '32', 08:14:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:14:59 INFO - 'title': 'talos-linux64-ix-034', 08:14:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:14:59 INFO - 'use_talos_json': True, 08:14:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:14:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:14:59 INFO - 'work_dir': 'build'} 08:14:59 INFO - ##### 08:14:59 INFO - ##### Running clobber step. 08:14:59 INFO - ##### 08:14:59 INFO - Running pre-action listener: _resource_record_pre_action 08:14:59 INFO - Running main action method: clobber 08:14:59 INFO - rmtree: /builds/slave/test/build 08:14:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:15:00 INFO - Running post-action listener: _resource_record_post_action 08:15:00 INFO - ##### 08:15:00 INFO - ##### Finished clobber step (success) 08:15:00 INFO - ##### 08:15:00 INFO - ##### 08:15:00 INFO - ##### Running read-buildbot-config step. 08:15:00 INFO - ##### 08:15:00 INFO - Running pre-action listener: _resource_record_pre_action 08:15:00 INFO - Running main action method: read_buildbot_config 08:15:00 INFO - Using buildbot properties: 08:15:00 INFO - { 08:15:00 INFO - "project": "", 08:15:00 INFO - "product": "firefox", 08:15:00 INFO - "script_repo_revision": "production", 08:15:00 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:15:00 INFO - "repository": "", 08:15:00 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 08:15:00 INFO - "buildid": "20160610064430", 08:15:00 INFO - "pgo_build": "False", 08:15:00 INFO - "basedir": "/builds/slave/test", 08:15:00 INFO - "buildnumber": 1402, 08:15:00 INFO - "slavename": "talos-linux64-ix-034", 08:15:00 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:15:00 INFO - "platform": "ubuntu64_hw", 08:15:00 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:15:00 INFO - "branch": "fx-team", 08:15:00 INFO - "repo_path": "integration/fx-team", 08:15:00 INFO - "revision": "acffab47253e0c19e586ed827470fec2819f7112", 08:15:00 INFO - "stage_platform": "linux64", 08:15:00 INFO - "builduid": "e80828f8848c482ab4eeac0a91f438a1", 08:15:00 INFO - "slavebuilddir": "test" 08:15:00 INFO - } 08:15:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/BTjEfDN6Q-iu06AUzf_8BQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:15:00 INFO - Running post-action listener: _resource_record_post_action 08:15:00 INFO - ##### 08:15:00 INFO - ##### Finished read-buildbot-config step (success) 08:15:00 INFO - ##### 08:15:00 INFO - ##### 08:15:00 INFO - ##### Running download-and-extract step. 08:15:00 INFO - ##### 08:15:00 INFO - Running pre-action listener: _resource_record_pre_action 08:15:00 INFO - Running main action method: download_and_extract 08:15:00 INFO - mkdir: /builds/slave/test/build/tests 08:15: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')]} 08:15:00 INFO - https://queue.taskcluster.net/v1/task/BTjEfDN6Q-iu06AUzf_8BQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:15:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BTjEfDN6Q-iu06AUzf_8BQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:15:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BTjEfDN6Q-iu06AUzf_8BQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:15:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BTjEfDN6Q-iu06AUzf_8BQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:15:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BTjEfDN6Q-iu06AUzf_8BQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:15:01 INFO - Downloaded 1361 bytes. 08:15:01 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:15:01 INFO - Using the following test package requirements: 08:15:01 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:15:01 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:15:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:15:01 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:15:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:15:01 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:15:01 INFO - u'jsshell-linux-x86_64.zip'], 08:15:01 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:15:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:15:01 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:15:01 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:15:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:15:01 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:15:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:15:01 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:15:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:15:01 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:15:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:15:01 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:15: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')]} 08:15:01 INFO - https://queue.taskcluster.net/v1/task/BTjEfDN6Q-iu06AUzf_8BQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:15:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BTjEfDN6Q-iu06AUzf_8BQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:15:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BTjEfDN6Q-iu06AUzf_8BQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:15:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BTjEfDN6Q-iu06AUzf_8BQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:15:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BTjEfDN6Q-iu06AUzf_8BQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:15:02 INFO - Downloaded 22891347 bytes. 08:15:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:15:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:15:03 INFO - Return code: 0 08:15:03 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:15: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')]} 08:15:03 INFO - https://queue.taskcluster.net/v1/task/BTjEfDN6Q-iu06AUzf_8BQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:15:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BTjEfDN6Q-iu06AUzf_8BQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:15:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BTjEfDN6Q-iu06AUzf_8BQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:15:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BTjEfDN6Q-iu06AUzf_8BQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:15:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BTjEfDN6Q-iu06AUzf_8BQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:15:04 INFO - Downloaded 22891347 bytes. 08:15:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:15:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:15:06 INFO - Return code: 0 08:15: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')]} 08:15:06 INFO - https://queue.taskcluster.net/v1/task/BTjEfDN6Q-iu06AUzf_8BQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:15:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BTjEfDN6Q-iu06AUzf_8BQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:15:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BTjEfDN6Q-iu06AUzf_8BQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:15:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BTjEfDN6Q-iu06AUzf_8BQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:15:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BTjEfDN6Q-iu06AUzf_8BQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:15:06 INFO - Downloaded 10833377 bytes. 08:15:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:15:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:15:07 INFO - Return code: 0 08:15:07 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')]} 08:15:07 INFO - https://queue.taskcluster.net/v1/task/BTjEfDN6Q-iu06AUzf_8BQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:15:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BTjEfDN6Q-iu06AUzf_8BQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:15:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BTjEfDN6Q-iu06AUzf_8BQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:15:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BTjEfDN6Q-iu06AUzf_8BQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:15:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BTjEfDN6Q-iu06AUzf_8BQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:15:08 INFO - Downloaded 55397283 bytes. 08:15:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BTjEfDN6Q-iu06AUzf_8BQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:15:08 INFO - mkdir: /builds/slave/test/properties 08:15:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:15:08 INFO - Writing to file /builds/slave/test/properties/build_url 08:15:08 INFO - Contents: 08:15:08 INFO - build_url:https://queue.taskcluster.net/v1/task/BTjEfDN6Q-iu06AUzf_8BQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:15:09 INFO - Running post-action listener: _resource_record_post_action 08:15:09 INFO - Running post-action listener: set_extra_try_arguments 08:15:09 INFO - ##### 08:15:09 INFO - ##### Finished download-and-extract step (success) 08:15:09 INFO - ##### 08:15:09 INFO - ##### 08:15:09 INFO - ##### Running populate-webroot step. 08:15:09 INFO - ##### 08:15:09 INFO - Running pre-action listener: _resource_record_pre_action 08:15:09 INFO - Running main action method: populate_webroot 08:15:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:15:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:15:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:15:09 INFO - '--tppagecycles', 08:15:09 INFO - '7'], 08:15:09 INFO - 'tests': ['tsvgm']}}, 08:15:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:15:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:15:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:15:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:15:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:15:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:15:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:15:09 INFO - 'talos_options': ['--disable-e10s'], 08:15:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:15:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:15:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:15:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:15:09 INFO - 'talos_options': ['--disable-e10s'], 08:15:09 INFO - 'tests': ['damp', 'tps']}, 08:15:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:15:09 INFO - 'tests': ['damp', 'tps']}, 08:15:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:15:09 INFO - 'tests': ['dromaeo_dom']}, 08:15:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:15:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:15:09 INFO - 'tests': ['a11yr', 08:15:09 INFO - 'ts_paint', 08:15:09 INFO - 'tpaint', 08:15:09 INFO - 'sessionrestore', 08:15:09 INFO - 'sessionrestore_no_auto_restore', 08:15:09 INFO - 'tabpaint']}, 08:15:09 INFO - 'other-e10s': {'tests': ['a11yr', 08:15:09 INFO - 'ts_paint', 08:15:09 INFO - 'tpaint', 08:15:09 INFO - 'sessionrestore', 08:15:09 INFO - 'sessionrestore_no_auto_restore', 08:15:09 INFO - 'tabpaint']}, 08:15:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:15:09 INFO - 'ts_paint', 08:15:09 INFO - 'tpaint', 08:15:09 INFO - 'sessionrestore', 08:15:09 INFO - 'sessionrestore_no_auto_restore', 08:15:09 INFO - 'tabpaint']}, 08:15:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:15:09 INFO - 'ts_paint', 08:15:09 INFO - 'tpaint', 08:15:09 INFO - 'sessionrestore', 08:15:09 INFO - 'sessionrestore_no_auto_restore', 08:15:09 INFO - 'tabpaint']}, 08:15:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:15:09 INFO - 'tests': ['a11yr', 08:15:09 INFO - 'ts_paint', 08:15:09 INFO - 'tpaint', 08:15:09 INFO - 'sessionrestore', 08:15:09 INFO - 'sessionrestore_no_auto_restore', 08:15:09 INFO - 'tabpaint']}, 08:15:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:15:09 INFO - 'tests': ['a11yr', 08:15:09 INFO - 'ts_paint', 08:15:09 INFO - 'tpaint', 08:15:09 INFO - 'sessionrestore', 08:15:09 INFO - 'sessionrestore_no_auto_restore', 08:15:09 INFO - 'tabpaint']}, 08:15:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:15:09 INFO - 'tests': ['tsvgx', 08:15:09 INFO - 'tsvgr_opacity', 08:15:09 INFO - 'tart', 08:15:09 INFO - 'tscrollx', 08:15:09 INFO - 'cart']}, 08:15:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:15:09 INFO - 'tsvgr_opacity', 08:15:09 INFO - 'tart', 08:15:09 INFO - 'tscrollx', 08:15:09 INFO - 'cart']}, 08:15:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:15:09 INFO - 'talos_options': ['--disable-e10s'], 08:15:09 INFO - 'tests': ['tp5o']}, 08:15:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:15:09 INFO - 'tests': ['tp5o']}, 08:15:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:15:09 INFO - 'talos_options': ['--disable-e10s', 08:15:09 INFO - '--xperf_path', 08:15:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:15:09 INFO - 'tests': ['tp5n']}, 08:15:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:15:09 INFO - 'talos_options': ['--xperf_path', 08:15:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:15:09 INFO - 'tests': ['tp5n']}}, 08:15:09 INFO - 'talos.zip': {'path': '', 08:15:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:15:09 INFO - Running post-action listener: _resource_record_post_action 08:15:09 INFO - ##### 08:15:09 INFO - ##### Finished populate-webroot step (success) 08:15:09 INFO - ##### 08:15:09 INFO - ##### 08:15:09 INFO - ##### Running create-virtualenv step. 08:15:09 INFO - ##### 08:15:09 INFO - Running pre-action listener: _resource_record_pre_action 08:15:09 INFO - Running main action method: create_virtualenv 08:15:09 INFO - Creating virtualenv /builds/slave/test/build/venv 08:15:09 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 08:15:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:15:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:15:09 INFO - Using real prefix '/usr' 08:15:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:15:10 INFO - Installing distribute.............................................................................................................................................................................................done. 08:15:11 INFO - Installing pip.................done. 08:15:11 INFO - Return code: 0 08:15:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:15:11 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')]} 08:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:11 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')]} 08:15:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:11 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 0x7f96e497af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1583350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16121c0>, '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 0x16130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1613550>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1465571697.524368-1478220865', '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 08:15:11 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 08:15:11 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 08:15:12 INFO - Using env: {'DISPLAY': ':0', 08:15:12 INFO - 'HOME': '/home/cltbld', 08:15:12 INFO - 'LANG': 'en_US.UTF-8', 08:15:12 INFO - 'LANGUAGE': 'en_US:en', 08:15:12 INFO - 'LOGNAME': 'cltbld', 08:15:12 INFO - 'MAIL': '/var/mail/cltbld', 08:15:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:12 INFO - 'MOZ_NO_REMOTE': '1', 08:15:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:12 INFO - 'NO_EM_RESTART': '1', 08:15:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:12 INFO - 'PWD': '/builds/slave/test', 08:15:12 INFO - 'SHELL': '/bin/bash', 08:15:12 INFO - 'SHLVL': '1', 08:15:12 INFO - 'TERM': 'linux', 08:15:12 INFO - 'TMOUT': '86400', 08:15:12 INFO - 'USER': 'cltbld', 08:15:12 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1465571697.524368-1478220865', 08:15:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:12 INFO - '_': '/tools/buildbot/bin/python'} 08:15:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:12 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 08:15:12 INFO - Cleaning up... 08:15:12 INFO - Return code: 0 08:15:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:15: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')]} 08:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15: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')]} 08:15:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:12 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 0x7f96e497af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1583350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16121c0>, '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 0x16130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1613550>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1465571697.524368-1478220865', '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 08:15:12 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 08:15:12 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 08:15:12 INFO - Using env: {'DISPLAY': ':0', 08:15:12 INFO - 'HOME': '/home/cltbld', 08:15:12 INFO - 'LANG': 'en_US.UTF-8', 08:15:12 INFO - 'LANGUAGE': 'en_US:en', 08:15:12 INFO - 'LOGNAME': 'cltbld', 08:15:12 INFO - 'MAIL': '/var/mail/cltbld', 08:15:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:12 INFO - 'MOZ_NO_REMOTE': '1', 08:15:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:12 INFO - 'NO_EM_RESTART': '1', 08:15:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:12 INFO - 'PWD': '/builds/slave/test', 08:15:12 INFO - 'SHELL': '/bin/bash', 08:15:12 INFO - 'SHLVL': '1', 08:15:12 INFO - 'TERM': 'linux', 08:15:12 INFO - 'TMOUT': '86400', 08:15:12 INFO - 'USER': 'cltbld', 08:15:12 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1465571697.524368-1478220865', 08:15:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:12 INFO - '_': '/tools/buildbot/bin/python'} 08:15:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:12 INFO - Downloading/unpacking psutil>=3.1.1 08:15:12 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 08:15:12 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 08:15:12 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 08:15:12 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 08:15:12 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 08:15:12 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 08:15:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:15:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:15:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:15:14 INFO - Installing collected packages: psutil 08:15:14 INFO - Running setup.py install for psutil 08:15:14 INFO - building 'psutil._psutil_linux' extension 08:15:14 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 08:15:14 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 08:15:14 INFO - building 'psutil._psutil_posix' extension 08:15:14 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 08:15:14 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 08:15:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:15:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:15:14 INFO - Successfully installed psutil 08:15:14 INFO - Cleaning up... 08:15:14 INFO - Return code: 0 08:15:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:15:14 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')]} 08:15:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:14 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')]} 08:15:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:14 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 0x7f96e497af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1583350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16121c0>, '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 0x16130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1613550>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1465571697.524368-1478220865', '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 08:15:14 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 08:15:14 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 08:15:14 INFO - Using env: {'DISPLAY': ':0', 08:15:14 INFO - 'HOME': '/home/cltbld', 08:15:14 INFO - 'LANG': 'en_US.UTF-8', 08:15:14 INFO - 'LANGUAGE': 'en_US:en', 08:15:14 INFO - 'LOGNAME': 'cltbld', 08:15:14 INFO - 'MAIL': '/var/mail/cltbld', 08:15:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:14 INFO - 'MOZ_NO_REMOTE': '1', 08:15:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:14 INFO - 'NO_EM_RESTART': '1', 08:15:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:14 INFO - 'PWD': '/builds/slave/test', 08:15:14 INFO - 'SHELL': '/bin/bash', 08:15:14 INFO - 'SHLVL': '1', 08:15:14 INFO - 'TERM': 'linux', 08:15:14 INFO - 'TMOUT': '86400', 08:15:14 INFO - 'USER': 'cltbld', 08:15:14 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1465571697.524368-1478220865', 08:15:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:14 INFO - '_': '/tools/buildbot/bin/python'} 08:15:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:15:15 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 08:15:15 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 08:15:15 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 08:15:15 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 08:15:15 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 08:15:15 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 08:15:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:15:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:15:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:15:17 INFO - Installing collected packages: mozsystemmonitor 08:15:17 INFO - Running setup.py install for mozsystemmonitor 08:15:17 INFO - Successfully installed mozsystemmonitor 08:15:17 INFO - Cleaning up... 08:15:17 INFO - Return code: 0 08:15:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:15:17 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')]} 08:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:17 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')]} 08:15:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:17 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 0x7f96e497af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1583350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16121c0>, '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 0x16130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1613550>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1465571697.524368-1478220865', '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 08:15:17 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 08:15:17 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 08:15:17 INFO - Using env: {'DISPLAY': ':0', 08:15:17 INFO - 'HOME': '/home/cltbld', 08:15:17 INFO - 'LANG': 'en_US.UTF-8', 08:15:17 INFO - 'LANGUAGE': 'en_US:en', 08:15:17 INFO - 'LOGNAME': 'cltbld', 08:15:17 INFO - 'MAIL': '/var/mail/cltbld', 08:15:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:17 INFO - 'MOZ_NO_REMOTE': '1', 08:15:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:17 INFO - 'NO_EM_RESTART': '1', 08:15:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:17 INFO - 'PWD': '/builds/slave/test', 08:15:17 INFO - 'SHELL': '/bin/bash', 08:15:17 INFO - 'SHLVL': '1', 08:15:17 INFO - 'TERM': 'linux', 08:15:17 INFO - 'TMOUT': '86400', 08:15:17 INFO - 'USER': 'cltbld', 08:15:17 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1465571697.524368-1478220865', 08:15:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:17 INFO - '_': '/tools/buildbot/bin/python'} 08:15:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:17 INFO - Downloading/unpacking jsonschema==2.5.1 08:15:17 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 08:15:17 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 08:15:17 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 08:15:17 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 08:15:17 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 08:15:17 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 08:15:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:15:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:15: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 08:15: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 08:15: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 08:15: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 08:15: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 08:15: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 08:15:19 INFO - Downloading functools32-3.2.3-2.tar.gz 08:15:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:15:19 INFO - warning: no files found matching '*.txt' 08:15:19 INFO - no previously-included directories found matching 'build' 08:15:19 INFO - no previously-included directories found matching 'dist' 08:15:19 INFO - no previously-included directories found matching '.git*' 08:15:19 INFO - Installing collected packages: jsonschema, functools32 08:15:19 INFO - Running setup.py install for functools32 08:15:19 INFO - warning: no files found matching '*.txt' 08:15:19 INFO - no previously-included directories found matching 'build' 08:15:19 INFO - no previously-included directories found matching 'dist' 08:15:19 INFO - no previously-included directories found matching '.git*' 08:15:19 INFO - Successfully installed jsonschema functools32 08:15:19 INFO - Cleaning up... 08:15:19 INFO - Return code: 0 08:15:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:15: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')]} 08:15:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15: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')]} 08:15:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15: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', '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 0x7f96e497af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1583350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16121c0>, '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 0x16130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1613550>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1465571697.524368-1478220865', '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 08:15: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:15: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 blobuploader==1.2.4 08:15:19 INFO - Using env: {'DISPLAY': ':0', 08:15:19 INFO - 'HOME': '/home/cltbld', 08:15:19 INFO - 'LANG': 'en_US.UTF-8', 08:15:19 INFO - 'LANGUAGE': 'en_US:en', 08:15:19 INFO - 'LOGNAME': 'cltbld', 08:15:19 INFO - 'MAIL': '/var/mail/cltbld', 08:15:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:19 INFO - 'MOZ_NO_REMOTE': '1', 08:15:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:19 INFO - 'NO_EM_RESTART': '1', 08:15:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:19 INFO - 'PWD': '/builds/slave/test', 08:15:19 INFO - 'SHELL': '/bin/bash', 08:15:19 INFO - 'SHLVL': '1', 08:15:19 INFO - 'TERM': 'linux', 08:15:19 INFO - 'TMOUT': '86400', 08:15:19 INFO - 'USER': 'cltbld', 08:15:19 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1465571697.524368-1478220865', 08:15:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:19 INFO - '_': '/tools/buildbot/bin/python'} 08:15:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:20 INFO - Downloading/unpacking blobuploader==1.2.4 08:15:20 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 08:15:20 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 08:15:20 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 08:15:20 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 08:15:20 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 08:15:20 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 08:15:21 INFO - Downloading blobuploader-1.2.4.tar.gz 08:15:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:15:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:15: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 08:15: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 08:15: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 08:15: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 08:15: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 08:15: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 08:15:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:15:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:15: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 08:15: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 08:15: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 08:15: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 08:15: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 08:15: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 08:15:22 INFO - Downloading docopt-0.6.1.tar.gz 08:15:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:15:22 INFO - Installing collected packages: blobuploader, requests, docopt 08:15:22 INFO - Running setup.py install for blobuploader 08:15:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:15:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:15:22 INFO - Running setup.py install for requests 08:15:23 INFO - Running setup.py install for docopt 08:15:23 INFO - Successfully installed blobuploader requests docopt 08:15:23 INFO - Cleaning up... 08:15:23 INFO - Return code: 0 08:15:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:15:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:15:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:15:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:23 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 0x7f96e497af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1583350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16121c0>, '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 0x16130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1613550>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1465571697.524368-1478220865', '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 08:15:23 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 08:15:23 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 08:15:23 INFO - Using env: {'DISPLAY': ':0', 08:15:23 INFO - 'HOME': '/home/cltbld', 08:15:23 INFO - 'LANG': 'en_US.UTF-8', 08:15:23 INFO - 'LANGUAGE': 'en_US:en', 08:15:23 INFO - 'LOGNAME': 'cltbld', 08:15:23 INFO - 'MAIL': '/var/mail/cltbld', 08:15:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:23 INFO - 'MOZ_NO_REMOTE': '1', 08:15:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:23 INFO - 'NO_EM_RESTART': '1', 08:15:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:23 INFO - 'PWD': '/builds/slave/test', 08:15:23 INFO - 'SHELL': '/bin/bash', 08:15:23 INFO - 'SHLVL': '1', 08:15:23 INFO - 'TERM': 'linux', 08:15:23 INFO - 'TMOUT': '86400', 08:15:23 INFO - 'USER': 'cltbld', 08:15:23 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1465571697.524368-1478220865', 08:15:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:23 INFO - '_': '/tools/buildbot/bin/python'} 08:15:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:15:23 INFO - Running setup.py (path:/tmp/pip-Sm1xZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:15:23 INFO - Running setup.py (path:/tmp/pip-fiNxN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:15:23 INFO - Running setup.py (path:/tmp/pip-iXyWKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:15:23 INFO - Running setup.py (path:/tmp/pip-q_hqqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:15:23 INFO - Running setup.py (path:/tmp/pip-JPmZnp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:15:23 INFO - Running setup.py (path:/tmp/pip-XjcQyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:15:23 INFO - Running setup.py (path:/tmp/pip-AukOZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:15:24 INFO - Running setup.py (path:/tmp/pip-bvVfWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:15:24 INFO - Running setup.py (path:/tmp/pip-yFbrfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:15:24 INFO - Running setup.py (path:/tmp/pip-8U0Uxs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:15:24 INFO - Running setup.py (path:/tmp/pip-M3gZab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:15:24 INFO - Running setup.py (path:/tmp/pip-506kb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:15:24 INFO - Running setup.py (path:/tmp/pip-0KoQS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:15:24 INFO - Running setup.py (path:/tmp/pip-CnPhoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:15:24 INFO - Running setup.py (path:/tmp/pip-CXRA5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:15:24 INFO - Running setup.py (path:/tmp/pip-whstgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:15:24 INFO - Running setup.py (path:/tmp/pip-8YnJrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:15:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:15:24 INFO - Running setup.py install for manifestparser 08:15:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:15:24 INFO - Running setup.py install for mozcrash 08:15:24 INFO - Running setup.py install for mozdebug 08:15:24 INFO - Running setup.py install for mozdevice 08:15:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:15:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:15:25 INFO - Running setup.py install for mozfile 08:15:25 INFO - Running setup.py install for mozhttpd 08:15:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:15:25 INFO - Running setup.py install for mozinfo 08:15:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:15:25 INFO - Running setup.py install for mozInstall 08:15:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:15:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:15:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:15:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:15:25 INFO - Running setup.py install for mozleak 08:15:25 INFO - Running setup.py install for mozlog 08:15:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:15:25 INFO - Running setup.py install for moznetwork 08:15:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:15:25 INFO - Running setup.py install for mozprocess 08:15:25 INFO - Running setup.py install for mozprofile 08:15:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:15:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:15:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:15:26 INFO - Running setup.py install for mozrunner 08:15:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:15:26 INFO - Running setup.py install for mozscreenshot 08:15:26 INFO - Running setup.py install for moztest 08:15:26 INFO - Running setup.py install for mozversion 08:15:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:15:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:15:26 INFO - Cleaning up... 08:15:26 INFO - Return code: 0 08:15:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:15:26 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')]} 08:15:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:26 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')]} 08:15:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:26 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 0x7f96e497af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1583350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16121c0>, '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 0x16130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1613550>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1465571697.524368-1478220865', '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 08:15:26 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 08:15:26 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 08:15:26 INFO - Using env: {'DISPLAY': ':0', 08:15:26 INFO - 'HOME': '/home/cltbld', 08:15:26 INFO - 'LANG': 'en_US.UTF-8', 08:15:26 INFO - 'LANGUAGE': 'en_US:en', 08:15:26 INFO - 'LOGNAME': 'cltbld', 08:15:26 INFO - 'MAIL': '/var/mail/cltbld', 08:15:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:26 INFO - 'MOZ_NO_REMOTE': '1', 08:15:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:26 INFO - 'NO_EM_RESTART': '1', 08:15:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:26 INFO - 'PWD': '/builds/slave/test', 08:15:26 INFO - 'SHELL': '/bin/bash', 08:15:26 INFO - 'SHLVL': '1', 08:15:26 INFO - 'TERM': 'linux', 08:15:26 INFO - 'TMOUT': '86400', 08:15:26 INFO - 'USER': 'cltbld', 08:15:26 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1465571697.524368-1478220865', 08:15:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:26 INFO - '_': '/tools/buildbot/bin/python'} 08:15:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:15:26 INFO - Running setup.py (path:/tmp/pip-8XMPRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:15:26 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)) 08:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:15:26 INFO - Running setup.py (path:/tmp/pip-EGS1zE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:15:26 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)) 08:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:15:26 INFO - Running setup.py (path:/tmp/pip-PBu3r9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:15:26 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)) 08:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:15:26 INFO - Running setup.py (path:/tmp/pip-Gix6XU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:15:27 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)) 08:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:15:27 INFO - Running setup.py (path:/tmp/pip-92hPDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:15:27 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)) 08:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:15:27 INFO - Running setup.py (path:/tmp/pip-NN3gMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:15:27 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)) 08:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:15:27 INFO - Running setup.py (path:/tmp/pip-3euuiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:15:27 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)) 08:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:15:27 INFO - Running setup.py (path:/tmp/pip-GNVBl6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:15:27 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)) 08:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:15:27 INFO - Running setup.py (path:/tmp/pip-SK2dLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:15:27 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)) 08:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:15:27 INFO - Running setup.py (path:/tmp/pip-LzjcGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:15:27 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)) 08:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:15:27 INFO - Running setup.py (path:/tmp/pip-vBxVjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:15:27 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)) 08:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:15:27 INFO - Running setup.py (path:/tmp/pip-iMa04i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:15:27 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)) 08:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:15:27 INFO - Running setup.py (path:/tmp/pip-YAoY2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:15:27 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)) 08:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:15:27 INFO - Running setup.py (path:/tmp/pip-0ruIvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:15:27 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)) 08:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:15:27 INFO - Running setup.py (path:/tmp/pip-1o_LaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:15:27 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)) 08:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:15:27 INFO - Running setup.py (path:/tmp/pip-ijx0c9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:15:27 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)) 08:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:15:27 INFO - Running setup.py (path:/tmp/pip-REEBPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:15:27 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)) 08:15:27 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)) 08:15:27 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)) 08:15:27 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)) 08:15:27 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)) 08:15:27 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)) 08:15:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:15:27 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 08:15:27 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 08:15:27 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 08:15:27 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 08:15:27 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 08:15:27 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 08:15:29 INFO - Downloading blessings-1.6.tar.gz 08:15:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:15:29 INFO - Installing collected packages: blessings 08:15:29 INFO - Running setup.py install for blessings 08:15:30 INFO - Successfully installed blessings 08:15:30 INFO - Cleaning up... 08:15:30 INFO - Return code: 0 08:15:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:15:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:15:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:15:30 INFO - Reading from file tmpfile_stdout 08:15:30 INFO - Current package versions: 08:15:30 INFO - argparse == 1.2.1 08:15:30 INFO - blessings == 1.6 08:15:30 INFO - blobuploader == 1.2.4 08:15:30 INFO - docopt == 0.6.1 08:15:30 INFO - functools32 == 3.2.3-2 08:15:30 INFO - jsonschema == 2.5.1 08:15:30 INFO - manifestparser == 1.1 08:15:30 INFO - mozInstall == 1.12 08:15:30 INFO - mozcrash == 0.17 08:15:30 INFO - mozdebug == 0.1 08:15:30 INFO - mozdevice == 0.48 08:15:30 INFO - mozfile == 1.2 08:15:30 INFO - mozhttpd == 0.7 08:15:30 INFO - mozinfo == 0.9 08:15:30 INFO - mozleak == 0.1 08:15:30 INFO - mozlog == 3.2 08:15:30 INFO - moznetwork == 0.27 08:15:30 INFO - mozprocess == 0.22 08:15:30 INFO - mozprofile == 0.28 08:15:30 INFO - mozrunner == 6.11 08:15:30 INFO - mozscreenshot == 0.1 08:15:30 INFO - mozsystemmonitor == 0.3 08:15:30 INFO - moztest == 0.7 08:15:30 INFO - mozversion == 1.4 08:15:30 INFO - psutil == 3.1.1 08:15:30 INFO - requests == 1.2.3 08:15:30 INFO - wsgiref == 0.1.2 08:15:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:15:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:15:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:15:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:30 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 0x7f96e497af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1583350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16121c0>, '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 0x16130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1613550>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1465571697.524368-1478220865', '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 08:15:30 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 08:15:30 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 08:15:30 INFO - Using env: {'DISPLAY': ':0', 08:15:30 INFO - 'HOME': '/home/cltbld', 08:15:30 INFO - 'LANG': 'en_US.UTF-8', 08:15:30 INFO - 'LANGUAGE': 'en_US:en', 08:15:30 INFO - 'LOGNAME': 'cltbld', 08:15:30 INFO - 'MAIL': '/var/mail/cltbld', 08:15:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:30 INFO - 'MOZ_NO_REMOTE': '1', 08:15:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:30 INFO - 'NO_EM_RESTART': '1', 08:15:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:30 INFO - 'PWD': '/builds/slave/test', 08:15:30 INFO - 'SHELL': '/bin/bash', 08:15:30 INFO - 'SHLVL': '1', 08:15:30 INFO - 'TERM': 'linux', 08:15:30 INFO - 'TMOUT': '86400', 08:15:30 INFO - 'USER': 'cltbld', 08:15:30 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1465571697.524368-1478220865', 08:15:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:30 INFO - '_': '/tools/buildbot/bin/python'} 08:15:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:30 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)) 08:15:30 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)) 08:15:30 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)) 08:15:30 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)) 08:15:30 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)) 08:15:30 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)) 08:15:30 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)) 08:15:30 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)) 08:15:30 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)) 08:15:30 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)) 08:15:30 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)) 08:15:30 INFO - Cleaning up... 08:15:30 INFO - Return code: 0 08:15:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:15:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:15:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:15:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:30 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 0x7f96e497af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1583350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16121c0>, '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 0x16130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1613550>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1465571697.524368-1478220865', '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 08:15:30 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 08:15:30 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 08:15:30 INFO - Using env: {'DISPLAY': ':0', 08:15:30 INFO - 'HOME': '/home/cltbld', 08:15:30 INFO - 'LANG': 'en_US.UTF-8', 08:15:30 INFO - 'LANGUAGE': 'en_US:en', 08:15:30 INFO - 'LOGNAME': 'cltbld', 08:15:30 INFO - 'MAIL': '/var/mail/cltbld', 08:15:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:30 INFO - 'MOZ_NO_REMOTE': '1', 08:15:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:30 INFO - 'NO_EM_RESTART': '1', 08:15:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:30 INFO - 'PWD': '/builds/slave/test', 08:15:30 INFO - 'SHELL': '/bin/bash', 08:15:30 INFO - 'SHLVL': '1', 08:15:30 INFO - 'TERM': 'linux', 08:15:30 INFO - 'TMOUT': '86400', 08:15:30 INFO - 'USER': 'cltbld', 08:15:30 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1465571697.524368-1478220865', 08:15:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:30 INFO - '_': '/tools/buildbot/bin/python'} 08:15:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:15:30 INFO - Cleaning up... 08:15:30 INFO - Return code: 0 08:15:30 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:15:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:15:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:15:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:30 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 0x7f96e497af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1583350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16121c0>, '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 0x16130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1613550>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1465571697.524368-1478220865', '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 08:15:30 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 08:15:30 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 08:15:30 INFO - Using env: {'DISPLAY': ':0', 08:15:30 INFO - 'HOME': '/home/cltbld', 08:15:30 INFO - 'LANG': 'en_US.UTF-8', 08:15:30 INFO - 'LANGUAGE': 'en_US:en', 08:15:30 INFO - 'LOGNAME': 'cltbld', 08:15:30 INFO - 'MAIL': '/var/mail/cltbld', 08:15:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:30 INFO - 'MOZ_NO_REMOTE': '1', 08:15:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:30 INFO - 'NO_EM_RESTART': '1', 08:15:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:30 INFO - 'PWD': '/builds/slave/test', 08:15:30 INFO - 'SHELL': '/bin/bash', 08:15:30 INFO - 'SHLVL': '1', 08:15:30 INFO - 'TERM': 'linux', 08:15:30 INFO - 'TMOUT': '86400', 08:15:30 INFO - 'USER': 'cltbld', 08:15:30 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1465571697.524368-1478220865', 08:15:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:30 INFO - '_': '/tools/buildbot/bin/python'} 08:15:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:31 INFO - Downloading/unpacking flake8 08:15:31 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 08:15:31 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 08:15:31 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 08:15:31 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 08:15:31 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 08:15:31 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 08:15:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:15:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:15:32 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 08:15:32 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 08:15:32 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 08:15:32 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 08:15:32 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 08:15:32 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 08:15:33 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:15:33 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:15:33 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 08:15:33 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 08:15:33 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 08:15:33 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 08:15:33 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 08:15:33 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 08:15:33 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:15:33 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 08:15:33 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 08:15:33 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 08:15:33 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 08:15:33 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 08:15:33 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 08:15:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:15:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:15:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:15:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:15:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:15:33 INFO - no previously-included directories found matching 'docs/_build' 08:15:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:15:33 INFO - Running setup.py install for pep8 08:15:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:15:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:15:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:15:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:15:33 INFO - no previously-included directories found matching 'docs/_build' 08:15:33 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:15:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:15:33 INFO - Cleaning up... 08:15:33 INFO - Return code: 0 08:15:33 INFO - Running post-action listener: _resource_record_post_action 08:15:33 INFO - Running post-action listener: _start_resource_monitoring 08:15:33 INFO - Starting resource monitoring. 08:15:33 INFO - ##### 08:15:33 INFO - ##### Finished create-virtualenv step (success) 08:15:33 INFO - ##### 08:15:33 INFO - ##### 08:15:33 INFO - ##### Running install step. 08:15:33 INFO - ##### 08:15:33 INFO - Running pre-action listener: _resource_record_pre_action 08:15:33 INFO - Running main action method: install 08:15:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:15:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:15:34 INFO - Reading from file tmpfile_stdout 08:15:34 INFO - Detecting whether we're running mozinstall >=1.0... 08:15:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:15:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:15:34 INFO - Reading from file tmpfile_stdout 08:15:34 INFO - Output received: 08:15:34 INFO - Usage: mozinstall [options] installer 08:15:34 INFO - Options: 08:15:34 INFO - -h, --help show this help message and exit 08:15:34 INFO - -d DEST, --destination=DEST 08:15:34 INFO - Directory to install application into. [default: 08:15:34 INFO - "/builds/slave/test"] 08:15:34 INFO - --app=APP Application being installed. [default: firefox] 08:15:34 INFO - mkdir: /builds/slave/test/build/application 08:15:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:15:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:15:50 INFO - Reading from file tmpfile_stdout 08:15:50 INFO - Output received: 08:15:50 INFO - /builds/slave/test/build/application/firefox/firefox 08:15:50 INFO - Running post-action listener: _resource_record_post_action 08:15:50 INFO - ##### 08:15:50 INFO - ##### Finished install step (success) 08:15:50 INFO - ##### 08:15:50 INFO - ##### 08:15:50 INFO - ##### Running run-tests step. 08:15:50 INFO - ##### 08:15:50 INFO - Running pre-action listener: _resource_record_pre_action 08:15:50 INFO - Running main action method: run_tests 08:15:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:15:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:15:50 INFO - Python 2.7.3 08:15:50 INFO - Return code: 0 08:15:50 INFO - grabbing minidump binary from tooltool 08:15:50 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')]} 08:15:50 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 0x16121c0>, '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 0x16130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1613550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:15:50 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 08:15:50 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 08:15:50 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 08:15:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:15:50 INFO - Return code: 0 08:15:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:15:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:15:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:15:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:15:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:15:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:15:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:15:51 INFO - Return code: 0 08:15:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BTjEfDN6Q-iu06AUzf_8BQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:15:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BTjEfDN6Q-iu06AUzf_8BQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:15:51 INFO - Using env: {'DISPLAY': ':0', 08:15:51 INFO - 'HOME': '/home/cltbld', 08:15:51 INFO - 'LANG': 'en_US.UTF-8', 08:15:51 INFO - 'LANGUAGE': 'en_US:en', 08:15:51 INFO - 'LOGNAME': 'cltbld', 08:15:51 INFO - 'MAIL': '/var/mail/cltbld', 08:15:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:15:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:15:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:51 INFO - 'MOZ_NO_REMOTE': '1', 08:15:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:15:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:51 INFO - 'NO_EM_RESTART': '1', 08:15:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:51 INFO - 'PWD': '/builds/slave/test', 08:15:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:15:51 INFO - 'SHELL': '/bin/bash', 08:15:51 INFO - 'SHLVL': '1', 08:15:51 INFO - 'TERM': 'linux', 08:15:51 INFO - 'TMOUT': '86400', 08:15:51 INFO - 'USER': 'cltbld', 08:15:51 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1465571697.524368-1478220865', 08:15:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:51 INFO - '_': '/tools/buildbot/bin/python'} 08:15:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BTjEfDN6Q-iu06AUzf_8BQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:15:51 INFO - mozversion application_buildid: 20160610064430 08:15:51 INFO - mozversion application_changeset: acffab47253e0c19e586ed827470fec2819f7112 08:15:51 INFO - mozversion application_display_name: Nightly 08:15:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:15:51 INFO - mozversion application_name: Firefox 08:15:51 INFO - mozversion application_remotingname: firefox 08:15:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:15:51 INFO - mozversion application_vendor: Mozilla 08:15:51 INFO - mozversion application_version: 50.0a1 08:15:51 INFO - mozversion platform_buildid: 20160610064430 08:15:51 INFO - mozversion platform_changeset: acffab47253e0c19e586ed827470fec2819f7112 08:15:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:15:51 INFO - mozversion platform_version: 50.0a1 08:15:51 INFO - using testdate: 1465571751 08:15:51 INFO - actual date: 1465571751 08:15:51 INFO - starting webserver on 'localhost:38081' 08:15:51 INFO - SUITE-START | Running 2 tests 08:15:51 INFO - TEST-START | dromaeo_css 08:15:51 INFO - operating with platform_type : linux_ 08:15:51 INFO - Initialising browser for dromaeo_css test... 08:15:51 INFO - TEST-INFO | started process 10956 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH40zK8/profile http://localhost:38081/getInfo.html) 08:15:56 INFO - PROCESS | 10956 | __metrics Screen width/height:1600/1200 08:15:56 INFO - PROCESS | 10956 | colorDepth:24 08:15:56 INFO - PROCESS | 10956 | Browser inner width/height: 1024/697 08:15:56 INFO - PROCESS | 10956 | __metrics 08:15:56 ERROR - PROCESS | 10956 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 08:15:57 INFO - TEST-INFO | 10956: exit 0 08:15:57 INFO - Browser initialized. 08:15:57 INFO - Running cycle 1/1 for dromaeo_css test... 08:15:57 INFO - TEST-INFO | started process 11073 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH40zK8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:16:09 INFO - PROCESS | 11073 | RSS: Main: 185389056 08:16:09 INFO - PROCESS | 11073 | 08:16:59 INFO - PROCESS | 11073 | 1465571819522 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] 08:19:11 INFO - PROCESS | 11073 | Cycle 1(1): loaded http://localhost:38081/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38081/tests/dromaeo/cssquery-ext.html) 08:19:13 INFO - PROCESS | 11073 | RSS: Main: 188252160 08:19:13 INFO - PROCESS | 11073 | 08:22:15 INFO - PROCESS | 11073 | Cycle 1(1): loaded http://localhost:38081/tests/dromaeo/cssquery-ext.html (next: http://localhost:38081/tests/dromaeo/cssquery-jquery.html) 08:22:15 INFO - PROCESS | 11073 | RSS: Main: 187670528 08:22:15 INFO - PROCESS | 11073 | 08:25:17 INFO - PROCESS | 11073 | Cycle 1(1): loaded http://localhost:38081/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38081/tests/dromaeo/cssquery-mootools.html) 08:25:18 INFO - PROCESS | 11073 | RSS: Main: 188764160 08:25:18 INFO - PROCESS | 11073 | 08:28:20 INFO - PROCESS | 11073 | Cycle 1(1): loaded http://localhost:38081/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38081/tests/dromaeo/cssquery-prototype.html) 08:28:20 INFO - PROCESS | 11073 | RSS: Main: 186281984 08:28:20 INFO - PROCESS | 11073 | 08:31:23 INFO - PROCESS | 11073 | Cycle 1(1): loaded http://localhost:38081/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38081/tests/dromaeo/cssquery-yui.html) 08:31:24 INFO - PROCESS | 11073 | RSS: Main: 188018688 08:31:24 INFO - PROCESS | 11073 | 08:34:26 INFO - PROCESS | 11073 | Cycle 1(1): loaded http://localhost:38081/tests/dromaeo/cssquery-yui.html (next: http://localhost:38081/tests/dromaeo/cssquery-dojo.html) 08:34:27 INFO - PROCESS | 11073 | RSS: Main: 189612032 08:34:27 INFO - PROCESS | 11073 | 08:34:27 INFO - PROCESS | 11073 | __start_tp_report 08:34:27 INFO - PROCESS | 11073 | _x_x_mozilla_page_load 08:34:27 INFO - PROCESS | 11073 | _x_x_mozilla_page_load_details 08:34:27 INFO - PROCESS | 11073 | |i|pagename|runs| 08:34:27 INFO - PROCESS | 11073 | |0;dojo.html;2614.281072705006;2640.1287575100214;2659.507991021661;2661.640678508401;2677.0228866463735;4702.24764037754;4706.717596944186;4779.283107533867;4867.756612169395;4911.386076740408;4690.085433340491;4714.5285471452835;4719.2685133804225;4839.830605928793;4864.805407783693;4316.84891028814;4392.143532011259;4440.444944381952;4456.621187199092;4457.264551349023;650.6574335972397;4267.701260911737;4327.264365057932;4329.350597410398;4369.519352871182;4351.325544540601;4358;4372.366006929009;4379.671524635665;4427.911441771179;4373.103513779667;4376.168527979674;4392.824287028515;4394.143142087294;4433.9113217735785;4353.216421044211;4359.651227901792;4394.231009573312;4417.226985277595;4434.401355816988;4822.541858523435;4841.878953026203;4846;4846.5880400166025;4855.927161092586;4979.1784355581285;5063.11395505785;5134.4095429025765;5147.613928955343;5165.328507294028;5126.307948426952;5145.6398052136365;5167.276581278624;5168.870778230536;5202.453742357074;4802.159622066124;4815.3499277597775;4815.903681926342;4816.590589799906;4878.634102442295;5208;5236.816711415082;5254;5260.184671375943;5272.130098533699;5035.571976382049;5046.848594542096;5052.9747351263;5055.545000949932;5105.055564720538;5086.847394578169;5131.076406246912;5141.948580514147;5143.6399452037995;5154.098032844237;4986.7257300848805;5049.823256186016;5069.8732531687;5090.10923088458;5096.974515127401;5045.646804723708;5050.898982020339;5059.342285502861;5078.365204349457;5117.232415137759;4206;4271.145770845843;4284.228838808982;4288.185244803477;4351.9564804352185;3663.6153203913736;3741.6819570336825;3766.5856755756845;3772.641599048086;3807.638274363931;4501.189785838515;4506.842260520866;4518.728876267434;4564.589186973122;4600.539946005372;5227;5241.816536421207;5246.344206974129;5247.370315562157;5264.078786212397;4346.7826608670075;4500.459944806644;4551.158035763395;4557.521460246627;4565.223911934912;4615.492295847454;4643.210654188796;4646.3727396801;4653.414450339119;4704.600108990706;4689.507601701772;4935.876603084952;4944.678595891256;4945.7527123644395;5002.499750024968;5171.560417364566;5218.930119325453;5235.633505654568;5236.842894713165;5252.238425428215;4889.364382630235;4933.925991110064;4937.432195297587;4951.702897826142;4976.776045077908;4924.532169443897;5041.773120209673;5144.511271429208;5190.455002224712;5197.8440646780655;5083.46623604531;5187.922181167361;5204.505571970657;5211.478852114758;5263.184206448007;5039.924401134059;5050.166722490895;5056.393232812086;5057.6459647824295;5106.4893510648635;4909.705417674951;4983.152864013199;5015.899682006412;5037.093323201859;5043.117454445384;4989.25161225819;4998.475160108136;5023.045621331935;5026.698398096126;5074.035933172685;5116.104681680766;5116.769745361542;5118.129917914038;5119.206522988943;5166.689998599945;4816.446108697404;4955.677880937727;4992.775325110451;4995.550400463831;5023.874403139805 08:34:27 INFO - PROCESS | 11073 | |1;ext.html;536.8034998813025;581.9301683797945;587.7237698281807;602.7829981206764;614.1218058176805;33832.4925126123;38216.23567528648;38233.61766382335;38254.04364890879;38259.42610860836;38248.42627360592;38598.035049123784;38703.41944870829;38721.61278387215;38803.41794873079;7664.92335076649;7774.922250777505;7786.883196752054;7791.415643826707;7818.100918394401;7611.923880761205;7753.689852405897;7764.650590723431;7777.572233527154;7799.88300175495;7723.189065148163;7752.2247775222595;7772.65023073963;7797.142314345418;7800.10298815635;7771.727989520368;7799.532028078305;7812.375009999187;7813.882791758128;7825.452218344718;7679.654415551314;7720.3051725344985;7759.806004849867;7760.805979850493;7770.145284018753;29450.410991780045;36612.450813237556;36933;36953;37152.071198219994;2914.664813546448;2934.7798915081453;3144.308252184516;3453.8445769940413;3673.5959044505084;27399.452010959867;30185.547216791765;30448.54327185094;30474.69525304741;30678.233044173852;3506.211102501942;3602.6757591816863;3614.168741189515;3627.274545090966;3630.7640003399692;253155;259492;259560.9999999981;259767;260413;56129;56976;57369.426305737245;57377.13934290989;57482.7125864368;34176.82911585476;35255;35258.647413525534;61051;61491.6925415379;15288.694226115414;15397.153156576496;15406.691866162613;15421.151836648867;15449.845501545065;9157.450552966844;9184.63261469547;9245.72262832116;9265.768355791159;9406.858897116548;19104.426867194008;19133.13900874464;19200.61598768017;19392.515187120152;19404.611907761766;7264.782056538313;7314.232005639331;7320.816979575447;7588.468807183444;7609.695612175562;819.8893149424871;821.9506829590243;922.8681745168682;1003.247564326755;1004.0812656419295;28143;28342;28382;28789.712102879123;28791.856040719664;923.4320892651106;944.9102335278137;949.7862980829397;963.2342287881152;1023.8771347438355;14763.409463621334;15060.246987650793;15186;15219.391224350902;15222.695546089017;383032;384008;386952;388701;389108;50025.24962125498;50627;50665.74667126641;50682;50711.49288507141;1146.7591805720724;1165.3241120150292;1169.1990986174499;1180.0854337888034;1182.1193211057816;26478.735212647625;27648.44703105967;27735.30661733473;28047.71952280451;28141.437171256868;39034.804825976826;39105.804470978605;39132.21735565216;39178.60821391863;39422.80288598539;326231;327217;328338;329269;330993;25755.484890302465;26006.73993260043;26057.869710651325;26246.21261362162;26401.735982639926;40549.39175912305;43199.56800431955;43732.78133609439;43850.561494384645;44137;36592.45111323279;36660.45009324809;36711.63288367082;37015;37201.10269881566;35953.82023089868;36376.81811590925;36545;36634;37107.257854843294;36085;36419.45370819493;36672;36988.26023479569;37041;32309.51535726919;32651.510227346134;33347;34161.48757768586;34590.48114278237;26056;26067.696615168785;26146.346341341618;26509.60235596506;26535.867320663274 08:34:27 INFO - PROCESS | 11073 | |2;jquery.html;369.20436459429936;380.83433706337735;380.8876381467467;389.561743039081;397.8309218582104;15729.921350393246;16112.35550577977;17037.91481042593;17071.975681459106;17081.658366832657;12885.806712899313;14894.47869324574;15701.685966280667;15784.0529568226;16277.430289939855;4595.333676616897;4733.219018861901;4794.808207671689;4796.760161991904;4807.495213002637;3508.386032444325;5185.896282074356;5476.780928762844;5495.917561236584;5569.66582005081;5464.808731694391;5531.3915469298345;5538.6399884007615;5541.418151094137;5555.527780138693;5367.194920761897;5483.506484416402;5507.173923911405;5537.778488860441;5546.223528705964;5260.894782104375;5275.815346462856;5308;5335.519803217729;5342.866428339284;12561.623151305475;13455.192688438725;19885.701714474293;20048.498787530283;20106.899465502724;1710.2645862279214;1850.8796928199624;1878.2674756844842;1939.1080103152567;2001.6196922584663;9554.665586704501;9639.469829159463;10808.675739727742;11424.42877856104;13390.330483475787;1653.5618061213788;1685.6460143369784;1727.4990252826665;1728.3173146607146;1797.5326415132029;65756;66379.33620663828;67544.32455675479;69596.6520167401;69820.6508967452;9912.851307230398;9998.500074996222;10028;10107.545160467796;10243.795124097476;13720.382582783599;13796.586102416944;13821.79267310991;13834.377453014638;13857.30713464343;7173.7130514779865;7243.782686519413;7334;7392.334689877936;7409.8147546311775;6864.828379290558;6878.174619045746;6895.75864844728;6984.4412447004115;6993.4055605274125;4255.97872010638;4262.360645903139;4303.505096913832;4304.20372231132;4306.310990241546;1721.9139043048049;1758.261530157337;1829.9085045747659;1837.9172937217857;1849.4359220437627;766.6358479722087;801.382935139939;833.6373677450207;839.5718183726343;863.2317237658489;15810.36758529669;15993.600159996093;16328.510144695678;16418.1790910454;16425.342986280415;858.9742307730778;877.0045997792552;878.9208971192623;883.1742320929823;903.1329923273731;8713.128687131237;9238.538073096319;9256.259499240045;9378.812423751624;9425.2931030173;392355;396030;396461;399780;400680;75510;78186.2181378179;78556.60721696354;78710.6064469674;79634;825.9752207433787;859.987100193485;877.2061284537504;879.9868001979976;886.5389997201419;14374.425022998963;14452.566423007327;14697.706045879237;14836.258187090387;15033.098014119189;32886;34114.829425853706;35167.64832351746;35705.46441803323;38420.231595367375;45362.546374535836;47439.102435902176;50787;52254.738726306125;52778.208326875894;7786.299233068825;8011.879821802561;8031.83936321282;8037.638306276114;8202.425830191829;6709.664516774239;10545.73451185832;11137.099676142472;11725.296482210753;12101.152919295917;10481.528331224961;10547.261691681508;10724.356538607708;10879.945600272265;10912.56349746033;7501.924980750123;10676.359418434608;10775.676729698122;10865.891341086804;10866.945665271624;6326.145970293951;8613.741587752378;10127.493625318852;10806.621768238074;11013.063889569476;6824.556403833735;7130.964345178449;7954.681812727657;8121.512709237465;8123.0658474276215;9715.805683886425;10125.290437005468;10193.184545236512;10404.635837745642;10516.526756295832 08:34:27 INFO - PROCESS | 11073 | |3;mootools.html;1232.0697873105803;1257.4844313831331;1342.8522862485124;1478.2017710436364;1480.6372438752508;6713.395794378505;7343.339099481045;7429.702811887525;7884.448088633798;7978.640961156747;7352.96323518383;7676.654550545225;7685.385169186466;7711.151773304946;7711.3059824615775;2178.9891050544725;2223.5775202711434;2229.320057382498;2237.407087121914;2240.316703405461;2187.1360812479143;2203.383052745226;2230.531588366445;2244.124791331374;2252.932412027642;2193.254293540196;2205.7132572765518;2212.4137103667463;2220.4670878989086;2220.4892874638845;2166.155199472207;2168.9566208675815;2175.9129634814667;2184.3446965910243;2200.1419446415753;2072.7409073865765;2078.8544801863877;2078.98960505198;2082.125507286943;2092.309537852505;7733.110692270405;7762.573058481781;7782.143964163937;7796.571188584626;7810.297073263377;4659.347691323217;4772.7136371817805;4780.80876764929;4818.855434336941;4827;2857.8571071446554;2874.798764086515;2996.9850150749107;3005;3012.021093144737;892.5046599137476;924.5931790012373;945.669015844449;946.0633972367375;949.7578117580042;10691.305065170816;10698.03717665414;10727.302725322907;10729.356238625707;10789.892101079045;4252.829886804493;4311.698181127291;4466.263066593976;4467.8212871484775;4474.597286244189;9135.908640913505;9148.405353651991;9162.450252984709;9182.403143795766;9184.954075229714;4710.4347478302825;4732.219183834629;4802.975985120052;4853.927191092136;4856.198727210041;3712.5173727415263;4185.225733239299;4294.055307832272;4300.677449191323;4313.6980411370905;3727.4408838674417;3727.813609319523;3743.419769935664;3839.7120215983914;3839.827207775657;1226.6994586326407;1250.5373011985623;1253.3419954523765;1256.7989121740477;1267.3726505379711;754.0988518720077;873.1094283830457;879.612970293069;886.4016788667624;903.214203642835;5269.341332333458;5499.175123731392;5508.476694713996;5524.724756524968;5559.054960656698;416.7539058215973;424.2999051564943;424.51181141687306;438.68853114289215;440.85231447464815;3790.8673196437994;3928.9017774555864;3986.2824691555797;4022.879313620596;4039.9798001010395;9401.57692903821;9551.952240238754;9587.089226523469;9593.568289426992;9602.279829012852;8951.149640784115;9263.814723705487;9297.95351023254;9391.530423478798;9522.523873806282;7112.786616401516;7171;7240.493165478366;7247.565146091251;7293.051903252649;5268.920966185434;5397.973010134924;5500.349895031554;5528.143137813485;5542.8337149885565;8602.91397086021;8952.23905968;8961.955190224007;8966.86549701742;9012.2339601132;8856.955715221382;8962.103789620985;9007.099290071203;9085.13691199335;9103.90896091057;6132.110843927695;6264.060390941395;6475.449586785176;6847.486438517031;6892.345227203407;7520.511166774142;7543.585102819397;7548.584827834522;7572.167061623327;7596.81007974805;6656.30108838565;6845.14435695538;6873.759418420332;6932.133483314586;6946.79159625212;6778.796636100925;6784.3894049535775;6828.317168283132;6843.931560684528;6890.483213759088;6110.175126357884;6125.785597504066;6184.474319682878;6187.226596675416;6190.721417536131;4492.595666390041;4543.159515489645;4545.454545454567;4593.127305811885;4653.837115700934;4407.405000324915;4542.909141817079;4659.65052621048;4674.953250467452;4782.378290822171 08:34:27 INFO - PROCESS | 11073 | |4;prototype.html;298.52683496657795;302.7063748164281;309.85281991054245;310.2553870710295;311.48604802076557;4807.591354734852;4921.769557610597;4974.726390048546;5010.471806099138;5019.347484826972;4967.850964471072;5020.723860187688;5025.221090730934;5025.648204625678;5026.145555255606;3910.4720862683457;3917.745346552465;3927.841286820395;3927.9803600981954;3947.5657677655436;3592.92814143717;3899.883003509899;3919.627635374635;3931.429942658313;3936.3308237599676;3793.412021136728;3804.885853424402;3807.1446415188607;3810.1617644118387;3819.197968426634;3821.541415030214;3828.272628200647;3833.926500579842;3834.4631751554666;3846.000039989623;3368.6968172864313;3405.6594340565994;3406.880759173417;3422.9315413691834;3427.3316703242876;4810.374651295344;4857.14999875024;4906.754662266872;4915.238138088602;4922.375616046732;4395.351743096339;4403.097365040159;4424.827420733508;4434.201843668138;4437.600615944581;5221.164613661834;5232.215167724872;5234.6335756497065;5238.397584277781;5246.291750613656;3631.382664946939;3692.2615476904725;3723.2739615774935;3729.5524537055726;3735.589085200626;5382.219578161144;5426.430224826416;5439.782408703647;5447.918281225785;5449.427810079964;3787.5833658297565;3800.9619903801163;3804.3722785740597;3810.3522401191863;3812.275667623143;3844.308024555607;3857.7685338879755;3857.996920800612;3860.2665493556133;3866.149447121629;4294.699371044059;4358.782060896942;4362.498312694081;4403;4414.713043652152;5146.305248791366;5155.355580552431;5165.509276618715;5177.4822517747925;5183.429822719498;1231.4422255846362;1297.8572357040719;1331.2811082015796;1336.1315145155727;1337.5786627212592;839.3788596438592;841.9158084191654;844.273924424994;860.2601762484259;861.9008813986346;4187.623113919762;4231.709328654728;4245.047278251977;4254.319308910622;4261.403403523509;4746.264329029006;4753.741972563005;4777.211760059621;4793.760311984387;4811.013742182844;4157.251694694984;4165.500139983222;4187.780476347541;4216.578342165759;4234.407182994383;2461.360046387916;2542.300867261518;2582.8248147093027;2593.6368908352847;2595.9610605840926;4491.595756381941;4513.323001549794;4536.523665015192;4544.818207271738;4559.81129058054;4840.54014868594;4882.975585122052;4933.901321973541;4938.234573641092;4945.67853089548;4372.366006929041;4395.384646149541;4432.645388368858;4482.887927801766;4507.887302817456;4718.009218064108;4722.268048452495;4723.055388922298;4724.480307166277;4770.475247722818;4654.48800631937;4709.7174169549935;4728.834490792806;4736.455307639666;4754.952450475589;4403.427554417905;4515.68390212682;4528.98822283178;4534.841280555164;4592.117231934891;3483.425234836224;3490.3891818932093;3505.596856361551;3524.7532672712664;3531.710925512118;4734.928976065293;4742.952570474251;4768.974670445871;4770.809167633256;5147.352847089045;5089.694618322913;5143.331366922276;5254.189008880231;5258.763355648928;5265.21021846726;5188.429272780067;5231.450697676689;5231.895362092813;5243.61044323247;5246.868828279324;4876.21980483121;5117.692938423706;5139.4603566626465;5166.664166829144;5178.533931946143;5304.840854774363;5323.973380133075;5325.121354976541;5326.9200961984825;5348.679079255257;5176.818811341585;5226;5226.529612334908;5229.6339256251695;5240.449752775904 08:34:27 INFO - PROCESS | 11073 | |5;yui.html;590.291650019976;607.8845019446302;617.1329282358287;657.0768070860443;742.9042162809852;10335.948320258407;12305.69235769105;12837.743245135092;12837.807432888514;13427.194368337881;13867.445302187925;14409.495667651609;14477.420903163887;14494.710105797878;14590.124592524457;763.2100775697155;775.1047540091204;784.1178673991759;785.8271180340345;787.1734678587488;779.8362343907786;783.7178615698344;783.9176886426928;787.0633945604741;789.8143936174994;825.4015838517087;826.1119296755982;827.5117680568463;829.4318391901537;830.9376796740269;812.175641723651;819.0703551469065;821.5686764448652;823.0329362998483;823.4071468542639;577.711144427786;587.9441453061952;592.6532978207754;594.8334466349386;597.9133025711247;13132.146410483383;13169.078164528486;13169.604911852659;13184.934075329658;13212.537561185312;12725.61823145307;13282.60152195426;13558.254296013716;13653.317334133253;13826.654333641638;10296.742581435448;10436.425996570186;10500.78998420035;10526.78946421075;10571.260011799177;3393.8642454302044;3435.089701229176;3442.569678790151;3446.4313388290902;3456.4296891013205;54802.45197548014;55110;55222.723886380714;56852.43147568554;57025.1446228311;10142.44216568081;10261.333013354108;10269.3569028955;10409.479526023668;10594.629187978384;17472.73790893112;18715.344962926232;18754.24983000692;18818.247270109317;18898.244070237313;7082.220955694973;7107.964460177666;7182.066331376887;7337.88993165103;7369.410447164214;3789.696824254053;3863.903402414906;3868.4025649840833;3904.1801221743185;4007.5591684914634;3031.621047369079;3139.8116113033293;3141.937161256762;3151.732102771244;3153.3377990621766;520.0431206579912;522.8117877564074;523.0297797585424;530.9442508536625;549.209138840069;476.76638447160644;542.2462776740334;547.3322546493272;562.8480310316191;580.0689892722205;7673.462857600026;7920.564368959763;8020.508336479814;8105.148959359182;8161.877571836427;542.3085565903505;549.3517649174013;598.5032423088826;606.5110154570518;612.9754809807557;3691.187938653492;3768.8968717257567;3948.407738839197;3987.102901847119;4079.4084857695466;85181.57409213038;90308;91739.79996112778;92990;93677;51308.74345628248;63193.684031580466;65035;78276.60861695655;80985.89437274463;70578.64710676414;74382.25617743861;74670.25329746633;74845.25154748492;75689.621551893;7248.782536523912;7538.924610753822;7550.35821955118;7573.659185336784;7767.184445633127;41085.38371924364;43866;44361.44734934262;44601.55398445974;45316;54157;61265.387346125965;61282.38717612945;61693.691531542056;62262.37737622566;9648.469334186406;9720.805583888141;9929.3545919515;9994.050565196294;10067.395956242648;11473.942630286796;11486.13853960973;11514.136439767219;11652.708682282671;11785;9771.31600787938;9870.111689947651;10066.496675166067;10067.798644026932;10762.3542587445;11259.718507037061;11558.248713833575;12492.562760303346;12700.618981430573;12849.293288869201;10318.48407579633;10436.582536698446;10480.947595261974;10570.524326405177;10976.121910247002;9630;9815.558299876666;10020.24848136378;10219.948900255451;10222.233332499944;9498.762530936781;9533.570989305637;9627.9037209627;9720.409972409523;9824.582410345516 08:34:27 INFO - PROCESS | 11073 | __end_tp_report 08:34:27 INFO - PROCESS | 11073 | __start_cc_report 08:34:27 INFO - PROCESS | 11073 | _x_x_mozilla_cycle_collect,407 08:34:27 INFO - PROCESS | 11073 | __end_cc_report 08:34:27 INFO - PROCESS | 11073 | __startTimestamp1465572867123__endTimestamp 08:34:27 INFO - PROCESS | 11073 | 08:34:27 INFO - PROCESS | 11073 | ------- Summary: start ------- 08:34:27 INFO - PROCESS | 11073 | Number of tests: 6 08:34:27 INFO - PROCESS | 11073 | 08:34:27 INFO - PROCESS | 11073 | [#0] dojo.html Cycles:165 Average:4738.22 Median:4944.68 stddev:607.03 (12.3%) stddev-sans-first:585.58 08:34:27 INFO - PROCESS | 11073 | Values: 2614.3 2640.1 2659.5 2661.6 2677.0 4702.2 4706.7 4779.3 4867.8 4911.4 4690.1 4714.5 4719.3 4839.8 4864.8 4316.8 4392.1 4440.4 4456.6 4457.3 650.7 4267.7 4327.3 4329.4 4369.5 4351.3 4358.0 4372.4 4379.7 4427.9 4373.1 4376.2 4392.8 4394.1 4433.9 4353.2 4359.7 4394.2 4417.2 4434.4 4822.5 4841.9 4846.0 4846.6 4855.9 4979.2 5063.1 5134.4 5147.6 5165.3 5126.3 5145.6 5167.3 5168.9 5202.5 4802.2 4815.3 4815.9 4816.6 4878.6 5208.0 5236.8 5254.0 5260.2 5272.1 5035.6 5046.8 5053.0 5055.5 5105.1 5086.8 5131.1 5141.9 5143.6 5154.1 4986.7 5049.8 5069.9 5090.1 5097.0 5045.6 5050.9 5059.3 5078.4 5117.2 4206.0 4271.1 4284.2 4288.2 4352.0 3663.6 3741.7 3766.6 3772.6 3807.6 4501.2 4506.8 4518.7 4564.6 4600.5 5227.0 5241.8 5246.3 5247.4 5264.1 4346.8 4500.5 4551.2 4557.5 4565.2 4615.5 4643.2 4646.4 4653.4 4704.6 4689.5 4935.9 4944.7 4945.8 5002.5 5171.6 5218.9 5235.6 5236.8 5252.2 4889.4 4933.9 4937.4 4951.7 4976.8 4924.5 5041.8 5144.5 5190.5 5197.8 5083.5 5187.9 5204.5 5211.5 5263.2 5039.9 5050.2 5056.4 5057.6 5106.5 4909.7 4983.2 5015.9 5037.1 5043.1 4989.3 4998.5 5023.0 5026.7 5074.0 5116.1 5116.8 5118.1 5119.2 5166.7 4816.4 4955.7 4992.8 4995.6 5023.9 08:34:27 INFO - PROCESS | 11073 | 08:34:27 INFO - PROCESS | 11073 | [#1] ext.html Cycles:180 Average:47704.02 Median:36970.63 stddev:86507.71 (234.0%) stddev-sans-first:86677.90 08:34:27 INFO - PROCESS | 11073 | Values: 536.8 581.9 587.7 602.8 614.1 33832.5 38216.2 38233.6 38254.0 38259.4 38248.4 38598.0 38703.4 38721.6 38803.4 7664.9 7774.9 7786.9 7791.4 7818.1 7611.9 7753.7 7764.7 7777.6 7799.9 7723.2 7752.2 7772.7 7797.1 7800.1 7771.7 7799.5 7812.4 7813.9 7825.5 7679.7 7720.3 7759.8 7760.8 7770.1 29450.4 36612.5 36933.0 36953.0 37152.1 2914.7 2934.8 3144.3 3453.8 3673.6 27399.5 30185.5 30448.5 30474.7 30678.2 3506.2 3602.7 3614.2 3627.3 3630.8 253155.0 259492.0 259561.0 259767.0 260413.0 56129.0 56976.0 57369.4 57377.1 57482.7 34176.8 35255.0 35258.6 61051.0 61491.7 15288.7 15397.2 15406.7 15421.2 15449.8 9157.5 9184.6 9245.7 9265.8 9406.9 19104.4 19133.1 19200.6 19392.5 19404.6 7264.8 7314.2 7320.8 7588.5 7609.7 819.9 822.0 922.9 1003.2 1004.1 28143.0 28342.0 28382.0 28789.7 28791.9 923.4 944.9 949.8 963.2 1023.9 14763.4 15060.2 15186.0 15219.4 15222.7 383032.0 384008.0 386952.0 388701.0 389108.0 50025.2 50627.0 50665.7 50682.0 50711.5 1146.8 1165.3 1169.2 1180.1 1182.1 26478.7 27648.4 27735.3 28047.7 28141.4 39034.8 39105.8 39132.2 39178.6 39422.8 326231.0 327217.0 328338.0 329269.0 330993.0 25755.5 26006.7 26057.9 26246.2 26401.7 40549.4 43199.6 43732.8 43850.6 44137.0 36592.5 36660.5 36711.6 37015.0 37201.1 35953.8 36376.8 36545.0 36634.0 37107.3 36085.0 36419.5 36672.0 36988.3 37041.0 32309.5 32651.5 33347.0 34161.5 34590.5 26056.0 26067.7 26146.3 26509.6 26535.9 08:34:27 INFO - PROCESS | 11073 | 08:34:27 INFO - PROCESS | 11073 | [#2] jquery.html Cycles:180 Average:24202.66 Median:4305.26 stddev:65528.01 (1522.0%) stddev-sans-first:65687.40 08:34:27 INFO - PROCESS | 11073 | Values: 369.2 380.8 380.9 389.6 397.8 15729.9 16112.4 17037.9 17072.0 17081.7 12885.8 14894.5 15701.7 15784.1 16277.4 4595.3 4733.2 4794.8 4796.8 4807.5 3508.4 5185.9 5476.8 5495.9 5569.7 5464.8 5531.4 5538.6 5541.4 5555.5 5367.2 5483.5 5507.2 5537.8 5546.2 5260.9 5275.8 5308.0 5335.5 5342.9 12561.6 13455.2 19885.7 20048.5 20106.9 1710.3 1850.9 1878.3 1939.1 2001.6 9554.7 9639.5 10808.7 11424.4 13390.3 1653.6 1685.6 1727.5 1728.3 1797.5 65756.0 66379.3 67544.3 69596.7 69820.7 9912.9 9998.5 10028.0 10107.5 10243.8 13720.4 13796.6 13821.8 13834.4 13857.3 7173.7 7243.8 7334.0 7392.3 7409.8 6864.8 6878.2 6895.8 6984.4 6993.4 4256.0 4262.4 4303.5 4304.2 4306.3 1721.9 1758.3 1829.9 1837.9 1849.4 766.6 801.4 833.6 839.6 863.2 15810.4 15993.6 16328.5 16418.2 16425.3 859.0 877.0 878.9 883.2 903.1 8713.1 9238.5 9256.3 9378.8 9425.3 392355.0 396030.0 396461.0 399780.0 400680.0 75510.0 78186.2 78556.6 78710.6 79634.0 826.0 860.0 877.2 880.0 886.5 14374.4 14452.6 14697.7 14836.3 15033.1 32886.0 34114.8 35167.6 35705.5 38420.2 45362.5 47439.1 50787.0 52254.7 52778.2 7786.3 8011.9 8031.8 8037.6 8202.4 6709.7 10545.7 11137.1 11725.3 12101.2 10481.5 10547.3 10724.4 10879.9 10912.6 7501.9 10676.4 10775.7 10865.9 10866.9 6326.1 8613.7 10127.5 10806.6 11013.1 6824.6 7131.0 7954.7 8121.5 8123.1 9715.8 10125.3 10193.2 10404.6 10516.5 08:34:27 INFO - PROCESS | 11073 | 08:34:27 INFO - PROCESS | 11073 | [#3] mootools.html Cycles:180 Average:5146.34 Median:5269.13 stddev:2861.15 (54.3%) stddev-sans-first:2854.05 08:34:27 INFO - PROCESS | 11073 | Values: 1232.1 1257.5 1342.9 1478.2 1480.6 6713.4 7343.3 7429.7 7884.4 7978.6 7353.0 7676.7 7685.4 7711.2 7711.3 2179.0 2223.6 2229.3 2237.4 2240.3 2187.1 2203.4 2230.5 2244.1 2252.9 2193.3 2205.7 2212.4 2220.5 2220.5 2166.2 2169.0 2175.9 2184.3 2200.1 2072.7 2078.9 2079.0 2082.1 2092.3 7733.1 7762.6 7782.1 7796.6 7810.3 4659.3 4772.7 4780.8 4818.9 4827.0 2857.9 2874.8 2997.0 3005.0 3012.0 892.5 924.6 945.7 946.1 949.8 10691.3 10698.0 10727.3 10729.4 10789.9 4252.8 4311.7 4466.3 4467.8 4474.6 9135.9 9148.4 9162.5 9182.4 9185.0 4710.4 4732.2 4803.0 4853.9 4856.2 3712.5 4185.2 4294.1 4300.7 4313.7 3727.4 3727.8 3743.4 3839.7 3839.8 1226.7 1250.5 1253.3 1256.8 1267.4 754.1 873.1 879.6 886.4 903.2 5269.3 5499.2 5508.5 5524.7 5559.1 416.8 424.3 424.5 438.7 440.9 3790.9 3928.9 3986.3 4022.9 4040.0 9401.6 9552.0 9587.1 9593.6 9602.3 8951.1 9263.8 9298.0 9391.5 9522.5 7112.8 7171.0 7240.5 7247.6 7293.1 5268.9 5398.0 5500.3 5528.1 5542.8 8602.9 8952.2 8962.0 8966.9 9012.2 8857.0 8962.1 9007.1 9085.1 9103.9 6132.1 6264.1 6475.4 6847.5 6892.3 7520.5 7543.6 7548.6 7572.2 7596.8 6656.3 6845.1 6873.8 6932.1 6946.8 6778.8 6784.4 6828.3 6843.9 6890.5 6110.2 6125.8 6184.5 6187.2 6190.7 4492.6 4543.2 4545.5 4593.1 4653.8 4407.4 4542.9 4659.7 4675.0 4782.4 08:34:27 INFO - PROCESS | 11073 | 08:34:27 INFO - PROCESS | 11073 | [#4] prototype.html Cycles:180 Average:4170.09 Median:4535.68 stddev:1206.72 (26.6%) stddev-sans-first:1174.59 08:34:27 INFO - PROCESS | 11073 | Values: 298.5 302.7 309.9 310.3 311.5 4807.6 4921.8 4974.7 5010.5 5019.3 4967.9 5020.7 5025.2 5025.6 5026.1 3910.5 3917.7 3927.8 3928.0 3947.6 3592.9 3899.9 3919.6 3931.4 3936.3 3793.4 3804.9 3807.1 3810.2 3819.2 3821.5 3828.3 3833.9 3834.5 3846.0 3368.7 3405.7 3406.9 3422.9 3427.3 4810.4 4857.1 4906.8 4915.2 4922.4 4395.4 4403.1 4424.8 4434.2 4437.6 5221.2 5232.2 5234.6 5238.4 5246.3 3631.4 3692.3 3723.3 3729.6 3735.6 5382.2 5426.4 5439.8 5447.9 5449.4 3787.6 3801.0 3804.4 3810.4 3812.3 3844.3 3857.8 3858.0 3860.3 3866.1 4294.7 4358.8 4362.5 4403.0 4414.7 5146.3 5155.4 5165.5 5177.5 5183.4 1231.4 1297.9 1331.3 1336.1 1337.6 839.4 841.9 844.3 860.3 861.9 4187.6 4231.7 4245.0 4254.3 4261.4 4746.3 4753.7 4777.2 4793.8 4811.0 4157.3 4165.5 4187.8 4216.6 4234.4 2461.4 2542.3 2582.8 2593.6 2596.0 4491.6 4513.3 4536.5 4544.8 4559.8 4840.5 4883.0 4933.9 4938.2 4945.7 4372.4 4395.4 4432.6 4482.9 4507.9 4718.0 4722.3 4723.1 4724.5 4770.5 4654.5 4709.7 4728.8 4736.5 4755.0 4403.4 4515.7 4529.0 4534.8 4592.1 3483.4 3490.4 3505.6 3524.8 3531.7 4734.9 4743.0 4769.0 4770.8 5147.4 5089.7 5143.3 5254.2 5258.8 5265.2 5188.4 5231.5 5231.9 5243.6 5246.9 4876.2 5117.7 5139.5 5166.7 5178.5 5304.8 5324.0 5325.1 5326.9 5348.7 5176.8 5226.0 5226.5 5229.6 5240.4 08:34:27 INFO - PROCESS | 11073 | 08:34:27 INFO - PROCESS | 11073 | [#5] yui.html Cycles:180 Average:16724.06 Median:544.82 stddev:23234.80 (4264.7%) stddev-sans-first:23268.40 08:34:27 INFO - PROCESS | 11073 | Values: 590.3 607.9 617.1 657.1 742.9 10335.9 12305.7 12837.7 12837.8 13427.2 13867.4 14409.5 14477.4 14494.7 14590.1 763.2 775.1 784.1 785.8 787.2 779.8 783.7 783.9 787.1 789.8 825.4 826.1 827.5 829.4 830.9 812.2 819.1 821.6 823.0 823.4 577.7 587.9 592.7 594.8 597.9 13132.1 13169.1 13169.6 13184.9 13212.5 12725.6 13282.6 13558.3 13653.3 13826.7 10296.7 10436.4 10500.8 10526.8 10571.3 3393.9 3435.1 3442.6 3446.4 3456.4 54802.5 55110.0 55222.7 56852.4 57025.1 10142.4 10261.3 10269.4 10409.5 10594.6 17472.7 18715.3 18754.2 18818.2 18898.2 7082.2 7108.0 7182.1 7337.9 7369.4 3789.7 3863.9 3868.4 3904.2 4007.6 3031.6 3139.8 3141.9 3151.7 3153.3 520.0 522.8 523.0 530.9 549.2 476.8 542.2 547.3 562.8 580.1 7673.5 7920.6 8020.5 8105.1 8161.9 542.3 549.4 598.5 606.5 613.0 3691.2 3768.9 3948.4 3987.1 4079.4 85181.6 90308.0 91739.8 92990.0 93677.0 51308.7 63193.7 65035.0 78276.6 80985.9 70578.6 74382.3 74670.3 74845.3 75689.6 7248.8 7538.9 7550.4 7573.7 7767.2 41085.4 43866.0 44361.4 44601.6 45316.0 54157.0 61265.4 61282.4 61693.7 62262.4 9648.5 9720.8 9929.4 9994.1 10067.4 11473.9 11486.1 11514.1 11652.7 11785.0 9771.3 9870.1 10066.5 10067.8 10762.4 11259.7 11558.2 12492.6 12700.6 12849.3 10318.5 10436.6 10480.9 10570.5 10976.1 9630.0 9815.6 10020.2 10219.9 10222.2 9498.8 9533.6 9627.9 9720.4 9824.6 08:34:27 INFO - PROCESS | 11073 | -------- Summary: end -------- 08:34:27 INFO - PROCESS | 11073 | 08:34:27 INFO - TEST-INFO | 11073: exit 0 08:34:27 INFO - TEST-OK | dromaeo_css | took 1116569ms 08:34:27 INFO - TEST-START | kraken 08:34:27 INFO - operating with platform_type : linux_ 08:34:27 INFO - Initialising browser for kraken test... 08:34:27 INFO - TEST-INFO | started process 11307 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcF4Xfb/profile http://localhost:38081/getInfo.html) 08:34:33 INFO - PROCESS | 11307 | __metrics Screen width/height:1600/1200 08:34:33 INFO - PROCESS | 11307 | colorDepth:24 08:34:33 INFO - PROCESS | 11307 | Browser inner width/height: 1024/697 08:34:33 INFO - PROCESS | 11307 | __metrics 08:34:33 ERROR - PROCESS | 11307 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 08:34:34 INFO - TEST-INFO | 11307: exit 0 08:34:34 INFO - Browser initialized. 08:34:34 INFO - Running cycle 1/1 for kraken test... 08:34:34 INFO - TEST-INFO | started process 11424 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcF4Xfb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:34:46 INFO - PROCESS | 11424 | RSS: Main: 185982976 08:34:46 INFO - PROCESS | 11424 | 08:34:49 INFO - PROCESS | 11424 | Cycle 1(1): loaded http://localhost:38081/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38081/tests/kraken/driver.html?testName=audio-beat-detection) 08:34:50 INFO - PROCESS | 11424 | RSS: Main: 190029824 08:34:50 INFO - PROCESS | 11424 | 08:34:53 INFO - PROCESS | 11424 | Cycle 1(1): loaded http://localhost:38081/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38081/tests/kraken/driver.html?testName=audio-dft) 08:34:53 INFO - PROCESS | 11424 | RSS: Main: 189771776 08:34:53 INFO - PROCESS | 11424 | 08:34:56 INFO - PROCESS | 11424 | Cycle 1(1): loaded http://localhost:38081/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38081/tests/kraken/driver.html?testName=audio-fft) 08:34:57 INFO - PROCESS | 11424 | RSS: Main: 185712640 08:34:57 INFO - PROCESS | 11424 | 08:34:59 INFO - PROCESS | 11424 | Cycle 1(1): loaded http://localhost:38081/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38081/tests/kraken/driver.html?testName=audio-oscillator) 08:35:00 INFO - PROCESS | 11424 | RSS: Main: 186056704 08:35:00 INFO - PROCESS | 11424 | 08:35:02 INFO - PROCESS | 11424 | Cycle 1(1): loaded http://localhost:38081/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38081/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:35:03 INFO - PROCESS | 11424 | RSS: Main: 186335232 08:35:03 INFO - PROCESS | 11424 | 08:35:06 INFO - PROCESS | 11424 | Cycle 1(1): loaded http://localhost:38081/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38081/tests/kraken/driver.html?testName=imaging-darkroom) 08:35:06 INFO - PROCESS | 11424 | RSS: Main: 186716160 08:35:06 INFO - PROCESS | 11424 | 08:35:10 INFO - PROCESS | 11424 | Cycle 1(1): loaded http://localhost:38081/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38081/tests/kraken/driver.html?testName=imaging-desaturate) 08:35:11 INFO - PROCESS | 11424 | RSS: Main: 184295424 08:35:11 INFO - PROCESS | 11424 | 08:35:14 INFO - PROCESS | 11424 | Cycle 1(1): loaded http://localhost:38081/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38081/tests/kraken/driver.html?testName=json-parse-financial) 08:35:14 INFO - PROCESS | 11424 | RSS: Main: 185606144 08:35:14 INFO - PROCESS | 11424 | 08:35:16 INFO - PROCESS | 11424 | Cycle 1(1): loaded http://localhost:38081/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38081/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:35:17 INFO - PROCESS | 11424 | RSS: Main: 186015744 08:35:17 INFO - PROCESS | 11424 | 08:35:18 INFO - PROCESS | 11424 | Cycle 1(1): loaded http://localhost:38081/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38081/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:35:19 INFO - PROCESS | 11424 | RSS: Main: 186335232 08:35:19 INFO - PROCESS | 11424 | 08:35:21 INFO - PROCESS | 11424 | Cycle 1(1): loaded http://localhost:38081/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38081/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:35:22 INFO - PROCESS | 11424 | RSS: Main: 186859520 08:35:22 INFO - PROCESS | 11424 | 08:35:25 INFO - PROCESS | 11424 | Cycle 1(1): loaded http://localhost:38081/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38081/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:35:25 INFO - PROCESS | 11424 | RSS: Main: 186740736 08:35:25 INFO - PROCESS | 11424 | 08:35:28 INFO - PROCESS | 11424 | Cycle 1(1): loaded http://localhost:38081/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38081/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:35:29 INFO - PROCESS | 11424 | RSS: Main: 186486784 08:35:29 INFO - PROCESS | 11424 | 08:35:31 INFO - PROCESS | 11424 | Cycle 1(1): loaded http://localhost:38081/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38081/tests/kraken/driver.html?testName=ai-astar) 08:35:31 INFO - PROCESS | 11424 | RSS: Main: 187310080 08:35:31 INFO - PROCESS | 11424 | 08:35:31 INFO - PROCESS | 11424 | __start_tp_report 08:35:31 INFO - PROCESS | 11424 | _x_x_mozilla_page_load 08:35:31 INFO - PROCESS | 11424 | _x_x_mozilla_page_load_details 08:35:31 INFO - PROCESS | 11424 | |i|pagename|runs| 08:35:31 INFO - PROCESS | 11424 | |0;ai-astar;115;109;114;117;114;115;114;116;113;115 08:35:31 INFO - PROCESS | 11424 | |1;audio-beat-detection;158;133;154;192;135;163;161;136;192;133 08:35:31 INFO - PROCESS | 11424 | |2;audio-dft;163;167;177;166;162;173;162;163;162;161 08:35:31 INFO - PROCESS | 11424 | |3;audio-fft;77;76;77;151;78;78;76;76;152;76 08:35:31 INFO - PROCESS | 11424 | |4;audio-oscillator;88;88;142;86;87;88;144;87;87;132 08:35:31 INFO - PROCESS | 11424 | |5;imaging-gaussian-blur;118;120;117;118;118;117;118;118;118;118 08:35:31 INFO - PROCESS | 11424 | |6;imaging-darkroom;147;151;147;147;146;147;147;147;150;147 08:35:31 INFO - PROCESS | 11424 | |7;imaging-desaturate;96;95;95;95;95;95;96;96;96;96 08:35:31 INFO - PROCESS | 11424 | |8;json-parse-financial;63;63;64;64;64;63;62;69;64;64 08:35:31 INFO - PROCESS | 11424 | |9;json-stringify-tinderbox;65;66;71;65;65;65;67;66;65;70 08:35:31 INFO - PROCESS | 11424 | |10;stanford-crypto-aes;90;87;84;91;87;85;85;85;111;84 08:35:31 INFO - PROCESS | 11424 | |11;stanford-crypto-ccm;137;133;143;140;137;130;135;133;134;135 08:35:31 INFO - PROCESS | 11424 | |12;stanford-crypto-pbkdf2;173;169;171;171;171;175;170;171;168;169 08:35:31 INFO - PROCESS | 11424 | |13;stanford-crypto-sha256-iterative;70;70;74;68;69;69;68;67;66;66 08:35:31 INFO - PROCESS | 11424 | __end_tp_report 08:35:31 INFO - PROCESS | 11424 | __start_cc_report 08:35:31 INFO - PROCESS | 11424 | _x_x_mozilla_cycle_collect,1010 08:35:31 INFO - PROCESS | 11424 | __end_cc_report 08:35:31 INFO - PROCESS | 11424 | __startTimestamp1465572931520__endTimestamp 08:35:31 INFO - PROCESS | 11424 | 08:35:31 INFO - PROCESS | 11424 | ------- Summary: start ------- 08:35:31 INFO - PROCESS | 11424 | Number of tests: 14 08:35:31 INFO - PROCESS | 11424 | 08:35:31 INFO - PROCESS | 11424 | [#0] ai-astar Cycles:10 Average:114.20 Median:115.00 stddev:2.15 (1.9%) stddev-sans-first:2.26 08:35:31 INFO - PROCESS | 11424 | Values: 115.0 109.0 114.0 117.0 114.0 115.0 114.0 116.0 113.0 115.0 08:35:31 INFO - PROCESS | 11424 | 08:35:31 INFO - PROCESS | 11424 | [#1] audio-beat-detection Cycles:10 Average:155.70 Median:159.50 stddev:22.54 (14.1%) stddev-sans-first:23.89 08:35:31 INFO - PROCESS | 11424 | Values: 158.0 133.0 154.0 192.0 135.0 163.0 161.0 136.0 192.0 133.0 08:35:31 INFO - PROCESS | 11424 | 08:35:31 INFO - PROCESS | 11424 | [#2] audio-dft Cycles:10 Average:165.60 Median:164.50 stddev:5.38 (3.3%) stddev-sans-first:5.62 08:35:31 INFO - PROCESS | 11424 | Values: 163.0 167.0 177.0 166.0 162.0 173.0 162.0 163.0 162.0 161.0 08:35:31 INFO - PROCESS | 11424 | 08:35:31 INFO - PROCESS | 11424 | [#3] audio-fft Cycles:10 Average:91.70 Median:76.50 stddev:31.53 (41.2%) stddev-sans-first:32.99 08:35:31 INFO - PROCESS | 11424 | Values: 77.0 76.0 77.0 151.0 78.0 78.0 76.0 76.0 152.0 76.0 08:35:31 INFO - PROCESS | 11424 | 08:35:31 INFO - PROCESS | 11424 | [#4] audio-oscillator Cycles:10 Average:102.90 Median:87.00 stddev:25.33 (29.1%) stddev-sans-first:26.29 08:35:31 INFO - PROCESS | 11424 | Values: 88.0 88.0 142.0 86.0 87.0 88.0 144.0 87.0 87.0 132.0 08:35:31 INFO - PROCESS | 11424 | 08:35:31 INFO - PROCESS | 11424 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 08:35:31 INFO - PROCESS | 11424 | Values: 118.0 120.0 117.0 118.0 118.0 117.0 118.0 118.0 118.0 118.0 08:35:31 INFO - PROCESS | 11424 | 08:35:31 INFO - PROCESS | 11424 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:147.00 stddev:1.58 (1.1%) stddev-sans-first:1.66 08:35:31 INFO - PROCESS | 11424 | Values: 147.0 151.0 147.0 147.0 146.0 147.0 147.0 147.0 150.0 147.0 08:35:31 INFO - PROCESS | 11424 | 08:35:31 INFO - PROCESS | 11424 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 08:35:31 INFO - PROCESS | 11424 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 96.0 96.0 08:35:31 INFO - PROCESS | 11424 | 08:35:31 INFO - PROCESS | 11424 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:64.00 stddev:1.89 (2.9%) stddev-sans-first:1.96 08:35:31 INFO - PROCESS | 11424 | Values: 63.0 63.0 64.0 64.0 64.0 63.0 62.0 69.0 64.0 64.0 08:35:31 INFO - PROCESS | 11424 | 08:35:31 INFO - PROCESS | 11424 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:66.00 stddev:2.22 (3.4%) stddev-sans-first:2.29 08:35:31 INFO - PROCESS | 11424 | Values: 65.0 66.0 71.0 65.0 65.0 65.0 67.0 66.0 65.0 70.0 08:35:31 INFO - PROCESS | 11424 | 08:35:31 INFO - PROCESS | 11424 | [#10] stanford-crypto-aes Cycles:10 Average:88.90 Median:86.00 stddev:8.13 (9.5%) stddev-sans-first:8.61 08:35:31 INFO - PROCESS | 11424 | Values: 90.0 87.0 84.0 91.0 87.0 85.0 85.0 85.0 111.0 84.0 08:35:31 INFO - PROCESS | 11424 | 08:35:31 INFO - PROCESS | 11424 | [#11] stanford-crypto-ccm Cycles:10 Average:135.70 Median:136.00 stddev:3.74 (2.8%) stddev-sans-first:3.94 08:35:31 INFO - PROCESS | 11424 | Values: 137.0 133.0 143.0 140.0 137.0 130.0 135.0 133.0 134.0 135.0 08:35:31 INFO - PROCESS | 11424 | 08:35:31 INFO - PROCESS | 11424 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.80 Median:171.00 stddev:2.04 (1.2%) stddev-sans-first:2.01 08:35:31 INFO - PROCESS | 11424 | Values: 173.0 169.0 171.0 171.0 171.0 175.0 170.0 171.0 168.0 169.0 08:35:31 INFO - PROCESS | 11424 | 08:35:31 INFO - PROCESS | 11424 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:2.36 (3.4%) stddev-sans-first:2.46 08:35:31 INFO - PROCESS | 11424 | Values: 70.0 70.0 74.0 68.0 69.0 69.0 68.0 67.0 66.0 66.0 08:35:31 INFO - PROCESS | 11424 | -------- Summary: end -------- 08:35:31 INFO - PROCESS | 11424 | 08:35:32 INFO - TEST-INFO | 11424: exit 0 08:35:32 INFO - TEST-OK | kraken | took 64812ms 08:35:32 INFO - SUITE-END | took 1181s 08:35:33 INFO - Completed test suite (00:19:41) 08:35:33 INFO - javascript benchmark 08:35:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6356.279240868104, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2614.281072705006, 2640.1287575100214, 2659.507991021661, 2661.640678508401, 2677.0228866463735, 4702.24764037754, 4706.717596944186, 4779.283107533867, 4867.756612169395, 4911.386076740408, 4690.085433340491, 4714.5285471452835, 4719.2685133804225, 4839.830605928793, 4864.805407783693, 4316.84891028814, 4392.143532011259, 4440.444944381952, 4456.621187199092, 4457.264551349023, 650.6574335972397, 4267.701260911737, 4327.264365057932, 4329.350597410398, 4369.519352871182, 4351.325544540601, 4358.0, 4372.366006929009, 4379.671524635665, 4427.911441771179, 4373.103513779667, 4376.168527979674, 4392.824287028515, 4394.143142087294, 4433.9113217735785, 4353.216421044211, 4359.651227901792, 4394.231009573312, 4417.226985277595, 4434.401355816988, 4822.541858523435, 4841.878953026203, 4846.0, 4846.5880400166025, 4855.927161092586, 4979.1784355581285, 5063.11395505785, 5134.4095429025765, 5147.613928955343, 5165.328507294028, 5126.307948426952, 5145.6398052136365, 5167.276581278624, 5168.870778230536, 5202.453742357074, 4802.159622066124, 4815.3499277597775, 4815.903681926342, 4816.590589799906, 4878.634102442295, 5208.0, 5236.816711415082, 5254.0, 5260.184671375943, 5272.130098533699, 5035.571976382049, 5046.848594542096, 5052.9747351263, 5055.545000949932, 5105.055564720538, 5086.847394578169, 5131.076406246912, 5141.948580514147, 5143.6399452037995, 5154.098032844237, 4986.7257300848805, 5049.823256186016, 5069.8732531687, 5090.10923088458, 5096.974515127401, 5045.646804723708, 5050.898982020339, 5059.342285502861, 5078.365204349457, 5117.232415137759, 4206.0, 4271.145770845843, 4284.228838808982, 4288.185244803477, 4351.9564804352185, 3663.6153203913736, 3741.6819570336825, 3766.5856755756845, 3772.641599048086, 3807.638274363931, 4501.189785838515, 4506.842260520866, 4518.728876267434, 4564.589186973122, 4600.539946005372, 5227.0, 5241.816536421207, 5246.344206974129, 5247.370315562157, 5264.078786212397, 4346.7826608670075, 4500.459944806644, 4551.158035763395, 4557.521460246627, 4565.223911934912, 4615.492295847454, 4643.210654188796, 4646.3727396801, 4653.414450339119, 4704.600108990706, 4689.507601701772, 4935.876603084952, 4944.678595891256, 4945.7527123644395, 5002.499750024968, 5171.560417364566, 5218.930119325453, 5235.633505654568, 5236.842894713165, 5252.238425428215, 4889.364382630235, 4933.925991110064, 4937.432195297587, 4951.702897826142, 4976.776045077908, 4924.532169443897, 5041.773120209673, 5144.511271429208, 5190.455002224712, 5197.8440646780655, 5083.46623604531, 5187.922181167361, 5204.505571970657, 5211.478852114758, 5263.184206448007, 5039.924401134059, 5050.166722490895, 5056.393232812086, 5057.6459647824295, 5106.4893510648635, 4909.705417674951, 4983.152864013199, 5015.899682006412, 5037.093323201859, 5043.117454445384, 4989.25161225819, 4998.475160108136, 5023.045621331935, 5026.698398096126, 5074.035933172685, 5116.104681680766, 5116.769745361542, 5118.129917914038, 5119.206522988943, 5166.689998599945, 4816.446108697404, 4955.677880937727, 4992.775325110451, 4995.550400463831, 5023.874403139805], "value": 4699.612686601995, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [536.8034998813025, 581.9301683797945, 587.7237698281807, 602.7829981206764, 614.1218058176805, 33832.4925126123, 38216.23567528648, 38233.61766382335, 38254.04364890879, 38259.42610860836, 38248.42627360592, 38598.035049123784, 38703.41944870829, 38721.61278387215, 38803.41794873079, 7664.92335076649, 7774.922250777505, 7786.883196752054, 7791.415643826707, 7818.100918394401, 7611.923880761205, 7753.689852405897, 7764.650590723431, 7777.572233527154, 7799.88300175495, 7723.189065148163, 7752.2247775222595, 7772.65023073963, 7797.142314345418, 7800.10298815635, 7771.727989520368, 7799.532028078305, 7812.375009999187, 7813.882791758128, 7825.452218344718, 7679.654415551314, 7720.3051725344985, 7759.806004849867, 7760.805979850493, 7770.145284018753, 29450.410991780045, 36612.450813237556, 36933.0, 36953.0, 37152.071198219994, 2914.664813546448, 2934.7798915081453, 3144.308252184516, 3453.8445769940413, 3673.5959044505084, 27399.452010959867, 30185.547216791765, 30448.54327185094, 30474.69525304741, 30678.233044173852, 3506.211102501942, 3602.6757591816863, 3614.168741189515, 3627.274545090966, 3630.7640003399692, 253155.0, 259492.0, 259560.9999999981, 259767.0, 260413.0, 56129.0, 56976.0, 57369.426305737245, 57377.13934290989, 57482.7125864368, 34176.82911585476, 35255.0, 35258.647413525534, 61051.0, 61491.6925415379, 15288.694226115414, 15397.153156576496, 15406.691866162613, 15421.151836648867, 15449.845501545065, 9157.450552966844, 9184.63261469547, 9245.72262832116, 9265.768355791159, 9406.858897116548, 19104.426867194008, 19133.13900874464, 19200.61598768017, 19392.515187120152, 19404.611907761766, 7264.782056538313, 7314.232005639331, 7320.816979575447, 7588.468807183444, 7609.695612175562, 819.8893149424871, 821.9506829590243, 922.8681745168682, 1003.247564326755, 1004.0812656419295, 28143.0, 28342.0, 28382.0, 28789.712102879123, 28791.856040719664, 923.4320892651106, 944.9102335278137, 949.7862980829397, 963.2342287881152, 1023.8771347438355, 14763.409463621334, 15060.246987650793, 15186.0, 15219.391224350902, 15222.695546089017, 383032.0, 384008.0, 386952.0, 388701.0, 389108.0, 50025.24962125498, 50627.0, 50665.74667126641, 50682.0, 50711.49288507141, 1146.7591805720724, 1165.3241120150292, 1169.1990986174499, 1180.0854337888034, 1182.1193211057816, 26478.735212647625, 27648.44703105967, 27735.30661733473, 28047.71952280451, 28141.437171256868, 39034.804825976826, 39105.804470978605, 39132.21735565216, 39178.60821391863, 39422.80288598539, 326231.0, 327217.0, 328338.0, 329269.0, 330993.0, 25755.484890302465, 26006.73993260043, 26057.869710651325, 26246.21261362162, 26401.735982639926, 40549.39175912305, 43199.56800431955, 43732.78133609439, 43850.561494384645, 44137.0, 36592.45111323279, 36660.45009324809, 36711.63288367082, 37015.0, 37201.10269881566, 35953.82023089868, 36376.81811590925, 36545.0, 36634.0, 37107.257854843294, 36085.0, 36419.45370819493, 36672.0, 36988.26023479569, 37041.0, 32309.51535726919, 32651.510227346134, 33347.0, 34161.48757768586, 34590.48114278237, 26056.0, 26067.696615168785, 26146.346341341618, 26509.60235596506, 26535.867320663274], "value": 17528.28316934421, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.20436459429936, 380.83433706337735, 380.8876381467467, 389.561743039081, 397.8309218582104, 15729.921350393246, 16112.35550577977, 17037.91481042593, 17071.975681459106, 17081.658366832657, 12885.806712899313, 14894.47869324574, 15701.685966280667, 15784.0529568226, 16277.430289939855, 4595.333676616897, 4733.219018861901, 4794.808207671689, 4796.760161991904, 4807.495213002637, 3508.386032444325, 5185.896282074356, 5476.780928762844, 5495.917561236584, 5569.66582005081, 5464.808731694391, 5531.3915469298345, 5538.6399884007615, 5541.418151094137, 5555.527780138693, 5367.194920761897, 5483.506484416402, 5507.173923911405, 5537.778488860441, 5546.223528705964, 5260.894782104375, 5275.815346462856, 5308.0, 5335.519803217729, 5342.866428339284, 12561.623151305475, 13455.192688438725, 19885.701714474293, 20048.498787530283, 20106.899465502724, 1710.2645862279214, 1850.8796928199624, 1878.2674756844842, 1939.1080103152567, 2001.6196922584663, 9554.665586704501, 9639.469829159463, 10808.675739727742, 11424.42877856104, 13390.330483475787, 1653.5618061213788, 1685.6460143369784, 1727.4990252826665, 1728.3173146607146, 1797.5326415132029, 65756.0, 66379.33620663828, 67544.32455675479, 69596.6520167401, 69820.6508967452, 9912.851307230398, 9998.500074996222, 10028.0, 10107.545160467796, 10243.795124097476, 13720.382582783599, 13796.586102416944, 13821.79267310991, 13834.377453014638, 13857.30713464343, 7173.7130514779865, 7243.782686519413, 7334.0, 7392.334689877936, 7409.8147546311775, 6864.828379290558, 6878.174619045746, 6895.75864844728, 6984.4412447004115, 6993.4055605274125, 4255.97872010638, 4262.360645903139, 4303.505096913832, 4304.20372231132, 4306.310990241546, 1721.9139043048049, 1758.261530157337, 1829.9085045747659, 1837.9172937217857, 1849.4359220437627, 766.6358479722087, 801.382935139939, 833.6373677450207, 839.5718183726343, 863.2317237658489, 15810.36758529669, 15993.600159996093, 16328.510144695678, 16418.1790910454, 16425.342986280415, 858.9742307730778, 877.0045997792552, 878.9208971192623, 883.1742320929823, 903.1329923273731, 8713.128687131237, 9238.538073096319, 9256.259499240045, 9378.812423751624, 9425.2931030173, 392355.0, 396030.0, 396461.0, 399780.0, 400680.0, 75510.0, 78186.2181378179, 78556.60721696354, 78710.6064469674, 79634.0, 825.9752207433787, 859.987100193485, 877.2061284537504, 879.9868001979976, 886.5389997201419, 14374.425022998963, 14452.566423007327, 14697.706045879237, 14836.258187090387, 15033.098014119189, 32886.0, 34114.829425853706, 35167.64832351746, 35705.46441803323, 38420.231595367375, 45362.546374535836, 47439.102435902176, 50787.0, 52254.738726306125, 52778.208326875894, 7786.299233068825, 8011.879821802561, 8031.83936321282, 8037.638306276114, 8202.425830191829, 6709.664516774239, 10545.73451185832, 11137.099676142472, 11725.296482210753, 12101.152919295917, 10481.528331224961, 10547.261691681508, 10724.356538607708, 10879.945600272265, 10912.56349746033, 7501.924980750123, 10676.359418434608, 10775.676729698122, 10865.891341086804, 10866.945665271624, 6326.145970293951, 8613.741587752378, 10127.493625318852, 10806.621768238074, 11013.063889569476, 6824.556403833735, 7130.964345178449, 7954.681812727657, 8121.512709237465, 8123.0658474276215, 9715.805683886425, 10125.290437005468, 10193.184545236512, 10404.635837745642, 10516.526756295832], "value": 8053.159273551046, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1232.0697873105803, 1257.4844313831331, 1342.8522862485124, 1478.2017710436364, 1480.6372438752508, 6713.395794378505, 7343.339099481045, 7429.702811887525, 7884.448088633798, 7978.640961156747, 7352.96323518383, 7676.654550545225, 7685.385169186466, 7711.151773304946, 7711.3059824615775, 2178.9891050544725, 2223.5775202711434, 2229.320057382498, 2237.407087121914, 2240.316703405461, 2187.1360812479143, 2203.383052745226, 2230.531588366445, 2244.124791331374, 2252.932412027642, 2193.254293540196, 2205.7132572765518, 2212.4137103667463, 2220.4670878989086, 2220.4892874638845, 2166.155199472207, 2168.9566208675815, 2175.9129634814667, 2184.3446965910243, 2200.1419446415753, 2072.7409073865765, 2078.8544801863877, 2078.98960505198, 2082.125507286943, 2092.309537852505, 7733.110692270405, 7762.573058481781, 7782.143964163937, 7796.571188584626, 7810.297073263377, 4659.347691323217, 4772.7136371817805, 4780.80876764929, 4818.855434336941, 4827.0, 2857.8571071446554, 2874.798764086515, 2996.9850150749107, 3005.0, 3012.021093144737, 892.5046599137476, 924.5931790012373, 945.669015844449, 946.0633972367375, 949.7578117580042, 10691.305065170816, 10698.03717665414, 10727.302725322907, 10729.356238625707, 10789.892101079045, 4252.829886804493, 4311.698181127291, 4466.263066593976, 4467.8212871484775, 4474.597286244189, 9135.908640913505, 9148.405353651991, 9162.450252984709, 9182.403143795766, 9184.954075229714, 4710.4347478302825, 4732.219183834629, 4802.975985120052, 4853.927191092136, 4856.198727210041, 3712.5173727415263, 4185.225733239299, 4294.055307832272, 4300.677449191323, 4313.6980411370905, 3727.4408838674417, 3727.813609319523, 3743.419769935664, 3839.7120215983914, 3839.827207775657, 1226.6994586326407, 1250.5373011985623, 1253.3419954523765, 1256.7989121740477, 1267.3726505379711, 754.0988518720077, 873.1094283830457, 879.612970293069, 886.4016788667624, 903.214203642835, 5269.341332333458, 5499.175123731392, 5508.476694713996, 5524.724756524968, 5559.054960656698, 416.7539058215973, 424.2999051564943, 424.51181141687306, 438.68853114289215, 440.85231447464815, 3790.8673196437994, 3928.9017774555864, 3986.2824691555797, 4022.879313620596, 4039.9798001010395, 9401.57692903821, 9551.952240238754, 9587.089226523469, 9593.568289426992, 9602.279829012852, 8951.149640784115, 9263.814723705487, 9297.95351023254, 9391.530423478798, 9522.523873806282, 7112.786616401516, 7171.0, 7240.493165478366, 7247.565146091251, 7293.051903252649, 5268.920966185434, 5397.973010134924, 5500.349895031554, 5528.143137813485, 5542.8337149885565, 8602.91397086021, 8952.23905968, 8961.955190224007, 8966.86549701742, 9012.2339601132, 8856.955715221382, 8962.103789620985, 9007.099290071203, 9085.13691199335, 9103.90896091057, 6132.110843927695, 6264.060390941395, 6475.449586785176, 6847.486438517031, 6892.345227203407, 7520.511166774142, 7543.585102819397, 7548.584827834522, 7572.167061623327, 7596.81007974805, 6656.30108838565, 6845.14435695538, 6873.759418420332, 6932.133483314586, 6946.79159625212, 6778.796636100925, 6784.3894049535775, 6828.317168283132, 6843.931560684528, 6890.483213759088, 6110.175126357884, 6125.785597504066, 6184.474319682878, 6187.226596675416, 6190.721417536131, 4492.595666390041, 4543.159515489645, 4545.454545454567, 4593.127305811885, 4653.837115700934, 4407.405000324915, 4542.909141817079, 4659.65052621048, 4674.953250467452, 4782.378290822171], "value": 4091.107603886541, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.52683496657795, 302.7063748164281, 309.85281991054245, 310.2553870710295, 311.48604802076557, 4807.591354734852, 4921.769557610597, 4974.726390048546, 5010.471806099138, 5019.347484826972, 4967.850964471072, 5020.723860187688, 5025.221090730934, 5025.648204625678, 5026.145555255606, 3910.4720862683457, 3917.745346552465, 3927.841286820395, 3927.9803600981954, 3947.5657677655436, 3592.92814143717, 3899.883003509899, 3919.627635374635, 3931.429942658313, 3936.3308237599676, 3793.412021136728, 3804.885853424402, 3807.1446415188607, 3810.1617644118387, 3819.197968426634, 3821.541415030214, 3828.272628200647, 3833.926500579842, 3834.4631751554666, 3846.000039989623, 3368.6968172864313, 3405.6594340565994, 3406.880759173417, 3422.9315413691834, 3427.3316703242876, 4810.374651295344, 4857.14999875024, 4906.754662266872, 4915.238138088602, 4922.375616046732, 4395.351743096339, 4403.097365040159, 4424.827420733508, 4434.201843668138, 4437.600615944581, 5221.164613661834, 5232.215167724872, 5234.6335756497065, 5238.397584277781, 5246.291750613656, 3631.382664946939, 3692.2615476904725, 3723.2739615774935, 3729.5524537055726, 3735.589085200626, 5382.219578161144, 5426.430224826416, 5439.782408703647, 5447.918281225785, 5449.427810079964, 3787.5833658297565, 3800.9619903801163, 3804.3722785740597, 3810.3522401191863, 3812.275667623143, 3844.308024555607, 3857.7685338879755, 3857.996920800612, 3860.2665493556133, 3866.149447121629, 4294.699371044059, 4358.782060896942, 4362.498312694081, 4403.0, 4414.713043652152, 5146.305248791366, 5155.355580552431, 5165.509276618715, 5177.4822517747925, 5183.429822719498, 1231.4422255846362, 1297.8572357040719, 1331.2811082015796, 1336.1315145155727, 1337.5786627212592, 839.3788596438592, 841.9158084191654, 844.273924424994, 860.2601762484259, 861.9008813986346, 4187.623113919762, 4231.709328654728, 4245.047278251977, 4254.319308910622, 4261.403403523509, 4746.264329029006, 4753.741972563005, 4777.211760059621, 4793.760311984387, 4811.013742182844, 4157.251694694984, 4165.500139983222, 4187.780476347541, 4216.578342165759, 4234.407182994383, 2461.360046387916, 2542.300867261518, 2582.8248147093027, 2593.6368908352847, 2595.9610605840926, 4491.595756381941, 4513.323001549794, 4536.523665015192, 4544.818207271738, 4559.81129058054, 4840.54014868594, 4882.975585122052, 4933.901321973541, 4938.234573641092, 4945.67853089548, 4372.366006929041, 4395.384646149541, 4432.645388368858, 4482.887927801766, 4507.887302817456, 4718.009218064108, 4722.268048452495, 4723.055388922298, 4724.480307166277, 4770.475247722818, 4654.48800631937, 4709.7174169549935, 4728.834490792806, 4736.455307639666, 4754.952450475589, 4403.427554417905, 4515.68390212682, 4528.98822283178, 4534.841280555164, 4592.117231934891, 3483.425234836224, 3490.3891818932093, 3505.596856361551, 3524.7532672712664, 3531.710925512118, 4734.928976065293, 4742.952570474251, 4768.974670445871, 4770.809167633256, 5147.352847089045, 5089.694618322913, 5143.331366922276, 5254.189008880231, 5258.763355648928, 5265.21021846726, 5188.429272780067, 5231.450697676689, 5231.895362092813, 5243.61044323247, 5246.868828279324, 4876.21980483121, 5117.692938423706, 5139.4603566626465, 5166.664166829144, 5178.533931946143, 5304.840854774363, 5323.973380133075, 5325.121354976541, 5326.9200961984825, 5348.679079255257, 5176.818811341585, 5226.0, 5226.529612334908, 5229.6339256251695, 5240.449752775904], "value": 3789.3862934501126, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.291650019976, 607.8845019446302, 617.1329282358287, 657.0768070860443, 742.9042162809852, 10335.948320258407, 12305.69235769105, 12837.743245135092, 12837.807432888514, 13427.194368337881, 13867.445302187925, 14409.495667651609, 14477.420903163887, 14494.710105797878, 14590.124592524457, 763.2100775697155, 775.1047540091204, 784.1178673991759, 785.8271180340345, 787.1734678587488, 779.8362343907786, 783.7178615698344, 783.9176886426928, 787.0633945604741, 789.8143936174994, 825.4015838517087, 826.1119296755982, 827.5117680568463, 829.4318391901537, 830.9376796740269, 812.175641723651, 819.0703551469065, 821.5686764448652, 823.0329362998483, 823.4071468542639, 577.711144427786, 587.9441453061952, 592.6532978207754, 594.8334466349386, 597.9133025711247, 13132.146410483383, 13169.078164528486, 13169.604911852659, 13184.934075329658, 13212.537561185312, 12725.61823145307, 13282.60152195426, 13558.254296013716, 13653.317334133253, 13826.654333641638, 10296.742581435448, 10436.425996570186, 10500.78998420035, 10526.78946421075, 10571.260011799177, 3393.8642454302044, 3435.089701229176, 3442.569678790151, 3446.4313388290902, 3456.4296891013205, 54802.45197548014, 55110.0, 55222.723886380714, 56852.43147568554, 57025.1446228311, 10142.44216568081, 10261.333013354108, 10269.3569028955, 10409.479526023668, 10594.629187978384, 17472.73790893112, 18715.344962926232, 18754.24983000692, 18818.247270109317, 18898.244070237313, 7082.220955694973, 7107.964460177666, 7182.066331376887, 7337.88993165103, 7369.410447164214, 3789.696824254053, 3863.903402414906, 3868.4025649840833, 3904.1801221743185, 4007.5591684914634, 3031.621047369079, 3139.8116113033293, 3141.937161256762, 3151.732102771244, 3153.3377990621766, 520.0431206579912, 522.8117877564074, 523.0297797585424, 530.9442508536625, 549.209138840069, 476.76638447160644, 542.2462776740334, 547.3322546493272, 562.8480310316191, 580.0689892722205, 7673.462857600026, 7920.564368959763, 8020.508336479814, 8105.148959359182, 8161.877571836427, 542.3085565903505, 549.3517649174013, 598.5032423088826, 606.5110154570518, 612.9754809807557, 3691.187938653492, 3768.8968717257567, 3948.407738839197, 3987.102901847119, 4079.4084857695466, 85181.57409213038, 90308.0, 91739.79996112778, 92990.0, 93677.0, 51308.74345628248, 63193.684031580466, 65035.0, 78276.60861695655, 80985.89437274463, 70578.64710676414, 74382.25617743861, 74670.25329746633, 74845.25154748492, 75689.621551893, 7248.782536523912, 7538.924610753822, 7550.35821955118, 7573.659185336784, 7767.184445633127, 41085.38371924364, 43866.0, 44361.44734934262, 44601.55398445974, 45316.0, 54157.0, 61265.387346125965, 61282.38717612945, 61693.691531542056, 62262.37737622566, 9648.469334186406, 9720.805583888141, 9929.3545919515, 9994.050565196294, 10067.395956242648, 11473.942630286796, 11486.13853960973, 11514.136439767219, 11652.708682282671, 11785.0, 9771.31600787938, 9870.111689947651, 10066.496675166067, 10067.798644026932, 10762.3542587445, 11259.718507037061, 11558.248713833575, 12492.562760303346, 12700.618981430573, 12849.293288869201, 10318.48407579633, 10436.582536698446, 10480.947595261974, 10570.524326405177, 10976.121910247002, 9630.0, 9815.558299876666, 10020.24848136378, 10219.948900255451, 10222.233332499944, 9498.762530936781, 9533.570989305637, 9627.9037209627, 9720.409972409523, 9824.582410345516], "value": 6411.957643663122, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1585.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 109.0, 114.0, 117.0, 114.0, 115.0, 114.0, 116.0, 113.0, 115.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 133.0, 154.0, 192.0, 135.0, 163.0, 161.0, 136.0, 192.0, 133.0], "value": 155.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 167.0, 177.0, 166.0, 162.0, 173.0, 162.0, 163.0, 162.0, 161.0], "value": 165.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 151.0, 78.0, 78.0, 76.0, 76.0, 152.0, 76.0], "value": 91.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 142.0, 86.0, 87.0, 88.0, 144.0, 87.0, 87.0, 132.0], "value": 102.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 120.0, 117.0, 118.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 151.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 150.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 64.0, 64.0, 63.0, 62.0, 69.0, 64.0, 64.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 71.0, 65.0, 65.0, 65.0, 67.0, 66.0, 65.0, 70.0], "value": 66.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 84.0, 91.0, 87.0, 85.0, 85.0, 85.0, 111.0, 84.0], "value": 88.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 133.0, 143.0, 140.0, 137.0, 130.0, 135.0, 133.0, 134.0, 135.0], "value": 135.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 169.0, 171.0, 171.0, 171.0, 175.0, 170.0, 171.0, 168.0, 169.0], "value": 170.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 74.0, 68.0, 69.0, 69.0, 68.0, 67.0, 66.0, 66.0], "value": 68.7, "unit": "score"}]}]} 08:35:33 INFO - Return code: 0 08:35:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:35:33 ERROR - # TBPL SUCCESS # 08:35:33 INFO - Running post-action listener: _resource_record_post_action 08:35:33 INFO - ##### 08:35:33 INFO - ##### Finished run-tests step (success) 08:35:33 INFO - ##### 08:35:33 INFO - Running post-run listener: _resource_record_post_run 08:35:33 INFO - Total resource usage - Wall time: 1199s; CPU: 14.0%; Read bytes: 126976; Write bytes: 536682496; Read time: 300; Write time: 634288 08:35:33 INFO - TinderboxPrint: CPU usage
13.5% 08:35:33 INFO - TinderboxPrint: I/O read bytes / time
126,976 / 300 08:35:33 INFO - TinderboxPrint: I/O write bytes / time
536,682,496 / 634,288 08:35:33 INFO - TinderboxPrint: CPU idle
8,267.6 (86.4%) 08:35:33 INFO - TinderboxPrint: CPU user
1,238.4 (12.9%) 08:35:33 INFO - TinderboxPrint: Swap in / out
0 / 0 08:35:33 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 118784; Write bytes: 238149632; Read time: 276; Write time: 353972 08:35:33 INFO - run-tests - Wall time: 1183s; CPU: 14.0%; Read bytes: 8192; Write bytes: 291942400; Read time: 24; Write time: 278476 08:35:33 INFO - Running post-run listener: _upload_blobber_files 08:35:33 INFO - Blob upload gear active. 08:35:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:35:33 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 08:35:33 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:35:33 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:35:34 INFO - (blobuploader) - INFO - Open directory for files ... 08:35:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:35:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:35:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:35:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:35:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:35:35 INFO - (blobuploader) - INFO - Done attempting. 08:35:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:35:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:35:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:35:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:35:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:35:35 INFO - (blobuploader) - INFO - Done attempting. 08:35:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:35:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:35:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:35:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:35:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:35:39 INFO - (blobuploader) - INFO - Done attempting. 08:35:39 INFO - (blobuploader) - INFO - Iteration through files over. 08:35:39 INFO - Return code: 0 08:35:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:35:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:35:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7a4ca4b7faa5f8712ebc35ea54365cf9f6f86e2b22a414a0072e75b5622ef56e60d17c81fe85e9073f5fa01a2dfb844943b044312e73a419154134bdb536a336", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/460c3142a10ae31a5593e3ef600c56f84c6d5fc970b7c6b9b19c68176c4cc4bd07ecf800aabdbf2351af910e2d584a35ecbe2bedcf60837386060a7758808365", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/746eb2e11f9d3ef62ffeb24557b58c9cf8779d5f2f03d1a97560a6470461c5f6f03808b11567f31fd7aff50ab9b188666d01a8de8461aa6ae8e820e8269d0cdd"} 08:35:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:35:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:35:39 INFO - Contents: 08:35:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7a4ca4b7faa5f8712ebc35ea54365cf9f6f86e2b22a414a0072e75b5622ef56e60d17c81fe85e9073f5fa01a2dfb844943b044312e73a419154134bdb536a336", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/460c3142a10ae31a5593e3ef600c56f84c6d5fc970b7c6b9b19c68176c4cc4bd07ecf800aabdbf2351af910e2d584a35ecbe2bedcf60837386060a7758808365", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/746eb2e11f9d3ef62ffeb24557b58c9cf8779d5f2f03d1a97560a6470461c5f6f03808b11567f31fd7aff50ab9b188666d01a8de8461aa6ae8e820e8269d0cdd"} 08:35:39 INFO - Running post-run listener: copy_logs_to_upload_dir 08:35:39 INFO - Copying logs to upload dir... 08:35:39 INFO - mkdir: /builds/slave/test/build/upload/logs 08:35:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.046725 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-10 08:35:39.362516) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 08:35:39.365880) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1465571697.524368-1478220865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7a4ca4b7faa5f8712ebc35ea54365cf9f6f86e2b22a414a0072e75b5622ef56e60d17c81fe85e9073f5fa01a2dfb844943b044312e73a419154134bdb536a336", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/460c3142a10ae31a5593e3ef600c56f84c6d5fc970b7c6b9b19c68176c4cc4bd07ecf800aabdbf2351af910e2d584a35ecbe2bedcf60837386060a7758808365", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/746eb2e11f9d3ef62ffeb24557b58c9cf8779d5f2f03d1a97560a6470461c5f6f03808b11567f31fd7aff50ab9b188666d01a8de8461aa6ae8e820e8269d0cdd"} build_url:https://queue.taskcluster.net/v1/task/BTjEfDN6Q-iu06AUzf_8BQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011276 build_url: 'https://queue.taskcluster.net/v1/task/BTjEfDN6Q-iu06AUzf_8BQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7a4ca4b7faa5f8712ebc35ea54365cf9f6f86e2b22a414a0072e75b5622ef56e60d17c81fe85e9073f5fa01a2dfb844943b044312e73a419154134bdb536a336", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/460c3142a10ae31a5593e3ef600c56f84c6d5fc970b7c6b9b19c68176c4cc4bd07ecf800aabdbf2351af910e2d584a35ecbe2bedcf60837386060a7758808365", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/746eb2e11f9d3ef62ffeb24557b58c9cf8779d5f2f03d1a97560a6470461c5f6f03808b11567f31fd7aff50ab9b188666d01a8de8461aa6ae8e820e8269d0cdd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 08:35:39.391393) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 08:35:39.391717) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1465571697.524368-1478220865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004428 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 08:35:39.475269) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 08:35:39.475587) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 08:35:39.475908) ========= ========= Total master_lag: 0.17 =========